builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1453722372.74 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.741952) ========= 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.742403) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.742896) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006471 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.817916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.818201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.900773) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.901038) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.984530) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.984786) ========= 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.985114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.985401) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 03:46:12-- 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% 37.6M=0s 2016-01-25 03:46:13 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.172639 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.196850) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.197131) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015086 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.255712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.256042) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 03:46:13,296 truncating revision to first 12 chars 2016-01-25 03:46:13,296 Setting DEBUG logging. 2016-01-25 03:46:13,296 attempt 1/10 2016-01-25 03:46:13,296 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,841 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.121105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.121437) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.004632 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.180791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.181070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.195683) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-25 03:46:14.195963) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 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-e10s --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-e10s', 03:46:14 INFO - 'system_bits': '32', 03:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:14 INFO - 'title': 'talos-linux64-ix-037', 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:14 INFO - Running post-action listener: _resource_record_post_action 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 03:46:14 INFO - Using buildbot properties: 03:46:14 INFO - { 03:46:14 INFO - "properties": { 03:46:14 INFO - "buildnumber": 82, 03:46:14 INFO - "product": "firefox", 03:46:14 INFO - "script_repo_revision": "production", 03:46:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:46:14 INFO - "repository": "", 03:46:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:46:14 INFO - "buildid": "20160125001712", 03:46:14 INFO - "slavename": "talos-linux64-ix-037", 03:46:14 INFO - "pgo_build": "True", 03:46:14 INFO - "basedir": "/builds/slave/test-pgo", 03:46:14 INFO - "project": "", 03:46:14 INFO - "platform": "ubuntu64_hw", 03:46:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:46:14 INFO - "slavebuilddir": "test", 03:46:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "branch": "mozilla-aurora", 03:46:14 INFO - "repo_path": "releases/mozilla-aurora", 03:46:14 INFO - "stage_platform": "linux64-pgo", 03:46:14 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - }, 03:46:14 INFO - "sourcestamp": { 03:46:14 INFO - "repository": "", 03:46:14 INFO - "hasPatch": false, 03:46:14 INFO - "project": "", 03:46:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "changes": [ 03:46:14 INFO - { 03:46:14 INFO - "category": null, 03:46:14 INFO - "files": [ 03:46:14 INFO - { 03:46:14 INFO - "url": null, 03:46:14 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:46:14 INFO - } 03:46:14 INFO - ], 03:46:14 INFO - "repository": "", 03:46:14 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 03:46:14 INFO - "who": "cbook@mozilla.com", 03:46:14 INFO - "when": 1453717351, 03:46:14 INFO - "number": 7510169, 03:46:14 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:14 INFO - "project": "", 03:46:14 INFO - "at": "Mon 25 Jan 2016 02:22:31", 03:46:14 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:14 INFO - "revlink": "", 03:46:14 INFO - "properties": [ 03:46:14 INFO - [ 03:46:14 INFO - "buildid", 03:46:14 INFO - "20160125001712", 03:46:14 INFO - "Change" 03:46:14 INFO - ], 03:46:14 INFO - [ 03:46:14 INFO - "builduid", 03:46:14 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:14 INFO - "Change" 03:46:14 INFO - ], 03:46:14 INFO - [ 03:46:14 INFO - "pgo_build", 03:46:14 INFO - "True", 03:46:14 INFO - "Change" 03:46:14 INFO - ] 03:46:14 INFO - ], 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - } 03:46:14 INFO - ], 03:46:14 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:14 INFO - } 03:46:14 INFO - } 03:46:14 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:14 INFO - Running post-action listener: _resource_record_post_action 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running download-and-extract 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: download_and_extract 03:46:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:14 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:14 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:14 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:26 INFO - Downloaded 1302 bytes. 03:46:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:26 INFO - Using the following test package requirements: 03:46:26 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:26 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:26 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'jsshell-linux-x86_64.zip'], 03:46:26 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:26 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:26 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:26 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:26 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:26 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:26 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:26 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:26 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:26 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:26 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:26 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:26 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:26 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:50 INFO - Downloaded 23159167 bytes. 03:46:50 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:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:50 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:51 INFO - Return code: 0 03:46:51 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:51 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:51 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:51 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:51 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:51 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:51 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:55 INFO - Downloaded 23159167 bytes. 03:46:55 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:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:46:55 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:57 INFO - Return code: 0 03:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:57 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:57 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:57 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:57 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:57 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:58 INFO - Downloaded 11132038 bytes. 03:46:58 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:58 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:58 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:58 INFO - Return code: 0 03:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:58 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:58 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:58 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:58 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:58 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:59 INFO - Downloaded 58033452 bytes. 03:46:59 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:59 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:59 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:59 INFO - Contents: 03:46:59 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:59 INFO - Running post-action listener: _resource_record_post_action 03:46:59 INFO - Running post-action listener: set_extra_try_arguments 03:46:59 INFO - ##### 03:46:59 INFO - ##### Running populate-webroot step. 03:46:59 INFO - ##### 03:46:59 INFO - Running pre-action listener: _resource_record_pre_action 03:46:59 INFO - Running main action method: populate_webroot 03:46:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:59 INFO - '--tppagecycles', 03:46:59 INFO - '7'], 03:46:59 INFO - 'tests': ['tsvgm']}}, 03:46:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'tests': ['damp', 'tps']}, 03:46:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['damp', 'tps']}, 03:46:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:59 INFO - 'other': {'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'other_l64': {'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:59 INFO - 'ts_paint', 03:46:59 INFO - 'tpaint', 03:46:59 INFO - 'sessionrestore', 03:46:59 INFO - 'sessionrestore_no_auto_restore']}, 03:46:59 INFO - 'svgr': {'tests': ['tsvgx', 03:46:59 INFO - 'tsvgr_opacity', 03:46:59 INFO - 'tart', 03:46:59 INFO - 'tscrollx', 03:46:59 INFO - 'cart']}, 03:46:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['tsvgx', 03:46:59 INFO - 'tsvgr_opacity', 03:46:59 INFO - 'tart', 03:46:59 INFO - 'tscrollx', 03:46:59 INFO - 'cart']}, 03:46:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'tests': ['tp5o']}, 03:46:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'talos_options': ['--e10s'], 03:46:59 INFO - 'tests': ['tp5o']}, 03:46:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'talos_options': ['--xperf_path', 03:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:59 INFO - 'tests': ['tp5n']}, 03:46:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:59 INFO - 'talos_options': ['--e10s', 03:46:59 INFO - '--xperf_path', 03:46:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:59 INFO - 'tests': ['tp5n']}}, 03:46:59 INFO - 'talos.zip': {'path': '', 03:46:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:59 INFO - Running post-action listener: _resource_record_post_action 03:46:59 INFO - ##### 03:46:59 INFO - ##### Running create-virtualenv step. 03:46:59 INFO - ##### 03:46:59 INFO - Running pre-action listener: _resource_record_pre_action 03:46:59 INFO - Running main action method: create_virtualenv 03:46:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:59 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:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:59 INFO - Using real prefix '/usr' 03:46:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:02 INFO - Installing pip.................done. 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 03:47:02 INFO - 'HOME': '/home/cltbld', 03:47:02 INFO - 'LANG': 'en_US.UTF-8', 03:47:02 INFO - 'LANGUAGE': 'en_US:en', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MAIL': '/var/mail/cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SHLVL': '1', 03:47:02 INFO - 'TERM': 'linux', 03:47:02 INFO - 'TMOUT': '86400', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 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:47:02 INFO - Cleaning up... 03:47:02 INFO - Return code: 0 03:47:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:02 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 03:47:02 INFO - 'HOME': '/home/cltbld', 03:47:02 INFO - 'LANG': 'en_US.UTF-8', 03:47:02 INFO - 'LANGUAGE': 'en_US:en', 03:47:02 INFO - 'LOGNAME': 'cltbld', 03:47:02 INFO - 'MAIL': '/var/mail/cltbld', 03:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:02 INFO - 'MOZ_NO_REMOTE': '1', 03:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:02 INFO - 'NO_EM_RESTART': '1', 03:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:02 INFO - 'SHELL': '/bin/bash', 03:47:02 INFO - 'SHLVL': '1', 03:47:02 INFO - 'TERM': 'linux', 03:47:02 INFO - 'TMOUT': '86400', 03:47:02 INFO - 'USER': 'cltbld', 03:47:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:02 INFO - '_': '/tools/buildbot/bin/python'} 03:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:02 INFO - Downloading/unpacking psutil>=0.7.1 03:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:02 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:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:04 INFO - Installing collected packages: psutil 03:47:04 INFO - Running setup.py install for psutil 03:47:04 INFO - building 'psutil._psutil_linux' extension 03:47:04 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:47:05 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:47:05 INFO - building 'psutil._psutil_posix' extension 03:47:05 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:47:05 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:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:05 INFO - Successfully installed psutil 03:47:05 INFO - Cleaning up... 03:47:05 INFO - Return code: 0 03:47:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:05 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:05 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:47:05 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:47:05 INFO - Using env: {'DISPLAY': ':0', 03:47:05 INFO - 'HOME': '/home/cltbld', 03:47:05 INFO - 'LANG': 'en_US.UTF-8', 03:47:05 INFO - 'LANGUAGE': 'en_US:en', 03:47:05 INFO - 'LOGNAME': 'cltbld', 03:47:05 INFO - 'MAIL': '/var/mail/cltbld', 03:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:05 INFO - 'MOZ_NO_REMOTE': '1', 03:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:05 INFO - 'NO_EM_RESTART': '1', 03:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:05 INFO - 'SHELL': '/bin/bash', 03:47:05 INFO - 'SHLVL': '1', 03:47:05 INFO - 'TERM': 'linux', 03:47:05 INFO - 'TMOUT': '86400', 03:47:05 INFO - 'USER': 'cltbld', 03:47:05 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:05 INFO - '_': '/tools/buildbot/bin/python'} 03:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:05 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:47:05 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:47:05 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:47:05 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:47:05 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:47:05 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:47:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:07 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:47:07 INFO - Installing collected packages: mozsystemmonitor 03:47:07 INFO - Running setup.py install for mozsystemmonitor 03:47:07 INFO - Successfully installed mozsystemmonitor 03:47:07 INFO - Cleaning up... 03:47:07 INFO - Return code: 0 03:47:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:07 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:07 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:47:07 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:47:07 INFO - Using env: {'DISPLAY': ':0', 03:47:07 INFO - 'HOME': '/home/cltbld', 03:47:07 INFO - 'LANG': 'en_US.UTF-8', 03:47:07 INFO - 'LANGUAGE': 'en_US:en', 03:47:07 INFO - 'LOGNAME': 'cltbld', 03:47:07 INFO - 'MAIL': '/var/mail/cltbld', 03:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:07 INFO - 'MOZ_NO_REMOTE': '1', 03:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:07 INFO - 'NO_EM_RESTART': '1', 03:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:07 INFO - 'SHELL': '/bin/bash', 03:47:07 INFO - 'SHLVL': '1', 03:47:07 INFO - 'TERM': 'linux', 03:47:07 INFO - 'TMOUT': '86400', 03:47:07 INFO - 'USER': 'cltbld', 03:47:07 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:07 INFO - '_': '/tools/buildbot/bin/python'} 03:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:07 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:47:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:47:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:10 INFO - Downloading docopt-0.6.1.tar.gz 03:47:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:10 INFO - Running setup.py install for blobuploader 03:47:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:47:10 INFO - Running setup.py install for requests 03:47:10 INFO - Running setup.py install for docopt 03:47:10 INFO - Successfully installed blobuploader requests docopt 03:47:10 INFO - Cleaning up... 03:47:10 INFO - Return code: 0 03:47:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:10 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:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:10 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:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:10 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:10 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:47:10 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:47:10 INFO - Using env: {'DISPLAY': ':0', 03:47:10 INFO - 'HOME': '/home/cltbld', 03:47:10 INFO - 'LANG': 'en_US.UTF-8', 03:47:10 INFO - 'LANGUAGE': 'en_US:en', 03:47:10 INFO - 'LOGNAME': 'cltbld', 03:47:10 INFO - 'MAIL': '/var/mail/cltbld', 03:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:10 INFO - 'MOZ_NO_REMOTE': '1', 03:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:10 INFO - 'NO_EM_RESTART': '1', 03:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:10 INFO - 'SHELL': '/bin/bash', 03:47:10 INFO - 'SHLVL': '1', 03:47:10 INFO - 'TERM': 'linux', 03:47:10 INFO - 'TMOUT': '86400', 03:47:10 INFO - 'USER': 'cltbld', 03:47:10 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:10 INFO - '_': '/tools/buildbot/bin/python'} 03:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:11 INFO - Running setup.py (path:/tmp/pip-PsOpRq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:11 INFO - Running setup.py (path:/tmp/pip-iMyV58-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:11 INFO - Running setup.py (path:/tmp/pip-uz2yCm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:11 INFO - Running setup.py (path:/tmp/pip-Zz6_El-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:11 INFO - Running setup.py (path:/tmp/pip-eyOd66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:11 INFO - Running setup.py (path:/tmp/pip-PzS5bJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:11 INFO - Running setup.py (path:/tmp/pip-ciVfCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:11 INFO - Running setup.py (path:/tmp/pip-_Yv3oX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:11 INFO - Running setup.py (path:/tmp/pip-3KboNz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:11 INFO - Running setup.py (path:/tmp/pip-JP3FE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:11 INFO - Running setup.py (path:/tmp/pip-Zl4F1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:11 INFO - Running setup.py (path:/tmp/pip-70Ba0m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:11 INFO - Running setup.py (path:/tmp/pip-_aTwjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:11 INFO - Running setup.py (path:/tmp/pip-bLzjb1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:12 INFO - Running setup.py (path:/tmp/pip-jrQ4Wa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:12 INFO - Running setup.py (path:/tmp/pip-ZSlQMh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:12 INFO - Running setup.py (path:/tmp/pip-N5FiWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:12 INFO - Running setup.py install for manifestparser 03:47:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:47:12 INFO - Running setup.py install for mozcrash 03:47:12 INFO - Running setup.py install for mozdebug 03:47:12 INFO - Running setup.py install for mozdevice 03:47:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:47:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:47:12 INFO - Running setup.py install for mozfile 03:47:12 INFO - Running setup.py install for mozhttpd 03:47:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:47:12 INFO - Running setup.py install for mozinfo 03:47:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:47:12 INFO - Running setup.py install for mozInstall 03:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Running setup.py install for mozleak 03:47:13 INFO - Running setup.py install for mozlog 03:47:13 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Running setup.py install for moznetwork 03:47:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Running setup.py install for mozprocess 03:47:13 INFO - Running setup.py install for mozprofile 03:47:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Running setup.py install for mozrunner 03:47:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:47:13 INFO - Running setup.py install for mozscreenshot 03:47:13 INFO - Running setup.py install for moztest 03:47:13 INFO - Running setup.py install for mozversion 03:47:14 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:47:14 INFO - Cleaning up... 03:47:14 INFO - Return code: 0 03:47:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:14 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:14 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:47:14 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:47:14 INFO - Using env: {'DISPLAY': ':0', 03:47:14 INFO - 'HOME': '/home/cltbld', 03:47:14 INFO - 'LANG': 'en_US.UTF-8', 03:47:14 INFO - 'LANGUAGE': 'en_US:en', 03:47:14 INFO - 'LOGNAME': 'cltbld', 03:47:14 INFO - 'MAIL': '/var/mail/cltbld', 03:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:14 INFO - 'MOZ_NO_REMOTE': '1', 03:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:14 INFO - 'NO_EM_RESTART': '1', 03:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:14 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:14 INFO - 'SHELL': '/bin/bash', 03:47:14 INFO - 'SHLVL': '1', 03:47:14 INFO - 'TERM': 'linux', 03:47:14 INFO - 'TMOUT': '86400', 03:47:14 INFO - 'USER': 'cltbld', 03:47:14 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:14 INFO - '_': '/tools/buildbot/bin/python'} 03:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:14 INFO - Running setup.py (path:/tmp/pip-QUGvST-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:14 INFO - Running setup.py (path:/tmp/pip-lxwW4Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:14 INFO - Running setup.py (path:/tmp/pip-F8asqf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:14 INFO - Running setup.py (path:/tmp/pip-aN2jDE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:14 INFO - Running setup.py (path:/tmp/pip-Bu5BU8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:14 INFO - Running setup.py (path:/tmp/pip-SR8JUk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:14 INFO - Running setup.py (path:/tmp/pip-rVLJEc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:14 INFO - Running setup.py (path:/tmp/pip-49r4y2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:14 INFO - Running setup.py (path:/tmp/pip-saRv4q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:14 INFO - Running setup.py (path:/tmp/pip-RTuCRI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:47:14 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:47:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:14 INFO - Running setup.py (path:/tmp/pip-KGqdke-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:15 INFO - Running setup.py (path:/tmp/pip-g3JYwr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:15 INFO - Running setup.py (path:/tmp/pip-TRzAaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:15 INFO - Running setup.py (path:/tmp/pip-kVk1Ya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:15 INFO - Running setup.py (path:/tmp/pip-Se4cds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:15 INFO - Running setup.py (path:/tmp/pip-3eyyeb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:47:15 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:47:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:15 INFO - Running setup.py (path:/tmp/pip-OzUt6G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:47:15 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:47:15 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:47:15 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:47:15 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:47:15 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:47:15 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:47:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:17 INFO - Downloading blessings-1.6.tar.gz 03:47:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:47:17 INFO - Installing collected packages: blessings 03:47:17 INFO - Running setup.py install for blessings 03:47:17 INFO - Successfully installed blessings 03:47:17 INFO - Cleaning up... 03:47:17 INFO - Return code: 0 03:47:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:47:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:17 INFO - Reading from file tmpfile_stdout 03:47:17 INFO - Current package versions: 03:47:17 INFO - argparse == 1.2.1 03:47:17 INFO - blessings == 1.6 03:47:17 INFO - blobuploader == 1.2.4 03:47:17 INFO - docopt == 0.6.1 03:47:17 INFO - manifestparser == 1.1 03:47:17 INFO - mozInstall == 1.12 03:47:17 INFO - mozcrash == 0.16 03:47:17 INFO - mozdebug == 0.1 03:47:17 INFO - mozdevice == 0.47 03:47:17 INFO - mozfile == 1.2 03:47:17 INFO - mozhttpd == 0.7 03:47:17 INFO - mozinfo == 0.9 03:47:17 INFO - mozleak == 0.1 03:47:17 INFO - mozlog == 3.1 03:47:17 INFO - moznetwork == 0.27 03:47:17 INFO - mozprocess == 0.22 03:47:17 INFO - mozprofile == 0.27 03:47:17 INFO - mozrunner == 6.11 03:47:17 INFO - mozscreenshot == 0.1 03:47:17 INFO - mozsystemmonitor == 0.0 03:47:17 INFO - moztest == 0.7 03:47:17 INFO - mozversion == 1.4 03:47:17 INFO - psutil == 3.1.1 03:47:17 INFO - requests == 1.2.3 03:47:17 INFO - wsgiref == 0.1.2 03:47:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:17 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 03:47:17 INFO - 'HOME': '/home/cltbld', 03:47:17 INFO - 'LANG': 'en_US.UTF-8', 03:47:17 INFO - 'LANGUAGE': 'en_US:en', 03:47:17 INFO - 'LOGNAME': 'cltbld', 03:47:17 INFO - 'MAIL': '/var/mail/cltbld', 03:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:17 INFO - 'MOZ_NO_REMOTE': '1', 03:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:17 INFO - 'NO_EM_RESTART': '1', 03:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:17 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:17 INFO - 'SHELL': '/bin/bash', 03:47:17 INFO - 'SHLVL': '1', 03:47:17 INFO - 'TERM': 'linux', 03:47:17 INFO - 'TMOUT': '86400', 03:47:17 INFO - 'USER': 'cltbld', 03:47:17 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:17 INFO - '_': '/tools/buildbot/bin/python'} 03:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 INFO - Cleaning up... 03:47:17 INFO - Return code: 0 03:47:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:47: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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:17 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 03:47:17 INFO - 'HOME': '/home/cltbld', 03:47:17 INFO - 'LANG': 'en_US.UTF-8', 03:47:17 INFO - 'LANGUAGE': 'en_US:en', 03:47:17 INFO - 'LOGNAME': 'cltbld', 03:47:17 INFO - 'MAIL': '/var/mail/cltbld', 03:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:17 INFO - 'MOZ_NO_REMOTE': '1', 03:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:17 INFO - 'NO_EM_RESTART': '1', 03:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:17 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:17 INFO - 'SHELL': '/bin/bash', 03:47:17 INFO - 'SHLVL': '1', 03:47:17 INFO - 'TERM': 'linux', 03:47:17 INFO - 'TMOUT': '86400', 03:47:17 INFO - 'USER': 'cltbld', 03:47:17 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:17 INFO - '_': '/tools/buildbot/bin/python'} 03:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:18 INFO - Downloading/unpacking jsonschema 03:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:47:19 INFO - Downloading/unpacking functools32 (from jsonschema) 03:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:20 INFO - Downloading functools32-3.2.3-2.tar.gz 03:47:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:47:20 INFO - warning: no files found matching '*.txt' 03:47:20 INFO - no previously-included directories found matching 'build' 03:47:20 INFO - no previously-included directories found matching 'dist' 03:47:20 INFO - no previously-included directories found matching '.git*' 03:47:20 INFO - Installing collected packages: jsonschema, functools32 03:47:20 INFO - Running setup.py install for functools32 03:47:20 INFO - warning: no files found matching '*.txt' 03:47:20 INFO - no previously-included directories found matching 'build' 03:47:20 INFO - no previously-included directories found matching 'dist' 03:47:20 INFO - no previously-included directories found matching '.git*' 03:47:20 INFO - Successfully installed jsonschema functools32 03:47:20 INFO - Cleaning up... 03:47:20 INFO - Return code: 0 03:47:20 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:47: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:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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:47:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:20 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 0x7f93a2e92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x151a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15e8450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', '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:47:20 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:47:20 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:47:20 INFO - Using env: {'DISPLAY': ':0', 03:47:20 INFO - 'HOME': '/home/cltbld', 03:47:20 INFO - 'LANG': 'en_US.UTF-8', 03:47:20 INFO - 'LANGUAGE': 'en_US:en', 03:47:20 INFO - 'LOGNAME': 'cltbld', 03:47:20 INFO - 'MAIL': '/var/mail/cltbld', 03:47:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:20 INFO - 'MOZ_NO_REMOTE': '1', 03:47:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:20 INFO - 'NO_EM_RESTART': '1', 03:47:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:20 INFO - 'SHELL': '/bin/bash', 03:47:20 INFO - 'SHLVL': '1', 03:47:20 INFO - 'TERM': 'linux', 03:47:20 INFO - 'TMOUT': '86400', 03:47:20 INFO - 'USER': 'cltbld', 03:47:20 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:20 INFO - '_': '/tools/buildbot/bin/python'} 03:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:20 INFO - Downloading/unpacking flake8 03:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:20 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:47:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:47:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:47:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:22 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:47:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:23 INFO - no previously-included directories found matching 'docs/_build' 03:47:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:47:23 INFO - Running setup.py install for pep8 03:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:47:23 INFO - no previously-included directories found matching 'docs/_build' 03:47:23 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:47:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:47:23 INFO - Cleaning up... 03:47:23 INFO - Return code: 0 03:47:23 INFO - Running post-action listener: _resource_record_post_action 03:47:23 INFO - Running post-action listener: _start_resource_monitoring 03:47:23 INFO - Starting resource monitoring. 03:47:23 INFO - ##### 03:47:23 INFO - ##### Running install step. 03:47:23 INFO - ##### 03:47:23 INFO - Running pre-action listener: _resource_record_pre_action 03:47:23 INFO - Running main action method: install 03:47:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:47:23 INFO - Reading from file tmpfile_stdout 03:47:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:47:23 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:47:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:47:23 INFO - Reading from file tmpfile_stdout 03:47:23 INFO - Output received: 03:47:23 INFO - Usage: mozinstall [options] installer 03:47:23 INFO - Options: 03:47:23 INFO - -h, --help show this help message and exit 03:47:23 INFO - -d DEST, --destination=DEST 03:47:23 INFO - Directory to install application into. [default: 03:47:23 INFO - "/builds/slave/test-pgo"] 03:47:23 INFO - --app=APP Application being installed. [default: firefox] 03:47:23 INFO - mkdir: /builds/slave/test-pgo/build/application 03:47:23 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:47:23 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:38 INFO - Reading from file tmpfile_stdout 03:47:38 INFO - Output received: 03:47:38 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:47:38 INFO - Running post-action listener: _resource_record_post_action 03:47:38 INFO - ##### 03:47:38 INFO - ##### Running run-tests step. 03:47:38 INFO - ##### 03:47:38 INFO - Running pre-action listener: _resource_record_pre_action 03:47:38 INFO - Running main action method: run_tests 03:47:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:47:38 INFO - Python 2.7.3 03:47:38 INFO - Return code: 0 03:47:38 INFO - grabbing minidump binary from tooltool 03:47:38 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:38 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 0x167aa50>, '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 0x15e6550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e69e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:47:38 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:38 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:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:47:38 INFO - Return code: 0 03:47:38 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:47:38 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:47:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:47:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:47:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:47:39 INFO - Return code: 0 03:47:39 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-e10s', '--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-037', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:47:39 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-e10s --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-037 --webServer localhost 03:47:39 INFO - Using env: {'DISPLAY': ':0', 03:47:39 INFO - 'HOME': '/home/cltbld', 03:47:39 INFO - 'LANG': 'en_US.UTF-8', 03:47:39 INFO - 'LANGUAGE': 'en_US:en', 03:47:39 INFO - 'LOGNAME': 'cltbld', 03:47:39 INFO - 'MAIL': '/var/mail/cltbld', 03:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:39 INFO - 'MOZ_NO_REMOTE': '1', 03:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:47:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:39 INFO - 'NO_EM_RESTART': '1', 03:47:39 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:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:39 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:39 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:47:39 INFO - 'SHELL': '/bin/bash', 03:47:39 INFO - 'SHLVL': '1', 03:47:39 INFO - 'TERM': 'linux', 03:47:39 INFO - 'TMOUT': '86400', 03:47:39 INFO - 'USER': 'cltbld', 03:47:39 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743', 03:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:39 INFO - '_': '/tools/buildbot/bin/python'} 03:47:39 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-e10s', '--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-037', '--webServer', 'localhost'] with output_timeout 3600 03:47:39 INFO - mozversion INFO | application_buildid: 20160125001712 03:47:39 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:39 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:47:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:47:39 INFO - mozversion INFO | application_name: Firefox 03:47:39 INFO - mozversion INFO | application_remotingname: firefox-dev 03:47:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:39 INFO - mozversion INFO | application_vendor: Mozilla 03:47:39 INFO - mozversion INFO | application_version: 45.0a2 03:47:39 INFO - mozversion INFO | platform_buildid: 20160125001712 03:47:39 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:47:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:47:39 INFO - mozversion INFO | platform_version: 45.0a2 03:47:39 INFO - 2016-01-25 03:47:39,649 DEBUG : using testdate: 1453722459 03:47:39 INFO - 2016-01-25 03:47:39,649 DEBUG : actual date: 1453722459 03:47:39 INFO - 2016-01-25 03:47:39,657 INFO : starting webserver on 'localhost:33214' 03:47:39 INFO - 2016-01-25 03:47:39,658 INFO : Starting test suite talos-linux64-ix-037.e 03:47:39 INFO - 2016-01-25 03:47:39,659 INFO : Starting test dromaeo_css 03:47:39 INFO - 2016-01-25 03:47:39,659 DEBUG : operating with platform_type : linux_ 03:47:39 INFO - 2016-01-25 03:47:39,659 INFO : Initialising browser for dromaeo_css test... 03:47:39 INFO - 2016-01-25 03:47:39,674 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpErSTes/profile http://localhost:33214/getInfo.html 03:47:43 INFO - 2016-01-25 03:47:43,287 DEBUG : BROWSER_OUTPUT: 03:47:43 INFO - 2016-01-25 03:47:43,288 DEBUG : BROWSER_OUTPUT: (process:6570): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:44 INFO - 2016-01-25 03:47:44,312 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:47:44 INFO - 2016-01-25 03:47:44,313 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:47:44 INFO - 2016-01-25 03:47:44,313 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:47:44 INFO - 2016-01-25 03:47:44,313 DEBUG : BROWSER_OUTPUT: __metrics 03:47:45 INFO - 2016-01-25 03:47:45,285 INFO : Browser initialized. 03:47:45 INFO - 2016-01-25 03:47:45,286 INFO : Running cycle 1/1 for dromaeo_css test... 03:47:45 INFO - 2016-01-25 03:47:45,286 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpErSTes/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:47:46 INFO - 2016-01-25 03:47:46,582 DEBUG : BROWSER_OUTPUT: 03:47:46 INFO - 2016-01-25 03:47:46,582 DEBUG : BROWSER_OUTPUT: (process:6684): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:57 INFO - 2016-01-25 03:47:57,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 138313728 03:47:57 INFO - 2016-01-25 03:47:57,089 DEBUG : BROWSER_OUTPUT: 03:48:46 INFO - 2016-01-25 03:48:46,726 DEBUG : BROWSER_OUTPUT: 1453722526722 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:55 INFO - 2016-01-25 03:50:55,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33214/tests/dromaeo/cssquery-ext.html) 03:50:56 INFO - 2016-01-25 03:50:56,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 140378112 03:50:56 INFO - 2016-01-25 03:50:56,144 DEBUG : BROWSER_OUTPUT: 03:53:57 INFO - 2016-01-25 03:53:57,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-ext.html (next: http://localhost:33214/tests/dromaeo/cssquery-jquery.html) 03:53:58 INFO - 2016-01-25 03:53:58,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 03:53:58 INFO - 2016-01-25 03:53:58,528 DEBUG : BROWSER_OUTPUT: 03:57:00 INFO - 2016-01-25 03:57:00,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33214/tests/dromaeo/cssquery-mootools.html) 03:57:00 INFO - 2016-01-25 03:57:00,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 138407936 03:57:00 INFO - 2016-01-25 03:57:00,731 DEBUG : BROWSER_OUTPUT: 04:00:02 INFO - 2016-01-25 04:00:02,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33214/tests/dromaeo/cssquery-prototype.html) 04:00:02 INFO - 2016-01-25 04:00:02,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 04:00:02 INFO - 2016-01-25 04:00:02,895 DEBUG : BROWSER_OUTPUT: 04:03:05 INFO - 2016-01-25 04:03:05,155 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33214/tests/dromaeo/cssquery-yui.html) 04:03:05 INFO - 2016-01-25 04:03:05,748 DEBUG : BROWSER_OUTPUT: RSS: Main: 138874880 04:03:05 INFO - 2016-01-25 04:03:05,748 DEBUG : BROWSER_OUTPUT: 04:06:07 INFO - 2016-01-25 04:06:07,875 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/dromaeo/cssquery-yui.html (next: http://localhost:33214/tests/dromaeo/cssquery-dojo.html) 04:06:08 INFO - 2016-01-25 04:06:08,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 142053376 04:06:08 INFO - 2016-01-25 04:06:08,125 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,127 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:08 INFO - 2016-01-25 04:06:08,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:08 INFO - 2016-01-25 04:06:08,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:08 INFO - 2016-01-25 04:06:08,127 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:08 INFO - 2016-01-25 04:06:08,129 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3371.7302615790736;3394.253264281857;3394.6435624259466;3427.41733905236;3431.19366948767;5530.917036244459;5542.057850165472;5560.6663600183965;5561.833145005646;5565.30433695788;5533.391326954032;5533.972330138344;5542.334919809628;5554.055810512213;5599.944000559994;5066.594672426216;5096.235564665293;5173.974130129344;5179.4561571035065;5181.300524429192;5026.5727413169925;5145.073886700392;5157.71632560209;5161.148410512261;5265.947340526584;5134.358205224347;5211.114110601188;5246.842594722164;5247.606429517782;5249.448807875176;5160.896782064357;5267.789288428458;5279;5281.392639846428;5318.5213330800025;5008;5030.3963524377305;5062.291279220912;5153.330067091291;5168.948310516922;5460.726963651841;5462.890742185134;5481.698506582136;5500.532454741352;5542.4457554244655;6049.062395328731;6069.15031895535;6088.604240724383;6116.48009919153;6175.505959523227;5663.89554036963;5759.913601295984;6032.396760323976;6120.569035656853;6209.223847019122;5739.368669446358;5743.62666426681;5744.597878148531;5749.798757043567;5750.626209296424;6161.691915404302;6219.942609756352;6223.315435302113;6233.0338797486465;6234.2830574483605;5805.245318108618;5886.499647529922;5889.234399528034;5952.9107063394085;5980.102984552265;6075.483583895419;6144.938550614526;6173.41352571505;6195.16365290689;6195.845103872439;5886.823395298148;6048.818535443944;6158.137860699506;6164.198654174928;6174.135621013062;5974.133750606225;6080.726367313481;6167.660778657128;6172.969135154385;6175.3824617538785;4672.971946171905;4677.134730074947;4677.742724150205;4680.719156850531;4748.382710247645;4111.794410279534;4209.810558524874;4234.87295381139;4238.87283381499;4269.274223382033;5798.623089499169;5865.178874957509;5872.207252021008;5891.057430811135;5926.377730338339;6056.757729690763;6063.484603808725;6094.268687757498;6115.908261376083;6125.632462052291;5573.108302671553;5682.40334764852;5704.229928959538;5785.595008349459;5787.913181302284;5250.842474725764;5301.655392399482;5311.548518375904;5325.840224793263;5340.49265319794;6244.843878903063;6281.497480201573;6283.560150789401;6285.528585356116;6291;5909.763609455574;5946.970265148647;5984.551158663031;6097.298810636834;6125.081237814364;6187.348600254654;6339.2392912850755;6371.267304259884;6377.521685873486;6378.425941665272;6088.299845517645;6097.237845269341;6101.2068431105445;6102.359252278447;6110.26676798787;5920.200772895604;5982.282126144891;6061.090836374579;6074.757009719739;6095.969520152371;6019.969900150471;6040.36576159497;6042.123892035718;6043.728032238472;6059.666718330358;5675.858103547444;6021.939780602138;6025.156478092983;6060.333363330118;6062.696865156637;5729.914051289151;5743.052396354722;5779.422057794355;5818.301803783573;5865.94134058654;5822.330432000204;5871.207387002871;5892.823215303548;5902.203202567598;6039.124326972476;5568.331800184003;5711.314642242957;5753.942460575508;5765.798197063083;5793.420657934173 04:06:08 INFO - 2016-01-25 04:06:08,132 DEBUG : BROWSER_OUTPUT: |1;ext.html;563.6702529020523;604.0637012630423;611.2145892528102;653.7940548727148;686.5708931917549;31496.68503314966;40755;41037.17925641493;41140.38289425661;41328.79335603325;44827;45159.322610160794;45375;45455.54544454555;45506.317405238864;9121.771955701111;9208.12522810332;9259.444433333987;9310.86033709495;9328.533573321307;9061.682841100563;9129.817403651923;9159.35884488086;9187.816243675123;9235.492047937361;9088.136627020422;9109.544522773835;9128.041555636662;9152.633894644207;9152.725418237464;9117.772055698595;9121.726348209564;9190.126937940884;9198.494082825442;9204.493752843591;9104.544772761401;9180;9188.127127922837;9197.770055748593;9205.217556507705;41081.1783764326;41489.377659335136;41632;41685.79157104225;41712;3624.746267761258;3740.756850804689;3792.089898424386;3865.4781604483314;4131.855385061508;32023;32206.677933220835;32285;32333.838330808194;33315.6668433315;3621.94567081494;3693.0582701410967;3724.1434470071763;3779.2063666630042;3801.486799282089;274892;274970;275468;276144.6192769043;276415;61001.38998610046;61249.38750612526;61491.07763383553;61509.384906150364;61519.6924015386;64250;64259;64370.0344494833;64658.353416466176;64735.35264647293;16162.191890405433;16540.75188872168;16551.172441377883;16557.503274901774;16597.91701041487;12568.434420451102;12598.685032874251;12632.621021369374;12685.429155688016;12725.427355769012;20332.59334813325;20782.27262045821;20793.688094678593;20807.895960520404;20863.47841303949;7833.725819596287;8063.556504392314;8125.06561745395;8171.468854524437;8270.627821748036;1020.505055048301;1043.9425831579335;1053.5048527192207;1153.5847095045776;1219.7987332090283;30216.84891575572;30275.848620757195;30944.69055309418;31403.68596314053;33508.32983340319;1105.950232239551;1115.3921112993437;1119.9496022679;1131.6322195286564;1132.881047490018;14638.853611463963;15223.847761522464;15242.847571524364;15308.69876060525;15615.297311621005;534541;535263;538567;539180;544231;57831;58488.41511584915;58728.11907821386;58742.706286468296;58835.11747323794;1418.6169734171715;1418.7659036259108;1419.5102689572082;1423.4662001749343;1457.4461704552202;30482.84758576193;31532.211694707818;31950;32436.35127297488;34194.48708269428;54345.72827135839;55408;55454;55504.167437489275;55830.162547561005;316143;317844;318885;319225;321211;44291.199904746405;44382;45472.31791523196;45680.31479527876;45695.543044570455;48887.266691000375;49343;49672.25491617557;49841.25238121504;50311.49688503068;42008.36987445252;42349.36475952801;43076;43519.78240108779;43563.34654980241;41751.1649767009;42055;42080.78959605182;42456;42546.361804572334;41052.58947410607;41338.379924301764;41588.79205603953;41938;41959.58040419557;36050.27899441944;36255.27489450249;39387.80306098451;39715;40101.1979760409;26436;27092.187234383;27335.58996615092;27353;28635.565976892198 04:06:08 INFO - 2016-01-25 04:06:08,134 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.0252008638016;385.8090245328561;388.99611003889953;389.60844351426823;390.69916164553297;16241.593960151002;17276.568085797844;17814.465566033006;18833.905830470845;18937.147828347723;10519.63181288655;17102.230399632015;17218.913905430454;17236.827631723678;17930.551736206602;5230.450802665713;5269.6311258211745;5763.769449222026;5831.4751672349485;5832.358440571534;5281.6830990140525;5411.458854114597;5462.9726851365685;5726.3987281335485;5739.942600574003;5382.354117505885;5410.08028635133;5425.26758887551;5435.157550579666;5439.075357189287;5651.717414129277;5656.2929633795775;5675.914861277084;5685.715714214293;5690.06113991191;5426.591791969078;5459.481349271813;5490.56075513958;5498.395176530578;5576.553875689976;13054.216746995211;13151.736965260738;13302.600921972356;13311;13788.862111378858;2222.555488902226;2287.199480181923;2292.197730794225;2306.561753266874;2336.556054349668;10132.848007279898;10154.89845101547;10224.897751022469;10358.53386597605;10405.063544280976;1893.829555340026;1900.781410137838;1916.6741653918866;1952.5997170579997;1968.5964377302619;64112.679436602986;64881;65681.67159164221;67238.66380668065;67266;10610.41642709643;11040.779184416268;11220.831687524693;11284.548618055185;11344.716382090513;13838;13931.58205253844;14014.71970560583;14025.228612426414;14076;7745.961270193726;7789.5715735635085;7790;8043.798905027421;8100.635471403801;7434.070741157356;7666.65500052499;7674.270944260286;7738.4969976951315;7799.1031031430975;4611.377464042378;4630.351750754897;4702.882427939329;4713.104510143062;4865.12427762999;1907.7774392832196;1931.3433432632971;1946.6593346164364;1987.8509111816381;2004.0080160320442;893.2005854760083;948.2366694810744;970.6263088710897;979.7648564344648;993.1310103659298;17114.354552876317;17851.375201868133;18000;18084;18486.537836554195;951.9428834269966;1048.9527971241312;1069.13934282903;1080.6920027792198;1139.128566646516;9772.315937884421;10267.127294179929;10277.794444111225;10313.22650801178;10342.5345859435;649220;650015;655682;677405;689436;85535.57232213799;86501.56749216339;87895.56052219697;88520;89222.55388723145;1205.873383294759;1225.3383173086434;1233.210745123122;1242.031215651793;1246.22111180514;16614.335426583286;16766.66466670684;16810.915945420194;16857.325706971584;17252.913735431244;38635.6136438632;38679.6132038676;38699.806500967316;38741.806290968365;38990.6100938987;46118.077638447714;46238.306425402974;48184.27723584219;50515.24227136523;51085;9688.806223875625;10106.848397274194;10116.08955194036;10136.391816491034;10591.735206619896;16549.751753723463;17439.215235314186;17949.371771987917;17957.551061223574;18360.90819545894;15490.225488725744;15504.689906202038;15575.143367114917;15595.922020389826;15818.655414289915;14906.776398353817;15003.549893503212;16033.438829640907;16074.598135046717;16515.33938642441;15523.922380388025;16026.118563478654;16509.009459432473;16887.831121688625;16982.320707172068;10319.638812641522;10443.530041148015;10558.630447934285;10749.570017199225;10854;14639.121652700873;15157.282659193448;15918.28367723432;16175.838241617905;16389.344426223295 04:06:08 INFO - 2016-01-25 04:06:08,135 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1491.4108926973852;1497;1687.232309299269;1807.900565468899;1853.388381833995;7043.964780176098;7270.38201752851;7295.416366690659;7599.886001709965;7800.453968222227;7492.36314913233;7540.84918301635;7622.047244094489;7626.809329766758;7638.12161601416;2264.071730590458;2292.197730794217;2302.7812357826065;2304.873231972241;2311.6070268054386;2244.5735310291075;2288;2296.7243930728337;2297.1615360393503;2304.0553373117027;2234.530748542808;2244.618414869476;2248.9887550562225;2274.4768703198274;2277.6925115109416;2201.1195521791333;2260.6609008648834;2276.1236923784463;2281.7718228177214;2282.6119559674894;2296.644020176875;2323.686302349195;2330.953380932389;2331.265651319829;2337.649352597107;7702.961485192594;7726.420518461138;7727.574983375912;7759.418043646749;7762.573058481781;4635.304704294349;4680.976595117037;4690.0854333405;4700.811967521295;4704.294355846616;2922.9853850730824;2980.4039192161435;3025.8789648414036;3045.604071470717;3046.1014000869795;956.526519372908;975.2393133355994;988.4267125067444;991.1476130527741;1007.7531004903846;10161.644342448053;10216.080552750214;10243.334183278062;10244.436555989418;10302.845457318146;3857.2092720992127;3913.5695073541888;3974.6422821945584;4039.7374170678813;4040.7575545467366;8078.151794061539;8084.595770211584;8114;8124.796880078045;8130;4457.598816106566;4458.6878918475395;4458.8439404620685;4468.419105516327;4486.102779444059;4127.607877251657;4133.8966525837095;4148.357004664282;4168.083021735213;4172.874813755531;3372.578427696538;3372.7470439717117;3375.932481350359;3392.135005573563;3395.5416018837636;1023.948802559869;1024.114141267798;1027.8304079826744;1037.7650595791135;1038.413296487482;1085.907697845692;1098.6868742408535;1139.7378602921374;1307.6469353274563;1386.3761307411705;6869.381755641916;6943.132108486439;6961.825954351182;6966.442684585221;7061.399781018671;1152.6772503698978;1161.872194058653;1169.1231576317762;1169.590643274847;1173.1260211142753;5426.375966763872;5450.5367043801725;5493.7802487900035;5499.230107784913;5502.779888804403;8778;8900.42147260426;9133;9280.489573073546;9331.393459425115;9123.133302336268;9138.63445462174;9152.679656212;9179.908200917906;9207.493587852598;7040.894386584103;7168.605726684978;7184.820379490555;7208.531445455924;7252.456065795086;7004.439644828503;7030.824229394306;7033.613151276729;7039.929600704132;7053.576785392893;8122.796930076559;8238.50568965864;8280.627371768165;8350.206730360605;8381.664733410838;8269.46248493846;8312.83374332522;8383.28742056932;8387.119352468148;8397.118302578385;6702.329767023259;6753.459723222032;6755.459563234831;6764.526483146133;6782.355676210752;7319.268073192638;7320.121585409572;7352.5220860643885;7375.889361659472;7378.188399275968;6422.903656445251;6908.274631163656;6921.169459664872;7058.71765129389;7084.681189346388;6798.150231221098;6834.214065382345;6863.416609588241;6877.518573699793;6903.102596662402;6756.358145976124;6756.527043106936;6767.086443330088;6838.179418469816;6848.6918088687125;6129.1112788644505;6164.568480206342;6176.66028368444;6184.5980011299125;6188.535859810622;6318.526110541819;6329.525285603506;6398.93601064002;6446.9032964506505;6454.935450645621 04:06:08 INFO - 2016-01-25 04:06:08,138 DEBUG : BROWSER_OUTPUT: |4;prototype.html;353.3198592709035;362.1507564760635;364.42057129164624;366.287570675037;368.022899202617;6331.620102793836;6480.9675951620175;6483.773067942617;6539.901901471481;6582.539222254438;6288.276848162463;6418.358164183591;6421.582597131183;6423.582467139633;6448.613083214998;4888.682235654671;4892.412910450751;4893.584045356149;4898.608111351084;4899.6815207011605;4881.1213981483315;4907.75461226939;4908.337374454457;4913.754312284372;4922;4647.790849411785;4816.229403295473;4823.614110871139;4824.107540105092;4826.638002149835;4806.567408933195;4807.879803004917;4808.951910480921;4811.855644330658;4831.985283090556;4190.20386126635;4202.117555313388;4213.620774130343;4216.2832318505625;4227.471566054243;6056;6162.383761623847;6170;6172.87654246917;6208.286047104551;5640.069388550925;5660.745266463019;5666.688332141731;5687.118496633028;5688.63023903445;6829.795106146824;6842.4183944364295;6843.794686159423;6845.110135682379;6854.828629284258;4670.719756814568;4694.718316900997;4701.200795864711;4705.600023997964;4705.670603057787;6911.963205519162;7041.4718896082995;7119.786406407816;7126.928730712731;7132.072830531998;4731.976340118277;4751.976240118777;4755.738434386073;4758.143534163814;4761.309610106515;4818;4821;4828.020511590231;4831.154547954094;4837.733924634179;5513.972430137904;5633.014222511126;5635.520980716685;5643.915341269884;5656.943430565724;6890.517663763489;6927.7228910843005;6936.375726184668;6936.687849046805;6938.06336144614;1649.736042233237;1710.2474911039103;1711.537884771105;1713.3746182643245;1715.1424287856073;1114.6767437443214;1126.594426006637;1131.4003578103618;1140.4753813245834;1147.1109889835445;6639.535232533676;6640.701168447432;6652.334766523406;6656.966715166393;6662.333766623396;7048.682809273595;7051.048108505286;7066.293370662996;7078.433725301964;7086.433085353159;6516.0877477153235;6523.804285871432;6614.404703576605;6618.338166183439;6639.435647969976;3797.5442946846556;3829.751066180689;3830.367989281793;3840.02079469739;3854.9229015419533;7297.525660832029;7301.379382752525;7321.487495875344;7338.669759860819;7338.853222935618;7099.787006389816;7221.061262036007;7242.203357630657;7255.165655949528;7260.9636951815955;7325.267473252632;7328.926710732824;7329.963350183215;7332.156801967842;7344.265573442613;7035.577865328097;7046.541974771623;7070;7092.432605391659;7096.077509923677;6800.387965083166;6915.965420173068;6940.965295173693;6965.164180298397;6965.44276457872;7171.641417929187;7241.818954526179;7276.927230727837;7279.781606551812;7283.162436319679;4771.06964141989;4801.68789028712;4810.39870016248;4819.373481447389;4829.106615276185;6957.304269573002;7062.15254169503;7104.147502299757;7119.394851437686;7225.169105552929;6981.616011119438;7032.929670703432;7034.753783617549;7039.225685174524;7063.505554611128;7015.263397343206;7030.964845175741;7037.612931288828;7037.612931288828;7040.3663670269925;6755.121834161528;6815.89776153368;6885.931140688729;6915.550489218184;6923.376896079377;7043.36609705129;7058.576485410892;7060.293970602898;7061.470389720895;7086.433085353056;6750.966245168743;6867.690953907186;6873.965630172017;6882.7591034313555;6886.173659160932 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: |5;yui.html;869.1178453869323;879.7932485865822;886.3573908916037;893.3924931046889;901.8557030875053;14864.628384290398;16352.83647163528;16540.83459165408;16549.91725041373;16619.169041547935;14614.926925365386;14638.634034149152;14665.340059697313;14673.633159171026;14696.632584185401;895.0244233785173;909.05912380686;913.1963871792847;917.513717729601;917.7063339731288;905.6105874473974;910.2490445382585;912.6760000199934;914.0356923445762;915.5605309451468;948.426202147701;951.70497145885;954.0602506531061;954.1984732824426;957.3059531839396;936.0218571592668;945.9243260539175;950.5484894675043;951.3673407184215;955.3360414511917;706.099722853361;708.2138825903244;708.8192510909737;710.8400609862739;711.7081996381459;13135.802962955564;13338.266395348252;13346.13250138738;13375.531856385078;13394.129381590166;12622.431990560355;12827.743445131046;12903.290319032449;13343;13543.741534539056;10507.474626268657;11233.887661123448;11249.100071994302;11304.208705390625;11306.095512358992;3808.447775072627;3852.2295540891932;3880;3890.1636148228267;3895.045713800109;46217;46810.765946170395;46878.06243875103;48036.51963480355;48364;10631.362118272928;10656.733581660521;10730.409827459409;10936.343819370863;10942.945285273523;18512.444626660952;18517.07414629263;18616.720749188775;18723.531911702317;18864.622707545772;8209;8242;8243;8386.119457457002;8691.435056721293;4636.142313671981;4811.663183577116;4852.611791056777;4928.8767780805765;4985.277134815431;3197.8880739174483;3222.2910959588853;3226.161198088467;3227.160938156096;3236.773425860167;593.7357875745251;599.1731410653358;600.3696119074954;602.9960116406222;613.6318209074519;699.1295836683261;727.8435136445584;736.8047467421138;739.737393225408;741.2476336518438;8683;8889.688860889837;8949.284057275532;8975.50634715097;9082.40964337316;657.7303305644663;720.5604581205461;724.3082855872628;744.9627518624047;785.3206975965862;4112.424260603518;4121;4180.28935081037;4258.127083947783;4284.293091639907;60042.39957600455;60454.09318860221;60581;60691;61009.389906101256;52672;52944.47055529473;53557.46442535525;54073.1889021665;54474;48439.75780121077;48771;49111.26333105078;50538;50617.24074138891;8515.787105322417;8517.74446766598;8548.230659240699;9007.954960225157;9082.273418126666;35836.283274333844;36800.815995919846;36857.81571092128;37036.81481592575;37555.436668450544;46245.53754462412;46538;46897.296540552605;47281.29078063901;48854;10655.680329590125;10790;10797.082248009006;11178.329300242012;11300.886991130312;13484;13493.460261589427;13598.456061757419;13646.590602281947;14382.568522944328;11631.243969141979;11913.940430297793;11953.820692689791;12039.578614748441;12450.377481126088;10309.381437113498;10914.454277286262;11379.54481820751;11569.479373428048;11575.01612362925;11458.71353216143;11489.023433008288;11599.536018559163;11803.881961180277;11972.281663100242;10550.577976880839;10563.63027294041;10627.25609207379;10773.353598783784;10990.450477476254;9782.119609235204;9821.558029888814;10049.497525123861;10054.396736195851;10199.031092046243 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,306 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723568126__endTimestamp 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:08 INFO - 2016-01-25 04:06:08,139 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5641.78 Median:5805.25 stddev:624.40 (10.8%) stddev-sans-first:600.38 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: Values: 3371.7 3394.3 3394.6 3427.4 3431.2 5530.9 5542.1 5560.7 5561.8 5565.3 5533.4 5534.0 5542.3 5554.1 5599.9 5066.6 5096.2 5174.0 5179.5 5181.3 5026.6 5145.1 5157.7 5161.1 5265.9 5134.4 5211.1 5246.8 5247.6 5249.4 5160.9 5267.8 5279.0 5281.4 5318.5 5008.0 5030.4 5062.3 5153.3 5168.9 5460.7 5462.9 5481.7 5500.5 5542.4 6049.1 6069.2 6088.6 6116.5 6175.5 5663.9 5759.9 6032.4 6120.6 6209.2 5739.4 5743.6 5744.6 5749.8 5750.6 6161.7 6219.9 6223.3 6233.0 6234.3 5805.2 5886.5 5889.2 5952.9 5980.1 6075.5 6144.9 6173.4 6195.2 6195.8 5886.8 6048.8 6158.1 6164.2 6174.1 5974.1 6080.7 6167.7 6173.0 6175.4 4673.0 4677.1 4677.7 4680.7 4748.4 4111.8 4209.8 4234.9 4238.9 4269.3 5798.6 5865.2 5872.2 5891.1 5926.4 6056.8 6063.5 6094.3 6115.9 6125.6 5573.1 5682.4 5704.2 5785.6 5787.9 5250.8 5301.7 5311.5 5325.8 5340.5 6244.8 6281.5 6283.6 6285.5 6291.0 5909.8 5947.0 5984.6 6097.3 6125.1 6187.3 6339.2 6371.3 6377.5 6378.4 6088.3 6097.2 6101.2 6102.4 6110.3 5920.2 5982.3 6061.1 6074.8 6096.0 6020.0 6040.4 6042.1 6043.7 6059.7 5675.9 6021.9 6025.2 6060.3 6062.7 5729.9 5743.1 5779.4 5818.3 5865.9 5822.3 5871.2 5892.8 5902.2 6039.1 5568.3 5711.3 5753.9 5765.8 5793.4 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55885.38 Median:41658.90 stddev:104555.69 (251.0%) stddev-sans-first:104766.49 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: Values: 563.7 604.1 611.2 653.8 686.6 31496.7 40755.0 41037.2 41140.4 41328.8 44827.0 45159.3 45375.0 45455.5 45506.3 9121.8 9208.1 9259.4 9310.9 9328.5 9061.7 9129.8 9159.4 9187.8 9235.5 9088.1 9109.5 9128.0 9152.6 9152.7 9117.8 9121.7 9190.1 9198.5 9204.5 9104.5 9180.0 9188.1 9197.8 9205.2 41081.2 41489.4 41632.0 41685.8 41712.0 3624.7 3740.8 3792.1 3865.5 4131.9 32023.0 32206.7 32285.0 32333.8 33315.7 3621.9 3693.1 3724.1 3779.2 3801.5 274892.0 274970.0 275468.0 276144.6 276415.0 61001.4 61249.4 61491.1 61509.4 61519.7 64250.0 64259.0 64370.0 64658.4 64735.4 16162.2 16540.8 16551.2 16557.5 16597.9 12568.4 12598.7 12632.6 12685.4 12725.4 20332.6 20782.3 20793.7 20807.9 20863.5 7833.7 8063.6 8125.1 8171.5 8270.6 1020.5 1043.9 1053.5 1153.6 1219.8 30216.8 30275.8 30944.7 31403.7 33508.3 1106.0 1115.4 1119.9 1131.6 1132.9 14638.9 15223.8 15242.8 15308.7 15615.3 534541.0 535263.0 538567.0 539180.0 544231.0 57831.0 58488.4 58728.1 58742.7 58835.1 1418.6 1418.8 1419.5 1423.5 1457.4 30482.8 31532.2 31950.0 32436.4 34194.5 54345.7 55408.0 55454.0 55504.2 55830.2 316143.0 317844.0 318885.0 319225.0 321211.0 44291.2 44382.0 45472.3 45680.3 45695.5 48887.3 49343.0 49672.3 49841.3 50311.5 42008.4 42349.4 43076.0 43519.8 43563.3 41751.2 42055.0 42080.8 42456.0 42546.4 41052.6 41338.4 41588.8 41938.0 41959.6 36050.3 36255.3 39387.8 39715.0 40101.2 26436.0 27092.2 27335.6 27353.0 28635.6 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33105.70 Median:1924.01 stddev:108540.09 (5641.4%) stddev-sans-first:108816.76 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: Values: 383.0 385.8 389.0 389.6 390.7 16241.6 17276.6 17814.5 18833.9 18937.1 10519.6 17102.2 17218.9 17236.8 17930.6 5230.5 5269.6 5763.8 5831.5 5832.4 5281.7 5411.5 5463.0 5726.4 5739.9 5382.4 5410.1 5425.3 5435.2 5439.1 5651.7 5656.3 5675.9 5685.7 5690.1 5426.6 5459.5 5490.6 5498.4 5576.6 13054.2 13151.7 13302.6 13311.0 13788.9 2222.6 2287.2 2292.2 2306.6 2336.6 10132.8 10154.9 10224.9 10358.5 10405.1 1893.8 1900.8 1916.7 1952.6 1968.6 64112.7 64881.0 65681.7 67238.7 67266.0 10610.4 11040.8 11220.8 11284.5 11344.7 13838.0 13931.6 14014.7 14025.2 14076.0 7746.0 7789.6 7790.0 8043.8 8100.6 7434.1 7666.7 7674.3 7738.5 7799.1 4611.4 4630.4 4702.9 4713.1 4865.1 1907.8 1931.3 1946.7 1987.9 2004.0 893.2 948.2 970.6 979.8 993.1 17114.4 17851.4 18000.0 18084.0 18486.5 951.9 1049.0 1069.1 1080.7 1139.1 9772.3 10267.1 10277.8 10313.2 10342.5 649220.0 650015.0 655682.0 677405.0 689436.0 85535.6 86501.6 87895.6 88520.0 89222.6 1205.9 1225.3 1233.2 1242.0 1246.2 16614.3 16766.7 16810.9 16857.3 17252.9 38635.6 38679.6 38699.8 38741.8 38990.6 46118.1 46238.3 48184.3 50515.2 51085.0 9688.8 10106.8 10116.1 10136.4 10591.7 16549.8 17439.2 17949.4 17957.6 18360.9 15490.2 15504.7 15575.1 15595.9 15818.7 14906.8 15003.5 16033.4 16074.6 16515.3 15523.9 16026.1 16509.0 16887.8 16982.3 10319.6 10443.5 10558.6 10749.6 10854.0 14639.1 15157.3 15918.3 16175.8 16389.3 04:06:08 INFO - 2016-01-25 04:06:08,140 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,141 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5302.20 Median:6253.53 stddev:2708.55 (43.3%) stddev-sans-first:2701.00 04:06:08 INFO - 2016-01-25 04:06:08,142 DEBUG : BROWSER_OUTPUT: Values: 1491.4 1497.0 1687.2 1807.9 1853.4 7044.0 7270.4 7295.4 7599.9 7800.5 7492.4 7540.8 7622.0 7626.8 7638.1 2264.1 2292.2 2302.8 2304.9 2311.6 2244.6 2288.0 2296.7 2297.2 2304.1 2234.5 2244.6 2249.0 2274.5 2277.7 2201.1 2260.7 2276.1 2281.8 2282.6 2296.6 2323.7 2331.0 2331.3 2337.6 7703.0 7726.4 7727.6 7759.4 7762.6 4635.3 4681.0 4690.1 4700.8 4704.3 2923.0 2980.4 3025.9 3045.6 3046.1 956.5 975.2 988.4 991.1 1007.8 10161.6 10216.1 10243.3 10244.4 10302.8 3857.2 3913.6 3974.6 4039.7 4040.8 8078.2 8084.6 8114.0 8124.8 8130.0 4457.6 4458.7 4458.8 4468.4 4486.1 4127.6 4133.9 4148.4 4168.1 4172.9 3372.6 3372.7 3375.9 3392.1 3395.5 1023.9 1024.1 1027.8 1037.8 1038.4 1085.9 1098.7 1139.7 1307.6 1386.4 6869.4 6943.1 6961.8 6966.4 7061.4 1152.7 1161.9 1169.1 1169.6 1173.1 5426.4 5450.5 5493.8 5499.2 5502.8 8778.0 8900.4 9133.0 9280.5 9331.4 9123.1 9138.6 9152.7 9179.9 9207.5 7040.9 7168.6 7184.8 7208.5 7252.5 7004.4 7030.8 7033.6 7039.9 7053.6 8122.8 8238.5 8280.6 8350.2 8381.7 8269.5 8312.8 8383.3 8387.1 8397.1 6702.3 6753.5 6755.5 6764.5 6782.4 7319.3 7320.1 7352.5 7375.9 7378.2 6422.9 6908.3 6921.2 7058.7 7084.7 6798.2 6834.2 6863.4 6877.5 6903.1 6756.4 6756.5 6767.1 6838.2 6848.7 6129.1 6164.6 6176.7 6184.6 6188.5 6318.5 6329.5 6398.9 6446.9 6454.9 04:06:08 INFO - 2016-01-25 04:06:08,142 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,142 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5728.05 Median:6561.22 stddev:1755.78 (26.8%) stddev-sans-first:1713.74 04:06:08 INFO - 2016-01-25 04:06:08,143 DEBUG : BROWSER_OUTPUT: Values: 353.3 362.2 364.4 366.3 368.0 6331.6 6481.0 6483.8 6539.9 6582.5 6288.3 6418.4 6421.6 6423.6 6448.6 4888.7 4892.4 4893.6 4898.6 4899.7 4881.1 4907.8 4908.3 4913.8 4922.0 4647.8 4816.2 4823.6 4824.1 4826.6 4806.6 4807.9 4809.0 4811.9 4832.0 4190.2 4202.1 4213.6 4216.3 4227.5 6056.0 6162.4 6170.0 6172.9 6208.3 5640.1 5660.7 5666.7 5687.1 5688.6 6829.8 6842.4 6843.8 6845.1 6854.8 4670.7 4694.7 4701.2 4705.6 4705.7 6912.0 7041.5 7119.8 7126.9 7132.1 4732.0 4752.0 4755.7 4758.1 4761.3 4818.0 4821.0 4828.0 4831.2 4837.7 5514.0 5633.0 5635.5 5643.9 5656.9 6890.5 6927.7 6936.4 6936.7 6938.1 1649.7 1710.2 1711.5 1713.4 1715.1 1114.7 1126.6 1131.4 1140.5 1147.1 6639.5 6640.7 6652.3 6657.0 6662.3 7048.7 7051.0 7066.3 7078.4 7086.4 6516.1 6523.8 6614.4 6618.3 6639.4 3797.5 3829.8 3830.4 3840.0 3854.9 7297.5 7301.4 7321.5 7338.7 7338.9 7099.8 7221.1 7242.2 7255.2 7261.0 7325.3 7328.9 7330.0 7332.2 7344.3 7035.6 7046.5 7070.0 7092.4 7096.1 6800.4 6916.0 6941.0 6965.2 6965.4 7171.6 7241.8 7276.9 7279.8 7283.2 4771.1 4801.7 4810.4 4819.4 4829.1 6957.3 7062.2 7104.1 7119.4 7225.2 6981.6 7032.9 7034.8 7039.2 7063.5 7015.3 7031.0 7037.6 7037.6 7040.4 6755.1 6815.9 6885.9 6915.6 6923.4 7043.4 7058.6 7060.3 7061.5 7086.4 6751.0 6867.7 6874.0 6882.8 6886.2 04:06:08 INFO - 2016-01-25 04:06:08,143 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,143 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14507.08 Median:25587.07 stddev:16597.51 (64.9%) stddev-sans-first:16612.47 04:06:08 INFO - 2016-01-25 04:06:08,143 DEBUG : BROWSER_OUTPUT: Values: 869.1 879.8 886.4 893.4 901.9 14864.6 16352.8 16540.8 16549.9 16619.2 14614.9 14638.6 14665.3 14673.6 14696.6 895.0 909.1 913.2 917.5 917.7 905.6 910.2 912.7 914.0 915.6 948.4 951.7 954.1 954.2 957.3 936.0 945.9 950.5 951.4 955.3 706.1 708.2 708.8 710.8 711.7 13135.8 13338.3 13346.1 13375.5 13394.1 12622.4 12827.7 12903.3 13343.0 13543.7 10507.5 11233.9 11249.1 11304.2 11306.1 3808.4 3852.2 3880.0 3890.2 3895.0 46217.0 46810.8 46878.1 48036.5 48364.0 10631.4 10656.7 10730.4 10936.3 10942.9 18512.4 18517.1 18616.7 18723.5 18864.6 8209.0 8242.0 8243.0 8386.1 8691.4 4636.1 4811.7 4852.6 4928.9 4985.3 3197.9 3222.3 3226.2 3227.2 3236.8 593.7 599.2 600.4 603.0 613.6 699.1 727.8 736.8 739.7 741.2 8683.0 8889.7 8949.3 8975.5 9082.4 657.7 720.6 724.3 745.0 785.3 4112.4 4121.0 4180.3 4258.1 4284.3 60042.4 60454.1 60581.0 60691.0 61009.4 52672.0 52944.5 53557.5 54073.2 54474.0 48439.8 48771.0 49111.3 50538.0 50617.2 8515.8 8517.7 8548.2 9008.0 9082.3 35836.3 36800.8 36857.8 37036.8 37555.4 46245.5 46538.0 46897.3 47281.3 48854.0 10655.7 10790.0 10797.1 11178.3 11300.9 13484.0 13493.5 13598.5 13646.6 14382.6 11631.2 11913.9 11953.8 12039.6 12450.4 10309.4 10914.5 11379.5 11569.5 11575.0 11458.7 11489.0 11599.5 11803.9 11972.3 10550.6 10563.6 10627.3 10773.4 10990.5 9782.1 9821.6 10049.5 10054.4 10199.0 04:06:08 INFO - 2016-01-25 04:06:08,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:08 INFO - 2016-01-25 04:06:08,144 DEBUG : BROWSER_OUTPUT: 04:06:08 INFO - 2016-01-25 04:06:08,821 INFO : Browser exited with error code: 0 04:06:08 INFO - 2016-01-25 04:06:08,840 INFO : Completed test dromaeo_css (00:18:29) 04:06:08 INFO - 2016-01-25 04:06:08,840 INFO : Starting test kraken 04:06:08 INFO - 2016-01-25 04:06:08,840 DEBUG : operating with platform_type : linux_ 04:06:08 INFO - 2016-01-25 04:06:08,840 INFO : Initialising browser for kraken test... 04:06:08 INFO - 2016-01-25 04:06:08,846 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplL7gMK/profile http://localhost:33214/getInfo.html 04:06:12 INFO - 2016-01-25 04:06:12,502 DEBUG : BROWSER_OUTPUT: 04:06:12 INFO - 2016-01-25 04:06:12,502 DEBUG : BROWSER_OUTPUT: (process:6948): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:13 INFO - 2016-01-25 04:06:13,365 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:13 INFO - 2016-01-25 04:06:13,366 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:13 INFO - 2016-01-25 04:06:13,366 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:13 INFO - 2016-01-25 04:06:13,366 DEBUG : BROWSER_OUTPUT: __metrics 04:06:14 INFO - 2016-01-25 04:06:14,369 INFO : Browser initialized. 04:06:14 INFO - 2016-01-25 04:06:14,370 INFO : Running cycle 1/1 for kraken test... 04:06:14 INFO - 2016-01-25 04:06:14,370 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplL7gMK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:15 INFO - 2016-01-25 04:06:15,646 DEBUG : BROWSER_OUTPUT: 04:06:15 INFO - 2016-01-25 04:06:15,646 DEBUG : BROWSER_OUTPUT: (process:7062): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:26 INFO - 2016-01-25 04:06:26,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 138346496 04:06:26 INFO - 2016-01-25 04:06:26,151 DEBUG : BROWSER_OUTPUT: 04:06:28 INFO - 2016-01-25 04:06:28,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33214/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:29 INFO - 2016-01-25 04:06:29,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 137891840 04:06:29 INFO - 2016-01-25 04:06:29,223 DEBUG : BROWSER_OUTPUT: 04:06:31 INFO - 2016-01-25 04:06:31,780 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33214/tests/kraken/driver.html?testName=audio-dft) 04:06:32 INFO - 2016-01-25 04:06:32,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 138981376 04:06:32 INFO - 2016-01-25 04:06:32,366 DEBUG : BROWSER_OUTPUT: 04:06:35 INFO - 2016-01-25 04:06:35,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33214/tests/kraken/driver.html?testName=audio-fft) 04:06:35 INFO - 2016-01-25 04:06:35,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 139837440 04:06:35 INFO - 2016-01-25 04:06:35,732 DEBUG : BROWSER_OUTPUT: 04:06:37 INFO - 2016-01-25 04:06:37,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33214/tests/kraken/driver.html?testName=audio-oscillator) 04:06:38 INFO - 2016-01-25 04:06:38,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 138088448 04:06:38 INFO - 2016-01-25 04:06:38,303 DEBUG : BROWSER_OUTPUT: 04:06:40 INFO - 2016-01-25 04:06:40,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:41 INFO - 2016-01-25 04:06:41,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 138592256 04:06:41 INFO - 2016-01-25 04:06:41,063 DEBUG : BROWSER_OUTPUT: 04:06:43 INFO - 2016-01-25 04:06:43,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33214/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:44 INFO - 2016-01-25 04:06:44,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 139530240 04:06:44 INFO - 2016-01-25 04:06:44,552 DEBUG : BROWSER_OUTPUT: 04:06:47 INFO - 2016-01-25 04:06:47,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33214/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:48 INFO - 2016-01-25 04:06:48,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 139653120 04:06:48 INFO - 2016-01-25 04:06:48,488 DEBUG : BROWSER_OUTPUT: 04:06:51 INFO - 2016-01-25 04:06:51,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33214/tests/kraken/driver.html?testName=json-parse-financial) 04:06:51 INFO - 2016-01-25 04:06:51,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 138145792 04:06:51 INFO - 2016-01-25 04:06:51,907 DEBUG : BROWSER_OUTPUT: 04:06:53 INFO - 2016-01-25 04:06:53,504 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:54 INFO - 2016-01-25 04:06:54,073 DEBUG : BROWSER_OUTPUT: RSS: Main: 138399744 04:06:54 INFO - 2016-01-25 04:06:54,073 DEBUG : BROWSER_OUTPUT: 04:06:55 INFO - 2016-01-25 04:06:55,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:56 INFO - 2016-01-25 04:06:56,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 138285056 04:06:56 INFO - 2016-01-25 04:06:56,469 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2016-01-25 04:06:58,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:59 INFO - 2016-01-25 04:06:59,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 04:06:59 INFO - 2016-01-25 04:06:59,068 DEBUG : BROWSER_OUTPUT: 04:07:01 INFO - 2016-01-25 04:07:01,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:02 INFO - 2016-01-25 04:07:02,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 138645504 04:07:02 INFO - 2016-01-25 04:07:02,044 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-25 04:07:04,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:05 INFO - 2016-01-25 04:07:05,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 138825728 04:07:05 INFO - 2016-01-25 04:07:05,150 DEBUG : BROWSER_OUTPUT: 04:07:06 INFO - 2016-01-25 04:07:06,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33214/tests/kraken/driver.html?testName=ai-astar) 04:07:07 INFO - 2016-01-25 04:07:07,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 140447744 04:07:07 INFO - 2016-01-25 04:07:07,020 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,021 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:07 INFO - 2016-01-25 04:07:07,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:07 INFO - 2016-01-25 04:07:07,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:07 INFO - 2016-01-25 04:07:07,022 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:07 INFO - 2016-01-25 04:07:07,022 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;112;113;113;121;111;110;111;111 04:07:07 INFO - 2016-01-25 04:07:07,023 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;123;149;154;125;150;146;129;160;123 04:07:07 INFO - 2016-01-25 04:07:07,023 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;159;162;163;159;161;160;163;163 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;150;71;73;70;71;160;72 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;135;93;93;92;142;93;92;137 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;109;110;109;109;110;110;110 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;146;146;147;146;146;147;146 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;97;96;98;96;95 04:07:07 INFO - 2016-01-25 04:07:07,024 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;59;60;60;61;61;65;73;58 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;65;63;64;64;64;64;64;63;63 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;83;82;81;82;85;81;82 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;119;119;114;118;113;122;113;116;113 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;144;145;143;144;155;143;137;143;131 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;67;63;65;62;65;67;64;65 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:07 INFO - 2016-01-25 04:07:07,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,705 04:07:07 INFO - 2016-01-25 04:07:07,026 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:07 INFO - 2016-01-25 04:07:07,026 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723627021__endTimestamp 04:07:07 INFO - 2016-01-25 04:07:07,026 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,033 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:07 INFO - 2016-01-25 04:07:07,033 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:111.50 stddev:3.59 (3.2%) stddev-sans-first:3.79 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 112.0 113.0 113.0 121.0 111.0 110.0 111.0 111.0 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.70 Median:148.50 stddev:14.13 (9.5%) stddev-sans-first:14.73 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: Values: 148.0 123.0 149.0 154.0 125.0 150.0 146.0 129.0 160.0 123.0 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.63 (1.0%) stddev-sans-first:1.69 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 159.0 162.0 163.0 159.0 161.0 160.0 163.0 163.0 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,034 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.60 Median:72.50 stddev:35.09 (48.4%) stddev-sans-first:36.76 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 150.0 71.0 73.0 70.0 71.0 160.0 72.0 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:92.50 stddev:22.01 (23.8%) stddev-sans-first:22.74 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 135.0 93.0 93.0 92.0 142.0 93.0 92.0 137.0 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 109.0 110.0 109.0 109.0 110.0 110.0 110.0 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,035 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 98.0 96.0 95.0 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.30 Median:60.50 stddev:4.62 (7.6%) stddev-sans-first:4.74 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 59.0 60.0 60.0 61.0 61.0 65.0 73.0 58.0 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: Values: 63.0 65.0 63.0 64.0 64.0 64.0 64.0 64.0 63.0 63.0 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.17 (1.4%) stddev-sans-first:1.24 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 83.0 82.0 81.0 82.0 85.0 81.0 82.0 04:07:07 INFO - 2016-01-25 04:07:07,036 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:117.00 stddev:3.30 (2.8%) stddev-sans-first:3.32 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: Values: 113.0 119.0 119.0 114.0 118.0 113.0 122.0 113.0 116.0 113.0 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:144.00 stddev:6.20 (4.3%) stddev-sans-first:6.42 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 145.0 143.0 144.0 155.0 143.0 137.0 143.0 131.0 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.55 (2.4%) stddev-sans-first:1.64 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 67.0 63.0 65.0 62.0 65.0 67.0 64.0 65.0 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:07 INFO - 2016-01-25 04:07:07,037 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,881 INFO : Browser exited with error code: 0 04:07:07 INFO - 2016-01-25 04:07:07,940 INFO : Completed test kraken (00:00:59) 04:07:07 INFO - 2016-01-25 04:07:07,940 INFO : Starting test v8_7 04:07:07 INFO - 2016-01-25 04:07:07,940 DEBUG : operating with platform_type : linux_ 04:07:07 INFO - 2016-01-25 04:07:07,941 INFO : Initialising browser for v8_7 test... 04:07:07 INFO - 2016-01-25 04:07:07,947 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzvuETX/profile http://localhost:33214/getInfo.html 04:07:11 INFO - 2016-01-25 04:07:11,604 DEBUG : BROWSER_OUTPUT: 04:07:11 INFO - 2016-01-25 04:07:11,605 DEBUG : BROWSER_OUTPUT: (process:7371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:12 INFO - 2016-01-25 04:07:12,496 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:12 INFO - 2016-01-25 04:07:12,496 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:12 INFO - 2016-01-25 04:07:12,496 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:12 INFO - 2016-01-25 04:07:12,497 DEBUG : BROWSER_OUTPUT: __metrics 04:07:13 INFO - 2016-01-25 04:07:13,477 INFO : Browser initialized. 04:07:13 INFO - 2016-01-25 04:07:13,478 INFO : Running cycle 1/1 for v8_7 test... 04:07:13 INFO - 2016-01-25 04:07:13,478 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzvuETX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:14 INFO - 2016-01-25 04:07:14,814 DEBUG : BROWSER_OUTPUT: 04:07:14 INFO - 2016-01-25 04:07:14,815 DEBUG : BROWSER_OUTPUT: (process:7485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:25 INFO - 2016-01-25 04:07:25,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 135516160 04:07:25 INFO - 2016-01-25 04:07:25,322 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33214/tests/v8_7/run.html (next: http://localhost:33214/tests/v8_7/run.html) 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 136163328 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:46 INFO - 2016-01-25 04:07:46,943 DEBUG : BROWSER_OUTPUT: |0;Richards;164.04199475065616 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.27868307283006 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |4;RayTrace;936.3295880149813 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |5;Earley;538.2131324004306 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |6;Boyer;10913.04347826087 04:07:46 INFO - 2016-01-25 04:07:46,944 DEBUG : BROWSER_OUTPUT: |7;RegExp;26000 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: |8;Splay;524.6589716684156 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723666942__endTimestamp 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,945 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:46 INFO - 2016-01-25 04:07:46,946 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:07:46 INFO - 2016-01-25 04:07:46,946 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,946 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.04 Median:164.04 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: Values: 164.0 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: Values: 166.3 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,947 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: Values: 278.3 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: Values: 5170.1 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:936.33 Median:936.33 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: Values: 936.3 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:538.21 Median:538.21 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: Values: 538.2 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,948 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10913.04 Median:10913.04 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: Values: 10913.0 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26000.00 Median:26000.00 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: Values: 26000.0 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.66 Median:524.66 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: Values: 524.7 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:07:46 INFO - 2016-01-25 04:07:46,949 DEBUG : BROWSER_OUTPUT: Values: 4826.9 04:07:46 INFO - 2016-01-25 04:07:46,950 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:46 INFO - 2016-01-25 04:07:46,950 DEBUG : BROWSER_OUTPUT: 04:07:47 INFO - 2016-01-25 04:07:47,721 INFO : Browser exited with error code: 0 04:07:47 INFO - 2016-01-25 04:07:47,738 INFO : Completed test v8_7 (00:00:39) 04:07:47 INFO - 2016-01-25 04:07:47,995 INFO : Completed test suite (00:20:08) 04:07:47 INFO - 2016-01-25 04:07:47,996 DEBUG : Working with test: dromaeo_css 04:07:47 INFO - 2016-01-25 04:07:47,996 DEBUG : Generating results file: dromaeo_css 04:07:47 INFO - 2016-01-25 04:07:47,997 DEBUG : Working with test: kraken 04:07:47 INFO - 2016-01-25 04:07:47,997 DEBUG : Generating results file: kraken 04:07:47 INFO - 2016-01-25 04:07:47,997 INFO : javascript benchmark 04:07:47 INFO - 2016-01-25 04:07:47,998 DEBUG : Working with test: v8_7 04:07:47 INFO - 2016-01-25 04:07:47,998 DEBUG : Generating results file: v8_7 04:07:47 INFO - 2016-01-25 04:07:47,998 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2016-01-25 04:07:48,056 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:07:48 INFO - 2016-01-25 04:07:48,056 DEBUG : process_Request line: dromaeo_css 7396.19 graph.html#tests=[[72,52,43]] 04:07:48 INFO - 2016-01-25 04:07:48,056 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2016-01-25 04:07:48,102 DEBUG : process_Request line: kraken 1492.40 graph.html#tests=[[232,52,43]] 04:07:48 INFO - 2016-01-25 04:07:48,102 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:48 INFO - 2016-01-25 04:07:48,130 DEBUG : process_Request line: v8_7 23132.22 graph.html#tests=[[230,52,43]] 04:07:48 INFO - 2016-01-25 04:07:48,131 INFO : javascript benchmark 04:07:48 INFO - 2016-01-25 04:07:48,135 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3371.7302615790736, 3394.253264281857, 3394.6435624259466, 3427.41733905236, 3431.19366948767, 5530.917036244459, 5542.057850165472, 5560.6663600183965, 5561.833145005646, 5565.30433695788, 5533.391326954032, 5533.972330138344, 5542.334919809628, 5554.055810512213, 5599.944000559994, 5066.594672426216, 5096.235564665293, 5173.974130129344, 5179.4561571035065, 5181.300524429192, 5026.5727413169925, 5145.073886700392, 5157.71632560209, 5161.148410512261, 5265.947340526584, 5134.358205224347, 5211.114110601188, 5246.842594722164, 5247.606429517782, 5249.448807875176, 5160.896782064357, 5267.789288428458, 5279.0, 5281.392639846428, 5318.5213330800025, 5008.0, 5030.3963524377305, 5062.291279220912, 5153.330067091291, 5168.948310516922, 5460.726963651841, 5462.890742185134, 5481.698506582136, 5500.532454741352, 5542.4457554244655, 6049.062395328731, 6069.15031895535, 6088.604240724383, 6116.48009919153, 6175.505959523227, 5663.89554036963, 5759.913601295984, 6032.396760323976, 6120.569035656853, 6209.223847019122, 5739.368669446358, 5743.62666426681, 5744.597878148531, 5749.798757043567, 5750.626209296424, 6161.691915404302, 6219.942609756352, 6223.315435302113, 6233.0338797486465, 6234.2830574483605, 5805.245318108618, 5886.499647529922, 5889.234399528034, 5952.9107063394085, 5980.102984552265, 6075.483583895419, 6144.938550614526, 6173.41352571505, 6195.16365290689, 6195.845103872439, 5886.823395298148, 6048.818535443944, 6158.137860699506, 6164.198654174928, 6174.135621013062, 5974.133750606225, 6080.726367313481, 6167.660778657128, 6172.969135154385, 6175.3824617538785, 4672.971946171905, 4677.134730074947, 4677.742724150205, 4680.719156850531, 4748.382710247645, 4111.794410279534, 4209.810558524874, 4234.87295381139, 4238.87283381499, 4269.274223382033, 5798.623089499169, 5865.178874957509, 5872.207252021008, 5891.057430811135, 5926.377730338339, 6056.757729690763, 6063.484603808725, 6094.268687757498, 6115.908261376083, 6125.632462052291, 5573.108302671553, 5682.40334764852, 5704.229928959538, 5785.595008349459, 5787.913181302284, 5250.842474725764, 5301.655392399482, 5311.548518375904, 5325.840224793263, 5340.49265319794, 6244.843878903063, 6281.497480201573, 6283.560150789401, 6285.528585356116, 6291.0, 5909.763609455574, 5946.970265148647, 5984.551158663031, 6097.298810636834, 6125.081237814364, 6187.348600254654, 6339.2392912850755, 6371.267304259884, 6377.521685873486, 6378.425941665272, 6088.299845517645, 6097.237845269341, 6101.2068431105445, 6102.359252278447, 6110.26676798787, 5920.200772895604, 5982.282126144891, 6061.090836374579, 6074.757009719739, 6095.969520152371, 6019.969900150471, 6040.36576159497, 6042.123892035718, 6043.728032238472, 6059.666718330358, 5675.858103547444, 6021.939780602138, 6025.156478092983, 6060.333363330118, 6062.696865156637, 5729.914051289151, 5743.052396354722, 5779.422057794355, 5818.301803783573, 5865.94134058654, 5822.330432000204, 5871.207387002871, 5892.823215303548, 5902.203202567598, 6039.124326972476, 5568.331800184003, 5711.314642242957, 5753.942460575508, 5765.798197063083, 5793.420657934173], "unit": "ms", "name": "dojo.html", "value": 5601.729180641662}, {"lowerIsBetter": false, "replicates": [563.6702529020523, 604.0637012630423, 611.2145892528102, 653.7940548727148, 686.5708931917549, 31496.68503314966, 40755.0, 41037.17925641493, 41140.38289425661, 41328.79335603325, 44827.0, 45159.322610160794, 45375.0, 45455.54544454555, 45506.317405238864, 9121.771955701111, 9208.12522810332, 9259.444433333987, 9310.86033709495, 9328.533573321307, 9061.682841100563, 9129.817403651923, 9159.35884488086, 9187.816243675123, 9235.492047937361, 9088.136627020422, 9109.544522773835, 9128.041555636662, 9152.633894644207, 9152.725418237464, 9117.772055698595, 9121.726348209564, 9190.126937940884, 9198.494082825442, 9204.493752843591, 9104.544772761401, 9180.0, 9188.127127922837, 9197.770055748593, 9205.217556507705, 41081.1783764326, 41489.377659335136, 41632.0, 41685.79157104225, 41712.0, 3624.746267761258, 3740.756850804689, 3792.089898424386, 3865.4781604483314, 4131.855385061508, 32023.0, 32206.677933220835, 32285.0, 32333.838330808194, 33315.6668433315, 3621.94567081494, 3693.0582701410967, 3724.1434470071763, 3779.2063666630042, 3801.486799282089, 274892.0, 274970.0, 275468.0, 276144.6192769043, 276415.0, 61001.38998610046, 61249.38750612526, 61491.07763383553, 61509.384906150364, 61519.6924015386, 64250.0, 64259.0, 64370.0344494833, 64658.353416466176, 64735.35264647293, 16162.191890405433, 16540.75188872168, 16551.172441377883, 16557.503274901774, 16597.91701041487, 12568.434420451102, 12598.685032874251, 12632.621021369374, 12685.429155688016, 12725.427355769012, 20332.59334813325, 20782.27262045821, 20793.688094678593, 20807.895960520404, 20863.47841303949, 7833.725819596287, 8063.556504392314, 8125.06561745395, 8171.468854524437, 8270.627821748036, 1020.505055048301, 1043.9425831579335, 1053.5048527192207, 1153.5847095045776, 1219.7987332090283, 30216.84891575572, 30275.848620757195, 30944.69055309418, 31403.68596314053, 33508.32983340319, 1105.950232239551, 1115.3921112993437, 1119.9496022679, 1131.6322195286564, 1132.881047490018, 14638.853611463963, 15223.847761522464, 15242.847571524364, 15308.69876060525, 15615.297311621005, 534541.0, 535263.0, 538567.0, 539180.0, 544231.0, 57831.0, 58488.41511584915, 58728.11907821386, 58742.706286468296, 58835.11747323794, 1418.6169734171715, 1418.7659036259108, 1419.5102689572082, 1423.4662001749343, 1457.4461704552202, 30482.84758576193, 31532.211694707818, 31950.0, 32436.35127297488, 34194.48708269428, 54345.72827135839, 55408.0, 55454.0, 55504.167437489275, 55830.162547561005, 316143.0, 317844.0, 318885.0, 319225.0, 321211.0, 44291.199904746405, 44382.0, 45472.31791523196, 45680.31479527876, 45695.543044570455, 48887.266691000375, 49343.0, 49672.25491617557, 49841.25238121504, 50311.49688503068, 42008.36987445252, 42349.36475952801, 43076.0, 43519.78240108779, 43563.34654980241, 41751.1649767009, 42055.0, 42080.78959605182, 42456.0, 42546.361804572334, 41052.58947410607, 41338.379924301764, 41588.79205603953, 41938.0, 41959.58040419557, 36050.27899441944, 36255.27489450249, 39387.80306098451, 39715.0, 40101.1979760409, 26436.0, 27092.187234383, 27335.58996615092, 27353.0, 28635.565976892198], "unit": "ms", "name": "ext.html", "value": 20394.384671193788}, {"lowerIsBetter": false, "replicates": [383.0252008638016, 385.8090245328561, 388.99611003889953, 389.60844351426823, 390.69916164553297, 16241.593960151002, 17276.568085797844, 17814.465566033006, 18833.905830470845, 18937.147828347723, 10519.63181288655, 17102.230399632015, 17218.913905430454, 17236.827631723678, 17930.551736206602, 5230.450802665713, 5269.6311258211745, 5763.769449222026, 5831.4751672349485, 5832.358440571534, 5281.6830990140525, 5411.458854114597, 5462.9726851365685, 5726.3987281335485, 5739.942600574003, 5382.354117505885, 5410.08028635133, 5425.26758887551, 5435.157550579666, 5439.075357189287, 5651.717414129277, 5656.2929633795775, 5675.914861277084, 5685.715714214293, 5690.06113991191, 5426.591791969078, 5459.481349271813, 5490.56075513958, 5498.395176530578, 5576.553875689976, 13054.216746995211, 13151.736965260738, 13302.600921972356, 13311.0, 13788.862111378858, 2222.555488902226, 2287.199480181923, 2292.197730794225, 2306.561753266874, 2336.556054349668, 10132.848007279898, 10154.89845101547, 10224.897751022469, 10358.53386597605, 10405.063544280976, 1893.829555340026, 1900.781410137838, 1916.6741653918866, 1952.5997170579997, 1968.5964377302619, 64112.679436602986, 64881.0, 65681.67159164221, 67238.66380668065, 67266.0, 10610.41642709643, 11040.779184416268, 11220.831687524693, 11284.548618055185, 11344.716382090513, 13838.0, 13931.58205253844, 14014.71970560583, 14025.228612426414, 14076.0, 7745.961270193726, 7789.5715735635085, 7790.0, 8043.798905027421, 8100.635471403801, 7434.070741157356, 7666.65500052499, 7674.270944260286, 7738.4969976951315, 7799.1031031430975, 4611.377464042378, 4630.351750754897, 4702.882427939329, 4713.104510143062, 4865.12427762999, 1907.7774392832196, 1931.3433432632971, 1946.6593346164364, 1987.8509111816381, 2004.0080160320442, 893.2005854760083, 948.2366694810744, 970.6263088710897, 979.7648564344648, 993.1310103659298, 17114.354552876317, 17851.375201868133, 18000.0, 18084.0, 18486.537836554195, 951.9428834269966, 1048.9527971241312, 1069.13934282903, 1080.6920027792198, 1139.128566646516, 9772.315937884421, 10267.127294179929, 10277.794444111225, 10313.22650801178, 10342.5345859435, 649220.0, 650015.0, 655682.0, 677405.0, 689436.0, 85535.57232213799, 86501.56749216339, 87895.56052219697, 88520.0, 89222.55388723145, 1205.873383294759, 1225.3383173086434, 1233.210745123122, 1242.031215651793, 1246.22111180514, 16614.335426583286, 16766.66466670684, 16810.915945420194, 16857.325706971584, 17252.913735431244, 38635.6136438632, 38679.6132038676, 38699.806500967316, 38741.806290968365, 38990.6100938987, 46118.077638447714, 46238.306425402974, 48184.27723584219, 50515.24227136523, 51085.0, 9688.806223875625, 10106.848397274194, 10116.08955194036, 10136.391816491034, 10591.735206619896, 16549.751753723463, 17439.215235314186, 17949.371771987917, 17957.551061223574, 18360.90819545894, 15490.225488725744, 15504.689906202038, 15575.143367114917, 15595.922020389826, 15818.655414289915, 14906.776398353817, 15003.549893503212, 16033.438829640907, 16074.598135046717, 16515.33938642441, 15523.922380388025, 16026.118563478654, 16509.009459432473, 16887.831121688625, 16982.320707172068, 10319.638812641522, 10443.530041148015, 10558.630447934285, 10749.570017199225, 10854.0, 14639.121652700873, 15157.282659193448, 15918.28367723432, 16175.838241617905, 16389.344426223295], "unit": "ms", "name": "jquery.html", "value": 9376.847504250843}, {"lowerIsBetter": false, "replicates": [1491.4108926973852, 1497.0, 1687.232309299269, 1807.900565468899, 1853.388381833995, 7043.964780176098, 7270.38201752851, 7295.416366690659, 7599.886001709965, 7800.453968222227, 7492.36314913233, 7540.84918301635, 7622.047244094489, 7626.809329766758, 7638.12161601416, 2264.071730590458, 2292.197730794217, 2302.7812357826065, 2304.873231972241, 2311.6070268054386, 2244.5735310291075, 2288.0, 2296.7243930728337, 2297.1615360393503, 2304.0553373117027, 2234.530748542808, 2244.618414869476, 2248.9887550562225, 2274.4768703198274, 2277.6925115109416, 2201.1195521791333, 2260.6609008648834, 2276.1236923784463, 2281.7718228177214, 2282.6119559674894, 2296.644020176875, 2323.686302349195, 2330.953380932389, 2331.265651319829, 2337.649352597107, 7702.961485192594, 7726.420518461138, 7727.574983375912, 7759.418043646749, 7762.573058481781, 4635.304704294349, 4680.976595117037, 4690.0854333405, 4700.811967521295, 4704.294355846616, 2922.9853850730824, 2980.4039192161435, 3025.8789648414036, 3045.604071470717, 3046.1014000869795, 956.526519372908, 975.2393133355994, 988.4267125067444, 991.1476130527741, 1007.7531004903846, 10161.644342448053, 10216.080552750214, 10243.334183278062, 10244.436555989418, 10302.845457318146, 3857.2092720992127, 3913.5695073541888, 3974.6422821945584, 4039.7374170678813, 4040.7575545467366, 8078.151794061539, 8084.595770211584, 8114.0, 8124.796880078045, 8130.0, 4457.598816106566, 4458.6878918475395, 4458.8439404620685, 4468.419105516327, 4486.102779444059, 4127.607877251657, 4133.8966525837095, 4148.357004664282, 4168.083021735213, 4172.874813755531, 3372.578427696538, 3372.7470439717117, 3375.932481350359, 3392.135005573563, 3395.5416018837636, 1023.948802559869, 1024.114141267798, 1027.8304079826744, 1037.7650595791135, 1038.413296487482, 1085.907697845692, 1098.6868742408535, 1139.7378602921374, 1307.6469353274563, 1386.3761307411705, 6869.381755641916, 6943.132108486439, 6961.825954351182, 6966.442684585221, 7061.399781018671, 1152.6772503698978, 1161.872194058653, 1169.1231576317762, 1169.590643274847, 1173.1260211142753, 5426.375966763872, 5450.5367043801725, 5493.7802487900035, 5499.230107784913, 5502.779888804403, 8778.0, 8900.42147260426, 9133.0, 9280.489573073546, 9331.393459425115, 9123.133302336268, 9138.63445462174, 9152.679656212, 9179.908200917906, 9207.493587852598, 7040.894386584103, 7168.605726684978, 7184.820379490555, 7208.531445455924, 7252.456065795086, 7004.439644828503, 7030.824229394306, 7033.613151276729, 7039.929600704132, 7053.576785392893, 8122.796930076559, 8238.50568965864, 8280.627371768165, 8350.206730360605, 8381.664733410838, 8269.46248493846, 8312.83374332522, 8383.28742056932, 8387.119352468148, 8397.118302578385, 6702.329767023259, 6753.459723222032, 6755.459563234831, 6764.526483146133, 6782.355676210752, 7319.268073192638, 7320.121585409572, 7352.5220860643885, 7375.889361659472, 7378.188399275968, 6422.903656445251, 6908.274631163656, 6921.169459664872, 7058.71765129389, 7084.681189346388, 6798.150231221098, 6834.214065382345, 6863.416609588241, 6877.518573699793, 6903.102596662402, 6756.358145976124, 6756.527043106936, 6767.086443330088, 6838.179418469816, 6848.6918088687125, 6129.1112788644505, 6164.568480206342, 6176.66028368444, 6184.5980011299125, 6188.535859810622, 6318.526110541819, 6329.525285603506, 6398.93601064002, 6446.9032964506505, 6454.935450645621], "unit": "ms", "name": "mootools.html", "value": 4384.797944710922}, {"lowerIsBetter": false, "replicates": [353.3198592709035, 362.1507564760635, 364.42057129164624, 366.287570675037, 368.022899202617, 6331.620102793836, 6480.9675951620175, 6483.773067942617, 6539.901901471481, 6582.539222254438, 6288.276848162463, 6418.358164183591, 6421.582597131183, 6423.582467139633, 6448.613083214998, 4888.682235654671, 4892.412910450751, 4893.584045356149, 4898.608111351084, 4899.6815207011605, 4881.1213981483315, 4907.75461226939, 4908.337374454457, 4913.754312284372, 4922.0, 4647.790849411785, 4816.229403295473, 4823.614110871139, 4824.107540105092, 4826.638002149835, 4806.567408933195, 4807.879803004917, 4808.951910480921, 4811.855644330658, 4831.985283090556, 4190.20386126635, 4202.117555313388, 4213.620774130343, 4216.2832318505625, 4227.471566054243, 6056.0, 6162.383761623847, 6170.0, 6172.87654246917, 6208.286047104551, 5640.069388550925, 5660.745266463019, 5666.688332141731, 5687.118496633028, 5688.63023903445, 6829.795106146824, 6842.4183944364295, 6843.794686159423, 6845.110135682379, 6854.828629284258, 4670.719756814568, 4694.718316900997, 4701.200795864711, 4705.600023997964, 4705.670603057787, 6911.963205519162, 7041.4718896082995, 7119.786406407816, 7126.928730712731, 7132.072830531998, 4731.976340118277, 4751.976240118777, 4755.738434386073, 4758.143534163814, 4761.309610106515, 4818.0, 4821.0, 4828.020511590231, 4831.154547954094, 4837.733924634179, 5513.972430137904, 5633.014222511126, 5635.520980716685, 5643.915341269884, 5656.943430565724, 6890.517663763489, 6927.7228910843005, 6936.375726184668, 6936.687849046805, 6938.06336144614, 1649.736042233237, 1710.2474911039103, 1711.537884771105, 1713.3746182643245, 1715.1424287856073, 1114.6767437443214, 1126.594426006637, 1131.4003578103618, 1140.4753813245834, 1147.1109889835445, 6639.535232533676, 6640.701168447432, 6652.334766523406, 6656.966715166393, 6662.333766623396, 7048.682809273595, 7051.048108505286, 7066.293370662996, 7078.433725301964, 7086.433085353159, 6516.0877477153235, 6523.804285871432, 6614.404703576605, 6618.338166183439, 6639.435647969976, 3797.5442946846556, 3829.751066180689, 3830.367989281793, 3840.02079469739, 3854.9229015419533, 7297.525660832029, 7301.379382752525, 7321.487495875344, 7338.669759860819, 7338.853222935618, 7099.787006389816, 7221.061262036007, 7242.203357630657, 7255.165655949528, 7260.9636951815955, 7325.267473252632, 7328.926710732824, 7329.963350183215, 7332.156801967842, 7344.265573442613, 7035.577865328097, 7046.541974771623, 7070.0, 7092.432605391659, 7096.077509923677, 6800.387965083166, 6915.965420173068, 6940.965295173693, 6965.164180298397, 6965.44276457872, 7171.641417929187, 7241.818954526179, 7276.927230727837, 7279.781606551812, 7283.162436319679, 4771.06964141989, 4801.68789028712, 4810.39870016248, 4819.373481447389, 4829.106615276185, 6957.304269573002, 7062.15254169503, 7104.147502299757, 7119.394851437686, 7225.169105552929, 6981.616011119438, 7032.929670703432, 7034.753783617549, 7039.225685174524, 7063.505554611128, 7015.263397343206, 7030.964845175741, 7037.612931288828, 7037.612931288828, 7040.3663670269925, 6755.121834161528, 6815.89776153368, 6885.931140688729, 6915.550489218184, 6923.376896079377, 7043.36609705129, 7058.576485410892, 7060.293970602898, 7061.470389720895, 7086.433085353056, 6750.966245168743, 6867.690953907186, 6873.965630172017, 6882.7591034313555, 6886.173659160932], "unit": "ms", "name": "prototype.html", "value": 5154.599483630918}, {"lowerIsBetter": false, "replicates": [869.1178453869323, 879.7932485865822, 886.3573908916037, 893.3924931046889, 901.8557030875053, 14864.628384290398, 16352.83647163528, 16540.83459165408, 16549.91725041373, 16619.169041547935, 14614.926925365386, 14638.634034149152, 14665.340059697313, 14673.633159171026, 14696.632584185401, 895.0244233785173, 909.05912380686, 913.1963871792847, 917.513717729601, 917.7063339731288, 905.6105874473974, 910.2490445382585, 912.6760000199934, 914.0356923445762, 915.5605309451468, 948.426202147701, 951.70497145885, 954.0602506531061, 954.1984732824426, 957.3059531839396, 936.0218571592668, 945.9243260539175, 950.5484894675043, 951.3673407184215, 955.3360414511917, 706.099722853361, 708.2138825903244, 708.8192510909737, 710.8400609862739, 711.7081996381459, 13135.802962955564, 13338.266395348252, 13346.13250138738, 13375.531856385078, 13394.129381590166, 12622.431990560355, 12827.743445131046, 12903.290319032449, 13343.0, 13543.741534539056, 10507.474626268657, 11233.887661123448, 11249.100071994302, 11304.208705390625, 11306.095512358992, 3808.447775072627, 3852.2295540891932, 3880.0, 3890.1636148228267, 3895.045713800109, 46217.0, 46810.765946170395, 46878.06243875103, 48036.51963480355, 48364.0, 10631.362118272928, 10656.733581660521, 10730.409827459409, 10936.343819370863, 10942.945285273523, 18512.444626660952, 18517.07414629263, 18616.720749188775, 18723.531911702317, 18864.622707545772, 8209.0, 8242.0, 8243.0, 8386.119457457002, 8691.435056721293, 4636.142313671981, 4811.663183577116, 4852.611791056777, 4928.8767780805765, 4985.277134815431, 3197.8880739174483, 3222.2910959588853, 3226.161198088467, 3227.160938156096, 3236.773425860167, 593.7357875745251, 599.1731410653358, 600.3696119074954, 602.9960116406222, 613.6318209074519, 699.1295836683261, 727.8435136445584, 736.8047467421138, 739.737393225408, 741.2476336518438, 8683.0, 8889.688860889837, 8949.284057275532, 8975.50634715097, 9082.40964337316, 657.7303305644663, 720.5604581205461, 724.3082855872628, 744.9627518624047, 785.3206975965862, 4112.424260603518, 4121.0, 4180.28935081037, 4258.127083947783, 4284.293091639907, 60042.39957600455, 60454.09318860221, 60581.0, 60691.0, 61009.389906101256, 52672.0, 52944.47055529473, 53557.46442535525, 54073.1889021665, 54474.0, 48439.75780121077, 48771.0, 49111.26333105078, 50538.0, 50617.24074138891, 8515.787105322417, 8517.74446766598, 8548.230659240699, 9007.954960225157, 9082.273418126666, 35836.283274333844, 36800.815995919846, 36857.81571092128, 37036.81481592575, 37555.436668450544, 46245.53754462412, 46538.0, 46897.296540552605, 47281.29078063901, 48854.0, 10655.680329590125, 10790.0, 10797.082248009006, 11178.329300242012, 11300.886991130312, 13484.0, 13493.460261589427, 13598.456061757419, 13646.590602281947, 14382.568522944328, 11631.243969141979, 11913.940430297793, 11953.820692689791, 12039.578614748441, 12450.377481126088, 10309.381437113498, 10914.454277286262, 11379.54481820751, 11569.479373428048, 11575.01612362925, 11458.71353216143, 11489.023433008288, 11599.536018559163, 11803.881961180277, 11972.281663100242, 10550.577976880839, 10563.63027294041, 10627.25609207379, 10773.353598783784, 10990.450477476254, 9782.119609235204, 9821.558029888814, 10049.497525123861, 10054.396736195851, 10199.031092046243], "unit": "ms", "name": "yui.html", "value": 6760.419785198786}], "name": "dromaeo_css", "value": 7396.189277760885}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 112.0, 113.0, 113.0, 121.0, 111.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 149.0, 154.0, 125.0, 150.0, 146.0, 129.0, 160.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.7}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 159.0, 162.0, 163.0, 159.0, 161.0, 160.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 150.0, 71.0, 73.0, 70.0, 71.0, 160.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 135.0, 93.0, 93.0, 92.0, 142.0, 93.0, 92.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 98.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 60.0, 60.0, 61.0, 61.0, 65.0, 73.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 61.3}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 83.0, 82.0, 81.0, 82.0, 85.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [113.0, 119.0, 119.0, 114.0, 118.0, 113.0, 122.0, 113.0, 116.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 116.0}, {"lowerIsBetter": true, "replicates": [147.0, 144.0, 145.0, 143.0, 144.0, 155.0, 143.0, 137.0, 143.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 67.0, 63.0, 65.0, 62.0, 65.0, 67.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 64.8}], "name": "kraken", "value": 1492.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.04199475065616], "unit": "score", "name": "Richards", "value": 215.20099200000004}, {"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "DeltaBlue", "value": 397.633652}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [936.3295880149813], "unit": "score", "name": "RayTrace", "value": 790.3082519999997}, {"lowerIsBetter": false, "replicates": [538.2131324004306], "unit": "score", "name": "Earley", "value": 1238.2882539999996}, {"lowerIsBetter": false, "replicates": [10913.04347826087], "unit": "score", "name": "Boyer", "value": 61.07031474103584}, {"lowerIsBetter": false, "replicates": [26000.0], "unit": "score", "name": "RegExp", "value": 35.037884615384634}, {"lowerIsBetter": false, "replicates": [524.6589716684156], "unit": "score", "name": "Splay", "value": 155.321846}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23132.219039070977}]} 04:07:48 INFO - RETURN: dromaeo_css: 7396.19 04:07:48 INFO - RETURN: kraken: 1492.40 04:07:48 INFO - RETURN: v8_7: 23132.22 04:07:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23132.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1492.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7396.19"}}} 04:07:48 INFO - Return code: 0 04:07:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:48 INFO - # TBPL SUCCESS # 04:07:48 INFO - Running post-action listener: _resource_record_post_action 04:07:48 INFO - Running post-run listener: _resource_record_post_run 04:07:49 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 262144; Write bytes: 511471616; Read time: 60; Write time: 488448 04:07:49 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 246145024; Read time: 0; Write time: 272408 04:07:49 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 262144; Write bytes: 265035776; Read time: 60; Write time: 216012 04:07:49 INFO - Running post-run listener: _upload_blobber_files 04:07:49 INFO - Blob upload gear active. 04:07:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:07:49 INFO - Copying logs to upload dir... 04:07:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1295.167135 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-01-25 04:07:49.388020) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:49.391657) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 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.009869 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.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:49.446342) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:49.446681) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453721216.500245-1467809743 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:07:49.496425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:49.496746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:07:49.497047) ========= ========= Total master_lag: 0.42 =========