builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1460415553.4 results: success (0) buildid: 20160411133031 builduid: b90dcda21f6c401fb474dc3211d88679 revision: 61ca2f5fd6967f16a01442e4a731ff94a317b63b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.396609) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.397129) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.397581) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004429 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.415558) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.415927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.428331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.428634) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004723 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.479653) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.480001) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.480381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.480698) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-11 15:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 226M=0s 2016-04-11 15:59:13 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.654785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.655131) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:13.704845) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 15:59:13.705225) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 61ca2f5fd6967f16a01442e4a731ff94a317b63b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 61ca2f5fd6967f16a01442e4a731ff94a317b63b --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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-11 15:59:13,842 truncating revision to first 12 chars 2016-04-11 15:59:13,842 Setting DEBUG logging. 2016-04-11 15:59:13,842 attempt 1/10 2016-04-11 15:59:13,842 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/61ca2f5fd696?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 15:59:14,629 unpacking tar archive at: mozilla-inbound-61ca2f5fd696/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 15:59:14.786257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:14.786570) ========= echo 61ca2f5fd6967f16a01442e4a731ff94a317b63b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'61ca2f5fd6967f16a01442e4a731ff94a317b63b'] 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 61ca2f5fd6967f16a01442e4a731ff94a317b63b program finished with exit code 0 elapsedTime=0.004719 script_repo_revision: '61ca2f5fd6967f16a01442e4a731ff94a317b63b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:14.836451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:14.836772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 15:59:14.847464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-11 15:59:14.847785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:59:15 INFO - MultiFileLogger online at 20160411 15:59:15 in /builds/slave/test-pgo 15:59:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:59:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:59:15 INFO - {'append_to_log': False, 15:59:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:59:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:59:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:59:15 INFO - 'branch': 'Mozilla-Inbound', 15:59:15 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:15 INFO - 'config_files': ('talos/linux_config.py',), 15:59:15 INFO - 'default_actions': ('clobber', 15:59:15 INFO - 'read-buildbot-config', 15:59:15 INFO - 'download-and-extract', 15:59:15 INFO - 'populate-webroot', 15:59:15 INFO - 'create-virtualenv', 15:59:15 INFO - 'install', 15:59:15 INFO - 'run-tests'), 15:59:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:15 INFO - 'download_minidump_stackwalk': True, 15:59:15 INFO - 'download_symbols': 'ondemand', 15:59:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:15 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:15 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:15 INFO - 'installer_path': 'installer.exe', 15:59:15 INFO - 'log_level': 'info', 15:59:15 INFO - 'log_name': 'talos', 15:59:15 INFO - 'log_to_console': True, 15:59:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:59:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:59:15 INFO - 'opt_config_files': (), 15:59:15 INFO - 'pip_index': False, 15:59:15 INFO - 'sps_profile': False, 15:59:15 INFO - 'sps_profile_interval': 0, 15:59:15 INFO - 'suite': 'dromaeojs-e10s', 15:59:15 INFO - 'system_bits': '32', 15:59:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:15 INFO - 'title': 'talos-linux64-ix-009', 15:59:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:15 INFO - 'use_talos_json': True, 15:59:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:59:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:15 INFO - 'work_dir': 'build'} 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running clobber step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: clobber 15:59:15 INFO - rmtree: /builds/slave/test-pgo/build 15:59:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running read-buildbot-config step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: read_buildbot_config 15:59:15 INFO - Using buildbot properties: 15:59:15 INFO - { 15:59:15 INFO - "project": "", 15:59:15 INFO - "product": "firefox", 15:59:15 INFO - "script_repo_revision": "production", 15:59:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:59:15 INFO - "repository": "", 15:59:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:59:15 INFO - "buildid": "20160411133031", 15:59:15 INFO - "pgo_build": "True", 15:59:15 INFO - "basedir": "/builds/slave/test-pgo", 15:59:15 INFO - "buildnumber": 906, 15:59:15 INFO - "slavename": "talos-linux64-ix-009", 15:59:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:59:15 INFO - "platform": "ubuntu64_hw", 15:59:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:59:15 INFO - "branch": "mozilla-inbound", 15:59:15 INFO - "repo_path": "integration/mozilla-inbound", 15:59:15 INFO - "revision": "61ca2f5fd6967f16a01442e4a731ff94a317b63b", 15:59:15 INFO - "stage_platform": "linux64-pgo", 15:59:15 INFO - "builduid": "b90dcda21f6c401fb474dc3211d88679", 15:59:15 INFO - "slavebuilddir": "test" 15:59:15 INFO - } 15:59:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:59:15 INFO - Running post-action listener: _resource_record_post_action 15:59:15 INFO - ##### 15:59:15 INFO - ##### Running download-and-extract step. 15:59:15 INFO - ##### 15:59:15 INFO - Running pre-action listener: _resource_record_pre_action 15:59:15 INFO - Running main action method: download_and_extract 15:59:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:15 INFO - https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:59:25 INFO - Downloaded 1361 bytes. 15:59:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:25 INFO - Using the following test package requirements: 15:59:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:59:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'jsshell-linux-x86_64.zip'], 15:59:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:25 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')]} 15:59:25 INFO - https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:59:38 INFO - Downloaded 23762447 bytes. 15:59:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:59:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:59:39 INFO - Return code: 0 15:59:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:59: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')]} 15:59:39 INFO - https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:59:40 INFO - Downloaded 23762447 bytes. 15:59:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:59:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:59:42 INFO - Return code: 0 15:59: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')]} 15:59:42 INFO - https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:59:43 INFO - Downloaded 10841076 bytes. 15:59:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:59:43 INFO - Return code: 0 15:59:43 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')]} 15:59:43 INFO - https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:59:45 INFO - Downloaded 57811812 bytes. 15:59:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:45 INFO - mkdir: /builds/slave/test-pgo/properties 15:59:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:59:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:59:45 INFO - Contents: 15:59:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:45 INFO - Running post-action listener: _resource_record_post_action 15:59:45 INFO - Running post-action listener: set_extra_try_arguments 15:59:45 INFO - ##### 15:59:45 INFO - ##### Running populate-webroot step. 15:59:45 INFO - ##### 15:59:45 INFO - Running pre-action listener: _resource_record_pre_action 15:59:45 INFO - Running main action method: populate_webroot 15:59:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:45 INFO - '--tppagecycles', 15:59:45 INFO - '7'], 15:59:45 INFO - 'tests': ['tsvgm']}}, 15:59:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:59:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:59:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['damp', 'tps']}, 15:59:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'tests': ['damp', 'tps']}, 15:59:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['dromaeo_dom']}, 15:59:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'other-e10s': {'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['a11yr', 15:59:45 INFO - 'ts_paint', 15:59:45 INFO - 'tpaint', 15:59:45 INFO - 'sessionrestore', 15:59:45 INFO - 'sessionrestore_no_auto_restore', 15:59:45 INFO - 'tabpaint']}, 15:59:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['tsvgx', 15:59:45 INFO - 'tsvgr_opacity', 15:59:45 INFO - 'tart', 15:59:45 INFO - 'tscrollx', 15:59:45 INFO - 'cart']}, 15:59:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:59:45 INFO - 'tsvgr_opacity', 15:59:45 INFO - 'tart', 15:59:45 INFO - 'tscrollx', 15:59:45 INFO - 'cart']}, 15:59:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'talos_options': ['--disable-e10s'], 15:59:45 INFO - 'tests': ['tp5o']}, 15:59:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'tests': ['tp5o']}, 15:59:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'talos_options': ['--disable-e10s', 15:59:45 INFO - '--xperf_path', 15:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:45 INFO - 'tests': ['tp5n']}, 15:59:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:45 INFO - 'talos_options': ['--xperf_path', 15:59:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:45 INFO - 'tests': ['tp5n']}}, 15:59:45 INFO - 'talos.zip': {'path': '', 15:59:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:45 INFO - Running post-action listener: _resource_record_post_action 15:59:45 INFO - ##### 15:59:45 INFO - ##### Running create-virtualenv step. 15:59:45 INFO - ##### 15:59:45 INFO - Running pre-action listener: _resource_record_pre_action 15:59:45 INFO - Running main action method: create_virtualenv 15:59:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:59:45 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 15:59:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:45 INFO - Using real prefix '/usr' 15:59:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:59:46 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:48 INFO - Installing pip.................done. 15:59:48 INFO - Return code: 0 15:59:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:59:48 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')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 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')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 15:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:48 INFO - Using env: {'DISPLAY': ':0', 15:59:48 INFO - 'HOME': '/home/cltbld', 15:59:48 INFO - 'LANG': 'en_US.UTF-8', 15:59:48 INFO - 'LANGUAGE': 'en_US:en', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MAIL': '/var/mail/cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SHLVL': '1', 15:59:48 INFO - 'TERM': 'linux', 15:59:48 INFO - 'TMOUT': '86400', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - '_': '/tools/buildbot/bin/python'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 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 15:59:48 INFO - Cleaning up... 15:59:48 INFO - Return code: 0 15:59:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:59:48 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')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 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')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 15:59:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:59:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:48 INFO - Using env: {'DISPLAY': ':0', 15:59:48 INFO - 'HOME': '/home/cltbld', 15:59:48 INFO - 'LANG': 'en_US.UTF-8', 15:59:48 INFO - 'LANGUAGE': 'en_US:en', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MAIL': '/var/mail/cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SHLVL': '1', 15:59:48 INFO - 'TERM': 'linux', 15:59:48 INFO - 'TMOUT': '86400', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - '_': '/tools/buildbot/bin/python'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 INFO - Downloading/unpacking psutil>=0.7.1 15:59:48 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 15:59:48 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 15:59:48 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 15:59:48 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 15:59:48 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 15:59:48 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 15:59:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:50 INFO - Installing collected packages: psutil 15:59:50 INFO - Running setup.py install for psutil 15:59:50 INFO - building 'psutil._psutil_linux' extension 15:59:50 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 15:59:51 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 15:59:51 INFO - building 'psutil._psutil_posix' extension 15:59:51 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 15:59:51 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 15:59:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:51 INFO - Successfully installed psutil 15:59:51 INFO - Cleaning up... 15:59:51 INFO - Return code: 0 15:59:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 15:59:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:59:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:59:51 INFO - Using env: {'DISPLAY': ':0', 15:59:51 INFO - 'HOME': '/home/cltbld', 15:59:51 INFO - 'LANG': 'en_US.UTF-8', 15:59:51 INFO - 'LANGUAGE': 'en_US:en', 15:59:51 INFO - 'LOGNAME': 'cltbld', 15:59:51 INFO - 'MAIL': '/var/mail/cltbld', 15:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:51 INFO - 'MOZ_NO_REMOTE': '1', 15:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:51 INFO - 'NO_EM_RESTART': '1', 15:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:51 INFO - 'SHELL': '/bin/bash', 15:59:51 INFO - 'SHLVL': '1', 15:59:51 INFO - 'TERM': 'linux', 15:59:51 INFO - 'TMOUT': '86400', 15:59:51 INFO - 'USER': 'cltbld', 15:59:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 15:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:51 INFO - '_': '/tools/buildbot/bin/python'} 15:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:53 INFO - Installing collected packages: mozsystemmonitor 15:59:53 INFO - Running setup.py install for mozsystemmonitor 15:59:53 INFO - Successfully installed mozsystemmonitor 15:59:53 INFO - Cleaning up... 15:59:53 INFO - Return code: 0 15:59:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 15:59:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:59:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:53 INFO - Using env: {'DISPLAY': ':0', 15:59:53 INFO - 'HOME': '/home/cltbld', 15:59:53 INFO - 'LANG': 'en_US.UTF-8', 15:59:53 INFO - 'LANGUAGE': 'en_US:en', 15:59:53 INFO - 'LOGNAME': 'cltbld', 15:59:53 INFO - 'MAIL': '/var/mail/cltbld', 15:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:53 INFO - 'MOZ_NO_REMOTE': '1', 15:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:53 INFO - 'NO_EM_RESTART': '1', 15:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:53 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:53 INFO - 'SHELL': '/bin/bash', 15:59:53 INFO - 'SHLVL': '1', 15:59:53 INFO - 'TERM': 'linux', 15:59:53 INFO - 'TMOUT': '86400', 15:59:53 INFO - 'USER': 'cltbld', 15:59:53 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 15:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:53 INFO - '_': '/tools/buildbot/bin/python'} 15:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:53 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 15:59:53 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 15:59:53 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 15:59:53 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 15:59:53 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 15:59:53 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 15:59:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:59:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:56 INFO - Downloading docopt-0.6.1.tar.gz 15:59:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:56 INFO - Running setup.py install for blobuploader 15:59:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:59:56 INFO - Running setup.py install for requests 15:59:57 INFO - Running setup.py install for docopt 15:59:57 INFO - Successfully installed blobuploader requests docopt 15:59:57 INFO - Cleaning up... 15:59:57 INFO - Return code: 0 15:59:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 15:59:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:59:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:57 INFO - Using env: {'DISPLAY': ':0', 15:59:57 INFO - 'HOME': '/home/cltbld', 15:59:57 INFO - 'LANG': 'en_US.UTF-8', 15:59:57 INFO - 'LANGUAGE': 'en_US:en', 15:59:57 INFO - 'LOGNAME': 'cltbld', 15:59:57 INFO - 'MAIL': '/var/mail/cltbld', 15:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:57 INFO - 'MOZ_NO_REMOTE': '1', 15:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:57 INFO - 'NO_EM_RESTART': '1', 15:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:57 INFO - 'SHELL': '/bin/bash', 15:59:57 INFO - 'SHLVL': '1', 15:59:57 INFO - 'TERM': 'linux', 15:59:57 INFO - 'TMOUT': '86400', 15:59:57 INFO - 'USER': 'cltbld', 15:59:57 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 15:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:57 INFO - '_': '/tools/buildbot/bin/python'} 15:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:57 INFO - Running setup.py (path:/tmp/pip-jQZ2hv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:57 INFO - Running setup.py (path:/tmp/pip-UCGUe1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:57 INFO - Running setup.py (path:/tmp/pip-9sGx6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:57 INFO - Running setup.py (path:/tmp/pip-ZZwJ_C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:57 INFO - Running setup.py (path:/tmp/pip-x_Qkrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:57 INFO - Running setup.py (path:/tmp/pip-UIlP8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:57 INFO - Running setup.py (path:/tmp/pip-lTJyEC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:57 INFO - Running setup.py (path:/tmp/pip-tBIwxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:58 INFO - Running setup.py (path:/tmp/pip-itVtCw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:58 INFO - Running setup.py (path:/tmp/pip-NvvUEH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:58 INFO - Running setup.py (path:/tmp/pip-VNnDdt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:58 INFO - Running setup.py (path:/tmp/pip-NF3n4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:58 INFO - Running setup.py (path:/tmp/pip-fXsngt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:58 INFO - Running setup.py (path:/tmp/pip-G_f4qP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:58 INFO - Running setup.py (path:/tmp/pip-i5np3H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:58 INFO - Running setup.py (path:/tmp/pip-oEbOnS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:58 INFO - Running setup.py (path:/tmp/pip-9HhKL0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:58 INFO - Running setup.py install for manifestparser 15:59:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:59:58 INFO - Running setup.py install for mozcrash 15:59:58 INFO - Running setup.py install for mozdebug 15:59:58 INFO - Running setup.py install for mozdevice 15:59:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for mozfile 15:59:59 INFO - Running setup.py install for mozhttpd 15:59:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for mozinfo 15:59:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for mozInstall 15:59:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for mozleak 15:59:59 INFO - Running setup.py install for mozlog 15:59:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for moznetwork 15:59:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Running setup.py install for mozprocess 15:59:59 INFO - Running setup.py install for mozprofile 15:59:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:59:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 16:00:00 INFO - Running setup.py install for mozrunner 16:00:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 16:00:00 INFO - Running setup.py install for mozscreenshot 16:00:00 INFO - Running setup.py install for moztest 16:00:00 INFO - Running setup.py install for mozversion 16:00:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 16:00:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:00:00 INFO - Cleaning up... 16:00:00 INFO - Return code: 0 16:00:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:00 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')]} 16:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 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')]} 16:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 16:00:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 16:00:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:00:00 INFO - Using env: {'DISPLAY': ':0', 16:00:00 INFO - 'HOME': '/home/cltbld', 16:00:00 INFO - 'LANG': 'en_US.UTF-8', 16:00:00 INFO - 'LANGUAGE': 'en_US:en', 16:00:00 INFO - 'LOGNAME': 'cltbld', 16:00:00 INFO - 'MAIL': '/var/mail/cltbld', 16:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:00 INFO - 'MOZ_NO_REMOTE': '1', 16:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:00 INFO - 'NO_EM_RESTART': '1', 16:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:00 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:00 INFO - 'SHELL': '/bin/bash', 16:00:00 INFO - 'SHLVL': '1', 16:00:00 INFO - 'TERM': 'linux', 16:00:00 INFO - 'TMOUT': '86400', 16:00:00 INFO - 'USER': 'cltbld', 16:00:00 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 16:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:00 INFO - '_': '/tools/buildbot/bin/python'} 16:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:00 INFO - Running setup.py (path:/tmp/pip-dRTGJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 16:00:00 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)) 16:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:00 INFO - Running setup.py (path:/tmp/pip-aHHKjt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 16:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 16:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:00 INFO - Running setup.py (path:/tmp/pip-OKxgc3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 16:00:00 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)) 16:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:00 INFO - Running setup.py (path:/tmp/pip-Q_vET8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 16:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 16:00:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:00 INFO - Running setup.py (path:/tmp/pip-pIX3aj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:01 INFO - Running setup.py (path:/tmp/pip-f8u0Ln-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:01 INFO - Running setup.py (path:/tmp/pip-li9PVb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:01 INFO - Running setup.py (path:/tmp/pip-ilKf4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:01 INFO - Running setup.py (path:/tmp/pip-iTBeZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:01 INFO - Running setup.py (path:/tmp/pip-pYYbKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:01 INFO - Running setup.py (path:/tmp/pip-Bo1U0j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:01 INFO - Running setup.py (path:/tmp/pip-2RXj8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:01 INFO - Running setup.py (path:/tmp/pip-8axzl2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 16:00:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:01 INFO - Running setup.py (path:/tmp/pip-PxmI7s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:01 INFO - Running setup.py (path:/tmp/pip-hRnIq4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:01 INFO - Running setup.py (path:/tmp/pip-xsd038-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 16:00:01 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)) 16:00:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:01 INFO - Running setup.py (path:/tmp/pip-6NZwUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 16:00:01 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)) 16:00:01 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:00:01 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 16:00:01 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)) 16:00:01 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:00:01 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 16:00:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 16:00:01 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 16:00:01 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 16:00:01 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 16:00:01 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 16:00:01 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 16:00:01 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 16:00:03 INFO - Downloading blessings-1.6.tar.gz 16:00:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 16:00:03 INFO - Installing collected packages: blessings 16:00:03 INFO - Running setup.py install for blessings 16:00:03 INFO - Successfully installed blessings 16:00:03 INFO - Cleaning up... 16:00:04 INFO - Return code: 0 16:00:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 16:00:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:04 INFO - Reading from file tmpfile_stdout 16:00:04 INFO - Current package versions: 16:00:04 INFO - argparse == 1.2.1 16:00:04 INFO - blessings == 1.6 16:00:04 INFO - blobuploader == 1.2.4 16:00:04 INFO - docopt == 0.6.1 16:00:04 INFO - manifestparser == 1.1 16:00:04 INFO - mozInstall == 1.12 16:00:04 INFO - mozcrash == 0.17 16:00:04 INFO - mozdebug == 0.1 16:00:04 INFO - mozdevice == 0.48 16:00:04 INFO - mozfile == 1.2 16:00:04 INFO - mozhttpd == 0.7 16:00:04 INFO - mozinfo == 0.9 16:00:04 INFO - mozleak == 0.1 16:00:04 INFO - mozlog == 3.1 16:00:04 INFO - moznetwork == 0.27 16:00:04 INFO - mozprocess == 0.22 16:00:04 INFO - mozprofile == 0.28 16:00:04 INFO - mozrunner == 6.11 16:00:04 INFO - mozscreenshot == 0.1 16:00:04 INFO - mozsystemmonitor == 0.0 16:00:04 INFO - moztest == 0.7 16:00:04 INFO - mozversion == 1.4 16:00:04 INFO - psutil == 3.1.1 16:00:04 INFO - requests == 1.2.3 16:00:04 INFO - wsgiref == 0.1.2 16:00:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 16:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 16:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 16:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:00:04 INFO - Using env: {'DISPLAY': ':0', 16:00:04 INFO - 'HOME': '/home/cltbld', 16:00:04 INFO - 'LANG': 'en_US.UTF-8', 16:00:04 INFO - 'LANGUAGE': 'en_US:en', 16:00:04 INFO - 'LOGNAME': 'cltbld', 16:00:04 INFO - 'MAIL': '/var/mail/cltbld', 16:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:04 INFO - 'MOZ_NO_REMOTE': '1', 16:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:04 INFO - 'NO_EM_RESTART': '1', 16:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:04 INFO - 'SHELL': '/bin/bash', 16:00:04 INFO - 'SHLVL': '1', 16:00:04 INFO - 'TERM': 'linux', 16:00:04 INFO - 'TMOUT': '86400', 16:00:04 INFO - 'USER': 'cltbld', 16:00:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 16:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:04 INFO - '_': '/tools/buildbot/bin/python'} 16:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 16:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 16:00:04 INFO - Cleaning up... 16:00:04 INFO - Return code: 0 16:00:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 16:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 16:00:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 16:00:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:00:04 INFO - Using env: {'DISPLAY': ':0', 16:00:04 INFO - 'HOME': '/home/cltbld', 16:00:04 INFO - 'LANG': 'en_US.UTF-8', 16:00:04 INFO - 'LANGUAGE': 'en_US:en', 16:00:04 INFO - 'LOGNAME': 'cltbld', 16:00:04 INFO - 'MAIL': '/var/mail/cltbld', 16:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:04 INFO - 'MOZ_NO_REMOTE': '1', 16:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:04 INFO - 'NO_EM_RESTART': '1', 16:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:04 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:04 INFO - 'SHELL': '/bin/bash', 16:00:04 INFO - 'SHLVL': '1', 16:00:04 INFO - 'TERM': 'linux', 16:00:04 INFO - 'TMOUT': '86400', 16:00:04 INFO - 'USER': 'cltbld', 16:00:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 16:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:04 INFO - '_': '/tools/buildbot/bin/python'} 16:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:04 INFO - Downloading/unpacking jsonschema 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:04 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 16:00:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:00:06 INFO - Downloading/unpacking functools32 (from jsonschema) 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 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 16:00:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 16:00:06 INFO - warning: no files found matching '*.txt' 16:00:06 INFO - no previously-included directories found matching 'build' 16:00:06 INFO - no previously-included directories found matching 'dist' 16:00:06 INFO - no previously-included directories found matching '.git*' 16:00:06 INFO - Installing collected packages: jsonschema, functools32 16:00:06 INFO - Running setup.py install for functools32 16:00:07 INFO - warning: no files found matching '*.txt' 16:00:07 INFO - no previously-included directories found matching 'build' 16:00:07 INFO - no previously-included directories found matching 'dist' 16:00:07 INFO - no previously-included directories found matching '.git*' 16:00:07 INFO - Successfully installed jsonschema functools32 16:00:07 INFO - Cleaning up... 16:00:07 INFO - Return code: 0 16:00:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 16:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4f121cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19768d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, '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': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', '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 16:00:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 16:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:00:07 INFO - Using env: {'DISPLAY': ':0', 16:00:07 INFO - 'HOME': '/home/cltbld', 16:00:07 INFO - 'LANG': 'en_US.UTF-8', 16:00:07 INFO - 'LANGUAGE': 'en_US:en', 16:00:07 INFO - 'LOGNAME': 'cltbld', 16:00:07 INFO - 'MAIL': '/var/mail/cltbld', 16:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:07 INFO - 'MOZ_NO_REMOTE': '1', 16:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:07 INFO - 'NO_EM_RESTART': '1', 16:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:07 INFO - 'SHELL': '/bin/bash', 16:00:07 INFO - 'SHLVL': '1', 16:00:07 INFO - 'TERM': 'linux', 16:00:07 INFO - 'TMOUT': '86400', 16:00:07 INFO - 'USER': 'cltbld', 16:00:07 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 16:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:07 INFO - '_': '/tools/buildbot/bin/python'} 16:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:00:07 INFO - Downloading/unpacking flake8 16:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:00:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:00:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 16:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:09 INFO - no previously-included directories found matching 'docs/_build' 16:00:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:00:09 INFO - Running setup.py install for pep8 16:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:00:10 INFO - no previously-included directories found matching 'docs/_build' 16:00:10 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 16:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:00:10 INFO - Cleaning up... 16:00:10 INFO - Return code: 0 16:00:10 INFO - Running post-action listener: _resource_record_post_action 16:00:10 INFO - Running post-action listener: _start_resource_monitoring 16:00:10 INFO - Starting resource monitoring. 16:00:10 INFO - ##### 16:00:10 INFO - ##### Running install step. 16:00:10 INFO - ##### 16:00:10 INFO - Running pre-action listener: _resource_record_pre_action 16:00:10 INFO - Running main action method: install 16:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 16:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 16:00:10 INFO - Reading from file tmpfile_stdout 16:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 16:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 16:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 16:00:10 INFO - Reading from file tmpfile_stdout 16:00:10 INFO - Output received: 16:00:10 INFO - Usage: mozinstall [options] installer 16:00:10 INFO - Options: 16:00:10 INFO - -h, --help show this help message and exit 16:00:10 INFO - -d DEST, --destination=DEST 16:00:10 INFO - Directory to install application into. [default: 16:00:10 INFO - "/builds/slave/test-pgo"] 16:00:10 INFO - --app=APP Application being installed. [default: firefox] 16:00:10 INFO - mkdir: /builds/slave/test-pgo/build/application 16:00:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 16:00:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 16:00:26 INFO - Reading from file tmpfile_stdout 16:00:26 INFO - Output received: 16:00:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:00:26 INFO - Running post-action listener: _resource_record_post_action 16:00:26 INFO - ##### 16:00:26 INFO - ##### Running run-tests step. 16:00:26 INFO - ##### 16:00:26 INFO - Running pre-action listener: _resource_record_pre_action 16:00:26 INFO - Running main action method: run_tests 16:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:00:26 INFO - Python 2.7.3 16:00:26 INFO - Return code: 0 16:00:26 INFO - grabbing minidump binary from tooltool 16:00: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')]} 16:00:26 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 0x1a058b0>, '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 0x1a067b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a06c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:00:26 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 16:00:26 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 16:00:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:26 INFO - Return code: 0 16:00:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:00:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:00:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:00:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:00:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:00:27 INFO - Return code: 0 16:00:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:00:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:00:27 INFO - Using env: {'DISPLAY': ':0', 16:00:27 INFO - 'HOME': '/home/cltbld', 16:00:27 INFO - 'LANG': 'en_US.UTF-8', 16:00:27 INFO - 'LANGUAGE': 'en_US:en', 16:00:27 INFO - 'LOGNAME': 'cltbld', 16:00:27 INFO - 'MAIL': '/var/mail/cltbld', 16:00:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:27 INFO - 'MOZ_NO_REMOTE': '1', 16:00:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:27 INFO - 'NO_EM_RESTART': '1', 16:00:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:00:27 INFO - 'SHELL': '/bin/bash', 16:00:27 INFO - 'SHLVL': '1', 16:00:27 INFO - 'TERM': 'linux', 16:00:27 INFO - 'TMOUT': '86400', 16:00:27 INFO - 'USER': 'cltbld', 16:00:27 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136', 16:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:27 INFO - '_': '/tools/buildbot/bin/python'} 16:00:27 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:00:28 INFO - mozversion application_buildid: 20160411133031 16:00:28 INFO - mozversion application_changeset: 61ca2f5fd6967f16a01442e4a731ff94a317b63b 16:00:28 INFO - mozversion application_display_name: Nightly 16:00:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:28 INFO - mozversion application_name: Firefox 16:00:28 INFO - mozversion application_remotingname: firefox 16:00:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:00:28 INFO - mozversion application_vendor: Mozilla 16:00:28 INFO - mozversion application_version: 48.0a1 16:00:28 INFO - mozversion platform_buildid: 20160411133031 16:00:28 INFO - mozversion platform_changeset: 61ca2f5fd6967f16a01442e4a731ff94a317b63b 16:00:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:00:28 INFO - mozversion platform_version: 48.0a1 16:00:28 INFO - using testdate: 1460415628 16:00:28 INFO - actual date: 1460415628 16:00:28 INFO - starting webserver on 'localhost:37665' 16:00:28 INFO - SUITE-START | Running 2 tests 16:00:28 INFO - TEST-START | dromaeo_css 16:00:28 INFO - operating with platform_type : linux_ 16:00:28 INFO - Initialising browser for dromaeo_css test... 16:00:28 INFO - TEST-INFO | started process 30297 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUJrMVa/profile http://localhost:37665/getInfo.html) 16:00:31 INFO - PROCESS | 30297 | 16:00:31 INFO - PROCESS | 30297 | (process:30365): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:32 INFO - PROCESS | 30297 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:00:32 INFO - PROCESS | 30297 | __metrics Screen width/height:1600/1200 16:00:32 INFO - PROCESS | 30297 | colorDepth:24 16:00:32 INFO - PROCESS | 30297 | Browser inner width/height: 1024/697 16:00:32 INFO - PROCESS | 30297 | __metrics 16:00:33 ERROR - PROCESS | 30297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:00:34 INFO - TEST-INFO | 30297: exit 0 16:00:34 INFO - Browser initialized. 16:00:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:34 INFO - TEST-INFO | started process 30416 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUJrMVa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:36 INFO - PROCESS | 30416 | 16:00:36 INFO - PROCESS | 30416 | (process:30476): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:46 INFO - PROCESS | 30416 | RSS: Main: 163307520 16:00:46 INFO - PROCESS | 30416 | 16:01:35 INFO - PROCESS | 30416 | 1460415695812 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] 16:03:43 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37665/tests/dromaeo/cssquery-ext.html) 16:03:44 INFO - PROCESS | 30416 | RSS: Main: 168714240 16:03:44 INFO - PROCESS | 30416 | 16:06:46 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-ext.html (next: http://localhost:37665/tests/dromaeo/cssquery-jquery.html) 16:06:47 INFO - PROCESS | 30416 | RSS: Main: 165060608 16:06:47 INFO - PROCESS | 30416 | 16:09:48 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37665/tests/dromaeo/cssquery-mootools.html) 16:09:49 INFO - PROCESS | 30416 | RSS: Main: 166068224 16:09:49 INFO - PROCESS | 30416 | 16:12:51 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37665/tests/dromaeo/cssquery-prototype.html) 16:12:51 INFO - PROCESS | 30416 | RSS: Main: 163913728 16:12:51 INFO - PROCESS | 30416 | 16:15:54 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37665/tests/dromaeo/cssquery-yui.html) 16:15:54 INFO - PROCESS | 30416 | RSS: Main: 165249024 16:15:54 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | Cycle 1(1): loaded http://localhost:37665/tests/dromaeo/cssquery-yui.html (next: http://localhost:37665/tests/dromaeo/cssquery-dojo.html) 16:18:57 INFO - PROCESS | 30416 | RSS: Main: 167559168 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | __start_tp_report 16:18:57 INFO - PROCESS | 30416 | _x_x_mozilla_page_load 16:18:57 INFO - PROCESS | 30416 | _x_x_mozilla_page_load_details 16:18:57 INFO - PROCESS | 30416 | |i|pagename|runs| 16:18:57 INFO - PROCESS | 30416 | |0;dojo.html;3141.2932090279687;3170.1123685368098;3205.2627895584;3219.0181994491686;3227.1770698471887;5383.353997520298;5383.9461605383985;5402.243685883969;5406.783728650854;5466.644668096581;5240.973795131029;5404.675719456835;5501.312335958005;5512;5546.805861794838;4872.488388719186;4960.181570040939;4971.602271818246;5129.410117836459;5142.460041695625;5027.245913113025;5051.520105589963;5062.164742817431;5065.1642478990925;5074.822381216658;4722.881927951811;4809.326694262789;4892.535209155125;4940.802367905279;5032.245163225527;4887.975560122212;4905.730184839832;4925.950740492621;4927.1870141426625;4950.207966725343;4818.494058123917;4867.221244600847;4870.6347023972985;4896;4928.482509336504;5298.258243845865;5345.705986170759;5352.170413585901;5364.812231571916;5366.248725178478;5696.914546281809;5708.942910570882;5717.199592057115;5724.4561766632105;5733.713314334266;5711.05767548354;5776.133579962997;5780.739866706008;5781.046127388976;5842.006858834008;5396.811111611075;5406.567474602022;5421.484958928895;5427.050266203438;5470.589705772043;5914.763409463573;5922.49658779;5930.644161350333;5930.673812940244;5934.13954976526;5581.386047534768;5665.66006039639;5673.489385955284;5747.942520574825;5765.625234359753;5857.121431785266;5870.970645146747;5874.618149820248;5887.087501437284;5891.175235467038;5627.324721033502;5658.801941932013;5693;5742.885142297131;5750.856228594319;5630.465105814941;5733.799317023884;5757.625754325955;5769.798057068067;5784.942150578525;4441.111777644484;4456.108778244364;4465.732056076646;4473.910521789611;4506.436695413074;3940.5074365704286;3960.544537378181;3961.504811898513;3975.204959008152;4004.739691920016;5433.266509021231;5576.525995290446;5619.4099619540175;5673.687947162945;5679.5172410345585;5875.324337701134;5879.441453061952;5890.263717035371;5896.469317761336;5934.109883517421;5692.8861422771315;5704;5722.341930677942;5725.341585717612;5732.3407808101765;4816.783244753994;4927.802887884444;4986.551210391082;4995;5009.323741294878;6128.3672827644;6133.977404287557;6149.877002459926;6158.107074474266;6169.598976066542;5813.709314534341;5853.678047707417;5857.384974577608;5874.882502350015;5912.46787789101;5918.733656985532;6120.599512025131;6144.293406258159;6176.567640265318;6204.069389591416;5674.432556744293;5682.6306290091015;5686.943130568641;5693.9430605693415;5714.228579141763;5738.655680659173;5755.251817263729;5784.074548072288;5794.62334948227;5796.884062318814;5442.3469183696625;5541.3904470509015;5632.5493960482245;5704.771809127588;5728.627639203439;5690.630109042899;5715.2855893013375;5753.942460575341;5754.884902302014;5802.361740208489;5522.696251706195;5528.115501519737;5533.253010843485;5538.750756216061;5547.5007249347755;5574.275344205227;5738.540916726735;5754.2519472469985;5787.826365209051;5822.0684690449325;5566.4990150886615;5575.832725018094;5577.749001295033;5577.776888924398;5613.663180209201 16:18:57 INFO - PROCESS | 30416 | |1;ext.html;611.6513587255266;643.9935600643995;658.3383699382122;668.6790340636494;693.6705065094084;36639.450408243894;38243.42634860476;38565;38661.420078698844;38671.22657546854;38809;39094.60905390945;39525.8023709881;39533;39614.20771584567;8610.397272190949;8775.122487751238;8787.692430764924;8835.77910552235;8867.290616750644;8769.079246679103;8785.516796576187;8828.73513794584;8843.29253659709;8854.468731876075;8835.46987180768;8884.555772211395;8894.644214231423;8903.154200350957;8909.599068041955;8775.297976161892;8794.592865141547;8854.247388971946;8855.778605534848;8914.687985920495;8779.253763430052;8855.73432797017;8881.378303518757;8882.511461869595;8920.197182253629;32434.35131297361;41188;41525.584744152475;41665.58334416678;41766.1646767066;3303.702666760003;3348.5479460272795;3508.5088087667746;3545.7340699447386;3591.425371940477;27349.86325068382;29013;29162;29555.852220738972;29695.70304296951;4000.819963101638;4138.275801734714;4165.91668166638;4180;4218.451601291843;220312;220811;221868;222695;223772;34663;35128.47307290393;35288.29423411517;35310;36826;34640.653593464245;34882.825585871906;34894.825525872206;34896.30207395838;35013;13723.862761372458;13895.305234738222;14012.929935350257;14055.648608784863;14095.436182552583;10894.945525272324;10962.287451315638;10990.285631433931;10993.890061099446;11067.114630829514;8534.359923005799;8611.65553377858;8629.43908645936;8706.650469177288;8717.259032982267;3304.5373647689344;3311.8840840570947;3367.461206206995;3371.292028674006;3425.880094196691;978.1832170137873;1006.4313662780505;1044.3656473326362;1076.9730756730987;1121.6635009497118;32381.35237295241;32687.5562382863;32721.836390817894;33061.66938330634;33113.834430828174;1053.5680371047833;1058.4601853054996;1070.71626019105;1086.5979587552656;1176.276589897224;15879.039667638837;15914.283857226452;15918.442854500268;15995.440159594358;16132.354705811871;418577;422676;426862;427487;427603;56721.14918276229;57495.42504574984;57693.423065769646;57989.42010579925;58131.93076484605;1370.5408688089403;1402.6703724624908;1410.7178564287183;1418.6169734171715;1420.6945506716106;28934.131976040753;29361.412771744872;29472.55791163177;29631.85184074066;30084;45752.31371529363;46577.3013404806;46810.531894680615;47024.29463557981;47108.7644561775;290427;291774;295090;295605;297893;28264;28282.15153545397;28546.143615691562;28687.282817929718;28765.424691505636;46832.297515537975;47636.414226232584;47817;48238.51761482481;48266.27600585924;39320.2135957285;39469.60530394774;40290.1941961165;41241.793791030854;41389.793051034554;34767;34929.30141397107;35031.82484087563;35436.291274173855;37072.258554828215;41268.587314126475;41599.58400415957;41827.58172418237;42321.153576927674;42413.78793106015;34666.65333346735;36099.694882921765;36628.267434650625;36702.8164859174;36709.63290367169;28036.579451308655;28304.575431368135;28752.42495150127;28851.5672264912;28942.276443089093 16:18:57 INFO - PROCESS | 30416 | |2;jquery.html;390.44946625258393;390.451415760856;401;402.9053172504463;405.44858991771196;17698.20358083886;18131.456056318333;18330.450086497392;18349.81650183498;19892.70160947587;16702;17096.658066838656;17257.39599114031;18347.81652183478;18385.448436546892;5582.218489411496;5626.071698169818;5831.387704291052;5843.824685259449;5879.735411906453;5691.943080569183;5693.601447898649;5701.14482827575;5706.800261990831;5709.0580054290995;5537.667739935597;5612.522935550483;5615.7472913718775;5635.63368381056;5674.552988987803;5675.914861277084;5697.344805347397;5701.657900525982;5704.372519022904;5722.341930677963;5010.599152067826;5022.974885125587;5062.31658726071;5110.9744451277875;5135.101357262464;21787;22089;22124.88937555302;22310.330690079325;22338.888305558532;2343.94140146496;2344.4373350395954;2354.21133920137;2704.269847141261;2843.900463483789;13460.394282257323;14198.716025679429;14211.36048877803;14388.06477578954;14447.133172009713;1865.9346922857635;1934.1006432009183;1945.105251584273;1970.8620396572246;1992.3724026931616;74213.62893185554;75982.62008689977;77770;78193;79396;9998.200143988464;10074.345167564084;10318.587256509656;10956.28784129029;11136.164787640959;14525.128492290496;14765.187914664797;14781.039232450072;14818.777718334233;14820;7461.738839140604;7773.183815699384;7883.802904927423;7885.329746971457;7898.921010789819;7507.099148102263;7588.127365353055;7598.658060387185;7617.238276172338;7685.231476852382;6193.256809182837;6277.24673039229;6283.088952102011;6392.872142557123;6412;1902.267626963629;1916.3963351544219;1927.8264956154014;1934.3616606520095;1952.8925909074853;968.7917097824002;984.6799790068256;1008.3596915958273;1024.4365598920565;1056.8203405421098;18314.725279120823;18516;18858;19054.523636909187;19173.424797256106;997.436448406648;998.3710262534556;1008.5965613754557;1044.3107549017611;1067.8024565455416;10363.844542331872;10416.895831041744;10725.570977160982;10825.07986821129;10844.373343998463;476877;506442;512826.87173128536;521081;521333;76575.61712191404;76955;78938;80086;81103;1044.7179261599479;1061.0556604621893;1066.0938202527789;1075.5697720911542;1077.6443773554709;15847.603809904844;16212.837871621605;16503.752443713114;16706.916465417595;16769;34758.30483390368;35549.111272218404;35634.64365356313;35720.64279357277;38419;47215.52784472111;49095.754521227165;50059.74970125126;50504;50568.747156263984;8165.591720413837;8299.585020748818;8384.622691978997;8580.399372044147;8658.783530411538;12953.54662586805;13132.671683207614;13465.730685386434;13469.595912122651;13650.726985460435;11553.537858485566;11953.402329883296;12190.75618487643;12267.570635028089;12278.140530162802;11586.536538538365;11685.883141168479;11736.823947640622;11762.235454695418;11836.76326473483;10923.726906827074;11320.320780753182;11660;11954.58158964432;12303.93848030754;7333.853322933618;7497.962510187414;8036.1160272368825;8423.11557286476;8597.699080532402;11058.778824423305;11321.603743869255;11644.35956022427;11686.94156529212;12031.63905082849 16:18:57 INFO - PROCESS | 30416 | |3;mootools.html;1467.1857119298788;1528.487956534561;1695.7965044194698;1798.8740788144835;1831.5146486181172;7345.88981165283;7967.76096717098;8109.310708589777;8267.917320826797;8280.917190828097;8304.294134998518;8308.875366869503;8352.415330926837;8362.874556881652;8370.53962032088;2352.9764702352973;2360.173939121311;2364.0661938534267;2372.8694921779297;2381.57131716291;2338.053088499152;2358.6933698619155;2402.315340128064;2406.6750988616486;2408.2414039577566;2350.0717216699395;2352.9529409411803;2365.06579900939;2381.0356805493802;2384.380061184096;2292.7248730152323;2306.6885970394032;2313.6645186447954;2313.7686231376897;2326.6975293211945;2245.932622021342;2258.4579700871836;2274.9886250568807;2275.5107651854764;2293.690351802502;8191.385646076568;8218.671253149867;8224.38317126218;8283.130271321485;8307.667693292262;5001.374828146481;5058.696478211319;5155.690658560461;5163.122269214243;5172.379314482248;3411.3688967541084;3454.827258637058;3501.1072176594807;3516.3494753470436;3526.7531272810916;1079.6545105566222;1105.6019832860163;1115.1970581181536;1118.1669656106253;1131.7736452709491;10634.202434817342;10804.675859724142;10813.18901082414;10817.83773243402;10832.729181770519;4370.868873933787;4438.755868427203;4511.571400716926;4565.520620334817;4687.789049492712;9269.860952085724;9271.953640231755;9287.210587100171;9292.814143717223;9297;5208;5222.060029194781;5222.4255331913455;5225.484609463213;5240.868978275497;4218.599233072914;4559.38448309474;4677.906441871143;4686.507916668701;4838.661293709477;3832.770033797981;3899.66852817508;3962.88111356654;3986.4817573715814;3998.3402738547816;1280.8719128087303;1288.1820044271956;1307.7057662025968;1331.8401791785047;1347.3061373392711;1237.566851601932;1242.6023672424917;1243.8631750507436;1358.959231223065;1379.7102608452137;7398.593077380796;7423.888641670379;7424.368928641018;7464.70141194357;7606.619669016527;461.3241601054471;463.10158292911643;465.68798904733234;467.82690404550533;490.4090570862103;5992.700364981821;6055.2430946131735;6068.696565171724;6115.633062016204;6120.908186377208;9493.477858717837;9704.126628603459;9879.901200988043;9904;9930.354526955725;9538.141567258841;9803.509824508747;9804.558794854249;9824.115829575372;9839.852402213972;7372.852542949111;7413.481056326005;7432.331090201799;7514.774556763196;7542.358899493494;7459.738909138154;7575.924240757742;7639.961800190964;7793.337566306701;7920.564368959763;8781.473111613068;8881.289496840367;9003.054679258583;9132.269418446376;9272.072792720674;8866.556672166495;9009.594568244576;9022.864657030019;9023.458592484472;9187;6665.766698165541;6899.930510770839;7074.504784665024;7283.963580182065;7406.629668516661;7710.845783084419;7785.260400261966;7805.024371953506;7815.921840781747;7854.410919181199;6926.515143939876;7085.645717713991;7163.176234733072;7181.317774811385;7197.172325182671;6957.199922009034;7022.648867556704;7032.331928466788;7043.154821421463;7193.388561972291;7144.535605185646;7308.269173082649;7531.058617672791;7540.359069479156;7560.546367217985;6801.115854939024;6864.862702745817;6882.070920425878;6897.7240910363025;6897.965510172417;6760.560563563353;6775.424088952297;6933.0986971693355;6952.791416257521;6956.582605043714 16:18:57 INFO - PROCESS | 30416 | |4;prototype.html;334.3463528801193;335.6509230400384;338.20521773831484;340.12757277583;348.26342286064965;5785.2189954356145;5862.677552734598;5884.382139875315;5907.88184236315;5921.615095018821;5791.942080579193;5815.447532484418;5835.153902684108;5846.590738648296;5861.912071318934;4444.4888837783665;4496.460424749034;4531.773411329436;4548.5224051474615;4550.180967425878;4532.9093418131615;4537.342085397615;4538.7503687297185;4549.340345649879;4553.134904368159;4496.955030449686;4513.50351461339;4522.186006518826;4531.184386810372;4534.478534968472;4375.540568240337;4422.447194100753;4430.446194225722;4474.351219073216;4531.62089902802;3919.627635374635;3921.0981474260793;3929;3937.9409308860104;3950.940735888964;5549.223108764776;5576.553875689935;5585.748641311151;5600.019996500637;5615.887682246333;5162.638615296931;5216.087184742692;5229.660072095339;5235.712035838027;5250.789968401259;6065.181200537915;6066.514678825683;6081.361457046991;6090.908636370458;6114.144019837182;4369.082492676542;4382.342648602735;4390.868273951786;4403.3174857897075;4414.668899832525;5977.3723759005115;6161.151654503676;6168.537359698041;6366.458850997625;6422.293547709748;4496.19068567661;4510.661700372485;4514.210013247669;4541.069080838486;4543.886402839889;4590.701604395704;4617.653675974316;4618.538146185355;4619.23782575878;4621.3068039793625;4903.901921961541;5098.872528186825;5237.16205407133;5243.449437809051;5258.421573626898;6135.202423684982;6135.478484328882;6172.8765424691255;6197.81406557804;6219.067139929047;1531.5022617649086;1533.5246073717183;1551.9379224831107;1557.5015994881755;1567.968640627204;978.4227305889559;998.3560603410759;1008.8083264179929;1027.5786927359748;1038.3977293169944;6029.095635654687;6060.454559089703;6085.8478538036015;6086.756529738761;6108.938910610926;6267.811965641038;6318.210223722035;6352.174217351807;6370.299267080617;6380.234371875312;5971.761129554856;6092.6543280837195;6113.633182009094;6127.969360153171;6136.355682653257;3389.322135572895;3391.6608339165887;3402.3705614461405;3406.3527929693278;3411.3859505288788;6516.837079073061;6692.464602831762;6728.6635668216395;6734.329790264318;6745.515986482966;6466.902996455057;6472.611643301417;6494.512911531559;6497.675116244169;6549.672516374162;6582.44049255809;6641.33586641332;6677.699503522354;6684.665766711645;6776.28848970851;6333.714982825876;6349.174607301206;6398.4561312287115;6399.680015999088;6409.198850143732;5776.566757493289;6257.843553911189;6278.937210627835;6294.3076261612105;6316.494680425647;6758.155230596176;6766.4248538874745;6783.864322713617;6786.830329241809;6799.5920244785475;4367.362239160315;4394.011347446799;4406.449193850769;4414.117176564636;4428.070105277928;6301.338359472189;6423.743050277936;6429.849373806707;6439.935600643934;6447.742090316335;6189.442950134509;6192;6209.161763161916;6229.937700622936;6232.345603711545;6084.262082063001;6163.96918015407;6199.442050215503;6216.937830621636;6228.532860035425;6067.302260239952;6091.269047714302;6103.755849765959;6119.44924956756;6120.8775824484155;6231.470325022424;6232.977006151922;6246.906296405648;6258.280297765815;6260.62436253808;5835.299764028344;6084.691791264722;6157.476614487819;6160.815175544741;6186.443220110212 16:18:57 INFO - PROCESS | 30416 | |5;yui.html;748.6930358552993;754.992450075499;771.4599780153894;794.8489786940481;802.7712102050915;14064.156150630957;14781.556553303404;14934.925325373386;15015;15030.624234394145;13569.389377478012;13616;13630.863691363083;13652.180869147858;13655.863441365584;678.3318431345122;787.9015123109612;795.4630624328584;817.5871185051541;818.8648872935959;802.6428239433454;811.0794248527905;812.1066826490871;812.354178428151;818.4802650317062;862.5514732339179;863.5336918064238;864.8140649760301;865;868.3487384461654;860.0539406652632;867.9001914779786;868.053821334745;868.0668281597308;869.395769939892;625.7090452939359;629.8645791154923;630.1870586942885;630.2059405149499;633.3603060908515;13119.934400328033;13121.934390327988;13158.539451119164;13200.86799132006;13220.405081771247;14266.714665706628;14349.497767578085;14362.353694083791;14517.274136293248;14534.273286335641;11007.559697612085;11014;11054.502547385388;11202.1598380121;11343;3846.557645870733;3853.3064048471265;3921.9803900980314;4028.637422631948;4033.798310084484;54245.728771356284;54340;55341.169882451795;55668;55743;10660.466976651136;10928.836067458995;10949;11125.499352529156;11326.15053870963;18967.430977070435;19115.23539058422;19138.138783754763;19202;19232;7664.156942736406;7818.687252509836;7843.607819608997;7934.404919630935;8027;4605.125026245069;4654.464736555339;4671.953280467152;4680.7191568506;4733.360996265529;3360.4623260278727;3458.9135271617906;3480.0951752544015;3491.2319289756215;3494.3011397720047;654.8722999015241;660.0660066006546;661.5104822431463;668.5888178770022;674.5244602555285;567.4807551090788;635.9936400636027;640.270092095012;651.1990251990079;661.8279247395616;7625.275598818103;8022.157673444321;8032.959835200787;8092.71675491355;8143.918560814316;611.7338957553478;629.2125882341181;646.5086534233922;664.867026594683;679.6363945289345;3801.353769859131;3935.58676338986;3959.7822119783687;4012.117334186474;4099.651529619956;50441;54458.18312725312;54638.18042729362;54683.726581367635;60595.39404605985;45777.31334029992;46089.30866037012;47483.5251647486;48291.758541207775;50496.242556361685;41430.96422589519;45620.315695264595;45768.54231457643;46596.5340346599;47584.5241547587;8547.110232044068;8721.825563488821;8772.912270877465;8825.117488251124;8955;28672.42655146927;30943.845280773454;31444.371112577162;31523.36953260876;31675.20811979719;37159.81420092882;39517;41989.1602167961;41995.58004419917;42842;12294.815577766161;12396.380180990735;12498.875011249771;12539.373031348214;12785.936070319589;11936.045116390495;12123.757524849278;12503.312317822607;12779.424925878171;14034.2982850855;12901.548445804727;12950.80573791375;13197;13600.319984000958;13666.794998075236;13140.671483212996;13210;13249.470021199044;13496.257705826274;13726.656833578842;12978.935105324414;13023.283719395524;13215.273159975908;13552.25462599527;13911.234882081582;9917.45454000037;10106.140978016656;10406.531706073396;10419.42693151884;10445.68662940113;9875.20998320147;9992.60029598837;10060.547275372772;10083.495825208856;10111.949440253045 16:18:57 INFO - PROCESS | 30416 | __end_tp_report 16:18:57 INFO - PROCESS | 30416 | __start_cc_report 16:18:57 INFO - PROCESS | 30416 | _x_x_mozilla_cycle_collect,333 16:18:57 INFO - PROCESS | 30416 | __end_cc_report 16:18:57 INFO - PROCESS | 30416 | __startTimestamp1460416737486__endTimestamp 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | ------- Summary: start ------- 16:18:57 INFO - PROCESS | 30416 | Number of tests: 6 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#0] dojo.html Cycles:165 Average:5404.75 Median:5627.32 stddev:614.44 (10.9%) stddev-sans-first:590.11 16:18:57 INFO - PROCESS | 30416 | Values: 3141.3 3170.1 3205.3 3219.0 3227.2 5383.4 5383.9 5402.2 5406.8 5466.6 5241.0 5404.7 5501.3 5512.0 5546.8 4872.5 4960.2 4971.6 5129.4 5142.5 5027.2 5051.5 5062.2 5065.2 5074.8 4722.9 4809.3 4892.5 4940.8 5032.2 4888.0 4905.7 4926.0 4927.2 4950.2 4818.5 4867.2 4870.6 4896.0 4928.5 5298.3 5345.7 5352.2 5364.8 5366.2 5696.9 5708.9 5717.2 5724.5 5733.7 5711.1 5776.1 5780.7 5781.0 5842.0 5396.8 5406.6 5421.5 5427.1 5470.6 5914.8 5922.5 5930.6 5930.7 5934.1 5581.4 5665.7 5673.5 5747.9 5765.6 5857.1 5871.0 5874.6 5887.1 5891.2 5627.3 5658.8 5693.0 5742.9 5750.9 5630.5 5733.8 5757.6 5769.8 5784.9 4441.1 4456.1 4465.7 4473.9 4506.4 3940.5 3960.5 3961.5 3975.2 4004.7 5433.3 5576.5 5619.4 5673.7 5679.5 5875.3 5879.4 5890.3 5896.5 5934.1 5692.9 5704.0 5722.3 5725.3 5732.3 4816.8 4927.8 4986.6 4995.0 5009.3 6128.4 6134.0 6149.9 6158.1 6169.6 5813.7 5853.7 5857.4 5874.9 5912.5 5918.7 6120.6 6144.3 6176.6 6204.1 5674.4 5682.6 5686.9 5693.9 5714.2 5738.7 5755.3 5784.1 5794.6 5796.9 5442.3 5541.4 5632.5 5704.8 5728.6 5690.6 5715.3 5753.9 5754.9 5802.4 5522.7 5528.1 5533.3 5538.8 5547.5 5574.3 5738.5 5754.3 5787.8 5822.1 5566.5 5575.8 5577.7 5577.8 5613.7 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#1] ext.html Cycles:180 Average:46979.20 Median:36633.86 stddev:85700.80 (233.9%) stddev-sans-first:85870.51 16:18:57 INFO - PROCESS | 30416 | Values: 611.7 644.0 658.3 668.7 693.7 36639.5 38243.4 38565.0 38661.4 38671.2 38809.0 39094.6 39525.8 39533.0 39614.2 8610.4 8775.1 8787.7 8835.8 8867.3 8769.1 8785.5 8828.7 8843.3 8854.5 8835.5 8884.6 8894.6 8903.2 8909.6 8775.3 8794.6 8854.2 8855.8 8914.7 8779.3 8855.7 8881.4 8882.5 8920.2 32434.4 41188.0 41525.6 41665.6 41766.2 3303.7 3348.5 3508.5 3545.7 3591.4 27349.9 29013.0 29162.0 29555.9 29695.7 4000.8 4138.3 4165.9 4180.0 4218.5 220312.0 220811.0 221868.0 222695.0 223772.0 34663.0 35128.5 35288.3 35310.0 36826.0 34640.7 34882.8 34894.8 34896.3 35013.0 13723.9 13895.3 14012.9 14055.6 14095.4 10894.9 10962.3 10990.3 10993.9 11067.1 8534.4 8611.7 8629.4 8706.7 8717.3 3304.5 3311.9 3367.5 3371.3 3425.9 978.2 1006.4 1044.4 1077.0 1121.7 32381.4 32687.6 32721.8 33061.7 33113.8 1053.6 1058.5 1070.7 1086.6 1176.3 15879.0 15914.3 15918.4 15995.4 16132.4 418577.0 422676.0 426862.0 427487.0 427603.0 56721.1 57495.4 57693.4 57989.4 58131.9 1370.5 1402.7 1410.7 1418.6 1420.7 28934.1 29361.4 29472.6 29631.9 30084.0 45752.3 46577.3 46810.5 47024.3 47108.8 290427.0 291774.0 295090.0 295605.0 297893.0 28264.0 28282.2 28546.1 28687.3 28765.4 46832.3 47636.4 47817.0 48238.5 48266.3 39320.2 39469.6 40290.2 41241.8 41389.8 34767.0 34929.3 35031.8 35436.3 37072.3 41268.6 41599.6 41827.6 42321.2 42413.8 34666.7 36099.7 36628.3 36702.8 36709.6 28036.6 28304.6 28752.4 28851.6 28942.3 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#2] jquery.html Cycles:180 Average:28570.17 Median:2344.19 stddev:83256.74 (3551.6%) stddev-sans-first:83463.41 16:18:57 INFO - PROCESS | 30416 | Values: 390.4 390.5 401.0 402.9 405.4 17698.2 18131.5 18330.5 18349.8 19892.7 16702.0 17096.7 17257.4 18347.8 18385.4 5582.2 5626.1 5831.4 5843.8 5879.7 5691.9 5693.6 5701.1 5706.8 5709.1 5537.7 5612.5 5615.7 5635.6 5674.6 5675.9 5697.3 5701.7 5704.4 5722.3 5010.6 5023.0 5062.3 5111.0 5135.1 21787.0 22089.0 22124.9 22310.3 22338.9 2343.9 2344.4 2354.2 2704.3 2843.9 13460.4 14198.7 14211.4 14388.1 14447.1 1865.9 1934.1 1945.1 1970.9 1992.4 74213.6 75982.6 77770.0 78193.0 79396.0 9998.2 10074.3 10318.6 10956.3 11136.2 14525.1 14765.2 14781.0 14818.8 14820.0 7461.7 7773.2 7883.8 7885.3 7898.9 7507.1 7588.1 7598.7 7617.2 7685.2 6193.3 6277.2 6283.1 6392.9 6412.0 1902.3 1916.4 1927.8 1934.4 1952.9 968.8 984.7 1008.4 1024.4 1056.8 18314.7 18516.0 18858.0 19054.5 19173.4 997.4 998.4 1008.6 1044.3 1067.8 10363.8 10416.9 10725.6 10825.1 10844.4 476877.0 506442.0 512826.9 521081.0 521333.0 76575.6 76955.0 78938.0 80086.0 81103.0 1044.7 1061.1 1066.1 1075.6 1077.6 15847.6 16212.8 16503.8 16706.9 16769.0 34758.3 35549.1 35634.6 35720.6 38419.0 47215.5 49095.8 50059.7 50504.0 50568.7 8165.6 8299.6 8384.6 8580.4 8658.8 12953.5 13132.7 13465.7 13469.6 13650.7 11553.5 11953.4 12190.8 12267.6 12278.1 11586.5 11685.9 11736.8 11762.2 11836.8 10923.7 11320.3 11660.0 11954.6 12303.9 7333.9 7498.0 8036.1 8423.1 8597.7 11058.8 11321.6 11644.4 11686.9 12031.6 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#3] mootools.html Cycles:180 Average:5707.80 Median:6713.16 stddev:2943.22 (43.8%) stddev-sans-first:2934.21 16:18:57 INFO - PROCESS | 30416 | Values: 1467.2 1528.5 1695.8 1798.9 1831.5 7345.9 7967.8 8109.3 8267.9 8280.9 8304.3 8308.9 8352.4 8362.9 8370.5 2353.0 2360.2 2364.1 2372.9 2381.6 2338.1 2358.7 2402.3 2406.7 2408.2 2350.1 2353.0 2365.1 2381.0 2384.4 2292.7 2306.7 2313.7 2313.8 2326.7 2245.9 2258.5 2275.0 2275.5 2293.7 8191.4 8218.7 8224.4 8283.1 8307.7 5001.4 5058.7 5155.7 5163.1 5172.4 3411.4 3454.8 3501.1 3516.3 3526.8 1079.7 1105.6 1115.2 1118.2 1131.8 10634.2 10804.7 10813.2 10817.8 10832.7 4370.9 4438.8 4511.6 4565.5 4687.8 9269.9 9272.0 9287.2 9292.8 9297.0 5208.0 5222.1 5222.4 5225.5 5240.9 4218.6 4559.4 4677.9 4686.5 4838.7 3832.8 3899.7 3962.9 3986.5 3998.3 1280.9 1288.2 1307.7 1331.8 1347.3 1237.6 1242.6 1243.9 1359.0 1379.7 7398.6 7423.9 7424.4 7464.7 7606.6 461.3 463.1 465.7 467.8 490.4 5992.7 6055.2 6068.7 6115.6 6120.9 9493.5 9704.1 9879.9 9904.0 9930.4 9538.1 9803.5 9804.6 9824.1 9839.9 7372.9 7413.5 7432.3 7514.8 7542.4 7459.7 7575.9 7640.0 7793.3 7920.6 8781.5 8881.3 9003.1 9132.3 9272.1 8866.6 9009.6 9022.9 9023.5 9187.0 6665.8 6899.9 7074.5 7284.0 7406.6 7710.8 7785.3 7805.0 7815.9 7854.4 6926.5 7085.6 7163.2 7181.3 7197.2 6957.2 7022.6 7032.3 7043.2 7193.4 7144.5 7308.3 7531.1 7540.4 7560.5 6801.1 6864.9 6882.1 6897.7 6898.0 6760.6 6775.4 6933.1 6952.8 6956.6 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#4] prototype.html Cycles:180 Average:5201.00 Median:5974.57 stddev:1560.43 (26.1%) stddev-sans-first:1521.45 16:18:57 INFO - PROCESS | 30416 | Values: 334.3 335.7 338.2 340.1 348.3 5785.2 5862.7 5884.4 5907.9 5921.6 5791.9 5815.4 5835.2 5846.6 5861.9 4444.5 4496.5 4531.8 4548.5 4550.2 4532.9 4537.3 4538.8 4549.3 4553.1 4497.0 4513.5 4522.2 4531.2 4534.5 4375.5 4422.4 4430.4 4474.4 4531.6 3919.6 3921.1 3929.0 3937.9 3950.9 5549.2 5576.6 5585.7 5600.0 5615.9 5162.6 5216.1 5229.7 5235.7 5250.8 6065.2 6066.5 6081.4 6090.9 6114.1 4369.1 4382.3 4390.9 4403.3 4414.7 5977.4 6161.2 6168.5 6366.5 6422.3 4496.2 4510.7 4514.2 4541.1 4543.9 4590.7 4617.7 4618.5 4619.2 4621.3 4903.9 5098.9 5237.2 5243.4 5258.4 6135.2 6135.5 6172.9 6197.8 6219.1 1531.5 1533.5 1551.9 1557.5 1568.0 978.4 998.4 1008.8 1027.6 1038.4 6029.1 6060.5 6085.8 6086.8 6108.9 6267.8 6318.2 6352.2 6370.3 6380.2 5971.8 6092.7 6113.6 6128.0 6136.4 3389.3 3391.7 3402.4 3406.4 3411.4 6516.8 6692.5 6728.7 6734.3 6745.5 6466.9 6472.6 6494.5 6497.7 6549.7 6582.4 6641.3 6677.7 6684.7 6776.3 6333.7 6349.2 6398.5 6399.7 6409.2 5776.6 6257.8 6278.9 6294.3 6316.5 6758.2 6766.4 6783.9 6786.8 6799.6 4367.4 4394.0 4406.4 4414.1 4428.1 6301.3 6423.7 6429.8 6439.9 6447.7 6189.4 6192.0 6209.2 6229.9 6232.3 6084.3 6164.0 6199.4 6216.9 6228.5 6067.3 6091.3 6103.8 6119.4 6120.9 6231.5 6233.0 6246.9 6258.3 6260.6 5835.3 6084.7 6157.5 6160.8 6186.4 16:18:57 INFO - PROCESS | 30416 | 16:18:57 INFO - PROCESS | 30416 | [#5] yui.html Cycles:180 Average:14015.27 Median:41992.37 stddev:15559.94 (37.1%) stddev-sans-first:15571.69 16:18:57 INFO - PROCESS | 30416 | Values: 748.7 755.0 771.5 794.8 802.8 14064.2 14781.6 14934.9 15015.0 15030.6 13569.4 13616.0 13630.9 13652.2 13655.9 678.3 787.9 795.5 817.6 818.9 802.6 811.1 812.1 812.4 818.5 862.6 863.5 864.8 865.0 868.3 860.1 867.9 868.1 868.1 869.4 625.7 629.9 630.2 630.2 633.4 13119.9 13121.9 13158.5 13200.9 13220.4 14266.7 14349.5 14362.4 14517.3 14534.3 11007.6 11014.0 11054.5 11202.2 11343.0 3846.6 3853.3 3922.0 4028.6 4033.8 54245.7 54340.0 55341.2 55668.0 55743.0 10660.5 10928.8 10949.0 11125.5 11326.2 18967.4 19115.2 19138.1 19202.0 19232.0 7664.2 7818.7 7843.6 7934.4 8027.0 4605.1 4654.5 4672.0 4680.7 4733.4 3360.5 3458.9 3480.1 3491.2 3494.3 654.9 660.1 661.5 668.6 674.5 567.5 636.0 640.3 651.2 661.8 7625.3 8022.2 8033.0 8092.7 8143.9 611.7 629.2 646.5 664.9 679.6 3801.4 3935.6 3959.8 4012.1 4099.7 50441.0 54458.2 54638.2 54683.7 60595.4 45777.3 46089.3 47483.5 48291.8 50496.2 41431.0 45620.3 45768.5 46596.5 47584.5 8547.1 8721.8 8772.9 8825.1 8955.0 28672.4 30943.8 31444.4 31523.4 31675.2 37159.8 39517.0 41989.2 41995.6 42842.0 12294.8 12396.4 12498.9 12539.4 12785.9 11936.0 12123.8 12503.3 12779.4 14034.3 12901.5 12950.8 13197.0 13600.3 13666.8 13140.7 13210.0 13249.5 13496.3 13726.7 12978.9 13023.3 13215.3 13552.3 13911.2 9917.5 10106.1 10406.5 10419.4 10445.7 9875.2 9992.6 10060.5 10083.5 10111.9 16:18:57 INFO - PROCESS | 30416 | -------- Summary: end -------- 16:18:57 INFO - PROCESS | 30416 | 16:18:58 INFO - TEST-INFO | 30416: exit 0 16:18:58 INFO - TEST-OK | dromaeo_css | took 1110090ms 16:18:58 INFO - TEST-START | kraken 16:18:58 INFO - operating with platform_type : linux_ 16:18:58 INFO - Initialising browser for kraken test... 16:18:58 INFO - TEST-INFO | started process 30653 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpERoVcj/profile http://localhost:37665/getInfo.html) 16:19:02 INFO - PROCESS | 30653 | 16:19:02 INFO - PROCESS | 30653 | (process:30721): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:19:02 INFO - PROCESS | 30653 | JavaScript error: jar:file:///builds/slave/test-pgo/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:19:02 INFO - PROCESS | 30653 | __metrics Screen width/height:1600/1200 16:19:02 INFO - PROCESS | 30653 | colorDepth:24 16:19:02 INFO - PROCESS | 30653 | Browser inner width/height: 1024/697 16:19:02 INFO - PROCESS | 30653 | __metrics 16:19:03 ERROR - PROCESS | 30653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:19:04 INFO - TEST-INFO | 30653: exit 0 16:19:04 INFO - Browser initialized. 16:19:04 INFO - Running cycle 1/1 for kraken test... 16:19:04 INFO - TEST-INFO | started process 30772 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpERoVcj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:19:06 INFO - PROCESS | 30772 | 16:19:06 INFO - PROCESS | 30772 | (process:30832): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:19:16 INFO - PROCESS | 30772 | RSS: Main: 163377152 16:19:16 INFO - PROCESS | 30772 | 16:19:18 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:19 INFO - PROCESS | 30772 | RSS: Main: 167960576 16:19:19 INFO - PROCESS | 30772 | 16:19:22 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-dft) 16:19:23 INFO - PROCESS | 30772 | RSS: Main: 171360256 16:19:23 INFO - PROCESS | 30772 | 16:19:25 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-fft) 16:19:26 INFO - PROCESS | 30772 | RSS: Main: 161775616 16:19:26 INFO - PROCESS | 30772 | 16:19:28 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37665/tests/kraken/driver.html?testName=audio-oscillator) 16:19:29 INFO - PROCESS | 30772 | RSS: Main: 162222080 16:19:29 INFO - PROCESS | 30772 | 16:19:31 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:32 INFO - PROCESS | 30772 | RSS: Main: 163729408 16:19:32 INFO - PROCESS | 30772 | 16:19:35 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:35 INFO - PROCESS | 30772 | RSS: Main: 163856384 16:19:35 INFO - PROCESS | 30772 | 16:19:39 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37665/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:39 INFO - PROCESS | 30772 | RSS: Main: 164339712 16:19:39 INFO - PROCESS | 30772 | 16:19:42 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37665/tests/kraken/driver.html?testName=json-parse-financial) 16:19:43 INFO - PROCESS | 30772 | RSS: Main: 166625280 16:19:43 INFO - PROCESS | 30772 | 16:19:44 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:45 INFO - PROCESS | 30772 | RSS: Main: 166256640 16:19:45 INFO - PROCESS | 30772 | 16:19:47 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:47 INFO - PROCESS | 30772 | RSS: Main: 166481920 16:19:47 INFO - PROCESS | 30772 | 16:19:49 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:50 INFO - PROCESS | 30772 | RSS: Main: 166891520 16:19:50 INFO - PROCESS | 30772 | 16:19:53 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:53 INFO - PROCESS | 30772 | RSS: Main: 167067648 16:19:53 INFO - PROCESS | 30772 | 16:19:56 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:57 INFO - PROCESS | 30772 | RSS: Main: 167186432 16:19:57 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | Cycle 1(1): loaded http://localhost:37665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37665/tests/kraken/driver.html?testName=ai-astar) 16:19:59 INFO - PROCESS | 30772 | RSS: Main: 168243200 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | __start_tp_report 16:19:59 INFO - PROCESS | 30772 | _x_x_mozilla_page_load 16:19:59 INFO - PROCESS | 30772 | _x_x_mozilla_page_load_details 16:19:59 INFO - PROCESS | 30772 | |i|pagename|runs| 16:19:59 INFO - PROCESS | 30772 | |0;ai-astar;112;106;112;112;112;125;111;112;113;112 16:19:59 INFO - PROCESS | 30772 | |1;audio-beat-detection;157;137;151;188;130;155;160;129;185;128 16:19:59 INFO - PROCESS | 30772 | |2;audio-dft;162;162;166;162;162;164;175;162;165;163 16:19:59 INFO - PROCESS | 30772 | |3;audio-fft;77;76;72;153;77;73;73;75;163;73 16:19:59 INFO - PROCESS | 30772 | |4;audio-oscillator;94;93;154;95;92;93;161;94;94;147 16:19:59 INFO - PROCESS | 30772 | |5;imaging-gaussian-blur;117;117;117;118;118;117;117;117;117;118 16:19:59 INFO - PROCESS | 30772 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;147;147 16:19:59 INFO - PROCESS | 30772 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;96;95 16:19:59 INFO - PROCESS | 30772 | |8;json-parse-financial;57;58;59;59;60;62;60;75;56;60 16:19:59 INFO - PROCESS | 30772 | |9;json-stringify-tinderbox;64;64;64;64;64;63;64;63;63;64 16:19:59 INFO - PROCESS | 30772 | |10;stanford-crypto-aes;81;88;81;80;81;82;83;81;83;82 16:19:59 INFO - PROCESS | 30772 | |11;stanford-crypto-ccm;132;133;144;141;136;130;140;143;187;134 16:19:59 INFO - PROCESS | 30772 | |12;stanford-crypto-pbkdf2;172;167;179;167;164;166;180;167;165;161 16:19:59 INFO - PROCESS | 30772 | |13;stanford-crypto-sha256-iterative;68;80;77;70;71;69;69;70;73;69 16:19:59 INFO - PROCESS | 30772 | __end_tp_report 16:19:59 INFO - PROCESS | 30772 | __start_cc_report 16:19:59 INFO - PROCESS | 30772 | _x_x_mozilla_cycle_collect,879 16:19:59 INFO - PROCESS | 30772 | __end_cc_report 16:19:59 INFO - PROCESS | 30772 | __startTimestamp1460416799305__endTimestamp 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | ------- Summary: start ------- 16:19:59 INFO - PROCESS | 30772 | Number of tests: 14 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#0] ai-astar Cycles:10 Average:112.70 Median:112.00 stddev:4.74 (4.2%) stddev-sans-first:5.02 16:19:59 INFO - PROCESS | 30772 | Values: 112.0 106.0 112.0 112.0 112.0 125.0 111.0 112.0 113.0 112.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:156.00 stddev:21.85 (14.0%) stddev-sans-first:23.10 16:19:59 INFO - PROCESS | 30772 | Values: 157.0 137.0 151.0 188.0 130.0 155.0 160.0 129.0 185.0 128.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:4.03 (2.5%) stddev-sans-first:4.19 16:19:59 INFO - PROCESS | 30772 | Values: 162.0 162.0 166.0 162.0 162.0 164.0 175.0 162.0 165.0 163.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:35.33 (47.7%) stddev-sans-first:37.10 16:19:59 INFO - PROCESS | 30772 | Values: 77.0 76.0 72.0 153.0 77.0 73.0 73.0 75.0 163.0 73.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#4] audio-oscillator Cycles:10 Average:111.70 Median:93.50 stddev:29.39 (31.4%) stddev-sans-first:30.46 16:19:59 INFO - PROCESS | 30772 | Values: 94.0 93.0 154.0 95.0 92.0 93.0 161.0 94.0 94.0 147.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:19:59 INFO - PROCESS | 30772 | Values: 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:19:59 INFO - PROCESS | 30772 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:19:59 INFO - PROCESS | 30772 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:5.34 (8.9%) stddev-sans-first:5.50 16:19:59 INFO - PROCESS | 30772 | Values: 57.0 58.0 59.0 59.0 60.0 62.0 60.0 75.0 56.0 60.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 16:19:59 INFO - PROCESS | 30772 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 64.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.25 (2.7%) stddev-sans-first:2.35 16:19:59 INFO - PROCESS | 30772 | Values: 81.0 88.0 81.0 80.0 81.0 82.0 83.0 81.0 83.0 82.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.50 stddev:16.53 (11.8%) stddev-sans-first:17.14 16:19:59 INFO - PROCESS | 30772 | Values: 132.0 133.0 144.0 141.0 136.0 130.0 140.0 143.0 187.0 134.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:167.00 stddev:6.29 (3.8%) stddev-sans-first:6.56 16:19:59 INFO - PROCESS | 30772 | Values: 172.0 167.0 179.0 167.0 164.0 166.0 180.0 167.0 165.0 161.0 16:19:59 INFO - PROCESS | 30772 | 16:19:59 INFO - PROCESS | 30772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:70.50 stddev:3.95 (5.6%) stddev-sans-first:3.97 16:19:59 INFO - PROCESS | 30772 | Values: 68.0 80.0 77.0 70.0 71.0 69.0 69.0 70.0 73.0 69.0 16:19:59 INFO - PROCESS | 30772 | -------- Summary: end -------- 16:19:59 INFO - PROCESS | 30772 | 16:20:00 INFO - TEST-INFO | 30772: exit 0 16:20:00 INFO - TEST-OK | kraken | took 62109ms 16:20:00 INFO - SUITE-END | took 1172s 16:20:00 INFO - Completed test suite (00:19:32) 16:20:00 INFO - javascript benchmark 16:20:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3141.2932090279687, 3170.1123685368098, 3205.2627895584, 3219.0181994491686, 3227.1770698471887, 5383.353997520298, 5383.9461605383985, 5402.243685883969, 5406.783728650854, 5466.644668096581, 5240.973795131029, 5404.675719456835, 5501.312335958005, 5512.0, 5546.805861794838, 4872.488388719186, 4960.181570040939, 4971.602271818246, 5129.410117836459, 5142.460041695625, 5027.245913113025, 5051.520105589963, 5062.164742817431, 5065.1642478990925, 5074.822381216658, 4722.881927951811, 4809.326694262789, 4892.535209155125, 4940.802367905279, 5032.245163225527, 4887.975560122212, 4905.730184839832, 4925.950740492621, 4927.1870141426625, 4950.207966725343, 4818.494058123917, 4867.221244600847, 4870.6347023972985, 4896.0, 4928.482509336504, 5298.258243845865, 5345.705986170759, 5352.170413585901, 5364.812231571916, 5366.248725178478, 5696.914546281809, 5708.942910570882, 5717.199592057115, 5724.4561766632105, 5733.713314334266, 5711.05767548354, 5776.133579962997, 5780.739866706008, 5781.046127388976, 5842.006858834008, 5396.811111611075, 5406.567474602022, 5421.484958928895, 5427.050266203438, 5470.589705772043, 5914.763409463573, 5922.49658779, 5930.644161350333, 5930.673812940244, 5934.13954976526, 5581.386047534768, 5665.66006039639, 5673.489385955284, 5747.942520574825, 5765.625234359753, 5857.121431785266, 5870.970645146747, 5874.618149820248, 5887.087501437284, 5891.175235467038, 5627.324721033502, 5658.801941932013, 5693.0, 5742.885142297131, 5750.856228594319, 5630.465105814941, 5733.799317023884, 5757.625754325955, 5769.798057068067, 5784.942150578525, 4441.111777644484, 4456.108778244364, 4465.732056076646, 4473.910521789611, 4506.436695413074, 3940.5074365704286, 3960.544537378181, 3961.504811898513, 3975.204959008152, 4004.739691920016, 5433.266509021231, 5576.525995290446, 5619.4099619540175, 5673.687947162945, 5679.5172410345585, 5875.324337701134, 5879.441453061952, 5890.263717035371, 5896.469317761336, 5934.109883517421, 5692.8861422771315, 5704.0, 5722.341930677942, 5725.341585717612, 5732.3407808101765, 4816.783244753994, 4927.802887884444, 4986.551210391082, 4995.0, 5009.323741294878, 6128.3672827644, 6133.977404287557, 6149.877002459926, 6158.107074474266, 6169.598976066542, 5813.709314534341, 5853.678047707417, 5857.384974577608, 5874.882502350015, 5912.46787789101, 5918.733656985532, 6120.599512025131, 6144.293406258159, 6176.567640265318, 6204.069389591416, 5674.432556744293, 5682.6306290091015, 5686.943130568641, 5693.9430605693415, 5714.228579141763, 5738.655680659173, 5755.251817263729, 5784.074548072288, 5794.62334948227, 5796.884062318814, 5442.3469183696625, 5541.3904470509015, 5632.5493960482245, 5704.771809127588, 5728.627639203439, 5690.630109042899, 5715.2855893013375, 5753.942460575341, 5754.884902302014, 5802.361740208489, 5522.696251706195, 5528.115501519737, 5533.253010843485, 5538.750756216061, 5547.5007249347755, 5574.275344205227, 5738.540916726735, 5754.2519472469985, 5787.826365209051, 5822.0684690449325, 5566.4990150886615, 5575.832725018094, 5577.749001295033, 5577.776888924398, 5613.663180209201], "value": 5363.683816050941, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [611.6513587255266, 643.9935600643995, 658.3383699382122, 668.6790340636494, 693.6705065094084, 36639.450408243894, 38243.42634860476, 38565.0, 38661.420078698844, 38671.22657546854, 38809.0, 39094.60905390945, 39525.8023709881, 39533.0, 39614.20771584567, 8610.397272190949, 8775.122487751238, 8787.692430764924, 8835.77910552235, 8867.290616750644, 8769.079246679103, 8785.516796576187, 8828.73513794584, 8843.29253659709, 8854.468731876075, 8835.46987180768, 8884.555772211395, 8894.644214231423, 8903.154200350957, 8909.599068041955, 8775.297976161892, 8794.592865141547, 8854.247388971946, 8855.778605534848, 8914.687985920495, 8779.253763430052, 8855.73432797017, 8881.378303518757, 8882.511461869595, 8920.197182253629, 32434.35131297361, 41188.0, 41525.584744152475, 41665.58334416678, 41766.1646767066, 3303.702666760003, 3348.5479460272795, 3508.5088087667746, 3545.7340699447386, 3591.425371940477, 27349.86325068382, 29013.0, 29162.0, 29555.852220738972, 29695.70304296951, 4000.819963101638, 4138.275801734714, 4165.91668166638, 4180.0, 4218.451601291843, 220312.0, 220811.0, 221868.0, 222695.0, 223772.0, 34663.0, 35128.47307290393, 35288.29423411517, 35310.0, 36826.0, 34640.653593464245, 34882.825585871906, 34894.825525872206, 34896.30207395838, 35013.0, 13723.862761372458, 13895.305234738222, 14012.929935350257, 14055.648608784863, 14095.436182552583, 10894.945525272324, 10962.287451315638, 10990.285631433931, 10993.890061099446, 11067.114630829514, 8534.359923005799, 8611.65553377858, 8629.43908645936, 8706.650469177288, 8717.259032982267, 3304.5373647689344, 3311.8840840570947, 3367.461206206995, 3371.292028674006, 3425.880094196691, 978.1832170137873, 1006.4313662780505, 1044.3656473326362, 1076.9730756730987, 1121.6635009497118, 32381.35237295241, 32687.5562382863, 32721.836390817894, 33061.66938330634, 33113.834430828174, 1053.5680371047833, 1058.4601853054996, 1070.71626019105, 1086.5979587552656, 1176.276589897224, 15879.039667638837, 15914.283857226452, 15918.442854500268, 15995.440159594358, 16132.354705811871, 418577.0, 422676.0, 426862.0, 427487.0, 427603.0, 56721.14918276229, 57495.42504574984, 57693.423065769646, 57989.42010579925, 58131.93076484605, 1370.5408688089403, 1402.6703724624908, 1410.7178564287183, 1418.6169734171715, 1420.6945506716106, 28934.131976040753, 29361.412771744872, 29472.55791163177, 29631.85184074066, 30084.0, 45752.31371529363, 46577.3013404806, 46810.531894680615, 47024.29463557981, 47108.7644561775, 290427.0, 291774.0, 295090.0, 295605.0, 297893.0, 28264.0, 28282.15153545397, 28546.143615691562, 28687.282817929718, 28765.424691505636, 46832.297515537975, 47636.414226232584, 47817.0, 48238.51761482481, 48266.27600585924, 39320.2135957285, 39469.60530394774, 40290.1941961165, 41241.793791030854, 41389.793051034554, 34767.0, 34929.30141397107, 35031.82484087563, 35436.291274173855, 37072.258554828215, 41268.587314126475, 41599.58400415957, 41827.58172418237, 42321.153576927674, 42413.78793106015, 34666.65333346735, 36099.694882921765, 36628.267434650625, 36702.8164859174, 36709.63290367169, 28036.579451308655, 28304.575431368135, 28752.42495150127, 28851.5672264912, 28942.276443089093], "value": 17638.679838596003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.44946625258393, 390.451415760856, 401.0, 402.9053172504463, 405.44858991771196, 17698.20358083886, 18131.456056318333, 18330.450086497392, 18349.81650183498, 19892.70160947587, 16702.0, 17096.658066838656, 17257.39599114031, 18347.81652183478, 18385.448436546892, 5582.218489411496, 5626.071698169818, 5831.387704291052, 5843.824685259449, 5879.735411906453, 5691.943080569183, 5693.601447898649, 5701.14482827575, 5706.800261990831, 5709.0580054290995, 5537.667739935597, 5612.522935550483, 5615.7472913718775, 5635.63368381056, 5674.552988987803, 5675.914861277084, 5697.344805347397, 5701.657900525982, 5704.372519022904, 5722.341930677963, 5010.599152067826, 5022.974885125587, 5062.31658726071, 5110.9744451277875, 5135.101357262464, 21787.0, 22089.0, 22124.88937555302, 22310.330690079325, 22338.888305558532, 2343.94140146496, 2344.4373350395954, 2354.21133920137, 2704.269847141261, 2843.900463483789, 13460.394282257323, 14198.716025679429, 14211.36048877803, 14388.06477578954, 14447.133172009713, 1865.9346922857635, 1934.1006432009183, 1945.105251584273, 1970.8620396572246, 1992.3724026931616, 74213.62893185554, 75982.62008689977, 77770.0, 78193.0, 79396.0, 9998.200143988464, 10074.345167564084, 10318.587256509656, 10956.28784129029, 11136.164787640959, 14525.128492290496, 14765.187914664797, 14781.039232450072, 14818.777718334233, 14820.0, 7461.738839140604, 7773.183815699384, 7883.802904927423, 7885.329746971457, 7898.921010789819, 7507.099148102263, 7588.127365353055, 7598.658060387185, 7617.238276172338, 7685.231476852382, 6193.256809182837, 6277.24673039229, 6283.088952102011, 6392.872142557123, 6412.0, 1902.267626963629, 1916.3963351544219, 1927.8264956154014, 1934.3616606520095, 1952.8925909074853, 968.7917097824002, 984.6799790068256, 1008.3596915958273, 1024.4365598920565, 1056.8203405421098, 18314.725279120823, 18516.0, 18858.0, 19054.523636909187, 19173.424797256106, 997.436448406648, 998.3710262534556, 1008.5965613754557, 1044.3107549017611, 1067.8024565455416, 10363.844542331872, 10416.895831041744, 10725.570977160982, 10825.07986821129, 10844.373343998463, 476877.0, 506442.0, 512826.87173128536, 521081.0, 521333.0, 76575.61712191404, 76955.0, 78938.0, 80086.0, 81103.0, 1044.7179261599479, 1061.0556604621893, 1066.0938202527789, 1075.5697720911542, 1077.6443773554709, 15847.603809904844, 16212.837871621605, 16503.752443713114, 16706.916465417595, 16769.0, 34758.30483390368, 35549.111272218404, 35634.64365356313, 35720.64279357277, 38419.0, 47215.52784472111, 49095.754521227165, 50059.74970125126, 50504.0, 50568.747156263984, 8165.591720413837, 8299.585020748818, 8384.622691978997, 8580.399372044147, 8658.783530411538, 12953.54662586805, 13132.671683207614, 13465.730685386434, 13469.595912122651, 13650.726985460435, 11553.537858485566, 11953.402329883296, 12190.75618487643, 12267.570635028089, 12278.140530162802, 11586.536538538365, 11685.883141168479, 11736.823947640622, 11762.235454695418, 11836.76326473483, 10923.726906827074, 11320.320780753182, 11660.0, 11954.58158964432, 12303.93848030754, 7333.853322933618, 7497.962510187414, 8036.1160272368825, 8423.11557286476, 8597.699080532402, 11058.778824423305, 11321.603743869255, 11644.35956022427, 11686.94156529212, 12031.63905082849], "value": 9141.88412260898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.1857119298788, 1528.487956534561, 1695.7965044194698, 1798.8740788144835, 1831.5146486181172, 7345.88981165283, 7967.76096717098, 8109.310708589777, 8267.917320826797, 8280.917190828097, 8304.294134998518, 8308.875366869503, 8352.415330926837, 8362.874556881652, 8370.53962032088, 2352.9764702352973, 2360.173939121311, 2364.0661938534267, 2372.8694921779297, 2381.57131716291, 2338.053088499152, 2358.6933698619155, 2402.315340128064, 2406.6750988616486, 2408.2414039577566, 2350.0717216699395, 2352.9529409411803, 2365.06579900939, 2381.0356805493802, 2384.380061184096, 2292.7248730152323, 2306.6885970394032, 2313.6645186447954, 2313.7686231376897, 2326.6975293211945, 2245.932622021342, 2258.4579700871836, 2274.9886250568807, 2275.5107651854764, 2293.690351802502, 8191.385646076568, 8218.671253149867, 8224.38317126218, 8283.130271321485, 8307.667693292262, 5001.374828146481, 5058.696478211319, 5155.690658560461, 5163.122269214243, 5172.379314482248, 3411.3688967541084, 3454.827258637058, 3501.1072176594807, 3516.3494753470436, 3526.7531272810916, 1079.6545105566222, 1105.6019832860163, 1115.1970581181536, 1118.1669656106253, 1131.7736452709491, 10634.202434817342, 10804.675859724142, 10813.18901082414, 10817.83773243402, 10832.729181770519, 4370.868873933787, 4438.755868427203, 4511.571400716926, 4565.520620334817, 4687.789049492712, 9269.860952085724, 9271.953640231755, 9287.210587100171, 9292.814143717223, 9297.0, 5208.0, 5222.060029194781, 5222.4255331913455, 5225.484609463213, 5240.868978275497, 4218.599233072914, 4559.38448309474, 4677.906441871143, 4686.507916668701, 4838.661293709477, 3832.770033797981, 3899.66852817508, 3962.88111356654, 3986.4817573715814, 3998.3402738547816, 1280.8719128087303, 1288.1820044271956, 1307.7057662025968, 1331.8401791785047, 1347.3061373392711, 1237.566851601932, 1242.6023672424917, 1243.8631750507436, 1358.959231223065, 1379.7102608452137, 7398.593077380796, 7423.888641670379, 7424.368928641018, 7464.70141194357, 7606.619669016527, 461.3241601054471, 463.10158292911643, 465.68798904733234, 467.82690404550533, 490.4090570862103, 5992.700364981821, 6055.2430946131735, 6068.696565171724, 6115.633062016204, 6120.908186377208, 9493.477858717837, 9704.126628603459, 9879.901200988043, 9904.0, 9930.354526955725, 9538.141567258841, 9803.509824508747, 9804.558794854249, 9824.115829575372, 9839.852402213972, 7372.852542949111, 7413.481056326005, 7432.331090201799, 7514.774556763196, 7542.358899493494, 7459.738909138154, 7575.924240757742, 7639.961800190964, 7793.337566306701, 7920.564368959763, 8781.473111613068, 8881.289496840367, 9003.054679258583, 9132.269418446376, 9272.072792720674, 8866.556672166495, 9009.594568244576, 9022.864657030019, 9023.458592484472, 9187.0, 6665.766698165541, 6899.930510770839, 7074.504784665024, 7283.963580182065, 7406.629668516661, 7710.845783084419, 7785.260400261966, 7805.024371953506, 7815.921840781747, 7854.410919181199, 6926.515143939876, 7085.645717713991, 7163.176234733072, 7181.317774811385, 7197.172325182671, 6957.199922009034, 7022.648867556704, 7032.331928466788, 7043.154821421463, 7193.388561972291, 7144.535605185646, 7308.269173082649, 7531.058617672791, 7540.359069479156, 7560.546367217985, 6801.115854939024, 6864.862702745817, 6882.070920425878, 6897.7240910363025, 6897.965510172417, 6760.560563563353, 6775.424088952297, 6933.0986971693355, 6952.791416257521, 6956.582605043714], "value": 4619.2080447590215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.3463528801193, 335.6509230400384, 338.20521773831484, 340.12757277583, 348.26342286064965, 5785.2189954356145, 5862.677552734598, 5884.382139875315, 5907.88184236315, 5921.615095018821, 5791.942080579193, 5815.447532484418, 5835.153902684108, 5846.590738648296, 5861.912071318934, 4444.4888837783665, 4496.460424749034, 4531.773411329436, 4548.5224051474615, 4550.180967425878, 4532.9093418131615, 4537.342085397615, 4538.7503687297185, 4549.340345649879, 4553.134904368159, 4496.955030449686, 4513.50351461339, 4522.186006518826, 4531.184386810372, 4534.478534968472, 4375.540568240337, 4422.447194100753, 4430.446194225722, 4474.351219073216, 4531.62089902802, 3919.627635374635, 3921.0981474260793, 3929.0, 3937.9409308860104, 3950.940735888964, 5549.223108764776, 5576.553875689935, 5585.748641311151, 5600.019996500637, 5615.887682246333, 5162.638615296931, 5216.087184742692, 5229.660072095339, 5235.712035838027, 5250.789968401259, 6065.181200537915, 6066.514678825683, 6081.361457046991, 6090.908636370458, 6114.144019837182, 4369.082492676542, 4382.342648602735, 4390.868273951786, 4403.3174857897075, 4414.668899832525, 5977.3723759005115, 6161.151654503676, 6168.537359698041, 6366.458850997625, 6422.293547709748, 4496.19068567661, 4510.661700372485, 4514.210013247669, 4541.069080838486, 4543.886402839889, 4590.701604395704, 4617.653675974316, 4618.538146185355, 4619.23782575878, 4621.3068039793625, 4903.901921961541, 5098.872528186825, 5237.16205407133, 5243.449437809051, 5258.421573626898, 6135.202423684982, 6135.478484328882, 6172.8765424691255, 6197.81406557804, 6219.067139929047, 1531.5022617649086, 1533.5246073717183, 1551.9379224831107, 1557.5015994881755, 1567.968640627204, 978.4227305889559, 998.3560603410759, 1008.8083264179929, 1027.5786927359748, 1038.3977293169944, 6029.095635654687, 6060.454559089703, 6085.8478538036015, 6086.756529738761, 6108.938910610926, 6267.811965641038, 6318.210223722035, 6352.174217351807, 6370.299267080617, 6380.234371875312, 5971.761129554856, 6092.6543280837195, 6113.633182009094, 6127.969360153171, 6136.355682653257, 3389.322135572895, 3391.6608339165887, 3402.3705614461405, 3406.3527929693278, 3411.3859505288788, 6516.837079073061, 6692.464602831762, 6728.6635668216395, 6734.329790264318, 6745.515986482966, 6466.902996455057, 6472.611643301417, 6494.512911531559, 6497.675116244169, 6549.672516374162, 6582.44049255809, 6641.33586641332, 6677.699503522354, 6684.665766711645, 6776.28848970851, 6333.714982825876, 6349.174607301206, 6398.4561312287115, 6399.680015999088, 6409.198850143732, 5776.566757493289, 6257.843553911189, 6278.937210627835, 6294.3076261612105, 6316.494680425647, 6758.155230596176, 6766.4248538874745, 6783.864322713617, 6786.830329241809, 6799.5920244785475, 4367.362239160315, 4394.011347446799, 4406.449193850769, 4414.117176564636, 4428.070105277928, 6301.338359472189, 6423.743050277936, 6429.849373806707, 6439.935600643934, 6447.742090316335, 6189.442950134509, 6192.0, 6209.161763161916, 6229.937700622936, 6232.345603711545, 6084.262082063001, 6163.96918015407, 6199.442050215503, 6216.937830621636, 6228.532860035425, 6067.302260239952, 6091.269047714302, 6103.755849765959, 6119.44924956756, 6120.8775824484155, 6231.470325022424, 6232.977006151922, 6246.906296405648, 6258.280297765815, 6260.62436253808, 5835.299764028344, 6084.691791264722, 6157.476614487819, 6160.815175544741, 6186.443220110212], "value": 4691.497720002175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.6930358552993, 754.992450075499, 771.4599780153894, 794.8489786940481, 802.7712102050915, 14064.156150630957, 14781.556553303404, 14934.925325373386, 15015.0, 15030.624234394145, 13569.389377478012, 13616.0, 13630.863691363083, 13652.180869147858, 13655.863441365584, 678.3318431345122, 787.9015123109612, 795.4630624328584, 817.5871185051541, 818.8648872935959, 802.6428239433454, 811.0794248527905, 812.1066826490871, 812.354178428151, 818.4802650317062, 862.5514732339179, 863.5336918064238, 864.8140649760301, 865.0, 868.3487384461654, 860.0539406652632, 867.9001914779786, 868.053821334745, 868.0668281597308, 869.395769939892, 625.7090452939359, 629.8645791154923, 630.1870586942885, 630.2059405149499, 633.3603060908515, 13119.934400328033, 13121.934390327988, 13158.539451119164, 13200.86799132006, 13220.405081771247, 14266.714665706628, 14349.497767578085, 14362.353694083791, 14517.274136293248, 14534.273286335641, 11007.559697612085, 11014.0, 11054.502547385388, 11202.1598380121, 11343.0, 3846.557645870733, 3853.3064048471265, 3921.9803900980314, 4028.637422631948, 4033.798310084484, 54245.728771356284, 54340.0, 55341.169882451795, 55668.0, 55743.0, 10660.466976651136, 10928.836067458995, 10949.0, 11125.499352529156, 11326.15053870963, 18967.430977070435, 19115.23539058422, 19138.138783754763, 19202.0, 19232.0, 7664.156942736406, 7818.687252509836, 7843.607819608997, 7934.404919630935, 8027.0, 4605.125026245069, 4654.464736555339, 4671.953280467152, 4680.7191568506, 4733.360996265529, 3360.4623260278727, 3458.9135271617906, 3480.0951752544015, 3491.2319289756215, 3494.3011397720047, 654.8722999015241, 660.0660066006546, 661.5104822431463, 668.5888178770022, 674.5244602555285, 567.4807551090788, 635.9936400636027, 640.270092095012, 651.1990251990079, 661.8279247395616, 7625.275598818103, 8022.157673444321, 8032.959835200787, 8092.71675491355, 8143.918560814316, 611.7338957553478, 629.2125882341181, 646.5086534233922, 664.867026594683, 679.6363945289345, 3801.353769859131, 3935.58676338986, 3959.7822119783687, 4012.117334186474, 4099.651529619956, 50441.0, 54458.18312725312, 54638.18042729362, 54683.726581367635, 60595.39404605985, 45777.31334029992, 46089.30866037012, 47483.5251647486, 48291.758541207775, 50496.242556361685, 41430.96422589519, 45620.315695264595, 45768.54231457643, 46596.5340346599, 47584.5241547587, 8547.110232044068, 8721.825563488821, 8772.912270877465, 8825.117488251124, 8955.0, 28672.42655146927, 30943.845280773454, 31444.371112577162, 31523.36953260876, 31675.20811979719, 37159.81420092882, 39517.0, 41989.1602167961, 41995.58004419917, 42842.0, 12294.815577766161, 12396.380180990735, 12498.875011249771, 12539.373031348214, 12785.936070319589, 11936.045116390495, 12123.757524849278, 12503.312317822607, 12779.424925878171, 14034.2982850855, 12901.548445804727, 12950.80573791375, 13197.0, 13600.319984000958, 13666.794998075236, 13140.671483212996, 13210.0, 13249.470021199044, 13496.257705826274, 13726.656833578842, 12978.935105324414, 13023.283719395524, 13215.273159975908, 13552.25462599527, 13911.234882081582, 9917.45454000037, 10106.140978016656, 10406.531706073396, 10419.42693151884, 10445.68662940113, 9875.20998320147, 9992.60029598837, 10060.547275372772, 10083.495825208856, 10111.949440253045], "value": 6553.796190618828, "unit": "score"}], "name": "dromaeo_css", "value": 7050.645530716198, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 112.0, 112.0, 125.0, 111.0, 112.0, 113.0, 112.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 137.0, 151.0, 188.0, 130.0, 155.0, 160.0, 129.0, 185.0, 128.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 162.0, 162.0, 164.0, 175.0, 162.0, 165.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 72.0, 153.0, 77.0, 73.0, 73.0, 75.0, 163.0, 73.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 154.0, 95.0, 92.0, 93.0, 161.0, 94.0, 94.0, 147.0], "value": 111.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 59.0, 60.0, 62.0, 60.0, 75.0, 56.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 81.0, 80.0, 81.0, 82.0, 83.0, 81.0, 83.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 144.0, 141.0, 136.0, 130.0, 140.0, 143.0, 187.0, 134.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 179.0, 167.0, 164.0, 166.0, 180.0, 167.0, 165.0, 161.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 80.0, 77.0, 70.0, 71.0, 69.0, 69.0, 70.0, 73.0, 69.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1580.3, "alertThreshold": 2.0}]} 16:20:00 INFO - Return code: 0 16:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:20:00 ERROR - # TBPL SUCCESS # 16:20:00 INFO - Running post-action listener: _resource_record_post_action 16:20:00 INFO - Running post-run listener: _resource_record_post_run 16:20:01 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536113152; Read time: 12; Write time: 934444 16:20:01 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 250343424; Read time: 0; Write time: 669456 16:20:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285769728; Read time: 12; Write time: 264988 16:20:01 INFO - Running post-run listener: _upload_blobber_files 16:20:01 INFO - Blob upload gear active. 16:20:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:20:01 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:20:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:20:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:20:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:02 INFO - (blobuploader) - INFO - Done attempting. 16:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:03 INFO - (blobuploader) - INFO - Done attempting. 16:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:03 INFO - Return code: 0 16:20:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25bba10208a3d1eed03ae9a1ff015fe610d46f5868ad4fff543eb127b9eedeac38f0da43b9f9357b1107bc111c1a51f30e16483df92bcaf01f185f439fd643d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d68fa280a01363af37f9f3c182cf26bf9933aea6f4c6ec5dd5e323a58bf587db8383d8cb79a9d8dd7ebf5b06377e352f9f142b5181548946216b9b72d1998a81"} 16:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:20:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:20:03 INFO - Contents: 16:20:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25bba10208a3d1eed03ae9a1ff015fe610d46f5868ad4fff543eb127b9eedeac38f0da43b9f9357b1107bc111c1a51f30e16483df92bcaf01f185f439fd643d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d68fa280a01363af37f9f3c182cf26bf9933aea6f4c6ec5dd5e323a58bf587db8383d8cb79a9d8dd7ebf5b06377e352f9f142b5181548946216b9b72d1998a81"} 16:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:03 INFO - Copying logs to upload dir... 16:20:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.766898 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-04-11 16:20:03.635943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 16:20:03.639391) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25bba10208a3d1eed03ae9a1ff015fe610d46f5868ad4fff543eb127b9eedeac38f0da43b9f9357b1107bc111c1a51f30e16483df92bcaf01f185f439fd643d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d68fa280a01363af37f9f3c182cf26bf9933aea6f4c6ec5dd5e323a58bf587db8383d8cb79a9d8dd7ebf5b06377e352f9f142b5181548946216b9b72d1998a81"} build_url:https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/Ua2hGlb9TyqEzmH07eeH6A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/25bba10208a3d1eed03ae9a1ff015fe610d46f5868ad4fff543eb127b9eedeac38f0da43b9f9357b1107bc111c1a51f30e16483df92bcaf01f185f439fd643d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d68fa280a01363af37f9f3c182cf26bf9933aea6f4c6ec5dd5e323a58bf587db8383d8cb79a9d8dd7ebf5b06377e352f9f142b5181548946216b9b72d1998a81"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 16:20:03.663933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 16:20:03.664232) ========= 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=aa52b8aba932b19cc50b5275000001de-1460415540.270209-1977492136 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 16:20:03.747710) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 16:20:03.748260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 16:20:03.748711) ========= ========= Total master_lag: 0.27 =========