builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1452059509.98 results: success (0) buildid: 20160105193035 builduid: 5d7d91b43e5b47c39abbdf2cb6ce0ccf revision: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.983316) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.983731) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:49.984095) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006455 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.023292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.023908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.094044) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.094309) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.153562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.153846) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.154233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.154518) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-05 21:51:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-05 21:51:50 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101810 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.275000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.275348) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:50.326292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 21:51:50.326653) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-05 21:51:51,080 truncating revision to first 12 chars 2016-01-05 21:51:51,080 Setting DEBUG logging. 2016-01-05 21:51:51,080 attempt 1/10 2016-01-05 21:51:51,080 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9d6ffc7a08b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-05 21:51:51,883 unpacking tar archive at: mozilla-central-9d6ffc7a08b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-05 21:51:51.395565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.395876) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.405998) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.406386) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-05 21:51:51.406852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-05 21:51:51.407140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:51:52 INFO - MultiFileLogger online at 20160105 21:51:52 in /builds/slave/test-pgo 21:51:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:51:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:51:52 INFO - {'append_to_log': False, 21:51:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:51:52 INFO - 'blob_upload_branch': 'Firefox', 21:51:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:51:52 INFO - 'branch': 'Firefox', 21:51:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:51:52 INFO - 'config_files': ('talos/linux_config.py',), 21:51:52 INFO - 'default_actions': ('clobber', 21:51:52 INFO - 'read-buildbot-config', 21:51:52 INFO - 'download-and-extract', 21:51:52 INFO - 'populate-webroot', 21:51:52 INFO - 'create-virtualenv', 21:51:52 INFO - 'install', 21:51:52 INFO - 'run-tests'), 21:51:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:51:52 INFO - 'download_minidump_stackwalk': True, 21:51:52 INFO - 'download_symbols': 'ondemand', 21:51:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:51:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:51:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:51:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:51:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:51:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:51:52 INFO - 'installer_path': 'installer.exe', 21:51:52 INFO - 'log_level': 'info', 21:51:52 INFO - 'log_name': 'talos', 21:51:52 INFO - 'log_to_console': True, 21:51:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:51:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:51:52 INFO - 'opt_config_files': (), 21:51:52 INFO - 'pip_index': False, 21:51:52 INFO - 'sps_profile': False, 21:51:52 INFO - 'sps_profile_interval': 0, 21:51:52 INFO - 'suite': 'dromaeojs', 21:51:52 INFO - 'system_bits': '32', 21:51:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:51:52 INFO - 'title': 'talos-linux64-ix-051', 21:51:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:51:52 INFO - 'use_talos_json': True, 21:51:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:51:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:51:52 INFO - 'work_dir': 'build'} 21:51:52 INFO - ##### 21:51:52 INFO - ##### Running clobber step. 21:51:52 INFO - ##### 21:51:52 INFO - Running pre-action listener: _resource_record_pre_action 21:51:52 INFO - Running main action method: clobber 21:51:52 INFO - rmtree: /builds/slave/test-pgo/build 21:51:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:51:53 INFO - Running post-action listener: _resource_record_post_action 21:51:53 INFO - ##### 21:51:53 INFO - ##### Running read-buildbot-config step. 21:51:53 INFO - ##### 21:51:53 INFO - Running pre-action listener: _resource_record_pre_action 21:51:53 INFO - Running main action method: read_buildbot_config 21:51:53 INFO - Using buildbot properties: 21:51:53 INFO - { 21:51:53 INFO - "project": "", 21:51:53 INFO - "product": "firefox", 21:51:53 INFO - "script_repo_revision": "production", 21:51:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:51:53 INFO - "repository": "", 21:51:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:51:53 INFO - "buildid": "20160105193035", 21:51:53 INFO - "pgo_build": "True", 21:51:53 INFO - "basedir": "/builds/slave/test-pgo", 21:51:53 INFO - "buildnumber": 152, 21:51:53 INFO - "slavename": "talos-linux64-ix-051", 21:51:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:51:53 INFO - "platform": "ubuntu64_hw", 21:51:53 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 21:51:53 INFO - "branch": "mozilla-central", 21:51:53 INFO - "repo_path": "mozilla-central", 21:51:53 INFO - "revision": "9d6ffc7a08b6b47056eefe1e652710a3849adbf7", 21:51:53 INFO - "stage_platform": "linux64-pgo", 21:51:53 INFO - "builduid": "5d7d91b43e5b47c39abbdf2cb6ce0ccf", 21:51:53 INFO - "slavebuilddir": "test" 21:51:53 INFO - } 21:51:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:51:53 INFO - Running post-action listener: _resource_record_post_action 21:51:53 INFO - ##### 21:51:53 INFO - ##### Running download-and-extract step. 21:51:53 INFO - ##### 21:51:53 INFO - Running pre-action listener: _resource_record_pre_action 21:51:53 INFO - Running main action method: download_and_extract 21:51:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:53 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:51:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json 21:51:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json 21:51:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:51:55 INFO - Downloaded 1302 bytes. 21:51:55 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:51:55 INFO - Using the following test package requirements: 21:51:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:51:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'jsshell-linux-x86_64.zip'], 21:51:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:51:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:51:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:51:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:51:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:51:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:51:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:51:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:55 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:51:56 INFO - Downloaded 24054382 bytes. 21:51:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:51:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:51:57 INFO - Return code: 0 21:51:57 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:51:57 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:51:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:52:02 INFO - Downloaded 24054382 bytes. 21:52:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 21:52:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:52:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 21:52:03 INFO - Return code: 0 21:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:03 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:52:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:52:04 INFO - Downloaded 11132285 bytes. 21:52:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 21:52:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:52:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 21:52:04 INFO - Return code: 0 21:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:04 INFO - https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:52:05 INFO - Downloaded 55062623 bytes. 21:52:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:05 INFO - mkdir: /builds/slave/test-pgo/properties 21:52:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:52:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:52:05 INFO - Contents: 21:52:05 INFO - build_url:https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:52:05 INFO - Running post-action listener: _resource_record_post_action 21:52:05 INFO - Running post-action listener: set_extra_try_arguments 21:52:05 INFO - ##### 21:52:05 INFO - ##### Running populate-webroot step. 21:52:05 INFO - ##### 21:52:05 INFO - Running pre-action listener: _resource_record_pre_action 21:52:05 INFO - Running main action method: populate_webroot 21:52:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:52:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:52:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:52:05 INFO - '--tppagecycles', 21:52:05 INFO - '7'], 21:52:05 INFO - 'tests': ['tsvgm']}}, 21:52:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:52:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:52:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:52:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:52:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'tests': ['damp', 'tps']}, 21:52:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['damp', 'tps']}, 21:52:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:52:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:52:05 INFO - 'other': {'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'other_l64': {'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'other_nol64': {'tests': ['a11yr', 21:52:05 INFO - 'ts_paint', 21:52:05 INFO - 'tpaint', 21:52:05 INFO - 'sessionrestore', 21:52:05 INFO - 'sessionrestore_no_auto_restore']}, 21:52:05 INFO - 'svgr': {'tests': ['tsvgx', 21:52:05 INFO - 'tsvgr_opacity', 21:52:05 INFO - 'tart', 21:52:05 INFO - 'tscrollx', 21:52:05 INFO - 'cart']}, 21:52:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['tsvgx', 21:52:05 INFO - 'tsvgr_opacity', 21:52:05 INFO - 'tart', 21:52:05 INFO - 'tscrollx', 21:52:05 INFO - 'cart']}, 21:52:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'tests': ['tp5o']}, 21:52:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'talos_options': ['--e10s'], 21:52:05 INFO - 'tests': ['tp5o']}, 21:52:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'talos_options': ['--xperf_path', 21:52:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:05 INFO - 'tests': ['tp5n']}, 21:52:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:52:05 INFO - 'talos_options': ['--e10s', 21:52:05 INFO - '--xperf_path', 21:52:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:52:05 INFO - 'tests': ['tp5n']}}, 21:52:05 INFO - 'talos.zip': {'path': '', 21:52:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:52:05 INFO - Running post-action listener: _resource_record_post_action 21:52:05 INFO - ##### 21:52:05 INFO - ##### Running create-virtualenv step. 21:52:05 INFO - ##### 21:52:05 INFO - Running pre-action listener: _resource_record_pre_action 21:52:05 INFO - Running main action method: create_virtualenv 21:52:05 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:52:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 21:52:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:52:05 INFO - Using real prefix '/usr' 21:52:05 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:52:06 INFO - Installing distribute.............................................................................................................................................................................................done. 21:52:08 INFO - Installing pip.................done. 21:52:08 INFO - Return code: 0 21:52:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 21:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:52:08 INFO - Using env: {'DISPLAY': ':0', 21:52:08 INFO - 'HOME': '/home/cltbld', 21:52:08 INFO - 'LANG': 'en_US.UTF-8', 21:52:08 INFO - 'LANGUAGE': 'en_US:en', 21:52:08 INFO - 'LOGNAME': 'cltbld', 21:52:08 INFO - 'MAIL': '/var/mail/cltbld', 21:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:08 INFO - 'MOZ_NO_REMOTE': '1', 21:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:08 INFO - 'NO_EM_RESTART': '1', 21:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:08 INFO - 'SHELL': '/bin/bash', 21:52:08 INFO - 'SHLVL': '1', 21:52:08 INFO - 'TERM': 'linux', 21:52:08 INFO - 'TMOUT': '86400', 21:52:08 INFO - 'USER': 'cltbld', 21:52:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:08 INFO - '_': '/tools/buildbot/bin/python'} 21:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:52:08 INFO - Cleaning up... 21:52:08 INFO - Return code: 0 21:52:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 21:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 21:52:08 INFO - Using env: {'DISPLAY': ':0', 21:52:08 INFO - 'HOME': '/home/cltbld', 21:52:08 INFO - 'LANG': 'en_US.UTF-8', 21:52:08 INFO - 'LANGUAGE': 'en_US:en', 21:52:08 INFO - 'LOGNAME': 'cltbld', 21:52:08 INFO - 'MAIL': '/var/mail/cltbld', 21:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:08 INFO - 'MOZ_NO_REMOTE': '1', 21:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:08 INFO - 'NO_EM_RESTART': '1', 21:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:08 INFO - 'SHELL': '/bin/bash', 21:52:08 INFO - 'SHLVL': '1', 21:52:08 INFO - 'TERM': 'linux', 21:52:08 INFO - 'TMOUT': '86400', 21:52:08 INFO - 'USER': 'cltbld', 21:52:08 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:08 INFO - '_': '/tools/buildbot/bin/python'} 21:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:08 INFO - Downloading/unpacking psutil>=0.7.1 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:10 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:52:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:52:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:10 INFO - Installing collected packages: psutil 21:52:10 INFO - Running setup.py install for psutil 21:52:10 INFO - building 'psutil._psutil_linux' extension 21:52:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:52:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:52:11 INFO - building 'psutil._psutil_posix' extension 21:52:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:52:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:52:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:52:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:52:11 INFO - Successfully installed psutil 21:52:11 INFO - Cleaning up... 21:52:11 INFO - Return code: 0 21:52:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 21:52:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 21:52:11 INFO - Using env: {'DISPLAY': ':0', 21:52:11 INFO - 'HOME': '/home/cltbld', 21:52:11 INFO - 'LANG': 'en_US.UTF-8', 21:52:11 INFO - 'LANGUAGE': 'en_US:en', 21:52:11 INFO - 'LOGNAME': 'cltbld', 21:52:11 INFO - 'MAIL': '/var/mail/cltbld', 21:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:11 INFO - 'MOZ_NO_REMOTE': '1', 21:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:11 INFO - 'NO_EM_RESTART': '1', 21:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:11 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:11 INFO - 'SHELL': '/bin/bash', 21:52:11 INFO - 'SHLVL': '1', 21:52:11 INFO - 'TERM': 'linux', 21:52:11 INFO - 'TMOUT': '86400', 21:52:11 INFO - 'USER': 'cltbld', 21:52:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:11 INFO - '_': '/tools/buildbot/bin/python'} 21:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:52:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:52:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:52:13 INFO - Installing collected packages: mozsystemmonitor 21:52:13 INFO - Running setup.py install for mozsystemmonitor 21:52:13 INFO - Successfully installed mozsystemmonitor 21:52:13 INFO - Cleaning up... 21:52:13 INFO - Return code: 0 21:52:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:13 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 21:52:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:52:13 INFO - Using env: {'DISPLAY': ':0', 21:52:13 INFO - 'HOME': '/home/cltbld', 21:52:13 INFO - 'LANG': 'en_US.UTF-8', 21:52:13 INFO - 'LANGUAGE': 'en_US:en', 21:52:13 INFO - 'LOGNAME': 'cltbld', 21:52:13 INFO - 'MAIL': '/var/mail/cltbld', 21:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:13 INFO - 'MOZ_NO_REMOTE': '1', 21:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:13 INFO - 'NO_EM_RESTART': '1', 21:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:13 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:13 INFO - 'SHELL': '/bin/bash', 21:52:13 INFO - 'SHLVL': '1', 21:52:13 INFO - 'TERM': 'linux', 21:52:13 INFO - 'TMOUT': '86400', 21:52:13 INFO - 'USER': 'cltbld', 21:52:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:13 INFO - '_': '/tools/buildbot/bin/python'} 21:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:52:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:52:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:52:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:52:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:52:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:15 INFO - Downloading docopt-0.6.1.tar.gz 21:52:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:52:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:52:16 INFO - Installing collected packages: blobuploader, requests, docopt 21:52:16 INFO - Running setup.py install for blobuploader 21:52:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:52:16 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:52:16 INFO - Running setup.py install for requests 21:52:16 INFO - Running setup.py install for docopt 21:52:16 INFO - Successfully installed blobuploader requests docopt 21:52:16 INFO - Cleaning up... 21:52:16 INFO - Return code: 0 21:52:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:16 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:52:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:52:16 INFO - Using env: {'DISPLAY': ':0', 21:52:16 INFO - 'HOME': '/home/cltbld', 21:52:16 INFO - 'LANG': 'en_US.UTF-8', 21:52:16 INFO - 'LANGUAGE': 'en_US:en', 21:52:16 INFO - 'LOGNAME': 'cltbld', 21:52:16 INFO - 'MAIL': '/var/mail/cltbld', 21:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:16 INFO - 'MOZ_NO_REMOTE': '1', 21:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:16 INFO - 'NO_EM_RESTART': '1', 21:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:16 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:16 INFO - 'SHELL': '/bin/bash', 21:52:16 INFO - 'SHLVL': '1', 21:52:16 INFO - 'TERM': 'linux', 21:52:16 INFO - 'TMOUT': '86400', 21:52:16 INFO - 'USER': 'cltbld', 21:52:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:16 INFO - '_': '/tools/buildbot/bin/python'} 21:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:16 INFO - Running setup.py (path:/tmp/pip-nnImXW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:16 INFO - Running setup.py (path:/tmp/pip-WN6Mt3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:17 INFO - Running setup.py (path:/tmp/pip-R44G75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:17 INFO - Running setup.py (path:/tmp/pip-ZhYrtj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:17 INFO - Running setup.py (path:/tmp/pip-gIsWYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:17 INFO - Running setup.py (path:/tmp/pip-ZjMQeu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:17 INFO - Running setup.py (path:/tmp/pip-65Xv9_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:17 INFO - Running setup.py (path:/tmp/pip-5X7Ovf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:17 INFO - Running setup.py (path:/tmp/pip-Q_5oHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:17 INFO - Running setup.py (path:/tmp/pip-BQZRK3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:17 INFO - Running setup.py (path:/tmp/pip-edfRG1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:17 INFO - Running setup.py (path:/tmp/pip-HXmJND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:17 INFO - Running setup.py (path:/tmp/pip-XRrFFw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:17 INFO - Running setup.py (path:/tmp/pip-NsBK1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:17 INFO - Running setup.py (path:/tmp/pip-8XwwIL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:17 INFO - Running setup.py (path:/tmp/pip-ymizAd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:18 INFO - Running setup.py (path:/tmp/pip-SlFdD9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:52:18 INFO - Running setup.py install for manifestparser 21:52:18 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Running setup.py install for mozcrash 21:52:18 INFO - Running setup.py install for mozdebug 21:52:18 INFO - Running setup.py install for mozdevice 21:52:18 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Running setup.py install for mozfile 21:52:18 INFO - Running setup.py install for mozhttpd 21:52:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Running setup.py install for mozinfo 21:52:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Running setup.py install for mozInstall 21:52:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:52:18 INFO - Running setup.py install for mozleak 21:52:18 INFO - Running setup.py install for mozlog 21:52:19 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Running setup.py install for moznetwork 21:52:19 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Running setup.py install for mozprocess 21:52:19 INFO - Running setup.py install for mozprofile 21:52:19 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Running setup.py install for mozrunner 21:52:19 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Running setup.py install for mozscreenshot 21:52:19 INFO - Running setup.py install for moztest 21:52:19 INFO - Running setup.py install for mozversion 21:52:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:52:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:52:19 INFO - Cleaning up... 21:52:19 INFO - Return code: 0 21:52:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 21:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:52:19 INFO - Using env: {'DISPLAY': ':0', 21:52:19 INFO - 'HOME': '/home/cltbld', 21:52:19 INFO - 'LANG': 'en_US.UTF-8', 21:52:19 INFO - 'LANGUAGE': 'en_US:en', 21:52:19 INFO - 'LOGNAME': 'cltbld', 21:52:19 INFO - 'MAIL': '/var/mail/cltbld', 21:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:19 INFO - 'MOZ_NO_REMOTE': '1', 21:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:19 INFO - 'NO_EM_RESTART': '1', 21:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:19 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:19 INFO - 'SHELL': '/bin/bash', 21:52:19 INFO - 'SHLVL': '1', 21:52:19 INFO - 'TERM': 'linux', 21:52:19 INFO - 'TMOUT': '86400', 21:52:19 INFO - 'USER': 'cltbld', 21:52:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:19 INFO - '_': '/tools/buildbot/bin/python'} 21:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:20 INFO - Running setup.py (path:/tmp/pip-JCS7B1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:20 INFO - Running setup.py (path:/tmp/pip-q245AM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:20 INFO - Running setup.py (path:/tmp/pip-Ks5VPf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:20 INFO - Running setup.py (path:/tmp/pip-bBS0Aq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:20 INFO - Running setup.py (path:/tmp/pip-LouDj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:20 INFO - Running setup.py (path:/tmp/pip-qzoWTD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:20 INFO - Running setup.py (path:/tmp/pip-5RrIIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:20 INFO - Running setup.py (path:/tmp/pip-EzDuuY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:20 INFO - Running setup.py (path:/tmp/pip-9YGYbJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:20 INFO - Running setup.py (path:/tmp/pip-2lEWne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:20 INFO - Running setup.py (path:/tmp/pip-ao2ozK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:20 INFO - Running setup.py (path:/tmp/pip-O4g6tu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:52:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:52:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:20 INFO - Running setup.py (path:/tmp/pip-fKEaQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:21 INFO - Running setup.py (path:/tmp/pip-TNWMRl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 21:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:21 INFO - Running setup.py (path:/tmp/pip-i_kO0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 21:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:21 INFO - Running setup.py (path:/tmp/pip-VARnP9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 21:52:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:21 INFO - Running setup.py (path:/tmp/pip-Zl_WYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 21:52:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:22 INFO - Downloading blessings-1.5.1.tar.gz 21:52:22 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 21:52:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:52:23 INFO - Installing collected packages: blessings 21:52:23 INFO - Running setup.py install for blessings 21:52:23 INFO - Successfully installed blessings 21:52:23 INFO - Cleaning up... 21:52:23 INFO - Return code: 0 21:52:23 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:52:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:23 INFO - Reading from file tmpfile_stdout 21:52:23 INFO - Current package versions: 21:52:23 INFO - argparse == 1.2.1 21:52:23 INFO - blessings == 1.5.1 21:52:23 INFO - blobuploader == 1.2.4 21:52:23 INFO - docopt == 0.6.1 21:52:23 INFO - manifestparser == 1.1 21:52:23 INFO - mozInstall == 1.12 21:52:23 INFO - mozcrash == 0.16 21:52:23 INFO - mozdebug == 0.1 21:52:23 INFO - mozdevice == 0.47 21:52:23 INFO - mozfile == 1.2 21:52:23 INFO - mozhttpd == 0.7 21:52:23 INFO - mozinfo == 0.9 21:52:23 INFO - mozleak == 0.1 21:52:23 INFO - mozlog == 3.1 21:52:23 INFO - moznetwork == 0.27 21:52:23 INFO - mozprocess == 0.22 21:52:23 INFO - mozprofile == 0.28 21:52:23 INFO - mozrunner == 6.11 21:52:23 INFO - mozscreenshot == 0.1 21:52:23 INFO - mozsystemmonitor == 0.0 21:52:23 INFO - moztest == 0.7 21:52:23 INFO - mozversion == 1.4 21:52:23 INFO - psutil == 3.1.1 21:52:23 INFO - requests == 1.2.3 21:52:23 INFO - wsgiref == 0.1.2 21:52:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 21:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:52:23 INFO - Using env: {'DISPLAY': ':0', 21:52:23 INFO - 'HOME': '/home/cltbld', 21:52:23 INFO - 'LANG': 'en_US.UTF-8', 21:52:23 INFO - 'LANGUAGE': 'en_US:en', 21:52:23 INFO - 'LOGNAME': 'cltbld', 21:52:23 INFO - 'MAIL': '/var/mail/cltbld', 21:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:23 INFO - 'MOZ_NO_REMOTE': '1', 21:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:23 INFO - 'NO_EM_RESTART': '1', 21:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:23 INFO - 'SHELL': '/bin/bash', 21:52:23 INFO - 'SHLVL': '1', 21:52:23 INFO - 'TERM': 'linux', 21:52:23 INFO - 'TMOUT': '86400', 21:52:23 INFO - 'USER': 'cltbld', 21:52:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:23 INFO - '_': '/tools/buildbot/bin/python'} 21:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 21:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 21:52:23 INFO - Cleaning up... 21:52:23 INFO - Return code: 0 21:52:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 21:52:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:52:23 INFO - Using env: {'DISPLAY': ':0', 21:52:23 INFO - 'HOME': '/home/cltbld', 21:52:23 INFO - 'LANG': 'en_US.UTF-8', 21:52:23 INFO - 'LANGUAGE': 'en_US:en', 21:52:23 INFO - 'LOGNAME': 'cltbld', 21:52:23 INFO - 'MAIL': '/var/mail/cltbld', 21:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:23 INFO - 'MOZ_NO_REMOTE': '1', 21:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:23 INFO - 'NO_EM_RESTART': '1', 21:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:23 INFO - 'SHELL': '/bin/bash', 21:52:23 INFO - 'SHLVL': '1', 21:52:23 INFO - 'TERM': 'linux', 21:52:23 INFO - 'TMOUT': '86400', 21:52:23 INFO - 'USER': 'cltbld', 21:52:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:23 INFO - '_': '/tools/buildbot/bin/python'} 21:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:23 INFO - Downloading/unpacking jsonschema 21:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:52:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 21:52:25 INFO - Downloading/unpacking functools32 (from jsonschema) 21:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 21:52:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:52:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:52:25 INFO - warning: no files found matching '*.txt' 21:52:25 INFO - no previously-included directories found matching 'build' 21:52:25 INFO - no previously-included directories found matching 'dist' 21:52:25 INFO - no previously-included directories found matching '.git*' 21:52:25 INFO - Installing collected packages: jsonschema, functools32 21:52:25 INFO - Running setup.py install for functools32 21:52:25 INFO - warning: no files found matching '*.txt' 21:52:25 INFO - no previously-included directories found matching 'build' 21:52:25 INFO - no previously-included directories found matching 'dist' 21:52:25 INFO - no previously-included directories found matching '.git*' 21:52:25 INFO - Successfully installed jsonschema functools32 21:52:25 INFO - Cleaning up... 21:52:26 INFO - Return code: 0 21:52:26 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:26 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff151d48f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd8630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:52:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 21:52:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 21:52:26 INFO - Using env: {'DISPLAY': ':0', 21:52:26 INFO - 'HOME': '/home/cltbld', 21:52:26 INFO - 'LANG': 'en_US.UTF-8', 21:52:26 INFO - 'LANGUAGE': 'en_US:en', 21:52:26 INFO - 'LOGNAME': 'cltbld', 21:52:26 INFO - 'MAIL': '/var/mail/cltbld', 21:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:26 INFO - 'MOZ_NO_REMOTE': '1', 21:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:26 INFO - 'NO_EM_RESTART': '1', 21:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:26 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:26 INFO - 'SHELL': '/bin/bash', 21:52:26 INFO - 'SHLVL': '1', 21:52:26 INFO - 'TERM': 'linux', 21:52:26 INFO - 'TMOUT': '86400', 21:52:26 INFO - 'USER': 'cltbld', 21:52:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:26 INFO - '_': '/tools/buildbot/bin/python'} 21:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:26 INFO - Downloading/unpacking flake8 21:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:52:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 21:52:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:52:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 21:52:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 21:52:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:52:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:52:28 INFO - no previously-included directories found matching 'docs/_build' 21:52:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:52:28 INFO - Running setup.py install for pep8 21:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:52:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:52:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:52:28 INFO - no previously-included directories found matching 'docs/_build' 21:52:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:52:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:52:28 INFO - Cleaning up... 21:52:28 INFO - Return code: 0 21:52:28 INFO - Running post-action listener: _resource_record_post_action 21:52:28 INFO - Running post-action listener: _start_resource_monitoring 21:52:28 INFO - Starting resource monitoring. 21:52:28 INFO - ##### 21:52:28 INFO - ##### Running install step. 21:52:28 INFO - ##### 21:52:28 INFO - Running pre-action listener: _resource_record_pre_action 21:52:28 INFO - Running main action method: install 21:52:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:52:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:52:29 INFO - Reading from file tmpfile_stdout 21:52:29 INFO - Detecting whether we're running mozinstall >=1.0... 21:52:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:52:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:52:29 INFO - Reading from file tmpfile_stdout 21:52:29 INFO - Output received: 21:52:29 INFO - Usage: mozinstall [options] installer 21:52:29 INFO - Options: 21:52:29 INFO - -h, --help show this help message and exit 21:52:29 INFO - -d DEST, --destination=DEST 21:52:29 INFO - Directory to install application into. [default: 21:52:29 INFO - "/builds/slave/test-pgo"] 21:52:29 INFO - --app=APP Application being installed. [default: firefox] 21:52:29 INFO - mkdir: /builds/slave/test-pgo/build/application 21:52:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 21:52:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 21:52:45 INFO - Reading from file tmpfile_stdout 21:52:45 INFO - Output received: 21:52:45 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:52:45 INFO - Running post-action listener: _resource_record_post_action 21:52:45 INFO - ##### 21:52:45 INFO - ##### Running run-tests step. 21:52:45 INFO - ##### 21:52:45 INFO - Running pre-action listener: _resource_record_pre_action 21:52:45 INFO - Running main action method: run_tests 21:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:52:45 INFO - Python 2.7.3 21:52:45 INFO - Return code: 0 21:52:45 INFO - grabbing minidump binary from tooltool 21:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:52:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069840>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd66b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd6b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:52:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 21:52:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:52:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:52:45 INFO - Return code: 0 21:52:45 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:52:45 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:52:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:52:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:52:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:52:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:52:46 INFO - Return code: 0 21:52:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:52:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:52:46 INFO - Using env: {'DISPLAY': ':0', 21:52:46 INFO - 'HOME': '/home/cltbld', 21:52:46 INFO - 'LANG': 'en_US.UTF-8', 21:52:46 INFO - 'LANGUAGE': 'en_US:en', 21:52:46 INFO - 'LOGNAME': 'cltbld', 21:52:46 INFO - 'MAIL': '/var/mail/cltbld', 21:52:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:46 INFO - 'MOZ_NO_REMOTE': '1', 21:52:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:52:46 INFO - 'NO_EM_RESTART': '1', 21:52:46 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:52:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:52:46 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:52:46 INFO - 'SHELL': '/bin/bash', 21:52:46 INFO - 'SHLVL': '1', 21:52:46 INFO - 'TERM': 'linux', 21:52:46 INFO - 'TMOUT': '86400', 21:52:46 INFO - 'USER': 'cltbld', 21:52:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330', 21:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:46 INFO - '_': '/tools/buildbot/bin/python'} 21:52:46 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:52:46 INFO - mozversion application_buildid: 20160105193035 21:52:46 INFO - mozversion application_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 21:52:46 INFO - mozversion application_display_name: Nightly 21:52:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:52:46 INFO - mozversion application_name: Firefox 21:52:46 INFO - mozversion application_remotingname: firefox 21:52:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:52:46 INFO - mozversion application_vendor: Mozilla 21:52:46 INFO - mozversion application_version: 46.0a1 21:52:46 INFO - mozversion platform_buildid: 20160105193035 21:52:46 INFO - mozversion platform_changeset: 9d6ffc7a08b6b47056eefe1e652710a3849adbf7 21:52:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:52:46 INFO - mozversion platform_version: 46.0a1 21:52:46 INFO - using testdate: 1452059566 21:52:46 INFO - actual date: 1452059566 21:52:46 INFO - starting webserver on 'localhost:55868' 21:52:46 INFO - SUITE-START | Running 3 tests 21:52:46 INFO - TEST-START | dromaeo_css 21:52:46 INFO - operating with platform_type : linux_ 21:52:46 INFO - Initialising browser for dromaeo_css test... 21:52:46 INFO - TEST-INFO | started process 23265 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaCK3H/profile http://localhost:55868/getInfo.html) 21:52:50 INFO - PROCESS | 23265 | __metrics Screen width/height:1600/1200 21:52:50 INFO - PROCESS | 23265 | colorDepth:24 21:52:50 INFO - PROCESS | 23265 | Browser inner width/height: 1024/697 21:52:50 INFO - PROCESS | 23265 | __metrics 21:52:50 INFO - PROCESS | 23265 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:52:50 INFO - PROCESS | 23265 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:52:51 INFO - TEST-INFO | 23265: exit 0 21:52:51 INFO - Browser initialized. 21:52:51 INFO - Running cycle 1/1 for dromaeo_css test... 21:52:51 INFO - TEST-INFO | started process 23355 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaaCK3H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:53:03 INFO - PROCESS | 23355 | RSS: Main: 150253568 21:53:03 INFO - PROCESS | 23355 | 21:53:54 INFO - PROCESS | 23355 | 1452059634664 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:56:03 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55868/tests/dromaeo/cssquery-ext.html) 21:56:04 INFO - PROCESS | 23355 | RSS: Main: 232329216 21:56:04 INFO - PROCESS | 23355 | 21:59:06 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-ext.html (next: http://localhost:55868/tests/dromaeo/cssquery-jquery.html) 21:59:07 INFO - PROCESS | 23355 | RSS: Main: 238694400 21:59:07 INFO - PROCESS | 23355 | 22:02:09 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55868/tests/dromaeo/cssquery-mootools.html) 22:02:09 INFO - PROCESS | 23355 | RSS: Main: 222515200 22:02:09 INFO - PROCESS | 23355 | 22:05:11 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55868/tests/dromaeo/cssquery-prototype.html) 22:05:12 INFO - PROCESS | 23355 | RSS: Main: 216330240 22:05:12 INFO - PROCESS | 23355 | 22:08:14 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55868/tests/dromaeo/cssquery-yui.html) 22:08:15 INFO - PROCESS | 23355 | RSS: Main: 219844608 22:08:15 INFO - PROCESS | 23355 | 22:11:17 INFO - PROCESS | 23355 | Cycle 1(1): loaded http://localhost:55868/tests/dromaeo/cssquery-yui.html (next: http://localhost:55868/tests/dromaeo/cssquery-dojo.html) 22:11:18 INFO - PROCESS | 23355 | RSS: Main: 292864000 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | __start_tp_report 22:11:18 INFO - PROCESS | 23355 | _x_x_mozilla_page_load 22:11:18 INFO - PROCESS | 23355 | _x_x_mozilla_page_load_details 22:11:18 INFO - PROCESS | 23355 | |i|pagename|runs| 22:11:18 INFO - PROCESS | 23355 | |0;dojo.html;3129.311551458679;3178.1577881861326;3213.501907204384;3213.7429005679564;3240.335731175109;4993.900121997558;5187.351581052369;5208.531232189102;5211.244369566415;5279.815206467774;5189.42916279209;5214.817481388152;5220.138677118271;5223.294855194547;5242.082635538775;4554.931676024862;4672.626189904817;4719.221328480805;4773.976130119345;4868.9269660955115;4669.089527542131;4767.189577771787;4818.373611430527;4831.275308703687;4935.0376676548085;4699.248120300753;4776.044791041805;4784.976075119637;4792.448868380146;4806.519348065183;4784.736839473828;4788.11419887322;4791.784369703371;4804.543568361;4815.49437309081;4659.906801863977;4756.262779269219;4769.737664428455;4774.80900763969;4810.182269014276;5109.9489005109845;5112.41207261166;5130.589552835764;5144.202648589438;5149.819756308549;5617.662940223599;5624.887502249973;5626.718664066781;5629.8592535186945;5674.631148975344;5544.974179776714;5621.971890140523;5629.915551266734;5633.60564760467;5717.056685646863;5286.444923283038;5321.441248668912;5326.041312563737;5331.413544510101;5331.786728530854;5786.218860453785;5806.82579522615;5807.157962095473;5812.88374232513;5859.619124756877;5401.675899445967;5498.257735205776;5503.752331145108;5540.418256083053;5655.773769049274;5660.2075709400715;5695.231143795535;5697.886042279131;5700.515456186187;5705.058665320175;5613.550915926716;5641.435856414408;5659.349174844863;5670.092785154356;5676.8864622707315;5468.808591699351;5566.387697353288;5587.38538760736;5698.287714035746;5702.372738998707;4396.296592545242;4399.824007039747;4406.228909940747;4432.335149727567;4435.512093669694;3896.59085795993;3930.4890364253038;3932.3511620582285;3944.723869329177;3971.5631280559114;5102.923456148161;5179.559737422286;5218.530332270114;5242.633015688942;5293.417724050351;5694.772209111589;5697.572682048863;5702.486776190163;5703.885922281531;5710.343310519261;5268.604854635841;5279.52484276417;5282.234076059027;5283.445238250005;5346.385165705994;4730.172219861511;4796.304535842283;4851.684640498356;4857.611391088704;4904;5750.223719797774;5793.62341447813;5796.478316951495;5796.82609521715;5798.478136967778;5618.831435056954;5634.605577609528;5636.239107720406;5637.182608521824;5638.971805140948;5545.1682247663175;5780.913286300793;5789.421057894177;5912.526997840077;5942.435468630473;5583.860403489945;5585.134304182858;5596.3284405871555;5603.523700485504;5609.635373700697;5630.915536267041;5636.323641163087;5636.661800291996;5642.520385767091;5651.858703532444;5414.214938833768;5506.284183056177;5506.531944784738;5513.558915286687;5626.381098079126;5538.833834984957;5551.111822108604;5552.69460179694;5553.08374118266;5555.50000499957;5455.972720136533;5463.071277882849;5468.4531546845;5468.535174510212;5527.474889885454;5395.541378982673;5403.864903377447;5485.122380419273;5557.527610153183;5644.379118297066;5386.084365657926;5444.047291723853;5451.127819548853;5462.863428414322;5481.561475082063 22:11:18 INFO - PROCESS | 23355 | |1;ext.html;523.092434625924;537.3068741323692;563.3380777586335;570.1106274212228;578.3233616668498;27659.861700691494;28330.575041374395;28340;28354.574681379796;34016.319673606515;38536.42195367072;39065.60934390655;39070;39093;39117.21765564694;8390.790230244262;8529.232369086782;8562.186592273754;8564.357673174505;8568.271696905771;7497.400207983348;7619.199984001683;10071.899281007207;10193.082622563968;10194.59221631134;9922.454265015422;9930.354526955762;9997.600095996188;10020.69937901864;10023.047810457994;7512.887306690404;7620.771376858703;9863.753406164831;9955.153811925995;9961.252906032041;10026.398416095057;10130;10176.338537995007;10178.134858537032;10190.643327483502;36401.45397819035;36721.449178262345;36855.81572092122;36969;37068.44397334042;3004.72957433832;3032.529957856536;3044.8224102110366;3162.920926976821;3577.302426026926;27580;27602;27773.583396249072;28006.85996570004;28532.857335713397;3829.17672700368;3836.4437156612134;3902.2195560887653;3905.9674502712533;3972.7219094663387;258996.9999999981;259497;259909;259982;260329;51480.22779658308;57361;57757.42242577604;57762.13356799651;57828.421715783144;46336;62251.06623400562;63620.681896591144;63643;63725;12769.170003949714;12913.418896149697;12961.935190323988;12967.286799225945;12973.870261297267;11010.284331518586;11085.889141108486;11102.167337449724;11106.500207490682;11118.277311974696;18746.156422961;18802.905985469984;18906;18907.527311817314;18938.90530547366;7407.037085178892;7594.734184303523;7747.147813740484;7749.651265692944;7780.961095194488;848.3849209323191;904.7421484876778;950.1591091883732;951.5765484359532;1041.8385150301715;28156.155315340573;28276;28417.71582284192;28529.286767830556;28683.2829179268;1002.5789168549227;1010.286645242375;1035.6116456328878;1060;1070.4219721350385;14818.851811481964;14849.406023759144;14969.251537423086;15081.472148474752;15125;298665;301796;302129;303260;304472;50926.74536627293;51247.48752512502;51251.743741281054;51336.486635133915;51503.22745158825;1264.64589914824;1290.2065229883553;1291.4317700211877;1295.8056291556343;1302.5766625846638;25539.489210216063;26718.866405667846;27133.72866271391;27173.86413067922;27199.1840244793;41497;45474.31788523241;45863;45873.77063114663;45891.54108458872;176038;293344;295079;297143;298457;29800;30372;30393.848030759706;30399.696003039688;30474.695253048074;39073.2185356297;39638.20723585454;39935;40122.79938600288;40441.1911761769;33913.3217335647;33991;34204;34413.827930860185;34487.31025379428;33995;34365.48451773275;34570.30859382748;34876.65123348835;34948.825255873555;33711.83144084362;33833;34160.658393415746;34406.13984650404;34421.139471513416;26534.601980969914;27407.314817128932;28742.856285719274;29225;29437.85281073581;30336;31057.68942310548;31296.374072518876;31454;31897 22:11:18 INFO - PROCESS | 23355 | |2;jquery.html;344.8120774178074;346.20891263462994;347.1321695760598;347.532568695105;348.2703735673764;13637;13976.510822121229;16232.756508652365;16273.837261627381;17117.74323385149;14069.507567235149;15475.380984760595;15802.13088280144;15833.762493562606;15853.286602102904;5177.559907407875;5303.178007408857;5304.6286759926825;5306.7346632668405;5309.601779866506;4034.11249525104;4106.527749308838;5268.789248430058;5318.76065577048;5677.233573467591;5729.0833466645345;5747.936631723123;5753.424657534255;5767.134929760548;5770.884582308351;5614.635048721841;5745.482906538411;5832.6500409975115;5833.125031245305;5838.1534677471955;5108.463611320795;5118.539331460149;5119.078565858144;5121.769520371592;5123.795048198068;18750.437486875417;20110.39668809938;20224.797752022438;20239.89880050605;20601.690974635392;2021.4643119573325;2071.658176400907;2140.1118535807623;2154.1706443019393;2177.7713340099376;8025.197480251986;9680.854787178198;12599.244045357216;13067.346632668328;13195.736085278337;1761.8238176182408;1783.4293026231612;1791.570023194437;1804.9357438899463;1865.1979648751033;58426.7078664604;60423.39576604265;61227.08159377657;61360.38639613636;62620.37379626191;9438;9592.472414017157;9718.659846905324;9739.318247722591;9774.218062554979;12593.244405335709;12600.810987835006;12607.5587354444;12631.747365052648;12653.683657908627;7048.823779405556;7238.819029524304;7302.56184628924;7372.59450730215;7584.2794934481135;7055.012298278245;7055.753048643272;7080.645967701595;7089.397401220851;7172.713091476283;4219.092895027584;4238.682098842599;4240.151969606091;4243.27864263076;4284.057507348379;1708.5813975576064;1720.7418887167025;1747.501961940866;1759.5601099725068;1784.97322540162;851.8211175653058;872.8210716803167;894.2801045158579;897.1880448194395;931.5016466190556;15812.130332831575;15988.76016859748;16640.58398540022;17094.829051709574;17343.4796956089;812.2567850416802;890.3811850763657;914.5244472874068;917.4770380882833;955.3885513271512;9526.809463810823;9868.358556693793;9937.354071985297;9951.55218015191;9955.900440995641;520238;522859;528868;543990;546487;78444.60777696075;79214;80535.59732201301;80785.59607201927;82244.58877705573;1018.8879223285433;1025.4923812712755;1029.7013865978781;1032.4579595712312;1048.6172547020283;15110.848891511383;15179.544613661608;15209.77185342243;15401.537953861402;15433.84566154324;33274.16814579558;33294.33411331808;34074.31851363008;34230.14424639404;36767.81616091902;37052;38270.23459530738;38385;38908.80545597254;39308.6069139305;9034.819303614022;9064.410813297114;9169.266458683423;9184.862227066465;9186.081391861027;15766.290516926996;16816.831831681528;17162.41772827728;17199.656006880043;17990.190441429906;13873.514426995007;14173.291335432981;14312.785308220176;14588.635284117981;14650.120992740469;13809.102408343426;14335.856641433453;14366.497172598909;14847.925760371128;14870;12036.578719745117;13439.395227214995;13491.325433728078;14040.929795350958;14550.781738273723;8826.42628229163;8839.248663863644;9064.773380665272;9072.002079771088;9083.137101975302;9742.220622350053;9909.702708918743;12485.56300529477;13448.93275533616;14515.709685806436 22:11:18 INFO - PROCESS | 23355 | |3;mootools.html;1297.9545715899944;1414.6251243420495;1415.5399495164072;1533.7852700621916;1732.1685590916359;6408.391202835729;6975.511714180009;7059.3293637104525;7062.152541694991;7071.752488662892;6699.832504187386;6846.110005699252;6846.726130954768;6852.520323577339;6859.897101543468;1930.845532357408;1969.7931717169706;2137.5190582118976;2156.536344685896;2186.6392045312505;2204.1293688992837;2204.162418281051;2208.282308249817;2210.933671989843;2213.7454192767877;2125.415510734545;2220.9777902221012;2224.5439684864564;2226.076178385976;2232.586971410286;2151.7955794199606;2160.2007257314735;2162.048698572623;2184.7815218478186;2198.373463562885;2183.967240491394;2224.5773303072365;2225.321277010511;2226.4656482444257;2239.7200349956256;7172.569645821268;7239.058922340115;7243.456740744466;7258.564486130849;7262.782116536512;4256.170046840867;4312.029793296515;4326.480822301312;4330.415393921811;4345.587169218951;2852.50081235785;2895.073576455535;2958.704129587046;2959.8520073996215;2965.584818125464;941.5433514745343;949.3403772535668;951.5289931483891;978.6721448314823;989;9769.169620582259;9771.316007879452;9781.608735650565;9791.853122203172;9802.607895684165;3948.6841052715713;3962.8018599069933;4000.3799411091327;4041.3533834586324;4092.3656833190903;8393.6222869971;8408.537530435884;8410.873836892451;8418.579071046423;8424.620892059873;4481.058977614737;4496.808345788369;4498.865034048984;4503.527129651405;4504.504504504502;4108.815103320358;4110.856120035784;4111.259973204852;4112.157007813391;4113.280175969194;3263.270466652678;3288.769786114949;3383.137299988487;3483.1814523586936;3524.524189234472;1101.1741194104422;1120.7142178744368;1122.539758698946;1139.8404223408563;1148.3569201247162;1020.9234307426973;1134.9035331996708;1148.3741360958297;1149.3621040322535;1168.2464810197375;6569;6617.7683781067435;6620.635865027373;6621.503387245976;6640.136782218281;1015.969520914359;1144.8339990701302;1166.2535976974743;1182.8876256755766;1187.400362816772;5161.922571161435;5246.790128394898;5247.134222853263;5248.6325957182635;5249.816256431007;8257.95871020641;8275.586220688941;8495.617697203641;8523.57382130891;8660.913390866137;8445.071042185355;8495.895533580595;8512.872306915402;8586.484810911365;8600.354973377021;6782.694778734969;6907.447404207652;6937.479689023243;6943.9652801735665;6994.195667498303;6445.226572811105;6449.355064493513;6449.4517965971545;6455.3221911700475;6456.12842266288;7380.96309518449;7700.576468294297;7701.268379503938;7722.53664780115;7869.960650196713;7641.579713115832;7808.453408261595;7828.5694286812495;7835.255650713173;7930.643121059451;6212;6291.370862913672;6293.937060629335;6302.338254483397;6307.716152773228;6148.077788331786;6228.626282423069;6475.222973243241;6509.1863517060365;6527;6353.237611486651;6464.903026454513;6473.449756770538;6529.249136349191;6587.47300215972;6333.841653958688;6346.428821406095;6361.077643741724;6456.322086180883;6462.870742585216;6281.623102613675;6336.144620476177;6338.809835704752;6343.238811342669;6423.42189202974;5890.381509941566;5932.911006334994;5943.613665111754;5945.702714864326;5951.494122999594;5996.070609055603;6013.188219590299;6089.665068421102;6092.634441933498;6098.847528811638 22:11:18 INFO - PROCESS | 23355 | |4;prototype.html;327.34530938123754;330.75689368314283;331.6617050608378;333.3815771743416;336.62802603123555;5951.553633477491;5966.0752583349595;5996.340402555716;6012.7895523656625;6043.969780151093;5892.263467066617;5928.22933018708;5939.46544810968;5940.257467816523;5942.970285148579;4552.317152427137;4593.563611456906;4594.839180628679;4598.793054312564;4600.987782687804;4428.822847086129;4546.749928753918;4553.317002449626;4553.840615578455;4596.885077873047;4475;4492.371068050459;4500.752458614775;4501.707389019703;4502.257127573963;4320.351947207912;4405.207062728708;4492.056668099686;4496.280595104784;4501.234790085677;3864.613538646141;3872.806359682033;3888.3778595424596;3915.2169566086895;3915.4909861717792;5586.41342659019;5605.663660180361;5634;5658.547316214735;5675.233843431125;4987.700737955734;5094.949050509485;5187.19598462239;5228.111221092423;5269.394019687747;6276.96861515694;6284.622922624657;6295.685215739195;6301;6305.0542418637115;4408.691391602589;4442.800073996678;4448.288273876196;4458.621017213508;4461.5315391883705;6347.936520634827;6519.3154718754795;6606.86786264272;6607.702653380609;6613.834654133637;4448.733076015449;4468.039371535136;4473.776311184428;4474.865754027384;4477.552244775497;4520.819167233274;4528.275475923836;4528.977355113203;4531.8896870266335;4533.0253995390485;5241.947580524222;5250.527452529291;5255.0540902637895;5255.290535777697;5261.316028916216;6171.7531298748445;6349.587276826992;6351.047342898602;6390.233172019387;6407.647579383085;1628.6091338078775;1645.7942757155356;1646.752987051928;1648.736202207665;1648.983510164907;1108.451316598289;1113.7661091170783;1118.697951553076;1134.6822889590928;1135.5287555664306;6016.187814644967;6039.1545183674325;6040.969795150996;6043.002904520705;6046.486048685823;6500.057491663777;6523.575967562093;6529.183852018497;6541.084248205255;6544.149260596092;5920.970395147997;6030.125631783455;6031.215941927521;6031.909521357183;6037.698115094227;3481.3385456763135;3538.469229615578;3540.6636369544854;3542.5217595624263;3546.804925729058;6703.262641109474;6725.932740672629;6776.119104516381;6776.220734615582;6791.660416979132;6458.773942911976;6569.244536878225;6628.204615446178;6693.531452798355;6708.932910670928;6523.282438931808;6657.23441804189;6733.764318248838;6733.9326606734285;6871.14110736158;6528.67356632176;6558.540902136805;6559.278479367361;6571.507136964651;6571.835704107436;6360;6488.935110648833;6493.831110400173;6496.317886622026;6500.284968653539;6768.695408706521;6819.147606549182;6825.658717064226;6827.897581536182;6835.316468353125;4589.38043364155;4594.379758732662;4596.494385617512;4598.655100867381;4601.263797792337;6431.5819471734185;6582.901256481253;6589.703463344257;6590.637514936724;6600.438962688033;6426.260979987362;6429.164208652845;6434.06706027614;6440.935590644033;6445.581037232565;6410.1025856381075;6410.711517981796;6414.93585064162;6419.454346380423;6422.2614399344675;6150.446459818638;6291.748330066746;6305.274893387319;6309.242890853127;6312.810615681537;6450.096986421999;6456.257530384066;6459.741610335534;6462.256840463407;6466.708998095003;6278.968605156945;6292.087647291209;6304.401081897213;6306.810795676137;6307.590006649553 22:11:18 INFO - PROCESS | 23355 | |5;yui.html;735.6101266328848;749.512816669165;750.3959312753235;751.7068343346093;762.6872982077348;12553.246805191695;12693.682657933534;12698;12722.536908255553;12745.235285882842;11234.606788762396;11921.403929803497;11929.403529823518;11948.7610247795;11993.340366279852;650.7559665125578;661.791535666266;792.7819849541364;796.9800754981143;799.2966189753009;788.4126325887222;794.1859593916224;800.6597196191624;803.028335713787;803.6704950970103;814.5519964019795;819.6803246733779;820.0446479850966;820.2289847543291;820.6266148902265;678.6844117485368;684.2575805251308;817.060380562355;820.7209548753452;829.9253067223979;608.6348191085358;609.2354095609982;609.3632154398664;609.5793902207507;609.8322961185665;11960.940195299056;12025.098117641212;12080;12095.576654817127;12127.93936030323;11850.11124165691;12032.21790583618;12150.939245303716;12333.568325108668;12363.320017399039;9724.854127188099;9919.752006199831;10029.097381235724;10061.748456288578;10100.545475453622;3501.1422201560526;3551.4140166872435;3558.466230065485;3562.8574857005688;3566.7146628269675;43920.78039609781;44351.77824110859;46896.29655555169;48532.99999999964;48879.26681099786;9509.717667759687;9687.564059617334;9794.265430092772;9850.359726617748;9869.111779939696;17565.648687026445;17622;17632.118394080502;17637.823621763873;17639.382621608183;7258.274172582699;7335.88996165058;7389.261073892675;7417;7613.238676132342;4066.6136717011836;4103.231704893275;4111.301078816608;4128.318827393507;4188.497380314382;3016.5022771242498;3045.6192975878016;3058.296591783858;3066.7699922505903;3074.339017111332;543.3724048723731;543.8422857371397;547.3240547923311;549.6015388843057;573.1345668041205;499.61280007993366;501.0880198039606;520.6095428428679;536.0083844886929;636.9967301500155;7588.544687318778;7646.158922518519;7680.231976802387;7857.4499785014505;7895.407844411692;541.6236806602641;607.6080927801544;619.7737825693589;624.5784095735361;653.5294587896707;3704.6110158433517;3762.2663580602066;3850.3454412749898;3884.9805750971063;3959.346707793182;47354.76322618365;48328.5167148331;48536.7573162139;48714.512854871704;48762.268565971535;44577.55422445734;44757;48936;49746;49760.25359619609;46137.307940380924;46529.76735116303;46705.76647116743;47378;48417.27374089321;7626.9618651906385;7637.809054773675;7700.884486732815;7720.073591169095;7879.133295337394;32799;32883.83558082194;33899.83050084734;33909.49135763015;34169;43725.56274437342;46405.76797116128;46753.53246467628;47917.28124078211;48139;9317.953410232905;9425.340226184102;9521.666741664008;9763.414195148314;10181.083702466518;10721.028678180373;10721.517531710935;10744.30162039465;10899;11003.834942475709;9421.199198068241;9518.667386566025;9657.46883921391;9995.800083998134;10018.699439016842;9870.457124858201;10165.491725413847;10435.426051567236;10458.63394781179;10560;9287.907120928705;9721.9027809721;9767.267454940766;9891.802163956825;9958.900410996088;8723.552894211576;8968.910310896808;9017.729468115967;9069.410488318239;9354.71935841926;8306.335493160654;8579.699710510102;8611.765173417592;9080.873721909438;9170.312226583166 22:11:18 INFO - PROCESS | 23355 | __end_tp_report 22:11:18 INFO - PROCESS | 23355 | __start_cc_report 22:11:18 INFO - PROCESS | 23355 | _x_x_mozilla_cycle_collect,987 22:11:18 INFO - PROCESS | 23355 | __end_cc_report 22:11:18 INFO - PROCESS | 23355 | __startTimestamp1452060678062__endTimestamp 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | ------- Summary: start ------- 22:11:18 INFO - PROCESS | 23355 | Number of tests: 6 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#0] dojo.html Cycles:165 Average:5234.59 Median:5455.97 stddev:573.64 (10.5%) stddev-sans-first:551.11 22:11:18 INFO - PROCESS | 23355 | Values: 3129.3 3178.2 3213.5 3213.7 3240.3 4993.9 5187.4 5208.5 5211.2 5279.8 5189.4 5214.8 5220.1 5223.3 5242.1 4554.9 4672.6 4719.2 4774.0 4868.9 4669.1 4767.2 4818.4 4831.3 4935.0 4699.2 4776.0 4785.0 4792.4 4806.5 4784.7 4788.1 4791.8 4804.5 4815.5 4659.9 4756.3 4769.7 4774.8 4810.2 5109.9 5112.4 5130.6 5144.2 5149.8 5617.7 5624.9 5626.7 5629.9 5674.6 5545.0 5622.0 5629.9 5633.6 5717.1 5286.4 5321.4 5326.0 5331.4 5331.8 5786.2 5806.8 5807.2 5812.9 5859.6 5401.7 5498.3 5503.8 5540.4 5655.8 5660.2 5695.2 5697.9 5700.5 5705.1 5613.6 5641.4 5659.3 5670.1 5676.9 5468.8 5566.4 5587.4 5698.3 5702.4 4396.3 4399.8 4406.2 4432.3 4435.5 3896.6 3930.5 3932.4 3944.7 3971.6 5102.9 5179.6 5218.5 5242.6 5293.4 5694.8 5697.6 5702.5 5703.9 5710.3 5268.6 5279.5 5282.2 5283.4 5346.4 4730.2 4796.3 4851.7 4857.6 4904.0 5750.2 5793.6 5796.5 5796.8 5798.5 5618.8 5634.6 5636.2 5637.2 5639.0 5545.2 5780.9 5789.4 5912.5 5942.4 5583.9 5585.1 5596.3 5603.5 5609.6 5630.9 5636.3 5636.7 5642.5 5651.9 5414.2 5506.3 5506.5 5513.6 5626.4 5538.8 5551.1 5552.7 5553.1 5555.5 5456.0 5463.1 5468.5 5468.5 5527.5 5395.5 5403.9 5485.1 5557.5 5644.4 5386.1 5444.0 5451.1 5462.9 5481.6 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#1] ext.html Cycles:180 Average:44169.35 Median:31375.19 stddev:73137.82 (233.1%) stddev-sans-first:73269.58 22:11:18 INFO - PROCESS | 23355 | Values: 523.1 537.3 563.3 570.1 578.3 27659.9 28330.6 28340.0 28354.6 34016.3 38536.4 39065.6 39070.0 39093.0 39117.2 8390.8 8529.2 8562.2 8564.4 8568.3 7497.4 7619.2 10071.9 10193.1 10194.6 9922.5 9930.4 9997.6 10020.7 10023.0 7512.9 7620.8 9863.8 9955.2 9961.3 10026.4 10130.0 10176.3 10178.1 10190.6 36401.5 36721.4 36855.8 36969.0 37068.4 3004.7 3032.5 3044.8 3162.9 3577.3 27580.0 27602.0 27773.6 28006.9 28532.9 3829.2 3836.4 3902.2 3906.0 3972.7 258997.0 259497.0 259909.0 259982.0 260329.0 51480.2 57361.0 57757.4 57762.1 57828.4 46336.0 62251.1 63620.7 63643.0 63725.0 12769.2 12913.4 12961.9 12967.3 12973.9 11010.3 11085.9 11102.2 11106.5 11118.3 18746.2 18802.9 18906.0 18907.5 18938.9 7407.0 7594.7 7747.1 7749.7 7781.0 848.4 904.7 950.2 951.6 1041.8 28156.2 28276.0 28417.7 28529.3 28683.3 1002.6 1010.3 1035.6 1060.0 1070.4 14818.9 14849.4 14969.3 15081.5 15125.0 298665.0 301796.0 302129.0 303260.0 304472.0 50926.7 51247.5 51251.7 51336.5 51503.2 1264.6 1290.2 1291.4 1295.8 1302.6 25539.5 26718.9 27133.7 27173.9 27199.2 41497.0 45474.3 45863.0 45873.8 45891.5 176038.0 293344.0 295079.0 297143.0 298457.0 29800.0 30372.0 30393.8 30399.7 30474.7 39073.2 39638.2 39935.0 40122.8 40441.2 33913.3 33991.0 34204.0 34413.8 34487.3 33995.0 34365.5 34570.3 34876.7 34948.8 33711.8 33833.0 34160.7 34406.1 34421.1 26534.6 27407.3 28742.9 29225.0 29437.9 30336.0 31057.7 31296.4 31454.0 31897.0 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#2] jquery.html Cycles:180 Average:28223.27 Median:21671.36 stddev:87025.08 (401.6%) stddev-sans-first:87244.03 22:11:18 INFO - PROCESS | 23355 | Values: 344.8 346.2 347.1 347.5 348.3 13637.0 13976.5 16232.8 16273.8 17117.7 14069.5 15475.4 15802.1 15833.8 15853.3 5177.6 5303.2 5304.6 5306.7 5309.6 4034.1 4106.5 5268.8 5318.8 5677.2 5729.1 5747.9 5753.4 5767.1 5770.9 5614.6 5745.5 5832.7 5833.1 5838.2 5108.5 5118.5 5119.1 5121.8 5123.8 18750.4 20110.4 20224.8 20239.9 20601.7 2021.5 2071.7 2140.1 2154.2 2177.8 8025.2 9680.9 12599.2 13067.3 13195.7 1761.8 1783.4 1791.6 1804.9 1865.2 58426.7 60423.4 61227.1 61360.4 62620.4 9438.0 9592.5 9718.7 9739.3 9774.2 12593.2 12600.8 12607.6 12631.7 12653.7 7048.8 7238.8 7302.6 7372.6 7584.3 7055.0 7055.8 7080.6 7089.4 7172.7 4219.1 4238.7 4240.2 4243.3 4284.1 1708.6 1720.7 1747.5 1759.6 1785.0 851.8 872.8 894.3 897.2 931.5 15812.1 15988.8 16640.6 17094.8 17343.5 812.3 890.4 914.5 917.5 955.4 9526.8 9868.4 9937.4 9951.6 9955.9 520238.0 522859.0 528868.0 543990.0 546487.0 78444.6 79214.0 80535.6 80785.6 82244.6 1018.9 1025.5 1029.7 1032.5 1048.6 15110.8 15179.5 15209.8 15401.5 15433.8 33274.2 33294.3 34074.3 34230.1 36767.8 37052.0 38270.2 38385.0 38908.8 39308.6 9034.8 9064.4 9169.3 9184.9 9186.1 15766.3 16816.8 17162.4 17199.7 17990.2 13873.5 14173.3 14312.8 14588.6 14650.1 13809.1 14335.9 14366.5 14847.9 14870.0 12036.6 13439.4 13491.3 14040.9 14550.8 8826.4 8839.2 9064.8 9072.0 9083.1 9742.2 9909.7 12485.6 13448.9 14515.7 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#3] mootools.html Cycles:180 Average:5018.28 Median:6180.04 stddev:2528.42 (40.9%) stddev-sans-first:2520.05 22:11:18 INFO - PROCESS | 23355 | Values: 1298.0 1414.6 1415.5 1533.8 1732.2 6408.4 6975.5 7059.3 7062.2 7071.8 6699.8 6846.1 6846.7 6852.5 6859.9 1930.8 1969.8 2137.5 2156.5 2186.6 2204.1 2204.2 2208.3 2210.9 2213.7 2125.4 2221.0 2224.5 2226.1 2232.6 2151.8 2160.2 2162.0 2184.8 2198.4 2184.0 2224.6 2225.3 2226.5 2239.7 7172.6 7239.1 7243.5 7258.6 7262.8 4256.2 4312.0 4326.5 4330.4 4345.6 2852.5 2895.1 2958.7 2959.9 2965.6 941.5 949.3 951.5 978.7 989.0 9769.2 9771.3 9781.6 9791.9 9802.6 3948.7 3962.8 4000.4 4041.4 4092.4 8393.6 8408.5 8410.9 8418.6 8424.6 4481.1 4496.8 4498.9 4503.5 4504.5 4108.8 4110.9 4111.3 4112.2 4113.3 3263.3 3288.8 3383.1 3483.2 3524.5 1101.2 1120.7 1122.5 1139.8 1148.4 1020.9 1134.9 1148.4 1149.4 1168.2 6569.0 6617.8 6620.6 6621.5 6640.1 1016.0 1144.8 1166.3 1182.9 1187.4 5161.9 5246.8 5247.1 5248.6 5249.8 8258.0 8275.6 8495.6 8523.6 8660.9 8445.1 8495.9 8512.9 8586.5 8600.4 6782.7 6907.4 6937.5 6944.0 6994.2 6445.2 6449.4 6449.5 6455.3 6456.1 7381.0 7700.6 7701.3 7722.5 7870.0 7641.6 7808.5 7828.6 7835.3 7930.6 6212.0 6291.4 6293.9 6302.3 6307.7 6148.1 6228.6 6475.2 6509.2 6527.0 6353.2 6464.9 6473.4 6529.2 6587.5 6333.8 6346.4 6361.1 6456.3 6462.9 6281.6 6336.1 6338.8 6343.2 6423.4 5890.4 5932.9 5943.6 5945.7 5951.5 5996.1 6013.2 6089.7 6092.6 6098.8 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#4] prototype.html Cycles:180 Average:5296.45 Median:6023.16 stddev:1596.95 (26.5%) stddev-sans-first:1557.26 22:11:18 INFO - PROCESS | 23355 | Values: 327.3 330.8 331.7 333.4 336.6 5951.6 5966.1 5996.3 6012.8 6044.0 5892.3 5928.2 5939.5 5940.3 5943.0 4552.3 4593.6 4594.8 4598.8 4601.0 4428.8 4546.7 4553.3 4553.8 4596.9 4475.0 4492.4 4500.8 4501.7 4502.3 4320.4 4405.2 4492.1 4496.3 4501.2 3864.6 3872.8 3888.4 3915.2 3915.5 5586.4 5605.7 5634.0 5658.5 5675.2 4987.7 5094.9 5187.2 5228.1 5269.4 6277.0 6284.6 6295.7 6301.0 6305.1 4408.7 4442.8 4448.3 4458.6 4461.5 6347.9 6519.3 6606.9 6607.7 6613.8 4448.7 4468.0 4473.8 4474.9 4477.6 4520.8 4528.3 4529.0 4531.9 4533.0 5241.9 5250.5 5255.1 5255.3 5261.3 6171.8 6349.6 6351.0 6390.2 6407.6 1628.6 1645.8 1646.8 1648.7 1649.0 1108.5 1113.8 1118.7 1134.7 1135.5 6016.2 6039.2 6041.0 6043.0 6046.5 6500.1 6523.6 6529.2 6541.1 6544.1 5921.0 6030.1 6031.2 6031.9 6037.7 3481.3 3538.5 3540.7 3542.5 3546.8 6703.3 6725.9 6776.1 6776.2 6791.7 6458.8 6569.2 6628.2 6693.5 6708.9 6523.3 6657.2 6733.8 6733.9 6871.1 6528.7 6558.5 6559.3 6571.5 6571.8 6360.0 6488.9 6493.8 6496.3 6500.3 6768.7 6819.1 6825.7 6827.9 6835.3 4589.4 4594.4 4596.5 4598.7 4601.3 6431.6 6582.9 6589.7 6590.6 6600.4 6426.3 6429.2 6434.1 6440.9 6445.6 6410.1 6410.7 6414.9 6419.5 6422.3 6150.4 6291.7 6305.3 6309.2 6312.8 6450.1 6456.3 6459.7 6462.3 6466.7 6279.0 6292.1 6304.4 6306.8 6307.6 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - PROCESS | 23355 | [#5] yui.html Cycles:180 Average:12976.45 Median:510.85 stddev:15147.62 (2965.2%) stddev-sans-first:15162.22 22:11:18 INFO - PROCESS | 23355 | Values: 735.6 749.5 750.4 751.7 762.7 12553.2 12693.7 12698.0 12722.5 12745.2 11234.6 11921.4 11929.4 11948.8 11993.3 650.8 661.8 792.8 797.0 799.3 788.4 794.2 800.7 803.0 803.7 814.6 819.7 820.0 820.2 820.6 678.7 684.3 817.1 820.7 829.9 608.6 609.2 609.4 609.6 609.8 11960.9 12025.1 12080.0 12095.6 12127.9 11850.1 12032.2 12150.9 12333.6 12363.3 9724.9 9919.8 10029.1 10061.7 10100.5 3501.1 3551.4 3558.5 3562.9 3566.7 43920.8 44351.8 46896.3 48533.0 48879.3 9509.7 9687.6 9794.3 9850.4 9869.1 17565.6 17622.0 17632.1 17637.8 17639.4 7258.3 7335.9 7389.3 7417.0 7613.2 4066.6 4103.2 4111.3 4128.3 4188.5 3016.5 3045.6 3058.3 3066.8 3074.3 543.4 543.8 547.3 549.6 573.1 499.6 501.1 520.6 536.0 637.0 7588.5 7646.2 7680.2 7857.4 7895.4 541.6 607.6 619.8 624.6 653.5 3704.6 3762.3 3850.3 3885.0 3959.3 47354.8 48328.5 48536.8 48714.5 48762.3 44577.6 44757.0 48936.0 49746.0 49760.3 46137.3 46529.8 46705.8 47378.0 48417.3 7627.0 7637.8 7700.9 7720.1 7879.1 32799.0 32883.8 33899.8 33909.5 34169.0 43725.6 46405.8 46753.5 47917.3 48139.0 9318.0 9425.3 9521.7 9763.4 10181.1 10721.0 10721.5 10744.3 10899.0 11003.8 9421.2 9518.7 9657.5 9995.8 10018.7 9870.5 10165.5 10435.4 10458.6 10560.0 9287.9 9721.9 9767.3 9891.8 9958.9 8723.6 8968.9 9017.7 9069.4 9354.7 8306.3 8579.7 8611.8 9080.9 9170.3 22:11:18 INFO - PROCESS | 23355 | -------- Summary: end -------- 22:11:18 INFO - PROCESS | 23355 | 22:11:18 INFO - TEST-INFO | 23355: exit 0 22:11:18 INFO - TEST-OK | dromaeo_css | took 1112450ms 22:11:18 INFO - TEST-START | kraken 22:11:18 INFO - operating with platform_type : linux_ 22:11:18 INFO - Initialising browser for kraken test... 22:11:18 INFO - TEST-INFO | started process 23552 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxF6XG/profile http://localhost:55868/getInfo.html) 22:11:22 INFO - PROCESS | 23552 | __metrics Screen width/height:1600/1200 22:11:22 INFO - PROCESS | 23552 | colorDepth:24 22:11:22 INFO - PROCESS | 23552 | Browser inner width/height: 1024/697 22:11:22 INFO - PROCESS | 23552 | __metrics 22:11:22 INFO - PROCESS | 23552 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:11:22 INFO - PROCESS | 23552 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:11:23 INFO - TEST-INFO | 23552: exit 0 22:11:23 INFO - Browser initialized. 22:11:23 INFO - Running cycle 1/1 for kraken test... 22:11:23 INFO - TEST-INFO | started process 23635 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyxF6XG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:35 INFO - PROCESS | 23635 | RSS: Main: 149794816 22:11:35 INFO - PROCESS | 23635 | 22:11:37 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55868/tests/kraken/driver.html?testName=audio-beat-detection) 22:11:38 INFO - PROCESS | 23635 | RSS: Main: 185245696 22:11:38 INFO - PROCESS | 23635 | 22:11:41 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55868/tests/kraken/driver.html?testName=audio-dft) 22:11:41 INFO - PROCESS | 23635 | RSS: Main: 174342144 22:11:41 INFO - PROCESS | 23635 | 22:11:44 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55868/tests/kraken/driver.html?testName=audio-fft) 22:11:45 INFO - PROCESS | 23635 | RSS: Main: 161157120 22:11:45 INFO - PROCESS | 23635 | 22:11:47 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55868/tests/kraken/driver.html?testName=audio-oscillator) 22:11:47 INFO - PROCESS | 23635 | RSS: Main: 162107392 22:11:47 INFO - PROCESS | 23635 | 22:11:50 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:11:50 INFO - PROCESS | 23635 | RSS: Main: 165253120 22:11:50 INFO - PROCESS | 23635 | 22:11:53 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55868/tests/kraken/driver.html?testName=imaging-darkroom) 22:11:54 INFO - PROCESS | 23635 | RSS: Main: 163868672 22:11:54 INFO - PROCESS | 23635 | 22:11:57 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55868/tests/kraken/driver.html?testName=imaging-desaturate) 22:11:57 INFO - PROCESS | 23635 | RSS: Main: 165478400 22:11:57 INFO - PROCESS | 23635 | 22:12:00 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55868/tests/kraken/driver.html?testName=json-parse-financial) 22:12:01 INFO - PROCESS | 23635 | RSS: Main: 165662720 22:12:01 INFO - PROCESS | 23635 | 22:12:02 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:12:03 INFO - PROCESS | 23635 | RSS: Main: 177848320 22:12:03 INFO - PROCESS | 23635 | 22:12:05 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:12:05 INFO - PROCESS | 23635 | RSS: Main: 176308224 22:12:05 INFO - PROCESS | 23635 | 22:12:07 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:12:08 INFO - PROCESS | 23635 | RSS: Main: 185659392 22:12:08 INFO - PROCESS | 23635 | 22:12:10 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:12:11 INFO - PROCESS | 23635 | RSS: Main: 192884736 22:12:11 INFO - PROCESS | 23635 | 22:12:13 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:12:14 INFO - PROCESS | 23635 | RSS: Main: 191508480 22:12:14 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | Cycle 1(1): loaded http://localhost:55868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55868/tests/kraken/driver.html?testName=ai-astar) 22:12:16 INFO - PROCESS | 23635 | RSS: Main: 249434112 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | __start_tp_report 22:12:16 INFO - PROCESS | 23635 | _x_x_mozilla_page_load 22:12:16 INFO - PROCESS | 23635 | _x_x_mozilla_page_load_details 22:12:16 INFO - PROCESS | 23635 | |i|pagename|runs| 22:12:16 INFO - PROCESS | 23635 | |0;ai-astar;110;110;104;111;111;111;99;110;112;111 22:12:16 INFO - PROCESS | 23635 | |1;audio-beat-detection;153;126;148;162;130;149;148;133;170;127 22:12:16 INFO - PROCESS | 23635 | |2;audio-dft;161;160;161;161;163;161;159;164;164;161 22:12:16 INFO - PROCESS | 23635 | |3;audio-fft;71;73;87;95;74;73;71;103;90;71 22:12:16 INFO - PROCESS | 23635 | |4;audio-oscillator;96;96;144;97;97;96;140;95;96;139 22:12:16 INFO - PROCESS | 23635 | |5;imaging-gaussian-blur;109;109;109;109;108;109;109;110;110;109 22:12:16 INFO - PROCESS | 23635 | |6;imaging-darkroom;147;146;145;146;146;146;147;147;145;146 22:12:16 INFO - PROCESS | 23635 | |7;imaging-desaturate;96;96;96;95;95;95;96;96;95;96 22:12:16 INFO - PROCESS | 23635 | |8;json-parse-financial;57;60;57;56;57;57;58;56;56;56 22:12:16 INFO - PROCESS | 23635 | |9;json-stringify-tinderbox;67;67;68;68;68;68;68;67;67;68 22:12:16 INFO - PROCESS | 23635 | |10;stanford-crypto-aes;84;85;84;85;85;85;85;85;85;85 22:12:16 INFO - PROCESS | 23635 | |11;stanford-crypto-ccm;116;117;119;121;112;124;115;114;131;123 22:12:16 INFO - PROCESS | 23635 | |12;stanford-crypto-pbkdf2;153;144;154;159;151;141;156;153;154;146 22:12:16 INFO - PROCESS | 23635 | |13;stanford-crypto-sha256-iterative;71;74;69;72;69;70;69;71;71;68 22:12:16 INFO - PROCESS | 23635 | __end_tp_report 22:12:16 INFO - PROCESS | 23635 | __start_cc_report 22:12:16 INFO - PROCESS | 23635 | _x_x_mozilla_cycle_collect,916 22:12:16 INFO - PROCESS | 23635 | __end_cc_report 22:12:16 INFO - PROCESS | 23635 | __startTimestamp1452060736511__endTimestamp 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | ------- Summary: start ------- 22:12:16 INFO - PROCESS | 23635 | Number of tests: 14 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:4.35 22:12:16 INFO - PROCESS | 23635 | Values: 110.0 110.0 104.0 111.0 111.0 111.0 99.0 110.0 112.0 111.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:148.50 stddev:15.15 (10.2%) stddev-sans-first:15.76 22:12:16 INFO - PROCESS | 23635 | Values: 153.0 126.0 148.0 162.0 130.0 149.0 148.0 133.0 170.0 127.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 22:12:16 INFO - PROCESS | 23635 | Values: 161.0 160.0 161.0 161.0 163.0 161.0 159.0 164.0 164.0 161.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:11.90 (16.2%) stddev-sans-first:12.08 22:12:16 INFO - PROCESS | 23635 | Values: 71.0 73.0 87.0 95.0 74.0 73.0 71.0 103.0 90.0 71.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:21.71 (22.6%) stddev-sans-first:22.46 22:12:16 INFO - PROCESS | 23635 | Values: 96.0 96.0 144.0 97.0 97.0 96.0 140.0 95.0 96.0 139.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 22:12:16 INFO - PROCESS | 23635 | Values: 109.0 109.0 109.0 109.0 108.0 109.0 109.0 110.0 110.0 109.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 22:12:16 INFO - PROCESS | 23635 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:12:16 INFO - PROCESS | 23635 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.25 (2.2%) stddev-sans-first:1.32 22:12:16 INFO - PROCESS | 23635 | Values: 57.0 60.0 57.0 56.0 57.0 57.0 58.0 56.0 56.0 56.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 22:12:16 INFO - PROCESS | 23635 | Values: 67.0 67.0 68.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 22:12:16 INFO - PROCESS | 23635 | Values: 84.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:120.00 stddev:5.69 (4.7%) stddev-sans-first:5.92 22:12:16 INFO - PROCESS | 23635 | Values: 116.0 117.0 119.0 121.0 112.0 124.0 115.0 114.0 131.0 123.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.10 Median:153.50 stddev:5.67 (3.7%) stddev-sans-first:5.97 22:12:16 INFO - PROCESS | 23635 | Values: 153.0 144.0 154.0 159.0 151.0 141.0 156.0 153.0 154.0 146.0 22:12:16 INFO - PROCESS | 23635 | 22:12:16 INFO - PROCESS | 23635 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 22:12:16 INFO - PROCESS | 23635 | Values: 71.0 74.0 69.0 72.0 69.0 70.0 69.0 71.0 71.0 68.0 22:12:16 INFO - PROCESS | 23635 | -------- Summary: end -------- 22:12:16 INFO - PROCESS | 23635 | 22:12:17 INFO - TEST-INFO | 23635: exit 0 22:12:17 INFO - TEST-OK | kraken | took 58686ms 22:12:17 INFO - TEST-START | v8_7 22:12:17 INFO - operating with platform_type : linux_ 22:12:17 INFO - Initialising browser for v8_7 test... 22:12:17 INFO - TEST-INFO | started process 23886 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaDVB40/profile http://localhost:55868/getInfo.html) 22:12:21 INFO - PROCESS | 23886 | __metrics Screen width/height:1600/1200 22:12:21 INFO - PROCESS | 23886 | colorDepth:24 22:12:21 INFO - PROCESS | 23886 | Browser inner width/height: 1024/697 22:12:21 INFO - PROCESS | 23886 | __metrics 22:12:21 INFO - PROCESS | 23886 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:12:21 INFO - PROCESS | 23886 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:12:22 INFO - TEST-INFO | 23886: exit 0 22:12:22 INFO - Browser initialized. 22:12:22 INFO - Running cycle 1/1 for v8_7 test... 22:12:22 INFO - TEST-INFO | started process 23969 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpaDVB40/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:34 INFO - PROCESS | 23969 | RSS: Main: 149786624 22:12:34 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | Cycle 1(1): loaded http://localhost:55868/tests/v8_7/run.html (next: http://localhost:55868/tests/v8_7/run.html) 22:12:55 INFO - PROCESS | 23969 | RSS: Main: 555577344 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | __start_tp_report 22:12:55 INFO - PROCESS | 23969 | _x_x_mozilla_page_load 22:12:55 INFO - PROCESS | 23969 | _x_x_mozilla_page_load_details 22:12:55 INFO - PROCESS | 23969 | |i|pagename|runs| 22:12:55 INFO - PROCESS | 23969 | |0;Richards;167.0843776106934 22:12:55 INFO - PROCESS | 23969 | |1;DeltaBlue;199.96000799840033 22:12:55 INFO - PROCESS | 23969 | |2;Encrypt;284.57598178713715 22:12:55 INFO - PROCESS | 23969 | |3;Decrypt;5202.072538860104 22:12:55 INFO - PROCESS | 23969 | |4;RayTrace;1941.860465116279 22:12:55 INFO - PROCESS | 23969 | |5;Earley;809.7165991902834 22:12:55 INFO - PROCESS | 23969 | |6;Boyer;11788.235294117647 22:12:55 INFO - PROCESS | 23969 | |7;RegExp;27135.135135135137 22:12:55 INFO - PROCESS | 23969 | |8;Splay;588.6150234741784 22:12:55 INFO - PROCESS | 23969 | |9;NavierStokes;4840.579710144928 22:12:55 INFO - PROCESS | 23969 | __end_tp_report 22:12:55 INFO - PROCESS | 23969 | __startTimestamp1452060775923__endTimestamp 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | ------- Summary: start ------- 22:12:55 INFO - PROCESS | 23969 | Number of tests: 10 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#0] Richards Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 167.1 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#1] DeltaBlue Cycles:1 Average:199.96 Median:199.96 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 200.0 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#2] Encrypt Cycles:1 Average:284.58 Median:284.58 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 284.6 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 5202.1 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#4] RayTrace Cycles:1 Average:1941.86 Median:1941.86 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 1941.9 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#5] Earley Cycles:1 Average:809.72 Median:809.72 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 809.7 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#6] Boyer Cycles:1 Average:11788.24 Median:11788.24 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 11788.2 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#7] RegExp Cycles:1 Average:27135.14 Median:27135.14 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 27135.1 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#8] Splay Cycles:1 Average:588.62 Median:588.62 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 588.6 22:12:55 INFO - PROCESS | 23969 | 22:12:55 INFO - PROCESS | 23969 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:12:55 INFO - PROCESS | 23969 | Values: 4840.6 22:12:55 INFO - PROCESS | 23969 | -------- Summary: end -------- 22:12:55 INFO - PROCESS | 23969 | 22:12:56 INFO - TEST-INFO | 23969: exit 0 22:12:56 INFO - TEST-OK | v8_7 | took 39346ms 22:12:56 INFO - SUITE-END | took 1210s 22:12:56 INFO - Completed test suite (00:20:10) 22:12:56 INFO - Working with test: dromaeo_css 22:12:56 INFO - Generating results file: dromaeo_css 22:12:56 INFO - Working with test: kraken 22:12:56 INFO - Generating results file: kraken 22:12:56 INFO - javascript benchmark 22:12:56 INFO - Working with test: v8_7 22:12:56 INFO - Generating results file: v8_7 22:12:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 22:12:57 INFO - process_Request line: dromaeo_css 6747.15 graph.html#tests=[[72,1,35]] 22:12:57 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:57 INFO - process_Request line: kraken 1506.30 graph.html#tests=[[232,1,35]] 22:12:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:12:57 INFO - process_Request line: v8_7 19695.16 graph.html#tests=[[230,1,35]] 22:12:57 INFO - RETURN: dromaeo_css: 6747.15 22:12:57 INFO - RETURN: kraken: 1506.30 22:12:57 INFO - RETURN: v8_7: 19695.16 22:12:57 INFO - javascript benchmark 22:12:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3129.311551458679, 3178.1577881861326, 3213.501907204384, 3213.7429005679564, 3240.335731175109, 4993.900121997558, 5187.351581052369, 5208.531232189102, 5211.244369566415, 5279.815206467774, 5189.42916279209, 5214.817481388152, 5220.138677118271, 5223.294855194547, 5242.082635538775, 4554.931676024862, 4672.626189904817, 4719.221328480805, 4773.976130119345, 4868.9269660955115, 4669.089527542131, 4767.189577771787, 4818.373611430527, 4831.275308703687, 4935.0376676548085, 4699.248120300753, 4776.044791041805, 4784.976075119637, 4792.448868380146, 4806.519348065183, 4784.736839473828, 4788.11419887322, 4791.784369703371, 4804.543568361, 4815.49437309081, 4659.906801863977, 4756.262779269219, 4769.737664428455, 4774.80900763969, 4810.182269014276, 5109.9489005109845, 5112.41207261166, 5130.589552835764, 5144.202648589438, 5149.819756308549, 5617.662940223599, 5624.887502249973, 5626.718664066781, 5629.8592535186945, 5674.631148975344, 5544.974179776714, 5621.971890140523, 5629.915551266734, 5633.60564760467, 5717.056685646863, 5286.444923283038, 5321.441248668912, 5326.041312563737, 5331.413544510101, 5331.786728530854, 5786.218860453785, 5806.82579522615, 5807.157962095473, 5812.88374232513, 5859.619124756877, 5401.675899445967, 5498.257735205776, 5503.752331145108, 5540.418256083053, 5655.773769049274, 5660.2075709400715, 5695.231143795535, 5697.886042279131, 5700.515456186187, 5705.058665320175, 5613.550915926716, 5641.435856414408, 5659.349174844863, 5670.092785154356, 5676.8864622707315, 5468.808591699351, 5566.387697353288, 5587.38538760736, 5698.287714035746, 5702.372738998707, 4396.296592545242, 4399.824007039747, 4406.228909940747, 4432.335149727567, 4435.512093669694, 3896.59085795993, 3930.4890364253038, 3932.3511620582285, 3944.723869329177, 3971.5631280559114, 5102.923456148161, 5179.559737422286, 5218.530332270114, 5242.633015688942, 5293.417724050351, 5694.772209111589, 5697.572682048863, 5702.486776190163, 5703.885922281531, 5710.343310519261, 5268.604854635841, 5279.52484276417, 5282.234076059027, 5283.445238250005, 5346.385165705994, 4730.172219861511, 4796.304535842283, 4851.684640498356, 4857.611391088704, 4904.0, 5750.223719797774, 5793.62341447813, 5796.478316951495, 5796.82609521715, 5798.478136967778, 5618.831435056954, 5634.605577609528, 5636.239107720406, 5637.182608521824, 5638.971805140948, 5545.1682247663175, 5780.913286300793, 5789.421057894177, 5912.526997840077, 5942.435468630473, 5583.860403489945, 5585.134304182858, 5596.3284405871555, 5603.523700485504, 5609.635373700697, 5630.915536267041, 5636.323641163087, 5636.661800291996, 5642.520385767091, 5651.858703532444, 5414.214938833768, 5506.284183056177, 5506.531944784738, 5513.558915286687, 5626.381098079126, 5538.833834984957, 5551.111822108604, 5552.69460179694, 5553.08374118266, 5555.50000499957, 5455.972720136533, 5463.071277882849, 5468.4531546845, 5468.535174510212, 5527.474889885454, 5395.541378982673, 5403.864903377447, 5485.122380419273, 5557.527610153183, 5644.379118297066, 5386.084365657926, 5444.047291723853, 5451.127819548853, 5462.863428414322, 5481.561475082063], "unit": "score", "name": "dojo.html", "value": 5198.284926068994}, {"lowerIsBetter": false, "replicates": [523.092434625924, 537.3068741323692, 563.3380777586335, 570.1106274212228, 578.3233616668498, 27659.861700691494, 28330.575041374395, 28340.0, 28354.574681379796, 34016.319673606515, 38536.42195367072, 39065.60934390655, 39070.0, 39093.0, 39117.21765564694, 8390.790230244262, 8529.232369086782, 8562.186592273754, 8564.357673174505, 8568.271696905771, 7497.400207983348, 7619.199984001683, 10071.899281007207, 10193.082622563968, 10194.59221631134, 9922.454265015422, 9930.354526955762, 9997.600095996188, 10020.69937901864, 10023.047810457994, 7512.887306690404, 7620.771376858703, 9863.753406164831, 9955.153811925995, 9961.252906032041, 10026.398416095057, 10130.0, 10176.338537995007, 10178.134858537032, 10190.643327483502, 36401.45397819035, 36721.449178262345, 36855.81572092122, 36969.0, 37068.44397334042, 3004.72957433832, 3032.529957856536, 3044.8224102110366, 3162.920926976821, 3577.302426026926, 27580.0, 27602.0, 27773.583396249072, 28006.85996570004, 28532.857335713397, 3829.17672700368, 3836.4437156612134, 3902.2195560887653, 3905.9674502712533, 3972.7219094663387, 258996.9999999981, 259497.0, 259909.0, 259982.0, 260329.0, 51480.22779658308, 57361.0, 57757.42242577604, 57762.13356799651, 57828.421715783144, 46336.0, 62251.06623400562, 63620.681896591144, 63643.0, 63725.0, 12769.170003949714, 12913.418896149697, 12961.935190323988, 12967.286799225945, 12973.870261297267, 11010.284331518586, 11085.889141108486, 11102.167337449724, 11106.500207490682, 11118.277311974696, 18746.156422961, 18802.905985469984, 18906.0, 18907.527311817314, 18938.90530547366, 7407.037085178892, 7594.734184303523, 7747.147813740484, 7749.651265692944, 7780.961095194488, 848.3849209323191, 904.7421484876778, 950.1591091883732, 951.5765484359532, 1041.8385150301715, 28156.155315340573, 28276.0, 28417.71582284192, 28529.286767830556, 28683.2829179268, 1002.5789168549227, 1010.286645242375, 1035.6116456328878, 1060.0, 1070.4219721350385, 14818.851811481964, 14849.406023759144, 14969.251537423086, 15081.472148474752, 15125.0, 298665.0, 301796.0, 302129.0, 303260.0, 304472.0, 50926.74536627293, 51247.48752512502, 51251.743741281054, 51336.486635133915, 51503.22745158825, 1264.64589914824, 1290.2065229883553, 1291.4317700211877, 1295.8056291556343, 1302.5766625846638, 25539.489210216063, 26718.866405667846, 27133.72866271391, 27173.86413067922, 27199.1840244793, 41497.0, 45474.31788523241, 45863.0, 45873.77063114663, 45891.54108458872, 176038.0, 293344.0, 295079.0, 297143.0, 298457.0, 29800.0, 30372.0, 30393.848030759706, 30399.696003039688, 30474.695253048074, 39073.2185356297, 39638.20723585454, 39935.0, 40122.79938600288, 40441.1911761769, 33913.3217335647, 33991.0, 34204.0, 34413.827930860185, 34487.31025379428, 33995.0, 34365.48451773275, 34570.30859382748, 34876.65123348835, 34948.825255873555, 33711.83144084362, 33833.0, 34160.658393415746, 34406.13984650404, 34421.139471513416, 26534.601980969914, 27407.314817128932, 28742.856285719274, 29225.0, 29437.85281073581, 30336.0, 31057.68942310548, 31296.374072518876, 31454.0, 31897.0], "unit": "score", "name": "ext.html", "value": 17871.207699139643}, {"lowerIsBetter": false, "replicates": [344.8120774178074, 346.20891263462994, 347.1321695760598, 347.532568695105, 348.2703735673764, 13637.0, 13976.510822121229, 16232.756508652365, 16273.837261627381, 17117.74323385149, 14069.507567235149, 15475.380984760595, 15802.13088280144, 15833.762493562606, 15853.286602102904, 5177.559907407875, 5303.178007408857, 5304.6286759926825, 5306.7346632668405, 5309.601779866506, 4034.11249525104, 4106.527749308838, 5268.789248430058, 5318.76065577048, 5677.233573467591, 5729.0833466645345, 5747.936631723123, 5753.424657534255, 5767.134929760548, 5770.884582308351, 5614.635048721841, 5745.482906538411, 5832.6500409975115, 5833.125031245305, 5838.1534677471955, 5108.463611320795, 5118.539331460149, 5119.078565858144, 5121.769520371592, 5123.795048198068, 18750.437486875417, 20110.39668809938, 20224.797752022438, 20239.89880050605, 20601.690974635392, 2021.4643119573325, 2071.658176400907, 2140.1118535807623, 2154.1706443019393, 2177.7713340099376, 8025.197480251986, 9680.854787178198, 12599.244045357216, 13067.346632668328, 13195.736085278337, 1761.8238176182408, 1783.4293026231612, 1791.570023194437, 1804.9357438899463, 1865.1979648751033, 58426.7078664604, 60423.39576604265, 61227.08159377657, 61360.38639613636, 62620.37379626191, 9438.0, 9592.472414017157, 9718.659846905324, 9739.318247722591, 9774.218062554979, 12593.244405335709, 12600.810987835006, 12607.5587354444, 12631.747365052648, 12653.683657908627, 7048.823779405556, 7238.819029524304, 7302.56184628924, 7372.59450730215, 7584.2794934481135, 7055.012298278245, 7055.753048643272, 7080.645967701595, 7089.397401220851, 7172.713091476283, 4219.092895027584, 4238.682098842599, 4240.151969606091, 4243.27864263076, 4284.057507348379, 1708.5813975576064, 1720.7418887167025, 1747.501961940866, 1759.5601099725068, 1784.97322540162, 851.8211175653058, 872.8210716803167, 894.2801045158579, 897.1880448194395, 931.5016466190556, 15812.130332831575, 15988.76016859748, 16640.58398540022, 17094.829051709574, 17343.4796956089, 812.2567850416802, 890.3811850763657, 914.5244472874068, 917.4770380882833, 955.3885513271512, 9526.809463810823, 9868.358556693793, 9937.354071985297, 9951.55218015191, 9955.900440995641, 520238.0, 522859.0, 528868.0, 543990.0, 546487.0, 78444.60777696075, 79214.0, 80535.59732201301, 80785.59607201927, 82244.58877705573, 1018.8879223285433, 1025.4923812712755, 1029.7013865978781, 1032.4579595712312, 1048.6172547020283, 15110.848891511383, 15179.544613661608, 15209.77185342243, 15401.537953861402, 15433.84566154324, 33274.16814579558, 33294.33411331808, 34074.31851363008, 34230.14424639404, 36767.81616091902, 37052.0, 38270.23459530738, 38385.0, 38908.80545597254, 39308.6069139305, 9034.819303614022, 9064.410813297114, 9169.266458683423, 9184.862227066465, 9186.081391861027, 15766.290516926996, 16816.831831681528, 17162.41772827728, 17199.656006880043, 17990.190441429906, 13873.514426995007, 14173.291335432981, 14312.785308220176, 14588.635284117981, 14650.120992740469, 13809.102408343426, 14335.856641433453, 14366.497172598909, 14847.925760371128, 14870.0, 12036.578719745117, 13439.395227214995, 13491.325433728078, 14040.929795350958, 14550.781738273723, 8826.42628229163, 8839.248663863644, 9064.773380665272, 9072.002079771088, 9083.137101975302, 9742.220622350053, 9909.702708918743, 12485.56300529477, 13448.93275533616, 14515.709685806436], "unit": "score", "name": "jquery.html", "value": 8622.217720414603}, {"lowerIsBetter": false, "replicates": [1297.9545715899944, 1414.6251243420495, 1415.5399495164072, 1533.7852700621916, 1732.1685590916359, 6408.391202835729, 6975.511714180009, 7059.3293637104525, 7062.152541694991, 7071.752488662892, 6699.832504187386, 6846.110005699252, 6846.726130954768, 6852.520323577339, 6859.897101543468, 1930.845532357408, 1969.7931717169706, 2137.5190582118976, 2156.536344685896, 2186.6392045312505, 2204.1293688992837, 2204.162418281051, 2208.282308249817, 2210.933671989843, 2213.7454192767877, 2125.415510734545, 2220.9777902221012, 2224.5439684864564, 2226.076178385976, 2232.586971410286, 2151.7955794199606, 2160.2007257314735, 2162.048698572623, 2184.7815218478186, 2198.373463562885, 2183.967240491394, 2224.5773303072365, 2225.321277010511, 2226.4656482444257, 2239.7200349956256, 7172.569645821268, 7239.058922340115, 7243.456740744466, 7258.564486130849, 7262.782116536512, 4256.170046840867, 4312.029793296515, 4326.480822301312, 4330.415393921811, 4345.587169218951, 2852.50081235785, 2895.073576455535, 2958.704129587046, 2959.8520073996215, 2965.584818125464, 941.5433514745343, 949.3403772535668, 951.5289931483891, 978.6721448314823, 989.0, 9769.169620582259, 9771.316007879452, 9781.608735650565, 9791.853122203172, 9802.607895684165, 3948.6841052715713, 3962.8018599069933, 4000.3799411091327, 4041.3533834586324, 4092.3656833190903, 8393.6222869971, 8408.537530435884, 8410.873836892451, 8418.579071046423, 8424.620892059873, 4481.058977614737, 4496.808345788369, 4498.865034048984, 4503.527129651405, 4504.504504504502, 4108.815103320358, 4110.856120035784, 4111.259973204852, 4112.157007813391, 4113.280175969194, 3263.270466652678, 3288.769786114949, 3383.137299988487, 3483.1814523586936, 3524.524189234472, 1101.1741194104422, 1120.7142178744368, 1122.539758698946, 1139.8404223408563, 1148.3569201247162, 1020.9234307426973, 1134.9035331996708, 1148.3741360958297, 1149.3621040322535, 1168.2464810197375, 6569.0, 6617.7683781067435, 6620.635865027373, 6621.503387245976, 6640.136782218281, 1015.969520914359, 1144.8339990701302, 1166.2535976974743, 1182.8876256755766, 1187.400362816772, 5161.922571161435, 5246.790128394898, 5247.134222853263, 5248.6325957182635, 5249.816256431007, 8257.95871020641, 8275.586220688941, 8495.617697203641, 8523.57382130891, 8660.913390866137, 8445.071042185355, 8495.895533580595, 8512.872306915402, 8586.484810911365, 8600.354973377021, 6782.694778734969, 6907.447404207652, 6937.479689023243, 6943.9652801735665, 6994.195667498303, 6445.226572811105, 6449.355064493513, 6449.4517965971545, 6455.3221911700475, 6456.12842266288, 7380.96309518449, 7700.576468294297, 7701.268379503938, 7722.53664780115, 7869.960650196713, 7641.579713115832, 7808.453408261595, 7828.5694286812495, 7835.255650713173, 7930.643121059451, 6212.0, 6291.370862913672, 6293.937060629335, 6302.338254483397, 6307.716152773228, 6148.077788331786, 6228.626282423069, 6475.222973243241, 6509.1863517060365, 6527.0, 6353.237611486651, 6464.903026454513, 6473.449756770538, 6529.249136349191, 6587.47300215972, 6333.841653958688, 6346.428821406095, 6361.077643741724, 6456.322086180883, 6462.870742585216, 6281.623102613675, 6336.144620476177, 6338.809835704752, 6343.238811342669, 6423.42189202974, 5890.381509941566, 5932.911006334994, 5943.613665111754, 5945.702714864326, 5951.494122999594, 5996.070609055603, 6013.188219590299, 6089.665068421102, 6092.634441933498, 6098.847528811638], "unit": "score", "name": "mootools.html", "value": 4177.400529490107}, {"lowerIsBetter": false, "replicates": [327.34530938123754, 330.75689368314283, 331.6617050608378, 333.3815771743416, 336.62802603123555, 5951.553633477491, 5966.0752583349595, 5996.340402555716, 6012.7895523656625, 6043.969780151093, 5892.263467066617, 5928.22933018708, 5939.46544810968, 5940.257467816523, 5942.970285148579, 4552.317152427137, 4593.563611456906, 4594.839180628679, 4598.793054312564, 4600.987782687804, 4428.822847086129, 4546.749928753918, 4553.317002449626, 4553.840615578455, 4596.885077873047, 4475.0, 4492.371068050459, 4500.752458614775, 4501.707389019703, 4502.257127573963, 4320.351947207912, 4405.207062728708, 4492.056668099686, 4496.280595104784, 4501.234790085677, 3864.613538646141, 3872.806359682033, 3888.3778595424596, 3915.2169566086895, 3915.4909861717792, 5586.41342659019, 5605.663660180361, 5634.0, 5658.547316214735, 5675.233843431125, 4987.700737955734, 5094.949050509485, 5187.19598462239, 5228.111221092423, 5269.394019687747, 6276.96861515694, 6284.622922624657, 6295.685215739195, 6301.0, 6305.0542418637115, 4408.691391602589, 4442.800073996678, 4448.288273876196, 4458.621017213508, 4461.5315391883705, 6347.936520634827, 6519.3154718754795, 6606.86786264272, 6607.702653380609, 6613.834654133637, 4448.733076015449, 4468.039371535136, 4473.776311184428, 4474.865754027384, 4477.552244775497, 4520.819167233274, 4528.275475923836, 4528.977355113203, 4531.8896870266335, 4533.0253995390485, 5241.947580524222, 5250.527452529291, 5255.0540902637895, 5255.290535777697, 5261.316028916216, 6171.7531298748445, 6349.587276826992, 6351.047342898602, 6390.233172019387, 6407.647579383085, 1628.6091338078775, 1645.7942757155356, 1646.752987051928, 1648.736202207665, 1648.983510164907, 1108.451316598289, 1113.7661091170783, 1118.697951553076, 1134.6822889590928, 1135.5287555664306, 6016.187814644967, 6039.1545183674325, 6040.969795150996, 6043.002904520705, 6046.486048685823, 6500.057491663777, 6523.575967562093, 6529.183852018497, 6541.084248205255, 6544.149260596092, 5920.970395147997, 6030.125631783455, 6031.215941927521, 6031.909521357183, 6037.698115094227, 3481.3385456763135, 3538.469229615578, 3540.6636369544854, 3542.5217595624263, 3546.804925729058, 6703.262641109474, 6725.932740672629, 6776.119104516381, 6776.220734615582, 6791.660416979132, 6458.773942911976, 6569.244536878225, 6628.204615446178, 6693.531452798355, 6708.932910670928, 6523.282438931808, 6657.23441804189, 6733.764318248838, 6733.9326606734285, 6871.14110736158, 6528.67356632176, 6558.540902136805, 6559.278479367361, 6571.507136964651, 6571.835704107436, 6360.0, 6488.935110648833, 6493.831110400173, 6496.317886622026, 6500.284968653539, 6768.695408706521, 6819.147606549182, 6825.658717064226, 6827.897581536182, 6835.316468353125, 4589.38043364155, 4594.379758732662, 4596.494385617512, 4598.655100867381, 4601.263797792337, 6431.5819471734185, 6582.901256481253, 6589.703463344257, 6590.637514936724, 6600.438962688033, 6426.260979987362, 6429.164208652845, 6434.06706027614, 6440.935590644033, 6445.581037232565, 6410.1025856381075, 6410.711517981796, 6414.93585064162, 6419.454346380423, 6422.2614399344675, 6150.446459818638, 6291.748330066746, 6305.274893387319, 6309.242890853127, 6312.810615681537, 6450.096986421999, 6456.257530384066, 6459.741610335534, 6462.256840463407, 6466.708998095003, 6278.968605156945, 6292.087647291209, 6304.401081897213, 6306.810795676137, 6307.590006649553], "unit": "score", "name": "prototype.html", "value": 4780.87422105938}, {"lowerIsBetter": false, "replicates": [735.6101266328848, 749.512816669165, 750.3959312753235, 751.7068343346093, 762.6872982077348, 12553.246805191695, 12693.682657933534, 12698.0, 12722.536908255553, 12745.235285882842, 11234.606788762396, 11921.403929803497, 11929.403529823518, 11948.7610247795, 11993.340366279852, 650.7559665125578, 661.791535666266, 792.7819849541364, 796.9800754981143, 799.2966189753009, 788.4126325887222, 794.1859593916224, 800.6597196191624, 803.028335713787, 803.6704950970103, 814.5519964019795, 819.6803246733779, 820.0446479850966, 820.2289847543291, 820.6266148902265, 678.6844117485368, 684.2575805251308, 817.060380562355, 820.7209548753452, 829.9253067223979, 608.6348191085358, 609.2354095609982, 609.3632154398664, 609.5793902207507, 609.8322961185665, 11960.940195299056, 12025.098117641212, 12080.0, 12095.576654817127, 12127.93936030323, 11850.11124165691, 12032.21790583618, 12150.939245303716, 12333.568325108668, 12363.320017399039, 9724.854127188099, 9919.752006199831, 10029.097381235724, 10061.748456288578, 10100.545475453622, 3501.1422201560526, 3551.4140166872435, 3558.466230065485, 3562.8574857005688, 3566.7146628269675, 43920.78039609781, 44351.77824110859, 46896.29655555169, 48532.99999999964, 48879.26681099786, 9509.717667759687, 9687.564059617334, 9794.265430092772, 9850.359726617748, 9869.111779939696, 17565.648687026445, 17622.0, 17632.118394080502, 17637.823621763873, 17639.382621608183, 7258.274172582699, 7335.88996165058, 7389.261073892675, 7417.0, 7613.238676132342, 4066.6136717011836, 4103.231704893275, 4111.301078816608, 4128.318827393507, 4188.497380314382, 3016.5022771242498, 3045.6192975878016, 3058.296591783858, 3066.7699922505903, 3074.339017111332, 543.3724048723731, 543.8422857371397, 547.3240547923311, 549.6015388843057, 573.1345668041205, 499.61280007993366, 501.0880198039606, 520.6095428428679, 536.0083844886929, 636.9967301500155, 7588.544687318778, 7646.158922518519, 7680.231976802387, 7857.4499785014505, 7895.407844411692, 541.6236806602641, 607.6080927801544, 619.7737825693589, 624.5784095735361, 653.5294587896707, 3704.6110158433517, 3762.2663580602066, 3850.3454412749898, 3884.9805750971063, 3959.346707793182, 47354.76322618365, 48328.5167148331, 48536.7573162139, 48714.512854871704, 48762.268565971535, 44577.55422445734, 44757.0, 48936.0, 49746.0, 49760.25359619609, 46137.307940380924, 46529.76735116303, 46705.76647116743, 47378.0, 48417.27374089321, 7626.9618651906385, 7637.809054773675, 7700.884486732815, 7720.073591169095, 7879.133295337394, 32799.0, 32883.83558082194, 33899.83050084734, 33909.49135763015, 34169.0, 43725.56274437342, 46405.76797116128, 46753.53246467628, 47917.28124078211, 48139.0, 9317.953410232905, 9425.340226184102, 9521.666741664008, 9763.414195148314, 10181.083702466518, 10721.028678180373, 10721.517531710935, 10744.30162039465, 10899.0, 11003.834942475709, 9421.199198068241, 9518.667386566025, 9657.46883921391, 9995.800083998134, 10018.699439016842, 9870.457124858201, 10165.491725413847, 10435.426051567236, 10458.63394781179, 10560.0, 9287.907120928705, 9721.9027809721, 9767.267454940766, 9891.802163956825, 9958.900410996088, 8723.552894211576, 8968.910310896808, 9017.729468115967, 9069.410488318239, 9354.71935841926, 8306.335493160654, 8579.699710510102, 8611.765173417592, 9080.873721909438, 9170.312226583166], "unit": "score", "name": "yui.html", "value": 5897.093547249703}], "name": "dromaeo_css", "value": 6747.156937909116}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 111.0, 111.0, 111.0, 99.0, 110.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [153.0, 126.0, 148.0, 162.0, 130.0, 149.0, 148.0, 133.0, 170.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 144.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 161.0, 163.0, 161.0, 159.0, 164.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 87.0, 95.0, 74.0, 73.0, 71.0, 103.0, 90.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 144.0, 97.0, 97.0, 96.0, 140.0, 95.0, 96.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 57.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 119.0, 121.0, 112.0, 124.0, 115.0, 114.0, 131.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [153.0, 144.0, 154.0, 159.0, 151.0, 141.0, 156.0, 153.0, 154.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.1}, {"lowerIsBetter": true, "replicates": [71.0, 74.0, 69.0, 72.0, 69.0, 70.0, 69.0, 71.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1506.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "Richards", "value": 211.28247000000007}, {"lowerIsBetter": false, "replicates": [199.96000799840033], "unit": "score", "name": "DeltaBlue", "value": 330.65611800000005}, {"lowerIsBetter": false, "replicates": [284.57598178713715], "unit": "score", "name": "Encrypt", "value": 935.3600340000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1941.860465116279], "unit": "score", "name": "RayTrace", "value": 381.07217964071845}, {"lowerIsBetter": false, "replicates": [809.7165991902834], "unit": "score", "name": "Earley", "value": 823.0818049999997}, {"lowerIsBetter": false, "replicates": [11788.235294117647], "unit": "score", "name": "Boyer", "value": 56.536282435129706}, {"lowerIsBetter": false, "replicates": [27135.135135135137], "unit": "score", "name": "RegExp", "value": 33.572156374501965}, {"lowerIsBetter": false, "replicates": [588.6150234741784], "unit": "score", "name": "Splay", "value": 138.44532801595213}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19695.1599926721}]} 22:12:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19695.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1506.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6747.15"}}} 22:12:57 INFO - Return code: 0 22:12:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:12:57 INFO - # TBPL SUCCESS # 22:12:57 INFO - Running post-action listener: _resource_record_post_action 22:12:57 INFO - Running post-run listener: _resource_record_post_run 22:12:58 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 564244480; Read time: 0; Write time: 404228 22:12:58 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255328256; Read time: 0; Write time: 219784 22:12:58 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 308629504; Read time: 0; Write time: 184416 22:12:58 INFO - Running post-run listener: _upload_blobber_files 22:12:58 INFO - Blob upload gear active. 22:12:58 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:12:58 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:12:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:12:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:13:29 INFO - (blobuploader) - INFO - Open directory for files ... 22:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:13:30 INFO - (blobuploader) - INFO - Done attempting. 22:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:13:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:13:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:13:31 INFO - (blobuploader) - INFO - Done attempting. 22:13:31 INFO - (blobuploader) - INFO - Iteration through files over. 22:13:31 INFO - Return code: 0 22:13:31 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:13:31 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:13:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d39545f32726410041d0bf7dd00a24e1129b2374092e6bc3e878eea2c3383f5ce46a94fcab820981a41782ca3daa36f837fe8f4e4a8d04570c43f74722822a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d320c19062c28ce8e064fc2d88a02f212c73354cb11e28586eadf123592064c3055db6a526c12f53e5a2ae5b473990f459c7a004513d6ecfeee47564d4892549"} 22:13:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:13:31 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:13:31 INFO - Contents: 22:13:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d39545f32726410041d0bf7dd00a24e1129b2374092e6bc3e878eea2c3383f5ce46a94fcab820981a41782ca3daa36f837fe8f4e4a8d04570c43f74722822a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d320c19062c28ce8e064fc2d88a02f212c73354cb11e28586eadf123592064c3055db6a526c12f53e5a2ae5b473990f459c7a004513d6ecfeee47564d4892549"} 22:13:31 INFO - Copying logs to upload dir... 22:13:31 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1299.517407 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-01-05 22:13:30.930636) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:30.933891) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d39545f32726410041d0bf7dd00a24e1129b2374092e6bc3e878eea2c3383f5ce46a94fcab820981a41782ca3daa36f837fe8f4e4a8d04570c43f74722822a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d320c19062c28ce8e064fc2d88a02f212c73354cb11e28586eadf123592064c3055db6a526c12f53e5a2ae5b473990f459c7a004513d6ecfeee47564d4892549"} build_url:https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/UTn8em1yTvizlhGldCYTlQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d39545f32726410041d0bf7dd00a24e1129b2374092e6bc3e878eea2c3383f5ce46a94fcab820981a41782ca3daa36f837fe8f4e4a8d04570c43f74722822a1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d320c19062c28ce8e064fc2d88a02f212c73354cb11e28586eadf123592064c3055db6a526c12f53e5a2ae5b473990f459c7a004513d6ecfeee47564d4892549"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:30.958539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:30.958888) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1452054561.841016-1078294330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-05 22:13:31.041344) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 22:13:31.041668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-05 22:13:31.042010) ========= ========= Total master_lag: 0.24 =========