builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1453722372.62 results: success (0) buildid: 20160125001712 builduid: 5d8eb007e2de4c2eae63c4ce4fd78a1e revision: ab89c814f1b8a841168de98ac2679a1d66122a06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.619099) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.619656) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.619949) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.713354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.713793) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.884423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.884701) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.956678) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.956943) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.957288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.957570) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 03:46:13-- 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% 20.2M=0.001s 2016-01-25 03:46:13 (20.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.160219 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.150995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.151303) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017227 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.208394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.208694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 03:46:13,393 truncating revision to first 12 chars 2016-01-25 03:46:13,393 Setting DEBUG logging. 2016-01-25 03:46:13,393 attempt 1/10 2016-01-25 03:46:13,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab89c814f1b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 03:46:13,848 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.954333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.954635) ========= echo ab89c814f1b8a841168de98ac2679a1d66122a06 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab89c814f1b8a841168de98ac2679a1d66122a06'] 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.004627 script_repo_revision: 'ab89c814f1b8a841168de98ac2679a1d66122a06' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.004729) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.005013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.014932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 03:46:14.015281) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:14 INFO - MultiFileLogger online at 20160125 03:46:14 in /builds/slave/test-pgo 03:46:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:14 INFO - {'append_to_log': False, 03:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:14 INFO - 'branch': 'Mozilla-Aurora', 03:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:14 INFO - 'config_files': ('talos/linux_config.py',), 03:46:14 INFO - 'default_actions': ('clobber', 03:46:14 INFO - 'read-buildbot-config', 03:46:14 INFO - 'download-and-extract', 03:46:14 INFO - 'populate-webroot', 03:46:14 INFO - 'create-virtualenv', 03:46:14 INFO - 'install', 03:46:14 INFO - 'run-tests'), 03:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:14 INFO - 'download_minidump_stackwalk': True, 03:46:14 INFO - 'download_symbols': 'ondemand', 03:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:14 INFO - 'installer_path': 'installer.exe', 03:46:14 INFO - 'log_level': 'info', 03:46:14 INFO - 'log_name': 'talos', 03:46:14 INFO - 'log_to_console': True, 03:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:14 INFO - 'opt_config_files': (), 03:46:14 INFO - 'pip_index': False, 03:46:14 INFO - 'sps_profile': False, 03:46:14 INFO - 'sps_profile_interval': 0, 03:46:14 INFO - 'suite': 'dromaeojs', 03:46:14 INFO - 'system_bits': '32', 03:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:14 INFO - 'title': 'talos-linux64-ix-055', 03:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:14 INFO - 'use_talos_json': True, 03:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:14 INFO - 'work_dir': 'build'} 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running clobber step. 03:46:14 INFO - ##### 03:46:14 INFO - Running pre-action listener: _resource_record_pre_action 03:46:14 INFO - Running main action method: clobber 03:46:14 INFO - rmtree: /builds/slave/test-pgo/build 03:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:15 INFO - Running post-action listener: _resource_record_post_action 03:46:15 INFO - ##### 03:46:15 INFO - ##### Running read-buildbot-config step. 03:46:15 INFO - ##### 03:46:15 INFO - Running pre-action listener: _resource_record_pre_action 03:46:15 INFO - Running main action method: read_buildbot_config 03:46:15 INFO - Using buildbot properties: 03:46:15 INFO - { 03:46:15 INFO - "properties": { 03:46:15 INFO - "buildnumber": 116, 03:46:15 INFO - "product": "firefox", 03:46:15 INFO - "script_repo_revision": "production", 03:46:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:46:15 INFO - "repository": "", 03:46:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:46:15 INFO - "buildid": "20160125001712", 03:46:15 INFO - "slavename": "talos-linux64-ix-055", 03:46:15 INFO - "pgo_build": "True", 03:46:15 INFO - "basedir": "/builds/slave/test-pgo", 03:46:15 INFO - "project": "", 03:46:15 INFO - "platform": "ubuntu64_hw", 03:46:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:46:15 INFO - "slavebuilddir": "test", 03:46:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "branch": "mozilla-aurora", 03:46:15 INFO - "repo_path": "releases/mozilla-aurora", 03:46:15 INFO - "stage_platform": "linux64-pgo", 03:46:15 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - }, 03:46:15 INFO - "sourcestamp": { 03:46:15 INFO - "repository": "", 03:46:15 INFO - "hasPatch": false, 03:46:15 INFO - "project": "", 03:46:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "changes": [ 03:46:15 INFO - { 03:46:15 INFO - "category": null, 03:46:15 INFO - "files": [ 03:46:15 INFO - { 03:46:15 INFO - "url": null, 03:46:15 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:46:15 INFO - } 03:46:15 INFO - ], 03:46:15 INFO - "repository": "", 03:46:15 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 03:46:15 INFO - "who": "cbook@mozilla.com", 03:46:15 INFO - "when": 1453717351, 03:46:15 INFO - "number": 7510169, 03:46:15 INFO - "comments": "Bug 1241061 - [firefox-ui-tests] Workaround for bug 1237706 to use ZipFile if unzip command is not available. r=maja_zf, a=test-only", 03:46:15 INFO - "project": "", 03:46:15 INFO - "at": "Mon 25 Jan 2016 02:22:31", 03:46:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "revlink": "", 03:46:15 INFO - "properties": [ 03:46:15 INFO - [ 03:46:15 INFO - "buildid", 03:46:15 INFO - "20160125001712", 03:46:15 INFO - "Change" 03:46:15 INFO - ], 03:46:15 INFO - [ 03:46:15 INFO - "builduid", 03:46:15 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:15 INFO - "Change" 03:46:15 INFO - ], 03:46:15 INFO - [ 03:46:15 INFO - "pgo_build", 03:46:15 INFO - "True", 03:46:15 INFO - "Change" 03:46:15 INFO - ] 03:46:15 INFO - ], 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - } 03:46:15 INFO - ], 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - } 03:46:15 INFO - } 03:46:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:46:15 INFO - Running post-action listener: _resource_record_post_action 03:46:15 INFO - ##### 03:46:15 INFO - ##### Running download-and-extract step. 03:46:15 INFO - ##### 03:46:15 INFO - Running pre-action listener: _resource_record_pre_action 03:46:15 INFO - Running main action method: download_and_extract 03:46:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:15 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')]} 03:46:15 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:17 INFO - Downloaded 1302 bytes. 03:46:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:17 INFO - Using the following test package requirements: 03:46:17 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:17 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:17 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'jsshell-linux-x86_64.zip'], 03:46:17 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:17 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:17 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:17 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:17 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:17 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:17 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:17 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:17 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:17 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')]} 03:46:17 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:19 INFO - Downloaded 23159167 bytes. 03:46:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:19 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:20 INFO - Return code: 0 03:46:20 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46:20 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')]} 03:46:20 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:26 INFO - Downloaded 23159167 bytes. 03:46:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:26 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:46:27 INFO - Return code: 0 03:46:27 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')]} 03:46:27 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:28 INFO - Downloaded 11132038 bytes. 03:46:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 03:46:28 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:46:28 INFO - Return code: 0 03:46: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')]} 03:46:28 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:46:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:31 INFO - Downloaded 58033452 bytes. 03:46:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:31 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:31 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:31 INFO - Contents: 03:46:31 INFO - build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:46:31 INFO - Running post-action listener: _resource_record_post_action 03:46:31 INFO - Running post-action listener: set_extra_try_arguments 03:46:31 INFO - ##### 03:46:31 INFO - ##### Running populate-webroot step. 03:46:31 INFO - ##### 03:46:31 INFO - Running pre-action listener: _resource_record_pre_action 03:46:31 INFO - Running main action method: populate_webroot 03:46:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:31 INFO - '--tppagecycles', 03:46:31 INFO - '7'], 03:46:31 INFO - 'tests': ['tsvgm']}}, 03:46:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'tests': ['damp', 'tps']}, 03:46:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['damp', 'tps']}, 03:46:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:31 INFO - 'other': {'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'other_l64': {'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:31 INFO - 'ts_paint', 03:46:31 INFO - 'tpaint', 03:46:31 INFO - 'sessionrestore', 03:46:31 INFO - 'sessionrestore_no_auto_restore']}, 03:46:31 INFO - 'svgr': {'tests': ['tsvgx', 03:46:31 INFO - 'tsvgr_opacity', 03:46:31 INFO - 'tart', 03:46:31 INFO - 'tscrollx', 03:46:31 INFO - 'cart']}, 03:46:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['tsvgx', 03:46:31 INFO - 'tsvgr_opacity', 03:46:31 INFO - 'tart', 03:46:31 INFO - 'tscrollx', 03:46:31 INFO - 'cart']}, 03:46:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'tests': ['tp5o']}, 03:46:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'talos_options': ['--e10s'], 03:46:31 INFO - 'tests': ['tp5o']}, 03:46:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'talos_options': ['--xperf_path', 03:46:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:31 INFO - 'tests': ['tp5n']}, 03:46:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:31 INFO - 'talos_options': ['--e10s', 03:46:31 INFO - '--xperf_path', 03:46:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:31 INFO - 'tests': ['tp5n']}}, 03:46:31 INFO - 'talos.zip': {'path': '', 03:46:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:31 INFO - Running post-action listener: _resource_record_post_action 03:46:31 INFO - ##### 03:46:31 INFO - ##### Running create-virtualenv step. 03:46:31 INFO - ##### 03:46:31 INFO - Running pre-action listener: _resource_record_pre_action 03:46:31 INFO - Running main action method: create_virtualenv 03:46:31 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:31 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 03:46:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:31 INFO - Using real prefix '/usr' 03:46:31 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:46:32 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:34 INFO - Installing pip.................done. 03:46:34 INFO - Return code: 0 03:46:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:46:34 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')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 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')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:34 INFO - Using env: {'DISPLAY': ':0', 03:46:34 INFO - 'HOME': '/home/cltbld', 03:46:34 INFO - 'LANG': 'en_US.UTF-8', 03:46:34 INFO - 'LANGUAGE': 'en_US:en', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MAIL': '/var/mail/cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SHLVL': '1', 03:46:34 INFO - 'TERM': 'linux', 03:46:34 INFO - 'TMOUT': '86400', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - '_': '/tools/buildbot/bin/python'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 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 03:46:34 INFO - Cleaning up... 03:46:34 INFO - Return code: 0 03:46:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:46:34 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')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 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')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:34 INFO - Using env: {'DISPLAY': ':0', 03:46:34 INFO - 'HOME': '/home/cltbld', 03:46:34 INFO - 'LANG': 'en_US.UTF-8', 03:46:34 INFO - 'LANGUAGE': 'en_US:en', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MAIL': '/var/mail/cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SHLVL': '1', 03:46:34 INFO - 'TERM': 'linux', 03:46:34 INFO - 'TMOUT': '86400', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - '_': '/tools/buildbot/bin/python'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 INFO - Downloading/unpacking psutil>=0.7.1 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:34 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 03:46:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:36 INFO - Installing collected packages: psutil 03:46:36 INFO - Running setup.py install for psutil 03:46:36 INFO - building 'psutil._psutil_linux' extension 03:46:36 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 03:46:36 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 03:46:36 INFO - building 'psutil._psutil_posix' extension 03:46:36 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 03:46:37 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 03:46:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:37 INFO - Successfully installed psutil 03:46:37 INFO - Cleaning up... 03:46:37 INFO - Return code: 0 03:46:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:46:37 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')]} 03:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 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')]} 03:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:37 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:37 INFO - Using env: {'DISPLAY': ':0', 03:46:37 INFO - 'HOME': '/home/cltbld', 03:46:37 INFO - 'LANG': 'en_US.UTF-8', 03:46:37 INFO - 'LANGUAGE': 'en_US:en', 03:46:37 INFO - 'LOGNAME': 'cltbld', 03:46:37 INFO - 'MAIL': '/var/mail/cltbld', 03:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:37 INFO - 'MOZ_NO_REMOTE': '1', 03:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:37 INFO - 'NO_EM_RESTART': '1', 03:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:37 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:37 INFO - 'SHELL': '/bin/bash', 03:46:37 INFO - 'SHLVL': '1', 03:46:37 INFO - 'TERM': 'linux', 03:46:37 INFO - 'TMOUT': '86400', 03:46:37 INFO - 'USER': 'cltbld', 03:46:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:37 INFO - '_': '/tools/buildbot/bin/python'} 03:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:37 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 03:46:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:39 INFO - Installing collected packages: mozsystemmonitor 03:46:39 INFO - Running setup.py install for mozsystemmonitor 03:46:39 INFO - Successfully installed mozsystemmonitor 03:46:39 INFO - Cleaning up... 03:46:39 INFO - Return code: 0 03:46:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:46:39 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')]} 03:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:39 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')]} 03:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:39 INFO - Using env: {'DISPLAY': ':0', 03:46:39 INFO - 'HOME': '/home/cltbld', 03:46:39 INFO - 'LANG': 'en_US.UTF-8', 03:46:39 INFO - 'LANGUAGE': 'en_US:en', 03:46:39 INFO - 'LOGNAME': 'cltbld', 03:46:39 INFO - 'MAIL': '/var/mail/cltbld', 03:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:39 INFO - 'MOZ_NO_REMOTE': '1', 03:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:39 INFO - 'NO_EM_RESTART': '1', 03:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:39 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:39 INFO - 'SHELL': '/bin/bash', 03:46:39 INFO - 'SHLVL': '1', 03:46:39 INFO - 'TERM': 'linux', 03:46:39 INFO - 'TMOUT': '86400', 03:46:39 INFO - 'USER': 'cltbld', 03:46:39 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:39 INFO - '_': '/tools/buildbot/bin/python'} 03:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:39 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 03:46:39 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 03:46:39 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 03:46:39 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 03:46:39 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 03:46:39 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 03:46:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:46:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 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 03:46:41 INFO - Downloading docopt-0.6.1.tar.gz 03:46:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:42 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:42 INFO - Running setup.py install for blobuploader 03:46:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:46:42 INFO - Running setup.py install for requests 03:46:42 INFO - Running setup.py install for docopt 03:46:42 INFO - Successfully installed blobuploader requests docopt 03:46:42 INFO - Cleaning up... 03:46:42 INFO - Return code: 0 03:46:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:42 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')]} 03:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:42 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')]} 03:46:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 03:46:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 03:46:42 INFO - Using env: {'DISPLAY': ':0', 03:46:42 INFO - 'HOME': '/home/cltbld', 03:46:42 INFO - 'LANG': 'en_US.UTF-8', 03:46:42 INFO - 'LANGUAGE': 'en_US:en', 03:46:42 INFO - 'LOGNAME': 'cltbld', 03:46:42 INFO - 'MAIL': '/var/mail/cltbld', 03:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:42 INFO - 'MOZ_NO_REMOTE': '1', 03:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:42 INFO - 'NO_EM_RESTART': '1', 03:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:42 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:42 INFO - 'SHELL': '/bin/bash', 03:46:42 INFO - 'SHLVL': '1', 03:46:42 INFO - 'TERM': 'linux', 03:46:42 INFO - 'TMOUT': '86400', 03:46:42 INFO - 'USER': 'cltbld', 03:46:42 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:42 INFO - '_': '/tools/buildbot/bin/python'} 03:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:42 INFO - Running setup.py (path:/tmp/pip-OAAa_X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:42 INFO - Running setup.py (path:/tmp/pip-tzB5Eq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:43 INFO - Running setup.py (path:/tmp/pip-8wmrmw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:43 INFO - Running setup.py (path:/tmp/pip-LDrN87-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:43 INFO - Running setup.py (path:/tmp/pip-7VzDoN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:43 INFO - Running setup.py (path:/tmp/pip-6vZWfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:43 INFO - Running setup.py (path:/tmp/pip-MBh7ED-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:43 INFO - Running setup.py (path:/tmp/pip-bQAbSo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:43 INFO - Running setup.py (path:/tmp/pip-FGenOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:43 INFO - Running setup.py (path:/tmp/pip-1krOm8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:43 INFO - Running setup.py (path:/tmp/pip-ikswMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:43 INFO - Running setup.py (path:/tmp/pip-rtKDyy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:43 INFO - Running setup.py (path:/tmp/pip-J3rYj5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:43 INFO - Running setup.py (path:/tmp/pip-kueeFP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:43 INFO - Running setup.py (path:/tmp/pip-sSr57K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:43 INFO - Running setup.py (path:/tmp/pip-3vgFuC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:44 INFO - Running setup.py (path:/tmp/pip-09kuYU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:44 INFO - Running setup.py install for manifestparser 03:46:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Running setup.py install for mozcrash 03:46:44 INFO - Running setup.py install for mozdebug 03:46:44 INFO - Running setup.py install for mozdevice 03:46:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Running setup.py install for mozfile 03:46:44 INFO - Running setup.py install for mozhttpd 03:46:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Running setup.py install for mozinfo 03:46:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Running setup.py install for mozInstall 03:46:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:46:44 INFO - Running setup.py install for mozleak 03:46:44 INFO - Running setup.py install for mozlog 03:46:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Running setup.py install for moznetwork 03:46:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Running setup.py install for mozprocess 03:46:45 INFO - Running setup.py install for mozprofile 03:46:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Running setup.py install for mozrunner 03:46:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Running setup.py install for mozscreenshot 03:46:45 INFO - Running setup.py install for moztest 03:46:45 INFO - Running setup.py install for mozversion 03:46:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:46:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:45 INFO - Cleaning up... 03:46:45 INFO - Return code: 0 03:46:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:45 INFO - Using env: {'DISPLAY': ':0', 03:46:45 INFO - 'HOME': '/home/cltbld', 03:46:45 INFO - 'LANG': 'en_US.UTF-8', 03:46:45 INFO - 'LANGUAGE': 'en_US:en', 03:46:45 INFO - 'LOGNAME': 'cltbld', 03:46:45 INFO - 'MAIL': '/var/mail/cltbld', 03:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:45 INFO - 'MOZ_NO_REMOTE': '1', 03:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:45 INFO - 'NO_EM_RESTART': '1', 03:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:45 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:45 INFO - 'SHELL': '/bin/bash', 03:46:45 INFO - 'SHLVL': '1', 03:46:45 INFO - 'TERM': 'linux', 03:46:45 INFO - 'TMOUT': '86400', 03:46:45 INFO - 'USER': 'cltbld', 03:46:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:45 INFO - '_': '/tools/buildbot/bin/python'} 03:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:46 INFO - Running setup.py (path:/tmp/pip-A8JXWn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:46 INFO - Running setup.py (path:/tmp/pip-4172hh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:46 INFO - Running setup.py (path:/tmp/pip-TsXjBi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:46 INFO - Running setup.py (path:/tmp/pip-OMZgkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:46 INFO - Running setup.py (path:/tmp/pip-NOohBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:46 INFO - Running setup.py (path:/tmp/pip-3I0Ulj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:46 INFO - Running setup.py (path:/tmp/pip-WUw43U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:46 INFO - Running setup.py (path:/tmp/pip-7R0dJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:46 INFO - Running setup.py (path:/tmp/pip-bqomX0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:46 INFO - Running setup.py (path:/tmp/pip-rLi16h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:46 INFO - Running setup.py (path:/tmp/pip-r2UPpS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:46 INFO - Running setup.py (path:/tmp/pip-rrudIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:46 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)) 03:46:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:46 INFO - Running setup.py (path:/tmp/pip-rVYmJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:47 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)) 03:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:47 INFO - Running setup.py (path:/tmp/pip-CmD1NT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:47 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)) 03:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:47 INFO - Running setup.py (path:/tmp/pip-FGACF8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:47 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)) 03:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:47 INFO - Running setup.py (path:/tmp/pip-IgZ9l3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:47 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)) 03:46:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:47 INFO - Running setup.py (path:/tmp/pip-Rzlca8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:47 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)) 03:46:47 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)) 03:46:47 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)) 03:46:47 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)) 03:46:47 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)) 03:46:47 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)) 03:46:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:47 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 03:46:47 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 03:46:47 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 03:46:47 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 03:46:47 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 03:46:47 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 03:46:49 INFO - Downloading blessings-1.6.tar.gz 03:46:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:49 INFO - Installing collected packages: blessings 03:46:49 INFO - Running setup.py install for blessings 03:46:49 INFO - Successfully installed blessings 03:46:49 INFO - Cleaning up... 03:46:49 INFO - Return code: 0 03:46:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:46:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:49 INFO - Reading from file tmpfile_stdout 03:46:49 INFO - Current package versions: 03:46:49 INFO - argparse == 1.2.1 03:46:49 INFO - blessings == 1.6 03:46:49 INFO - blobuploader == 1.2.4 03:46:49 INFO - docopt == 0.6.1 03:46:49 INFO - manifestparser == 1.1 03:46:49 INFO - mozInstall == 1.12 03:46:49 INFO - mozcrash == 0.16 03:46:49 INFO - mozdebug == 0.1 03:46:49 INFO - mozdevice == 0.47 03:46:49 INFO - mozfile == 1.2 03:46:49 INFO - mozhttpd == 0.7 03:46:49 INFO - mozinfo == 0.9 03:46:49 INFO - mozleak == 0.1 03:46:49 INFO - mozlog == 3.1 03:46:49 INFO - moznetwork == 0.27 03:46:49 INFO - mozprocess == 0.22 03:46:49 INFO - mozprofile == 0.27 03:46:49 INFO - mozrunner == 6.11 03:46:49 INFO - mozscreenshot == 0.1 03:46:49 INFO - mozsystemmonitor == 0.0 03:46:49 INFO - moztest == 0.7 03:46:49 INFO - mozversion == 1.4 03:46:49 INFO - psutil == 3.1.1 03:46:49 INFO - requests == 1.2.3 03:46:49 INFO - wsgiref == 0.1.2 03:46:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:49 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')]} 03:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:49 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')]} 03:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:49 INFO - Using env: {'DISPLAY': ':0', 03:46:49 INFO - 'HOME': '/home/cltbld', 03:46:49 INFO - 'LANG': 'en_US.UTF-8', 03:46:49 INFO - 'LANGUAGE': 'en_US:en', 03:46:49 INFO - 'LOGNAME': 'cltbld', 03:46:49 INFO - 'MAIL': '/var/mail/cltbld', 03:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:49 INFO - 'MOZ_NO_REMOTE': '1', 03:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:49 INFO - 'NO_EM_RESTART': '1', 03:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:49 INFO - 'SHELL': '/bin/bash', 03:46:49 INFO - 'SHLVL': '1', 03:46:49 INFO - 'TERM': 'linux', 03:46:49 INFO - 'TMOUT': '86400', 03:46:49 INFO - 'USER': 'cltbld', 03:46:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:49 INFO - '_': '/tools/buildbot/bin/python'} 03:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 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)) 03:46:49 INFO - Cleaning up... 03:46:49 INFO - Return code: 0 03:46:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:46:49 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')]} 03:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:49 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')]} 03:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:49 INFO - Using env: {'DISPLAY': ':0', 03:46:49 INFO - 'HOME': '/home/cltbld', 03:46:49 INFO - 'LANG': 'en_US.UTF-8', 03:46:49 INFO - 'LANGUAGE': 'en_US:en', 03:46:49 INFO - 'LOGNAME': 'cltbld', 03:46:49 INFO - 'MAIL': '/var/mail/cltbld', 03:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:49 INFO - 'MOZ_NO_REMOTE': '1', 03:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:49 INFO - 'NO_EM_RESTART': '1', 03:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:49 INFO - 'SHELL': '/bin/bash', 03:46:49 INFO - 'SHLVL': '1', 03:46:49 INFO - 'TERM': 'linux', 03:46:49 INFO - 'TMOUT': '86400', 03:46:49 INFO - 'USER': 'cltbld', 03:46:49 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:49 INFO - '_': '/tools/buildbot/bin/python'} 03:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:49 INFO - Downloading/unpacking jsonschema 03:46:49 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 03:46:49 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 03:46:49 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 03:46:49 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 03:46:49 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 03:46:49 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 03:46:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:51 INFO - Downloading/unpacking functools32 (from jsonschema) 03:46:51 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 03:46:51 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 03:46:51 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 03:46:51 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 03:46:51 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 03:46:51 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 03:46:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:51 INFO - warning: no files found matching '*.txt' 03:46:51 INFO - no previously-included directories found matching 'build' 03:46:51 INFO - no previously-included directories found matching 'dist' 03:46:51 INFO - no previously-included directories found matching '.git*' 03:46:51 INFO - Installing collected packages: jsonschema, functools32 03:46:52 INFO - Running setup.py install for functools32 03:46:52 INFO - warning: no files found matching '*.txt' 03:46:52 INFO - no previously-included directories found matching 'build' 03:46:52 INFO - no previously-included directories found matching 'dist' 03:46:52 INFO - no previously-included directories found matching '.git*' 03:46:52 INFO - Successfully installed jsonschema functools32 03:46:52 INFO - Cleaning up... 03:46:52 INFO - Return code: 0 03:46:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:46:52 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')]} 03:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:52 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')]} 03:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f4716016f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf56600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', '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 03:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 03:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 03:46:52 INFO - Using env: {'DISPLAY': ':0', 03:46:52 INFO - 'HOME': '/home/cltbld', 03:46:52 INFO - 'LANG': 'en_US.UTF-8', 03:46:52 INFO - 'LANGUAGE': 'en_US:en', 03:46:52 INFO - 'LOGNAME': 'cltbld', 03:46:52 INFO - 'MAIL': '/var/mail/cltbld', 03:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:52 INFO - 'MOZ_NO_REMOTE': '1', 03:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:52 INFO - 'NO_EM_RESTART': '1', 03:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:52 INFO - 'SHELL': '/bin/bash', 03:46:52 INFO - 'SHLVL': '1', 03:46:52 INFO - 'TERM': 'linux', 03:46:52 INFO - 'TMOUT': '86400', 03:46:52 INFO - 'USER': 'cltbld', 03:46:52 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:52 INFO - '_': '/tools/buildbot/bin/python'} 03:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:52 INFO - Downloading/unpacking flake8 03:46:52 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 03:46:52 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 03:46:52 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 03:46:52 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 03:46:52 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 03:46:52 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 03:46:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:46:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:46:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 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 03:46:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:54 INFO - no previously-included directories found matching 'docs/_build' 03:46:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:54 INFO - Running setup.py install for pep8 03:46:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:54 INFO - no previously-included directories found matching 'docs/_build' 03:46:54 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:46:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:55 INFO - Cleaning up... 03:46:55 INFO - Return code: 0 03:46:55 INFO - Running post-action listener: _resource_record_post_action 03:46:55 INFO - Running post-action listener: _start_resource_monitoring 03:46:55 INFO - Starting resource monitoring. 03:46:55 INFO - ##### 03:46:55 INFO - ##### Running install step. 03:46:55 INFO - ##### 03:46:55 INFO - Running pre-action listener: _resource_record_pre_action 03:46:55 INFO - Running main action method: install 03:46:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:55 INFO - Reading from file tmpfile_stdout 03:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:46:55 INFO - Reading from file tmpfile_stdout 03:46:55 INFO - Output received: 03:46:55 INFO - Usage: mozinstall [options] installer 03:46:55 INFO - Options: 03:46:55 INFO - -h, --help show this help message and exit 03:46:55 INFO - -d DEST, --destination=DEST 03:46:55 INFO - Directory to install application into. [default: 03:46:55 INFO - "/builds/slave/test-pgo"] 03:46:55 INFO - --app=APP Application being installed. [default: firefox] 03:46:55 INFO - mkdir: /builds/slave/test-pgo/build/application 03:46:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:47:09 INFO - Reading from file tmpfile_stdout 03:47:09 INFO - Output received: 03:47:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:09 INFO - Running post-action listener: _resource_record_post_action 03:47:09 INFO - ##### 03:47:09 INFO - ##### Running run-tests step. 03:47:09 INFO - ##### 03:47:09 INFO - Running pre-action listener: _resource_record_pre_action 03:47:09 INFO - Running main action method: run_tests 03:47:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:09 INFO - Python 2.7.3 03:47:09 INFO - Return code: 0 03:47:09 INFO - grabbing minidump binary from tooltool 03:47:09 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')]} 03:47:09 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 0xfe5350>, '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 0xfe6250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfe66e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:09 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 03:47:09 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 03:47:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:09 INFO - Return code: 0 03:47:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:47:11 INFO - Return code: 0 03:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 03:47:11 INFO - Using env: {'DISPLAY': ':0', 03:47:11 INFO - 'HOME': '/home/cltbld', 03:47:11 INFO - 'LANG': 'en_US.UTF-8', 03:47:11 INFO - 'LANGUAGE': 'en_US:en', 03:47:11 INFO - 'LOGNAME': 'cltbld', 03:47:11 INFO - 'MAIL': '/var/mail/cltbld', 03:47:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:11 INFO - 'MOZ_NO_REMOTE': '1', 03:47:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:11 INFO - 'NO_EM_RESTART': '1', 03:47:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:11 INFO - 'SHELL': '/bin/bash', 03:47:11 INFO - 'SHLVL': '1', 03:47:11 INFO - 'TERM': 'linux', 03:47:11 INFO - 'TMOUT': '86400', 03:47:11 INFO - 'USER': 'cltbld', 03:47:11 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874', 03:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:11 INFO - '_': '/tools/buildbot/bin/python'} 03:47:11 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 03:47:11 INFO - mozversion INFO | application_buildid: 20160125001712 03:47:11 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:11 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:47:11 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:11 INFO - mozversion INFO | application_name: Firefox 03:47:11 INFO - mozversion INFO | application_remotingname: firefox-dev 03:47:11 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:11 INFO - mozversion INFO | application_vendor: Mozilla 03:47:11 INFO - mozversion INFO | application_version: 45.0a2 03:47:11 INFO - mozversion INFO | platform_buildid: 20160125001712 03:47:11 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:11 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:11 INFO - mozversion INFO | platform_version: 45.0a2 03:47:11 INFO - 2016-01-25 03:47:11,269 DEBUG : using testdate: 1453722431 03:47:11 INFO - 2016-01-25 03:47:11,269 DEBUG : actual date: 1453722431 03:47:11 INFO - 2016-01-25 03:47:11,279 INFO : starting webserver on 'localhost:54989' 03:47:11 INFO - 2016-01-25 03:47:11,280 INFO : Starting test suite talos-linux64-ix-055 03:47:11 INFO - 2016-01-25 03:47:11,280 INFO : Starting test dromaeo_css 03:47:11 INFO - 2016-01-25 03:47:11,280 DEBUG : operating with platform_type : linux_ 03:47:11 INFO - 2016-01-25 03:47:11,280 INFO : Initialising browser for dromaeo_css test... 03:47:11 INFO - 2016-01-25 03:47:11,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi69Ley/profile http://localhost:54989/getInfo.html 03:47:15 INFO - 2016-01-25 03:47:15,233 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:15 INFO - 2016-01-25 03:47:15,233 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:15 INFO - 2016-01-25 03:47:15,233 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:15 INFO - 2016-01-25 03:47:15,234 DEBUG : BROWSER_OUTPUT: __metrics 03:47:15 INFO - 2016-01-25 03:47:15,370 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:16 INFO - 2016-01-25 03:47:16,115 INFO : Browser initialized. 03:47:16 INFO - 2016-01-25 03:47:16,115 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:16 INFO - 2016-01-25 03:47:16,116 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpi69Ley/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:27 INFO - 2016-01-25 03:47:27,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 137453568 03:47:27 INFO - 2016-01-25 03:47:27,923 DEBUG : BROWSER_OUTPUT: 03:48:18 INFO - 2016-01-25 03:48:18,994 DEBUG : BROWSER_OUTPUT: 1453722498992 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] 03:50:27 INFO - 2016-01-25 03:50:27,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54989/tests/dromaeo/cssquery-ext.html) 03:50:28 INFO - 2016-01-25 03:50:28,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 223137792 03:50:28 INFO - 2016-01-25 03:50:28,435 DEBUG : BROWSER_OUTPUT: 03:53:30 INFO - 2016-01-25 03:53:30,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-ext.html (next: http://localhost:54989/tests/dromaeo/cssquery-jquery.html) 03:53:31 INFO - 2016-01-25 03:53:31,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 218341376 03:53:31 INFO - 2016-01-25 03:53:31,191 DEBUG : BROWSER_OUTPUT: 03:56:33 INFO - 2016-01-25 03:56:33,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54989/tests/dromaeo/cssquery-mootools.html) 03:56:33 INFO - 2016-01-25 03:56:33,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 216031232 03:56:33 INFO - 2016-01-25 03:56:33,584 DEBUG : BROWSER_OUTPUT: 03:59:35 INFO - 2016-01-25 03:59:35,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54989/tests/dromaeo/cssquery-prototype.html) 03:59:35 INFO - 2016-01-25 03:59:35,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 206217216 03:59:35 INFO - 2016-01-25 03:59:35,938 DEBUG : BROWSER_OUTPUT: 04:02:38 INFO - 2016-01-25 04:02:38,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54989/tests/dromaeo/cssquery-yui.html) 04:02:38 INFO - 2016-01-25 04:02:38,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 205676544 04:02:38 INFO - 2016-01-25 04:02:38,918 DEBUG : BROWSER_OUTPUT: 04:05:40 INFO - 2016-01-25 04:05:40,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/dromaeo/cssquery-yui.html (next: http://localhost:54989/tests/dromaeo/cssquery-dojo.html) 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 239280128 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:41 INFO - 2016-01-25 04:05:41,198 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:41 INFO - 2016-01-25 04:05:41,199 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3309.387763263795;3335.8498867550957;3341.4820702791076;3343.2143446290133;3357.21105540198;5510.614257002011;5593.105103183491;5608.270924779783;5613.101903695405;5613.859653508659;5525.281713377255;5597.524210442118;5624.803131890385;5625.465580769831;5634.3802181759975;4965.180745177042;5056.544910958013;5082.440931497532;5117.7185254810975;5174.611904107188;5019.874503137415;5061;5067.113255180348;5067.214581739836;5074.391073071237;4952.108620448318;5010.148274793294;5052.292679024939;5058.519440653132;5062.215356619729;5032.169692000815;5106.591472682177;5108.770105345268;5110.310108135392;5112.616553758465;4911;5000.149974504343;5014.097462456756;5018.723970181639;5126.307948426952;5268.736563171864;5273.050850846846;5349.893002139936;5373.838784836461;5392.973035134838;5928.911066334009;5966.910496342558;5969.074793407029;5974.97012514939;5997.760089596454;5906.350301466835;5990.550708696822;5993.310769261547;5993.4006599340155;5994.07091900756;5415.566754659618;5418.4039755626845;5506.587005974568;5558.861028474321;5568.248286481355;5985.281766188085;6169.537284703665;6192.783252586138;6194.81415557534;6197.907031394533;5680;5967.283925928917;5993.370696076936;5994.760209591567;5995.550333724988;5826.213461182686;5888.234529511136;5970.313413957364;5973.044312909914;5998.340182579913;5864.941350586525;5980.85047873798;5993.910091348634;6020.4280593343565;6022.69886505673;5727.627704199213;5772.220750198753;6009.969950150221;6018.428249316308;6031.547633927473;4515.300128480091;4574.336721175411;4574.771261436915;4593.081383723202;4603.9079218415445;4097.713160078766;4120.381942708557;4120.958790412117;4128.277551428488;4156.7921603919685;5282.2340760589495;5417.295751552273;5501.862453438616;5696.287964004499;5701.173329867146;6010.879782404328;6027.126066720389;6028.216331876828;6064.482600091936;6102.237220347457;5656.123300888369;5662.320521537442;5663.433656634386;5664.376918538957;5671.432856714378;5005.474425185376;5116.923246151311;5165.66423182492;5215.348081489814;5217;6112.397599661398;6236.501079913596;6237.656928868956;6241.968790156111;6243.625382477066;6063.211782468251;6075.544334174866;6077;6078.270607527125;6081.908771368521;5942.554308426799;6016.067509536029;6046.455818976313;6143.972489078683;6149.292831324455;5938.257717785277;5995.070764031582;5996.160537524663;5996.730147143302;6021.277446706424;6043.456088952015;6063.393660634078;6066.18106555627;6068.605540639845;6073.665948372882;5671.092625179951;5782.219400381063;5796.478316951495;5870.823875283749;5890.9396308664855;5843.094320380348;5848.181254624441;5851.268591426072;5865.061590145556;5938.406159384027;5531.308586426697;5740.569457290637;5746.482816546531;5748.655080695172;5760.135979603093;5664.716764161693;5794.594378393641;5856.648601083949;5861.882762344644;5897.675627840338;5778.653280803165;5780.104083867007;5780.132980052857;5783.797567085132;5815.5929084963645 04:05:41 INFO - 2016-01-25 04:05:41,200 DEBUG : BROWSER_OUTPUT: |1;ext.html;617.1329282358288;618.6844709198309;633.3381616211059;633.9033472093279;636.6530241018644;31925;40546.18907621849;40723.389149162715;40956;41033.384499232496;46193.30710039352;46668;46676;46694;46826.53173468264;8088.878666820003;8184.754457366289;8923.821523569524;9078.500682462462;9102.544872756336;10756.892431075667;10996.780064398747;11017.779644407146;11019.614313499029;11032.062274706619;10716.142708583333;10823;10833.83749243762;10846.18653600979;10855.565777368896;8302.875456868182;8451.619677114482;8492.193241642035;10649.893501065006;10819.945900270526;10499.947500262526;10665.9466702666;10667.893321066767;10670.466476676213;10673.466326683712;41934.58065419337;42590.57409425897;42601.573984260074;42606;42627.147457050996;3537;3557.5375201223674;3595.0473124621994;3928.921421571581;4301.935470967938;30615.540766888513;30960;31071.378572428424;31136.221594460094;31696.366072678647;3893.610638936112;3997.120633460634;4052.0882801369457;4063.634272915422;4102.5692302308125;287477;288122;288696;289392;289602;55356.44643553594;56359.43640563542;61993;68783;69977.3002269981;62455.37544624587;62505.374946250864;62583;62715.372846271865;62788.68605657034;16394.83605163957;16494.505164845075;16502.917485412738;16556;16663.6667266654;11986;12005.279683219034;12019.819702704466;12023.21849079807;12137.635870923887;20533.254673352632;20830.687539686918;20852.1659133636;20946.371608851758;20950.685739713917;7879.251471110236;7952.960235198787;8010.519368837889;8044.959775201203;8155.184481551797;1095.2552264460085;1098.132475344469;1136.5510623303749;1205.5900993662196;1227.756856385273;28409.71590284112;29060;29778.10665680033;29888;30081.097567073022;1069.0752499088233;1097.8792332843382;1144.347721798567;1183.8342632031522;1230.5939040116739;13225.73548529024;13440.932795336157;14078.929605351908;15554.844451555566;15934.60163495922;260158;263817;263933;264093;264172;53622.46377536175;54798.178027329624;54853.177202342;54877.72561137169;54926.17610735842;1457.1766951672482;1459.0953608762636;1469.8383177850428;1474.3807600807686;1474.4544518528214;25922;28615.14154575366;28858.134255972356;29085.418291634473;29254.41491170122;52363.47636523586;53067;53137.7343113282;53176.46823531715;53189.7340513295;206191;208206;209878;210144;210738;30191.09426717202;30243;30739.385212295183;33773.15567110842;33889;39871.2025759489;40293.39559906545;40404.3939340916;41053.589464106175;41281.380779288935;34009.31981360309;34702.65297346994;34919.301613968084;35317.82341088278;36701.81649091737;32694.34611307808;36989.63010369862;37146.8142659285;37307.81346093252;38891.41662875003;34746.30507389889;35097.47353789644;36358.454623181206;36871;36989.630103699696;31838.681613183573;32577.34845303128;33491.33017339591;33636.831815840764;33774.80463769847;25308.873455632605;25509.23472295834;25621.615675764504;25779.331709673756;25989.6101558473 04:05:41 INFO - 2016-01-25 04:05:41,204 DEBUG : BROWSER_OUTPUT: |2;jquery.html;378.87686501886895;378.93179227738995;383.97504162229455;385.75119048213884;389.6201203826269;18109.818901810977;18990.240390384402;20074;20103.19587216513;20155.39533813986;14954.252287385641;15305.617359566017;17263.48209553712;18231.817681823177;18407.07964601768;5046.798128074873;5056.949430505703;5059.11465493539;5217.5565076968505;5250.238715386266;5458.372287186965;5494.313210848644;5495.917561236584;5500.1749737539285;5502.119660854264;4197.496300443951;4291.914161716763;5836.533077353802;5988.341282458926;5989.970050149765;5817.7382017809305;5924.37794031627;5937.643741375509;5941.465268125889;5966.134910437984;5392.56859451243;5405.216243644689;5415.972920135374;5417.729113544307;5422.2951016368015;21027.894860525754;21074.78925210759;21220;21382.57234855294;21941.561168776694;2374.726906405768;2547.503236868811;2554.3741783263217;2581.586946088617;2767.5848622706553;14204.644883877985;14304;14395.064320819114;14403.351849166813;14775.335109919972;1788.2668106076446;1936.9612607747906;1945.2802463088606;1976.071246514136;1989.9701504477443;64203.35796642067;66540;66645;66770;67084.66457667729;10493;10704.30422022566;10915.39965301916;10918.454077296103;10996.12031037515;14199.71600567983;14213.857861421253;14289.142651440947;14295.213763243122;14318.14091154534;7946.404019698546;7989.7203597873795;8005;8227.876581851157;8309.335253179732;7613.619319034026;7620.9618951905995;7683.078030636248;7689.50018248812;7724.266194711493;6376.776812811529;6412.67936603168;6424.38968298011;6470.547061705635;6489.545731798823;1722.8277172282671;1884.877482963603;1894.7631546056743;1916.5687720263109;1917.0606402862497;889.5818965086399;898.0525545549508;964.2430691906819;990.8810942686923;1093.8632670916136;16400.917995410186;16940.07498065984;16947.898386605077;18191.727124093148;18205.27178912855;891.5007595746403;987.9851802222972;988.9802203956025;998.9500524973722;1021.0504231065032;9199.862002069975;9899.109080182818;10147.7463063424;10246.692599222035;10361.533730982124;620752;627429;632808;641003;642483;75039.87440188402;75781;76060;77896;79431;1187.034995182319;1189.756099999498;1195.8923696867323;1198.269055875915;1200.507791805373;15592.844071559593;15728.449504267295;15804.920975395049;15933.36266549325;16043.358265669243;34330.48504272488;34998.47502287519;35209.47185792164;35818.64181358153;36458;47332;48312;49338;49546;50011.49988500214;9659.46872921968;9987.950060249652;10470.94764526203;10507.369557826554;10520.473976301308;11200.887991119984;11284.266522676;11314.434278286217;12184;17248.568785780455;14581.270936453348;14705.485308014167;14909.254537272876;15094.622634434227;15352.616184595474;14075.296235187994;14665.367608483764;14867.107973521623;14887.776683349975;15077.246137692851;14577;15265.313060912064;16156.626686731759;16522.58693532671;16544.090075045988;8469.237768600855;9587.424754514752;9865.161461275586;10163.593456261962;10290.073893349634;10881.891181088404;14611.780823287872;14696.55910322692;14857.851421485646;14926.328315225624 04:05:41 INFO - 2016-01-25 04:05:41,205 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1621.9756703649455;1768.8761786674931;1812.2298023340077;1822.1133340607246;1840.190316260845;6441.355864413556;6810;7267.781966541005;7543.170251272356;7563.92436075639;7477.289657482531;7488.550686958786;7540.283673051065;7571.205023472538;7578.734744283951;1956.2761778142108;1983.4446355020618;2229.3646310801423;2264.445210923326;2266.9206577769783;2245.7080579524722;2255.650374192003;2267.2291420916886;2270.012544543129;2271.2618399020303;2113.028007116728;2137.957240855182;2158.2554018863543;2162.286445472998;2164.199246278871;2154.795294447025;2162.167565487283;2206.7572567017614;2230.3643461613524;2232.2745107839937;2230.4535388829677;2235.1059576169664;2257;2262.558801033799;2264.184893438361;7495.925040749577;7544.924550754477;7566.356859666935;7566.470347075707;7567.243275672388;4490.977545112253;4552.4764652065105;4586.4266966629175;4595.195840727859;4619.214733495314;2881.423715256957;2975.9851200744074;2996.2509372656837;3012.29211135383;3021.22958645544;947.4599478297373;961.4904100826503;995.875515560555;1010.9241806864441;1014.8782146142437;10141.2394070445;10211.183105351554;10222.846657300071;10227.590896364136;10234.02776736209;4021.678265738734;4047;4093.8362465501045;4095.9385609215888;4099.590040995877;8698.34762392823;8731.51976641278;8741.169588889044;8756.824863502694;8814.603342849587;4603.17142914272;4610.677252592353;4620.884477888079;4654.185517534418;4656.883577910579;4178.874633760992;4267.445232119804;4269.935950960738;4269.957300427018;4277.379779931893;3209.293955329824;3301.3067255876053;3317.1209629448217;3633.073566240592;3733.178700685845;1128.2948157401624;1159.4666453431516;1167.6963989362828;1178.1811640909486;1186.9821952670716;999.3504222255592;1002.1631937332263;1086.8641419822522;1090.2368342160519;1132.003836623766;6925.826854328682;6956.686949087303;6969.47728920333;7035.683394247271;7044.647767611701;1098.7637657903429;1108.9001989820954;1119.3843386137592;1123.7640095579857;1131.9603813866474;5506.174073888948;5556.666600003932;5556.749946252428;5557.3886872444;5569.192467092249;8611.6985905493;8978.281737460988;8981.191692747683;8994.86507702385;9052.909470905206;8906.287497000225;8952.955235223912;9002.099790020946;9012.549372531346;9024.503652299187;7093.432525398059;7124.46566507514;7262.455315851333;7289.817754556072;7294.307040831112;6797.9320206799275;6830.385265326145;6845.041694162921;6853.211880633791;6855.211650660238;7985.560794156378;7987.440879138405;7991.92008079935;8015.158408367271;8161.836763264582;8162.347012239125;8182.509049456814;8333.291670207858;8390.119037500974;8395.370347224105;6535.477161827138;6556.3443655634055;6614.272430032596;6640.966795165993;6641.933580664325;6348.841278968062;6416.32628573993;6799.524033317621;6924.826879328057;7174.641267936687;6695.330466953265;6722.9663851680425;6748.561343512656;6811.829704257433;6832.726690932307;6670.066190733204;6709.630970296485;6750.932490675031;6758.898616520658;6832.692528836314;6862.519623626498;6880.862382752417;6884.795160846732;6885.655717214219;6892.965535172292;5992.700364981821;6164.660943648142;6181.35095814933;6196.1635179252025;6201.441870231701;6318.368163183829;6358.650274234961;6403.07155462446;6413.518986076157;6416.871662566629 04:05:41 INFO - 2016-01-25 04:05:41,206 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.089198272681;337.57634169117756;342.71897044423577;344.34574308813234;347.5568649971286;6168.969155154224;6186.969065154673;6200.410960958713;6274.121622972787;6302.716377762995;5865.970670146654;5969.761209551612;6064.9696751516185;6109.053096770008;6139.447449729523;4667.019925815566;4705.3177289293035;4706.576408123268;4710.788014539346;4714;4514.864554063383;4721.622270218391;4727.1727447696685;4731.503192164825;4736.171170045245;4547.408836851221;4560.315952607102;4692.085043416535;4696.483386827464;4699.553542413482;4669.439667239919;4680.5085466026085;4681.204195286809;4687.203175460146;4689.788959496831;4135.813888375031;4136.482939632546;4142.2958097123565;4143.4199212110325;4149.2531344358;5697.230873832063;5770.509506691937;5820.068788993783;5821.79623713168;5825.38833422493;5384.030874442598;5384.219288203189;5388.084025715599;5395.10980688186;5398.379186393576;6512.967435162841;6538.313477084933;6546.672666366662;6546.770863019819;6559.901601475982;4421.624161946238;4426;4430.645548356124;4431.756253406062;4434.046679963791;6674.16572928384;6698.8995165072565;6787.72849086036;6790.5925644461495;6793.626350550718;4537.4328208973875;4538.1377538267625;4538.228501154812;4539.546045395434;4542.068875880436;4581.954180458153;4584.060267645124;4586.931196032062;4588.151192029419;4589.013362127159;5366.570674346043;5367.060764366221;5370.113931201308;5377.946220537823;5378.1932710093015;6453.128827608307;6590.143281373391;6601.76893808724;6608.2730899601;6612.570182938093;1595.5771720494079;1617.8543931046027;1617.9191040448165;1618.449727092794;1618.6034421566792;1077.5797438998798;1079.3254216114929;1086.559943222996;1093.3822390349428;1108.1854836695022;6349.857025735319;6353.4599559038;6365.968170159213;6371.585846920028;6374.107624932513;6618.371254730889;6786.219584747817;6792.830179245559;6800.863982720318;6807.115075040213;6269.686515674198;6304.873902521924;6413.422791948747;6415.069814876817;6422.8715425691225;3649.8905032849057;3693.1136527233807;3694.07648087978;3697.9815100924325;3699.667029967316;6850.965745171342;7018.824529386704;7027.5080744348425;7039.612821294775;7044.15470143586;7057;7067.293270672994;7070.787876363717;7070.92929070713;7074.823129421806;7034.120734908137;7059.976303436076;7061.717531298793;7065.2228254891925;7067.82330441743;6672.466202703675;6847.486438517031;6876.862462750617;6887.380135787803;6895.758648447481;6809.250982392032;6816.897746533707;6817.284185160685;6821.727130914708;6829.795106146824;7054.541454805421;7062.682179301841;7066.681999309941;7068.434525237866;7070.540414873017;4446.42196514451;4456.5766252205985;4457.732536047847;4464.285714285698;4581.679282450196;6801.489888258301;6818.795436136924;6825.044493770777;6826.488013398915;6828.931710682829;6627.701753421204;6632.767853125118;6633.502487313374;6638.5684930479365;6643.7674681385915;6494.967525162533;6601.141851559267;6628.038934354588;6629.270780214269;6629.569078009914;6431.292557818542;6509.088727578238;6511.609303441809;6514.315996820455;6531.673416329069;6621.238557565749;6630.071789949315;6631.701573429304;6632.270450250565;6634.203895532374;6330.556861019684;6379.7129129190225;6482.513811464253;6485.610863348025;6498.155239818793 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: |5;yui.html;794.4994653368377;811.963461644226;816.5672193737319;823.8146417056163;911.9407238529493;13608.523701670443;16224.675506489863;16525.504234872944;16531.173441327945;16568.171591420425;14491.130532168077;14519.637009074779;14536.927315363408;14552.417903283857;14621.342039608217;748.0462410426695;753.8906858505513;874.6501399440211;889.1952782731638;904.5160838951163;903.1059251341158;906.075802681268;907.2152588011388;909.1681111782744;911.6080085563239;773.6441237030973;913.7532866126176;920.0339643374464;923.0630909626734;924.9213816825544;778.8286576953061;921.889373275208;924.8474001789697;935.5556110847361;938.1509733690987;685.7394190207739;691.0187533702154;691.1878542712343;693.2062788107639;694.8124006518211;13773.724525509533;13808.447662093504;13812.861871381258;13820.170789752547;13856.168629882239;12566.497340106385;12649.177803442746;12817.87182128176;12911.612651620466;13034.21794692312;10935.271816632427;10960.506777194965;11059.889401105966;11320.377379244139;11366.772664546745;3726.217494326195;3795.9430608540893;3846.807659617008;3851.422286657024;3852.711046671483;49489.50510494885;49977;50236.497635023545;50853;51169;9841;9867.901320986699;9878.407295562289;10032.79934401308;10070.446125463024;16540.6691866162;16556.917215414087;16562.83437165637;16564.585885352964;16582.336706531605;8762.079981601968;8831.470111793313;8835.20483156519;8851.955740221258;9134.086591340812;4782.163121453732;4879.487653796371;4895.485973972753;4922.261660750844;4942.5304596063315;3128.9374212515622;3164.1298642873394;3172.0800967719565;3173.841307934594;3174.4920812670325;559.6222549778882;579.9768009279582;580.2862479150668;580.9215755872988;588.1266319515516;686.7562015484531;691.2120182991393;715.445529714465;723.8660847743184;744.3486948919696;9068.637254509878;9624.085711857362;9801.509924503745;9827.901720982698;9835.704928852147;701.680735265453;713.7644577289586;719.481972979454;739.2792027772986;744.2297222374816;4158.147579746144;4266.530681625019;4280.101178752497;4335.3713711511655;4353.064091220403;57599.42400575941;57916.420835791105;58590.70704646449;58780.70609646924;58806.11790823141;51455.74272128615;52491.21263181055;52610.473895260555;52759.472405276225;53216.20175697368;47983.28025079626;48252.5174748255;48335.516644833806;48768;49050;8608.61261243258;8746.781330466789;8772.649094036167;8841.911580884365;8959.118585096941;35404.11489712675;35688.28623427465;35814;36315.27369452649;36590.26819463543;42765.35851962161;46484.69892397902;46689.76655116703;46852;46889.53110468852;10549.050585447347;10888.237823352607;10926.508307126358;10997.395143267197;11403.942980285046;12201.32892690875;12277.386130693609;12408.497415518752;12586.622401327975;12590.24458532491;10657.626983055556;10822.350658960488;10824.5128969195;10831;11152.498137583665;11128.165387596124;11171.273867198606;11211.047060999907;11317.71705707364;11474.082073433938;9027.684031058881;10351.275410721177;11547.422628868691;11714.76570468603;11826.940865295619;10255.58977640886;10275.486225688535;10330.845037324296;10387.584496620051;10389.9480502597;10124.746881328027;10152.984701529787;10190;10268.281220314506;10457.738556536147 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,682 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:41 INFO - 2016-01-25 04:05:41,210 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723541196__endTimestamp 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5542.85 Median:5748.66 stddev:624.56 (10.9%) stddev-sans-first:601.39 04:05:41 INFO - 2016-01-25 04:05:41,211 DEBUG : BROWSER_OUTPUT: Values: 3309.4 3335.8 3341.5 3343.2 3357.2 5510.6 5593.1 5608.3 5613.1 5613.9 5525.3 5597.5 5624.8 5625.5 5634.4 4965.2 5056.5 5082.4 5117.7 5174.6 5019.9 5061.0 5067.1 5067.2 5074.4 4952.1 5010.1 5052.3 5058.5 5062.2 5032.2 5106.6 5108.8 5110.3 5112.6 4911.0 5000.1 5014.1 5018.7 5126.3 5268.7 5273.1 5349.9 5373.8 5393.0 5928.9 5966.9 5969.1 5975.0 5997.8 5906.4 5990.6 5993.3 5993.4 5994.1 5415.6 5418.4 5506.6 5558.9 5568.2 5985.3 6169.5 6192.8 6194.8 6197.9 5680.0 5967.3 5993.4 5994.8 5995.6 5826.2 5888.2 5970.3 5973.0 5998.3 5864.9 5980.9 5993.9 6020.4 6022.7 5727.6 5772.2 6010.0 6018.4 6031.5 4515.3 4574.3 4574.8 4593.1 4603.9 4097.7 4120.4 4121.0 4128.3 4156.8 5282.2 5417.3 5501.9 5696.3 5701.2 6010.9 6027.1 6028.2 6064.5 6102.2 5656.1 5662.3 5663.4 5664.4 5671.4 5005.5 5116.9 5165.7 5215.3 5217.0 6112.4 6236.5 6237.7 6242.0 6243.6 6063.2 6075.5 6077.0 6078.3 6081.9 5942.6 6016.1 6046.5 6144.0 6149.3 5938.3 5995.1 5996.2 5996.7 6021.3 6043.5 6063.4 6066.2 6068.6 6073.7 5671.1 5782.2 5796.5 5870.8 5890.9 5843.1 5848.2 5851.3 5865.1 5938.4 5531.3 5740.6 5746.5 5748.7 5760.1 5664.7 5794.6 5856.6 5861.9 5897.7 5778.7 5780.1 5780.1 5783.8 5815.6 04:05:41 INFO - 2016-01-25 04:05:41,212 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,212 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43997.40 Median:31881.84 stddev:66516.83 (208.6%) stddev-sans-first:66623.68 04:05:41 INFO - 2016-01-25 04:05:41,212 DEBUG : BROWSER_OUTPUT: Values: 617.1 618.7 633.3 633.9 636.7 31925.0 40546.2 40723.4 40956.0 41033.4 46193.3 46668.0 46676.0 46694.0 46826.5 8088.9 8184.8 8923.8 9078.5 9102.5 10756.9 10996.8 11017.8 11019.6 11032.1 10716.1 10823.0 10833.8 10846.2 10855.6 8302.9 8451.6 8492.2 10649.9 10819.9 10499.9 10665.9 10667.9 10670.5 10673.5 41934.6 42590.6 42601.6 42606.0 42627.1 3537.0 3557.5 3595.0 3928.9 4301.9 30615.5 30960.0 31071.4 31136.2 31696.4 3893.6 3997.1 4052.1 4063.6 4102.6 287477.0 288122.0 288696.0 289392.0 289602.0 55356.4 56359.4 61993.0 68783.0 69977.3 62455.4 62505.4 62583.0 62715.4 62788.7 16394.8 16494.5 16502.9 16556.0 16663.7 11986.0 12005.3 12019.8 12023.2 12137.6 20533.3 20830.7 20852.2 20946.4 20950.7 7879.3 7953.0 8010.5 8045.0 8155.2 1095.3 1098.1 1136.6 1205.6 1227.8 28409.7 29060.0 29778.1 29888.0 30081.1 1069.1 1097.9 1144.3 1183.8 1230.6 13225.7 13440.9 14078.9 15554.8 15934.6 260158.0 263817.0 263933.0 264093.0 264172.0 53622.5 54798.2 54853.2 54877.7 54926.2 1457.2 1459.1 1469.8 1474.4 1474.5 25922.0 28615.1 28858.1 29085.4 29254.4 52363.5 53067.0 53137.7 53176.5 53189.7 206191.0 208206.0 209878.0 210144.0 210738.0 30191.1 30243.0 30739.4 33773.2 33889.0 39871.2 40293.4 40404.4 41053.6 41281.4 34009.3 34702.7 34919.3 35317.8 36701.8 32694.3 36989.6 37146.8 37307.8 38891.4 34746.3 35097.5 36358.5 36871.0 36989.6 31838.7 32577.3 33491.3 33636.8 33774.8 25308.9 25509.2 25621.6 25779.3 25989.6 04:05:41 INFO - 2016-01-25 04:05:41,212 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,212 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31994.58 Median:2461.12 stddev:103243.15 (4195.0%) stddev-sans-first:103505.47 04:05:41 INFO - 2016-01-25 04:05:41,213 DEBUG : BROWSER_OUTPUT: Values: 378.9 378.9 384.0 385.8 389.6 18109.8 18990.2 20074.0 20103.2 20155.4 14954.3 15305.6 17263.5 18231.8 18407.1 5046.8 5056.9 5059.1 5217.6 5250.2 5458.4 5494.3 5495.9 5500.2 5502.1 4197.5 4291.9 5836.5 5988.3 5990.0 5817.7 5924.4 5937.6 5941.5 5966.1 5392.6 5405.2 5416.0 5417.7 5422.3 21027.9 21074.8 21220.0 21382.6 21941.6 2374.7 2547.5 2554.4 2581.6 2767.6 14204.6 14304.0 14395.1 14403.4 14775.3 1788.3 1937.0 1945.3 1976.1 1990.0 64203.4 66540.0 66645.0 66770.0 67084.7 10493.0 10704.3 10915.4 10918.5 10996.1 14199.7 14213.9 14289.1 14295.2 14318.1 7946.4 7989.7 8005.0 8227.9 8309.3 7613.6 7621.0 7683.1 7689.5 7724.3 6376.8 6412.7 6424.4 6470.5 6489.5 1722.8 1884.9 1894.8 1916.6 1917.1 889.6 898.1 964.2 990.9 1093.9 16400.9 16940.1 16947.9 18191.7 18205.3 891.5 988.0 989.0 999.0 1021.1 9199.9 9899.1 10147.7 10246.7 10361.5 620752.0 627429.0 632808.0 641003.0 642483.0 75039.9 75781.0 76060.0 77896.0 79431.0 1187.0 1189.8 1195.9 1198.3 1200.5 15592.8 15728.4 15804.9 15933.4 16043.4 34330.5 34998.5 35209.5 35818.6 36458.0 47332.0 48312.0 49338.0 49546.0 50011.5 9659.5 9988.0 10470.9 10507.4 10520.5 11200.9 11284.3 11314.4 12184.0 17248.6 14581.3 14705.5 14909.3 15094.6 15352.6 14075.3 14665.4 14867.1 14887.8 15077.2 14577.0 15265.3 16156.6 16522.6 16544.1 8469.2 9587.4 9865.2 10163.6 10290.1 10881.9 14611.8 14696.6 14857.9 14926.3 04:05:41 INFO - 2016-01-25 04:05:41,213 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,213 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5257.08 Median:6259.91 stddev:2685.64 (42.9%) stddev-sans-first:2679.27 04:05:41 INFO - 2016-01-25 04:05:41,214 DEBUG : BROWSER_OUTPUT: Values: 1622.0 1768.9 1812.2 1822.1 1840.2 6441.4 6810.0 7267.8 7543.2 7563.9 7477.3 7488.6 7540.3 7571.2 7578.7 1956.3 1983.4 2229.4 2264.4 2266.9 2245.7 2255.7 2267.2 2270.0 2271.3 2113.0 2138.0 2158.3 2162.3 2164.2 2154.8 2162.2 2206.8 2230.4 2232.3 2230.5 2235.1 2257.0 2262.6 2264.2 7495.9 7544.9 7566.4 7566.5 7567.2 4491.0 4552.5 4586.4 4595.2 4619.2 2881.4 2976.0 2996.3 3012.3 3021.2 947.5 961.5 995.9 1010.9 1014.9 10141.2 10211.2 10222.8 10227.6 10234.0 4021.7 4047.0 4093.8 4095.9 4099.6 8698.3 8731.5 8741.2 8756.8 8814.6 4603.2 4610.7 4620.9 4654.2 4656.9 4178.9 4267.4 4269.9 4270.0 4277.4 3209.3 3301.3 3317.1 3633.1 3733.2 1128.3 1159.5 1167.7 1178.2 1187.0 999.4 1002.2 1086.9 1090.2 1132.0 6925.8 6956.7 6969.5 7035.7 7044.6 1098.8 1108.9 1119.4 1123.8 1132.0 5506.2 5556.7 5556.7 5557.4 5569.2 8611.7 8978.3 8981.2 8994.9 9052.9 8906.3 8953.0 9002.1 9012.5 9024.5 7093.4 7124.5 7262.5 7289.8 7294.3 6797.9 6830.4 6845.0 6853.2 6855.2 7985.6 7987.4 7991.9 8015.2 8161.8 8162.3 8182.5 8333.3 8390.1 8395.4 6535.5 6556.3 6614.3 6641.0 6641.9 6348.8 6416.3 6799.5 6924.8 7174.6 6695.3 6723.0 6748.6 6811.8 6832.7 6670.1 6709.6 6750.9 6758.9 6832.7 6862.5 6880.9 6884.8 6885.7 6893.0 5992.7 6164.7 6181.4 6196.2 6201.4 6318.4 6358.7 6403.1 6413.5 6416.9 04:05:41 INFO - 2016-01-25 04:05:41,214 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,214 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5478.67 Median:6303.80 stddev:1682.05 (26.7%) stddev-sans-first:1641.89 04:05:41 INFO - 2016-01-25 04:05:41,214 DEBUG : BROWSER_OUTPUT: Values: 336.1 337.6 342.7 344.3 347.6 6169.0 6187.0 6200.4 6274.1 6302.7 5866.0 5969.8 6065.0 6109.1 6139.4 4667.0 4705.3 4706.6 4710.8 4714.0 4514.9 4721.6 4727.2 4731.5 4736.2 4547.4 4560.3 4692.1 4696.5 4699.6 4669.4 4680.5 4681.2 4687.2 4689.8 4135.8 4136.5 4142.3 4143.4 4149.3 5697.2 5770.5 5820.1 5821.8 5825.4 5384.0 5384.2 5388.1 5395.1 5398.4 6513.0 6538.3 6546.7 6546.8 6559.9 4421.6 4426.0 4430.6 4431.8 4434.0 6674.2 6698.9 6787.7 6790.6 6793.6 4537.4 4538.1 4538.2 4539.5 4542.1 4582.0 4584.1 4586.9 4588.2 4589.0 5366.6 5367.1 5370.1 5377.9 5378.2 6453.1 6590.1 6601.8 6608.3 6612.6 1595.6 1617.9 1617.9 1618.4 1618.6 1077.6 1079.3 1086.6 1093.4 1108.2 6349.9 6353.5 6366.0 6371.6 6374.1 6618.4 6786.2 6792.8 6800.9 6807.1 6269.7 6304.9 6413.4 6415.1 6422.9 3649.9 3693.1 3694.1 3698.0 3699.7 6851.0 7018.8 7027.5 7039.6 7044.2 7057.0 7067.3 7070.8 7070.9 7074.8 7034.1 7060.0 7061.7 7065.2 7067.8 6672.5 6847.5 6876.9 6887.4 6895.8 6809.3 6816.9 6817.3 6821.7 6829.8 7054.5 7062.7 7066.7 7068.4 7070.5 4446.4 4456.6 4457.7 4464.3 4581.7 6801.5 6818.8 6825.0 6826.5 6828.9 6627.7 6632.8 6633.5 6638.6 6643.8 6495.0 6601.1 6628.0 6629.3 6629.6 6431.3 6509.1 6511.6 6514.3 6531.7 6621.2 6630.1 6631.7 6632.3 6634.2 6330.6 6379.7 6482.5 6485.6 6498.2 04:05:41 INFO - 2016-01-25 04:05:41,214 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,215 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14269.31 Median:25835.85 stddev:16384.66 (63.4%) stddev-sans-first:16399.37 04:05:41 INFO - 2016-01-25 04:05:41,215 DEBUG : BROWSER_OUTPUT: Values: 794.5 812.0 816.6 823.8 911.9 13608.5 16224.7 16525.5 16531.2 16568.2 14491.1 14519.6 14536.9 14552.4 14621.3 748.0 753.9 874.7 889.2 904.5 903.1 906.1 907.2 909.2 911.6 773.6 913.8 920.0 923.1 924.9 778.8 921.9 924.8 935.6 938.2 685.7 691.0 691.2 693.2 694.8 13773.7 13808.4 13812.9 13820.2 13856.2 12566.5 12649.2 12817.9 12911.6 13034.2 10935.3 10960.5 11059.9 11320.4 11366.8 3726.2 3795.9 3846.8 3851.4 3852.7 49489.5 49977.0 50236.5 50853.0 51169.0 9841.0 9867.9 9878.4 10032.8 10070.4 16540.7 16556.9 16562.8 16564.6 16582.3 8762.1 8831.5 8835.2 8852.0 9134.1 4782.2 4879.5 4895.5 4922.3 4942.5 3128.9 3164.1 3172.1 3173.8 3174.5 559.6 580.0 580.3 580.9 588.1 686.8 691.2 715.4 723.9 744.3 9068.6 9624.1 9801.5 9827.9 9835.7 701.7 713.8 719.5 739.3 744.2 4158.1 4266.5 4280.1 4335.4 4353.1 57599.4 57916.4 58590.7 58780.7 58806.1 51455.7 52491.2 52610.5 52759.5 53216.2 47983.3 48252.5 48335.5 48768.0 49050.0 8608.6 8746.8 8772.6 8841.9 8959.1 35404.1 35688.3 35814.0 36315.3 36590.3 42765.4 46484.7 46689.8 46852.0 46889.5 10549.1 10888.2 10926.5 10997.4 11403.9 12201.3 12277.4 12408.5 12586.6 12590.2 10657.6 10822.4 10824.5 10831.0 11152.5 11128.2 11171.3 11211.0 11317.7 11474.1 9027.7 10351.3 11547.4 11714.8 11826.9 10255.6 10275.5 10330.8 10387.6 10389.9 10124.7 10153.0 10190.0 10268.3 10457.7 04:05:41 INFO - 2016-01-25 04:05:41,215 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:41 INFO - 2016-01-25 04:05:41,215 DEBUG : BROWSER_OUTPUT: 04:05:41 INFO - 2016-01-25 04:05:41,798 INFO : Browser exited with error code: 0 04:05:41 INFO - 2016-01-25 04:05:41,816 INFO : Completed test dromaeo_css (00:18:30) 04:05:41 INFO - 2016-01-25 04:05:41,816 INFO : Starting test kraken 04:05:41 INFO - 2016-01-25 04:05:41,816 DEBUG : operating with platform_type : linux_ 04:05:41 INFO - 2016-01-25 04:05:41,816 INFO : Initialising browser for kraken test... 04:05:41 INFO - 2016-01-25 04:05:41,823 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBlIhg2/profile http://localhost:54989/getInfo.html 04:05:45 INFO - 2016-01-25 04:05:45,476 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:45 INFO - 2016-01-25 04:05:45,477 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:45 INFO - 2016-01-25 04:05:45,477 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:45 INFO - 2016-01-25 04:05:45,477 DEBUG : BROWSER_OUTPUT: __metrics 04:05:45 INFO - 2016-01-25 04:05:45,593 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:05:46 INFO - 2016-01-25 04:05:46,744 INFO : Browser initialized. 04:05:46 INFO - 2016-01-25 04:05:46,744 INFO : Running cycle 1/1 for kraken test... 04:05:46 INFO - 2016-01-25 04:05:46,745 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBlIhg2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:05:58 INFO - 2016-01-25 04:05:58,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 137056256 04:05:58 INFO - 2016-01-25 04:05:58,537 DEBUG : BROWSER_OUTPUT: 04:06:01 INFO - 2016-01-25 04:06:01,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:01 INFO - 2016-01-25 04:06:01,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 169422848 04:06:01 INFO - 2016-01-25 04:06:01,598 DEBUG : BROWSER_OUTPUT: 04:06:04 INFO - 2016-01-25 04:06:04,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-dft) 04:06:04 INFO - 2016-01-25 04:06:04,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 168685568 04:06:04 INFO - 2016-01-25 04:06:04,759 DEBUG : BROWSER_OUTPUT: 04:06:07 INFO - 2016-01-25 04:06:07,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-fft) 04:06:08 INFO - 2016-01-25 04:06:08,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 165408768 04:06:08 INFO - 2016-01-25 04:06:08,144 DEBUG : BROWSER_OUTPUT: 04:06:10 INFO - 2016-01-25 04:06:10,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54989/tests/kraken/driver.html?testName=audio-oscillator) 04:06:10 INFO - 2016-01-25 04:06:10,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 164536320 04:06:10 INFO - 2016-01-25 04:06:10,697 DEBUG : BROWSER_OUTPUT: 04:06:12 INFO - 2016-01-25 04:06:12,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:13 INFO - 2016-01-25 04:06:13,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 162775040 04:06:13 INFO - 2016-01-25 04:06:13,437 DEBUG : BROWSER_OUTPUT: 04:06:16 INFO - 2016-01-25 04:06:16,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:16 INFO - 2016-01-25 04:06:16,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 164298752 04:06:16 INFO - 2016-01-25 04:06:16,900 DEBUG : BROWSER_OUTPUT: 04:06:20 INFO - 2016-01-25 04:06:20,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54989/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:20 INFO - 2016-01-25 04:06:20,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 164642816 04:06:20 INFO - 2016-01-25 04:06:20,821 DEBUG : BROWSER_OUTPUT: 04:06:23 INFO - 2016-01-25 04:06:23,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54989/tests/kraken/driver.html?testName=json-parse-financial) 04:06:24 INFO - 2016-01-25 04:06:24,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 164614144 04:06:24 INFO - 2016-01-25 04:06:24,143 DEBUG : BROWSER_OUTPUT: 04:06:25 INFO - 2016-01-25 04:06:25,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54989/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:26 INFO - 2016-01-25 04:06:26,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 171982848 04:06:26 INFO - 2016-01-25 04:06:26,244 DEBUG : BROWSER_OUTPUT: 04:06:27 INFO - 2016-01-25 04:06:27,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:28 INFO - 2016-01-25 04:06:28,583 DEBUG : BROWSER_OUTPUT: RSS: Main: 167948288 04:06:28 INFO - 2016-01-25 04:06:28,583 DEBUG : BROWSER_OUTPUT: 04:06:30 INFO - 2016-01-25 04:06:30,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:31 INFO - 2016-01-25 04:06:31,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 176701440 04:06:31 INFO - 2016-01-25 04:06:31,155 DEBUG : BROWSER_OUTPUT: 04:06:33 INFO - 2016-01-25 04:06:33,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:34 INFO - 2016-01-25 04:06:34,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 182575104 04:06:34 INFO - 2016-01-25 04:06:34,056 DEBUG : BROWSER_OUTPUT: 04:06:36 INFO - 2016-01-25 04:06:36,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:37 INFO - 2016-01-25 04:06:37,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 178180096 04:06:37 INFO - 2016-01-25 04:06:37,078 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54989/tests/kraken/driver.html?testName=ai-astar) 04:06:38 INFO - 2016-01-25 04:06:38,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 235732992 04:06:38 INFO - 2016-01-25 04:06:38,979 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,979 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:38 INFO - 2016-01-25 04:06:38,979 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:38 INFO - 2016-01-25 04:06:38,980 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:38 INFO - 2016-01-25 04:06:38,980 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:38 INFO - 2016-01-25 04:06:38,980 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;109;111;111;100;110;109;111 04:06:38 INFO - 2016-01-25 04:06:38,980 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;121;155;157;126;142;149;124;160;120 04:06:38 INFO - 2016-01-25 04:06:38,980 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;159;159;161;160;163;162;159 04:06:38 INFO - 2016-01-25 04:06:38,981 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;72;72;145;72;73;71;72;149;75 04:06:38 INFO - 2016-01-25 04:06:38,981 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;136;91;93;92;138;91;92;137 04:06:38 INFO - 2016-01-25 04:06:38,981 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;109;109;110 04:06:38 INFO - 2016-01-25 04:06:38,981 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;145;145;145;146;144 04:06:38 INFO - 2016-01-25 04:06:38,982 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 04:06:38 INFO - 2016-01-25 04:06:38,982 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;54;58;57;57;57;55;58;58;54;56 04:06:38 INFO - 2016-01-25 04:06:38,982 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;63;64;63;69;63;64;64 04:06:38 INFO - 2016-01-25 04:06:38,982 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;80;81;80;81;90;82;81;81;83 04:06:38 INFO - 2016-01-25 04:06:38,982 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;110;115;112;107;114;110;113;118;111;117 04:06:38 INFO - 2016-01-25 04:06:38,983 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;132;139;144;142;132;142;140;149;135 04:06:38 INFO - 2016-01-25 04:06:38,983 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;63;63;62;64;62;62;63 04:06:38 INFO - 2016-01-25 04:06:38,983 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:38 INFO - 2016-01-25 04:06:38,983 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:38 INFO - 2016-01-25 04:06:38,983 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,895 04:06:38 INFO - 2016-01-25 04:06:38,984 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:38 INFO - 2016-01-25 04:06:38,984 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723598978__endTimestamp 04:06:38 INFO - 2016-01-25 04:06:38,984 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,985 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:38 INFO - 2016-01-25 04:06:38,986 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:38 INFO - 2016-01-25 04:06:38,986 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,986 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.50 stddev:3.53 (3.2%) stddev-sans-first:3.75 04:06:38 INFO - 2016-01-25 04:06:38,986 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 109.0 111.0 111.0 100.0 110.0 109.0 111.0 04:06:38 INFO - 2016-01-25 04:06:38,987 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,987 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.30 Median:149.00 stddev:15.96 (10.7%) stddev-sans-first:16.61 04:06:38 INFO - 2016-01-25 04:06:38,987 DEBUG : BROWSER_OUTPUT: Values: 149.0 121.0 155.0 157.0 126.0 142.0 149.0 124.0 160.0 120.0 04:06:38 INFO - 2016-01-25 04:06:38,987 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,987 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.43 (0.9%) stddev-sans-first:1.51 04:06:38 INFO - 2016-01-25 04:06:38,988 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 159.0 159.0 161.0 160.0 163.0 162.0 159.0 04:06:38 INFO - 2016-01-25 04:06:38,988 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,988 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:87.90 Median:72.00 stddev:31.23 (43.4%) stddev-sans-first:32.92 04:06:38 INFO - 2016-01-25 04:06:38,988 DEBUG : BROWSER_OUTPUT: Values: 78.0 72.0 72.0 145.0 72.0 73.0 71.0 72.0 149.0 75.0 04:06:38 INFO - 2016-01-25 04:06:38,989 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,989 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:92.00 stddev:21.82 (23.7%) stddev-sans-first:22.60 04:06:38 INFO - 2016-01-25 04:06:38,989 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 136.0 91.0 93.0 92.0 138.0 91.0 92.0 137.0 04:06:38 INFO - 2016-01-25 04:06:38,989 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,989 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.00 Median:145.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 144.0 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,990 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.41 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: Values: 54.0 58.0 57.0 57.0 57.0 55.0 58.0 58.0 54.0 56.0 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:1.79 (2.8%) stddev-sans-first:1.86 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 63.0 64.0 63.0 69.0 63.0 64.0 64.0 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:3.00 (3.7%) stddev-sans-first:3.10 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 81.0 80.0 81.0 90.0 82.0 81.0 81.0 83.0 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,991 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:112.70 Median:113.50 stddev:3.40 (3.0%) stddev-sans-first:3.46 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: Values: 110.0 115.0 112.0 107.0 114.0 110.0 113.0 118.0 111.0 117.0 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:141.00 stddev:5.52 (3.9%) stddev-sans-first:5.66 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: Values: 135.0 132.0 139.0 144.0 142.0 132.0 142.0 140.0 149.0 135.0 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:1.58 (2.5%) stddev-sans-first:1.41 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 63.0 63.0 62.0 64.0 62.0 62.0 63.0 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:38 INFO - 2016-01-25 04:06:38,992 DEBUG : BROWSER_OUTPUT: 04:06:39 INFO - 2016-01-25 04:06:39,782 INFO : Browser exited with error code: 0 04:06:39 INFO - 2016-01-25 04:06:39,832 INFO : Completed test kraken (00:00:58) 04:06:39 INFO - 2016-01-25 04:06:39,832 INFO : Starting test v8_7 04:06:39 INFO - 2016-01-25 04:06:39,832 DEBUG : operating with platform_type : linux_ 04:06:39 INFO - 2016-01-25 04:06:39,832 INFO : Initialising browser for v8_7 test... 04:06:39 INFO - 2016-01-25 04:06:39,838 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1WJF_p/profile http://localhost:54989/getInfo.html 04:06:43 INFO - 2016-01-25 04:06:43,636 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:43 INFO - 2016-01-25 04:06:43,636 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:43 INFO - 2016-01-25 04:06:43,637 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:43 INFO - 2016-01-25 04:06:43,637 DEBUG : BROWSER_OUTPUT: __metrics 04:06:43 INFO - 2016-01-25 04:06:43,801 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:44 INFO - 2016-01-25 04:06:44,659 INFO : Browser initialized. 04:06:44 INFO - 2016-01-25 04:06:44,659 INFO : Running cycle 1/1 for v8_7 test... 04:06:44 INFO - 2016-01-25 04:06:44,659 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1WJF_p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:56 INFO - 2016-01-25 04:06:56,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 137707520 04:06:56 INFO - 2016-01-25 04:06:56,448 DEBUG : BROWSER_OUTPUT: 04:07:17 INFO - 2016-01-25 04:07:17,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:54989/tests/v8_7/run.html (next: http://localhost:54989/tests/v8_7/run.html) 04:07:18 INFO - 2016-01-25 04:07:18,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 424607744 04:07:18 INFO - 2016-01-25 04:07:18,053 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,054 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:18 INFO - 2016-01-25 04:07:18,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:18 INFO - 2016-01-25 04:07:18,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:18 INFO - 2016-01-25 04:07:18,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:18 INFO - 2016-01-25 04:07:18,054 DEBUG : BROWSER_OUTPUT: |0;Richards;164.41959881617888 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.7619461337967 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.2415136338342 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |4;RayTrace;949.667616334283 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |5;Earley;559.2841163310962 04:07:18 INFO - 2016-01-25 04:07:18,055 DEBUG : BROWSER_OUTPUT: |6;Boyer;11164.835164835165 04:07:18 INFO - 2016-01-25 04:07:18,056 DEBUG : BROWSER_OUTPUT: |7;RegExp;24047.619047619046 04:07:18 INFO - 2016-01-25 04:07:18,056 DEBUG : BROWSER_OUTPUT: |8;Splay;523.2862375719518 04:07:18 INFO - 2016-01-25 04:07:18,056 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:07:18 INFO - 2016-01-25 04:07:18,056 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:18 INFO - 2016-01-25 04:07:18,056 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723638053__endTimestamp 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.42 Median:164.42 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,057 DEBUG : BROWSER_OUTPUT: Values: 164.4 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.76 Median:173.76 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: Values: 173.8 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,058 DEBUG : BROWSER_OUTPUT: Values: 278.2 04:07:18 INFO - 2016-01-25 04:07:18,059 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,059 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,060 DEBUG : BROWSER_OUTPUT: Values: 5122.4 04:07:18 INFO - 2016-01-25 04:07:18,060 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,060 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:949.67 Median:949.67 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,060 DEBUG : BROWSER_OUTPUT: Values: 949.7 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:559.28 Median:559.28 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: Values: 559.3 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11164.84 Median:11164.84 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: Values: 11164.8 04:07:18 INFO - 2016-01-25 04:07:18,061 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24047.62 Median:24047.62 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: Values: 24047.6 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:523.29 Median:523.29 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: Values: 523.3 04:07:18 INFO - 2016-01-25 04:07:18,062 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,063 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:07:18 INFO - 2016-01-25 04:07:18,063 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:07:18 INFO - 2016-01-25 04:07:18,063 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:18 INFO - 2016-01-25 04:07:18,063 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2016-01-25 04:07:18,862 INFO : Browser exited with error code: 0 04:07:18 INFO - 2016-01-25 04:07:18,878 INFO : Completed test v8_7 (00:00:39) 04:07:19 INFO - 2016-01-25 04:07:19,101 INFO : Completed test suite (00:20:07) 04:07:19 INFO - 2016-01-25 04:07:19,102 DEBUG : Working with test: dromaeo_css 04:07:19 INFO - 2016-01-25 04:07:19,102 DEBUG : Generating results file: dromaeo_css 04:07:19 INFO - 2016-01-25 04:07:19,103 DEBUG : Working with test: kraken 04:07:19 INFO - 2016-01-25 04:07:19,103 DEBUG : Generating results file: kraken 04:07:19 INFO - 2016-01-25 04:07:19,103 INFO : javascript benchmark 04:07:19 INFO - 2016-01-25 04:07:19,103 DEBUG : Working with test: v8_7 04:07:19 INFO - 2016-01-25 04:07:19,103 DEBUG : Generating results file: v8_7 04:07:19 INFO - 2016-01-25 04:07:19,104 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:19 INFO - 2016-01-25 04:07:19,152 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 04:07:19 INFO - 2016-01-25 04:07:19,152 DEBUG : process_Request line: dromaeo_css 7214.88 graph.html#tests=[[72,52,35]] 04:07:19 INFO - 2016-01-25 04:07:19,152 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:19 INFO - 2016-01-25 04:07:19,178 DEBUG : process_Request line: kraken 1469.80 graph.html#tests=[[232,52,35]] 04:07:19 INFO - 2016-01-25 04:07:19,178 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:19 INFO - 2016-01-25 04:07:19,208 DEBUG : process_Request line: v8_7 23053.32 graph.html#tests=[[230,52,35]] 04:07:19 INFO - 2016-01-25 04:07:19,209 INFO : javascript benchmark 04:07:19 INFO - 2016-01-25 04:07:19,213 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3309.387763263795, 3335.8498867550957, 3341.4820702791076, 3343.2143446290133, 3357.21105540198, 5510.614257002011, 5593.105103183491, 5608.270924779783, 5613.101903695405, 5613.859653508659, 5525.281713377255, 5597.524210442118, 5624.803131890385, 5625.465580769831, 5634.3802181759975, 4965.180745177042, 5056.544910958013, 5082.440931497532, 5117.7185254810975, 5174.611904107188, 5019.874503137415, 5061.0, 5067.113255180348, 5067.214581739836, 5074.391073071237, 4952.108620448318, 5010.148274793294, 5052.292679024939, 5058.519440653132, 5062.215356619729, 5032.169692000815, 5106.591472682177, 5108.770105345268, 5110.310108135392, 5112.616553758465, 4911.0, 5000.149974504343, 5014.097462456756, 5018.723970181639, 5126.307948426952, 5268.736563171864, 5273.050850846846, 5349.893002139936, 5373.838784836461, 5392.973035134838, 5928.911066334009, 5966.910496342558, 5969.074793407029, 5974.97012514939, 5997.760089596454, 5906.350301466835, 5990.550708696822, 5993.310769261547, 5993.4006599340155, 5994.07091900756, 5415.566754659618, 5418.4039755626845, 5506.587005974568, 5558.861028474321, 5568.248286481355, 5985.281766188085, 6169.537284703665, 6192.783252586138, 6194.81415557534, 6197.907031394533, 5680.0, 5967.283925928917, 5993.370696076936, 5994.760209591567, 5995.550333724988, 5826.213461182686, 5888.234529511136, 5970.313413957364, 5973.044312909914, 5998.340182579913, 5864.941350586525, 5980.85047873798, 5993.910091348634, 6020.4280593343565, 6022.69886505673, 5727.627704199213, 5772.220750198753, 6009.969950150221, 6018.428249316308, 6031.547633927473, 4515.300128480091, 4574.336721175411, 4574.771261436915, 4593.081383723202, 4603.9079218415445, 4097.713160078766, 4120.381942708557, 4120.958790412117, 4128.277551428488, 4156.7921603919685, 5282.2340760589495, 5417.295751552273, 5501.862453438616, 5696.287964004499, 5701.173329867146, 6010.879782404328, 6027.126066720389, 6028.216331876828, 6064.482600091936, 6102.237220347457, 5656.123300888369, 5662.320521537442, 5663.433656634386, 5664.376918538957, 5671.432856714378, 5005.474425185376, 5116.923246151311, 5165.66423182492, 5215.348081489814, 5217.0, 6112.397599661398, 6236.501079913596, 6237.656928868956, 6241.968790156111, 6243.625382477066, 6063.211782468251, 6075.544334174866, 6077.0, 6078.270607527125, 6081.908771368521, 5942.554308426799, 6016.067509536029, 6046.455818976313, 6143.972489078683, 6149.292831324455, 5938.257717785277, 5995.070764031582, 5996.160537524663, 5996.730147143302, 6021.277446706424, 6043.456088952015, 6063.393660634078, 6066.18106555627, 6068.605540639845, 6073.665948372882, 5671.092625179951, 5782.219400381063, 5796.478316951495, 5870.823875283749, 5890.9396308664855, 5843.094320380348, 5848.181254624441, 5851.268591426072, 5865.061590145556, 5938.406159384027, 5531.308586426697, 5740.569457290637, 5746.482816546531, 5748.655080695172, 5760.135979603093, 5664.716764161693, 5794.594378393641, 5856.648601083949, 5861.882762344644, 5897.675627840338, 5778.653280803165, 5780.104083867007, 5780.132980052857, 5783.797567085132, 5815.5929084963645], "unit": "ms", "name": "dojo.html", "value": 5502.100538843666}, {"lowerIsBetter": false, "replicates": [617.1329282358288, 618.6844709198309, 633.3381616211059, 633.9033472093279, 636.6530241018644, 31925.0, 40546.18907621849, 40723.389149162715, 40956.0, 41033.384499232496, 46193.30710039352, 46668.0, 46676.0, 46694.0, 46826.53173468264, 8088.878666820003, 8184.754457366289, 8923.821523569524, 9078.500682462462, 9102.544872756336, 10756.892431075667, 10996.780064398747, 11017.779644407146, 11019.614313499029, 11032.062274706619, 10716.142708583333, 10823.0, 10833.83749243762, 10846.18653600979, 10855.565777368896, 8302.875456868182, 8451.619677114482, 8492.193241642035, 10649.893501065006, 10819.945900270526, 10499.947500262526, 10665.9466702666, 10667.893321066767, 10670.466476676213, 10673.466326683712, 41934.58065419337, 42590.57409425897, 42601.573984260074, 42606.0, 42627.147457050996, 3537.0, 3557.5375201223674, 3595.0473124621994, 3928.921421571581, 4301.935470967938, 30615.540766888513, 30960.0, 31071.378572428424, 31136.221594460094, 31696.366072678647, 3893.610638936112, 3997.120633460634, 4052.0882801369457, 4063.634272915422, 4102.5692302308125, 287477.0, 288122.0, 288696.0, 289392.0, 289602.0, 55356.44643553594, 56359.43640563542, 61993.0, 68783.0, 69977.3002269981, 62455.37544624587, 62505.374946250864, 62583.0, 62715.372846271865, 62788.68605657034, 16394.83605163957, 16494.505164845075, 16502.917485412738, 16556.0, 16663.6667266654, 11986.0, 12005.279683219034, 12019.819702704466, 12023.21849079807, 12137.635870923887, 20533.254673352632, 20830.687539686918, 20852.1659133636, 20946.371608851758, 20950.685739713917, 7879.251471110236, 7952.960235198787, 8010.519368837889, 8044.959775201203, 8155.184481551797, 1095.2552264460085, 1098.132475344469, 1136.5510623303749, 1205.5900993662196, 1227.756856385273, 28409.71590284112, 29060.0, 29778.10665680033, 29888.0, 30081.097567073022, 1069.0752499088233, 1097.8792332843382, 1144.347721798567, 1183.8342632031522, 1230.5939040116739, 13225.73548529024, 13440.932795336157, 14078.929605351908, 15554.844451555566, 15934.60163495922, 260158.0, 263817.0, 263933.0, 264093.0, 264172.0, 53622.46377536175, 54798.178027329624, 54853.177202342, 54877.72561137169, 54926.17610735842, 1457.1766951672482, 1459.0953608762636, 1469.8383177850428, 1474.3807600807686, 1474.4544518528214, 25922.0, 28615.14154575366, 28858.134255972356, 29085.418291634473, 29254.41491170122, 52363.47636523586, 53067.0, 53137.7343113282, 53176.46823531715, 53189.7340513295, 206191.0, 208206.0, 209878.0, 210144.0, 210738.0, 30191.09426717202, 30243.0, 30739.385212295183, 33773.15567110842, 33889.0, 39871.2025759489, 40293.39559906545, 40404.3939340916, 41053.589464106175, 41281.380779288935, 34009.31981360309, 34702.65297346994, 34919.301613968084, 35317.82341088278, 36701.81649091737, 32694.34611307808, 36989.63010369862, 37146.8142659285, 37307.81346093252, 38891.41662875003, 34746.30507389889, 35097.47353789644, 36358.454623181206, 36871.0, 36989.630103699696, 31838.681613183573, 32577.34845303128, 33491.33017339591, 33636.831815840764, 33774.80463769847, 25308.873455632605, 25509.23472295834, 25621.615675764504, 25779.331709673756, 25989.6101558473], "unit": "ms", "name": "ext.html", "value": 19226.527358745898}, {"lowerIsBetter": false, "replicates": [378.87686501886895, 378.93179227738995, 383.97504162229455, 385.75119048213884, 389.6201203826269, 18109.818901810977, 18990.240390384402, 20074.0, 20103.19587216513, 20155.39533813986, 14954.252287385641, 15305.617359566017, 17263.48209553712, 18231.817681823177, 18407.07964601768, 5046.798128074873, 5056.949430505703, 5059.11465493539, 5217.5565076968505, 5250.238715386266, 5458.372287186965, 5494.313210848644, 5495.917561236584, 5500.1749737539285, 5502.119660854264, 4197.496300443951, 4291.914161716763, 5836.533077353802, 5988.341282458926, 5989.970050149765, 5817.7382017809305, 5924.37794031627, 5937.643741375509, 5941.465268125889, 5966.134910437984, 5392.56859451243, 5405.216243644689, 5415.972920135374, 5417.729113544307, 5422.2951016368015, 21027.894860525754, 21074.78925210759, 21220.0, 21382.57234855294, 21941.561168776694, 2374.726906405768, 2547.503236868811, 2554.3741783263217, 2581.586946088617, 2767.5848622706553, 14204.644883877985, 14304.0, 14395.064320819114, 14403.351849166813, 14775.335109919972, 1788.2668106076446, 1936.9612607747906, 1945.2802463088606, 1976.071246514136, 1989.9701504477443, 64203.35796642067, 66540.0, 66645.0, 66770.0, 67084.66457667729, 10493.0, 10704.30422022566, 10915.39965301916, 10918.454077296103, 10996.12031037515, 14199.71600567983, 14213.857861421253, 14289.142651440947, 14295.213763243122, 14318.14091154534, 7946.404019698546, 7989.7203597873795, 8005.0, 8227.876581851157, 8309.335253179732, 7613.619319034026, 7620.9618951905995, 7683.078030636248, 7689.50018248812, 7724.266194711493, 6376.776812811529, 6412.67936603168, 6424.38968298011, 6470.547061705635, 6489.545731798823, 1722.8277172282671, 1884.877482963603, 1894.7631546056743, 1916.5687720263109, 1917.0606402862497, 889.5818965086399, 898.0525545549508, 964.2430691906819, 990.8810942686923, 1093.8632670916136, 16400.917995410186, 16940.07498065984, 16947.898386605077, 18191.727124093148, 18205.27178912855, 891.5007595746403, 987.9851802222972, 988.9802203956025, 998.9500524973722, 1021.0504231065032, 9199.862002069975, 9899.109080182818, 10147.7463063424, 10246.692599222035, 10361.533730982124, 620752.0, 627429.0, 632808.0, 641003.0, 642483.0, 75039.87440188402, 75781.0, 76060.0, 77896.0, 79431.0, 1187.034995182319, 1189.756099999498, 1195.8923696867323, 1198.269055875915, 1200.507791805373, 15592.844071559593, 15728.449504267295, 15804.920975395049, 15933.36266549325, 16043.358265669243, 34330.48504272488, 34998.47502287519, 35209.47185792164, 35818.64181358153, 36458.0, 47332.0, 48312.0, 49338.0, 49546.0, 50011.49988500214, 9659.46872921968, 9987.950060249652, 10470.94764526203, 10507.369557826554, 10520.473976301308, 11200.887991119984, 11284.266522676, 11314.434278286217, 12184.0, 17248.568785780455, 14581.270936453348, 14705.485308014167, 14909.254537272876, 15094.622634434227, 15352.616184595474, 14075.296235187994, 14665.367608483764, 14867.107973521623, 14887.776683349975, 15077.246137692851, 14577.0, 15265.313060912064, 16156.626686731759, 16522.58693532671, 16544.090075045988, 8469.237768600855, 9587.424754514752, 9865.161461275586, 10163.593456261962, 10290.073893349634, 10881.891181088404, 14611.780823287872, 14696.55910322692, 14857.851421485646, 14926.328315225624], "unit": "ms", "name": "jquery.html", "value": 9404.612487341801}, {"lowerIsBetter": false, "replicates": [1621.9756703649455, 1768.8761786674931, 1812.2298023340077, 1822.1133340607246, 1840.190316260845, 6441.355864413556, 6810.0, 7267.781966541005, 7543.170251272356, 7563.92436075639, 7477.289657482531, 7488.550686958786, 7540.283673051065, 7571.205023472538, 7578.734744283951, 1956.2761778142108, 1983.4446355020618, 2229.3646310801423, 2264.445210923326, 2266.9206577769783, 2245.7080579524722, 2255.650374192003, 2267.2291420916886, 2270.012544543129, 2271.2618399020303, 2113.028007116728, 2137.957240855182, 2158.2554018863543, 2162.286445472998, 2164.199246278871, 2154.795294447025, 2162.167565487283, 2206.7572567017614, 2230.3643461613524, 2232.2745107839937, 2230.4535388829677, 2235.1059576169664, 2257.0, 2262.558801033799, 2264.184893438361, 7495.925040749577, 7544.924550754477, 7566.356859666935, 7566.470347075707, 7567.243275672388, 4490.977545112253, 4552.4764652065105, 4586.4266966629175, 4595.195840727859, 4619.214733495314, 2881.423715256957, 2975.9851200744074, 2996.2509372656837, 3012.29211135383, 3021.22958645544, 947.4599478297373, 961.4904100826503, 995.875515560555, 1010.9241806864441, 1014.8782146142437, 10141.2394070445, 10211.183105351554, 10222.846657300071, 10227.590896364136, 10234.02776736209, 4021.678265738734, 4047.0, 4093.8362465501045, 4095.9385609215888, 4099.590040995877, 8698.34762392823, 8731.51976641278, 8741.169588889044, 8756.824863502694, 8814.603342849587, 4603.17142914272, 4610.677252592353, 4620.884477888079, 4654.185517534418, 4656.883577910579, 4178.874633760992, 4267.445232119804, 4269.935950960738, 4269.957300427018, 4277.379779931893, 3209.293955329824, 3301.3067255876053, 3317.1209629448217, 3633.073566240592, 3733.178700685845, 1128.2948157401624, 1159.4666453431516, 1167.6963989362828, 1178.1811640909486, 1186.9821952670716, 999.3504222255592, 1002.1631937332263, 1086.8641419822522, 1090.2368342160519, 1132.003836623766, 6925.826854328682, 6956.686949087303, 6969.47728920333, 7035.683394247271, 7044.647767611701, 1098.7637657903429, 1108.9001989820954, 1119.3843386137592, 1123.7640095579857, 1131.9603813866474, 5506.174073888948, 5556.666600003932, 5556.749946252428, 5557.3886872444, 5569.192467092249, 8611.6985905493, 8978.281737460988, 8981.191692747683, 8994.86507702385, 9052.909470905206, 8906.287497000225, 8952.955235223912, 9002.099790020946, 9012.549372531346, 9024.503652299187, 7093.432525398059, 7124.46566507514, 7262.455315851333, 7289.817754556072, 7294.307040831112, 6797.9320206799275, 6830.385265326145, 6845.041694162921, 6853.211880633791, 6855.211650660238, 7985.560794156378, 7987.440879138405, 7991.92008079935, 8015.158408367271, 8161.836763264582, 8162.347012239125, 8182.509049456814, 8333.291670207858, 8390.119037500974, 8395.370347224105, 6535.477161827138, 6556.3443655634055, 6614.272430032596, 6640.966795165993, 6641.933580664325, 6348.841278968062, 6416.32628573993, 6799.524033317621, 6924.826879328057, 7174.641267936687, 6695.330466953265, 6722.9663851680425, 6748.561343512656, 6811.829704257433, 6832.726690932307, 6670.066190733204, 6709.630970296485, 6750.932490675031, 6758.898616520658, 6832.692528836314, 6862.519623626498, 6880.862382752417, 6884.795160846732, 6885.655717214219, 6892.965535172292, 5992.700364981821, 6164.660943648142, 6181.35095814933, 6196.1635179252025, 6201.441870231701, 6318.368163183829, 6358.650274234961, 6403.07155462446, 6413.518986076157, 6416.871662566629], "unit": "ms", "name": "mootools.html", "value": 4346.633752632878}, {"lowerIsBetter": false, "replicates": [336.089198272681, 337.57634169117756, 342.71897044423577, 344.34574308813234, 347.5568649971286, 6168.969155154224, 6186.969065154673, 6200.410960958713, 6274.121622972787, 6302.716377762995, 5865.970670146654, 5969.761209551612, 6064.9696751516185, 6109.053096770008, 6139.447449729523, 4667.019925815566, 4705.3177289293035, 4706.576408123268, 4710.788014539346, 4714.0, 4514.864554063383, 4721.622270218391, 4727.1727447696685, 4731.503192164825, 4736.171170045245, 4547.408836851221, 4560.315952607102, 4692.085043416535, 4696.483386827464, 4699.553542413482, 4669.439667239919, 4680.5085466026085, 4681.204195286809, 4687.203175460146, 4689.788959496831, 4135.813888375031, 4136.482939632546, 4142.2958097123565, 4143.4199212110325, 4149.2531344358, 5697.230873832063, 5770.509506691937, 5820.068788993783, 5821.79623713168, 5825.38833422493, 5384.030874442598, 5384.219288203189, 5388.084025715599, 5395.10980688186, 5398.379186393576, 6512.967435162841, 6538.313477084933, 6546.672666366662, 6546.770863019819, 6559.901601475982, 4421.624161946238, 4426.0, 4430.645548356124, 4431.756253406062, 4434.046679963791, 6674.16572928384, 6698.8995165072565, 6787.72849086036, 6790.5925644461495, 6793.626350550718, 4537.4328208973875, 4538.1377538267625, 4538.228501154812, 4539.546045395434, 4542.068875880436, 4581.954180458153, 4584.060267645124, 4586.931196032062, 4588.151192029419, 4589.013362127159, 5366.570674346043, 5367.060764366221, 5370.113931201308, 5377.946220537823, 5378.1932710093015, 6453.128827608307, 6590.143281373391, 6601.76893808724, 6608.2730899601, 6612.570182938093, 1595.5771720494079, 1617.8543931046027, 1617.9191040448165, 1618.449727092794, 1618.6034421566792, 1077.5797438998798, 1079.3254216114929, 1086.559943222996, 1093.3822390349428, 1108.1854836695022, 6349.857025735319, 6353.4599559038, 6365.968170159213, 6371.585846920028, 6374.107624932513, 6618.371254730889, 6786.219584747817, 6792.830179245559, 6800.863982720318, 6807.115075040213, 6269.686515674198, 6304.873902521924, 6413.422791948747, 6415.069814876817, 6422.8715425691225, 3649.8905032849057, 3693.1136527233807, 3694.07648087978, 3697.9815100924325, 3699.667029967316, 6850.965745171342, 7018.824529386704, 7027.5080744348425, 7039.612821294775, 7044.15470143586, 7057.0, 7067.293270672994, 7070.787876363717, 7070.92929070713, 7074.823129421806, 7034.120734908137, 7059.976303436076, 7061.717531298793, 7065.2228254891925, 7067.82330441743, 6672.466202703675, 6847.486438517031, 6876.862462750617, 6887.380135787803, 6895.758648447481, 6809.250982392032, 6816.897746533707, 6817.284185160685, 6821.727130914708, 6829.795106146824, 7054.541454805421, 7062.682179301841, 7066.681999309941, 7068.434525237866, 7070.540414873017, 4446.42196514451, 4456.5766252205985, 4457.732536047847, 4464.285714285698, 4581.679282450196, 6801.489888258301, 6818.795436136924, 6825.044493770777, 6826.488013398915, 6828.931710682829, 6627.701753421204, 6632.767853125118, 6633.502487313374, 6638.5684930479365, 6643.7674681385915, 6494.967525162533, 6601.141851559267, 6628.038934354588, 6629.270780214269, 6629.569078009914, 6431.292557818542, 6509.088727578238, 6511.609303441809, 6514.315996820455, 6531.673416329069, 6621.238557565749, 6630.071789949315, 6631.701573429304, 6632.270450250565, 6634.203895532374, 6330.556861019684, 6379.7129129190225, 6482.513811464253, 6485.610863348025, 6498.155239818793], "unit": "ms", "name": "prototype.html", "value": 4928.185050437966}, {"lowerIsBetter": false, "replicates": [794.4994653368377, 811.963461644226, 816.5672193737319, 823.8146417056163, 911.9407238529493, 13608.523701670443, 16224.675506489863, 16525.504234872944, 16531.173441327945, 16568.171591420425, 14491.130532168077, 14519.637009074779, 14536.927315363408, 14552.417903283857, 14621.342039608217, 748.0462410426695, 753.8906858505513, 874.6501399440211, 889.1952782731638, 904.5160838951163, 903.1059251341158, 906.075802681268, 907.2152588011388, 909.1681111782744, 911.6080085563239, 773.6441237030973, 913.7532866126176, 920.0339643374464, 923.0630909626734, 924.9213816825544, 778.8286576953061, 921.889373275208, 924.8474001789697, 935.5556110847361, 938.1509733690987, 685.7394190207739, 691.0187533702154, 691.1878542712343, 693.2062788107639, 694.8124006518211, 13773.724525509533, 13808.447662093504, 13812.861871381258, 13820.170789752547, 13856.168629882239, 12566.497340106385, 12649.177803442746, 12817.87182128176, 12911.612651620466, 13034.21794692312, 10935.271816632427, 10960.506777194965, 11059.889401105966, 11320.377379244139, 11366.772664546745, 3726.217494326195, 3795.9430608540893, 3846.807659617008, 3851.422286657024, 3852.711046671483, 49489.50510494885, 49977.0, 50236.497635023545, 50853.0, 51169.0, 9841.0, 9867.901320986699, 9878.407295562289, 10032.79934401308, 10070.446125463024, 16540.6691866162, 16556.917215414087, 16562.83437165637, 16564.585885352964, 16582.336706531605, 8762.079981601968, 8831.470111793313, 8835.20483156519, 8851.955740221258, 9134.086591340812, 4782.163121453732, 4879.487653796371, 4895.485973972753, 4922.261660750844, 4942.5304596063315, 3128.9374212515622, 3164.1298642873394, 3172.0800967719565, 3173.841307934594, 3174.4920812670325, 559.6222549778882, 579.9768009279582, 580.2862479150668, 580.9215755872988, 588.1266319515516, 686.7562015484531, 691.2120182991393, 715.445529714465, 723.8660847743184, 744.3486948919696, 9068.637254509878, 9624.085711857362, 9801.509924503745, 9827.901720982698, 9835.704928852147, 701.680735265453, 713.7644577289586, 719.481972979454, 739.2792027772986, 744.2297222374816, 4158.147579746144, 4266.530681625019, 4280.101178752497, 4335.3713711511655, 4353.064091220403, 57599.42400575941, 57916.420835791105, 58590.70704646449, 58780.70609646924, 58806.11790823141, 51455.74272128615, 52491.21263181055, 52610.473895260555, 52759.472405276225, 53216.20175697368, 47983.28025079626, 48252.5174748255, 48335.516644833806, 48768.0, 49050.0, 8608.61261243258, 8746.781330466789, 8772.649094036167, 8841.911580884365, 8959.118585096941, 35404.11489712675, 35688.28623427465, 35814.0, 36315.27369452649, 36590.26819463543, 42765.35851962161, 46484.69892397902, 46689.76655116703, 46852.0, 46889.53110468852, 10549.050585447347, 10888.237823352607, 10926.508307126358, 10997.395143267197, 11403.942980285046, 12201.32892690875, 12277.386130693609, 12408.497415518752, 12586.622401327975, 12590.24458532491, 10657.626983055556, 10822.350658960488, 10824.5128969195, 10831.0, 11152.498137583665, 11128.165387596124, 11171.273867198606, 11211.047060999907, 11317.71705707364, 11474.082073433938, 9027.684031058881, 10351.275410721177, 11547.422628868691, 11714.76570468603, 11826.940865295619, 10255.58977640886, 10275.486225688535, 10330.845037324296, 10387.584496620051, 10389.9480502597, 10124.746881328027, 10152.984701529787, 10190.0, 10268.281220314506, 10457.738556536147], "unit": "ms", "name": "yui.html", "value": 6617.982328304011}], "name": "dromaeo_css", "value": 7214.884013273096}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 105.0, 109.0, 111.0, 111.0, 100.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [149.0, 121.0, 155.0, 157.0, 126.0, 142.0, 149.0, 124.0, 160.0, 120.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.3}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 159.0, 159.0, 161.0, 160.0, 163.0, 162.0, 159.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 72.0, 145.0, 72.0, 73.0, 71.0, 72.0, 149.0, 75.0], "unit": "ms", "name": "audio-fft", "value": 87.9}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 136.0, 91.0, 93.0, 92.0, 138.0, 91.0, 92.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 144.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [54.0, 58.0, 57.0, 57.0, 57.0, 55.0, 58.0, 58.0, 54.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 69.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.1}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 80.0, 81.0, 90.0, 82.0, 81.0, 81.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [110.0, 115.0, 112.0, 107.0, 114.0, 110.0, 113.0, 118.0, 111.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 112.7}, {"lowerIsBetter": true, "replicates": [135.0, 132.0, 139.0, 144.0, 142.0, 132.0, 142.0, 140.0, 149.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.6}], "name": "kraken", "value": 1469.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.41959881617888], "unit": "score", "name": "Richards", "value": 214.70676399999994}, {"lowerIsBetter": false, "replicates": [173.7619461337967], "unit": "score", "name": "DeltaBlue", "value": 380.5090899999999}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [949.667616334283], "unit": "score", "name": "RayTrace", "value": 779.2084170000002}, {"lowerIsBetter": false, "replicates": [559.2841163310962], "unit": "score", "name": "Earley", "value": 1191.6358439999997}, {"lowerIsBetter": false, "replicates": [11164.835164835165], "unit": "score", "name": "Boyer", "value": 59.693044291338616}, {"lowerIsBetter": false, "replicates": [24047.619047619046], "unit": "score", "name": "RegExp", "value": 37.88254455445545}, {"lowerIsBetter": false, "replicates": [523.2862375719518], "unit": "score", "name": "Splay", "value": 155.72930100000005}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23053.322429778702}]} 04:07:19 INFO - RETURN: dromaeo_css: 7214.88 04:07:19 INFO - RETURN: kraken: 1469.80 04:07:19 INFO - RETURN: v8_7: 23053.32 04:07:19 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "23053.32"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1469.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7214.88"}}} 04:07:19 INFO - Return code: 0 04:07:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:19 INFO - # TBPL SUCCESS # 04:07:19 INFO - Running post-action listener: _resource_record_post_action 04:07:19 INFO - Running post-run listener: _resource_record_post_run 04:07:20 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 502751232; Read time: 8; Write time: 341280 04:07:20 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237912064; Read time: 0; Write time: 212836 04:07:20 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264839168; Read time: 8; Write time: 128444 04:07:20 INFO - Running post-run listener: _upload_blobber_files 04:07:20 INFO - Blob upload gear active. 04:07:20 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:20 INFO - Copying logs to upload dir... 04:07:20 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.293494 ========= master_lag: 1.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-25 04:07:21.328079) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:21.335746) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009921 build_url: 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.44 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:21.782852) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:21.783181) ========= 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=82e07478c745e68b1fe4678a000001bc-1453721293.897014-1522753874 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:21.853690) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:21.854008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:21.860015) ========= ========= Total master_lag: 1.81 =========