builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1450836384.6 results: success (0) buildid: 20151222155326 builduid: bd5bf6cabf254eecaeef57e3b8f03b0d revision: 3f93f9d49477032fd076d7e3532113cc3c593178 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.604456) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.604800) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.605101) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.638683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.638950) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.688840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.689115) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.741358) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.741611) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.741954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.742232) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 18:06:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 63.1M=0s 2015-12-22 18:06:25 (63.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170401 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.927695) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.927974) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016376 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.977785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:24.978099) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f93f9d49477032fd076d7e3532113cc3c593178 --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 3f93f9d49477032fd076d7e3532113cc3c593178 --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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 18:06:25,257 truncating revision to first 12 chars 2015-12-22 18:06:25,257 Setting DEBUG logging. 2015-12-22 18:06:25,257 attempt 1/10 2015-12-22 18:06:25,257 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3f93f9d49477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 18:06:25,519 unpacking tar archive at: mozilla-aurora-3f93f9d49477/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:25.533146) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:25.533466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:25.549496) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:25.549867) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 18:06:25.550311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-22 18:06:25.550615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --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', '--system-bits', '64', '--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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:25 INFO - MultiFileLogger online at 20151222 18:06:25 in /builds/slave/test-pgo 18:06:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 18:06:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:06:25 INFO - {'append_to_log': False, 18:06:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:06:25 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:06:25 INFO - 'branch': 'Mozilla-Aurora', 18:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:25 INFO - 'config_files': ('talos/linux_config.py',), 18:06:25 INFO - 'default_actions': ('clobber', 18:06:25 INFO - 'read-buildbot-config', 18:06:25 INFO - 'download-and-extract', 18:06:25 INFO - 'populate-webroot', 18:06:25 INFO - 'create-virtualenv', 18:06:25 INFO - 'install', 18:06:25 INFO - 'run-tests'), 18:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:25 INFO - 'download_minidump_stackwalk': True, 18:06:25 INFO - 'download_symbols': 'ondemand', 18:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 18:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 18:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:25 INFO - 'installer_path': 'installer.exe', 18:06:25 INFO - 'log_level': 'info', 18:06:25 INFO - 'log_name': 'talos', 18:06:25 INFO - 'log_to_console': True, 18:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:25 INFO - 'opt_config_files': (), 18:06:25 INFO - 'pip_index': False, 18:06:25 INFO - 'sps_profile': False, 18:06:25 INFO - 'sps_profile_interval': 0, 18:06:25 INFO - 'suite': 'dromaeojs-e10s', 18:06:25 INFO - 'system_bits': '64', 18:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:25 INFO - 'title': 'talos-linux64-ix-042', 18:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:25 INFO - 'use_talos_json': True, 18:06:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:25 INFO - 'work_dir': 'build'} 18:06:25 INFO - ##### 18:06:25 INFO - ##### Running clobber step. 18:06:25 INFO - ##### 18:06:25 INFO - Running pre-action listener: _resource_record_pre_action 18:06:25 INFO - Running main action method: clobber 18:06:25 INFO - rmtree: /builds/slave/test-pgo/build 18:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:06:26 INFO - Running post-action listener: _resource_record_post_action 18:06:26 INFO - ##### 18:06:26 INFO - ##### Running read-buildbot-config step. 18:06:26 INFO - ##### 18:06:26 INFO - Running pre-action listener: _resource_record_pre_action 18:06:26 INFO - Running main action method: read_buildbot_config 18:06:26 INFO - Using buildbot properties: 18:06:26 INFO - { 18:06:26 INFO - "properties": { 18:06:26 INFO - "buildnumber": 42, 18:06:26 INFO - "product": "firefox", 18:06:26 INFO - "script_repo_revision": "production", 18:06:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:06:26 INFO - "repository": "", 18:06:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:06:26 INFO - "buildid": "20151222155326", 18:06:26 INFO - "slavename": "talos-linux64-ix-042", 18:06:26 INFO - "pgo_build": "True", 18:06:26 INFO - "basedir": "/builds/slave/test-pgo", 18:06:26 INFO - "project": "", 18:06:26 INFO - "platform": "ubuntu64_hw", 18:06:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:06:26 INFO - "slavebuilddir": "test", 18:06:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:06:26 INFO - "branch": "mozilla-aurora", 18:06:26 INFO - "repo_path": "releases/mozilla-aurora", 18:06:26 INFO - "stage_platform": "linux64-pgo", 18:06:26 INFO - "builduid": "bd5bf6cabf254eecaeef57e3b8f03b0d", 18:06:26 INFO - "revision": "3f93f9d49477032fd076d7e3532113cc3c593178" 18:06:26 INFO - }, 18:06:26 INFO - "sourcestamp": { 18:06:26 INFO - "repository": "", 18:06:26 INFO - "hasPatch": false, 18:06:26 INFO - "project": "", 18:06:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 18:06:26 INFO - "changes": [ 18:06:26 INFO - { 18:06:26 INFO - "category": null, 18:06:26 INFO - "files": [ 18:06:26 INFO - { 18:06:26 INFO - "url": null, 18:06:26 INFO - "name": "https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 18:06:26 INFO - } 18:06:26 INFO - ], 18:06:26 INFO - "repository": "", 18:06:26 INFO - "rev": "3f93f9d49477032fd076d7e3532113cc3c593178", 18:06:26 INFO - "who": "kwierso@gmail.com", 18:06:26 INFO - "when": 1450836329, 18:06:26 INFO - "number": 7388340, 18:06:26 INFO - "comments": "Bug 1221424 - Disable v. unstable custom elements test, a=testonly", 18:06:26 INFO - "project": "", 18:06:26 INFO - "at": "Tue 22 Dec 2015 18:05:29", 18:06:26 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 18:06:26 INFO - "revlink": "", 18:06:26 INFO - "properties": [ 18:06:26 INFO - [ 18:06:26 INFO - "buildid", 18:06:26 INFO - "20151222155326", 18:06:26 INFO - "Change" 18:06:26 INFO - ], 18:06:26 INFO - [ 18:06:26 INFO - "builduid", 18:06:26 INFO - "bd5bf6cabf254eecaeef57e3b8f03b0d", 18:06:26 INFO - "Change" 18:06:26 INFO - ], 18:06:26 INFO - [ 18:06:26 INFO - "pgo_build", 18:06:26 INFO - "True", 18:06:26 INFO - "Change" 18:06:26 INFO - ] 18:06:26 INFO - ], 18:06:26 INFO - "revision": "3f93f9d49477032fd076d7e3532113cc3c593178" 18:06:26 INFO - } 18:06:26 INFO - ], 18:06:26 INFO - "revision": "3f93f9d49477032fd076d7e3532113cc3c593178" 18:06:26 INFO - } 18:06:26 INFO - } 18:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 18:06:26 INFO - Running post-action listener: _resource_record_post_action 18:06:26 INFO - ##### 18:06:26 INFO - ##### Running download-and-extract step. 18:06:26 INFO - ##### 18:06:26 INFO - Running pre-action listener: _resource_record_pre_action 18:06:26 INFO - Running main action method: download_and_extract 18:06:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:06: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')]} 18:06:26 INFO - https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:06:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/test_packages.json 18:06:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/test_packages.json 18:06:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:06:28 INFO - Downloaded 1302 bytes. 18:06:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:06:28 INFO - Using the following test package requirements: 18:06:28 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 18:06:28 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:06:28 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'jsshell-linux-x86_64.zip'], 18:06:28 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:06:28 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 18:06:28 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:06:28 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:06:28 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:06:28 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 18:06:28 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 18:06:28 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:06:28 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:28 INFO - https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:29 INFO - Downloaded 23022846 bytes. 18:06:29 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 18:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:29 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 18:06:30 INFO - Return code: 0 18:06:30 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 18:06:30 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')]} 18:06:30 INFO - https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:06:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:31 INFO - Downloaded 23022846 bytes. 18:06:31 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 18:06:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 18:06:31 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 18:06:32 INFO - Return code: 0 18:06:32 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')]} 18:06:32 INFO - https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 18:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 18:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:34 INFO - Downloaded 11132038 bytes. 18:06:34 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 18:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 18:06:34 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 18:06:34 INFO - Return code: 0 18:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:34 INFO - https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:06:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 18:06:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 18:06:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 18:06:37 INFO - Downloaded 58087013 bytes. 18:06:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 18:06:37 INFO - mkdir: /builds/slave/test-pgo/properties 18:06:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:06:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:06:37 INFO - Contents: 18:06:37 INFO - build_url:https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 18:06:37 INFO - Running post-action listener: _resource_record_post_action 18:06:37 INFO - Running post-action listener: set_extra_try_arguments 18:06:37 INFO - ##### 18:06:37 INFO - ##### Running populate-webroot step. 18:06:37 INFO - ##### 18:06:37 INFO - Running pre-action listener: _resource_record_pre_action 18:06:37 INFO - Running main action method: populate_webroot 18:06:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:06:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:06:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:06:37 INFO - '--tppagecycles', 18:06:37 INFO - '7'], 18:06:37 INFO - 'tests': ['tsvgm']}}, 18:06:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:06:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:06:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:06:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:06:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:06:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'tests': ['damp', 'tps']}, 18:06:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['damp', 'tps']}, 18:06:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:06:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:06:37 INFO - 'other': {'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'other_l64': {'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'other_nol64': {'tests': ['a11yr', 18:06:37 INFO - 'ts_paint', 18:06:37 INFO - 'tpaint', 18:06:37 INFO - 'sessionrestore', 18:06:37 INFO - 'sessionrestore_no_auto_restore']}, 18:06:37 INFO - 'svgr': {'tests': ['tsvgx', 18:06:37 INFO - 'tsvgr_opacity', 18:06:37 INFO - 'tart', 18:06:37 INFO - 'tscrollx', 18:06:37 INFO - 'cart']}, 18:06:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['tsvgx', 18:06:37 INFO - 'tsvgr_opacity', 18:06:37 INFO - 'tart', 18:06:37 INFO - 'tscrollx', 18:06:37 INFO - 'cart']}, 18:06:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'tests': ['tp5o']}, 18:06:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'talos_options': ['--e10s'], 18:06:37 INFO - 'tests': ['tp5o']}, 18:06:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'talos_options': ['--xperf_path', 18:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:37 INFO - 'tests': ['tp5n']}, 18:06:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:06:37 INFO - 'talos_options': ['--e10s', 18:06:37 INFO - '--xperf_path', 18:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:06:37 INFO - 'tests': ['tp5n']}}, 18:06:37 INFO - 'talos.zip': {'path': '', 18:06:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:06:37 INFO - Running post-action listener: _resource_record_post_action 18:06:37 INFO - ##### 18:06:37 INFO - ##### Running create-virtualenv step. 18:06:37 INFO - ##### 18:06:37 INFO - Running pre-action listener: _resource_record_pre_action 18:06:37 INFO - Running main action method: create_virtualenv 18:06:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:06:37 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 18:06:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:06:37 INFO - Using real prefix '/usr' 18:06:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:06:37 INFO - Installing distribute.............................................................................................................................................................................................done. 18:06:39 INFO - Installing pip.................done. 18:06:39 INFO - Return code: 0 18:06:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:06:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:06:39 INFO - Using env: {'DISPLAY': ':0', 18:06:39 INFO - 'HOME': '/home/cltbld', 18:06:39 INFO - 'LANG': 'en_US.UTF-8', 18:06:39 INFO - 'LANGUAGE': 'en_US:en', 18:06:39 INFO - 'LOGNAME': 'cltbld', 18:06:39 INFO - 'MAIL': '/var/mail/cltbld', 18:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:39 INFO - 'MOZ_NO_REMOTE': '1', 18:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:39 INFO - 'NO_EM_RESTART': '1', 18:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:39 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:39 INFO - 'SHELL': '/bin/bash', 18:06:39 INFO - 'SHLVL': '1', 18:06:39 INFO - 'TERM': 'linux', 18:06:39 INFO - 'TMOUT': '86400', 18:06:39 INFO - 'USER': 'cltbld', 18:06:39 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:39 INFO - '_': '/tools/buildbot/bin/python'} 18:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:40 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 18:06:40 INFO - Cleaning up... 18:06:40 INFO - Return code: 0 18:06:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:06:40 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')]} 18:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:40 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')]} 18:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:06:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:06:40 INFO - Using env: {'DISPLAY': ':0', 18:06:40 INFO - 'HOME': '/home/cltbld', 18:06:40 INFO - 'LANG': 'en_US.UTF-8', 18:06:40 INFO - 'LANGUAGE': 'en_US:en', 18:06:40 INFO - 'LOGNAME': 'cltbld', 18:06:40 INFO - 'MAIL': '/var/mail/cltbld', 18:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:40 INFO - 'MOZ_NO_REMOTE': '1', 18:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:40 INFO - 'NO_EM_RESTART': '1', 18:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:40 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:40 INFO - 'SHELL': '/bin/bash', 18:06:40 INFO - 'SHLVL': '1', 18:06:40 INFO - 'TERM': 'linux', 18:06:40 INFO - 'TMOUT': '86400', 18:06:40 INFO - 'USER': 'cltbld', 18:06:40 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:40 INFO - '_': '/tools/buildbot/bin/python'} 18:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:40 INFO - Downloading/unpacking psutil>=0.7.1 18:06:40 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 18:06:40 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 18:06:40 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 18:06:40 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 18:06:40 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 18:06:40 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 18:06:41 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:06:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:06:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:42 INFO - Installing collected packages: psutil 18:06:42 INFO - Running setup.py install for psutil 18:06:42 INFO - building 'psutil._psutil_linux' extension 18:06:42 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 18:06:42 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 18:06:42 INFO - building 'psutil._psutil_posix' extension 18:06:42 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 18:06:42 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 18:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:06:42 INFO - Successfully installed psutil 18:06:42 INFO - Cleaning up... 18:06:42 INFO - Return code: 0 18:06:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:06:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:06:42 INFO - Using env: {'DISPLAY': ':0', 18:06:42 INFO - 'HOME': '/home/cltbld', 18:06:42 INFO - 'LANG': 'en_US.UTF-8', 18:06:42 INFO - 'LANGUAGE': 'en_US:en', 18:06:42 INFO - 'LOGNAME': 'cltbld', 18:06:42 INFO - 'MAIL': '/var/mail/cltbld', 18:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:42 INFO - 'MOZ_NO_REMOTE': '1', 18:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:42 INFO - 'NO_EM_RESTART': '1', 18:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:42 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:42 INFO - 'SHELL': '/bin/bash', 18:06:42 INFO - 'SHLVL': '1', 18:06:42 INFO - 'TERM': 'linux', 18:06:42 INFO - 'TMOUT': '86400', 18:06:42 INFO - 'USER': 'cltbld', 18:06:42 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:42 INFO - '_': '/tools/buildbot/bin/python'} 18:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:42 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 18:06:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:06:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:06:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:06:44 INFO - Installing collected packages: mozsystemmonitor 18:06:44 INFO - Running setup.py install for mozsystemmonitor 18:06:44 INFO - Successfully installed mozsystemmonitor 18:06:44 INFO - Cleaning up... 18:06:44 INFO - Return code: 0 18:06:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:06:44 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')]} 18:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 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')]} 18:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:06:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:06:44 INFO - Using env: {'DISPLAY': ':0', 18:06:44 INFO - 'HOME': '/home/cltbld', 18:06:44 INFO - 'LANG': 'en_US.UTF-8', 18:06:44 INFO - 'LANGUAGE': 'en_US:en', 18:06:44 INFO - 'LOGNAME': 'cltbld', 18:06:44 INFO - 'MAIL': '/var/mail/cltbld', 18:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:44 INFO - 'MOZ_NO_REMOTE': '1', 18:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:44 INFO - 'NO_EM_RESTART': '1', 18:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:44 INFO - 'SHELL': '/bin/bash', 18:06:44 INFO - 'SHLVL': '1', 18:06:44 INFO - 'TERM': 'linux', 18:06:44 INFO - 'TMOUT': '86400', 18:06:44 INFO - 'USER': 'cltbld', 18:06:44 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:44 INFO - '_': '/tools/buildbot/bin/python'} 18:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:44 INFO - Downloading/unpacking blobuploader==1.2.4 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:44 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 18:06:46 INFO - Downloading blobuploader-1.2.4.tar.gz 18:06:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:06:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:06:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:06:46 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 18:06:46 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 18:06:46 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 18:06:46 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 18:06:46 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 18:06:46 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 18:06:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:06:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:47 INFO - Downloading docopt-0.6.1.tar.gz 18:06:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:06:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:06:47 INFO - Installing collected packages: blobuploader, requests, docopt 18:06:47 INFO - Running setup.py install for blobuploader 18:06:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:06:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:06:47 INFO - Running setup.py install for requests 18:06:47 INFO - Running setup.py install for docopt 18:06:47 INFO - Successfully installed blobuploader requests docopt 18:06:47 INFO - Cleaning up... 18:06:47 INFO - Return code: 0 18:06:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:06:47 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')]} 18:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:47 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')]} 18:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:06:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:06:47 INFO - Using env: {'DISPLAY': ':0', 18:06:47 INFO - 'HOME': '/home/cltbld', 18:06:47 INFO - 'LANG': 'en_US.UTF-8', 18:06:47 INFO - 'LANGUAGE': 'en_US:en', 18:06:47 INFO - 'LOGNAME': 'cltbld', 18:06:47 INFO - 'MAIL': '/var/mail/cltbld', 18:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:47 INFO - 'MOZ_NO_REMOTE': '1', 18:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:47 INFO - 'NO_EM_RESTART': '1', 18:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:47 INFO - 'SHELL': '/bin/bash', 18:06:47 INFO - 'SHLVL': '1', 18:06:47 INFO - 'TERM': 'linux', 18:06:47 INFO - 'TMOUT': '86400', 18:06:47 INFO - 'USER': 'cltbld', 18:06:47 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:47 INFO - '_': '/tools/buildbot/bin/python'} 18:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:06:48 INFO - Running setup.py (path:/tmp/pip-_DifWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:06:48 INFO - Running setup.py (path:/tmp/pip-hclHeN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:06:48 INFO - Running setup.py (path:/tmp/pip-gQfAHp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:06:48 INFO - Running setup.py (path:/tmp/pip-DCNjcv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:06:48 INFO - Running setup.py (path:/tmp/pip-4jF1YU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:06:48 INFO - Running setup.py (path:/tmp/pip-wNetN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:06:48 INFO - Running setup.py (path:/tmp/pip-ujeYKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:06:48 INFO - Running setup.py (path:/tmp/pip-PTcHth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:06:48 INFO - Running setup.py (path:/tmp/pip-2pQWek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:06:48 INFO - Running setup.py (path:/tmp/pip-P3t4NT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:06:48 INFO - Running setup.py (path:/tmp/pip-YdECQ2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:06:48 INFO - Running setup.py (path:/tmp/pip-VUzNLS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:06:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:06:48 INFO - Running setup.py (path:/tmp/pip-4HWQE9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:06:49 INFO - Running setup.py (path:/tmp/pip-F9YHxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:06:49 INFO - Running setup.py (path:/tmp/pip-XDeaPZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:06:49 INFO - Running setup.py (path:/tmp/pip-01zzjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:06:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:06:49 INFO - Running setup.py (path:/tmp/pip-4CbJC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:06:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:06:49 INFO - Running setup.py install for manifestparser 18:06:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:06:49 INFO - Running setup.py install for mozcrash 18:06:49 INFO - Running setup.py install for mozdebug 18:06:49 INFO - Running setup.py install for mozdevice 18:06:49 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:06:49 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:06:49 INFO - Running setup.py install for mozfile 18:06:49 INFO - Running setup.py install for mozhttpd 18:06:49 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:06:49 INFO - Running setup.py install for mozinfo 18:06:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for mozInstall 18:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for mozleak 18:06:50 INFO - Running setup.py install for mozlog 18:06:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for moznetwork 18:06:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for mozprocess 18:06:50 INFO - Running setup.py install for mozprofile 18:06:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for mozrunner 18:06:50 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:06:50 INFO - Running setup.py install for mozscreenshot 18:06:50 INFO - Running setup.py install for moztest 18:06:51 INFO - Running setup.py install for mozversion 18:06:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:06:51 INFO - Cleaning up... 18:06:51 INFO - Return code: 0 18:06:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:06: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')]} 18:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:06:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:06:51 INFO - Using env: {'DISPLAY': ':0', 18:06:51 INFO - 'HOME': '/home/cltbld', 18:06:51 INFO - 'LANG': 'en_US.UTF-8', 18:06:51 INFO - 'LANGUAGE': 'en_US:en', 18:06:51 INFO - 'LOGNAME': 'cltbld', 18:06:51 INFO - 'MAIL': '/var/mail/cltbld', 18:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:51 INFO - 'MOZ_NO_REMOTE': '1', 18:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:51 INFO - 'NO_EM_RESTART': '1', 18:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:51 INFO - 'SHELL': '/bin/bash', 18:06:51 INFO - 'SHLVL': '1', 18:06:51 INFO - 'TERM': 'linux', 18:06:51 INFO - 'TMOUT': '86400', 18:06:51 INFO - 'USER': 'cltbld', 18:06:51 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:51 INFO - '_': '/tools/buildbot/bin/python'} 18:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:06:51 INFO - Running setup.py (path:/tmp/pip-BRPf3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:06:51 INFO - Running setup.py (path:/tmp/pip-1tqw__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:06:51 INFO - Running setup.py (path:/tmp/pip-315wkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:06:51 INFO - Running setup.py (path:/tmp/pip-skFEB_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:06:51 INFO - Running setup.py (path:/tmp/pip-bc6H5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:06:51 INFO - Running setup.py (path:/tmp/pip-xnF6uU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:06:51 INFO - Running setup.py (path:/tmp/pip-cEQdl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:06:51 INFO - Running setup.py (path:/tmp/pip-qVRNkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:06:51 INFO - Running setup.py (path:/tmp/pip-Y7UkJ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:06:51 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)) 18:06:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:06:52 INFO - Running setup.py (path:/tmp/pip-wU0W4w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:06:52 INFO - Running setup.py (path:/tmp/pip-e3MFYE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:06:52 INFO - Running setup.py (path:/tmp/pip-zfGC_Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:06:52 INFO - Running setup.py (path:/tmp/pip-miWg6V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:06:52 INFO - Running setup.py (path:/tmp/pip-u6RxUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:06:52 INFO - Running setup.py (path:/tmp/pip-f0uj44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:06:52 INFO - Running setup.py (path:/tmp/pip-dTmVTH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:06:52 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)) 18:06:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:06:52 INFO - Running setup.py (path:/tmp/pip-2xmLwY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:06:52 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)) 18:06:52 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)) 18:06:52 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)) 18:06:52 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)) 18:06:52 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)) 18:06:52 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)) 18:06:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:06:54 INFO - Downloading blessings-1.5.1.tar.gz 18:06:54 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:06:54 INFO - Installing collected packages: blessings 18:06:54 INFO - Running setup.py install for blessings 18:06:54 INFO - Successfully installed blessings 18:06:54 INFO - Cleaning up... 18:06:54 INFO - Return code: 0 18:06:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:06:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:06:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:06:54 INFO - Reading from file tmpfile_stdout 18:06:54 INFO - Current package versions: 18:06:54 INFO - argparse == 1.2.1 18:06:54 INFO - blessings == 1.5.1 18:06:54 INFO - blobuploader == 1.2.4 18:06:54 INFO - docopt == 0.6.1 18:06:54 INFO - manifestparser == 1.1 18:06:54 INFO - mozInstall == 1.12 18:06:54 INFO - mozcrash == 0.16 18:06:54 INFO - mozdebug == 0.1 18:06:54 INFO - mozdevice == 0.47 18:06:54 INFO - mozfile == 1.2 18:06:54 INFO - mozhttpd == 0.7 18:06:54 INFO - mozinfo == 0.9 18:06:54 INFO - mozleak == 0.1 18:06:54 INFO - mozlog == 3.1 18:06:54 INFO - moznetwork == 0.27 18:06:54 INFO - mozprocess == 0.22 18:06:54 INFO - mozprofile == 0.27 18:06:54 INFO - mozrunner == 6.11 18:06:54 INFO - mozscreenshot == 0.1 18:06:54 INFO - mozsystemmonitor == 0.0 18:06:54 INFO - moztest == 0.7 18:06:54 INFO - mozversion == 1.4 18:06:54 INFO - psutil == 3.1.1 18:06:54 INFO - requests == 1.2.3 18:06:54 INFO - wsgiref == 0.1.2 18:06:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:06:54 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')]} 18:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:54 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')]} 18:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:06:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:06:54 INFO - Using env: {'DISPLAY': ':0', 18:06:54 INFO - 'HOME': '/home/cltbld', 18:06:54 INFO - 'LANG': 'en_US.UTF-8', 18:06:54 INFO - 'LANGUAGE': 'en_US:en', 18:06:54 INFO - 'LOGNAME': 'cltbld', 18:06:54 INFO - 'MAIL': '/var/mail/cltbld', 18:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:54 INFO - 'MOZ_NO_REMOTE': '1', 18:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:54 INFO - 'NO_EM_RESTART': '1', 18:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:54 INFO - 'SHELL': '/bin/bash', 18:06:54 INFO - 'SHLVL': '1', 18:06:54 INFO - 'TERM': 'linux', 18:06:54 INFO - 'TMOUT': '86400', 18:06:54 INFO - 'USER': 'cltbld', 18:06:54 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:54 INFO - '_': '/tools/buildbot/bin/python'} 18:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 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)) 18:06:54 INFO - Cleaning up... 18:06:55 INFO - Return code: 0 18:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:06:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:06:55 INFO - Using env: {'DISPLAY': ':0', 18:06:55 INFO - 'HOME': '/home/cltbld', 18:06:55 INFO - 'LANG': 'en_US.UTF-8', 18:06:55 INFO - 'LANGUAGE': 'en_US:en', 18:06:55 INFO - 'LOGNAME': 'cltbld', 18:06:55 INFO - 'MAIL': '/var/mail/cltbld', 18:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:55 INFO - 'MOZ_NO_REMOTE': '1', 18:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:55 INFO - 'NO_EM_RESTART': '1', 18:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:55 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:55 INFO - 'SHELL': '/bin/bash', 18:06:55 INFO - 'SHLVL': '1', 18:06:55 INFO - 'TERM': 'linux', 18:06:55 INFO - 'TMOUT': '86400', 18:06:55 INFO - 'USER': 'cltbld', 18:06:55 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:55 INFO - '_': '/tools/buildbot/bin/python'} 18:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:55 INFO - Downloading/unpacking jsonschema 18:06:55 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 18:06:55 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 18:06:55 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 18:06:55 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 18:06:55 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 18:06:55 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 18:06:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:06:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:06:56 INFO - Downloading/unpacking functools32 (from jsonschema) 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:56 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 18:06:57 INFO - Downloading functools32-3.2.3-2.tar.gz 18:06:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:06:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:06:57 INFO - warning: no files found matching '*.txt' 18:06:57 INFO - no previously-included directories found matching 'build' 18:06:57 INFO - no previously-included directories found matching 'dist' 18:06:57 INFO - no previously-included directories found matching '.git*' 18:06:57 INFO - Installing collected packages: jsonschema, functools32 18:06:57 INFO - Running setup.py install for functools32 18:06:57 INFO - warning: no files found matching '*.txt' 18:06:57 INFO - no previously-included directories found matching 'build' 18:06:57 INFO - no previously-included directories found matching 'dist' 18:06:57 INFO - no previously-included directories found matching '.git*' 18:06:57 INFO - Successfully installed jsonschema functools32 18:06:57 INFO - Cleaning up... 18:06:57 INFO - Return code: 0 18:06:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:06: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')]} 18:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06: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')]} 18:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:06:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0674715f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b73500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, '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': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', '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 18:06:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:06:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:06:57 INFO - Using env: {'DISPLAY': ':0', 18:06:57 INFO - 'HOME': '/home/cltbld', 18:06:57 INFO - 'LANG': 'en_US.UTF-8', 18:06:57 INFO - 'LANGUAGE': 'en_US:en', 18:06:57 INFO - 'LOGNAME': 'cltbld', 18:06:57 INFO - 'MAIL': '/var/mail/cltbld', 18:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:57 INFO - 'MOZ_NO_REMOTE': '1', 18:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:57 INFO - 'NO_EM_RESTART': '1', 18:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:06:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:06:57 INFO - 'SHELL': '/bin/bash', 18:06:57 INFO - 'SHLVL': '1', 18:06:57 INFO - 'TERM': 'linux', 18:06:57 INFO - 'TMOUT': '86400', 18:06:57 INFO - 'USER': 'cltbld', 18:06:57 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:57 INFO - '_': '/tools/buildbot/bin/python'} 18:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:06:57 INFO - Downloading/unpacking flake8 18:06:57 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 18:06:57 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 18:06:57 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 18:06:57 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 18:06:57 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 18:06:57 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 18:06:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:06:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:06:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:06:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 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 18:06:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:06:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:06:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:06:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:06:59 INFO - no previously-included directories found matching 'docs/_build' 18:06:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:06:59 INFO - Running setup.py install for pep8 18:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:07:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:07:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:07:00 INFO - no previously-included directories found matching 'docs/_build' 18:07:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:07:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:07:00 INFO - Cleaning up... 18:07:00 INFO - Return code: 0 18:07:00 INFO - Running post-action listener: _resource_record_post_action 18:07:00 INFO - Running post-action listener: _start_resource_monitoring 18:07:00 INFO - Starting resource monitoring. 18:07:00 INFO - ##### 18:07:00 INFO - ##### Running install step. 18:07:00 INFO - ##### 18:07:00 INFO - Running pre-action listener: _resource_record_pre_action 18:07:00 INFO - Running main action method: install 18:07:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:07:00 INFO - Reading from file tmpfile_stdout 18:07:00 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:07:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:07:00 INFO - Reading from file tmpfile_stdout 18:07:00 INFO - Output received: 18:07:00 INFO - Usage: mozinstall [options] installer 18:07:00 INFO - Options: 18:07:00 INFO - -h, --help show this help message and exit 18:07:00 INFO - -d DEST, --destination=DEST 18:07:00 INFO - Directory to install application into. [default: 18:07:00 INFO - "/builds/slave/test-pgo"] 18:07:00 INFO - --app=APP Application being installed. [default: firefox] 18:07:00 INFO - mkdir: /builds/slave/test-pgo/build/application 18:07:00 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'] 18:07:00 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 18:07:16 INFO - Reading from file tmpfile_stdout 18:07:16 INFO - Output received: 18:07:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:07:16 INFO - Running post-action listener: _resource_record_post_action 18:07:16 INFO - ##### 18:07:16 INFO - ##### Running run-tests step. 18:07:16 INFO - ##### 18:07:16 INFO - Running pre-action listener: _resource_record_pre_action 18:07:16 INFO - Running main action method: run_tests 18:07:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:07:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:07:16 INFO - Python 2.7.3 18:07:16 INFO - Return code: 0 18:07:16 INFO - grabbing minidump binary from tooltool 18:07:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:16 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 0x2b706a0>, '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 0x2b715a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b71a30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:07:16 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 18:07:16 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 18:07:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:16 INFO - Return code: 0 18:07:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:07:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:07:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:07:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:07:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:07:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:07:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:07:17 INFO - Return code: 0 18:07:17 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/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 18:07:17 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/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 18:07:17 INFO - Using env: {'DISPLAY': ':0', 18:07:17 INFO - 'HOME': '/home/cltbld', 18:07:17 INFO - 'LANG': 'en_US.UTF-8', 18:07:17 INFO - 'LANGUAGE': 'en_US:en', 18:07:17 INFO - 'LOGNAME': 'cltbld', 18:07:17 INFO - 'MAIL': '/var/mail/cltbld', 18:07:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:07:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:17 INFO - 'MOZ_NO_REMOTE': '1', 18:07:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:17 INFO - 'NO_EM_RESTART': '1', 18:07:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:07:17 INFO - 'PWD': '/builds/slave/test-pgo', 18:07:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:07:17 INFO - 'SHELL': '/bin/bash', 18:07:17 INFO - 'SHLVL': '1', 18:07:17 INFO - 'TERM': 'linux', 18:07:17 INFO - 'TMOUT': '86400', 18:07:17 INFO - 'USER': 'cltbld', 18:07:17 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1450836088.801893-80712015', 18:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:17 INFO - '_': '/tools/buildbot/bin/python'} 18:07:17 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/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 18:07:17 INFO - mozversion INFO | application_buildid: 20151222155326 18:07:17 INFO - mozversion INFO | application_changeset: 3f93f9d49477032fd076d7e3532113cc3c593178 18:07:17 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 18:07:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:17 INFO - mozversion INFO | application_name: Firefox 18:07:17 INFO - mozversion INFO | application_remotingname: firefox-dev 18:07:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:07:17 INFO - mozversion INFO | application_vendor: Mozilla 18:07:17 INFO - mozversion INFO | application_version: 45.0a2 18:07:17 INFO - mozversion INFO | platform_buildid: 20151222155326 18:07:17 INFO - mozversion INFO | platform_changeset: 3f93f9d49477032fd076d7e3532113cc3c593178 18:07:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:07:17 INFO - mozversion INFO | platform_version: 45.0a2 18:07:17 INFO - 2015-12-22 18:07:17,266 DEBUG : using testdate: 1450836437 18:07:17 INFO - 2015-12-22 18:07:17,266 DEBUG : actual date: 1450836437 18:07:17 INFO - 2015-12-22 18:07:17,274 INFO : starting webserver on 'localhost:46092' 18:07:17 INFO - 2015-12-22 18:07:17,275 INFO : Starting test suite talos-linux64-ix-042.e 18:07:17 INFO - 2015-12-22 18:07:17,275 INFO : Starting test dromaeo_css 18:07:17 INFO - 2015-12-22 18:07:17,276 DEBUG : operating with platform_type : linux_ 18:07:17 INFO - 2015-12-22 18:07:17,276 INFO : Initialising browser for dromaeo_css test... 18:07:17 INFO - 2015-12-22 18:07:17,290 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl1ZWFP/profile http://localhost:46092/getInfo.html 18:07:22 INFO - 2015-12-22 18:07:22,237 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:07:22 INFO - 2015-12-22 18:07:22,237 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:07:22 INFO - 2015-12-22 18:07:22,238 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:07:22 INFO - 2015-12-22 18:07:22,238 DEBUG : BROWSER_OUTPUT: __metrics 18:07:23 INFO - 2015-12-22 18:07:23,231 INFO : Browser initialized. 18:07:23 INFO - 2015-12-22 18:07:23,232 INFO : Running cycle 1/1 for dromaeo_css test... 18:07:23 INFO - 2015-12-22 18:07:23,232 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpl1ZWFP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:07:34 INFO - 2015-12-22 18:07:34,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 138153984 18:07:34 INFO - 2015-12-22 18:07:34,998 DEBUG : BROWSER_OUTPUT: 18:08:24 INFO - 2015-12-22 18:08:24,637 DEBUG : BROWSER_OUTPUT: 1450836504636 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] 18:10:32 INFO - 2015-12-22 18:10:32,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46092/tests/dromaeo/cssquery-ext.html) 18:10:33 INFO - 2015-12-22 18:10:33,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 141877248 18:10:33 INFO - 2015-12-22 18:10:33,451 DEBUG : BROWSER_OUTPUT: 18:13:35 INFO - 2015-12-22 18:13:35,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-ext.html (next: http://localhost:46092/tests/dromaeo/cssquery-jquery.html) 18:13:35 INFO - 2015-12-22 18:13:35,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 140554240 18:13:35 INFO - 2015-12-22 18:13:35,794 DEBUG : BROWSER_OUTPUT: 18:16:37 INFO - 2015-12-22 18:16:37,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46092/tests/dromaeo/cssquery-mootools.html) 18:16:38 INFO - 2015-12-22 18:16:38,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 140304384 18:16:38 INFO - 2015-12-22 18:16:38,004 DEBUG : BROWSER_OUTPUT: 18:19:39 INFO - 2015-12-22 18:19:39,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46092/tests/dromaeo/cssquery-prototype.html) 18:19:40 INFO - 2015-12-22 18:19:40,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 139763712 18:19:40 INFO - 2015-12-22 18:19:40,141 DEBUG : BROWSER_OUTPUT: 18:22:42 INFO - 2015-12-22 18:22:42,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46092/tests/dromaeo/cssquery-yui.html) 18:22:42 INFO - 2015-12-22 18:22:42,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 140038144 18:22:42 INFO - 2015-12-22 18:22:42,970 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,106 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/dromaeo/cssquery-yui.html (next: http://localhost:46092/tests/dromaeo/cssquery-dojo.html) 18:25:45 INFO - 2015-12-22 18:25:45,356 DEBUG : BROWSER_OUTPUT: RSS: Main: 142635008 18:25:45 INFO - 2015-12-22 18:25:45,357 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,358 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:25:45 INFO - 2015-12-22 18:25:45,358 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:25:45 INFO - 2015-12-22 18:25:45,358 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:25:45 INFO - 2015-12-22 18:25:45,358 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:25:45 INFO - 2015-12-22 18:25:45,362 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3350.36343094812;3365.242820365418;3380.1380647934775;3393.677600627941;3400.642932492088;5416.702081385522;5440.347158340995;5440.537554307879;5447.536959358449;5477.972610136943;5432.402435732066;5473.507384335409;5507.311586051744;5511.035568775468;5529.529989950859;4994.5005499450035;5023.974880125595;5075.111855425304;5103.15797893349;5111.974440127813;4846.9515304846855;5003.249512573125;5012.273220383042;5024.246363045554;5116.769745361467;5017.84946451607;5101.081805275049;5107.770150343244;5112.539871411572;5114.335136432259;5099.821506247282;5162.586993040548;5167.044096842096;5181.974090129563;5197.8440646780655;4843.636727245471;4931.43288521821;4932.778024988884;5075;5092.618053645954;5282.418933917266;5352.946470535323;5354.625176237665;5378.462153784591;5397.055515284848;5935.0503919372695;5950.404959504058;6005.519558435359;6021.157038014681;6025.0661147522205;5892.970535147339;5930.258717660293;5985.551083668743;5992.940070599282;6012.947734146507;5580.748866301026;5587.1339942309005;5597.160425936061;5627.324721033461;5629.437056294338;6005.759769609254;6012.819615411545;6040.456358927718;6045.153678485016;6049.304330002018;5714.485696287354;5744.425557444306;5809.651420914759;5861.501772349398;5871.6770577618645;5928.79249226275;5933.139694744238;5946.67293298864;5948.167256584082;5985.191999080155;5855.648661080349;5863.120531920246;5875.148103524965;5884.08796636522;5910.143029260733;5701.945140149002;5781.739821707949;5862.677552734641;5928.970355148197;5959.106134079922;4524.5701658342405;4593.242115051046;4605.102005108972;4608.631309495232;4635.582797548237;4033.2941735196223;4127.2570937231585;4133.7106402551535;4152.211079894871;4170.207660544487;5429.864253393618;5556.499915007668;5596.552275817925;5642.830715078554;5647.943520564741;5990.071538911476;5991.2510936132985;5994.520438364921;6007.669578173155;6007.8197654070445;5525.972370138204;5657.32112146545;5717.771289148471;5722.198892155102;5730.19777231188;5164.638475306692;5206.140986737146;5234.712090835041;5252.894942101137;5272.209168624737;6107.511399088063;6126.326104128542;6133.355997620275;6170.876582468325;6189.442950134509;5713.171590119493;5907.143464197753;6020.638761674226;6032.336442991355;6034.426729460694;5978.893904627658;6013.067974463965;6051.273847138372;6066.3630318815885;6095.786647467317;5859.58982871212;5879.559033072451;5912.054071348563;5913.674747888907;5939.881202375842;5970.194023806731;5971.164037034905;5996.730147143302;6021.036634138517;6096.055111457731;5884.558658100574;5899.292084949833;5908.793192238251;5916.556258280732;5927.644341339534;5887.1757953885635;5894.616849904743;5897.292324921037;5900.085486749561;5912.940870591411;5471.316085489314;5563.165525171256;5608;5608.2148499209325;5801.100829371454;5851.590388672922;5880.176775251382;5892.734826932712;5959.821205363846;5965.105234214902;5743.8564035899435;5767.942320576741;5772.105323674838;5784.190213370216;5805.158252053344 18:25:45 INFO - 2015-12-22 18:25:45,362 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.2964831147557;629.2826178156902;629.6002038705426;652.6638781027772;661.2131563439508;31254.374912501735;40088.79955600222;40512.594874051254;40668;40786.59213407865;43222.56777432225;43752.343714844304;44004.77997610015;44108;44128.77935610325;8949.373543851916;9029.95485022574;9073.909260907405;9123.771905702344;9127.132922372397;8932.687355942544;9053.230475409599;9054.366194366397;9059.864102038475;9073.410228335137;8992.370534062618;9082.591283392263;9092.909070909305;9100.135487128713;9104.45373277602;8929.508877011762;9018.36871419001;9025.729228123168;9029.322800789902;9035.593398297027;8915.197632213132;9062.546872656407;9079.68221112258;9101.271898248124;9105.772355691095;41159.176816463805;41288.38067428991;41301.58698413037;41444.1711165775;41487;3511.17487390463;3537.188114095178;3697.926041479155;3774.565924918642;3796.5823759386444;31744.365112697848;32202.6779732202;32277.838610806797;32385;32765.344693106243;3883.0874744435037;3901.2197560487734;3951.6443520083044;4018.2365350583295;4038.414429907647;276645;277071;277520;278566;279250.99999999796;43551;44048.779756101656;44220.55779442229;59297;59775;42119.57880421157;42262.36606450906;42294.15411691749;42448.78775606102;42678.78660606677;16292.42976495817;16418.1790910454;16454.177291135395;16488.917555412387;16631.6673666526;12014.279143251433;12063.336516491501;12099.153059285942;12146.757064858653;12190.695232619079;14925.328360223815;15025.323860426308;15105.697886042217;15140.697186056217;15201.543953681406;6046.455818976313;6177.289611694623;6210.844728881814;6235.812925612239;6307.9369206308265;982.7641366072235;1024.6567399920962;1068.6099573655715;1069.6202847989007;1079.9308684402386;28702.99539516107;33605.327893441994;34264.31471370609;34265;34267.828660857034;1073.5330527358258;1107.789519991199;1158.3860553906443;1178.8290697848936;1185.1690229545936;14975.32611032506;15206.467773628092;15231.390744370323;15453.072815631098;15637.530874073796;403110;554538;790446;797082;816949;59326;59371.40628593745;59595.404045959855;59656;60144.097838532456;1521.0721459909446;1541.537538738374;1553.5028790787067;1554.3471741868443;1561.4534912780664;31203.84398077995;31227;31455.685443145274;31679.366412671156;31705.841470792497;49766;49851;49909.500904990484;50178.74910625423;50273.74863125661;307826;309132;310047;310480;311977;34417.13957151091;34846.825765871006;34899.302013960085;35058;35509.467357990165;46193.53806461892;46561;46744.53255467402;47029.764851175525;47898.281525776445;39369.60630393659;39537;40108.59891401165;40514.79742601268;40619.7969010153;41682;45538;46128.76935615435;46524.767376162905;46590.767046164554;43341.783291083346;43484.34773478337;43723;43950;44578.10843783171;33910;39757.403638946016;39936.4009539863;39937;40936.59063409328;26361;26456.470870582096;26461.603075954263;26555;27308.31729206786 18:25:45 INFO - 2015-12-22 18:25:45,366 DEBUG : BROWSER_OUTPUT: |2;jquery.html;372.13293027246516;375.61499463050376;377.21915634636315;377.30199131606514;381.9713521485888;15655.608609784733;16994.150292485374;18335.083245837723;18779.436616901497;18922.905385473052;10165.59337626494;11609.361485118316;11723.765524689501;15388.15365154916;17672.116394180302;5037.773300201499;5152.407473140581;5166.992436474889;5167.974160129213;5169.09540830355;5247.422783493813;5324.973375133139;5327.094393953037;5392.946070539303;5444.809431669893;5245.842624721265;5309.840704778863;5331.946680533184;5336.546393556533;5444.346678398578;5567.9977604031255;5584.050711379055;5587.580931430159;5597.7201139943045;5599.608027438081;5090.745462726849;5252.133397989327;5366.168243922199;5382.681243095428;5393;20649.17403303866;20679.5864082719;23513.294601161822;23987.88006059976;24265.514689706106;2326.162581470669;2329.988350058256;2349.9072931087126;2378.452955820154;2442.426029882976;15130.773038404433;15568.922155389264;15850.44523441674;16081.919590401973;16208.594785130348;2140.9571808563896;2174.967375489369;2186.6719992001167;2195.1658369819525;2272.4773302140434;69297.30702692959;69915;73792.26207737907;74589.88115178331;76012.23987760107;16720.41478548245;16850.578735531464;16894.15529223534;16928.322867085426;17140.914295428443;26512.602310964965;26515.602265966027;26606.86696566505;26756.331091722863;26965.247258928106;10199.18406527476;10277.126444252173;10284.537195826206;10329.483525823678;10350;8848.070952550019;8911.598978046004;8950.328725345626;8963.641454341883;8968.148025937526;4474.440694913136;8476.915230847735;8478.915210847812;8506.702265420805;8670.219680228809;1950.7366505521572;1961.4017724594137;1963.1656545967905;1969.793171716949;1971.684530475117;879.2306731609841;955.5799219063974;1020.8570800087994;1043.7338478687886;1109.7891400633853;17400.91299543494;18046.729299060524;18157.909210453865;18435.170417331254;18621.255149793855;978.83849164887;980.352967041749;1028.2596530498029;1044.9268551201344;1073.388168743824;10281.12610428122;10343.224258180666;10603.681889543172;10764.300320479144;10849.78300433987;714464;715700;723142;724799;725370;84012;84665;86746.13253867507;87567.12432875589;87673.56163219143;1206.3485717712513;1216.6593353860933;1254.8305978692943;1257.1137348169518;1275.64282001038;16733.91633041827;16802.243899024328;16817.243224054702;17127;17207.13964301805;38635.806820965714;39076.2184756309;39430.408543872436;39459.40810887782;39494.60505394909;44689.32966005577;46677.76661116809;47715.76142119267;47836;49882.50117498924;9478.38390504615;10150.54322555472;10244.64143754965;10250.948745256524;10322.587096516056;17584.472465826046;18113.547161321072;18357.81642183561;18516.444506664822;18812.435626931216;14785.408583656963;14882.330295136528;15115.31981060833;15455.768163477782;15880.841191588399;14672.26638668041;14985.40058397652;15409.152496612345;15537.76693349578;15703.293351798968;15157;15160.620984475476;15511.301991410188;15658;15830.762538562161;9669.468179250209;10155.543000564845;10300.227482938659;10330.638427654996;10353.17174626013;15824.841751582797;15872.682546348777;16026;16070.517884463485;16196.838031619533 18:25:45 INFO - 2015-12-22 18:25:45,367 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1556.5096994446749;1558.7038462692094;1790.5165605286566;1792.8834625749328;1843.8524918006556;7177.82055448614;7559.7354092606765;7590.62046897655;7715.537067775937;7985.92014079859;7952.085510166333;7972.481788683746;8046.718364857216;8084.636191371388;8091.838163236732;2264.7055882735262;2301.5972204864165;2302.1482051640915;2304.7810458006547;2307.1348244408346;2326.150954901466;2340.0405833608224;2364.160722943356;2366.538524987628;2381.3570336009266;2301.6892719482908;2315.918942837001;2338.1115176233006;2351.2593533037125;2366.230974933145;2265.784750448705;2269.375921621551;2281.1103669568884;2287.9199228027023;2298.9885050574726;2320.4198950262435;2375.002498950445;2376.845505042184;2378.3935096550267;2378.690770199863;7714.807129821799;7734.767956961244;7782.105057918356;7798.454108212427;7807;4799.496052914428;4848.587870031051;4896.02079584081;4896.730679812609;4901.926471102936;3091.7990330628436;3142.4186525492855;3174.3809957058384;3177.634572024224;3186.8087914725193;1016.6238491758097;1036.9014943580348;1056.387295368692;1059.5708737961138;1077.342820879271;10707.250492465531;10780.353178809297;10799.946000269949;10803.729906752316;10821.83767243492;4333.609975102256;4338.674599405057;4393.033532622818;4400.3399490076745;4407.382966384709;9383.202427793714;9396.812063758687;9401.90598094024;9437.386569872937;9465.337426380087;4900.485449027872;4926.75366231687;4946.802127914843;4953.108440480676;4967.925481117786;4507.57178068083;4507.774611269489;4512.729236245836;4535.138323718483;4543;3681.0981309579324;3748.775073495599;3755.8356909358185;3773.603771603997;3773.698074164409;1151.3322273081592;1157.5948418053783;1158.362900404791;1175.9000484958704;1189.482575079843;1061.7557961668858;1103.9282446640943;1114.1198453221864;1221.6029790318182;1400.0969374753226;7528.5859277739155;7533.020707308015;7552.358049565849;7559.659815308324;7602.353799926957;1139.9544018239344;1230.059004861282;1237.2452803789681;1241.9565315213924;1259.8614152443224;5676.148577713376;5698.886022279531;5755.625884317506;5769.971150144306;5786.855328616734;9358.064193580587;9508.90491095094;9516.476593787269;9546.95226523863;9650.903490965;9269.119433653792;9462.763430914145;9483.715488535356;9485.33602647808;9515.286353523514;7445.516041457288;7469.663865126083;7501.024866767176;7517.060367454068;7563.621818909032;7147.356737893615;7166.856662866818;7240.384567311838;7254.274572542704;7287.344139027513;8295.95852020736;8405.495670259805;8413.70552030676;8433.662653493791;8494.617742201492;8417.663293468193;8570.271526920282;8643.351748618754;8648.78378040554;8650.826983460169;6784.93215067843;6816.488763342868;6821.113255276782;6833.487488438288;6841.350071743176;7371.189169191492;7371.926280737124;7424.0348754661545;7450.925490745023;7475.813104672427;7098.929010709827;7123.180834204133;7221.061262035902;7322.524035937647;7372.41020718352;6985;7202.747903823341;7260.927390726237;7287.526310789782;7292;6800.897986530107;7073.045138906387;7081.8937715935335;7087.64561771899;7175.31834475724;6548.705308261235;6575;6589.703463344065;6597.208334999831;6604.504662150454;6663.633500157538;6679.465642748665;6684.131062961784;6716.126903502513;6744.69648865812 18:25:45 INFO - 2015-12-22 18:25:45,368 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.46461071537306;333.773034336651;343.9071450708309;345.17847522895505;351.6975401155007;6237.5945563538335;6316.115743795866;6336.334684858092;6359.777407790728;6361.5864968777;6169.691515424233;6331.2085989251345;6331.398517140876;6342.0486926960975;6342.238931328236;4838.104950584153;4853.344798452199;4880.633952453562;4891.559759621633;4892.217245240762;4884.658073934826;4893.04585605807;4895.681780684262;4905.3132561441425;4911.803527858881;4777.426708794949;4842.588379987706;4878;4878.414590249157;4882.682625629341;4809.927851082237;4834.830780922668;4859.052484765472;4864.927026094611;4866.075445665312;4118.855840045584;4213.578642135762;4262.445882035347;4264.87205383839;4282.42187304713;6031.758729650809;6041.848953776147;6048.69756512177;6056.6063205891915;6086.2087928569445;5621.606487545873;5622.775088996435;5627.184058311522;5631.690257035862;5643.492085712305;6600.174978127734;6705.731770729165;6714.6306953117555;6732.966335168342;6733.49498787588;4599.563041511051;4602.3786788783755;4602.470715867685;4617.399738034068;4620.052889157714;6885.242623311432;6983.580985140908;7003.474739394565;7006.684699188498;7021.473389495808;4580.770961451981;4590.770461476913;4601.838935637236;4603.056373443436;4623.214053610895;4629.189891768927;4687.7656117194;4690.71855688653;4808.374911261583;4848.248521479177;5592.636478628958;5594.13290939905;5597.692126933058;5601.271834661549;5608.046632072557;6801.537669401004;6823.078884350648;6827.044213810071;6828.624425656637;6834.760783372558;1698.5923378389098;1708.1630001299523;1711.5122190175741;1713.742938559201;1714.4428060880264;1117.5976648406568;1149.6378640728144;1155.8959693627614;1167.4746364136172;1174.8883856033663;6527.086207930894;6545.4436372907885;6556;6558.409743123142;6563.015547667888;6947.270536593686;6976.930230697628;7005.894911576331;7008.088948436773;7014.158301003912;6397.872042559123;6405.071264666597;6526;6534.052562378429;6559.081728558006;3765.9246815064093;3792.7534710243744;3794.0894185395305;3798;3806.410006449005;7135.179454362711;7329.377002954702;7334.963325183447;7341.88987165193;7358.558486490828;7275.126984761757;7277.19950805411;7280.3083707047745;7294.8176295591975;7323.304286092813;7193.820154496179;7283.053203083565;7320.7071717131785;7328.78013659591;7329.19378868324;7090;7124.323189297009;7141.64291785419;7149.177844547736;7152.570845749272;7009.9649501752165;7014.403775679124;7020.613866237406;7028;7029.824254393681;7138.964305178441;7284.599347035964;7334.743283985248;7346.7061317546695;7347.853042939005;4789.377380940595;4810.927836082392;4813.518648135158;4827.541383568555;4846.854594362175;7085.468589855678;7090.255523170199;7108.289171082851;7128.928710712827;7142.5714457132735;6833.282505336868;6912.412444942236;6931.584104953719;6944.236134025152;6950.131233595801;6846.110005699227;6873.656317184021;6885.1049363582415;6885.758998435231;6907.274736152833;6734.629595372302;6750;6778.864422711419;6786.151731033621;6811.65941702903;6792.796216113525;6931.618760968196;6937.340952609494;6937.410320122846;6945.0971373721095;6718.496112791462;6743.494237932273;6754.324567543206;6770.796876093725;6783.118194634666 18:25:45 INFO - 2015-12-22 18:25:45,369 DEBUG : BROWSER_OUTPUT: |5;yui.html;809.9635516401761;824.6701319472214;943.9764005899851;949.5537097564143;951.9571619277132;13833.861661383384;15930.203489825506;16059.437919672813;16082.7587586186;16134.838651613494;15002.099874007567;15057.849421505782;15104.924475377635;15114.319855606496;15128.546143615682;906.419891269588;918.5085979001236;919.2921450483124;921.7925966657516;930.1721467893581;912.6668765900432;913.0686699566438;917.8990311065777;919.5723988345418;920.4201353147507;944.8582712593097;952.0146648219095;952.200151872427;952.2857856607544;956.0057540158227;946.1390134977172;947.4362754161263;947.8530827721714;948.0898337595917;948.6252930092609;709.2340272505733;710.6233696141054;710.6553321639001;711.7295427737427;712.0707476742848;15106.39574417022;15276.770848437282;15287.235638218044;15288.082715037133;15295.694086118327;12579.685507862285;12800.6799830005;12827.615171544869;12937.288449135294;13408.798868016987;11055.447227638666;11335.489902954305;11573.710657233552;11905.404729763477;11971.580994665144;3846.6345697158727;3856;3859.36320507116;3871;3888.51393575803;50711.49288507141;50758.49241507574;50828.49171508312;51322.486775132515;51345.743271283405;10891.128709703205;10907.781844363068;10976.725581860517;11071.335719856834;11124.721881952853;19054.42836714901;19110.140043698066;19165.425037248904;19171.137298821308;19171.424857254304;7436.628168591549;7553.773386798295;7600;7666.9616651916385;7744;4227.957720422818;4455.331700244924;4461.57615026572;4503.662225333113;4580.24425969718;3175.0792270241373;3227.644959054502;3242.1732458223473;3247.5453436518906;3359.2105855124028;637.8309747916805;647.1586936981998;652.4714980865514;662.4600950225647;675.6891829758366;707.7098389660215;708.5642329967034;713.1138139620778;727.1274470635259;727.7707522130618;9147.77130571741;9266.212371948324;9316.673916412892;9351.849074712854;9388.8591671125;564.1932037186862;695.8016965164903;739.9408047356198;742.7511783552462;761.7333933123363;4198.1393814268;4240.321548552217;4397.2085024695225;4601.585857272861;4655.441347038377;52952.73523632357;55434;55997.720011400495;56080.439195608335;59545.106823397684;51171.48828511742;51549.226761598606;51974.22038669423;51986.48013519892;52528.212076818876;46483;46501.30248046282;46627.53372466232;46768;47063.76468117706;9128.771780705536;9175.816483670156;9254.444733316022;9279.814403712024;9361.485118318285;34743;35283;35299.47050794292;35697.46453803143;35747.99999999896;42595.787021064694;45869.08261834678;46336.7683161582;46645.53354466412;47142.52857471381;11517.136214783757;11636.06911447099;11822.82265765997;11846.289222646668;12085.637430877088;12876.356182190666;13061.131296285312;13155.736885262433;13387.196768193939;13483.797743033667;11684.240524365889;11716.297022178696;11988.220765650205;12048.879511204776;12867;11686.415679215836;11786.764264714486;11899.04807615406;11997.980171685505;12082.75834483323;11260.268082574607;11895.940520297343;11902.345371004678;12140.392980351124;12157.270563766202;10271.435071070864;10440.58237670515;10655.840162397415;10675.57297708083;11143.16426268017;9997.350172238781;10471.94764026175;10647;10694.62568810088;10954.233203675667 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: __startTimestamp1450837545357__endTimestamp 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,370 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:25:45 INFO - 2015-12-22 18:25:45,371 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:25:45 INFO - 2015-12-22 18:25:45,371 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,371 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5525.54 Median:5743.86 stddev:601.82 (10.5%) stddev-sans-first:578.97 18:25:45 INFO - 2015-12-22 18:25:45,371 DEBUG : BROWSER_OUTPUT: Values: 3350.4 3365.2 3380.1 3393.7 3400.6 5416.7 5440.3 5440.5 5447.5 5478.0 5432.4 5473.5 5507.3 5511.0 5529.5 4994.5 5024.0 5075.1 5103.2 5112.0 4847.0 5003.2 5012.3 5024.2 5116.8 5017.8 5101.1 5107.8 5112.5 5114.3 5099.8 5162.6 5167.0 5182.0 5197.8 4843.6 4931.4 4932.8 5075.0 5092.6 5282.4 5352.9 5354.6 5378.5 5397.1 5935.1 5950.4 6005.5 6021.2 6025.1 5893.0 5930.3 5985.6 5992.9 6012.9 5580.7 5587.1 5597.2 5627.3 5629.4 6005.8 6012.8 6040.5 6045.2 6049.3 5714.5 5744.4 5809.7 5861.5 5871.7 5928.8 5933.1 5946.7 5948.2 5985.2 5855.6 5863.1 5875.1 5884.1 5910.1 5701.9 5781.7 5862.7 5929.0 5959.1 4524.6 4593.2 4605.1 4608.6 4635.6 4033.3 4127.3 4133.7 4152.2 4170.2 5429.9 5556.5 5596.6 5642.8 5647.9 5990.1 5991.3 5994.5 6007.7 6007.8 5526.0 5657.3 5717.8 5722.2 5730.2 5164.6 5206.1 5234.7 5252.9 5272.2 6107.5 6126.3 6133.4 6170.9 6189.4 5713.2 5907.1 6020.6 6032.3 6034.4 5978.9 6013.1 6051.3 6066.4 6095.8 5859.6 5879.6 5912.1 5913.7 5939.9 5970.2 5971.2 5996.7 6021.0 6096.1 5884.6 5899.3 5908.8 5916.6 5927.6 5887.2 5894.6 5897.3 5900.1 5912.9 5471.3 5563.2 5608.0 5608.2 5801.1 5851.6 5880.2 5892.7 5959.8 5965.1 5743.9 5767.9 5772.1 5784.2 5805.2 18:25:45 INFO - 2015-12-22 18:25:45,371 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57825.64 Median:40567.30 stddev:125474.22 (309.3%) stddev-sans-first:125752.65 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: Values: 601.3 629.3 629.6 652.7 661.2 31254.4 40088.8 40512.6 40668.0 40786.6 43222.6 43752.3 44004.8 44108.0 44128.8 8949.4 9030.0 9073.9 9123.8 9127.1 8932.7 9053.2 9054.4 9059.9 9073.4 8992.4 9082.6 9092.9 9100.1 9104.5 8929.5 9018.4 9025.7 9029.3 9035.6 8915.2 9062.5 9079.7 9101.3 9105.8 41159.2 41288.4 41301.6 41444.2 41487.0 3511.2 3537.2 3697.9 3774.6 3796.6 31744.4 32202.7 32277.8 32385.0 32765.3 3883.1 3901.2 3951.6 4018.2 4038.4 276645.0 277071.0 277520.0 278566.0 279251.0 43551.0 44048.8 44220.6 59297.0 59775.0 42119.6 42262.4 42294.2 42448.8 42678.8 16292.4 16418.2 16454.2 16488.9 16631.7 12014.3 12063.3 12099.2 12146.8 12190.7 14925.3 15025.3 15105.7 15140.7 15201.5 6046.5 6177.3 6210.8 6235.8 6307.9 982.8 1024.7 1068.6 1069.6 1079.9 28703.0 33605.3 34264.3 34265.0 34267.8 1073.5 1107.8 1158.4 1178.8 1185.2 14975.3 15206.5 15231.4 15453.1 15637.5 403110.0 554538.0 790446.0 797082.0 816949.0 59326.0 59371.4 59595.4 59656.0 60144.1 1521.1 1541.5 1553.5 1554.3 1561.5 31203.8 31227.0 31455.7 31679.4 31705.8 49766.0 49851.0 49909.5 50178.7 50273.7 307826.0 309132.0 310047.0 310480.0 311977.0 34417.1 34846.8 34899.3 35058.0 35509.5 46193.5 46561.0 46744.5 47029.8 47898.3 39369.6 39537.0 40108.6 40514.8 40619.8 41682.0 45538.0 46128.8 46524.8 46590.8 43341.8 43484.3 43723.0 43950.0 44578.1 33910.0 39757.4 39936.4 39937.0 40936.6 26361.0 26456.5 26461.6 26555.0 27308.3 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:35807.33 Median:11410.27 stddev:117547.43 (1030.2%) stddev-sans-first:117847.06 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: Values: 372.1 375.6 377.2 377.3 382.0 15655.6 16994.2 18335.1 18779.4 18922.9 10165.6 11609.4 11723.8 15388.2 17672.1 5037.8 5152.4 5167.0 5168.0 5169.1 5247.4 5325.0 5327.1 5392.9 5444.8 5245.8 5309.8 5331.9 5336.5 5444.3 5568.0 5584.1 5587.6 5597.7 5599.6 5090.7 5252.1 5366.2 5382.7 5393.0 20649.2 20679.6 23513.3 23987.9 24265.5 2326.2 2330.0 2349.9 2378.5 2442.4 15130.8 15568.9 15850.4 16081.9 16208.6 2141.0 2175.0 2186.7 2195.2 2272.5 69297.3 69915.0 73792.3 74589.9 76012.2 16720.4 16850.6 16894.2 16928.3 17140.9 26512.6 26515.6 26606.9 26756.3 26965.2 10199.2 10277.1 10284.5 10329.5 10350.0 8848.1 8911.6 8950.3 8963.6 8968.1 4474.4 8476.9 8478.9 8506.7 8670.2 1950.7 1961.4 1963.2 1969.8 1971.7 879.2 955.6 1020.9 1043.7 1109.8 17400.9 18046.7 18157.9 18435.2 18621.3 978.8 980.4 1028.3 1044.9 1073.4 10281.1 10343.2 10603.7 10764.3 10849.8 714464.0 715700.0 723142.0 724799.0 725370.0 84012.0 84665.0 86746.1 87567.1 87673.6 1206.3 1216.7 1254.8 1257.1 1275.6 16733.9 16802.2 16817.2 17127.0 17207.1 38635.8 39076.2 39430.4 39459.4 39494.6 44689.3 46677.8 47715.8 47836.0 49882.5 9478.4 10150.5 10244.6 10250.9 10322.6 17584.5 18113.5 18357.8 18516.4 18812.4 14785.4 14882.3 15115.3 15455.8 15880.8 14672.3 14985.4 15409.2 15537.8 15703.3 15157.0 15160.6 15511.3 15658.0 15830.8 9669.5 10155.5 10300.2 10330.6 10353.2 15824.8 15872.7 16026.0 16070.5 16196.8 18:25:45 INFO - 2015-12-22 18:25:45,372 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,373 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5559.11 Median:6561.85 stddev:2837.77 (43.2%) stddev-sans-first:2829.78 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: Values: 1556.5 1558.7 1790.5 1792.9 1843.9 7177.8 7559.7 7590.6 7715.5 7985.9 7952.1 7972.5 8046.7 8084.6 8091.8 2264.7 2301.6 2302.1 2304.8 2307.1 2326.2 2340.0 2364.2 2366.5 2381.4 2301.7 2315.9 2338.1 2351.3 2366.2 2265.8 2269.4 2281.1 2287.9 2299.0 2320.4 2375.0 2376.8 2378.4 2378.7 7714.8 7734.8 7782.1 7798.5 7807.0 4799.5 4848.6 4896.0 4896.7 4901.9 3091.8 3142.4 3174.4 3177.6 3186.8 1016.6 1036.9 1056.4 1059.6 1077.3 10707.3 10780.4 10799.9 10803.7 10821.8 4333.6 4338.7 4393.0 4400.3 4407.4 9383.2 9396.8 9401.9 9437.4 9465.3 4900.5 4926.8 4946.8 4953.1 4967.9 4507.6 4507.8 4512.7 4535.1 4543.0 3681.1 3748.8 3755.8 3773.6 3773.7 1151.3 1157.6 1158.4 1175.9 1189.5 1061.8 1103.9 1114.1 1221.6 1400.1 7528.6 7533.0 7552.4 7559.7 7602.4 1140.0 1230.1 1237.2 1242.0 1259.9 5676.1 5698.9 5755.6 5770.0 5786.9 9358.1 9508.9 9516.5 9547.0 9650.9 9269.1 9462.8 9483.7 9485.3 9515.3 7445.5 7469.7 7501.0 7517.1 7563.6 7147.4 7166.9 7240.4 7254.3 7287.3 8296.0 8405.5 8413.7 8433.7 8494.6 8417.7 8570.3 8643.4 8648.8 8650.8 6784.9 6816.5 6821.1 6833.5 6841.4 7371.2 7371.9 7424.0 7450.9 7475.8 7098.9 7123.2 7221.1 7322.5 7372.4 6985.0 7202.7 7260.9 7287.5 7292.0 6800.9 7073.0 7081.9 7087.6 7175.3 6548.7 6575.0 6589.7 6597.2 6604.5 6663.6 6679.5 6684.1 6716.1 6744.7 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5681.81 Median:6401.47 stddev:1739.98 (27.2%) stddev-sans-first:1697.78 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: Values: 325.5 333.8 343.9 345.2 351.7 6237.6 6316.1 6336.3 6359.8 6361.6 6169.7 6331.2 6331.4 6342.0 6342.2 4838.1 4853.3 4880.6 4891.6 4892.2 4884.7 4893.0 4895.7 4905.3 4911.8 4777.4 4842.6 4878.0 4878.4 4882.7 4809.9 4834.8 4859.1 4864.9 4866.1 4118.9 4213.6 4262.4 4264.9 4282.4 6031.8 6041.8 6048.7 6056.6 6086.2 5621.6 5622.8 5627.2 5631.7 5643.5 6600.2 6705.7 6714.6 6733.0 6733.5 4599.6 4602.4 4602.5 4617.4 4620.1 6885.2 6983.6 7003.5 7006.7 7021.5 4580.8 4590.8 4601.8 4603.1 4623.2 4629.2 4687.8 4690.7 4808.4 4848.2 5592.6 5594.1 5597.7 5601.3 5608.0 6801.5 6823.1 6827.0 6828.6 6834.8 1698.6 1708.2 1711.5 1713.7 1714.4 1117.6 1149.6 1155.9 1167.5 1174.9 6527.1 6545.4 6556.0 6558.4 6563.0 6947.3 6976.9 7005.9 7008.1 7014.2 6397.9 6405.1 6526.0 6534.1 6559.1 3765.9 3792.8 3794.1 3798.0 3806.4 7135.2 7329.4 7335.0 7341.9 7358.6 7275.1 7277.2 7280.3 7294.8 7323.3 7193.8 7283.1 7320.7 7328.8 7329.2 7090.0 7124.3 7141.6 7149.2 7152.6 7010.0 7014.4 7020.6 7028.0 7029.8 7139.0 7284.6 7334.7 7346.7 7347.9 4789.4 4810.9 4813.5 4827.5 4846.9 7085.5 7090.3 7108.3 7128.9 7142.6 6833.3 6912.4 6931.6 6944.2 6950.1 6846.1 6873.7 6885.1 6885.8 6907.3 6734.6 6750.0 6778.9 6786.2 6811.7 6792.8 6931.6 6937.3 6937.4 6945.1 6718.5 6743.5 6754.3 6770.8 6783.1 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14407.29 Median:4482.62 stddev:16063.38 (358.3%) stddev-sans-first:16075.98 18:25:45 INFO - 2015-12-22 18:25:45,374 DEBUG : BROWSER_OUTPUT: Values: 810.0 824.7 944.0 949.6 952.0 13833.9 15930.2 16059.4 16082.8 16134.8 15002.1 15057.8 15104.9 15114.3 15128.5 906.4 918.5 919.3 921.8 930.2 912.7 913.1 917.9 919.6 920.4 944.9 952.0 952.2 952.3 956.0 946.1 947.4 947.9 948.1 948.6 709.2 710.6 710.7 711.7 712.1 15106.4 15276.8 15287.2 15288.1 15295.7 12579.7 12800.7 12827.6 12937.3 13408.8 11055.4 11335.5 11573.7 11905.4 11971.6 3846.6 3856.0 3859.4 3871.0 3888.5 50711.5 50758.5 50828.5 51322.5 51345.7 10891.1 10907.8 10976.7 11071.3 11124.7 19054.4 19110.1 19165.4 19171.1 19171.4 7436.6 7553.8 7600.0 7667.0 7744.0 4228.0 4455.3 4461.6 4503.7 4580.2 3175.1 3227.6 3242.2 3247.5 3359.2 637.8 647.2 652.5 662.5 675.7 707.7 708.6 713.1 727.1 727.8 9147.8 9266.2 9316.7 9351.8 9388.9 564.2 695.8 739.9 742.8 761.7 4198.1 4240.3 4397.2 4601.6 4655.4 52952.7 55434.0 55997.7 56080.4 59545.1 51171.5 51549.2 51974.2 51986.5 52528.2 46483.0 46501.3 46627.5 46768.0 47063.8 9128.8 9175.8 9254.4 9279.8 9361.5 34743.0 35283.0 35299.5 35697.5 35748.0 42595.8 45869.1 46336.8 46645.5 47142.5 11517.1 11636.1 11822.8 11846.3 12085.6 12876.4 13061.1 13155.7 13387.2 13483.8 11684.2 11716.3 11988.2 12048.9 12867.0 11686.4 11786.8 11899.0 11998.0 12082.8 11260.3 11895.9 11902.3 12140.4 12157.3 10271.4 10440.6 10655.8 10675.6 11143.2 9997.4 10471.9 10647.0 10694.6 10954.2 18:25:45 INFO - 2015-12-22 18:25:45,375 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:25:45 INFO - 2015-12-22 18:25:45,375 DEBUG : BROWSER_OUTPUT: 18:25:46 INFO - 2015-12-22 18:25:46,072 INFO : Browser exited with error code: 0 18:25:46 INFO - 2015-12-22 18:25:46,093 INFO : Completed test dromaeo_css (00:18:28) 18:25:46 INFO - 2015-12-22 18:25:46,093 INFO : Starting test kraken 18:25:46 INFO - 2015-12-22 18:25:46,093 DEBUG : operating with platform_type : linux_ 18:25:46 INFO - 2015-12-22 18:25:46,093 INFO : Initialising browser for kraken test... 18:25:46 INFO - 2015-12-22 18:25:46,099 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2DcTyD/profile http://localhost:46092/getInfo.html 18:25:50 INFO - 2015-12-22 18:25:50,884 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:25:50 INFO - 2015-12-22 18:25:50,884 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:25:50 INFO - 2015-12-22 18:25:50,884 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:25:50 INFO - 2015-12-22 18:25:50,884 DEBUG : BROWSER_OUTPUT: __metrics 18:25:51 INFO - 2015-12-22 18:25:51,971 INFO : Browser initialized. 18:25:51 INFO - 2015-12-22 18:25:51,972 INFO : Running cycle 1/1 for kraken test... 18:25:51 INFO - 2015-12-22 18:25:51,972 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2DcTyD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:26:03 INFO - 2015-12-22 18:26:03,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 18:26:03 INFO - 2015-12-22 18:26:03,741 DEBUG : BROWSER_OUTPUT: 18:26:06 INFO - 2015-12-22 18:26:06,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46092/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:06 INFO - 2015-12-22 18:26:06,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 18:26:06 INFO - 2015-12-22 18:26:06,808 DEBUG : BROWSER_OUTPUT: 18:26:09 INFO - 2015-12-22 18:26:09,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46092/tests/kraken/driver.html?testName=audio-dft) 18:26:09 INFO - 2015-12-22 18:26:09,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 18:26:09 INFO - 2015-12-22 18:26:09,980 DEBUG : BROWSER_OUTPUT: 18:26:12 INFO - 2015-12-22 18:26:12,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46092/tests/kraken/driver.html?testName=audio-fft) 18:26:13 INFO - 2015-12-22 18:26:13,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 139018240 18:26:13 INFO - 2015-12-22 18:26:13,380 DEBUG : BROWSER_OUTPUT: 18:26:15 INFO - 2015-12-22 18:26:15,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46092/tests/kraken/driver.html?testName=audio-oscillator) 18:26:15 INFO - 2015-12-22 18:26:15,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 18:26:15 INFO - 2015-12-22 18:26:15,975 DEBUG : BROWSER_OUTPUT: 18:26:18 INFO - 2015-12-22 18:26:18,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:18 INFO - 2015-12-22 18:26:18,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 138940416 18:26:18 INFO - 2015-12-22 18:26:18,734 DEBUG : BROWSER_OUTPUT: 18:26:21 INFO - 2015-12-22 18:26:21,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46092/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:22 INFO - 2015-12-22 18:26:22,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 139509760 18:26:22 INFO - 2015-12-22 18:26:22,303 DEBUG : BROWSER_OUTPUT: 18:26:25 INFO - 2015-12-22 18:26:25,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46092/tests/kraken/driver.html?testName=imaging-desaturate) 18:26:26 INFO - 2015-12-22 18:26:26,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 139251712 18:26:26 INFO - 2015-12-22 18:26:26,216 DEBUG : BROWSER_OUTPUT: 18:26:28 INFO - 2015-12-22 18:26:28,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46092/tests/kraken/driver.html?testName=json-parse-financial) 18:26:29 INFO - 2015-12-22 18:26:29,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 139841536 18:26:29 INFO - 2015-12-22 18:26:29,563 DEBUG : BROWSER_OUTPUT: 18:26:31 INFO - 2015-12-22 18:26:31,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:26:31 INFO - 2015-12-22 18:26:31,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 140226560 18:26:31 INFO - 2015-12-22 18:26:31,726 DEBUG : BROWSER_OUTPUT: 18:26:33 INFO - 2015-12-22 18:26:33,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:26:34 INFO - 2015-12-22 18:26:34,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 139313152 18:26:34 INFO - 2015-12-22 18:26:34,103 DEBUG : BROWSER_OUTPUT: 18:26:36 INFO - 2015-12-22 18:26:36,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:26:36 INFO - 2015-12-22 18:26:36,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 139091968 18:26:36 INFO - 2015-12-22 18:26:36,753 DEBUG : BROWSER_OUTPUT: 18:26:39 INFO - 2015-12-22 18:26:39,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:26:39 INFO - 2015-12-22 18:26:39,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 139882496 18:26:39 INFO - 2015-12-22 18:26:39,782 DEBUG : BROWSER_OUTPUT: 18:26:42 INFO - 2015-12-22 18:26:42,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:26:42 INFO - 2015-12-22 18:26:42,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 139616256 18:26:42 INFO - 2015-12-22 18:26:42,906 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46092/tests/kraken/driver.html?testName=ai-astar) 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 140718080 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:26:44 INFO - 2015-12-22 18:26:44,831 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;111;112;112;121;111;112;112;112 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;126;145;161;126;145;154;129;156;123 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;161;162;162;161;160;161;162;162 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;74;71;164;71;74;71;71;154;73 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;146;92;93;94;138;92;93;145 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;110 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;146;146;146;147;146;145;147;147 18:26:44 INFO - 2015-12-22 18:26:44,832 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;95;96;96;96;96;96;96;96 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;61;61;60;59;69;59;59;56;58 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;63;64;64;64;63;63;63 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;81;83;83;82;82;81;90;87;84 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;116;119;118;119;126;120;115;128;127 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;146;147;148;147;138;149;149;147;147 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;66;68;68;68;67;70;66;66 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:26:44 INFO - 2015-12-22 18:26:44,833 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:26:44 INFO - 2015-12-22 18:26:44,834 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 18:26:44 INFO - 2015-12-22 18:26:44,834 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:26:44 INFO - 2015-12-22 18:26:44,834 DEBUG : BROWSER_OUTPUT: __startTimestamp1450837604829__endTimestamp 18:26:44 INFO - 2015-12-22 18:26:44,834 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,837 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:3.63 (3.2%) stddev-sans-first:3.86 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 111.0 112.0 112.0 121.0 111.0 112.0 112.0 112.0 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.50 Median:147.50 stddev:14.23 (9.6%) stddev-sans-first:14.76 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: Values: 150.0 126.0 145.0 161.0 126.0 145.0 154.0 129.0 156.0 123.0 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,838 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 161.0 162.0 162.0 161.0 160.0 161.0 162.0 162.0 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.10 Median:72.00 stddev:36.46 (50.6%) stddev-sans-first:38.40 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: Values: 78.0 74.0 71.0 164.0 71.0 74.0 71.0 71.0 154.0 73.0 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:92.50 stddev:24.38 (26.4%) stddev-sans-first:25.18 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 146.0 92.0 93.0 94.0 138.0 92.0 93.0 145.0 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 18:26:44 INFO - 2015-12-22 18:26:44,840 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 145.0 147.0 147.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:3.43 (5.7%) stddev-sans-first:3.63 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 61.0 60.0 59.0 69.0 59.0 59.0 56.0 58.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 63.0 64.0 64.0 64.0 63.0 63.0 63.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:2.83 (3.4%) stddev-sans-first:3.00 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: Values: 84.0 81.0 83.0 83.0 82.0 82.0 81.0 90.0 87.0 84.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:122.00 stddev:4.69 (3.8%) stddev-sans-first:4.86 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: Values: 124.0 116.0 119.0 118.0 119.0 126.0 120.0 115.0 128.0 127.0 18:26:44 INFO - 2015-12-22 18:26:44,841 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:147.00 stddev:3.16 (2.2%) stddev-sans-first:3.32 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 147.0 148.0 147.0 138.0 149.0 149.0 147.0 147.0 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.27 (1.9%) stddev-sans-first:1.33 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 66.0 68.0 68.0 68.0 67.0 70.0 66.0 66.0 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:26:44 INFO - 2015-12-22 18:26:44,842 DEBUG : BROWSER_OUTPUT: 18:26:45 INFO - 2015-12-22 18:26:45,876 INFO : Browser exited with error code: 0 18:26:45 INFO - 2015-12-22 18:26:45,926 INFO : Completed test kraken (00:00:59) 18:26:45 INFO - 2015-12-22 18:26:45,926 INFO : Starting test v8_7 18:26:45 INFO - 2015-12-22 18:26:45,927 DEBUG : operating with platform_type : linux_ 18:26:45 INFO - 2015-12-22 18:26:45,927 INFO : Initialising browser for v8_7 test... 18:26:45 INFO - 2015-12-22 18:26:45,933 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNVIORj/profile http://localhost:46092/getInfo.html 18:26:50 INFO - 2015-12-22 18:26:50,642 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:26:50 INFO - 2015-12-22 18:26:50,642 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:26:50 INFO - 2015-12-22 18:26:50,642 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:26:50 INFO - 2015-12-22 18:26:50,642 DEBUG : BROWSER_OUTPUT: __metrics 18:26:51 INFO - 2015-12-22 18:26:51,647 INFO : Browser initialized. 18:26:51 INFO - 2015-12-22 18:26:51,648 INFO : Running cycle 1/1 for v8_7 test... 18:26:51 INFO - 2015-12-22 18:26:51,648 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNVIORj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:27:03 INFO - 2015-12-22 18:27:03,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 138371072 18:27:03 INFO - 2015-12-22 18:27:03,391 DEBUG : BROWSER_OUTPUT: 18:27:24 INFO - 2015-12-22 18:27:24,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46092/tests/v8_7/run.html (next: http://localhost:46092/tests/v8_7/run.html) 18:27:25 INFO - 2015-12-22 18:27:25,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 136695808 18:27:25 INFO - 2015-12-22 18:27:25,011 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,011 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:27:25 INFO - 2015-12-22 18:27:25,011 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:27:25 INFO - 2015-12-22 18:27:25,011 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:27:25 INFO - 2015-12-22 18:27:25,013 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:27:25 INFO - 2015-12-22 18:27:25,013 DEBUG : BROWSER_OUTPUT: |0;Richards;165.50810989738497 18:27:25 INFO - 2015-12-22 18:27:25,013 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.22408026755852 18:27:25 INFO - 2015-12-22 18:27:25,013 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |4;RayTrace;909.9181073703367 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |5;Earley;554.6311702717693 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |6;Boyer;11010.989010989011 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |7;RegExp;23952.380952380954 18:27:25 INFO - 2015-12-22 18:27:25,014 DEBUG : BROWSER_OUTPUT: |8;Splay;528.2620179609086 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: __startTimestamp1450837645010__endTimestamp 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.51 Median:165.51 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,015 DEBUG : BROWSER_OUTPUT: Values: 165.5 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: Values: 167.2 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: Values: 278.3 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,016 DEBUG : BROWSER_OUTPUT: Values: 5202.1 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:909.92 Median:909.92 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: Values: 909.9 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:554.63 Median:554.63 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: Values: 554.6 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,017 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11010.99 Median:11010.99 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: Values: 11011.0 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23952.38 Median:23952.38 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: Values: 23952.4 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,018 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:528.26 Median:528.26 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: Values: 528.3 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: Values: 4822.1 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:27:25 INFO - 2015-12-22 18:27:25,019 DEBUG : BROWSER_OUTPUT: 18:27:25 INFO - 2015-12-22 18:27:25,899 INFO : Browser exited with error code: 0 18:27:25 INFO - 2015-12-22 18:27:25,916 INFO : Completed test v8_7 (00:00:39) 18:27:26 INFO - 2015-12-22 18:27:26,099 INFO : Completed test suite (00:20:08) 18:27:26 INFO - 2015-12-22 18:27:26,099 DEBUG : Working with test: dromaeo_css 18:27:26 INFO - 2015-12-22 18:27:26,099 DEBUG : Generating results file: dromaeo_css 18:27:26 INFO - 2015-12-22 18:27:26,101 DEBUG : Working with test: kraken 18:27:26 INFO - 2015-12-22 18:27:26,101 DEBUG : Generating results file: kraken 18:27:26 INFO - 2015-12-22 18:27:26,102 INFO : javascript benchmark 18:27:26 INFO - 2015-12-22 18:27:26,102 DEBUG : Working with test: v8_7 18:27:26 INFO - 2015-12-22 18:27:26,102 DEBUG : Generating results file: v8_7 18:27:26 INFO - 2015-12-22 18:27:26,103 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:27:26 INFO - 2015-12-22 18:27:26,161 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 18:27:26 INFO - 2015-12-22 18:27:26,161 DEBUG : process_Request line: dromaeo_css 7475.70 graph.html#tests=[[72,52,43]] 18:27:26 INFO - 2015-12-22 18:27:26,161 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:27:26 INFO - 2015-12-22 18:27:26,188 DEBUG : process_Request line: kraken 1507.40 graph.html#tests=[[232,52,43]] 18:27:26 INFO - 2015-12-22 18:27:26,188 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:27:26 INFO - 2015-12-22 18:27:26,221 DEBUG : process_Request line: v8_7 23232.89 graph.html#tests=[[230,52,43]] 18:27:26 INFO - 2015-12-22 18:27:26,222 INFO : javascript benchmark 18:27:26 INFO - 2015-12-22 18:27:26,226 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3350.36343094812, 3365.242820365418, 3380.1380647934775, 3393.677600627941, 3400.642932492088, 5416.702081385522, 5440.347158340995, 5440.537554307879, 5447.536959358449, 5477.972610136943, 5432.402435732066, 5473.507384335409, 5507.311586051744, 5511.035568775468, 5529.529989950859, 4994.5005499450035, 5023.974880125595, 5075.111855425304, 5103.15797893349, 5111.974440127813, 4846.9515304846855, 5003.249512573125, 5012.273220383042, 5024.246363045554, 5116.769745361467, 5017.84946451607, 5101.081805275049, 5107.770150343244, 5112.539871411572, 5114.335136432259, 5099.821506247282, 5162.586993040548, 5167.044096842096, 5181.974090129563, 5197.8440646780655, 4843.636727245471, 4931.43288521821, 4932.778024988884, 5075.0, 5092.618053645954, 5282.418933917266, 5352.946470535323, 5354.625176237665, 5378.462153784591, 5397.055515284848, 5935.0503919372695, 5950.404959504058, 6005.519558435359, 6021.157038014681, 6025.0661147522205, 5892.970535147339, 5930.258717660293, 5985.551083668743, 5992.940070599282, 6012.947734146507, 5580.748866301026, 5587.1339942309005, 5597.160425936061, 5627.324721033461, 5629.437056294338, 6005.759769609254, 6012.819615411545, 6040.456358927718, 6045.153678485016, 6049.304330002018, 5714.485696287354, 5744.425557444306, 5809.651420914759, 5861.501772349398, 5871.6770577618645, 5928.79249226275, 5933.139694744238, 5946.67293298864, 5948.167256584082, 5985.191999080155, 5855.648661080349, 5863.120531920246, 5875.148103524965, 5884.08796636522, 5910.143029260733, 5701.945140149002, 5781.739821707949, 5862.677552734641, 5928.970355148197, 5959.106134079922, 4524.5701658342405, 4593.242115051046, 4605.102005108972, 4608.631309495232, 4635.582797548237, 4033.2941735196223, 4127.2570937231585, 4133.7106402551535, 4152.211079894871, 4170.207660544487, 5429.864253393618, 5556.499915007668, 5596.552275817925, 5642.830715078554, 5647.943520564741, 5990.071538911476, 5991.2510936132985, 5994.520438364921, 6007.669578173155, 6007.8197654070445, 5525.972370138204, 5657.32112146545, 5717.771289148471, 5722.198892155102, 5730.19777231188, 5164.638475306692, 5206.140986737146, 5234.712090835041, 5252.894942101137, 5272.209168624737, 6107.511399088063, 6126.326104128542, 6133.355997620275, 6170.876582468325, 6189.442950134509, 5713.171590119493, 5907.143464197753, 6020.638761674226, 6032.336442991355, 6034.426729460694, 5978.893904627658, 6013.067974463965, 6051.273847138372, 6066.3630318815885, 6095.786647467317, 5859.58982871212, 5879.559033072451, 5912.054071348563, 5913.674747888907, 5939.881202375842, 5970.194023806731, 5971.164037034905, 5996.730147143302, 6021.036634138517, 6096.055111457731, 5884.558658100574, 5899.292084949833, 5908.793192238251, 5916.556258280732, 5927.644341339534, 5887.1757953885635, 5894.616849904743, 5897.292324921037, 5900.085486749561, 5912.940870591411, 5471.316085489314, 5563.165525171256, 5608.0, 5608.2148499209325, 5801.100829371454, 5851.590388672922, 5880.176775251382, 5892.734826932712, 5959.821205363846, 5965.105234214902, 5743.8564035899435, 5767.942320576741, 5772.105323674838, 5784.190213370216, 5805.158252053344], "unit": "ms", "name": "dojo.html", "value": 5487.476941519604}, {"lowerIsBetter": false, "replicates": [601.2964831147557, 629.2826178156902, 629.6002038705426, 652.6638781027772, 661.2131563439508, 31254.374912501735, 40088.79955600222, 40512.594874051254, 40668.0, 40786.59213407865, 43222.56777432225, 43752.343714844304, 44004.77997610015, 44108.0, 44128.77935610325, 8949.373543851916, 9029.95485022574, 9073.909260907405, 9123.771905702344, 9127.132922372397, 8932.687355942544, 9053.230475409599, 9054.366194366397, 9059.864102038475, 9073.410228335137, 8992.370534062618, 9082.591283392263, 9092.909070909305, 9100.135487128713, 9104.45373277602, 8929.508877011762, 9018.36871419001, 9025.729228123168, 9029.322800789902, 9035.593398297027, 8915.197632213132, 9062.546872656407, 9079.68221112258, 9101.271898248124, 9105.772355691095, 41159.176816463805, 41288.38067428991, 41301.58698413037, 41444.1711165775, 41487.0, 3511.17487390463, 3537.188114095178, 3697.926041479155, 3774.565924918642, 3796.5823759386444, 31744.365112697848, 32202.6779732202, 32277.838610806797, 32385.0, 32765.344693106243, 3883.0874744435037, 3901.2197560487734, 3951.6443520083044, 4018.2365350583295, 4038.414429907647, 276645.0, 277071.0, 277520.0, 278566.0, 279250.99999999796, 43551.0, 44048.779756101656, 44220.55779442229, 59297.0, 59775.0, 42119.57880421157, 42262.36606450906, 42294.15411691749, 42448.78775606102, 42678.78660606677, 16292.42976495817, 16418.1790910454, 16454.177291135395, 16488.917555412387, 16631.6673666526, 12014.279143251433, 12063.336516491501, 12099.153059285942, 12146.757064858653, 12190.695232619079, 14925.328360223815, 15025.323860426308, 15105.697886042217, 15140.697186056217, 15201.543953681406, 6046.455818976313, 6177.289611694623, 6210.844728881814, 6235.812925612239, 6307.9369206308265, 982.7641366072235, 1024.6567399920962, 1068.6099573655715, 1069.6202847989007, 1079.9308684402386, 28702.99539516107, 33605.327893441994, 34264.31471370609, 34265.0, 34267.828660857034, 1073.5330527358258, 1107.789519991199, 1158.3860553906443, 1178.8290697848936, 1185.1690229545936, 14975.32611032506, 15206.467773628092, 15231.390744370323, 15453.072815631098, 15637.530874073796, 403110.0, 554538.0, 790446.0, 797082.0, 816949.0, 59326.0, 59371.40628593745, 59595.404045959855, 59656.0, 60144.097838532456, 1521.0721459909446, 1541.537538738374, 1553.5028790787067, 1554.3471741868443, 1561.4534912780664, 31203.84398077995, 31227.0, 31455.685443145274, 31679.366412671156, 31705.841470792497, 49766.0, 49851.0, 49909.500904990484, 50178.74910625423, 50273.74863125661, 307826.0, 309132.0, 310047.0, 310480.0, 311977.0, 34417.13957151091, 34846.825765871006, 34899.302013960085, 35058.0, 35509.467357990165, 46193.53806461892, 46561.0, 46744.53255467402, 47029.764851175525, 47898.281525776445, 39369.60630393659, 39537.0, 40108.59891401165, 40514.79742601268, 40619.7969010153, 41682.0, 45538.0, 46128.76935615435, 46524.767376162905, 46590.767046164554, 43341.783291083346, 43484.34773478337, 43723.0, 43950.0, 44578.10843783171, 33910.0, 39757.403638946016, 39936.4009539863, 39937.0, 40936.59063409328, 26361.0, 26456.470870582096, 26461.603075954263, 26555.0, 27308.31729206786], "unit": "ms", "name": "ext.html", "value": 19615.118120067345}, {"lowerIsBetter": false, "replicates": [372.13293027246516, 375.61499463050376, 377.21915634636315, 377.30199131606514, 381.9713521485888, 15655.608609784733, 16994.150292485374, 18335.083245837723, 18779.436616901497, 18922.905385473052, 10165.59337626494, 11609.361485118316, 11723.765524689501, 15388.15365154916, 17672.116394180302, 5037.773300201499, 5152.407473140581, 5166.992436474889, 5167.974160129213, 5169.09540830355, 5247.422783493813, 5324.973375133139, 5327.094393953037, 5392.946070539303, 5444.809431669893, 5245.842624721265, 5309.840704778863, 5331.946680533184, 5336.546393556533, 5444.346678398578, 5567.9977604031255, 5584.050711379055, 5587.580931430159, 5597.7201139943045, 5599.608027438081, 5090.745462726849, 5252.133397989327, 5366.168243922199, 5382.681243095428, 5393.0, 20649.17403303866, 20679.5864082719, 23513.294601161822, 23987.88006059976, 24265.514689706106, 2326.162581470669, 2329.988350058256, 2349.9072931087126, 2378.452955820154, 2442.426029882976, 15130.773038404433, 15568.922155389264, 15850.44523441674, 16081.919590401973, 16208.594785130348, 2140.9571808563896, 2174.967375489369, 2186.6719992001167, 2195.1658369819525, 2272.4773302140434, 69297.30702692959, 69915.0, 73792.26207737907, 74589.88115178331, 76012.23987760107, 16720.41478548245, 16850.578735531464, 16894.15529223534, 16928.322867085426, 17140.914295428443, 26512.602310964965, 26515.602265966027, 26606.86696566505, 26756.331091722863, 26965.247258928106, 10199.18406527476, 10277.126444252173, 10284.537195826206, 10329.483525823678, 10350.0, 8848.070952550019, 8911.598978046004, 8950.328725345626, 8963.641454341883, 8968.148025937526, 4474.440694913136, 8476.915230847735, 8478.915210847812, 8506.702265420805, 8670.219680228809, 1950.7366505521572, 1961.4017724594137, 1963.1656545967905, 1969.793171716949, 1971.684530475117, 879.2306731609841, 955.5799219063974, 1020.8570800087994, 1043.7338478687886, 1109.7891400633853, 17400.91299543494, 18046.729299060524, 18157.909210453865, 18435.170417331254, 18621.255149793855, 978.83849164887, 980.352967041749, 1028.2596530498029, 1044.9268551201344, 1073.388168743824, 10281.12610428122, 10343.224258180666, 10603.681889543172, 10764.300320479144, 10849.78300433987, 714464.0, 715700.0, 723142.0, 724799.0, 725370.0, 84012.0, 84665.0, 86746.13253867507, 87567.12432875589, 87673.56163219143, 1206.3485717712513, 1216.6593353860933, 1254.8305978692943, 1257.1137348169518, 1275.64282001038, 16733.91633041827, 16802.243899024328, 16817.243224054702, 17127.0, 17207.13964301805, 38635.806820965714, 39076.2184756309, 39430.408543872436, 39459.40810887782, 39494.60505394909, 44689.32966005577, 46677.76661116809, 47715.76142119267, 47836.0, 49882.50117498924, 9478.38390504615, 10150.54322555472, 10244.64143754965, 10250.948745256524, 10322.587096516056, 17584.472465826046, 18113.547161321072, 18357.81642183561, 18516.444506664822, 18812.435626931216, 14785.408583656963, 14882.330295136528, 15115.31981060833, 15455.768163477782, 15880.841191588399, 14672.26638668041, 14985.40058397652, 15409.152496612345, 15537.76693349578, 15703.293351798968, 15157.0, 15160.620984475476, 15511.301991410188, 15658.0, 15830.762538562161, 9669.468179250209, 10155.543000564845, 10300.227482938659, 10330.638427654996, 10353.17174626013, 15824.841751582797, 15872.682546348777, 16026.0, 16070.517884463485, 16196.838031619533], "unit": "ms", "name": "jquery.html", "value": 10145.248995572643}, {"lowerIsBetter": false, "replicates": [1556.5096994446749, 1558.7038462692094, 1790.5165605286566, 1792.8834625749328, 1843.8524918006556, 7177.82055448614, 7559.7354092606765, 7590.62046897655, 7715.537067775937, 7985.92014079859, 7952.085510166333, 7972.481788683746, 8046.718364857216, 8084.636191371388, 8091.838163236732, 2264.7055882735262, 2301.5972204864165, 2302.1482051640915, 2304.7810458006547, 2307.1348244408346, 2326.150954901466, 2340.0405833608224, 2364.160722943356, 2366.538524987628, 2381.3570336009266, 2301.6892719482908, 2315.918942837001, 2338.1115176233006, 2351.2593533037125, 2366.230974933145, 2265.784750448705, 2269.375921621551, 2281.1103669568884, 2287.9199228027023, 2298.9885050574726, 2320.4198950262435, 2375.002498950445, 2376.845505042184, 2378.3935096550267, 2378.690770199863, 7714.807129821799, 7734.767956961244, 7782.105057918356, 7798.454108212427, 7807.0, 4799.496052914428, 4848.587870031051, 4896.02079584081, 4896.730679812609, 4901.926471102936, 3091.7990330628436, 3142.4186525492855, 3174.3809957058384, 3177.634572024224, 3186.8087914725193, 1016.6238491758097, 1036.9014943580348, 1056.387295368692, 1059.5708737961138, 1077.342820879271, 10707.250492465531, 10780.353178809297, 10799.946000269949, 10803.729906752316, 10821.83767243492, 4333.609975102256, 4338.674599405057, 4393.033532622818, 4400.3399490076745, 4407.382966384709, 9383.202427793714, 9396.812063758687, 9401.90598094024, 9437.386569872937, 9465.337426380087, 4900.485449027872, 4926.75366231687, 4946.802127914843, 4953.108440480676, 4967.925481117786, 4507.57178068083, 4507.774611269489, 4512.729236245836, 4535.138323718483, 4543.0, 3681.0981309579324, 3748.775073495599, 3755.8356909358185, 3773.603771603997, 3773.698074164409, 1151.3322273081592, 1157.5948418053783, 1158.362900404791, 1175.9000484958704, 1189.482575079843, 1061.7557961668858, 1103.9282446640943, 1114.1198453221864, 1221.6029790318182, 1400.0969374753226, 7528.5859277739155, 7533.020707308015, 7552.358049565849, 7559.659815308324, 7602.353799926957, 1139.9544018239344, 1230.059004861282, 1237.2452803789681, 1241.9565315213924, 1259.8614152443224, 5676.148577713376, 5698.886022279531, 5755.625884317506, 5769.971150144306, 5786.855328616734, 9358.064193580587, 9508.90491095094, 9516.476593787269, 9546.95226523863, 9650.903490965, 9269.119433653792, 9462.763430914145, 9483.715488535356, 9485.33602647808, 9515.286353523514, 7445.516041457288, 7469.663865126083, 7501.024866767176, 7517.060367454068, 7563.621818909032, 7147.356737893615, 7166.856662866818, 7240.384567311838, 7254.274572542704, 7287.344139027513, 8295.95852020736, 8405.495670259805, 8413.70552030676, 8433.662653493791, 8494.617742201492, 8417.663293468193, 8570.271526920282, 8643.351748618754, 8648.78378040554, 8650.826983460169, 6784.93215067843, 6816.488763342868, 6821.113255276782, 6833.487488438288, 6841.350071743176, 7371.189169191492, 7371.926280737124, 7424.0348754661545, 7450.925490745023, 7475.813104672427, 7098.929010709827, 7123.180834204133, 7221.061262035902, 7322.524035937647, 7372.41020718352, 6985.0, 7202.747903823341, 7260.927390726237, 7287.526310789782, 7292.0, 6800.897986530107, 7073.045138906387, 7081.8937715935335, 7087.64561771899, 7175.31834475724, 6548.705308261235, 6575.0, 6589.703463344065, 6597.208334999831, 6604.504662150454, 6663.633500157538, 6679.465642748665, 6684.131062961784, 6716.126903502513, 6744.69648865812], "unit": "ms", "name": "mootools.html", "value": 4594.897463432476}, {"lowerIsBetter": false, "replicates": [325.46461071537306, 333.773034336651, 343.9071450708309, 345.17847522895505, 351.6975401155007, 6237.5945563538335, 6316.115743795866, 6336.334684858092, 6359.777407790728, 6361.5864968777, 6169.691515424233, 6331.2085989251345, 6331.398517140876, 6342.0486926960975, 6342.238931328236, 4838.104950584153, 4853.344798452199, 4880.633952453562, 4891.559759621633, 4892.217245240762, 4884.658073934826, 4893.04585605807, 4895.681780684262, 4905.3132561441425, 4911.803527858881, 4777.426708794949, 4842.588379987706, 4878.0, 4878.414590249157, 4882.682625629341, 4809.927851082237, 4834.830780922668, 4859.052484765472, 4864.927026094611, 4866.075445665312, 4118.855840045584, 4213.578642135762, 4262.445882035347, 4264.87205383839, 4282.42187304713, 6031.758729650809, 6041.848953776147, 6048.69756512177, 6056.6063205891915, 6086.2087928569445, 5621.606487545873, 5622.775088996435, 5627.184058311522, 5631.690257035862, 5643.492085712305, 6600.174978127734, 6705.731770729165, 6714.6306953117555, 6732.966335168342, 6733.49498787588, 4599.563041511051, 4602.3786788783755, 4602.470715867685, 4617.399738034068, 4620.052889157714, 6885.242623311432, 6983.580985140908, 7003.474739394565, 7006.684699188498, 7021.473389495808, 4580.770961451981, 4590.770461476913, 4601.838935637236, 4603.056373443436, 4623.214053610895, 4629.189891768927, 4687.7656117194, 4690.71855688653, 4808.374911261583, 4848.248521479177, 5592.636478628958, 5594.13290939905, 5597.692126933058, 5601.271834661549, 5608.046632072557, 6801.537669401004, 6823.078884350648, 6827.044213810071, 6828.624425656637, 6834.760783372558, 1698.5923378389098, 1708.1630001299523, 1711.5122190175741, 1713.742938559201, 1714.4428060880264, 1117.5976648406568, 1149.6378640728144, 1155.8959693627614, 1167.4746364136172, 1174.8883856033663, 6527.086207930894, 6545.4436372907885, 6556.0, 6558.409743123142, 6563.015547667888, 6947.270536593686, 6976.930230697628, 7005.894911576331, 7008.088948436773, 7014.158301003912, 6397.872042559123, 6405.071264666597, 6526.0, 6534.052562378429, 6559.081728558006, 3765.9246815064093, 3792.7534710243744, 3794.0894185395305, 3798.0, 3806.410006449005, 7135.179454362711, 7329.377002954702, 7334.963325183447, 7341.88987165193, 7358.558486490828, 7275.126984761757, 7277.19950805411, 7280.3083707047745, 7294.8176295591975, 7323.304286092813, 7193.820154496179, 7283.053203083565, 7320.7071717131785, 7328.78013659591, 7329.19378868324, 7090.0, 7124.323189297009, 7141.64291785419, 7149.177844547736, 7152.570845749272, 7009.9649501752165, 7014.403775679124, 7020.613866237406, 7028.0, 7029.824254393681, 7138.964305178441, 7284.599347035964, 7334.743283985248, 7346.7061317546695, 7347.853042939005, 4789.377380940595, 4810.927836082392, 4813.518648135158, 4827.541383568555, 4846.854594362175, 7085.468589855678, 7090.255523170199, 7108.289171082851, 7128.928710712827, 7142.5714457132735, 6833.282505336868, 6912.412444942236, 6931.584104953719, 6944.236134025152, 6950.131233595801, 6846.110005699227, 6873.656317184021, 6885.1049363582415, 6885.758998435231, 6907.274736152833, 6734.629595372302, 6750.0, 6778.864422711419, 6786.151731033621, 6811.65941702903, 6792.796216113525, 6931.618760968196, 6937.340952609494, 6937.410320122846, 6945.0971373721095, 6718.496112791462, 6743.494237932273, 6754.324567543206, 6770.796876093725, 6783.118194634666], "unit": "ms", "name": "prototype.html", "value": 5110.006473817359}, {"lowerIsBetter": false, "replicates": [809.9635516401761, 824.6701319472214, 943.9764005899851, 949.5537097564143, 951.9571619277132, 13833.861661383384, 15930.203489825506, 16059.437919672813, 16082.7587586186, 16134.838651613494, 15002.099874007567, 15057.849421505782, 15104.924475377635, 15114.319855606496, 15128.546143615682, 906.419891269588, 918.5085979001236, 919.2921450483124, 921.7925966657516, 930.1721467893581, 912.6668765900432, 913.0686699566438, 917.8990311065777, 919.5723988345418, 920.4201353147507, 944.8582712593097, 952.0146648219095, 952.200151872427, 952.2857856607544, 956.0057540158227, 946.1390134977172, 947.4362754161263, 947.8530827721714, 948.0898337595917, 948.6252930092609, 709.2340272505733, 710.6233696141054, 710.6553321639001, 711.7295427737427, 712.0707476742848, 15106.39574417022, 15276.770848437282, 15287.235638218044, 15288.082715037133, 15295.694086118327, 12579.685507862285, 12800.6799830005, 12827.615171544869, 12937.288449135294, 13408.798868016987, 11055.447227638666, 11335.489902954305, 11573.710657233552, 11905.404729763477, 11971.580994665144, 3846.6345697158727, 3856.0, 3859.36320507116, 3871.0, 3888.51393575803, 50711.49288507141, 50758.49241507574, 50828.49171508312, 51322.486775132515, 51345.743271283405, 10891.128709703205, 10907.781844363068, 10976.725581860517, 11071.335719856834, 11124.721881952853, 19054.42836714901, 19110.140043698066, 19165.425037248904, 19171.137298821308, 19171.424857254304, 7436.628168591549, 7553.773386798295, 7600.0, 7666.9616651916385, 7744.0, 4227.957720422818, 4455.331700244924, 4461.57615026572, 4503.662225333113, 4580.24425969718, 3175.0792270241373, 3227.644959054502, 3242.1732458223473, 3247.5453436518906, 3359.2105855124028, 637.8309747916805, 647.1586936981998, 652.4714980865514, 662.4600950225647, 675.6891829758366, 707.7098389660215, 708.5642329967034, 713.1138139620778, 727.1274470635259, 727.7707522130618, 9147.77130571741, 9266.212371948324, 9316.673916412892, 9351.849074712854, 9388.8591671125, 564.1932037186862, 695.8016965164903, 739.9408047356198, 742.7511783552462, 761.7333933123363, 4198.1393814268, 4240.321548552217, 4397.2085024695225, 4601.585857272861, 4655.441347038377, 52952.73523632357, 55434.0, 55997.720011400495, 56080.439195608335, 59545.106823397684, 51171.48828511742, 51549.226761598606, 51974.22038669423, 51986.48013519892, 52528.212076818876, 46483.0, 46501.30248046282, 46627.53372466232, 46768.0, 47063.76468117706, 9128.771780705536, 9175.816483670156, 9254.444733316022, 9279.814403712024, 9361.485118318285, 34743.0, 35283.0, 35299.47050794292, 35697.46453803143, 35747.99999999896, 42595.787021064694, 45869.08261834678, 46336.7683161582, 46645.53354466412, 47142.52857471381, 11517.136214783757, 11636.06911447099, 11822.82265765997, 11846.289222646668, 12085.637430877088, 12876.356182190666, 13061.131296285312, 13155.736885262433, 13387.196768193939, 13483.797743033667, 11684.240524365889, 11716.297022178696, 11988.220765650205, 12048.879511204776, 12867.0, 11686.415679215836, 11786.764264714486, 11899.04807615406, 11997.980171685505, 12082.75834483323, 11260.268082574607, 11895.940520297343, 11902.345371004678, 12140.392980351124, 12157.270563766202, 10271.435071070864, 10440.58237670515, 10655.840162397415, 10675.57297708083, 11143.16426268017, 9997.350172238781, 10471.94764026175, 10647.0, 10694.62568810088, 10954.233203675667], "unit": "ms", "name": "yui.html", "value": 6806.864986937003}], "name": "dromaeo_css", "value": 7475.695390731457}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 112.0, 112.0, 121.0, 111.0, 112.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 145.0, 161.0, 126.0, 145.0, 154.0, 129.0, 156.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.5}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 161.0, 162.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 71.0, 164.0, 71.0, 74.0, 71.0, 71.0, 154.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 90.1}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 146.0, 92.0, 93.0, 94.0, 138.0, 92.0, 93.0, 145.0], "unit": "ms", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 61.0, 60.0, 59.0, 69.0, 59.0, 59.0, 56.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 83.0, 83.0, 82.0, 82.0, 81.0, 90.0, 87.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [124.0, 116.0, 119.0, 118.0, 119.0, 126.0, 120.0, 115.0, 128.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 147.0, 148.0, 147.0, 138.0, 149.0, 149.0, 147.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 68.0, 68.0, 68.0, 67.0, 70.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1507.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.50810989738497], "unit": "score", "name": "Richards", "value": 213.294684}, {"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "DeltaBlue", "value": 395.38564}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [909.9181073703367], "unit": "score", "name": "RayTrace", "value": 813.2479109999997}, {"lowerIsBetter": false, "replicates": [554.6311702717693], "unit": "score", "name": "Earley", "value": 1201.6327890000002}, {"lowerIsBetter": false, "replicates": [11010.989010989011], "unit": "score", "name": "Boyer", "value": 60.527078842315376}, {"lowerIsBetter": false, "replicates": [23952.380952380954], "unit": "score", "name": "RegExp", "value": 38.0331709741551}, {"lowerIsBetter": false, "replicates": [528.2620179609086], "unit": "score", "name": "Splay", "value": 154.26246300000008}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23232.889809312117}]} 18:27:26 INFO - RETURN: dromaeo_css: 7475.70 18:27:26 INFO - RETURN: kraken: 1507.40 18:27:26 INFO - RETURN: v8_7: 23232.89 18:27:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23232.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1507.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7475.70"}}} 18:27:26 INFO - Return code: 0 18:27:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:27:26 INFO - # TBPL SUCCESS # 18:27:26 INFO - Running post-action listener: _resource_record_post_action 18:27:26 INFO - Running post-run listener: _resource_record_post_run 18:27:27 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520638464; Read time: 12; Write time: 886608 18:27:27 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 244690944; Read time: 0; Write time: 515376 18:27:27 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275947520; Read time: 12; Write time: 371232 18:27:27 INFO - Running post-run listener: _upload_blobber_files 18:27:27 INFO - Blob upload gear active. 18:27:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:27:27 INFO - Copying logs to upload dir... 18:27:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.674351 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-12-22 18:27:27.235194) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-22 18:27:27.238492) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010124 build_url: 'https://queue.taskcluster.net/v1/task/2_-_NUb3ToS9ktjDSw37TA/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 2015-12-22 18:27:27.290246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:27:27.290560) ========= 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=c402a24d74c70935940d60dd000001de-1450836088.801893-80712015 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:27:27.339797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 18:27:27.340119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 18:27:27.340395) ========= ========= Total master_lag: 0.23 =========