builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1449688310.2 results: success (0) buildid: 20151209083102 builduid: 28d6454e11c84e3fb951156873346b26 revision: 74b17234e93408021bc0413b60874638457e2e5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.203666) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.204158) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.204470) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006404 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.255545) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.255914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.362755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.363044) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.456083) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.456462) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.456968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.457282) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 11:11:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.7M=0s 2015-12-09 11:11:52 (33.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161437 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.684288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.684597) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018556 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:50.738214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:11:50.738595) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74b17234e93408021bc0413b60874638457e2e5e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 74b17234e93408021bc0413b60874638457e2e5e --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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 11:11:52,202 truncating revision to first 12 chars 2015-12-09 11:11:52,203 Setting DEBUG logging. 2015-12-09 11:11:52,203 attempt 1/10 2015-12-09 11:11:52,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74b17234e934?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 11:11:53,089 unpacking tar archive at: fx-team-74b17234e934/testing/mozharness/ program finished with exit code 0 elapsedTime=1.166331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:11:51.919667) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:51.919975) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:51.927747) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:51.928129) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:11:51.928656) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-09 11:11:51.928955) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:11:53 INFO - MultiFileLogger online at 20151209 11:11:53 in /builds/slave/test-pgo 11:11:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:11:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:11:53 INFO - {'append_to_log': False, 11:11:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:11:53 INFO - 'blob_upload_branch': 'Fx-Team', 11:11:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:11:53 INFO - 'branch': 'Fx-Team', 11:11:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:11:53 INFO - 'config_files': ('talos/linux_config.py',), 11:11:53 INFO - 'default_actions': ('clobber', 11:11:53 INFO - 'read-buildbot-config', 11:11:53 INFO - 'download-and-extract', 11:11:53 INFO - 'populate-webroot', 11:11:53 INFO - 'create-virtualenv', 11:11:53 INFO - 'install', 11:11:53 INFO - 'run-tests'), 11:11:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:11:53 INFO - 'download_minidump_stackwalk': True, 11:11:53 INFO - 'download_symbols': 'ondemand', 11:11:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:11:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:11:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:11:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:11:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:11:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:11:53 INFO - 'installer_path': 'installer.exe', 11:11:53 INFO - 'log_level': 'info', 11:11:53 INFO - 'log_name': 'talos', 11:11:53 INFO - 'log_to_console': True, 11:11:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:11:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:11:53 INFO - 'opt_config_files': (), 11:11:53 INFO - 'pip_index': False, 11:11:53 INFO - 'sps_profile': False, 11:11:53 INFO - 'sps_profile_interval': 0, 11:11:53 INFO - 'suite': 'dromaeojs-e10s', 11:11:53 INFO - 'system_bits': '64', 11:11:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:11:53 INFO - 'title': 'talos-linux64-ix-012', 11:11:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:11:53 INFO - 'use_talos_json': True, 11:11:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:11:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:11:53 INFO - 'work_dir': 'build'} 11:11:53 INFO - ##### 11:11:53 INFO - ##### Running clobber step. 11:11:53 INFO - ##### 11:11:53 INFO - Running pre-action listener: _resource_record_pre_action 11:11:53 INFO - Running main action method: clobber 11:11:53 INFO - rmtree: /builds/slave/test-pgo/build 11:11:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:11:53 INFO - Running post-action listener: _resource_record_post_action 11:11:53 INFO - ##### 11:11:53 INFO - ##### Running read-buildbot-config step. 11:11:53 INFO - ##### 11:11:53 INFO - Running pre-action listener: _resource_record_pre_action 11:11:53 INFO - Running main action method: read_buildbot_config 11:11:53 INFO - Using buildbot properties: 11:11:53 INFO - { 11:11:53 INFO - "properties": { 11:11:53 INFO - "buildnumber": 130, 11:11:53 INFO - "product": "firefox", 11:11:53 INFO - "script_repo_revision": "production", 11:11:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:11:53 INFO - "repository": "", 11:11:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:11:53 INFO - "buildid": "20151209083102", 11:11:53 INFO - "slavename": "talos-linux64-ix-012", 11:11:53 INFO - "pgo_build": "True", 11:11:53 INFO - "basedir": "/builds/slave/test-pgo", 11:11:53 INFO - "project": "", 11:11:53 INFO - "platform": "ubuntu64_hw", 11:11:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:11:53 INFO - "slavebuilddir": "test", 11:11:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:11:53 INFO - "branch": "fx-team", 11:11:53 INFO - "repo_path": "integration/fx-team", 11:11:53 INFO - "stage_platform": "linux64-pgo", 11:11:53 INFO - "builduid": "28d6454e11c84e3fb951156873346b26", 11:11:53 INFO - "revision": "74b17234e93408021bc0413b60874638457e2e5e" 11:11:53 INFO - }, 11:11:53 INFO - "sourcestamp": { 11:11:53 INFO - "repository": "", 11:11:53 INFO - "hasPatch": false, 11:11:53 INFO - "project": "", 11:11:53 INFO - "branch": "fx-team-linux64-pgo-talos", 11:11:53 INFO - "changes": [ 11:11:53 INFO - { 11:11:53 INFO - "category": null, 11:11:53 INFO - "files": [ 11:11:53 INFO - { 11:11:53 INFO - "url": null, 11:11:53 INFO - "name": "https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:11:53 INFO - } 11:11:53 INFO - ], 11:11:53 INFO - "repository": "", 11:11:53 INFO - "rev": "74b17234e93408021bc0413b60874638457e2e5e", 11:11:53 INFO - "who": "sendchange", 11:11:53 INFO - "when": 1449688246, 11:11:53 INFO - "number": 7171520, 11:11:53 INFO - "comments": "", 11:11:53 INFO - "project": "", 11:11:53 INFO - "at": "Wed 09 Dec 2015 11:10:46", 11:11:53 INFO - "branch": "fx-team-linux64-pgo-talos", 11:11:53 INFO - "revlink": "", 11:11:53 INFO - "properties": [ 11:11:53 INFO - [ 11:11:53 INFO - "buildid", 11:11:53 INFO - "20151209083102", 11:11:53 INFO - "Change" 11:11:53 INFO - ], 11:11:53 INFO - [ 11:11:53 INFO - "builduid", 11:11:53 INFO - "28d6454e11c84e3fb951156873346b26", 11:11:53 INFO - "Change" 11:11:53 INFO - ], 11:11:53 INFO - [ 11:11:53 INFO - "pgo_build", 11:11:53 INFO - "True", 11:11:53 INFO - "Change" 11:11:53 INFO - ] 11:11:53 INFO - ], 11:11:53 INFO - "revision": "74b17234e93408021bc0413b60874638457e2e5e" 11:11:53 INFO - } 11:11:53 INFO - ], 11:11:53 INFO - "revision": "74b17234e93408021bc0413b60874638457e2e5e" 11:11:53 INFO - } 11:11:53 INFO - } 11:11:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:11:53 INFO - Running post-action listener: _resource_record_post_action 11:11:53 INFO - ##### 11:11:53 INFO - ##### Running download-and-extract step. 11:11:53 INFO - ##### 11:11:53 INFO - Running pre-action listener: _resource_record_pre_action 11:11:53 INFO - Running main action method: download_and_extract 11:11:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:11: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')]} 11:11:53 INFO - https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:11:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/test_packages.json 11:11:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/test_packages.json 11:11:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:11:58 INFO - Downloaded 1302 bytes. 11:11:58 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:11:58 INFO - Using the following test package requirements: 11:11:58 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:11:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'jsshell-linux-x86_64.zip'], 11:11:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:11:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:11:58 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:11:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:11:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:11:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:11:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:11:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:11:58 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')]} 11:11:58 INFO - https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:11:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:11:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:11:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:11:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:01 INFO - Downloaded 23109224 bytes. 11:12:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:12:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:12:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:12:02 INFO - Return code: 0 11:12:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:12:02 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')]} 11:12:02 INFO - https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:12:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:12:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:12:04 INFO - Downloaded 23109224 bytes. 11:12:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:12:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:12:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:12:05 INFO - Return code: 0 11:12:05 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')]} 11:12:05 INFO - https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:12:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:12:07 INFO - Downloaded 11132038 bytes. 11:12:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:12:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:12:07 INFO - Return code: 0 11:12:07 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')]} 11:12:07 INFO - https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:12:09 INFO - Downloaded 59268245 bytes. 11:12:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:12:09 INFO - mkdir: /builds/slave/test-pgo/properties 11:12:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:12:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:12:09 INFO - Contents: 11:12:09 INFO - build_url:https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - Running post-action listener: set_extra_try_arguments 11:12:09 INFO - ##### 11:12:09 INFO - ##### Running populate-webroot step. 11:12:09 INFO - ##### 11:12:09 INFO - Running pre-action listener: _resource_record_pre_action 11:12:09 INFO - Running main action method: populate_webroot 11:12:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:09 INFO - '--tppagecycles', 11:12:09 INFO - '7'], 11:12:09 INFO - 'tests': ['tsvgm']}}, 11:12:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:12:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:12:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'tests': ['damp', 'tps']}, 11:12:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['damp', 'tps']}, 11:12:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:12:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:09 INFO - 'other': {'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'other_l64': {'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'other_nol64': {'tests': ['a11yr', 11:12:09 INFO - 'ts_paint', 11:12:09 INFO - 'tpaint', 11:12:09 INFO - 'sessionrestore', 11:12:09 INFO - 'sessionrestore_no_auto_restore']}, 11:12:09 INFO - 'svgr': {'tests': ['tsvgx', 11:12:09 INFO - 'tsvgr_opacity', 11:12:09 INFO - 'tart', 11:12:09 INFO - 'tscrollx', 11:12:09 INFO - 'cart']}, 11:12:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['tsvgx', 11:12:09 INFO - 'tsvgr_opacity', 11:12:09 INFO - 'tart', 11:12:09 INFO - 'tscrollx', 11:12:09 INFO - 'cart']}, 11:12:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'tests': ['tp5o']}, 11:12:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'talos_options': ['--e10s'], 11:12:09 INFO - 'tests': ['tp5o']}, 11:12:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'talos_options': ['--xperf_path', 11:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:09 INFO - 'tests': ['tp5n']}, 11:12:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:09 INFO - 'talos_options': ['--e10s', 11:12:09 INFO - '--xperf_path', 11:12:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:09 INFO - 'tests': ['tp5n']}}, 11:12:09 INFO - 'talos.zip': {'path': '', 11:12:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:09 INFO - Running post-action listener: _resource_record_post_action 11:12:09 INFO - ##### 11:12:09 INFO - ##### Running create-virtualenv step. 11:12:09 INFO - ##### 11:12:09 INFO - Running pre-action listener: _resource_record_pre_action 11:12:09 INFO - Running main action method: create_virtualenv 11:12:09 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:12:09 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 11:12:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:12:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:09 INFO - Using real prefix '/usr' 11:12:09 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:12:09 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:11 INFO - Installing pip.................done. 11:12:11 INFO - Return code: 0 11:12:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 11:12: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 pip>=1.5 11:12:11 INFO - Using env: {'DISPLAY': ':0', 11:12:11 INFO - 'HOME': '/home/cltbld', 11:12:11 INFO - 'LANG': 'en_US.UTF-8', 11:12:11 INFO - 'LANGUAGE': 'en_US:en', 11:12:11 INFO - 'LOGNAME': 'cltbld', 11:12:11 INFO - 'MAIL': '/var/mail/cltbld', 11:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:11 INFO - 'MOZ_NO_REMOTE': '1', 11:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:11 INFO - 'NO_EM_RESTART': '1', 11:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:11 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:11 INFO - 'SHELL': '/bin/bash', 11:12:11 INFO - 'SHLVL': '1', 11:12:11 INFO - 'TERM': 'linux', 11:12:11 INFO - 'TMOUT': '86400', 11:12:11 INFO - 'USER': 'cltbld', 11:12:11 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:11 INFO - '_': '/tools/buildbot/bin/python'} 11:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:12 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 11:12:12 INFO - Cleaning up... 11:12:12 INFO - Return code: 0 11:12:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:12:12 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')]} 11:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:12 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')]} 11:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:12 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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:12 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 11:12:12 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 11:12:12 INFO - Using env: {'DISPLAY': ':0', 11:12:12 INFO - 'HOME': '/home/cltbld', 11:12:12 INFO - 'LANG': 'en_US.UTF-8', 11:12:12 INFO - 'LANGUAGE': 'en_US:en', 11:12:12 INFO - 'LOGNAME': 'cltbld', 11:12:12 INFO - 'MAIL': '/var/mail/cltbld', 11:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:12 INFO - 'MOZ_NO_REMOTE': '1', 11:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:12 INFO - 'NO_EM_RESTART': '1', 11:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:12 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:12 INFO - 'SHELL': '/bin/bash', 11:12:12 INFO - 'SHLVL': '1', 11:12:12 INFO - 'TERM': 'linux', 11:12:12 INFO - 'TMOUT': '86400', 11:12:12 INFO - 'USER': 'cltbld', 11:12:12 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:12 INFO - '_': '/tools/buildbot/bin/python'} 11:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:12 INFO - Downloading/unpacking psutil>=0.7.1 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:12 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 11:12:13 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 11:12:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:12:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:14 INFO - Installing collected packages: psutil 11:12:14 INFO - Running setup.py install for psutil 11:12:14 INFO - building 'psutil._psutil_linux' extension 11:12:14 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 11:12:14 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 11:12:14 INFO - building 'psutil._psutil_posix' extension 11:12:14 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 11:12:14 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 11:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:14 INFO - Successfully installed psutil 11:12:14 INFO - Cleaning up... 11:12:14 INFO - Return code: 0 11:12:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:12:14 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')]} 11:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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')]} 11:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:14 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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:14 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 11:12:14 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 11:12:14 INFO - Using env: {'DISPLAY': ':0', 11:12:14 INFO - 'HOME': '/home/cltbld', 11:12:14 INFO - 'LANG': 'en_US.UTF-8', 11:12:14 INFO - 'LANGUAGE': 'en_US:en', 11:12:14 INFO - 'LOGNAME': 'cltbld', 11:12:14 INFO - 'MAIL': '/var/mail/cltbld', 11:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:14 INFO - 'MOZ_NO_REMOTE': '1', 11:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:14 INFO - 'NO_EM_RESTART': '1', 11:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:14 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:14 INFO - 'SHELL': '/bin/bash', 11:12:14 INFO - 'SHLVL': '1', 11:12:14 INFO - 'TERM': 'linux', 11:12:14 INFO - 'TMOUT': '86400', 11:12:14 INFO - 'USER': 'cltbld', 11:12:14 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:14 INFO - '_': '/tools/buildbot/bin/python'} 11:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:14 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 11:12:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:12:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:12:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:12:16 INFO - Installing collected packages: mozsystemmonitor 11:12:16 INFO - Running setup.py install for mozsystemmonitor 11:12:16 INFO - Successfully installed mozsystemmonitor 11:12:16 INFO - Cleaning up... 11:12:16 INFO - Return code: 0 11:12:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:16 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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:16 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 11:12:16 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 11:12:16 INFO - Using env: {'DISPLAY': ':0', 11:12:16 INFO - 'HOME': '/home/cltbld', 11:12:16 INFO - 'LANG': 'en_US.UTF-8', 11:12:16 INFO - 'LANGUAGE': 'en_US:en', 11:12:16 INFO - 'LOGNAME': 'cltbld', 11:12:16 INFO - 'MAIL': '/var/mail/cltbld', 11:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:16 INFO - 'MOZ_NO_REMOTE': '1', 11:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:16 INFO - 'NO_EM_RESTART': '1', 11:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:16 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:16 INFO - 'SHELL': '/bin/bash', 11:12:16 INFO - 'SHLVL': '1', 11:12:16 INFO - 'TERM': 'linux', 11:12:16 INFO - 'TMOUT': '86400', 11:12:16 INFO - 'USER': 'cltbld', 11:12:16 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:16 INFO - '_': '/tools/buildbot/bin/python'} 11:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:16 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 11:12:18 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:12:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:18 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 11:12:18 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 11:12:18 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 11:12:18 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 11:12:18 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 11:12:18 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 11:12:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:12:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:12:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:19 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 11:12:19 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 11:12:19 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 11:12:19 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 11:12:19 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 11:12:19 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 11:12:19 INFO - Downloading docopt-0.6.1.tar.gz 11:12:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:12:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:19 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:19 INFO - Running setup.py install for blobuploader 11:12:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:19 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:12:19 INFO - Running setup.py install for requests 11:12:19 INFO - Running setup.py install for docopt 11:12:19 INFO - Successfully installed blobuploader requests docopt 11:12:19 INFO - Cleaning up... 11:12:19 INFO - Return code: 0 11:12:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:19 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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:19 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 11:12:19 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 11:12:19 INFO - Using env: {'DISPLAY': ':0', 11:12:19 INFO - 'HOME': '/home/cltbld', 11:12:19 INFO - 'LANG': 'en_US.UTF-8', 11:12:19 INFO - 'LANGUAGE': 'en_US:en', 11:12:19 INFO - 'LOGNAME': 'cltbld', 11:12:19 INFO - 'MAIL': '/var/mail/cltbld', 11:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:19 INFO - 'MOZ_NO_REMOTE': '1', 11:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:19 INFO - 'NO_EM_RESTART': '1', 11:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:19 INFO - 'SHELL': '/bin/bash', 11:12:19 INFO - 'SHLVL': '1', 11:12:19 INFO - 'TERM': 'linux', 11:12:19 INFO - 'TMOUT': '86400', 11:12:19 INFO - 'USER': 'cltbld', 11:12:19 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:19 INFO - '_': '/tools/buildbot/bin/python'} 11:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:20 INFO - Running setup.py (path:/tmp/pip-UE9BJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:20 INFO - Running setup.py (path:/tmp/pip-o6iyCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:20 INFO - Running setup.py (path:/tmp/pip-KsAOO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:20 INFO - Running setup.py (path:/tmp/pip-ugFbR6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:20 INFO - Running setup.py (path:/tmp/pip-NkokRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:20 INFO - Running setup.py (path:/tmp/pip-h9IDcz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:20 INFO - Running setup.py (path:/tmp/pip-5uj48X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:20 INFO - Running setup.py (path:/tmp/pip-rTHcSK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:20 INFO - Running setup.py (path:/tmp/pip-N9_UfA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:20 INFO - Running setup.py (path:/tmp/pip-iGsDEX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:20 INFO - Running setup.py (path:/tmp/pip-JIq569-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:20 INFO - Running setup.py (path:/tmp/pip-OPyu87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:20 INFO - Running setup.py (path:/tmp/pip-a097si-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:21 INFO - Running setup.py (path:/tmp/pip-BOlHeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:21 INFO - Running setup.py (path:/tmp/pip-YJ2F2t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:21 INFO - Running setup.py (path:/tmp/pip-uHO_SW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:21 INFO - Running setup.py (path:/tmp/pip-4Y8mFe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:21 INFO - Running setup.py install for manifestparser 11:12:21 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:12:21 INFO - Running setup.py install for mozcrash 11:12:21 INFO - Running setup.py install for mozdebug 11:12:21 INFO - Running setup.py install for mozdevice 11:12:21 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:12:21 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:12:21 INFO - Running setup.py install for mozfile 11:12:21 INFO - Running setup.py install for mozhttpd 11:12:21 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:12:21 INFO - Running setup.py install for mozinfo 11:12:22 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for mozInstall 11:12:22 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for mozleak 11:12:22 INFO - Running setup.py install for mozlog 11:12:22 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for moznetwork 11:12:22 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for mozprocess 11:12:22 INFO - Running setup.py install for mozprofile 11:12:22 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for mozrunner 11:12:22 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:12:22 INFO - Running setup.py install for mozscreenshot 11:12:22 INFO - Running setup.py install for moztest 11:12:23 INFO - Running setup.py install for mozversion 11:12:23 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:12:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:12:23 INFO - Cleaning up... 11:12:23 INFO - Return code: 0 11:12:23 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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/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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12: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/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 11:12: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/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 11:12:23 INFO - Using env: {'DISPLAY': ':0', 11:12:23 INFO - 'HOME': '/home/cltbld', 11:12:23 INFO - 'LANG': 'en_US.UTF-8', 11:12:23 INFO - 'LANGUAGE': 'en_US:en', 11:12:23 INFO - 'LOGNAME': 'cltbld', 11:12:23 INFO - 'MAIL': '/var/mail/cltbld', 11:12:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:23 INFO - 'MOZ_NO_REMOTE': '1', 11:12:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:23 INFO - 'NO_EM_RESTART': '1', 11:12:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:23 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:23 INFO - 'SHELL': '/bin/bash', 11:12:23 INFO - 'SHLVL': '1', 11:12:23 INFO - 'TERM': 'linux', 11:12:23 INFO - 'TMOUT': '86400', 11:12:23 INFO - 'USER': 'cltbld', 11:12:23 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:23 INFO - '_': '/tools/buildbot/bin/python'} 11:12:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:23 INFO - Running setup.py (path:/tmp/pip-JenPFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:23 INFO - Running setup.py (path:/tmp/pip-wgcYTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:23 INFO - Running setup.py (path:/tmp/pip-_DLRua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:23 INFO - Running setup.py (path:/tmp/pip-QgNldI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:23 INFO - Running setup.py (path:/tmp/pip-NWJjsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:23 INFO - Running setup.py (path:/tmp/pip-B3XjFu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:23 INFO - Running setup.py (path:/tmp/pip-NrYYLT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:23 INFO - Running setup.py (path:/tmp/pip-22ZtZl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:23 INFO - Running setup.py (path:/tmp/pip-_Qkfi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:12:23 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)) 11:12:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:24 INFO - Running setup.py (path:/tmp/pip-1vPt_k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:24 INFO - Running setup.py (path:/tmp/pip-76jW5A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:24 INFO - Running setup.py (path:/tmp/pip-Pt_t5D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:24 INFO - Running setup.py (path:/tmp/pip-_ZDdb6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:24 INFO - Running setup.py (path:/tmp/pip-dMXfLO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:24 INFO - Running setup.py (path:/tmp/pip-QeAGi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:24 INFO - Running setup.py (path:/tmp/pip-dgEaaO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:12:24 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)) 11:12:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:24 INFO - Running setup.py (path:/tmp/pip-o25XdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 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)) 11:12:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:12:24 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 11:12:24 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 11:12:24 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 11:12:24 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 11:12:24 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 11:12:24 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 11:12:26 INFO - Downloading blessings-1.5.1.tar.gz 11:12:26 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 11:12:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:12:26 INFO - Installing collected packages: blessings 11:12:26 INFO - Running setup.py install for blessings 11:12:26 INFO - Successfully installed blessings 11:12:26 INFO - Cleaning up... 11:12:26 INFO - Return code: 0 11:12:26 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:12:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:26 INFO - Reading from file tmpfile_stdout 11:12:26 INFO - Current package versions: 11:12:26 INFO - argparse == 1.2.1 11:12:26 INFO - blessings == 1.5.1 11:12:26 INFO - blobuploader == 1.2.4 11:12:26 INFO - docopt == 0.6.1 11:12:26 INFO - manifestparser == 1.1 11:12:26 INFO - mozInstall == 1.12 11:12:26 INFO - mozcrash == 0.16 11:12:26 INFO - mozdebug == 0.1 11:12:26 INFO - mozdevice == 0.47 11:12:26 INFO - mozfile == 1.2 11:12:26 INFO - mozhttpd == 0.7 11:12:26 INFO - mozinfo == 0.9 11:12:26 INFO - mozleak == 0.1 11:12:26 INFO - mozlog == 3.1 11:12:26 INFO - moznetwork == 0.27 11:12:26 INFO - mozprocess == 0.22 11:12:26 INFO - mozprofile == 0.27 11:12:26 INFO - mozrunner == 6.11 11:12:26 INFO - mozscreenshot == 0.1 11:12:26 INFO - mozsystemmonitor == 0.0 11:12:26 INFO - moztest == 0.7 11:12:26 INFO - mozversion == 1.4 11:12:26 INFO - psutil == 3.1.1 11:12:26 INFO - requests == 1.2.3 11:12:26 INFO - wsgiref == 0.1.2 11:12:26 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', '-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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:26 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 11:12:26 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 11:12:26 INFO - Using env: {'DISPLAY': ':0', 11:12:26 INFO - 'HOME': '/home/cltbld', 11:12:26 INFO - 'LANG': 'en_US.UTF-8', 11:12:26 INFO - 'LANGUAGE': 'en_US:en', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MAIL': '/var/mail/cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SHLVL': '1', 11:12:26 INFO - 'TERM': 'linux', 11:12:26 INFO - 'TMOUT': '86400', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - '_': '/tools/buildbot/bin/python'} 11:12:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:26 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 1)) 11:12:26 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 2)) 11:12:26 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 3)) 11:12:26 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 4)) 11:12:26 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 5)) 11:12:26 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 6)) 11:12:26 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 7)) 11:12:26 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 8)) 11:12:26 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:12:26 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 3)) 11:12:26 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 11:12:26 INFO - Cleaning up... 11:12:26 INFO - Return code: 0 11:12:26 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:12: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')]} 11:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12: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', 'jsonschema'] in /builds/slave/test-pgo/build 11:12: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 jsonschema 11:12:26 INFO - Using env: {'DISPLAY': ':0', 11:12:26 INFO - 'HOME': '/home/cltbld', 11:12:26 INFO - 'LANG': 'en_US.UTF-8', 11:12:26 INFO - 'LANGUAGE': 'en_US:en', 11:12:26 INFO - 'LOGNAME': 'cltbld', 11:12:26 INFO - 'MAIL': '/var/mail/cltbld', 11:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:26 INFO - 'MOZ_NO_REMOTE': '1', 11:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:26 INFO - 'NO_EM_RESTART': '1', 11:12:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:26 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:26 INFO - 'SHELL': '/bin/bash', 11:12:26 INFO - 'SHLVL': '1', 11:12:26 INFO - 'TERM': 'linux', 11:12:26 INFO - 'TMOUT': '86400', 11:12:26 INFO - 'USER': 'cltbld', 11:12:26 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:26 INFO - '_': '/tools/buildbot/bin/python'} 11:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:27 INFO - Downloading/unpacking jsonschema 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:28 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 11:12:28 INFO - Downloading/unpacking functools32 (from jsonschema) 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:12:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:28 INFO - warning: no files found matching '*.txt' 11:12:28 INFO - no previously-included directories found matching 'build' 11:12:28 INFO - no previously-included directories found matching 'dist' 11:12:28 INFO - no previously-included directories found matching '.git*' 11:12:28 INFO - Installing collected packages: jsonschema, functools32 11:12:28 INFO - Running setup.py install for functools32 11:12:28 INFO - warning: no files found matching '*.txt' 11:12:28 INFO - no previously-included directories found matching 'build' 11:12:28 INFO - no previously-included directories found matching 'dist' 11:12:28 INFO - no previously-included directories found matching '.git*' 11:12:28 INFO - Successfully installed jsonschema functools32 11:12:28 INFO - Cleaning up... 11:12:28 INFO - Return code: 0 11:12:28 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:12:28 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')]} 11:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 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')]} 11:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:28 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 0x7fe66a312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd78600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, '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': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', '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 11:12:28 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 11:12:28 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 11:12:28 INFO - Using env: {'DISPLAY': ':0', 11:12:28 INFO - 'HOME': '/home/cltbld', 11:12:28 INFO - 'LANG': 'en_US.UTF-8', 11:12:28 INFO - 'LANGUAGE': 'en_US:en', 11:12:28 INFO - 'LOGNAME': 'cltbld', 11:12:28 INFO - 'MAIL': '/var/mail/cltbld', 11:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:28 INFO - 'MOZ_NO_REMOTE': '1', 11:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:28 INFO - 'NO_EM_RESTART': '1', 11:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:28 INFO - 'SHELL': '/bin/bash', 11:12:28 INFO - 'SHLVL': '1', 11:12:28 INFO - 'TERM': 'linux', 11:12:28 INFO - 'TMOUT': '86400', 11:12:28 INFO - 'USER': 'cltbld', 11:12:28 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:28 INFO - '_': '/tools/buildbot/bin/python'} 11:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:29 INFO - Downloading/unpacking flake8 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:29 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 11:12:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:12:30 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 11:12:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:12:30 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 11:12:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:30 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 11:12:31 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 11:12:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 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 11:12:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:12:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:31 INFO - no previously-included directories found matching 'docs/_build' 11:12:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:12:31 INFO - Running setup.py install for pep8 11:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:12:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:12:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:12:31 INFO - no previously-included directories found matching 'docs/_build' 11:12:31 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:12:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:12:31 INFO - Cleaning up... 11:12:31 INFO - Return code: 0 11:12:31 INFO - Running post-action listener: _resource_record_post_action 11:12:31 INFO - Running post-action listener: _start_resource_monitoring 11:12:31 INFO - Starting resource monitoring. 11:12:31 INFO - ##### 11:12:31 INFO - ##### Running install step. 11:12:31 INFO - ##### 11:12:31 INFO - Running pre-action listener: _resource_record_pre_action 11:12:31 INFO - Running main action method: install 11:12:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:12:31 INFO - Reading from file tmpfile_stdout 11:12:31 INFO - Detecting whether we're running mozinstall >=1.0... 11:12:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:12:31 INFO - Reading from file tmpfile_stdout 11:12:31 INFO - Output received: 11:12:31 INFO - Usage: mozinstall [options] installer 11:12:31 INFO - Options: 11:12:31 INFO - -h, --help show this help message and exit 11:12:31 INFO - -d DEST, --destination=DEST 11:12:31 INFO - Directory to install application into. [default: 11:12:31 INFO - "/builds/slave/test-pgo"] 11:12:31 INFO - --app=APP Application being installed. [default: firefox] 11:12:31 INFO - mkdir: /builds/slave/test-pgo/build/application 11:12:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:12:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:12:46 INFO - Reading from file tmpfile_stdout 11:12:46 INFO - Output received: 11:12:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:12:46 INFO - Running post-action listener: _resource_record_post_action 11:12:46 INFO - ##### 11:12:46 INFO - ##### Running run-tests step. 11:12:46 INFO - ##### 11:12:46 INFO - Running pre-action listener: _resource_record_pre_action 11:12:46 INFO - Running main action method: run_tests 11:12:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:12:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:12:46 INFO - Python 2.7.3 11:12:46 INFO - Return code: 0 11:12:46 INFO - grabbing minidump binary from tooltool 11:12:46 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')]} 11:12:46 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 0xe07350>, '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 0xe08250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe086e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:12:46 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 11:12:46 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 11:12:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:12:46 INFO - Return code: 0 11:12:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:12:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:12:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:12:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:12:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:12:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:12:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:12:47 INFO - Return code: 0 11:12:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:12:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost 11:12:47 INFO - Using env: {'DISPLAY': ':0', 11:12:47 INFO - 'HOME': '/home/cltbld', 11:12:47 INFO - 'LANG': 'en_US.UTF-8', 11:12:47 INFO - 'LANGUAGE': 'en_US:en', 11:12:47 INFO - 'LOGNAME': 'cltbld', 11:12:47 INFO - 'MAIL': '/var/mail/cltbld', 11:12:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:12:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:47 INFO - 'MOZ_NO_REMOTE': '1', 11:12:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:12:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:47 INFO - 'NO_EM_RESTART': '1', 11:12:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:12:47 INFO - 'PWD': '/builds/slave/test-pgo', 11:12:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:12:47 INFO - 'SHELL': '/bin/bash', 11:12:47 INFO - 'SHLVL': '1', 11:12:47 INFO - 'TERM': 'linux', 11:12:47 INFO - 'TMOUT': '86400', 11:12:47 INFO - 'USER': 'cltbld', 11:12:47 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1449688229.926082-396047106', 11:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:47 INFO - '_': '/tools/buildbot/bin/python'} 11:12:47 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost'] with output_timeout 3600 11:12:48 INFO - mozversion INFO | application_buildid: 20151209083102 11:12:48 INFO - mozversion INFO | application_changeset: 74b17234e93408021bc0413b60874638457e2e5e 11:12:48 INFO - mozversion INFO | application_display_name: Nightly 11:12:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:12:48 INFO - mozversion INFO | application_name: Firefox 11:12:48 INFO - mozversion INFO | application_remotingname: firefox 11:12:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:12:48 INFO - mozversion INFO | application_vendor: Mozilla 11:12:48 INFO - mozversion INFO | application_version: 45.0a1 11:12:48 INFO - mozversion INFO | platform_buildid: 20151209083102 11:12:48 INFO - mozversion INFO | platform_changeset: 74b17234e93408021bc0413b60874638457e2e5e 11:12:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:12:48 INFO - mozversion INFO | platform_version: 45.0a1 11:12:48 INFO - 2015-12-09 11:12:48,002 DEBUG : using testdate: 1449688368 11:12:48 INFO - 2015-12-09 11:12:48,002 DEBUG : actual date: 1449688368 11:12:48 INFO - 2015-12-09 11:12:48,051 INFO : starting webserver on 'localhost:59615' 11:12:48 INFO - 2015-12-09 11:12:48,052 INFO : Starting test suite talos-linux64-ix-012.e 11:12:48 INFO - 2015-12-09 11:12:48,052 INFO : Starting test dromaeo_css 11:12:48 INFO - 2015-12-09 11:12:48,052 DEBUG : operating with platform_type : linux_ 11:12:48 INFO - 2015-12-09 11:12:48,053 INFO : Initialising browser for dromaeo_css test... 11:12:48 INFO - 2015-12-09 11:12:48,067 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUoceg1/profile http://localhost:59615/getInfo.html 11:12:52 INFO - 2015-12-09 11:12:52,208 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:12:52 INFO - 2015-12-09 11:12:52,208 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:12:52 INFO - 2015-12-09 11:12:52,208 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:12:52 INFO - 2015-12-09 11:12:52,208 DEBUG : BROWSER_OUTPUT: __metrics 11:12:52 INFO - 2015-12-09 11:12:52,329 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:12:53 INFO - 2015-12-09 11:12:53,169 INFO : Browser initialized. 11:12:53 INFO - 2015-12-09 11:12:53,170 INFO : Running cycle 1/1 for dromaeo_css test... 11:12:53 INFO - 2015-12-09 11:12:53,170 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUoceg1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:13:05 INFO - 2015-12-09 11:13:05,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 143499264 11:13:05 INFO - 2015-12-09 11:13:05,059 DEBUG : BROWSER_OUTPUT: 11:13:54 INFO - 2015-12-09 11:13:54,650 DEBUG : BROWSER_OUTPUT: 1449688434650 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] 11:16:03 INFO - 2015-12-09 11:16:03,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59615/tests/dromaeo/cssquery-ext.html) 11:16:04 INFO - 2015-12-09 11:16:04,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 149458944 11:16:04 INFO - 2015-12-09 11:16:04,995 DEBUG : BROWSER_OUTPUT: 11:19:07 INFO - 2015-12-09 11:19:07,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-ext.html (next: http://localhost:59615/tests/dromaeo/cssquery-jquery.html) 11:19:07 INFO - 2015-12-09 11:19:07,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 146948096 11:19:07 INFO - 2015-12-09 11:19:07,655 DEBUG : BROWSER_OUTPUT: 11:22:09 INFO - 2015-12-09 11:22:09,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59615/tests/dromaeo/cssquery-mootools.html) 11:22:10 INFO - 2015-12-09 11:22:10,024 DEBUG : BROWSER_OUTPUT: RSS: Main: 145342464 11:22:10 INFO - 2015-12-09 11:22:10,024 DEBUG : BROWSER_OUTPUT: 11:25:11 INFO - 2015-12-09 11:25:11,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59615/tests/dromaeo/cssquery-prototype.html) 11:25:12 INFO - 2015-12-09 11:25:12,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 144515072 11:25:12 INFO - 2015-12-09 11:25:12,247 DEBUG : BROWSER_OUTPUT: 11:28:14 INFO - 2015-12-09 11:28:14,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59615/tests/dromaeo/cssquery-yui.html) 11:28:15 INFO - 2015-12-09 11:28:15,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 145498112 11:28:15 INFO - 2015-12-09 11:28:15,220 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/dromaeo/cssquery-yui.html (next: http://localhost:59615/tests/dromaeo/cssquery-dojo.html) 11:31:17 INFO - 2015-12-09 11:31:17,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 148561920 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3195.057458049875;3213.0360891732475;3254.5118232265163;3257.495088261319;3257.983710081452;5271.182966640167;5304.0452718510605;5363.892722145555;5390.1914712793105;5403.648762830413;5490.450954904508;5523.944760552393;5537.446255374461;5587.888242235153;5617.241672374228;4933.703977761345;5009.824656137036;5014.323066386046;5077.771500282496;5086.313347698069;5043.067032598962;5059.721715305656;5115.283860259567;5125.718085505296;5178.249153872686;4896.559309662111;4993.700377977297;5025.045241404122;5086.567641750474;5124.923126153092;5006.649534532584;5096.439391666913;5097.439281679012;5104.795808167669;5118.6416950813455;4990.675606085593;4994.725290109042;5007.2489126630935;5017.67385119966;5031.220160875034;5150.124478838569;5208.869778255574;5251.369835619712;5365.678059316453;5396.7301634918485;5894.292684877799;5898.64608123514;5947.226860508106;5950.226470558843;6006.549508786815;5857.179994800731;5866.384029676908;5899.085641725539;5901.2918449785875;5924.614900031527;5441.863953401157;5526.640768350004;5543.168524721284;5552.7223638817895;5620.747066382022;5956.315023772235;5967.19442875215;5990.071538911476;6020.849478763066;6021.157038014681;5807.651540907559;5811.941880581225;5813.09896965971;5813.854653633693;5822.039363505059;5752.798652047159;5845.444682755132;5937.346891841894;5963.522918166536;6037.305709843336;5853.7365818538265;5854.531637468992;5865.032269675456;5875.441833025856;5911.940880591225;5795.855103622359;5872.471477566954;5914;5918.7928422505;5919.704014799243;4497.347884556786;4547.954520454819;4551.658625603027;4570.451545814523;4590.724556526619;4044.3529035354204;4046;4049.088954985105;4063.3701776224734;4082.857100001486;5455.454454554513;5569.359523654751;5601.131824567198;5614.242077319591;5624.971875140598;5853.5317174625925;5913.58604897653;5939.10913362999;5939.584229103922;5980.611260268069;5544.77820887168;5545.694986775686;5559.27729395176;5578.944210557843;5596.356419011866;5064.18972964324;5092.719900405439;5106.029854327666;5173.32746742921;5175.301334319894;5986.760529578768;6010.579259451796;6029.3669164737075;6040;6092.281754394682;5940.079287710412;5980;5993.70031498432;6002.069679199731;6055.5458340623745;6000.129981152796;6077.6961151943115;6089.147519347206;6092.939070609415;6093.421124993119;5850.151727999501;5917.526597872074;5966.731497082555;5996.4603185713495;6000.5799594028;5963.135345374983;5969.283685957713;5971.462568368867;5972.462478376967;5979.133025711334;5696.886062278814;5806.332271788799;5843.181954526284;5888.440598143169;5925.259342582177;5716.657000579979;5796.565257605781;5802.100674395476;5816.36020037804;5836.737346819488;5585.581081418991;5724.599278050497;5725.312962444534;5733.31200255972;5748.39641837601;5679.659220446786;5757;5783.19035335045;5800.50695690871;5840.094785308284;5686.77252909879;5710.971445142914;5736.741846616829;5749.54003679713;5789.478946894799 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.8521377048853;583.4224118123058;589.3958692340351;597.4861619007655;615.9722812473439;37738.43392349117;38337.42493862594;38456.23087538255;38561.228775424475;38597.22805543887;39479.80260098696;39913;39922;39957.400638990366;40191.397129043085;8476.660933562665;8651.783705407384;8677;8689.391742578022;8708.259797917184;8265.421420500568;8365.07984121746;8381.413301068927;8391.992960844707;8393.454425462356;8376.371772117085;8467;8490.915090849105;8529.232369086782;8535.445196062266;8373.41386102973;8479.364047696417;8501.489910605384;8502.362322825782;8506.82986340276;8330.250277475056;8426.4944103354;8426.873596896052;8443.493390396534;8450.112738162466;36134.81932590347;36466.27067458662;36498.635013649786;36526.45210321847;36561.634383656354;3171.8414079295944;3219.3400352927592;3248.740100791955;3268.313654132635;3269.084656296241;28986.42027159466;29312.853435732897;29316.560251596242;29520.26199345012;29895.850520747255;3700.389435743099;3715.925681486355;3747.4191500317493;3758.661720445173;3759.812009399519;255204.72397638077;255738;256098;256189;256283;41843.7907810459;41917.79041104775;42052;48304.27543586849;48328;39566;39598.80200598978;39832;39953.400698989535;39970.600293996686;12395.876041239653;12440.315782632042;12483.625491235278;12495.187812792139;12496.437660305308;10614.787704245871;10615.52230149645;10664;10667.733306667395;10701.143908487302;13909.374078166507;14154.858451415354;14277.14337139775;14283.214423206824;14382.496612618508;5788.450097240755;5805.6806875621405;5830.533557315404;5832.154337621021;5837.766489340379;956.4739393333778;1009.2128140050772;1016.4511163971521;1021.5607288865859;1068.0067537190487;27792.72207277901;27917;28537.286567835556;28546.571801422997;28613.427731445256;1074.398336931321;1074.9570017199223;1076.6716151573846;1114.3369695031442;1121.4560937945091;15904.522864314089;16867.493975180765;17045;17066.48800535986;17335.25426601593;371875;375768;376164;376377;376393;53486.465135348924;53775.46224537783;54008;54027.729861351225;54067.188992165145;1304.8825605695533;1330.900182486298;1340.5710172744627;1357.253510569183;1368.8973327000515;29153;30226;31439.84280078585;32496;32569;48607.27089093596;48786;49014;49346.50653493419;49466.268680597444;303980;308375;309571;309857;310673;41020.17959640731;44584;45024.77487612541;45412.31881521846;46021.53978460172;42465.787671061444;42504.362434562885;42530;43107.13785724331;43243.35134973041;35928.28143437169;35990.4601430984;36420.27159456849;36544.08639784026;41053.1789364205;34663.480047798796;35819.10452238715;40647;40764.59235407608;42314.788426057676;34484.82757586196;34842.30315393729;34923;35512.46731299084;35604.82197588996;31342.37315253728;32413.35173296568;32775.836120819244;33198;33208.66791332152;25148.49703005966;25227.873860630578;25358;25457.745422545537;25780.226593202235 11:31:17 INFO - 2015-12-09 11:31:17,955 DEBUG : BROWSER_OUTPUT: |2;jquery.html;361.39285999520797;362.25556481430664;366.1030475335428;366.89543480108176;367.6084969507475;16527;16795.1602419879;17350.132493375328;17936;18557.721634175497;13717.519886803964;15874.36502539897;16083.276252568634;16133.27400266988;16396.67206655866;4815.422149342084;4931;4962.5533701966815;4972.328735620699;4980.551750342468;4875.926861097087;4878.219484882419;4903.141950158726;4916.360873086512;4919.409670839486;5191.117510023286;5198.142306519419;5274.736263186845;5357.08929481989;5380.784768609251;5307.946920530784;5320.733963301839;5337.759800808973;5373.892522149574;6067.666278354689;5401.891962160774;5413.431589683105;5413.485718856702;5415.566754659618;5432.158015507603;12911.741765164645;12983.610491685264;13555.728885422237;13587.52443664467;13588.728225435436;2066.1941842681367;2099;2166.306781829815;2228.4094714900566;2388.9283321500384;9758.12176904075;9913.504324783804;9995.400275983464;10038.598456061749;10088.293819432643;1725.8619310455133;1745.816689247636;1766.1169415292354;1813.5919418130816;1836.8071352507927;61679;62369;62853;63664;64067;10158.695239142837;10328.380297182193;10521.579136834594;10580.25938184335;10588.682339529672;13739.725205496034;13751.724965500634;13863.168209907439;13872.861271387157;13878.375473103735;6929.5842249464185;7179;7299.927000730031;7365.668544915492;7495.437842161859;6677.666116694146;6682.298358672367;6706.497012724065;6728.6972086255255;6990.720371185197;4452.821887124479;4499.190145773727;4533.161365147458;4564.475085365159;4583.129205450954;1796.6316905034437;1823.8267364600342;1852.5090850924516;1864.6736821056531;1868.6169335286233;436.4936673458836;442.6635756824772;480.3683156649065;807.9676812927418;903.5211337990876;10349.793004139876;10877.129829613612;16827.326906923587;17120.14399280031;17452.5636859077;870.8954925408865;890.3455959869491;920.0283085633308;993.6820217530466;1027.8869324374461;8858.911410885938;9074.364794464456;9402.576884040234;10030.097291243823;10297.742556436;529969;541714;547682;550191;569542;81030;81123.59438202772;83200.16799832045;84205.57897210475;85151;1112.9499172537255;1141.4635121492886;1146.0545050333508;1153.140910022039;1155.936423496699;15564.766528501856;15840.28718707684;16037.278322475284;16176;16195.352185912432;36016.459753104245;36316;36396.27207455889;36692.0826979317;37358.62641373552;47327.76336118297;47435.76282118567;49208.50791492182;50010;51464.22803657873;9574.281928855224;9593;9741.123298903132;9816.754581135528;9830.557624906753;17039.48881533556;17422.128893555524;17749;17755.556111097325;18035.38355354959;13617.931910340385;13690.726185476435;13784.586462406143;13987.650308742363;14771.630709232355;13818.894488441101;13965.930170349084;14121.2233327168;14474.710505790035;14582.739675350338;14470.276486175439;14538.709225815213;14619.269036547917;14861.777073344125;14884.627884302547;9385.81228375415;9476.289278304017;9516.666916657883;9619.56711947978;9644.855327170239;10475.685729428129;10605.098566621615;12207.69480762988;14655.780163297772;15226.695466090838 11:31:17 INFO - 2015-12-09 11:31:17,956 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1520.0271826031335;1692.8307169283073;1733.2980143042073;1751.6934536456117;1756.964860702786;7048.823779405518;7245.601491917955;7450.40396768258;7488.962555187217;7513.511621744589;7402.259774022595;7430.18267990522;7466.216047315035;7490.138634057085;7497;2207.0399376271293;2239.104358256694;2239.585676649825;2240.4174914522177;2244.494988627562;2225.5993921094196;2251.0995601759346;2251.324602619216;2253.504229069602;2281.9315420537328;2167.880766557839;2196.934091977243;2204.526026904215;2215.7451893032267;2220.04538048639;2180.5420861619077;2247.910083596654;2248.2917880867476;2261.366817291161;2264.2641141628874;2206.9558608827733;2242.6972358731527;2256.3231030690727;2263;2272;7447;7476.813079673052;7522.285382888617;7523.623818809037;7551;4512.187806194884;4583.518730533313;4603.930941035887;4607.424071991001;4621.23749581322;2993.5060714982;3028.606281183432;3036;3056.449839028974;3058.8835075197617;973.255459573427;1008.7377281906757;1033.8966103389675;1037.102905986324;1044.81715699753;9832.803343933081;9909.75225619358;9913;9953.004699530062;9958.502074896227;3947.842086316515;3969.384745364473;4019.0957034666967;4035.21313343901;4060.796960151981;8093.392995525359;8122.959385203154;8139.715109971241;8141.755747327589;8160.795980100545;4496.842610508616;4509.526499717548;4534.569215924482;4537.478190008192;4565.5206203348835;4129.504459464883;4159.729617574848;4180.728252663567;4183.602557757008;4185.874423767292;3276.3447310537986;3279.065466342081;3282.294306724066;3301.009697090863;3315.8839440619463;1003.6085926488676;1004.6031817432073;1021.4024795494719;1025.559009625868;1027.3014350241758;883.8541640629225;947.1664934857281;1039.9584016639249;1113.554578168739;1340.7251513439721;7020.368166865007;7028.92971070293;7040.894386584206;7045.471589630798;7054.2240353561065;612.8988716861668;621.8662987457628;636.0999186151544;638.0684201066495;761.4859969520552;5260.605454590845;5489.725513724298;5509.779608815683;5528.032594295983;5537.6954267515675;8676.783080422914;8684.261837743863;8701.651933922572;8707.825843483095;8859.24696400813;8737.694180703646;8763.167499087576;8783.780405489913;8828.161324674145;8840;6966.9303306967295;6986.510944233956;7017.263187365355;7032.718691252395;7034.929650703428;6623.105880706235;6777.796666100025;6798.252192258748;6829.487788415988;6832.726690932506;7757.961210193913;7867.449278550446;7903.486273392211;7914.643841027052;7983.960080199794;7747.30274275318;7925.841483170419;8063.233992770912;8075.111737708729;8078.23256790604;6651.102101216274;6651.46788256948;6674.132362792806;6694;6697.665116744241;7123;7229.421646268391;7237.927620723936;7253.528520646352;7272.127344718668;6795.25252222265;6831.351021652935;6856.280090590416;6906.654667266516;6931.994860745062;6524.608523488606;6588.901166482411;6644.4020038196795;6746.089277947414;6766.661666916733;6667.533272670867;6667.933320666732;6735.4274886635185;6752.729890804313;6776;5985.281766188085;6007.639541627516;6016.2479690038745;6040.637561746309;6115.480184184395;6302.401271879165;6351.9047214290895;6371.649559274284;6375.203099612549;6381.7128229228865 11:31:17 INFO - 2015-12-09 11:31:17,956 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.74818885835623;337.07641063486045;339.6433744568204;340.16319853161224;345.9584849818022;6302.306746257919;6306.936930630693;6325.588836725609;6331.683415829208;6427.775027874025;6187.226596675416;6279.68601569922;6335.239771227459;6341.429271365576;6343.175387199658;4779.617630589544;4808.783604737778;4809.975950120262;4810.63920205986;4812.133815913135;4807.687500312486;4815.855524334275;4816.662833601649;4817.108834865561;4827.082854257697;4662.323963025359;4762.595179409755;4779.259214821708;4787.305840653104;4788.138135135674;4705.317728929321;4746.359241502388;4751.073540659556;4759.4764575896625;4778.546038126373;4136.772477513736;4138;4139.337705967061;4144.544100148981;4152.335626299778;6048.364921683204;6050.455459008666;6069.119977603223;6070.2715674118945;6075.848103797396;5454.154606036071;5578.330600327946;5579.8605034874045;5584.636998595079;5586.1062230043;6657.101291325657;6659.234188068385;6688.565243259172;6709.396154346084;6714.19429668438;4580.9770951145365;4595.885102872455;4596.839110631146;4603.907921841578;4608.585227329523;6768.661566921634;6854.6229957352325;6856.142982127284;6922.446204303644;6932.0988271524375;4678.415198100238;4687.062587482517;4689.976550117228;4691.038337140878;4693.342931989524;4715.95284047162;4727.267273572602;4736.881577960578;4739.336492890998;4740.620750339965;5507.476789704971;5509.531689806331;5510.256115424447;5513.476219759116;5519.889602207933;6597.241317248482;6664.366885145903;6703.22912865017;6709.798706038827;6726.058351830748;1629.055148014149;1648.2747591059895;1666.7249903765985;1679.5968967447968;1682.2513981278457;1080.8000519903685;1093.7211011192096;1100.4167791070586;1104.4312179227704;1108.1633366808007;6281.623102613858;6282.277538083179;6321.747130114744;6323.9051414228825;6343.460805831463;6802.489813264025;6807.183138023469;6830.180378354629;6830.692618832164;6846.657667116624;6155.72299246526;6259.155014073133;6271.466925311308;6284.685765711696;6319.33646967071;3724.4599533067553;3728;3730.440433934877;3730.7388482806487;3734.57052438973;6894.448444124458;6986.44108471321;6988;6989.685464154125;7006.194287656883;6837.760678376233;7004.404625606779;7012.403945664573;7016.7193312267955;7019.473539484559;6978.47661425385;6981.685824137926;6982.371586557234;6994.965025174842;7001.054857594261;6827.385535301847;6835.248122706597;6838.487113466411;6841.3842754152365;6843.794686159423;6632.436242919406;6719.227288861844;6751.122354093936;6754.493412994143;6781.796546103625;6932.7226910923;6934.8613027740175;6956.339147780953;6978.232394436506;6997.510174287954;4669.906601868011;4671.346011558452;4674.62602991753;4677.181493238601;4681.368015317888;6778.4577233822165;6832;6845.0759147514445;6851.931480685329;7012.403945664676;6765.086713293839;6794.082798822095;6801.9319806801295;6804.217514985642;6815.693293801692;6681.799546013627;6736.93263067363;6742.69657865407;6744.62904540255;6748.19021717397;6498.187726534184;6556.967215163893;6608.273089960197;6619.50353723463;6657.53397262187;6811.659417029228;6820.795376138723;6820.829479263058;6828.760993365208;6843.110395648534;6583.703733332108;6630.204375474974;6634.9004764927595;6645.734170633121;6666.899996500153 11:31:17 INFO - 2015-12-09 11:31:17,957 DEBUG : BROWSER_OUTPUT: |5;yui.html;743.9665215065321;748.0723902361074;772.212343409722;844.8479273730729;856.4689892266791;13282.66793330166;13513.864861351383;13520.121192122506;15038;15220.39118435264;15287.770683439758;15309.84690153101;15340.61648458789;15437.536873893801;15485.535433937;821.3388222480901;836.5733475927291;837.8073043200083;840.6679361652174;844.6916875340487;800.1598321762156;838.337713206566;841.5497708725833;846.0439703135448;851.059579165023;877.1009715042069;879.0462348352046;880.4981160738382;882.7748924024365;887.6050157679836;871.1288711288743;872.7687162901836;872.8865247517846;874.3879284500812;876.1982785751062;642.3448082955406;646.7703965092419;647.2297965421134;647.2427260105687;655.9672016399209;13938.58184254474;13940.93029534856;14016.088954218045;14093.5067272646;14096.08375455592;12501.624951251386;12558.497660093586;12635.873641263654;12659.240445573296;13148.474061037547;10433.269671123024;10470.214733894989;10484.79030419395;10616.203784716177;10617.787644247072;3613.2050948791225;3708.8887333380044;3805.60041195676;3918.784466854322;3924.6860251179837;49485.75257123727;49606.50393496055;50290.245646315336;50304.496955030714;50496.242556361685;10499.107575855985;10506.947465262778;10519.737006574896;10528.526216320284;10584.629537966135;18762.624747504975;18938.242470301033;18939;18949;18989.430317090508;7490.6629201686055;7678.808029799188;7710.575918324546;7801.375889928792;7840.647170877324;4427.313766366218;4443.7111587746695;4513.774311284423;4527.026689261825;4531.682782205214;2977.898177674231;3012.457757603652;3032.6815684353264;3038.741706954889;3040.9543856842165;534.946505349462;539.8083680293439;544.3984397240991;548;554.5840619535348;623.2925629410652;630.2688880898136;632.4718859752066;672.3276723276723;676.1818199978081;8713;8796.604152813139;8831.955840220759;8837.337199710048;8964.551772411483;675.7228837497134;676.7665155521337;681.56039354616;699.1086364884812;725.2312548698396;3825.732198746117;3846;3955.8219880105466;4352.891177720519;4375.146846364992;58277.70861145667;58282.7085864568;58351.41648583545;58390.12414813781;58754;52193;53880;54091;54271.72864135733;54471.72764136233;48279.75860120677;48425.51574484281;51367.48632513702;52333;54007.72996134994;8643.394962352575;8769.91230087691;8916.33127515452;9063.41087829289;9182.449053056838;34094.31811363808;34913.47629785606;35565.64434355623;35875.461868072525;36182.63817361898;41400.37899431571;43092;43453.56546434622;43729.344059839765;47212.291815622106;11438.656840294805;11719.12106592026;11790.823137652771;11856.940715296369;12151.513939442324;11792.76414471723;12063.612684541391;12458.501659933501;12474.313912734886;12544.560940367044;11001.889981100087;11172.273802202832;11359.148063895405;11559.133065019989;11592.744947658948;11123.888761112285;11208.27146235492;11471.483783229942;11575.826362604736;11701.590444334408;10897.509612067317;11548.769024619629;11633.63515167724;11659.650210493699;11750.94124529372;9844;9896.950515247378;9918.851217231602;9941.502924853583;10076;8951.194392504705;9000.81998360016;9401.952990235006;9513.33406661527;9794.314397992357 11:31:17 INFO - 2015-12-09 11:31:17,957 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:31:17 INFO - 2015-12-09 11:31:17,957 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:31:17 INFO - 2015-12-09 11:31:17,957 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,315 11:31:17 INFO - 2015-12-09 11:31:17,957 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1449689477947__endTimestamp 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,958 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5488.92 Median:5725.31 stddev:614.70 (10.7%) stddev-sans-first:589.66 11:31:17 INFO - 2015-12-09 11:31:17,959 DEBUG : BROWSER_OUTPUT: Values: 3195.1 3213.0 3254.5 3257.5 3258.0 5271.2 5304.0 5363.9 5390.2 5403.6 5490.5 5523.9 5537.4 5587.9 5617.2 4933.7 5009.8 5014.3 5077.8 5086.3 5043.1 5059.7 5115.3 5125.7 5178.2 4896.6 4993.7 5025.0 5086.6 5124.9 5006.6 5096.4 5097.4 5104.8 5118.6 4990.7 4994.7 5007.2 5017.7 5031.2 5150.1 5208.9 5251.4 5365.7 5396.7 5894.3 5898.6 5947.2 5950.2 6006.5 5857.2 5866.4 5899.1 5901.3 5924.6 5441.9 5526.6 5543.2 5552.7 5620.7 5956.3 5967.2 5990.1 6020.8 6021.2 5807.7 5811.9 5813.1 5813.9 5822.0 5752.8 5845.4 5937.3 5963.5 6037.3 5853.7 5854.5 5865.0 5875.4 5911.9 5795.9 5872.5 5914.0 5918.8 5919.7 4497.3 4548.0 4551.7 4570.5 4590.7 4044.4 4046.0 4049.1 4063.4 4082.9 5455.5 5569.4 5601.1 5614.2 5625.0 5853.5 5913.6 5939.1 5939.6 5980.6 5544.8 5545.7 5559.3 5578.9 5596.4 5064.2 5092.7 5106.0 5173.3 5175.3 5986.8 6010.6 6029.4 6040.0 6092.3 5940.1 5980.0 5993.7 6002.1 6055.5 6000.1 6077.7 6089.1 6092.9 6093.4 5850.2 5917.5 5966.7 5996.5 6000.6 5963.1 5969.3 5971.5 5972.5 5979.1 5696.9 5806.3 5843.2 5888.4 5925.3 5716.7 5796.6 5802.1 5816.4 5836.7 5585.6 5724.6 5725.3 5733.3 5748.4 5679.7 5757.0 5783.2 5800.5 5840.1 5686.8 5711.0 5736.7 5749.5 5789.5 11:31:17 INFO - 2015-12-09 11:31:17,959 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,960 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47223.86 Median:3708.16 stddev:83225.92 (2244.4%) stddev-sans-first:83385.70 11:31:17 INFO - 2015-12-09 11:31:17,960 DEBUG : BROWSER_OUTPUT: Values: 579.9 583.4 589.4 597.5 616.0 37738.4 38337.4 38456.2 38561.2 38597.2 39479.8 39913.0 39922.0 39957.4 40191.4 8476.7 8651.8 8677.0 8689.4 8708.3 8265.4 8365.1 8381.4 8392.0 8393.5 8376.4 8467.0 8490.9 8529.2 8535.4 8373.4 8479.4 8501.5 8502.4 8506.8 8330.3 8426.5 8426.9 8443.5 8450.1 36134.8 36466.3 36498.6 36526.5 36561.6 3171.8 3219.3 3248.7 3268.3 3269.1 28986.4 29312.9 29316.6 29520.3 29895.9 3700.4 3715.9 3747.4 3758.7 3759.8 255204.7 255738.0 256098.0 256189.0 256283.0 41843.8 41917.8 42052.0 48304.3 48328.0 39566.0 39598.8 39832.0 39953.4 39970.6 12395.9 12440.3 12483.6 12495.2 12496.4 10614.8 10615.5 10664.0 10667.7 10701.1 13909.4 14154.9 14277.1 14283.2 14382.5 5788.5 5805.7 5830.5 5832.2 5837.8 956.5 1009.2 1016.5 1021.6 1068.0 27792.7 27917.0 28537.3 28546.6 28613.4 1074.4 1075.0 1076.7 1114.3 1121.5 15904.5 16867.5 17045.0 17066.5 17335.3 371875.0 375768.0 376164.0 376377.0 376393.0 53486.5 53775.5 54008.0 54027.7 54067.2 1304.9 1330.9 1340.6 1357.3 1368.9 29153.0 30226.0 31439.8 32496.0 32569.0 48607.3 48786.0 49014.0 49346.5 49466.3 303980.0 308375.0 309571.0 309857.0 310673.0 41020.2 44584.0 45024.8 45412.3 46021.5 42465.8 42504.4 42530.0 43107.1 43243.4 35928.3 35990.5 36420.3 36544.1 41053.2 34663.5 35819.1 40647.0 40764.6 42314.8 34484.8 34842.3 34923.0 35512.5 35604.8 31342.4 32413.4 32775.8 33198.0 33208.7 25148.5 25227.9 25358.0 25457.7 25780.2 11:31:17 INFO - 2015-12-09 11:31:17,960 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,960 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29047.16 Median:366.50 stddev:89649.13 (24460.9%) stddev-sans-first:89874.74 11:31:17 INFO - 2015-12-09 11:31:17,961 DEBUG : BROWSER_OUTPUT: Values: 361.4 362.3 366.1 366.9 367.6 16527.0 16795.2 17350.1 17936.0 18557.7 13717.5 15874.4 16083.3 16133.3 16396.7 4815.4 4931.0 4962.6 4972.3 4980.6 4875.9 4878.2 4903.1 4916.4 4919.4 5191.1 5198.1 5274.7 5357.1 5380.8 5307.9 5320.7 5337.8 5373.9 6067.7 5401.9 5413.4 5413.5 5415.6 5432.2 12911.7 12983.6 13555.7 13587.5 13588.7 2066.2 2099.0 2166.3 2228.4 2388.9 9758.1 9913.5 9995.4 10038.6 10088.3 1725.9 1745.8 1766.1 1813.6 1836.8 61679.0 62369.0 62853.0 63664.0 64067.0 10158.7 10328.4 10521.6 10580.3 10588.7 13739.7 13751.7 13863.2 13872.9 13878.4 6929.6 7179.0 7299.9 7365.7 7495.4 6677.7 6682.3 6706.5 6728.7 6990.7 4452.8 4499.2 4533.2 4564.5 4583.1 1796.6 1823.8 1852.5 1864.7 1868.6 436.5 442.7 480.4 808.0 903.5 10349.8 10877.1 16827.3 17120.1 17452.6 870.9 890.3 920.0 993.7 1027.9 8858.9 9074.4 9402.6 10030.1 10297.7 529969.0 541714.0 547682.0 550191.0 569542.0 81030.0 81123.6 83200.2 84205.6 85151.0 1112.9 1141.5 1146.1 1153.1 1155.9 15564.8 15840.3 16037.3 16176.0 16195.4 36016.5 36316.0 36396.3 36692.1 37358.6 47327.8 47435.8 49208.5 50010.0 51464.2 9574.3 9593.0 9741.1 9816.8 9830.6 17039.5 17422.1 17749.0 17755.6 18035.4 13617.9 13690.7 13784.6 13987.7 14771.6 13818.9 13965.9 14121.2 14474.7 14582.7 14470.3 14538.7 14619.3 14861.8 14884.6 9385.8 9476.3 9516.7 9619.6 9644.9 10475.7 10605.1 12207.7 14655.8 15226.7 11:31:17 INFO - 2015-12-09 11:31:17,961 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,961 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5188.36 Median:6453.16 stddev:2650.83 (41.1%) stddev-sans-first:2643.93 11:31:17 INFO - 2015-12-09 11:31:17,961 DEBUG : BROWSER_OUTPUT: Values: 1520.0 1692.8 1733.3 1751.7 1757.0 7048.8 7245.6 7450.4 7489.0 7513.5 7402.3 7430.2 7466.2 7490.1 7497.0 2207.0 2239.1 2239.6 2240.4 2244.5 2225.6 2251.1 2251.3 2253.5 2281.9 2167.9 2196.9 2204.5 2215.7 2220.0 2180.5 2247.9 2248.3 2261.4 2264.3 2207.0 2242.7 2256.3 2263.0 2272.0 7447.0 7476.8 7522.3 7523.6 7551.0 4512.2 4583.5 4603.9 4607.4 4621.2 2993.5 3028.6 3036.0 3056.4 3058.9 973.3 1008.7 1033.9 1037.1 1044.8 9832.8 9909.8 9913.0 9953.0 9958.5 3947.8 3969.4 4019.1 4035.2 4060.8 8093.4 8123.0 8139.7 8141.8 8160.8 4496.8 4509.5 4534.6 4537.5 4565.5 4129.5 4159.7 4180.7 4183.6 4185.9 3276.3 3279.1 3282.3 3301.0 3315.9 1003.6 1004.6 1021.4 1025.6 1027.3 883.9 947.2 1040.0 1113.6 1340.7 7020.4 7028.9 7040.9 7045.5 7054.2 612.9 621.9 636.1 638.1 761.5 5260.6 5489.7 5509.8 5528.0 5537.7 8676.8 8684.3 8701.7 8707.8 8859.2 8737.7 8763.2 8783.8 8828.2 8840.0 6966.9 6986.5 7017.3 7032.7 7034.9 6623.1 6777.8 6798.3 6829.5 6832.7 7758.0 7867.4 7903.5 7914.6 7984.0 7747.3 7925.8 8063.2 8075.1 8078.2 6651.1 6651.5 6674.1 6694.0 6697.7 7123.0 7229.4 7237.9 7253.5 7272.1 6795.3 6831.4 6856.3 6906.7 6932.0 6524.6 6588.9 6644.4 6746.1 6766.7 6667.5 6667.9 6735.4 6752.7 6776.0 5985.3 6007.6 6016.2 6040.6 6115.5 6302.4 6351.9 6371.6 6375.2 6381.7 11:31:17 INFO - 2015-12-09 11:31:17,961 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,962 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5557.79 Median:6320.54 stddev:1680.02 (26.6%) stddev-sans-first:1638.37 11:31:17 INFO - 2015-12-09 11:31:17,962 DEBUG : BROWSER_OUTPUT: Values: 335.7 337.1 339.6 340.2 346.0 6302.3 6306.9 6325.6 6331.7 6427.8 6187.2 6279.7 6335.2 6341.4 6343.2 4779.6 4808.8 4810.0 4810.6 4812.1 4807.7 4815.9 4816.7 4817.1 4827.1 4662.3 4762.6 4779.3 4787.3 4788.1 4705.3 4746.4 4751.1 4759.5 4778.5 4136.8 4138.0 4139.3 4144.5 4152.3 6048.4 6050.5 6069.1 6070.3 6075.8 5454.2 5578.3 5579.9 5584.6 5586.1 6657.1 6659.2 6688.6 6709.4 6714.2 4581.0 4595.9 4596.8 4603.9 4608.6 6768.7 6854.6 6856.1 6922.4 6932.1 4678.4 4687.1 4690.0 4691.0 4693.3 4716.0 4727.3 4736.9 4739.3 4740.6 5507.5 5509.5 5510.3 5513.5 5519.9 6597.2 6664.4 6703.2 6709.8 6726.1 1629.1 1648.3 1666.7 1679.6 1682.3 1080.8 1093.7 1100.4 1104.4 1108.2 6281.6 6282.3 6321.7 6323.9 6343.5 6802.5 6807.2 6830.2 6830.7 6846.7 6155.7 6259.2 6271.5 6284.7 6319.3 3724.5 3728.0 3730.4 3730.7 3734.6 6894.4 6986.4 6988.0 6989.7 7006.2 6837.8 7004.4 7012.4 7016.7 7019.5 6978.5 6981.7 6982.4 6995.0 7001.1 6827.4 6835.2 6838.5 6841.4 6843.8 6632.4 6719.2 6751.1 6754.5 6781.8 6932.7 6934.9 6956.3 6978.2 6997.5 4669.9 4671.3 4674.6 4677.2 4681.4 6778.5 6832.0 6845.1 6851.9 7012.4 6765.1 6794.1 6801.9 6804.2 6815.7 6681.8 6736.9 6742.7 6744.6 6748.2 6498.2 6557.0 6608.3 6619.5 6657.5 6811.7 6820.8 6820.8 6828.8 6843.1 6583.7 6630.2 6634.9 6645.7 6666.9 11:31:17 INFO - 2015-12-09 11:31:17,962 DEBUG : BROWSER_OUTPUT: 11:31:17 INFO - 2015-12-09 11:31:17,962 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14264.98 Median:47746.03 stddev:16518.56 (34.6%) stddev-sans-first:16533.70 11:31:17 INFO - 2015-12-09 11:31:17,963 DEBUG : BROWSER_OUTPUT: Values: 744.0 748.1 772.2 844.8 856.5 13282.7 13513.9 13520.1 15038.0 15220.4 15287.8 15309.8 15340.6 15437.5 15485.5 821.3 836.6 837.8 840.7 844.7 800.2 838.3 841.5 846.0 851.1 877.1 879.0 880.5 882.8 887.6 871.1 872.8 872.9 874.4 876.2 642.3 646.8 647.2 647.2 656.0 13938.6 13940.9 14016.1 14093.5 14096.1 12501.6 12558.5 12635.9 12659.2 13148.5 10433.3 10470.2 10484.8 10616.2 10617.8 3613.2 3708.9 3805.6 3918.8 3924.7 49485.8 49606.5 50290.2 50304.5 50496.2 10499.1 10506.9 10519.7 10528.5 10584.6 18762.6 18938.2 18939.0 18949.0 18989.4 7490.7 7678.8 7710.6 7801.4 7840.6 4427.3 4443.7 4513.8 4527.0 4531.7 2977.9 3012.5 3032.7 3038.7 3041.0 534.9 539.8 544.4 548.0 554.6 623.3 630.3 632.5 672.3 676.2 8713.0 8796.6 8832.0 8837.3 8964.6 675.7 676.8 681.6 699.1 725.2 3825.7 3846.0 3955.8 4352.9 4375.1 58277.7 58282.7 58351.4 58390.1 58754.0 52193.0 53880.0 54091.0 54271.7 54471.7 48279.8 48425.5 51367.5 52333.0 54007.7 8643.4 8769.9 8916.3 9063.4 9182.4 34094.3 34913.5 35565.6 35875.5 36182.6 41400.4 43092.0 43453.6 43729.3 47212.3 11438.7 11719.1 11790.8 11856.9 12151.5 11792.8 12063.6 12458.5 12474.3 12544.6 11001.9 11172.3 11359.1 11559.1 11592.7 11123.9 11208.3 11471.5 11575.8 11701.6 10897.5 11548.8 11633.6 11659.7 11750.9 9844.0 9897.0 9918.9 9941.5 10076.0 8951.2 9000.8 9402.0 9513.3 9794.3 11:31:17 INFO - 2015-12-09 11:31:17,963 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:31:17 INFO - 2015-12-09 11:31:17,963 DEBUG : BROWSER_OUTPUT: 11:31:18 INFO - 2015-12-09 11:31:18,654 INFO : Browser exited with error code: 0 11:31:18 INFO - 2015-12-09 11:31:18,677 INFO : Completed test dromaeo_css (00:18:30) 11:31:18 INFO - 2015-12-09 11:31:18,677 INFO : Starting test kraken 11:31:18 INFO - 2015-12-09 11:31:18,678 DEBUG : operating with platform_type : linux_ 11:31:18 INFO - 2015-12-09 11:31:18,678 INFO : Initialising browser for kraken test... 11:31:18 INFO - 2015-12-09 11:31:18,684 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZim1ac/profile http://localhost:59615/getInfo.html 11:31:22 INFO - 2015-12-09 11:31:22,968 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:31:22 INFO - 2015-12-09 11:31:22,968 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:31:22 INFO - 2015-12-09 11:31:22,968 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:31:22 INFO - 2015-12-09 11:31:22,968 DEBUG : BROWSER_OUTPUT: __metrics 11:31:23 INFO - 2015-12-09 11:31:23,064 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:31:23 INFO - 2015-12-09 11:31:23,897 INFO : Browser initialized. 11:31:23 INFO - 2015-12-09 11:31:23,898 INFO : Running cycle 1/1 for kraken test... 11:31:23 INFO - 2015-12-09 11:31:23,898 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpZim1ac/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:31:35 INFO - 2015-12-09 11:31:35,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 142700544 11:31:35 INFO - 2015-12-09 11:31:35,764 DEBUG : BROWSER_OUTPUT: 11:31:38 INFO - 2015-12-09 11:31:38,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59615/tests/kraken/driver.html?testName=audio-beat-detection) 11:31:38 INFO - 2015-12-09 11:31:38,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 143495168 11:31:38 INFO - 2015-12-09 11:31:38,854 DEBUG : BROWSER_OUTPUT: 11:31:41 INFO - 2015-12-09 11:31:41,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59615/tests/kraken/driver.html?testName=audio-dft) 11:31:42 INFO - 2015-12-09 11:31:42,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 143769600 11:31:42 INFO - 2015-12-09 11:31:42,100 DEBUG : BROWSER_OUTPUT: 11:31:44 INFO - 2015-12-09 11:31:44,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59615/tests/kraken/driver.html?testName=audio-fft) 11:31:45 INFO - 2015-12-09 11:31:45,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 139448320 11:31:45 INFO - 2015-12-09 11:31:45,557 DEBUG : BROWSER_OUTPUT: 11:31:47 INFO - 2015-12-09 11:31:47,514 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59615/tests/kraken/driver.html?testName=audio-oscillator) 11:31:48 INFO - 2015-12-09 11:31:48,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 11:31:48 INFO - 2015-12-09 11:31:48,136 DEBUG : BROWSER_OUTPUT: 11:31:50 INFO - 2015-12-09 11:31:50,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:31:50 INFO - 2015-12-09 11:31:50,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 141172736 11:31:50 INFO - 2015-12-09 11:31:50,937 DEBUG : BROWSER_OUTPUT: 11:31:53 INFO - 2015-12-09 11:31:53,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59615/tests/kraken/driver.html?testName=imaging-darkroom) 11:31:54 INFO - 2015-12-09 11:31:54,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 140595200 11:31:54 INFO - 2015-12-09 11:31:54,507 DEBUG : BROWSER_OUTPUT: 11:31:57 INFO - 2015-12-09 11:31:57,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59615/tests/kraken/driver.html?testName=imaging-desaturate) 11:31:58 INFO - 2015-12-09 11:31:58,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 11:31:58 INFO - 2015-12-09 11:31:58,471 DEBUG : BROWSER_OUTPUT: 11:32:01 INFO - 2015-12-09 11:32:01,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59615/tests/kraken/driver.html?testName=json-parse-financial) 11:32:01 INFO - 2015-12-09 11:32:01,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 141189120 11:32:01 INFO - 2015-12-09 11:32:01,943 DEBUG : BROWSER_OUTPUT: 11:32:03 INFO - 2015-12-09 11:32:03,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:04 INFO - 2015-12-09 11:32:04,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 142307328 11:32:04 INFO - 2015-12-09 11:32:04,125 DEBUG : BROWSER_OUTPUT: 11:32:05 INFO - 2015-12-09 11:32:05,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:06 INFO - 2015-12-09 11:32:06,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 141185024 11:32:06 INFO - 2015-12-09 11:32:06,555 DEBUG : BROWSER_OUTPUT: 11:32:08 INFO - 2015-12-09 11:32:08,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:09 INFO - 2015-12-09 11:32:09,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 141193216 11:32:09 INFO - 2015-12-09 11:32:09,259 DEBUG : BROWSER_OUTPUT: 11:32:11 INFO - 2015-12-09 11:32:11,754 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:12 INFO - 2015-12-09 11:32:12,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 141062144 11:32:12 INFO - 2015-12-09 11:32:12,347 DEBUG : BROWSER_OUTPUT: 11:32:14 INFO - 2015-12-09 11:32:14,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:15 INFO - 2015-12-09 11:32:15,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 140865536 11:32:15 INFO - 2015-12-09 11:32:15,561 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59615/tests/kraken/driver.html?testName=ai-astar) 11:32:17 INFO - 2015-12-09 11:32:17,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 141361152 11:32:17 INFO - 2015-12-09 11:32:17,487 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,487 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:17 INFO - 2015-12-09 11:32:17,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:17 INFO - 2015-12-09 11:32:17,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;112;112;110;122;112;111;112;112 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;127;150;171;130;153;159;124;171;129 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;163;160;161;160;162;168;172;161 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;73;73;72;72;134;72;71;73 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;98;132;92;93;94;135;93;97;133 11:32:17 INFO - 2015-12-09 11:32:17,488 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;111;110;111;111;110;112;110;110 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;147;148;147;147;147;147;147;146;146 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;96;97;96;96;97;96 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;65;67;63;65;63;62;62;61;60 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;68;66;67;67;67;68;66;71;67 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;87;96;87;91;86;86;87;87;88 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;117;130;122;139;126;124;124;120;124 11:32:17 INFO - 2015-12-09 11:32:17,489 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;152;152;152;160;156;151;151;151;156 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;70;67;67;67;66;69;68;68 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,711 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: __startTimestamp1449689537485__endTimestamp 11:32:17 INFO - 2015-12-09 11:32:17,490 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,494 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:17 INFO - 2015-12-09 11:32:17,494 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:32:17 INFO - 2015-12-09 11:32:17,494 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,494 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.96 (3.5%) stddev-sans-first:4.20 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 112.0 112.0 110.0 122.0 112.0 111.0 112.0 112.0 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:18.21 (11.7%) stddev-sans-first:18.95 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: Values: 157.0 127.0 150.0 171.0 130.0 153.0 159.0 124.0 171.0 129.0 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,495 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:3.86 (2.4%) stddev-sans-first:4.07 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 163.0 160.0 161.0 160.0 162.0 168.0 172.0 161.0 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:72.00 stddev:19.58 (27.2%) stddev-sans-first:20.59 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 73.0 73.0 72.0 72.0 134.0 72.0 71.0 73.0 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,496 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:93.00 stddev:18.97 (20.4%) stddev-sans-first:19.53 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: Values: 93.0 98.0 132.0 92.0 93.0 94.0 135.0 93.0 97.0 133.0 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.73 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 111.0 110.0 111.0 111.0 110.0 112.0 110.0 110.0 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.60 11:32:17 INFO - 2015-12-09 11:32:17,497 DEBUG : BROWSER_OUTPUT: Values: 145.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:2.11 (3.3%) stddev-sans-first:2.20 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: Values: 62.0 65.0 67.0 63.0 65.0 63.0 62.0 62.0 61.0 60.0 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:1.49 (2.2%) stddev-sans-first:1.51 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 66.0 67.0 67.0 67.0 68.0 66.0 71.0 67.0 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:87.00 stddev:3.23 (3.7%) stddev-sans-first:3.24 11:32:17 INFO - 2015-12-09 11:32:17,498 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 96.0 87.0 91.0 86.0 86.0 87.0 87.0 88.0 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:124.00 stddev:6.13 (4.9%) stddev-sans-first:6.35 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 130.0 122.0 139.0 126.0 124.0 124.0 120.0 124.0 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:152.00 stddev:4.01 (2.6%) stddev-sans-first:3.17 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: Values: 145.0 152.0 152.0 152.0 160.0 156.0 151.0 151.0 151.0 156.0 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 70.0 67.0 67.0 67.0 66.0 69.0 68.0 68.0 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:17 INFO - 2015-12-09 11:32:17,499 DEBUG : BROWSER_OUTPUT: 11:32:18 INFO - 2015-12-09 11:32:18,493 INFO : Browser exited with error code: 0 11:32:18 INFO - 2015-12-09 11:32:18,544 INFO : Completed test kraken (00:00:59) 11:32:18 INFO - 2015-12-09 11:32:18,544 INFO : Starting test v8_7 11:32:18 INFO - 2015-12-09 11:32:18,544 DEBUG : operating with platform_type : linux_ 11:32:18 INFO - 2015-12-09 11:32:18,544 INFO : Initialising browser for v8_7 test... 11:32:18 INFO - 2015-12-09 11:32:18,550 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmum4Xp/profile http://localhost:59615/getInfo.html 11:32:22 INFO - 2015-12-09 11:32:22,692 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:32:22 INFO - 2015-12-09 11:32:22,692 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:32:22 INFO - 2015-12-09 11:32:22,692 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:32:22 INFO - 2015-12-09 11:32:22,692 DEBUG : BROWSER_OUTPUT: __metrics 11:32:22 INFO - 2015-12-09 11:32:22,800 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:32:23 INFO - 2015-12-09 11:32:23,609 INFO : Browser initialized. 11:32:23 INFO - 2015-12-09 11:32:23,610 INFO : Running cycle 1/1 for v8_7 test... 11:32:23 INFO - 2015-12-09 11:32:23,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmum4Xp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:32:35 INFO - 2015-12-09 11:32:35,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 143417344 11:32:35 INFO - 2015-12-09 11:32:35,501 DEBUG : BROWSER_OUTPUT: 11:32:56 INFO - 2015-12-09 11:32:56,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59615/tests/v8_7/run.html (next: http://localhost:59615/tests/v8_7/run.html) 11:32:57 INFO - 2015-12-09 11:32:57,180 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 11:32:57 INFO - 2015-12-09 11:32:57,180 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,181 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:32:57 INFO - 2015-12-09 11:32:57,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |0;Richards;167.95431642593215 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.07598269700958 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.2524161455372 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1086.9565217391305 11:32:57 INFO - 2015-12-09 11:32:57,182 DEBUG : BROWSER_OUTPUT: |5;Earley;705.2186177715091 11:32:57 INFO - 2015-12-09 11:32:57,183 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 11:32:57 INFO - 2015-12-09 11:32:57,183 DEBUG : BROWSER_OUTPUT: |7;RegExp;25666.666666666668 11:32:57 INFO - 2015-12-09 11:32:57,183 DEBUG : BROWSER_OUTPUT: |8;Splay;562.1135469364812 11:32:57 INFO - 2015-12-09 11:32:57,183 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4873.78640776699 11:32:57 INFO - 2015-12-09 11:32:57,183 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:32:57 INFO - 2015-12-09 11:32:57,184 DEBUG : BROWSER_OUTPUT: __startTimestamp1449689577180__endTimestamp 11:32:57 INFO - 2015-12-09 11:32:57,184 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,184 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:32:57 INFO - 2015-12-09 11:32:57,184 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:32:57 INFO - 2015-12-09 11:32:57,184 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: Values: 168.0 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.08 Median:188.08 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: Values: 188.1 11:32:57 INFO - 2015-12-09 11:32:57,185 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,186 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.25 Median:284.25 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,186 DEBUG : BROWSER_OUTPUT: Values: 284.3 11:32:57 INFO - 2015-12-09 11:32:57,186 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,186 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,186 DEBUG : BROWSER_OUTPUT: Values: 5218.8 11:32:57 INFO - 2015-12-09 11:32:57,187 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,187 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,187 DEBUG : BROWSER_OUTPUT: Values: 1087.0 11:32:57 INFO - 2015-12-09 11:32:57,187 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,187 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:705.22 Median:705.22 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: Values: 705.2 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: Values: 12243.9 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,188 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: Values: 25666.7 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:562.11 Median:562.11 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: Values: 562.1 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,189 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4873.79 Median:4873.79 stddev:0.00 (0.0%) 11:32:57 INFO - 2015-12-09 11:32:57,190 DEBUG : BROWSER_OUTPUT: Values: 4873.8 11:32:57 INFO - 2015-12-09 11:32:57,190 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:32:57 INFO - 2015-12-09 11:32:57,190 DEBUG : BROWSER_OUTPUT: 11:32:57 INFO - 2015-12-09 11:32:57,958 INFO : Browser exited with error code: 0 11:32:57 INFO - 2015-12-09 11:32:57,975 INFO : Completed test v8_7 (00:00:39) 11:32:58 INFO - 2015-12-09 11:32:58,207 INFO : Completed test suite (00:20:10) 11:32:58 INFO - 2015-12-09 11:32:58,207 DEBUG : Working with test: dromaeo_css 11:32:58 INFO - 2015-12-09 11:32:58,207 DEBUG : Generating results file: dromaeo_css 11:32:58 INFO - 2015-12-09 11:32:58,208 DEBUG : Working with test: kraken 11:32:58 INFO - 2015-12-09 11:32:58,208 DEBUG : Generating results file: kraken 11:32:58 INFO - 2015-12-09 11:32:58,208 INFO : javascript benchmark 11:32:58 INFO - 2015-12-09 11:32:58,208 DEBUG : Working with test: v8_7 11:32:58 INFO - 2015-12-09 11:32:58,209 DEBUG : Generating results file: v8_7 11:32:58 INFO - 2015-12-09 11:32:58,209 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:58 INFO - 2015-12-09 11:32:58,260 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 11:32:58 INFO - 2015-12-09 11:32:58,260 DEBUG : process_Request line: dromaeo_css 6986.72 graph.html#tests=[[72,64,43]] 11:32:58 INFO - 2015-12-09 11:32:58,260 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:58 INFO - 2015-12-09 11:32:58,293 DEBUG : process_Request line: kraken 1523.40 graph.html#tests=[[232,64,43]] 11:32:58 INFO - 2015-12-09 11:32:58,293 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:32:58 INFO - 2015-12-09 11:32:58,322 DEBUG : process_Request line: v8_7 21401.39 graph.html#tests=[[230,64,43]] 11:32:58 INFO - 2015-12-09 11:32:58,324 INFO : javascript benchmark 11:32:58 INFO - 2015-12-09 11:32:58,327 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.057458049875, 3213.0360891732475, 3254.5118232265163, 3257.495088261319, 3257.983710081452, 5271.182966640167, 5304.0452718510605, 5363.892722145555, 5390.1914712793105, 5403.648762830413, 5490.450954904508, 5523.944760552393, 5537.446255374461, 5587.888242235153, 5617.241672374228, 4933.703977761345, 5009.824656137036, 5014.323066386046, 5077.771500282496, 5086.313347698069, 5043.067032598962, 5059.721715305656, 5115.283860259567, 5125.718085505296, 5178.249153872686, 4896.559309662111, 4993.700377977297, 5025.045241404122, 5086.567641750474, 5124.923126153092, 5006.649534532584, 5096.439391666913, 5097.439281679012, 5104.795808167669, 5118.6416950813455, 4990.675606085593, 4994.725290109042, 5007.2489126630935, 5017.67385119966, 5031.220160875034, 5150.124478838569, 5208.869778255574, 5251.369835619712, 5365.678059316453, 5396.7301634918485, 5894.292684877799, 5898.64608123514, 5947.226860508106, 5950.226470558843, 6006.549508786815, 5857.179994800731, 5866.384029676908, 5899.085641725539, 5901.2918449785875, 5924.614900031527, 5441.863953401157, 5526.640768350004, 5543.168524721284, 5552.7223638817895, 5620.747066382022, 5956.315023772235, 5967.19442875215, 5990.071538911476, 6020.849478763066, 6021.157038014681, 5807.651540907559, 5811.941880581225, 5813.09896965971, 5813.854653633693, 5822.039363505059, 5752.798652047159, 5845.444682755132, 5937.346891841894, 5963.522918166536, 6037.305709843336, 5853.7365818538265, 5854.531637468992, 5865.032269675456, 5875.441833025856, 5911.940880591225, 5795.855103622359, 5872.471477566954, 5914.0, 5918.7928422505, 5919.704014799243, 4497.347884556786, 4547.954520454819, 4551.658625603027, 4570.451545814523, 4590.724556526619, 4044.3529035354204, 4046.0, 4049.088954985105, 4063.3701776224734, 4082.857100001486, 5455.454454554513, 5569.359523654751, 5601.131824567198, 5614.242077319591, 5624.971875140598, 5853.5317174625925, 5913.58604897653, 5939.10913362999, 5939.584229103922, 5980.611260268069, 5544.77820887168, 5545.694986775686, 5559.27729395176, 5578.944210557843, 5596.356419011866, 5064.18972964324, 5092.719900405439, 5106.029854327666, 5173.32746742921, 5175.301334319894, 5986.760529578768, 6010.579259451796, 6029.3669164737075, 6040.0, 6092.281754394682, 5940.079287710412, 5980.0, 5993.70031498432, 6002.069679199731, 6055.5458340623745, 6000.129981152796, 6077.6961151943115, 6089.147519347206, 6092.939070609415, 6093.421124993119, 5850.151727999501, 5917.526597872074, 5966.731497082555, 5996.4603185713495, 6000.5799594028, 5963.135345374983, 5969.283685957713, 5971.462568368867, 5972.462478376967, 5979.133025711334, 5696.886062278814, 5806.332271788799, 5843.181954526284, 5888.440598143169, 5925.259342582177, 5716.657000579979, 5796.565257605781, 5802.100674395476, 5816.36020037804, 5836.737346819488, 5585.581081418991, 5724.599278050497, 5725.312962444534, 5733.31200255972, 5748.39641837601, 5679.659220446786, 5757.0, 5783.19035335045, 5800.50695690871, 5840.094785308284, 5686.77252909879, 5710.971445142914, 5736.741846616829, 5749.54003679713, 5789.478946894799], "unit": "ms", "name": "dojo.html", "value": 5448.19715028656}, {"lowerIsBetter": false, "replicates": [579.8521377048853, 583.4224118123058, 589.3958692340351, 597.4861619007655, 615.9722812473439, 37738.43392349117, 38337.42493862594, 38456.23087538255, 38561.228775424475, 38597.22805543887, 39479.80260098696, 39913.0, 39922.0, 39957.400638990366, 40191.397129043085, 8476.660933562665, 8651.783705407384, 8677.0, 8689.391742578022, 8708.259797917184, 8265.421420500568, 8365.07984121746, 8381.413301068927, 8391.992960844707, 8393.454425462356, 8376.371772117085, 8467.0, 8490.915090849105, 8529.232369086782, 8535.445196062266, 8373.41386102973, 8479.364047696417, 8501.489910605384, 8502.362322825782, 8506.82986340276, 8330.250277475056, 8426.4944103354, 8426.873596896052, 8443.493390396534, 8450.112738162466, 36134.81932590347, 36466.27067458662, 36498.635013649786, 36526.45210321847, 36561.634383656354, 3171.8414079295944, 3219.3400352927592, 3248.740100791955, 3268.313654132635, 3269.084656296241, 28986.42027159466, 29312.853435732897, 29316.560251596242, 29520.26199345012, 29895.850520747255, 3700.389435743099, 3715.925681486355, 3747.4191500317493, 3758.661720445173, 3759.812009399519, 255204.72397638077, 255738.0, 256098.0, 256189.0, 256283.0, 41843.7907810459, 41917.79041104775, 42052.0, 48304.27543586849, 48328.0, 39566.0, 39598.80200598978, 39832.0, 39953.400698989535, 39970.600293996686, 12395.876041239653, 12440.315782632042, 12483.625491235278, 12495.187812792139, 12496.437660305308, 10614.787704245871, 10615.52230149645, 10664.0, 10667.733306667395, 10701.143908487302, 13909.374078166507, 14154.858451415354, 14277.14337139775, 14283.214423206824, 14382.496612618508, 5788.450097240755, 5805.6806875621405, 5830.533557315404, 5832.154337621021, 5837.766489340379, 956.4739393333778, 1009.2128140050772, 1016.4511163971521, 1021.5607288865859, 1068.0067537190487, 27792.72207277901, 27917.0, 28537.286567835556, 28546.571801422997, 28613.427731445256, 1074.398336931321, 1074.9570017199223, 1076.6716151573846, 1114.3369695031442, 1121.4560937945091, 15904.522864314089, 16867.493975180765, 17045.0, 17066.48800535986, 17335.25426601593, 371875.0, 375768.0, 376164.0, 376377.0, 376393.0, 53486.465135348924, 53775.46224537783, 54008.0, 54027.729861351225, 54067.188992165145, 1304.8825605695533, 1330.900182486298, 1340.5710172744627, 1357.253510569183, 1368.8973327000515, 29153.0, 30226.0, 31439.84280078585, 32496.0, 32569.0, 48607.27089093596, 48786.0, 49014.0, 49346.50653493419, 49466.268680597444, 303980.0, 308375.0, 309571.0, 309857.0, 310673.0, 41020.17959640731, 44584.0, 45024.77487612541, 45412.31881521846, 46021.53978460172, 42465.787671061444, 42504.362434562885, 42530.0, 43107.13785724331, 43243.35134973041, 35928.28143437169, 35990.4601430984, 36420.27159456849, 36544.08639784026, 41053.1789364205, 34663.480047798796, 35819.10452238715, 40647.0, 40764.59235407608, 42314.788426057676, 34484.82757586196, 34842.30315393729, 34923.0, 35512.46731299084, 35604.82197588996, 31342.37315253728, 32413.35173296568, 32775.836120819244, 33198.0, 33208.66791332152, 25148.49703005966, 25227.873860630578, 25358.0, 25457.745422545537, 25780.226593202235], "unit": "ms", "name": "ext.html", "value": 17941.402459530604}, {"lowerIsBetter": false, "replicates": [361.39285999520797, 362.25556481430664, 366.1030475335428, 366.89543480108176, 367.6084969507475, 16527.0, 16795.1602419879, 17350.132493375328, 17936.0, 18557.721634175497, 13717.519886803964, 15874.36502539897, 16083.276252568634, 16133.27400266988, 16396.67206655866, 4815.422149342084, 4931.0, 4962.5533701966815, 4972.328735620699, 4980.551750342468, 4875.926861097087, 4878.219484882419, 4903.141950158726, 4916.360873086512, 4919.409670839486, 5191.117510023286, 5198.142306519419, 5274.736263186845, 5357.08929481989, 5380.784768609251, 5307.946920530784, 5320.733963301839, 5337.759800808973, 5373.892522149574, 6067.666278354689, 5401.891962160774, 5413.431589683105, 5413.485718856702, 5415.566754659618, 5432.158015507603, 12911.741765164645, 12983.610491685264, 13555.728885422237, 13587.52443664467, 13588.728225435436, 2066.1941842681367, 2099.0, 2166.306781829815, 2228.4094714900566, 2388.9283321500384, 9758.12176904075, 9913.504324783804, 9995.400275983464, 10038.598456061749, 10088.293819432643, 1725.8619310455133, 1745.816689247636, 1766.1169415292354, 1813.5919418130816, 1836.8071352507927, 61679.0, 62369.0, 62853.0, 63664.0, 64067.0, 10158.695239142837, 10328.380297182193, 10521.579136834594, 10580.25938184335, 10588.682339529672, 13739.725205496034, 13751.724965500634, 13863.168209907439, 13872.861271387157, 13878.375473103735, 6929.5842249464185, 7179.0, 7299.927000730031, 7365.668544915492, 7495.437842161859, 6677.666116694146, 6682.298358672367, 6706.497012724065, 6728.6972086255255, 6990.720371185197, 4452.821887124479, 4499.190145773727, 4533.161365147458, 4564.475085365159, 4583.129205450954, 1796.6316905034437, 1823.8267364600342, 1852.5090850924516, 1864.6736821056531, 1868.6169335286233, 436.4936673458836, 442.6635756824772, 480.3683156649065, 807.9676812927418, 903.5211337990876, 10349.793004139876, 10877.129829613612, 16827.326906923587, 17120.14399280031, 17452.5636859077, 870.8954925408865, 890.3455959869491, 920.0283085633308, 993.6820217530466, 1027.8869324374461, 8858.911410885938, 9074.364794464456, 9402.576884040234, 10030.097291243823, 10297.742556436, 529969.0, 541714.0, 547682.0, 550191.0, 569542.0, 81030.0, 81123.59438202772, 83200.16799832045, 84205.57897210475, 85151.0, 1112.9499172537255, 1141.4635121492886, 1146.0545050333508, 1153.140910022039, 1155.936423496699, 15564.766528501856, 15840.28718707684, 16037.278322475284, 16176.0, 16195.352185912432, 36016.459753104245, 36316.0, 36396.27207455889, 36692.0826979317, 37358.62641373552, 47327.76336118297, 47435.76282118567, 49208.50791492182, 50010.0, 51464.22803657873, 9574.281928855224, 9593.0, 9741.123298903132, 9816.754581135528, 9830.557624906753, 17039.48881533556, 17422.128893555524, 17749.0, 17755.556111097325, 18035.38355354959, 13617.931910340385, 13690.726185476435, 13784.586462406143, 13987.650308742363, 14771.630709232355, 13818.894488441101, 13965.930170349084, 14121.2233327168, 14474.710505790035, 14582.739675350338, 14470.276486175439, 14538.709225815213, 14619.269036547917, 14861.777073344125, 14884.627884302547, 9385.81228375415, 9476.289278304017, 9516.666916657883, 9619.56711947978, 9644.855327170239, 10475.685729428129, 10605.098566621615, 12207.69480762988, 14655.780163297772, 15226.695466090838], "unit": "ms", "name": "jquery.html", "value": 8639.45621251121}, {"lowerIsBetter": false, "replicates": [1520.0271826031335, 1692.8307169283073, 1733.2980143042073, 1751.6934536456117, 1756.964860702786, 7048.823779405518, 7245.601491917955, 7450.40396768258, 7488.962555187217, 7513.511621744589, 7402.259774022595, 7430.18267990522, 7466.216047315035, 7490.138634057085, 7497.0, 2207.0399376271293, 2239.104358256694, 2239.585676649825, 2240.4174914522177, 2244.494988627562, 2225.5993921094196, 2251.0995601759346, 2251.324602619216, 2253.504229069602, 2281.9315420537328, 2167.880766557839, 2196.934091977243, 2204.526026904215, 2215.7451893032267, 2220.04538048639, 2180.5420861619077, 2247.910083596654, 2248.2917880867476, 2261.366817291161, 2264.2641141628874, 2206.9558608827733, 2242.6972358731527, 2256.3231030690727, 2263.0, 2272.0, 7447.0, 7476.813079673052, 7522.285382888617, 7523.623818809037, 7551.0, 4512.187806194884, 4583.518730533313, 4603.930941035887, 4607.424071991001, 4621.23749581322, 2993.5060714982, 3028.606281183432, 3036.0, 3056.449839028974, 3058.8835075197617, 973.255459573427, 1008.7377281906757, 1033.8966103389675, 1037.102905986324, 1044.81715699753, 9832.803343933081, 9909.75225619358, 9913.0, 9953.004699530062, 9958.502074896227, 3947.842086316515, 3969.384745364473, 4019.0957034666967, 4035.21313343901, 4060.796960151981, 8093.392995525359, 8122.959385203154, 8139.715109971241, 8141.755747327589, 8160.795980100545, 4496.842610508616, 4509.526499717548, 4534.569215924482, 4537.478190008192, 4565.5206203348835, 4129.504459464883, 4159.729617574848, 4180.728252663567, 4183.602557757008, 4185.874423767292, 3276.3447310537986, 3279.065466342081, 3282.294306724066, 3301.009697090863, 3315.8839440619463, 1003.6085926488676, 1004.6031817432073, 1021.4024795494719, 1025.559009625868, 1027.3014350241758, 883.8541640629225, 947.1664934857281, 1039.9584016639249, 1113.554578168739, 1340.7251513439721, 7020.368166865007, 7028.92971070293, 7040.894386584206, 7045.471589630798, 7054.2240353561065, 612.8988716861668, 621.8662987457628, 636.0999186151544, 638.0684201066495, 761.4859969520552, 5260.605454590845, 5489.725513724298, 5509.779608815683, 5528.032594295983, 5537.6954267515675, 8676.783080422914, 8684.261837743863, 8701.651933922572, 8707.825843483095, 8859.24696400813, 8737.694180703646, 8763.167499087576, 8783.780405489913, 8828.161324674145, 8840.0, 6966.9303306967295, 6986.510944233956, 7017.263187365355, 7032.718691252395, 7034.929650703428, 6623.105880706235, 6777.796666100025, 6798.252192258748, 6829.487788415988, 6832.726690932506, 7757.961210193913, 7867.449278550446, 7903.486273392211, 7914.643841027052, 7983.960080199794, 7747.30274275318, 7925.841483170419, 8063.233992770912, 8075.111737708729, 8078.23256790604, 6651.102101216274, 6651.46788256948, 6674.132362792806, 6694.0, 6697.665116744241, 7123.0, 7229.421646268391, 7237.927620723936, 7253.528520646352, 7272.127344718668, 6795.25252222265, 6831.351021652935, 6856.280090590416, 6906.654667266516, 6931.994860745062, 6524.608523488606, 6588.901166482411, 6644.4020038196795, 6746.089277947414, 6766.661666916733, 6667.533272670867, 6667.933320666732, 6735.4274886635185, 6752.729890804313, 6776.0, 5985.281766188085, 6007.639541627516, 6016.2479690038745, 6040.637561746309, 6115.480184184395, 6302.401271879165, 6351.9047214290895, 6371.649559274284, 6375.203099612549, 6381.7128229228865], "unit": "ms", "name": "mootools.html", "value": 4242.249693619904}, {"lowerIsBetter": false, "replicates": [335.74818885835623, 337.07641063486045, 339.6433744568204, 340.16319853161224, 345.9584849818022, 6302.306746257919, 6306.936930630693, 6325.588836725609, 6331.683415829208, 6427.775027874025, 6187.226596675416, 6279.68601569922, 6335.239771227459, 6341.429271365576, 6343.175387199658, 4779.617630589544, 4808.783604737778, 4809.975950120262, 4810.63920205986, 4812.133815913135, 4807.687500312486, 4815.855524334275, 4816.662833601649, 4817.108834865561, 4827.082854257697, 4662.323963025359, 4762.595179409755, 4779.259214821708, 4787.305840653104, 4788.138135135674, 4705.317728929321, 4746.359241502388, 4751.073540659556, 4759.4764575896625, 4778.546038126373, 4136.772477513736, 4138.0, 4139.337705967061, 4144.544100148981, 4152.335626299778, 6048.364921683204, 6050.455459008666, 6069.119977603223, 6070.2715674118945, 6075.848103797396, 5454.154606036071, 5578.330600327946, 5579.8605034874045, 5584.636998595079, 5586.1062230043, 6657.101291325657, 6659.234188068385, 6688.565243259172, 6709.396154346084, 6714.19429668438, 4580.9770951145365, 4595.885102872455, 4596.839110631146, 4603.907921841578, 4608.585227329523, 6768.661566921634, 6854.6229957352325, 6856.142982127284, 6922.446204303644, 6932.0988271524375, 4678.415198100238, 4687.062587482517, 4689.976550117228, 4691.038337140878, 4693.342931989524, 4715.95284047162, 4727.267273572602, 4736.881577960578, 4739.336492890998, 4740.620750339965, 5507.476789704971, 5509.531689806331, 5510.256115424447, 5513.476219759116, 5519.889602207933, 6597.241317248482, 6664.366885145903, 6703.22912865017, 6709.798706038827, 6726.058351830748, 1629.055148014149, 1648.2747591059895, 1666.7249903765985, 1679.5968967447968, 1682.2513981278457, 1080.8000519903685, 1093.7211011192096, 1100.4167791070586, 1104.4312179227704, 1108.1633366808007, 6281.623102613858, 6282.277538083179, 6321.747130114744, 6323.9051414228825, 6343.460805831463, 6802.489813264025, 6807.183138023469, 6830.180378354629, 6830.692618832164, 6846.657667116624, 6155.72299246526, 6259.155014073133, 6271.466925311308, 6284.685765711696, 6319.33646967071, 3724.4599533067553, 3728.0, 3730.440433934877, 3730.7388482806487, 3734.57052438973, 6894.448444124458, 6986.44108471321, 6988.0, 6989.685464154125, 7006.194287656883, 6837.760678376233, 7004.404625606779, 7012.403945664573, 7016.7193312267955, 7019.473539484559, 6978.47661425385, 6981.685824137926, 6982.371586557234, 6994.965025174842, 7001.054857594261, 6827.385535301847, 6835.248122706597, 6838.487113466411, 6841.3842754152365, 6843.794686159423, 6632.436242919406, 6719.227288861844, 6751.122354093936, 6754.493412994143, 6781.796546103625, 6932.7226910923, 6934.8613027740175, 6956.339147780953, 6978.232394436506, 6997.510174287954, 4669.906601868011, 4671.346011558452, 4674.62602991753, 4677.181493238601, 4681.368015317888, 6778.4577233822165, 6832.0, 6845.0759147514445, 6851.931480685329, 7012.403945664676, 6765.086713293839, 6794.082798822095, 6801.9319806801295, 6804.217514985642, 6815.693293801692, 6681.799546013627, 6736.93263067363, 6742.69657865407, 6744.62904540255, 6748.19021717397, 6498.187726534184, 6556.967215163893, 6608.273089960197, 6619.50353723463, 6657.53397262187, 6811.659417029228, 6820.795376138723, 6820.829479263058, 6828.760993365208, 6843.110395648534, 6583.703733332108, 6630.204375474974, 6634.9004764927595, 6645.734170633121, 6666.899996500153], "unit": "ms", "name": "prototype.html", "value": 5003.559159787721}, {"lowerIsBetter": false, "replicates": [743.9665215065321, 748.0723902361074, 772.212343409722, 844.8479273730729, 856.4689892266791, 13282.66793330166, 13513.864861351383, 13520.121192122506, 15038.0, 15220.39118435264, 15287.770683439758, 15309.84690153101, 15340.61648458789, 15437.536873893801, 15485.535433937, 821.3388222480901, 836.5733475927291, 837.8073043200083, 840.6679361652174, 844.6916875340487, 800.1598321762156, 838.337713206566, 841.5497708725833, 846.0439703135448, 851.059579165023, 877.1009715042069, 879.0462348352046, 880.4981160738382, 882.7748924024365, 887.6050157679836, 871.1288711288743, 872.7687162901836, 872.8865247517846, 874.3879284500812, 876.1982785751062, 642.3448082955406, 646.7703965092419, 647.2297965421134, 647.2427260105687, 655.9672016399209, 13938.58184254474, 13940.93029534856, 14016.088954218045, 14093.5067272646, 14096.08375455592, 12501.624951251386, 12558.497660093586, 12635.873641263654, 12659.240445573296, 13148.474061037547, 10433.269671123024, 10470.214733894989, 10484.79030419395, 10616.203784716177, 10617.787644247072, 3613.2050948791225, 3708.8887333380044, 3805.60041195676, 3918.784466854322, 3924.6860251179837, 49485.75257123727, 49606.50393496055, 50290.245646315336, 50304.496955030714, 50496.242556361685, 10499.107575855985, 10506.947465262778, 10519.737006574896, 10528.526216320284, 10584.629537966135, 18762.624747504975, 18938.242470301033, 18939.0, 18949.0, 18989.430317090508, 7490.6629201686055, 7678.808029799188, 7710.575918324546, 7801.375889928792, 7840.647170877324, 4427.313766366218, 4443.7111587746695, 4513.774311284423, 4527.026689261825, 4531.682782205214, 2977.898177674231, 3012.457757603652, 3032.6815684353264, 3038.741706954889, 3040.9543856842165, 534.946505349462, 539.8083680293439, 544.3984397240991, 548.0, 554.5840619535348, 623.2925629410652, 630.2688880898136, 632.4718859752066, 672.3276723276723, 676.1818199978081, 8713.0, 8796.604152813139, 8831.955840220759, 8837.337199710048, 8964.551772411483, 675.7228837497134, 676.7665155521337, 681.56039354616, 699.1086364884812, 725.2312548698396, 3825.732198746117, 3846.0, 3955.8219880105466, 4352.891177720519, 4375.146846364992, 58277.70861145667, 58282.7085864568, 58351.41648583545, 58390.12414813781, 58754.0, 52193.0, 53880.0, 54091.0, 54271.72864135733, 54471.72764136233, 48279.75860120677, 48425.51574484281, 51367.48632513702, 52333.0, 54007.72996134994, 8643.394962352575, 8769.91230087691, 8916.33127515452, 9063.41087829289, 9182.449053056838, 34094.31811363808, 34913.47629785606, 35565.64434355623, 35875.461868072525, 36182.63817361898, 41400.37899431571, 43092.0, 43453.56546434622, 43729.344059839765, 47212.291815622106, 11438.656840294805, 11719.12106592026, 11790.823137652771, 11856.940715296369, 12151.513939442324, 11792.76414471723, 12063.612684541391, 12458.501659933501, 12474.313912734886, 12544.560940367044, 11001.889981100087, 11172.273802202832, 11359.148063895405, 11559.133065019989, 11592.744947658948, 11123.888761112285, 11208.27146235492, 11471.483783229942, 11575.826362604736, 11701.590444334408, 10897.509612067317, 11548.769024619629, 11633.63515167724, 11659.650210493699, 11750.94124529372, 9844.0, 9896.950515247378, 9918.851217231602, 9941.502924853583, 10076.0, 8951.194392504705, 9000.81998360016, 9401.952990235006, 9513.33406661527, 9794.314397992357], "unit": "ms", "name": "yui.html", "value": 6488.320205517365}], "name": "dromaeo_css", "value": 6986.72118697035}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 112.0, 112.0, 110.0, 122.0, 112.0, 111.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [157.0, 127.0, 150.0, 171.0, 130.0, 153.0, 159.0, 124.0, 171.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 163.0, 160.0, 161.0, 160.0, 162.0, 168.0, 172.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 163.3}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 73.0, 73.0, 72.0, 72.0, 134.0, 72.0, 71.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [93.0, 98.0, 132.0, 92.0, 93.0, 94.0, 135.0, 93.0, 97.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 112.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 67.0, 63.0, 65.0, 63.0, 62.0, 62.0, 61.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 63.0}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 67.0, 67.0, 67.0, 68.0, 66.0, 71.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 96.0, 87.0, 91.0, 86.0, 86.0, 87.0, 87.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [121.0, 117.0, 130.0, 122.0, 139.0, 126.0, 124.0, 124.0, 120.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [145.0, 152.0, 152.0, 152.0, 160.0, 156.0, 151.0, 151.0, 151.0, 156.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 70.0, 67.0, 67.0, 67.0, 66.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1523.3999999999996}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [188.07598269700958], "unit": "score", "name": "DeltaBlue", "value": 351.549406}, {"lowerIsBetter": false, "replicates": [284.2524161455372], "unit": "score", "name": "Encrypt", "value": 936.4247580000001}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [705.2186177715091], "unit": "score", "name": "Earley", "value": 945.0445340000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [562.1135469364812], "unit": "score", "name": "Splay", "value": 144.97248899999997}, {"lowerIsBetter": false, "replicates": [4873.78640776699], "unit": "score", "name": "NavierStokes", "value": 304.48605577689233}], "name": "v8_7", "value": 21401.385203847087}]} 11:32:58 INFO - RETURN: dromaeo_css: 6986.72 11:32:58 INFO - RETURN: kraken: 1523.40 11:32:58 INFO - RETURN: v8_7: 21401.39 11:32:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21401.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1523.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6986.72"}}} 11:32:58 INFO - Return code: 0 11:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:32:58 INFO - # TBPL SUCCESS # 11:32:58 INFO - Running post-action listener: _resource_record_post_action 11:32:58 INFO - Running post-run listener: _resource_record_post_run 11:32:59 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 518602752; Read time: 104; Write time: 363272 11:32:59 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238350336; Read time: 0; Write time: 223144 11:32:59 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279433216; Read time: 104; Write time: 140096 11:32:59 INFO - Running post-run listener: _upload_blobber_files 11:32:59 INFO - Blob upload gear active. 11:32:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:32:59 INFO - Copying logs to upload dir... 11:32:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.217518 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-12-09 11:32:58.166486) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:32:58.169828) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009467 build_url: 'https://queue.taskcluster.net/v1/task/mBbIixU_SDy_9emxtpAVhg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.06 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:32:58.234786) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:32:58.235165) ========= 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=928fd09416829678a2f67a56000001ac-1449688229.926082-396047106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:32:58.285790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:32:58.286151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:32:58.286556) ========= ========= Total master_lag: 0.37 =========