builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1459129991.5 results: success (0) buildid: 20160327163001 builduid: 0162a7b6902e455c85590799618a5f96 revision: db4111c66699e246fd9fdf7d562526297a11c7df ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.501763) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.502355) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.502649) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006430 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.558039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.558322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.590258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.590527) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.639076) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.639374) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.639730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.639996) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-27 18:53: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% 42.5M=0s 2016-03-27 18:53:13 (42.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.807833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.808137) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018244 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.860004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:11.860306) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev db4111c66699e246fd9fdf7d562526297a11c7df --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 db4111c66699e246fd9fdf7d562526297a11c7df --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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-27 18:53:14,084 truncating revision to first 12 chars 2016-03-27 18:53:14,084 Setting DEBUG logging. 2016-03-27 18:53:14,084 attempt 1/10 2016-03-27 18:53:14,084 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/db4111c66699?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-27 18:53:14,395 unpacking tar archive at: mozilla-inbound-db4111c66699/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878858 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.752035) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.752369) ========= echo db4111c66699e246fd9fdf7d562526297a11c7df in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'db4111c66699e246fd9fdf7d562526297a11c7df'] 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False db4111c66699e246fd9fdf7d562526297a11c7df program finished with exit code 0 elapsedTime=0.004119 script_repo_revision: 'db4111c66699e246fd9fdf7d562526297a11c7df' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.802244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.802553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-27 18:53:12.812859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-27 18:53:12.813257) ========= /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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:15 INFO - MultiFileLogger online at 20160327 18:53:15 in /builds/slave/test-pgo 18:53: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 18:53:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:53:15 INFO - {'append_to_log': False, 18:53:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:53:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:53:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:53:15 INFO - 'branch': 'Mozilla-Inbound', 18:53:15 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:15 INFO - 'config_files': ('talos/linux_config.py',), 18:53:15 INFO - 'default_actions': ('clobber', 18:53:15 INFO - 'read-buildbot-config', 18:53:15 INFO - 'download-and-extract', 18:53:15 INFO - 'populate-webroot', 18:53:15 INFO - 'create-virtualenv', 18:53:15 INFO - 'install', 18:53:15 INFO - 'run-tests'), 18:53:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:15 INFO - 'download_minidump_stackwalk': True, 18:53:15 INFO - 'download_symbols': 'ondemand', 18:53:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:15 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:15 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:15 INFO - 'installer_path': 'installer.exe', 18:53:15 INFO - 'log_level': 'info', 18:53:15 INFO - 'log_name': 'talos', 18:53:15 INFO - 'log_to_console': True, 18:53:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:15 INFO - 'opt_config_files': (), 18:53:15 INFO - 'pip_index': False, 18:53:15 INFO - 'sps_profile': False, 18:53:15 INFO - 'sps_profile_interval': 0, 18:53:15 INFO - 'suite': 'dromaeojs-e10s', 18:53:15 INFO - 'system_bits': '32', 18:53:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:15 INFO - 'title': 'talos-linux64-ix-042', 18:53:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:15 INFO - 'use_talos_json': True, 18:53:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:53:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:15 INFO - 'work_dir': 'build'} 18:53:15 INFO - ##### 18:53:15 INFO - ##### Running clobber step. 18:53:15 INFO - ##### 18:53:15 INFO - Running pre-action listener: _resource_record_pre_action 18:53:15 INFO - Running main action method: clobber 18:53:15 INFO - rmtree: /builds/slave/test-pgo/build 18:53:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:53:15 INFO - Running post-action listener: _resource_record_post_action 18:53:15 INFO - ##### 18:53:15 INFO - ##### Running read-buildbot-config step. 18:53:15 INFO - ##### 18:53:15 INFO - Running pre-action listener: _resource_record_pre_action 18:53:15 INFO - Running main action method: read_buildbot_config 18:53:15 INFO - Using buildbot properties: 18:53:15 INFO - { 18:53:15 INFO - "project": "", 18:53:15 INFO - "product": "firefox", 18:53:15 INFO - "script_repo_revision": "production", 18:53:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:53:15 INFO - "repository": "", 18:53:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:53:15 INFO - "buildid": "20160327163001", 18:53:15 INFO - "pgo_build": "True", 18:53:15 INFO - "basedir": "/builds/slave/test-pgo", 18:53:15 INFO - "buildnumber": 857, 18:53:15 INFO - "slavename": "talos-linux64-ix-042", 18:53:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:53:15 INFO - "platform": "ubuntu64_hw", 18:53:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:53:15 INFO - "branch": "mozilla-inbound", 18:53:15 INFO - "repo_path": "integration/mozilla-inbound", 18:53:15 INFO - "revision": "db4111c66699e246fd9fdf7d562526297a11c7df", 18:53:15 INFO - "stage_platform": "linux64-pgo", 18:53:15 INFO - "builduid": "0162a7b6902e455c85590799618a5f96", 18:53:15 INFO - "slavebuilddir": "test" 18:53:15 INFO - } 18:53:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:53:15 INFO - Running post-action listener: _resource_record_post_action 18:53:15 INFO - ##### 18:53:15 INFO - ##### Running download-and-extract step. 18:53:15 INFO - ##### 18:53:15 INFO - Running pre-action listener: _resource_record_pre_action 18:53:15 INFO - Running main action method: download_and_extract 18:53:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:53: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')]} 18:53:15 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:53:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:25 INFO - Downloaded 1361 bytes. 18:53:25 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:25 INFO - Using the following test package requirements: 18:53:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'jsshell-linux-x86_64.zip'], 18:53:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53: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')]} 18:53:25 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:38 INFO - Downloaded 23655425 bytes. 18:53: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'] 18:53: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 18:53:40 INFO - Return code: 0 18:53:40 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 18:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:40 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:41 INFO - Downloaded 23655425 bytes. 18:53:41 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'] 18:53:41 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 18:53:42 INFO - Return code: 0 18:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:42 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:43 INFO - Downloaded 10847531 bytes. 18:53: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'] 18:53: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 18:53:43 INFO - Return code: 0 18:53: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')]} 18:53:43 INFO - https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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 18:53:45 INFO - Downloaded 57747535 bytes. 18:53:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:45 INFO - mkdir: /builds/slave/test-pgo/properties 18:53:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:53:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:53:45 INFO - Contents: 18:53:45 INFO - build_url:https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:45 INFO - Running post-action listener: _resource_record_post_action 18:53:45 INFO - Running post-action listener: set_extra_try_arguments 18:53:45 INFO - ##### 18:53:45 INFO - ##### Running populate-webroot step. 18:53:45 INFO - ##### 18:53:45 INFO - Running pre-action listener: _resource_record_pre_action 18:53:45 INFO - Running main action method: populate_webroot 18:53:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:45 INFO - '--tppagecycles', 18:53:45 INFO - '7'], 18:53:45 INFO - 'tests': ['tsvgm']}}, 18:53:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:53:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:53:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'tests': ['damp', 'tps']}, 18:53:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['damp', 'tps']}, 18:53:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:53:45 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['dromaeo_dom']}, 18:53:45 INFO - 'other': {'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'other_l64': {'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:53:45 INFO - 'ts_paint', 18:53:45 INFO - 'tpaint', 18:53:45 INFO - 'sessionrestore', 18:53:45 INFO - 'sessionrestore_no_auto_restore', 18:53:45 INFO - 'tabpaint']}, 18:53:45 INFO - 'svgr': {'tests': ['tsvgx', 18:53:45 INFO - 'tsvgr_opacity', 18:53:45 INFO - 'tart', 18:53:45 INFO - 'tscrollx', 18:53:45 INFO - 'cart']}, 18:53:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['tsvgx', 18:53:45 INFO - 'tsvgr_opacity', 18:53:45 INFO - 'tart', 18:53:45 INFO - 'tscrollx', 18:53:45 INFO - 'cart']}, 18:53:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'tests': ['tp5o']}, 18:53:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'talos_options': ['--e10s'], 18:53:45 INFO - 'tests': ['tp5o']}, 18:53:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'talos_options': ['--xperf_path', 18:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:45 INFO - 'tests': ['tp5n']}, 18:53:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:45 INFO - 'talos_options': ['--e10s', 18:53:45 INFO - '--xperf_path', 18:53:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:45 INFO - 'tests': ['tp5n']}}, 18:53:45 INFO - 'talos.zip': {'path': '', 18:53:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:45 INFO - Running post-action listener: _resource_record_post_action 18:53:45 INFO - ##### 18:53:45 INFO - ##### Running create-virtualenv step. 18:53:45 INFO - ##### 18:53:46 INFO - Running pre-action listener: _resource_record_pre_action 18:53:46 INFO - Running main action method: create_virtualenv 18:53:46 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:53:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:53:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:53:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:46 INFO - Using real prefix '/usr' 18:53:46 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:53:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:48 INFO - Installing pip.................done. 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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 18:53: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 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53: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 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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 18:53: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 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:49 INFO - Downloading/unpacking psutil>=0.7.1 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:50 INFO - Installing collected packages: psutil 18:53:50 INFO - Running setup.py install for psutil 18:53:51 INFO - building 'psutil._psutil_linux' extension 18:53:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:53: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 18:53:51 INFO - building 'psutil._psutil_posix' extension 18:53: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 18:53: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 18:53:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:51 INFO - Successfully installed psutil 18:53:51 INFO - Cleaning up... 18:53:51 INFO - Return code: 0 18:53:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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 18:53: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 18:53:51 INFO - Using env: {'DISPLAY': ':0', 18:53:51 INFO - 'HOME': '/home/cltbld', 18:53:51 INFO - 'LANG': 'en_US.UTF-8', 18:53:51 INFO - 'LANGUAGE': 'en_US:en', 18:53:51 INFO - 'LOGNAME': 'cltbld', 18:53:51 INFO - 'MAIL': '/var/mail/cltbld', 18:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:51 INFO - 'MOZ_NO_REMOTE': '1', 18:53:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:51 INFO - 'NO_EM_RESTART': '1', 18:53:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:51 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:51 INFO - 'SHELL': '/bin/bash', 18:53:51 INFO - 'SHLVL': '1', 18:53:51 INFO - 'TERM': 'linux', 18:53:51 INFO - 'TMOUT': '86400', 18:53:51 INFO - 'USER': 'cltbld', 18:53:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:51 INFO - '_': '/tools/buildbot/bin/python'} 18:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53: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) 18:53:53 INFO - Installing collected packages: mozsystemmonitor 18:53:53 INFO - Running setup.py install for mozsystemmonitor 18:53:53 INFO - Successfully installed mozsystemmonitor 18:53:53 INFO - Cleaning up... 18:53:53 INFO - Return code: 0 18:53:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:53: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')]} 18:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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')]} 18:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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 18:53: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 18:53:53 INFO - Using env: {'DISPLAY': ':0', 18:53:53 INFO - 'HOME': '/home/cltbld', 18:53:53 INFO - 'LANG': 'en_US.UTF-8', 18:53:53 INFO - 'LANGUAGE': 'en_US:en', 18:53:53 INFO - 'LOGNAME': 'cltbld', 18:53:53 INFO - 'MAIL': '/var/mail/cltbld', 18:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:53 INFO - 'MOZ_NO_REMOTE': '1', 18:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:53 INFO - 'NO_EM_RESTART': '1', 18:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:53 INFO - 'SHELL': '/bin/bash', 18:53:53 INFO - 'SHLVL': '1', 18:53:53 INFO - 'TERM': 'linux', 18:53:53 INFO - 'TMOUT': '86400', 18:53:53 INFO - 'USER': 'cltbld', 18:53:53 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:53 INFO - '_': '/tools/buildbot/bin/python'} 18:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:54 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:55 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:53:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:56 INFO - Downloading docopt-0.6.1.tar.gz 18:53:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:56 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:56 INFO - Running setup.py install for blobuploader 18:53:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:56 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:53:56 INFO - Running setup.py install for requests 18:53:57 INFO - Running setup.py install for docopt 18:53:57 INFO - Successfully installed blobuploader requests docopt 18:53:57 INFO - Cleaning up... 18:53:57 INFO - Return code: 0 18:53:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53: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 18:53: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 18:53:57 INFO - Using env: {'DISPLAY': ':0', 18:53:57 INFO - 'HOME': '/home/cltbld', 18:53:57 INFO - 'LANG': 'en_US.UTF-8', 18:53:57 INFO - 'LANGUAGE': 'en_US:en', 18:53:57 INFO - 'LOGNAME': 'cltbld', 18:53:57 INFO - 'MAIL': '/var/mail/cltbld', 18:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:57 INFO - 'MOZ_NO_REMOTE': '1', 18:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:57 INFO - 'NO_EM_RESTART': '1', 18:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 18:53:57 INFO - 'SHELL': '/bin/bash', 18:53:57 INFO - 'SHLVL': '1', 18:53:57 INFO - 'TERM': 'linux', 18:53:57 INFO - 'TMOUT': '86400', 18:53:57 INFO - 'USER': 'cltbld', 18:53:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:57 INFO - '_': '/tools/buildbot/bin/python'} 18:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:57 INFO - Running setup.py (path:/tmp/pip-re6q8p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:57 INFO - Running setup.py (path:/tmp/pip-NgljJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:57 INFO - Running setup.py (path:/tmp/pip-bn6tgd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:57 INFO - Running setup.py (path:/tmp/pip-9z83iv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:57 INFO - Running setup.py (path:/tmp/pip-K1bC94-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:57 INFO - Running setup.py (path:/tmp/pip-BwLiAN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:57 INFO - Running setup.py (path:/tmp/pip-BIYRdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:57 INFO - Running setup.py (path:/tmp/pip-k3o7eY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:57 INFO - Running setup.py (path:/tmp/pip-Jk1OBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:58 INFO - Running setup.py (path:/tmp/pip-GzytV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:58 INFO - Running setup.py (path:/tmp/pip-aIAiXa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:58 INFO - Running setup.py (path:/tmp/pip-moqIbi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:58 INFO - Running setup.py (path:/tmp/pip-cVruT7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:58 INFO - Running setup.py (path:/tmp/pip-pZTlaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:58 INFO - Running setup.py (path:/tmp/pip-qyhbKE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:58 INFO - Running setup.py (path:/tmp/pip-wyjUag-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:58 INFO - Running setup.py (path:/tmp/pip-ps5L0f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:53:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:58 INFO - Running setup.py install for manifestparser 18:53:58 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:53:58 INFO - Running setup.py install for mozcrash 18:53:58 INFO - Running setup.py install for mozdebug 18:53:58 INFO - Running setup.py install for mozdevice 18:53:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozfile 18:53:59 INFO - Running setup.py install for mozhttpd 18:53:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozinfo 18:53:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozInstall 18:53:59 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozleak 18:53:59 INFO - Running setup.py install for mozlog 18:53:59 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for moznetwork 18:53:59 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozprocess 18:53:59 INFO - Running setup.py install for mozprofile 18:53:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:53:59 INFO - Running setup.py install for mozrunner 18:54:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:54:00 INFO - Running setup.py install for mozscreenshot 18:54:00 INFO - Running setup.py install for moztest 18:54:00 INFO - Running setup.py install for mozversion 18:54:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:54:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:54:00 INFO - Cleaning up... 18:54:00 INFO - Return code: 0 18:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:54: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')]} 18:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54: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 18:54: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 18:54:00 INFO - Using env: {'DISPLAY': ':0', 18:54:00 INFO - 'HOME': '/home/cltbld', 18:54:00 INFO - 'LANG': 'en_US.UTF-8', 18:54:00 INFO - 'LANGUAGE': 'en_US:en', 18:54:00 INFO - 'LOGNAME': 'cltbld', 18:54:00 INFO - 'MAIL': '/var/mail/cltbld', 18:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:00 INFO - 'MOZ_NO_REMOTE': '1', 18:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:00 INFO - 'NO_EM_RESTART': '1', 18:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:00 INFO - 'SHELL': '/bin/bash', 18:54:00 INFO - 'SHLVL': '1', 18:54:00 INFO - 'TERM': 'linux', 18:54:00 INFO - 'TMOUT': '86400', 18:54:00 INFO - 'USER': 'cltbld', 18:54:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:00 INFO - '_': '/tools/buildbot/bin/python'} 18:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:54:00 INFO - Running setup.py (path:/tmp/pip-TWJkU_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:54: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)) 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:54:00 INFO - Running setup.py (path:/tmp/pip-cD9z11-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:54: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)) 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:54:00 INFO - Running setup.py (path:/tmp/pip-fRQPOL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:54: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)) 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:54:00 INFO - Running setup.py (path:/tmp/pip-dusqee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:54: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)) 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:54:00 INFO - Running setup.py (path:/tmp/pip-fTjVTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:54:00 INFO - Running setup.py (path:/tmp/pip-TNDyy9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:54:01 INFO - Running setup.py (path:/tmp/pip-j7FLPL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:54:01 INFO - Running setup.py (path:/tmp/pip-gjs8CO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:54:01 INFO - Running setup.py (path:/tmp/pip-bGhpQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:54:01 INFO - Running setup.py (path:/tmp/pip-_krixu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:54:01 INFO - Running setup.py (path:/tmp/pip-W5prVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:54:01 INFO - Running setup.py (path:/tmp/pip-P4zIeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:54:01 INFO - Running setup.py (path:/tmp/pip-OaOPWL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:54:01 INFO - Running setup.py (path:/tmp/pip-dRJ200-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:54:01 INFO - Running setup.py (path:/tmp/pip-OZgi1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:54:01 INFO - Running setup.py (path:/tmp/pip-xVoxrS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:54: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)) 18:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:54:01 INFO - Running setup.py (path:/tmp/pip-G7kNBS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:03 INFO - Downloading blessings-1.6.tar.gz 18:54:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:03 INFO - Installing collected packages: blessings 18:54:03 INFO - Running setup.py install for blessings 18:54:03 INFO - Successfully installed blessings 18:54:03 INFO - Cleaning up... 18:54:03 INFO - Return code: 0 18:54:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:54:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:54:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:54:04 INFO - Reading from file tmpfile_stdout 18:54:04 INFO - Current package versions: 18:54:04 INFO - argparse == 1.2.1 18:54:04 INFO - blessings == 1.6 18:54:04 INFO - blobuploader == 1.2.4 18:54:04 INFO - docopt == 0.6.1 18:54:04 INFO - manifestparser == 1.1 18:54:04 INFO - mozInstall == 1.12 18:54:04 INFO - mozcrash == 0.17 18:54:04 INFO - mozdebug == 0.1 18:54:04 INFO - mozdevice == 0.48 18:54:04 INFO - mozfile == 1.2 18:54:04 INFO - mozhttpd == 0.7 18:54:04 INFO - mozinfo == 0.9 18:54:04 INFO - mozleak == 0.1 18:54:04 INFO - mozlog == 3.1 18:54:04 INFO - moznetwork == 0.27 18:54:04 INFO - mozprocess == 0.22 18:54:04 INFO - mozprofile == 0.28 18:54:04 INFO - mozrunner == 6.11 18:54:04 INFO - mozscreenshot == 0.1 18:54:04 INFO - mozsystemmonitor == 0.0 18:54:04 INFO - moztest == 0.7 18:54:04 INFO - mozversion == 1.4 18:54:04 INFO - psutil == 3.1.1 18:54:04 INFO - requests == 1.2.3 18:54:04 INFO - wsgiref == 0.1.2 18:54:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:54: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')]} 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54: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 18:54: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 18:54:04 INFO - Using env: {'DISPLAY': ':0', 18:54:04 INFO - 'HOME': '/home/cltbld', 18:54:04 INFO - 'LANG': 'en_US.UTF-8', 18:54:04 INFO - 'LANGUAGE': 'en_US:en', 18:54:04 INFO - 'LOGNAME': 'cltbld', 18:54:04 INFO - 'MAIL': '/var/mail/cltbld', 18:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:04 INFO - 'MOZ_NO_REMOTE': '1', 18:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:04 INFO - 'NO_EM_RESTART': '1', 18:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:04 INFO - 'SHELL': '/bin/bash', 18:54:04 INFO - 'SHLVL': '1', 18:54:04 INFO - 'TERM': 'linux', 18:54:04 INFO - 'TMOUT': '86400', 18:54:04 INFO - 'USER': 'cltbld', 18:54:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:04 INFO - '_': '/tools/buildbot/bin/python'} 18:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54: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)) 18:54:04 INFO - Cleaning up... 18:54:04 INFO - Return code: 0 18:54:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:54: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')]} 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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')]} 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54: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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54: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 18:54: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 18:54:04 INFO - Using env: {'DISPLAY': ':0', 18:54:04 INFO - 'HOME': '/home/cltbld', 18:54:04 INFO - 'LANG': 'en_US.UTF-8', 18:54:04 INFO - 'LANGUAGE': 'en_US:en', 18:54:04 INFO - 'LOGNAME': 'cltbld', 18:54:04 INFO - 'MAIL': '/var/mail/cltbld', 18:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:04 INFO - 'MOZ_NO_REMOTE': '1', 18:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:04 INFO - 'NO_EM_RESTART': '1', 18:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:04 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:04 INFO - 'SHELL': '/bin/bash', 18:54:04 INFO - 'SHLVL': '1', 18:54:04 INFO - 'TERM': 'linux', 18:54:04 INFO - 'TMOUT': '86400', 18:54:04 INFO - 'USER': 'cltbld', 18:54:04 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:04 INFO - '_': '/tools/buildbot/bin/python'} 18:54:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:04 INFO - Downloading/unpacking jsonschema 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:54:06 INFO - Downloading/unpacking functools32 (from jsonschema) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:54:06 INFO - warning: no files found matching '*.txt' 18:54:06 INFO - no previously-included directories found matching 'build' 18:54:06 INFO - no previously-included directories found matching 'dist' 18:54:06 INFO - no previously-included directories found matching '.git*' 18:54:06 INFO - Installing collected packages: jsonschema, functools32 18:54:06 INFO - Running setup.py install for functools32 18:54:06 INFO - warning: no files found matching '*.txt' 18:54:06 INFO - no previously-included directories found matching 'build' 18:54:06 INFO - no previously-included directories found matching 'dist' 18:54:06 INFO - no previously-included directories found matching '.git*' 18:54:06 INFO - Successfully installed jsonschema functools32 18:54:06 INFO - Cleaning up... 18:54:06 INFO - Return code: 0 18:54:06 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:06 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 0x7fb84ca6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a358d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, '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': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:06 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 18:54:06 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 18:54:06 INFO - Using env: {'DISPLAY': ':0', 18:54:06 INFO - 'HOME': '/home/cltbld', 18:54:06 INFO - 'LANG': 'en_US.UTF-8', 18:54:06 INFO - 'LANGUAGE': 'en_US:en', 18:54:06 INFO - 'LOGNAME': 'cltbld', 18:54:06 INFO - 'MAIL': '/var/mail/cltbld', 18:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:06 INFO - 'MOZ_NO_REMOTE': '1', 18:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:06 INFO - 'NO_EM_RESTART': '1', 18:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:06 INFO - 'SHELL': '/bin/bash', 18:54:06 INFO - 'SHLVL': '1', 18:54:06 INFO - 'TERM': 'linux', 18:54:06 INFO - 'TMOUT': '86400', 18:54:06 INFO - 'USER': 'cltbld', 18:54:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:06 INFO - '_': '/tools/buildbot/bin/python'} 18:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:07 INFO - Downloading/unpacking flake8 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:54:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:54:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54: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 18:54:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:09 INFO - no previously-included directories found matching 'docs/_build' 18:54:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:54:09 INFO - Running setup.py install for pep8 18:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:09 INFO - no previously-included directories found matching 'docs/_build' 18:54:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:54:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:54:09 INFO - Cleaning up... 18:54:09 INFO - Return code: 0 18:54:09 INFO - Running post-action listener: _resource_record_post_action 18:54:09 INFO - Running post-action listener: _start_resource_monitoring 18:54:10 INFO - Starting resource monitoring. 18:54:10 INFO - ##### 18:54:10 INFO - ##### Running install step. 18:54:10 INFO - ##### 18:54:10 INFO - Running pre-action listener: _resource_record_pre_action 18:54:10 INFO - Running main action method: install 18:54:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:54:10 INFO - Reading from file tmpfile_stdout 18:54:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:54:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:54:10 INFO - Reading from file tmpfile_stdout 18:54:10 INFO - Output received: 18:54:10 INFO - Usage: mozinstall [options] installer 18:54:10 INFO - Options: 18:54:10 INFO - -h, --help show this help message and exit 18:54:10 INFO - -d DEST, --destination=DEST 18:54:10 INFO - Directory to install application into. [default: 18:54:10 INFO - "/builds/slave/test-pgo"] 18:54:10 INFO - --app=APP Application being installed. [default: firefox] 18:54:10 INFO - mkdir: /builds/slave/test-pgo/build/application 18:54: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'] 18:54: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 18:54:26 INFO - Reading from file tmpfile_stdout 18:54:26 INFO - Output received: 18:54:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:54:26 INFO - Running post-action listener: _resource_record_post_action 18:54:26 INFO - ##### 18:54:26 INFO - ##### Running run-tests step. 18:54:26 INFO - ##### 18:54:26 INFO - Running pre-action listener: _resource_record_pre_action 18:54:26 INFO - Running main action method: run_tests 18:54:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:54:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:54:26 INFO - Python 2.7.3 18:54:26 INFO - Return code: 0 18:54:26 INFO - grabbing minidump binary from tooltool 18:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54: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 0x2ac48b0>, '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 0x2ac57b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac5c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:54: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 18:54: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 18:54:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:26 INFO - Return code: 0 18:54:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:54:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:54:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:54:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:54:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:54:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:54:27 INFO - Return code: 0 18:54: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/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 18:54: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/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 18:54:27 INFO - Using env: {'DISPLAY': ':0', 18:54:27 INFO - 'HOME': '/home/cltbld', 18:54:27 INFO - 'LANG': 'en_US.UTF-8', 18:54:27 INFO - 'LANGUAGE': 'en_US:en', 18:54:27 INFO - 'LOGNAME': 'cltbld', 18:54:27 INFO - 'MAIL': '/var/mail/cltbld', 18:54:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:27 INFO - 'MOZ_NO_REMOTE': '1', 18:54:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:27 INFO - 'NO_EM_RESTART': '1', 18:54:27 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:54:27 INFO - 'PWD': '/builds/slave/test-pgo', 18:54:27 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:54:27 INFO - 'SHELL': '/bin/bash', 18:54:27 INFO - 'SHLVL': '1', 18:54:27 INFO - 'TERM': 'linux', 18:54:27 INFO - 'TMOUT': '86400', 18:54:27 INFO - 'USER': 'cltbld', 18:54:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929', 18:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:27 INFO - '_': '/tools/buildbot/bin/python'} 18:54: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/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 18:54:28 INFO - mozversion application_buildid: 20160327163001 18:54:28 INFO - mozversion application_changeset: db4111c66699e246fd9fdf7d562526297a11c7df 18:54:28 INFO - mozversion application_display_name: Nightly 18:54:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:28 INFO - mozversion application_name: Firefox 18:54:28 INFO - mozversion application_remotingname: firefox 18:54:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:28 INFO - mozversion application_vendor: Mozilla 18:54:28 INFO - mozversion application_version: 48.0a1 18:54:28 INFO - mozversion platform_buildid: 20160327163001 18:54:28 INFO - mozversion platform_changeset: db4111c66699e246fd9fdf7d562526297a11c7df 18:54:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:54:28 INFO - mozversion platform_version: 48.0a1 18:54:28 INFO - using testdate: 1459130068 18:54:28 INFO - actual date: 1459130068 18:54:28 INFO - starting webserver on 'localhost:43595' 18:54:28 INFO - SUITE-START | Running 2 tests 18:54:28 INFO - TEST-START | dromaeo_css 18:54:28 INFO - operating with platform_type : linux_ 18:54:28 INFO - Initialising browser for dromaeo_css test... 18:54:28 INFO - TEST-INFO | started process 20180 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpffEEoX/profile http://localhost:43595/getInfo.html) 18:54:32 INFO - PROCESS | 20180 | 18:54:32 INFO - PROCESS | 20180 | (process:20260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:32 INFO - PROCESS | 20180 | 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] 18:54:33 INFO - PROCESS | 20180 | __metrics Screen width/height:1600/1200 18:54:33 INFO - PROCESS | 20180 | colorDepth:24 18:54:33 INFO - PROCESS | 20180 | Browser inner width/height: 1024/697 18:54:33 INFO - PROCESS | 20180 | __metrics 18:54:33 ERROR - PROCESS | 20180 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 18:54:34 INFO - TEST-INFO | 20180: exit 0 18:54:34 INFO - Browser initialized. 18:54:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:34 INFO - TEST-INFO | started process 20311 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpffEEoX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:36 INFO - PROCESS | 20311 | 18:54:36 INFO - PROCESS | 20311 | (process:20375): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:54:46 INFO - PROCESS | 20311 | RSS: Main: 163704832 18:54:46 INFO - PROCESS | 20311 | 18:55:35 INFO - PROCESS | 20311 | 1459130135930 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:57:43 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43595/tests/dromaeo/cssquery-ext.html) 18:57:44 INFO - PROCESS | 20311 | RSS: Main: 168951808 18:57:44 INFO - PROCESS | 20311 | 19:00:46 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-ext.html (next: http://localhost:43595/tests/dromaeo/cssquery-jquery.html) 19:00:47 INFO - PROCESS | 20311 | RSS: Main: 166264832 19:00:47 INFO - PROCESS | 20311 | 19:03:48 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43595/tests/dromaeo/cssquery-mootools.html) 19:03:49 INFO - PROCESS | 20311 | RSS: Main: 167071744 19:03:49 INFO - PROCESS | 20311 | 19:06:50 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43595/tests/dromaeo/cssquery-prototype.html) 19:06:51 INFO - PROCESS | 20311 | RSS: Main: 164532224 19:06:51 INFO - PROCESS | 20311 | 19:09:53 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43595/tests/dromaeo/cssquery-yui.html) 19:09:54 INFO - PROCESS | 20311 | RSS: Main: 166236160 19:09:54 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | Cycle 1(1): loaded http://localhost:43595/tests/dromaeo/cssquery-yui.html (next: http://localhost:43595/tests/dromaeo/cssquery-dojo.html) 19:12:56 INFO - PROCESS | 20311 | RSS: Main: 168038400 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | __start_tp_report 19:12:56 INFO - PROCESS | 20311 | _x_x_mozilla_page_load 19:12:56 INFO - PROCESS | 20311 | _x_x_mozilla_page_load_details 19:12:56 INFO - PROCESS | 20311 | |i|pagename|runs| 19:12:56 INFO - PROCESS | 20311 | |0;dojo.html;3084.07477756673;3086.845657717114;3112.9533057004137;3158.352537729764;3159.5260710893363;5326.493983071612;5329.333833270836;5341.839744807658;5348.572114230862;5399.7030163341;5248.265242866002;5294.973525132378;5389.595780316482;5414.160805075219;5434.049041417746;4871.488493708162;4896.2410826321975;4908.901821963558;4915.803367865281;5028.899422011557;4954.157793175151;4973.776180071905;4983.426905905812;4984.551390374865;5057.216131499624;4850.660453768238;4917.950820491803;4931.038447502739;4952.529509696573;4970.478099799505;4855.126077306083;4888.462269150391;4888.584470319992;4896.387951506062;4919.77860996256;4805.20714082176;4862.7325497097645;4863.562279394871;4877.975610121962;4879.853604391874;5263.6841789492755;5339.279197308352;5360.705161216131;5363.704996225206;5365.3293338332705;5667.263255776764;5669.716514174274;5678.6024978251535;5688.374278829326;5691.4593113654555;5663.575231857586;5718.313802343745;5723.971380143073;5725.77096916127;5726.713664316809;5295.788168473295;5330.147176451788;5334.759935802898;5358.383785864637;5362.383325917531;5842.561807864342;5863.941360586339;5868.061110222344;5881.294244690579;5892.587518873637;5526.723663816793;5557.944420555824;5647.858803529944;5659.179418984307;5677.148427735872;5636.267285252973;5683.829485115453;5689.971550142305;5720.77116915327;5758.481736643722;5678.77284908599;5694.145878118233;5700.37295897451;5712.714364281769;5770.653760774367;5573.860653483695;5621.915671264935;5643.943560564424;5645.294338207724;5780;4332.848350307724;4337.306031035019;4339.934900976488;4369.6722745794195;4374.365716971085;3866.845326186921;3888.7861167635488;3890.9883430308323;3901.5318161820765;3907.8046097695;5368.516833485005;5464.3442786865835;5482.80810171642;5520.641158324696;5528.778848846082;5715.1713001614535;5743.052396354555;5753.8561535961935;5765.048766953406;5783.537317014629;5422.43064478232;5466.671999680032;5484.725763711798;5490.423505531941;5491.560675145979;4854.05345957542;4996.050750357421;5003.349564556657;5034.572061374751;5083.212102124176;5961.135635332853;5977.641341519523;5989.64062156272;5994.6403215807195;5997.520198384119;5818.359980402152;5841.386654401396;5842.152887831326;5846.736896839738;5853.268341457318;5721.742521586455;5772.624779389326;5823.272090988627;5835.066389377679;5835.94164058354;5673.971630141823;5721.799737009184;5727.11229759388;5760.337561180518;5787.971060144672;5692.601517893708;5752.309722833287;5774.538036956949;5798.85502862415;5804.071348584206;5532.889342213052;5652.152177173457;5661.235733175969;5673.77304907799;5674.517665998271;5559.082751345983;5562.471565201299;5580.804671836466;5595.244641973281;5624.128260119688;5470.398256191896;5503.614746967673;5517.779288828562;5518.255035570307;5540.833774986757;5494.066008778597;5628.8874222514505;5640.435956404327;5716.828495145152;5778.8266352009505;5519.972400137974;5551.2228288040515;5555.111182210827;5560.944390556043;5562.415946325739 19:12:56 INFO - PROCESS | 20311 | |1;ext.html;518.4608007672022;557.8019802969945;571.3573476255765;573.6615396915819;588.8645611509355;39986.600133998654;40668.389974150414;40793.7960310198;40799;40903.79548102259;41388;42182.57817421825;42205.577944220546;42283.78858105705;42341.36487952683;8522.786930326745;8674;8688.131186881325;8712.259457946082;8724.607392667345;8644.524551149716;8730.083341249172;8742.519161446118;8769.123087691212;8800.647974081028;8679.305655547572;8742.475451472932;8777.253933415668;8789.296856251485;8795.472271663688;8718.694845680402;8763.561821908943;8770.693025744133;8802.29581633471;8810.691625793099;8690.087540808187;8758.912410875873;8765.912340876637;8792;8813.206811386943;36217.27565448703;36598.63401365979;36610.63389366125;36748;36795.81602091999;3035.2867076237067;3212.4378233809225;3234.2399536108996;3434.244466217428;3728.776273423576;29181.124566263046;29245.561316580268;29314.706852931624;29608;30519.69480305213;4241.34259189823;4328.069465064995;4341.327094300357;4372.825086996516;4419.62433193179;259106;259731;260280;261413;262570.68714656495;48581.5141848584;49217.26174107391;57677.71161144167;57960.710196448745;58252.70873645604;41230;41348;41387.37918931218;41395;41492.585074148876;14528.709425811636;14701.55895323142;14792.260386980823;14840.703185936221;14860.851391485947;11574.47914843834;11606.94196529012;11613.883861161281;11623.476943537562;11671.649850504498;16174.676506469805;16346.427875024317;16347.100909450095;16408.343666253455;16464.917675411547;6125.387461253928;6172.321044685081;6212.192414986023;6238.03501896901;6293.748250070037;1020.698893826323;1040.9967244499674;1073.0074680920275;1130.3387518301886;1142.8628564572305;31641.8417907909;31709.8414507926;32196.517052244235;32201.677983220336;32518;1094.9124070074374;1125.7953989231444;1195.1036722458157;1195.2888031621171;1241.0195945203368;16207.270672819752;16256.75614865778;16335.754963675554;16344.591385215226;16549.50351489457;432598;438442.27009784634;438841;439239;439522;55262.723686382116;55984;56259.156112657525;56318.15522767162;56396.71801641048;1348.5549768576543;1376.7590671632624;1391.3808355281803;1404.024203178781;1404.592668126232;31000.0699979001;31031.379372411975;31346.1022373745;31912.52131217987;32529.349413011132;50438.2434263479;50822.983540329726;51006.48993510166;51016.234756479425;51337.48662513327;299225;303227;304072;304169;305812;36114.4582831263;36524.452133218554;36595.451068233466;36748.44877326789;36814.63185368112;47476.52523474721;48019.51980480151;48746.26880596865;48753.75623121862;48774.51225487841;39734.60265397309;40655.59344406636;40699.59300406958;40774.79612601918;42357.5764242366;39334.40998384969;39835.402468962406;40237.39643905402;40765.38851917164;41208;34948.12629684278;40362.798186008884;40516.3922541168;40765.592344076176;41620.375694364004;31660.366792664478;32630.673693262765;32753.508697370034;32838.83580582082;32903.83548082244;25702;26301.868490657424;26325.473490529697;26446;26642.333941651614 19:12:56 INFO - PROCESS | 20311 | |2;jquery.html;353.92390636013255;365.1510238695035;367.2434784344251;368.2487725040916;368.3958308374265;16835.83164168358;17173.313067477287;17484.65030699385;17583.20875560598;17585.64828703425;10612.416317102556;10675.306105103182;10794.082502987236;10801.83797243042;15721.921390393032;4739.2654138608395;4828.951710482886;4851.781669824866;4852.078105160026;4857.562819346258;4998.60011199105;5370.140777475604;5387.138057910735;5393.83818485446;5399.676019438826;5243.501867322618;5259.552938000255;5269.920951185735;5300.231466437364;5389.757460914248;5088.313077734514;5238.319018527605;5262.894742105174;5269.841904742864;5428.9185662215095;4997.800087996476;5018.197088465828;5039.697618142924;5083;5088.109580823379;12170.452329645188;12377.938110309391;12386.504539818396;12514.74970500594;12534.561290354884;2198.9450263743374;2571.7813985811226;2865.1834227245345;2887.595736596878;2901;9578.193772075805;9582.472963986978;11984.322194892722;13026.153300035467;13849.861501384958;1937.1282922684848;1965.3612575912744;1979.732736080625;2004.6592079346547;2008.457716416574;66707;73737;74675.6266218671;74957;75320.24679753187;9618;9636.71089867305;9958.900410995942;10376.844347334796;10509.159267258754;12974.35128243584;13104.868951310556;13117.803232951514;13179.60461186166;13223.272720000492;7543.886841697379;7558.093028836574;7592.291734359725;7682;7686.116096648957;7279.526830755984;7291.817704557428;7376.446766492534;7443.665035073434;7517.285857843496;4167;4170.708050436501;4173.478315210598;4319.827206911751;4328.675349348811;1759.894406335624;1829.7712785901763;1869.7382366468705;1891.3569386408687;1902.6480101181326;938.2494004796135;944.7024187380953;964.8070385922844;990.2968892086556;1048.370977413561;16948.491545253662;17535;17827;18166.18252178655;18340.816591834177;984.3700031979396;1001.9248556358157;1007.5818535307765;1027.091024443373;1041.1150522056191;10043.648472303434;10203.183745300357;10245.692629221136;10286.485675716185;10336.431496267778;508328;511260;521290;523513;527404;81411.18588814154;84193;84662;84976;86881.5655921729;1017.3387298256044;1035.9274850760526;1036.1296510930854;1050.0444595418132;1063.7127975446585;15825.841741582437;15877.364905403654;15991;16097.839021609634;16460.670786583963;35676.28647426985;36478.088047799014;37916.43125353067;39231.41152882652;39247.21505569816;53762;53856.46143538514;53951;54101.18848217359;54437.727811362274;7877.803054923444;7958.641861116148;8069.677212911418;8171.55056471876;8206.507609543447;8536.91463085386;9184.908150918405;9262.95368523153;12168.57409990646;13631.113977591425;11768.94115529417;11810.82283765727;12039.277643341427;12108.576199833316;12351.444185011876;11586.710332241424;11699.06407487416;11853.170278080452;11948.163628546266;12052.698682533006;11965.76068478643;11968.581099661471;12000.819987700366;12040.578579749666;12340.197887137307;7984.081830589324;8119.944407227023;8125.015577100322;8145.42981991255;8202.548859812767;8595.613197406257;10918.781624367628;11868.347240901488;11962.401879905796;12207.633770986884 19:12:56 INFO - PROCESS | 20311 | |3;mootools.html;1405.4729476446337;1407.2541552976923;1562.5624825048983;1715.2538645689133;1748.5016770220482;6653.035309880064;7237.31245531675;7292.8541429171455;7445.292697193765;7457.25427457254;7310.524815886964;7345.742898998523;7436.1820199777985;7441.962790186041;7450.441216908726;2206.3711842125;2230.587341341857;2237.1498830444407;2237.865728056314;2241.2491815241833;2203.900824462895;2237.127520267089;2252.31304452142;2269.716285464317;2277.4420267034598;2243.248511748558;2253.4704344479114;2274.4996100857784;2281.3840263128945;2291.140822191678;2249.1003598560624;2250.1224522436264;2259.8757068361233;2265.954680906389;2276.578832915916;2230.3643461613524;2242.1031587365023;2259;2263.739669937945;2263.762304957972;7474.252574742537;7527.134379546367;7542.8114297142465;7577.242275772379;7588.089429268468;4742.0515896820425;4841.419029716457;4845.588125009378;4850.854474365775;4860.684055536379;3208.246062175387;3220.372027454647;3301.4717645176656;3313.2710803623163;3328.0847766864063;1042.9009244121796;1059.0468578279533;1062.054771253585;1087.7933192693363;1088.8149014667526;10487.265891387606;10511.894881051168;10547.261691681662;10561.577536898514;10594;4145.54399016108;4251.362295655615;4282.764447955392;4313.84901528445;4333.8699839004885;9162.770930726652;9174.403663761834;9177.77055573616;9193.172614464596;9206.401583897024;4886.144924638174;4893.486183950705;4917.655764096479;4930;4931.4821943696115;3770.0763312987947;4302.290122129813;4408.669349798778;4491.1915855145735;4538.341940418621;3606.8737594184604;3671.504346913186;3681.7975011374633;3687.0966613179944;3733.8506459741848;1190.220405634311;1195.49789088583;1210.7033776724584;1221.432034104146;1223.2171410297417;1188.3701638131804;1195.4500929572494;1206.5716670581992;1217.1175897474436;1221;7143.8571228576175;7146.2496437874315;7198.208197098315;7199.424046076301;7372.48392612512;456.4408599465628;460.9147307748077;461.46239630829706;463.52488699083034;468.73984938358853;5721;5764.250647415809;5769.07694768835;5817.011108111631;5825.300963884276;9069.682561110329;9095.636174553076;9380.718578442658;9495.762605934908;9503.57233924475;9202.401843880127;9255.213306868856;9288.674896378594;9296.349255552183;9301.348905576544;7153.713851445884;7158.928410716035;7185.497015208885;7207.279272072751;7262.491625586264;7102.715891364288;7180.7845764627145;7182.174049984319;7216.7474138404905;7227.747028853965;8271.793205169919;8316.958415207886;8407.2433480987;8466.830663386821;8483.27892129176;8526.914730852612;8583.227509523924;8617.48295102296;8704.78238044054;8717.041125476066;6083.939160608515;6182.752689892533;6293.181886354744;6711.832204194934;6842.349976752201;7385.187629360874;7399.926000739923;7404.407647388089;7407.851842963219;7444.627768611439;6450.387213214737;6522.836929076811;6579.17760279965;6694.330566943461;6697.665116744046;6459.61242325462;6505.2518960318275;6531.183602049744;6558.967205163944;6589.406953374028;6942.51402401827;6952.270011648907;6991.860162796817;6994.440444764305;7022.157341118894;6089.147519347206;6402.391772781578;6411.839704007437;6437.25971513282;6490.837729056811;6562.245341785565;6576.967115164393;6581.80254592363;6601.933980660132;6627.536072474881 19:12:56 INFO - PROCESS | 20311 | |4;prototype.html;331.8141840569281;334.8643799261299;338.74594054459146;339.50940890413364;346.923676791106;6405.103285540023;6425.7509871544935;6465.288818229991;6489.091527186186;6515.087887695727;6325.4307112359875;6382.234131904166;6398.2322121345505;6412.743490260395;6421.261554921185;4727.621790256789;4797.544233297848;4815.975920120412;4850.175470170079;4885.022995400916;4801.615870730333;4811.109944660231;4819.831305904294;4828.87927801806;4832.9275060874115;4753.47711751707;4766.428028636568;4771.475137734864;4788.6887352322165;4791.736454495001;4748.525147485241;4752.881177970544;4755.571998520132;4767.404074490689;4776.188048031843;4181.038361176947;4199.958000420018;4221.493420789494;4222.725522841006;4226.408302837574;6092.086187071975;6245.219347581552;6255.24937007562;6257.436830685215;6258.374162583706;5609.579281553859;5626.352969408529;5627.634203776742;5629.774809007635;5644.491995720364;6741.157355330583;6772.18733751948;6775.0514927910135;6782.287859774702;6782.660866956632;4596.103759766846;4628.09752098341;4631.930521042187;4637.953620463786;4641.466231383401;7022.12223472066;7030;7106.751263705745;7112.502124851262;7113;4548.909021819545;4718.9382388962895;4723.551262630044;4734.715917044989;4752.358431611758;4751.881202969954;4752.073345697556;4782.971661092882;4793.304970779218;4801.5438533339275;5586.966411213938;5609.5792815539;5613.242212301368;5624.931263060005;5632.915506267409;6863.897041544381;6872.450203983669;6883.8967415488805;6884.965575172092;6890.483213758988;1670.9665806683797;1694.2037242496008;1694.9237284322235;1697.7283634618402;1703.2931333496708;1047.1936608811325;1079.7786453776957;1085.5440714899603;1092.1426680056118;1100.2188446203124;6489.7404103835315;6507.479401647857;6514.120593719787;6523;6578.63817490033;7024.648767561602;7030.2969703029285;7034.6482675866;7044.471664625174;7061.964690176516;6340.080688300171;6464.5798023128345;6560.245571759308;6585.440237579859;6667;3808.3145033894166;3810.542734871833;3830.9042273943373;3840.116773142193;3840.2895464339185;7361.190269070398;7365.226651201654;7372.705091796268;7375.594342311224;7382.815429614303;7231.783046508614;7233.89149162763;7234.529755565976;7239.674214660353;7262.9273707262255;7160.176579693298;7361.6319184040585;7361.852762944818;7366.558006519519;7415.480916335805;7055.894161587683;7091.43268538526;7105.32499412555;7108.680109395193;7109.431245500244;6939.271376505596;6952.721891124298;7013.438924886099;7013.684384202825;7025.0516180317045;7341.3392794648735;7358.411327093927;7365.594892280762;7367.484276100621;7390.889136663062;4561.49823519406;4686.671932964659;4687;4690.92963605553;4716.528347165256;7003.894941575779;7010.649467526501;7052.753153639598;7063.57618542889;7069.752558660422;6793.558418702769;6794.898076528757;6810.489213308922;6815.761448349284;6836.111305530249;6812.216595091628;6817.352351526597;6824.965875170592;6839.89740153908;6853.828654283483;6456.677166141768;6706.6646667665445;6734.6632668367365;6784.3554862288;6791.93208067913;6959;6978.406835418843;7000.19497757744;7007.439404847498;7029.753958611424;6731.259561448139;6767.627780472121;6788.151481064867;6796.490263230178;6799.762008329685 19:12:56 INFO - PROCESS | 20311 | |5;yui.html;632.7880160146348;652.5171373183839;668.5119862500375;686.0738003695012;709.6664567653204;13350.933245333772;13416.53042143525;13508.05443618947;13531.729365412686;13564.796528052088;11913.106517011216;13347;13504.459821607124;13555.93222033891;13558.593242202749;792.0495405513378;819.1971867569786;833.9166083391673;834.7245409015011;834.7620928035511;610.6214147228725;612.1216054961122;612.5681394616785;612.874360756044;613.1691557938996;872.3413822563955;874.6457684637732;874.6457684637732;876.3164731509432;881.8412685716569;854.107457706698;855.4867079752161;856.1053698884649;857.2199298638241;858.5664239559045;608.2062907905182;610.6061590274293;615.9938400616026;619.3991827926949;619.4332186049759;13276.336183190899;13463.528776492874;13470.52853150135;13498.325083745773;13498.32508374587;12764.425600847984;12852;12931;13056.347182640924;13189;10541.156707463384;10576.206784491116;10618;10681.786364272748;10685.03834654877;3697.8705745299053;3711.350513660099;3745.325841348556;3787.4129509926006;3796.221774536241;56930.715346423414;57110;57616;57627.423725763045;57914.71042644802;9710.951445242728;9812.313138080408;10153.796924061477;10161.136303414292;10172.440515771703;16940.23768930401;17021;17064.2321095551;17130.657386852192;17160.22778974949;7318.158411782713;7372.963135184397;7412.221716719667;7593.088829340514;7778.805529861799;4504.2793153095345;4513.842015529506;4579.129965306581;4599.2871104978785;4614.884627884263;3213.9839300803346;3233.3210025894828;3264.5103234515013;3265.265315304085;3271.4275001875053;528.2446102073994;530.5728888244922;538.7737150396842;539.9433059528772;560.5823661372303;587.6973358720262;633.0630666613438;664.1465716554204;682.6825526130373;703.7958991892397;8918.37571369998;9157.404768690014;9193.954030229806;9446.197073248852;9577.856332155023;533.9279197308314;578.4071326889972;588.8586739182565;629.804760524239;674.6323253826677;4066.959330406658;4264.0832221072;4320.78396080201;4321.67587430944;4411.18393097278;67721.32278677249;68401.31598684049;68507;68892;69521;59746;60916;60966.69516652388;61523.6923815378;61574;47896.760516197195;53388.46611533913;53559.732201339524;53695.731521342146;54010.45989540133;9318.673846415342;9505.692060994204;9869.605215791287;9950.701478955643;9954.950225248827;38739.41890871696;38744.6125538741;39435.60564394319;39558.40662390124;41061.1787764249;47131;50508.747456262485;50971;51287.23069153891;51846.22230666618;11594;11641.59254426091;11657.591984280509;11768.470418831344;11971.580994665144;12749.93625031869;12949.935250323688;13054;13067.281299528237;13309.86690133125;12145.14983951115;12356.62930112098;12474.5010199591;12654.810177847156;13132;11814;11883.762324753283;11927.165098443025;11937.46281417321;11988;11626.244294120856;11753.47109380097;11809;11979.640610781691;12110.333931633493;10131.752633807437;10220.693379198636;10342.069213770797;10504.159667226757;10543.420111893613;9821.116099551075;9906.405615662796;10163.086714399305;10182.726070046781;10257.692269231935 19:12:56 INFO - PROCESS | 20311 | __end_tp_report 19:12:56 INFO - PROCESS | 20311 | __start_cc_report 19:12:56 INFO - PROCESS | 20311 | _x_x_mozilla_cycle_collect,317 19:12:56 INFO - PROCESS | 20311 | __end_cc_report 19:12:56 INFO - PROCESS | 20311 | __startTimestamp1459131176911__endTimestamp 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | ------- Summary: start ------- 19:12:56 INFO - PROCESS | 20311 | Number of tests: 6 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#0] dojo.html Cycles:165 Average:5333.72 Median:5532.89 stddev:599.55 (10.8%) stddev-sans-first:574.83 19:12:56 INFO - PROCESS | 20311 | Values: 3084.1 3086.8 3113.0 3158.4 3159.5 5326.5 5329.3 5341.8 5348.6 5399.7 5248.3 5295.0 5389.6 5414.2 5434.0 4871.5 4896.2 4908.9 4915.8 5028.9 4954.2 4973.8 4983.4 4984.6 5057.2 4850.7 4918.0 4931.0 4952.5 4970.5 4855.1 4888.5 4888.6 4896.4 4919.8 4805.2 4862.7 4863.6 4878.0 4879.9 5263.7 5339.3 5360.7 5363.7 5365.3 5667.3 5669.7 5678.6 5688.4 5691.5 5663.6 5718.3 5724.0 5725.8 5726.7 5295.8 5330.1 5334.8 5358.4 5362.4 5842.6 5863.9 5868.1 5881.3 5892.6 5526.7 5557.9 5647.9 5659.2 5677.1 5636.3 5683.8 5690.0 5720.8 5758.5 5678.8 5694.1 5700.4 5712.7 5770.7 5573.9 5621.9 5643.9 5645.3 5780.0 4332.8 4337.3 4339.9 4369.7 4374.4 3866.8 3888.8 3891.0 3901.5 3907.8 5368.5 5464.3 5482.8 5520.6 5528.8 5715.2 5743.1 5753.9 5765.0 5783.5 5422.4 5466.7 5484.7 5490.4 5491.6 4854.1 4996.1 5003.3 5034.6 5083.2 5961.1 5977.6 5989.6 5994.6 5997.5 5818.4 5841.4 5842.2 5846.7 5853.3 5721.7 5772.6 5823.3 5835.1 5835.9 5674.0 5721.8 5727.1 5760.3 5788.0 5692.6 5752.3 5774.5 5798.9 5804.1 5532.9 5652.2 5661.2 5673.8 5674.5 5559.1 5562.5 5580.8 5595.2 5624.1 5470.4 5503.6 5517.8 5518.3 5540.8 5494.1 5628.9 5640.4 5716.8 5778.8 5520.0 5551.2 5555.1 5560.9 5562.4 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#1] ext.html Cycles:180 Average:50060.09 Median:40300.10 stddev:90163.18 (223.7%) stddev-sans-first:90339.38 19:12:56 INFO - PROCESS | 20311 | Values: 518.5 557.8 571.4 573.7 588.9 39986.6 40668.4 40793.8 40799.0 40903.8 41388.0 42182.6 42205.6 42283.8 42341.4 8522.8 8674.0 8688.1 8712.3 8724.6 8644.5 8730.1 8742.5 8769.1 8800.6 8679.3 8742.5 8777.3 8789.3 8795.5 8718.7 8763.6 8770.7 8802.3 8810.7 8690.1 8758.9 8765.9 8792.0 8813.2 36217.3 36598.6 36610.6 36748.0 36795.8 3035.3 3212.4 3234.2 3434.2 3728.8 29181.1 29245.6 29314.7 29608.0 30519.7 4241.3 4328.1 4341.3 4372.8 4419.6 259106.0 259731.0 260280.0 261413.0 262570.7 48581.5 49217.3 57677.7 57960.7 58252.7 41230.0 41348.0 41387.4 41395.0 41492.6 14528.7 14701.6 14792.3 14840.7 14860.9 11574.5 11606.9 11613.9 11623.5 11671.6 16174.7 16346.4 16347.1 16408.3 16464.9 6125.4 6172.3 6212.2 6238.0 6293.7 1020.7 1041.0 1073.0 1130.3 1142.9 31641.8 31709.8 32196.5 32201.7 32518.0 1094.9 1125.8 1195.1 1195.3 1241.0 16207.3 16256.8 16335.8 16344.6 16549.5 432598.0 438442.3 438841.0 439239.0 439522.0 55262.7 55984.0 56259.2 56318.2 56396.7 1348.6 1376.8 1391.4 1404.0 1404.6 31000.1 31031.4 31346.1 31912.5 32529.3 50438.2 50823.0 51006.5 51016.2 51337.5 299225.0 303227.0 304072.0 304169.0 305812.0 36114.5 36524.5 36595.5 36748.4 36814.6 47476.5 48019.5 48746.3 48753.8 48774.5 39734.6 40655.6 40699.6 40774.8 42357.6 39334.4 39835.4 40237.4 40765.4 41208.0 34948.1 40362.8 40516.4 40765.6 41620.4 31660.4 32630.7 32753.5 32838.8 32903.8 25702.0 26301.9 26325.5 26446.0 26642.3 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#2] jquery.html Cycles:180 Average:28234.45 Median:367.75 stddev:85161.91 (23157.8%) stddev-sans-first:85375.07 19:12:56 INFO - PROCESS | 20311 | Values: 353.9 365.2 367.2 368.2 368.4 16835.8 17173.3 17484.7 17583.2 17585.6 10612.4 10675.3 10794.1 10801.8 15721.9 4739.3 4829.0 4851.8 4852.1 4857.6 4998.6 5370.1 5387.1 5393.8 5399.7 5243.5 5259.6 5269.9 5300.2 5389.8 5088.3 5238.3 5262.9 5269.8 5428.9 4997.8 5018.2 5039.7 5083.0 5088.1 12170.5 12377.9 12386.5 12514.7 12534.6 2198.9 2571.8 2865.2 2887.6 2901.0 9578.2 9582.5 11984.3 13026.2 13849.9 1937.1 1965.4 1979.7 2004.7 2008.5 66707.0 73737.0 74675.6 74957.0 75320.2 9618.0 9636.7 9958.9 10376.8 10509.2 12974.4 13104.9 13117.8 13179.6 13223.3 7543.9 7558.1 7592.3 7682.0 7686.1 7279.5 7291.8 7376.4 7443.7 7517.3 4167.0 4170.7 4173.5 4319.8 4328.7 1759.9 1829.8 1869.7 1891.4 1902.6 938.2 944.7 964.8 990.3 1048.4 16948.5 17535.0 17827.0 18166.2 18340.8 984.4 1001.9 1007.6 1027.1 1041.1 10043.6 10203.2 10245.7 10286.5 10336.4 508328.0 511260.0 521290.0 523513.0 527404.0 81411.2 84193.0 84662.0 84976.0 86881.6 1017.3 1035.9 1036.1 1050.0 1063.7 15825.8 15877.4 15991.0 16097.8 16460.7 35676.3 36478.1 37916.4 39231.4 39247.2 53762.0 53856.5 53951.0 54101.2 54437.7 7877.8 7958.6 8069.7 8171.6 8206.5 8536.9 9184.9 9263.0 12168.6 13631.1 11768.9 11810.8 12039.3 12108.6 12351.4 11586.7 11699.1 11853.2 11948.2 12052.7 11965.8 11968.6 12000.8 12040.6 12340.2 7984.1 8119.9 8125.0 8145.4 8202.5 8595.6 10918.8 11868.3 11962.4 12207.6 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#3] mootools.html Cycles:180 Average:5382.19 Median:6086.54 stddev:2787.33 (45.8%) stddev-sans-first:2779.12 19:12:56 INFO - PROCESS | 20311 | Values: 1405.5 1407.3 1562.6 1715.3 1748.5 6653.0 7237.3 7292.9 7445.3 7457.3 7310.5 7345.7 7436.2 7442.0 7450.4 2206.4 2230.6 2237.1 2237.9 2241.2 2203.9 2237.1 2252.3 2269.7 2277.4 2243.2 2253.5 2274.5 2281.4 2291.1 2249.1 2250.1 2259.9 2266.0 2276.6 2230.4 2242.1 2259.0 2263.7 2263.8 7474.3 7527.1 7542.8 7577.2 7588.1 4742.1 4841.4 4845.6 4850.9 4860.7 3208.2 3220.4 3301.5 3313.3 3328.1 1042.9 1059.0 1062.1 1087.8 1088.8 10487.3 10511.9 10547.3 10561.6 10594.0 4145.5 4251.4 4282.8 4313.8 4333.9 9162.8 9174.4 9177.8 9193.2 9206.4 4886.1 4893.5 4917.7 4930.0 4931.5 3770.1 4302.3 4408.7 4491.2 4538.3 3606.9 3671.5 3681.8 3687.1 3733.9 1190.2 1195.5 1210.7 1221.4 1223.2 1188.4 1195.5 1206.6 1217.1 1221.0 7143.9 7146.2 7198.2 7199.4 7372.5 456.4 460.9 461.5 463.5 468.7 5721.0 5764.3 5769.1 5817.0 5825.3 9069.7 9095.6 9380.7 9495.8 9503.6 9202.4 9255.2 9288.7 9296.3 9301.3 7153.7 7158.9 7185.5 7207.3 7262.5 7102.7 7180.8 7182.2 7216.7 7227.7 8271.8 8317.0 8407.2 8466.8 8483.3 8526.9 8583.2 8617.5 8704.8 8717.0 6083.9 6182.8 6293.2 6711.8 6842.3 7385.2 7399.9 7404.4 7407.9 7444.6 6450.4 6522.8 6579.2 6694.3 6697.7 6459.6 6505.3 6531.2 6559.0 6589.4 6942.5 6952.3 6991.9 6994.4 7022.2 6089.1 6402.4 6411.8 6437.3 6490.8 6562.2 6577.0 6581.8 6601.9 6627.5 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#4] prototype.html Cycles:180 Average:5687.40 Median:6477.19 stddev:1757.41 (27.1%) stddev-sans-first:1715.75 19:12:56 INFO - PROCESS | 20311 | Values: 331.8 334.9 338.7 339.5 346.9 6405.1 6425.8 6465.3 6489.1 6515.1 6325.4 6382.2 6398.2 6412.7 6421.3 4727.6 4797.5 4816.0 4850.2 4885.0 4801.6 4811.1 4819.8 4828.9 4832.9 4753.5 4766.4 4771.5 4788.7 4791.7 4748.5 4752.9 4755.6 4767.4 4776.2 4181.0 4200.0 4221.5 4222.7 4226.4 6092.1 6245.2 6255.2 6257.4 6258.4 5609.6 5626.4 5627.6 5629.8 5644.5 6741.2 6772.2 6775.1 6782.3 6782.7 4596.1 4628.1 4631.9 4638.0 4641.5 7022.1 7030.0 7106.8 7112.5 7113.0 4548.9 4718.9 4723.6 4734.7 4752.4 4751.9 4752.1 4783.0 4793.3 4801.5 5587.0 5609.6 5613.2 5624.9 5632.9 6863.9 6872.5 6883.9 6885.0 6890.5 1671.0 1694.2 1694.9 1697.7 1703.3 1047.2 1079.8 1085.5 1092.1 1100.2 6489.7 6507.5 6514.1 6523.0 6578.6 7024.6 7030.3 7034.6 7044.5 7062.0 6340.1 6464.6 6560.2 6585.4 6667.0 3808.3 3810.5 3830.9 3840.1 3840.3 7361.2 7365.2 7372.7 7375.6 7382.8 7231.8 7233.9 7234.5 7239.7 7262.9 7160.2 7361.6 7361.9 7366.6 7415.5 7055.9 7091.4 7105.3 7108.7 7109.4 6939.3 6952.7 7013.4 7013.7 7025.1 7341.3 7358.4 7365.6 7367.5 7390.9 4561.5 4686.7 4687.0 4690.9 4716.5 7003.9 7010.6 7052.8 7063.6 7069.8 6793.6 6794.9 6810.5 6815.8 6836.1 6812.2 6817.4 6825.0 6839.9 6853.8 6456.7 6706.7 6734.7 6784.4 6791.9 6959.0 6978.4 7000.2 7007.4 7029.8 6731.3 6767.6 6788.2 6796.5 6799.8 19:12:56 INFO - PROCESS | 20311 | 19:12:56 INFO - PROCESS | 20311 | [#5] yui.html Cycles:180 Average:15281.66 Median:25872.94 stddev:18794.32 (72.6%) stddev-sans-first:18814.85 19:12:56 INFO - PROCESS | 20311 | Values: 632.8 652.5 668.5 686.1 709.7 13350.9 13416.5 13508.1 13531.7 13564.8 11913.1 13347.0 13504.5 13555.9 13558.6 792.0 819.2 833.9 834.7 834.8 610.6 612.1 612.6 612.9 613.2 872.3 874.6 874.6 876.3 881.8 854.1 855.5 856.1 857.2 858.6 608.2 610.6 616.0 619.4 619.4 13276.3 13463.5 13470.5 13498.3 13498.3 12764.4 12852.0 12931.0 13056.3 13189.0 10541.2 10576.2 10618.0 10681.8 10685.0 3697.9 3711.4 3745.3 3787.4 3796.2 56930.7 57110.0 57616.0 57627.4 57914.7 9711.0 9812.3 10153.8 10161.1 10172.4 16940.2 17021.0 17064.2 17130.7 17160.2 7318.2 7373.0 7412.2 7593.1 7778.8 4504.3 4513.8 4579.1 4599.3 4614.9 3214.0 3233.3 3264.5 3265.3 3271.4 528.2 530.6 538.8 539.9 560.6 587.7 633.1 664.1 682.7 703.8 8918.4 9157.4 9194.0 9446.2 9577.9 533.9 578.4 588.9 629.8 674.6 4067.0 4264.1 4320.8 4321.7 4411.2 67721.3 68401.3 68507.0 68892.0 69521.0 59746.0 60916.0 60966.7 61523.7 61574.0 47896.8 53388.5 53559.7 53695.7 54010.5 9318.7 9505.7 9869.6 9950.7 9955.0 38739.4 38744.6 39435.6 39558.4 41061.2 47131.0 50508.7 50971.0 51287.2 51846.2 11594.0 11641.6 11657.6 11768.5 11971.6 12749.9 12949.9 13054.0 13067.3 13309.9 12145.1 12356.6 12474.5 12654.8 13132.0 11814.0 11883.8 11927.2 11937.5 11988.0 11626.2 11753.5 11809.0 11979.6 12110.3 10131.8 10220.7 10342.1 10504.2 10543.4 9821.1 9906.4 10163.1 10182.7 10257.7 19:12:56 INFO - PROCESS | 20311 | -------- Summary: end -------- 19:12:56 INFO - PROCESS | 20311 | 19:12:57 INFO - TEST-INFO | 20311: exit 0 19:12:57 INFO - TEST-OK | dromaeo_css | took 1109579ms 19:12:57 INFO - TEST-START | kraken 19:12:57 INFO - operating with platform_type : linux_ 19:12:57 INFO - Initialising browser for kraken test... 19:12:57 INFO - TEST-INFO | started process 20550 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcnJHlQ/profile http://localhost:43595/getInfo.html) 19:13:01 INFO - PROCESS | 20550 | 19:13:01 INFO - PROCESS | 20550 | (process:20621): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:13:01 INFO - PROCESS | 20550 | 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] 19:13:01 INFO - PROCESS | 20550 | __metrics Screen width/height:1600/1200 19:13:01 INFO - PROCESS | 20550 | colorDepth:24 19:13:01 INFO - PROCESS | 20550 | Browser inner width/height: 1024/697 19:13:01 INFO - PROCESS | 20550 | __metrics 19:13:02 ERROR - PROCESS | 20550 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2864: TypeError: this.tabs is undefined 19:13:03 INFO - TEST-INFO | 20550: exit 0 19:13:03 INFO - Browser initialized. 19:13:03 INFO - Running cycle 1/1 for kraken test... 19:13:03 INFO - TEST-INFO | started process 20672 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcnJHlQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:05 INFO - PROCESS | 20672 | 19:13:05 INFO - PROCESS | 20672 | (process:20734): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:13:15 INFO - PROCESS | 20672 | RSS: Main: 163856384 19:13:15 INFO - PROCESS | 20672 | 19:13:17 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:18 INFO - PROCESS | 20672 | RSS: Main: 168701952 19:13:18 INFO - PROCESS | 20672 | 19:13:20 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-dft) 19:13:21 INFO - PROCESS | 20672 | RSS: Main: 171712512 19:13:21 INFO - PROCESS | 20672 | 19:13:24 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-fft) 19:13:25 INFO - PROCESS | 20672 | RSS: Main: 163110912 19:13:25 INFO - PROCESS | 20672 | 19:13:27 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43595/tests/kraken/driver.html?testName=audio-oscillator) 19:13:27 INFO - PROCESS | 20672 | RSS: Main: 163004416 19:13:27 INFO - PROCESS | 20672 | 19:13:29 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:30 INFO - PROCESS | 20672 | RSS: Main: 164548608 19:13:30 INFO - PROCESS | 20672 | 19:13:33 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:34 INFO - PROCESS | 20672 | RSS: Main: 164184064 19:13:34 INFO - PROCESS | 20672 | 19:13:37 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43595/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:38 INFO - PROCESS | 20672 | RSS: Main: 164368384 19:13:38 INFO - PROCESS | 20672 | 19:13:41 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43595/tests/kraken/driver.html?testName=json-parse-financial) 19:13:41 INFO - PROCESS | 20672 | RSS: Main: 166486016 19:13:41 INFO - PROCESS | 20672 | 19:13:43 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43595/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:43 INFO - PROCESS | 20672 | RSS: Main: 166678528 19:13:43 INFO - PROCESS | 20672 | 19:13:45 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:46 INFO - PROCESS | 20672 | RSS: Main: 166580224 19:13:46 INFO - PROCESS | 20672 | 19:13:48 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:48 INFO - PROCESS | 20672 | RSS: Main: 166989824 19:13:48 INFO - PROCESS | 20672 | 19:13:51 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:51 INFO - PROCESS | 20672 | RSS: Main: 167206912 19:13:51 INFO - PROCESS | 20672 | 19:13:54 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:55 INFO - PROCESS | 20672 | RSS: Main: 167534592 19:13:55 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | Cycle 1(1): loaded http://localhost:43595/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43595/tests/kraken/driver.html?testName=ai-astar) 19:13:56 INFO - PROCESS | 20672 | RSS: Main: 168939520 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | __start_tp_report 19:13:56 INFO - PROCESS | 20672 | _x_x_mozilla_page_load 19:13:56 INFO - PROCESS | 20672 | _x_x_mozilla_page_load_details 19:13:56 INFO - PROCESS | 20672 | |i|pagename|runs| 19:13:56 INFO - PROCESS | 20672 | |0;ai-astar;113;105;112;110;111;123;112;111;111;110 19:13:56 INFO - PROCESS | 20672 | |1;audio-beat-detection;162;135;151;175;132;154;156;128;174;128 19:13:56 INFO - PROCESS | 20672 | |2;audio-dft;163;165;164;165;162;163;164;168;169;162 19:13:56 INFO - PROCESS | 20672 | |3;audio-fft;74;73;78;74;77;72;73;73;140;78 19:13:56 INFO - PROCESS | 20672 | |4;audio-oscillator;93;93;151;93;93;93;139;92;93;149 19:13:56 INFO - PROCESS | 20672 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;118;118;118 19:13:56 INFO - PROCESS | 20672 | |6;imaging-darkroom;146;148;150;148;147;147;147;147;149;147 19:13:56 INFO - PROCESS | 20672 | |7;imaging-desaturate;96;96;96;97;97;96;95;96;95;95 19:13:56 INFO - PROCESS | 20672 | |8;json-parse-financial;59;57;56;58;57;57;55;58;54;61 19:13:56 INFO - PROCESS | 20672 | |9;json-stringify-tinderbox;59;59;59;60;60;60;59;60;60;60 19:13:56 INFO - PROCESS | 20672 | |10;stanford-crypto-aes;86;78;79;80;87;80;79;80;82;79 19:13:56 INFO - PROCESS | 20672 | |11;stanford-crypto-ccm;129;119;115;112;121;111;121;120;119;113 19:13:56 INFO - PROCESS | 20672 | |12;stanford-crypto-pbkdf2;143;143;151;143;144;143;144;144;139;143 19:13:56 INFO - PROCESS | 20672 | |13;stanford-crypto-sha256-iterative;65;65;65;63;63;70;63;65;62;63 19:13:56 INFO - PROCESS | 20672 | __end_tp_report 19:13:56 INFO - PROCESS | 20672 | __start_cc_report 19:13:56 INFO - PROCESS | 20672 | _x_x_mozilla_cycle_collect,812 19:13:56 INFO - PROCESS | 20672 | __end_cc_report 19:13:56 INFO - PROCESS | 20672 | __startTimestamp1459131236924__endTimestamp 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | ------- Summary: start ------- 19:13:56 INFO - PROCESS | 20672 | Number of tests: 14 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:4.49 (4.0%) stddev-sans-first:4.74 19:13:56 INFO - PROCESS | 20672 | Values: 113.0 105.0 112.0 110.0 111.0 123.0 112.0 111.0 111.0 110.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:155.00 stddev:17.99 (11.6%) stddev-sans-first:18.50 19:13:56 INFO - PROCESS | 20672 | Values: 162.0 135.0 151.0 175.0 132.0 154.0 156.0 128.0 174.0 128.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.37 (1.4%) stddev-sans-first:2.45 19:13:56 INFO - PROCESS | 20672 | Values: 163.0 165.0 164.0 165.0 162.0 163.0 164.0 168.0 169.0 162.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:20.78 (28.1%) stddev-sans-first:21.87 19:13:56 INFO - PROCESS | 20672 | Values: 74.0 73.0 78.0 74.0 77.0 72.0 73.0 73.0 140.0 78.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:93.00 stddev:26.01 (28.0%) stddev-sans-first:26.94 19:13:56 INFO - PROCESS | 20672 | Values: 93.0 93.0 151.0 93.0 93.0 93.0 139.0 92.0 93.0 149.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:13:56 INFO - PROCESS | 20672 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.09 19:13:56 INFO - PROCESS | 20672 | Values: 146.0 148.0 150.0 148.0 147.0 147.0 147.0 147.0 149.0 147.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 19:13:56 INFO - PROCESS | 20672 | Values: 96.0 96.0 96.0 97.0 97.0 96.0 95.0 96.0 95.0 95.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.50 stddev:1.99 (3.5%) stddev-sans-first:2.00 19:13:56 INFO - PROCESS | 20672 | Values: 59.0 57.0 56.0 58.0 57.0 57.0 55.0 58.0 54.0 61.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 19:13:56 INFO - PROCESS | 20672 | Values: 59.0 59.0 59.0 60.0 60.0 60.0 59.0 60.0 60.0 60.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.00 stddev:3.09 (3.9%) stddev-sans-first:2.70 19:13:56 INFO - PROCESS | 20672 | Values: 86.0 78.0 79.0 80.0 87.0 80.0 79.0 80.0 82.0 79.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#11] stanford-crypto-ccm Cycles:10 Average:118.00 Median:119.50 stddev:5.42 (4.5%) stddev-sans-first:4.02 19:13:56 INFO - PROCESS | 20672 | Values: 129.0 119.0 115.0 112.0 121.0 111.0 121.0 120.0 119.0 113.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.70 Median:143.50 stddev:2.95 (2.1%) stddev-sans-first:3.11 19:13:56 INFO - PROCESS | 20672 | Values: 143.0 143.0 151.0 143.0 144.0 143.0 144.0 144.0 139.0 143.0 19:13:56 INFO - PROCESS | 20672 | 19:13:56 INFO - PROCESS | 20672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:2.27 (3.5%) stddev-sans-first:2.40 19:13:56 INFO - PROCESS | 20672 | Values: 65.0 65.0 65.0 63.0 63.0 70.0 63.0 65.0 62.0 63.0 19:13:56 INFO - PROCESS | 20672 | -------- Summary: end -------- 19:13:56 INFO - PROCESS | 20672 | 19:13:57 INFO - TEST-INFO | 20672: exit 0 19:13:57 INFO - TEST-OK | kraken | took 60193ms 19:13:57 INFO - SUITE-END | took 1169s 19:13:58 INFO - Completed test suite (00:19:30) 19:13:58 INFO - javascript benchmark 19:13:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3084.07477756673, 3086.845657717114, 3112.9533057004137, 3158.352537729764, 3159.5260710893363, 5326.493983071612, 5329.333833270836, 5341.839744807658, 5348.572114230862, 5399.7030163341, 5248.265242866002, 5294.973525132378, 5389.595780316482, 5414.160805075219, 5434.049041417746, 4871.488493708162, 4896.2410826321975, 4908.901821963558, 4915.803367865281, 5028.899422011557, 4954.157793175151, 4973.776180071905, 4983.426905905812, 4984.551390374865, 5057.216131499624, 4850.660453768238, 4917.950820491803, 4931.038447502739, 4952.529509696573, 4970.478099799505, 4855.126077306083, 4888.462269150391, 4888.584470319992, 4896.387951506062, 4919.77860996256, 4805.20714082176, 4862.7325497097645, 4863.562279394871, 4877.975610121962, 4879.853604391874, 5263.6841789492755, 5339.279197308352, 5360.705161216131, 5363.704996225206, 5365.3293338332705, 5667.263255776764, 5669.716514174274, 5678.6024978251535, 5688.374278829326, 5691.4593113654555, 5663.575231857586, 5718.313802343745, 5723.971380143073, 5725.77096916127, 5726.713664316809, 5295.788168473295, 5330.147176451788, 5334.759935802898, 5358.383785864637, 5362.383325917531, 5842.561807864342, 5863.941360586339, 5868.061110222344, 5881.294244690579, 5892.587518873637, 5526.723663816793, 5557.944420555824, 5647.858803529944, 5659.179418984307, 5677.148427735872, 5636.267285252973, 5683.829485115453, 5689.971550142305, 5720.77116915327, 5758.481736643722, 5678.77284908599, 5694.145878118233, 5700.37295897451, 5712.714364281769, 5770.653760774367, 5573.860653483695, 5621.915671264935, 5643.943560564424, 5645.294338207724, 5780.0, 4332.848350307724, 4337.306031035019, 4339.934900976488, 4369.6722745794195, 4374.365716971085, 3866.845326186921, 3888.7861167635488, 3890.9883430308323, 3901.5318161820765, 3907.8046097695, 5368.516833485005, 5464.3442786865835, 5482.80810171642, 5520.641158324696, 5528.778848846082, 5715.1713001614535, 5743.052396354555, 5753.8561535961935, 5765.048766953406, 5783.537317014629, 5422.43064478232, 5466.671999680032, 5484.725763711798, 5490.423505531941, 5491.560675145979, 4854.05345957542, 4996.050750357421, 5003.349564556657, 5034.572061374751, 5083.212102124176, 5961.135635332853, 5977.641341519523, 5989.64062156272, 5994.6403215807195, 5997.520198384119, 5818.359980402152, 5841.386654401396, 5842.152887831326, 5846.736896839738, 5853.268341457318, 5721.742521586455, 5772.624779389326, 5823.272090988627, 5835.066389377679, 5835.94164058354, 5673.971630141823, 5721.799737009184, 5727.11229759388, 5760.337561180518, 5787.971060144672, 5692.601517893708, 5752.309722833287, 5774.538036956949, 5798.85502862415, 5804.071348584206, 5532.889342213052, 5652.152177173457, 5661.235733175969, 5673.77304907799, 5674.517665998271, 5559.082751345983, 5562.471565201299, 5580.804671836466, 5595.244641973281, 5624.128260119688, 5470.398256191896, 5503.614746967673, 5517.779288828562, 5518.255035570307, 5540.833774986757, 5494.066008778597, 5628.8874222514505, 5640.435956404327, 5716.828495145152, 5778.8266352009505, 5519.972400137974, 5551.2228288040515, 5555.111182210827, 5560.944390556043, 5562.415946325739], "unit": "score", "name": "dojo.html", "value": 5293.407375474892}, {"lowerIsBetter": false, "replicates": [518.4608007672022, 557.8019802969945, 571.3573476255765, 573.6615396915819, 588.8645611509355, 39986.600133998654, 40668.389974150414, 40793.7960310198, 40799.0, 40903.79548102259, 41388.0, 42182.57817421825, 42205.577944220546, 42283.78858105705, 42341.36487952683, 8522.786930326745, 8674.0, 8688.131186881325, 8712.259457946082, 8724.607392667345, 8644.524551149716, 8730.083341249172, 8742.519161446118, 8769.123087691212, 8800.647974081028, 8679.305655547572, 8742.475451472932, 8777.253933415668, 8789.296856251485, 8795.472271663688, 8718.694845680402, 8763.561821908943, 8770.693025744133, 8802.29581633471, 8810.691625793099, 8690.087540808187, 8758.912410875873, 8765.912340876637, 8792.0, 8813.206811386943, 36217.27565448703, 36598.63401365979, 36610.63389366125, 36748.0, 36795.81602091999, 3035.2867076237067, 3212.4378233809225, 3234.2399536108996, 3434.244466217428, 3728.776273423576, 29181.124566263046, 29245.561316580268, 29314.706852931624, 29608.0, 30519.69480305213, 4241.34259189823, 4328.069465064995, 4341.327094300357, 4372.825086996516, 4419.62433193179, 259106.0, 259731.0, 260280.0, 261413.0, 262570.68714656495, 48581.5141848584, 49217.26174107391, 57677.71161144167, 57960.710196448745, 58252.70873645604, 41230.0, 41348.0, 41387.37918931218, 41395.0, 41492.585074148876, 14528.709425811636, 14701.55895323142, 14792.260386980823, 14840.703185936221, 14860.851391485947, 11574.47914843834, 11606.94196529012, 11613.883861161281, 11623.476943537562, 11671.649850504498, 16174.676506469805, 16346.427875024317, 16347.100909450095, 16408.343666253455, 16464.917675411547, 6125.387461253928, 6172.321044685081, 6212.192414986023, 6238.03501896901, 6293.748250070037, 1020.698893826323, 1040.9967244499674, 1073.0074680920275, 1130.3387518301886, 1142.8628564572305, 31641.8417907909, 31709.8414507926, 32196.517052244235, 32201.677983220336, 32518.0, 1094.9124070074374, 1125.7953989231444, 1195.1036722458157, 1195.2888031621171, 1241.0195945203368, 16207.270672819752, 16256.75614865778, 16335.754963675554, 16344.591385215226, 16549.50351489457, 432598.0, 438442.27009784634, 438841.0, 439239.0, 439522.0, 55262.723686382116, 55984.0, 56259.156112657525, 56318.15522767162, 56396.71801641048, 1348.5549768576543, 1376.7590671632624, 1391.3808355281803, 1404.024203178781, 1404.592668126232, 31000.0699979001, 31031.379372411975, 31346.1022373745, 31912.52131217987, 32529.349413011132, 50438.2434263479, 50822.983540329726, 51006.48993510166, 51016.234756479425, 51337.48662513327, 299225.0, 303227.0, 304072.0, 304169.0, 305812.0, 36114.4582831263, 36524.452133218554, 36595.451068233466, 36748.44877326789, 36814.63185368112, 47476.52523474721, 48019.51980480151, 48746.26880596865, 48753.75623121862, 48774.51225487841, 39734.60265397309, 40655.59344406636, 40699.59300406958, 40774.79612601918, 42357.5764242366, 39334.40998384969, 39835.402468962406, 40237.39643905402, 40765.38851917164, 41208.0, 34948.12629684278, 40362.798186008884, 40516.3922541168, 40765.592344076176, 41620.375694364004, 31660.366792664478, 32630.673693262765, 32753.508697370034, 32838.83580582082, 32903.83548082244, 25702.0, 26301.868490657424, 26325.473490529697, 26446.0, 26642.333941651614], "unit": "score", "name": "ext.html", "value": 18871.362446500792}, {"lowerIsBetter": false, "replicates": [353.92390636013255, 365.1510238695035, 367.2434784344251, 368.2487725040916, 368.3958308374265, 16835.83164168358, 17173.313067477287, 17484.65030699385, 17583.20875560598, 17585.64828703425, 10612.416317102556, 10675.306105103182, 10794.082502987236, 10801.83797243042, 15721.921390393032, 4739.2654138608395, 4828.951710482886, 4851.781669824866, 4852.078105160026, 4857.562819346258, 4998.60011199105, 5370.140777475604, 5387.138057910735, 5393.83818485446, 5399.676019438826, 5243.501867322618, 5259.552938000255, 5269.920951185735, 5300.231466437364, 5389.757460914248, 5088.313077734514, 5238.319018527605, 5262.894742105174, 5269.841904742864, 5428.9185662215095, 4997.800087996476, 5018.197088465828, 5039.697618142924, 5083.0, 5088.109580823379, 12170.452329645188, 12377.938110309391, 12386.504539818396, 12514.74970500594, 12534.561290354884, 2198.9450263743374, 2571.7813985811226, 2865.1834227245345, 2887.595736596878, 2901.0, 9578.193772075805, 9582.472963986978, 11984.322194892722, 13026.153300035467, 13849.861501384958, 1937.1282922684848, 1965.3612575912744, 1979.732736080625, 2004.6592079346547, 2008.457716416574, 66707.0, 73737.0, 74675.6266218671, 74957.0, 75320.24679753187, 9618.0, 9636.71089867305, 9958.900410995942, 10376.844347334796, 10509.159267258754, 12974.35128243584, 13104.868951310556, 13117.803232951514, 13179.60461186166, 13223.272720000492, 7543.886841697379, 7558.093028836574, 7592.291734359725, 7682.0, 7686.116096648957, 7279.526830755984, 7291.817704557428, 7376.446766492534, 7443.665035073434, 7517.285857843496, 4167.0, 4170.708050436501, 4173.478315210598, 4319.827206911751, 4328.675349348811, 1759.894406335624, 1829.7712785901763, 1869.7382366468705, 1891.3569386408687, 1902.6480101181326, 938.2494004796135, 944.7024187380953, 964.8070385922844, 990.2968892086556, 1048.370977413561, 16948.491545253662, 17535.0, 17827.0, 18166.18252178655, 18340.816591834177, 984.3700031979396, 1001.9248556358157, 1007.5818535307765, 1027.091024443373, 1041.1150522056191, 10043.648472303434, 10203.183745300357, 10245.692629221136, 10286.485675716185, 10336.431496267778, 508328.0, 511260.0, 521290.0, 523513.0, 527404.0, 81411.18588814154, 84193.0, 84662.0, 84976.0, 86881.5655921729, 1017.3387298256044, 1035.9274850760526, 1036.1296510930854, 1050.0444595418132, 1063.7127975446585, 15825.841741582437, 15877.364905403654, 15991.0, 16097.839021609634, 16460.670786583963, 35676.28647426985, 36478.088047799014, 37916.43125353067, 39231.41152882652, 39247.21505569816, 53762.0, 53856.46143538514, 53951.0, 54101.18848217359, 54437.727811362274, 7877.803054923444, 7958.641861116148, 8069.677212911418, 8171.55056471876, 8206.507609543447, 8536.91463085386, 9184.908150918405, 9262.95368523153, 12168.57409990646, 13631.113977591425, 11768.94115529417, 11810.82283765727, 12039.277643341427, 12108.576199833316, 12351.444185011876, 11586.710332241424, 11699.06407487416, 11853.170278080452, 11948.163628546266, 12052.698682533006, 11965.76068478643, 11968.581099661471, 12000.819987700366, 12040.578579749666, 12340.197887137307, 7984.081830589324, 8119.944407227023, 8125.015577100322, 8145.42981991255, 8202.548859812767, 8595.613197406257, 10918.781624367628, 11868.347240901488, 11962.401879905796, 12207.633770986884], "unit": "score", "name": "jquery.html", "value": 8513.518438026831}, {"lowerIsBetter": false, "replicates": [1405.4729476446337, 1407.2541552976923, 1562.5624825048983, 1715.2538645689133, 1748.5016770220482, 6653.035309880064, 7237.31245531675, 7292.8541429171455, 7445.292697193765, 7457.25427457254, 7310.524815886964, 7345.742898998523, 7436.1820199777985, 7441.962790186041, 7450.441216908726, 2206.3711842125, 2230.587341341857, 2237.1498830444407, 2237.865728056314, 2241.2491815241833, 2203.900824462895, 2237.127520267089, 2252.31304452142, 2269.716285464317, 2277.4420267034598, 2243.248511748558, 2253.4704344479114, 2274.4996100857784, 2281.3840263128945, 2291.140822191678, 2249.1003598560624, 2250.1224522436264, 2259.8757068361233, 2265.954680906389, 2276.578832915916, 2230.3643461613524, 2242.1031587365023, 2259.0, 2263.739669937945, 2263.762304957972, 7474.252574742537, 7527.134379546367, 7542.8114297142465, 7577.242275772379, 7588.089429268468, 4742.0515896820425, 4841.419029716457, 4845.588125009378, 4850.854474365775, 4860.684055536379, 3208.246062175387, 3220.372027454647, 3301.4717645176656, 3313.2710803623163, 3328.0847766864063, 1042.9009244121796, 1059.0468578279533, 1062.054771253585, 1087.7933192693363, 1088.8149014667526, 10487.265891387606, 10511.894881051168, 10547.261691681662, 10561.577536898514, 10594.0, 4145.54399016108, 4251.362295655615, 4282.764447955392, 4313.84901528445, 4333.8699839004885, 9162.770930726652, 9174.403663761834, 9177.77055573616, 9193.172614464596, 9206.401583897024, 4886.144924638174, 4893.486183950705, 4917.655764096479, 4930.0, 4931.4821943696115, 3770.0763312987947, 4302.290122129813, 4408.669349798778, 4491.1915855145735, 4538.341940418621, 3606.8737594184604, 3671.504346913186, 3681.7975011374633, 3687.0966613179944, 3733.8506459741848, 1190.220405634311, 1195.49789088583, 1210.7033776724584, 1221.432034104146, 1223.2171410297417, 1188.3701638131804, 1195.4500929572494, 1206.5716670581992, 1217.1175897474436, 1221.0, 7143.8571228576175, 7146.2496437874315, 7198.208197098315, 7199.424046076301, 7372.48392612512, 456.4408599465628, 460.9147307748077, 461.46239630829706, 463.52488699083034, 468.73984938358853, 5721.0, 5764.250647415809, 5769.07694768835, 5817.011108111631, 5825.300963884276, 9069.682561110329, 9095.636174553076, 9380.718578442658, 9495.762605934908, 9503.57233924475, 9202.401843880127, 9255.213306868856, 9288.674896378594, 9296.349255552183, 9301.348905576544, 7153.713851445884, 7158.928410716035, 7185.497015208885, 7207.279272072751, 7262.491625586264, 7102.715891364288, 7180.7845764627145, 7182.174049984319, 7216.7474138404905, 7227.747028853965, 8271.793205169919, 8316.958415207886, 8407.2433480987, 8466.830663386821, 8483.27892129176, 8526.914730852612, 8583.227509523924, 8617.48295102296, 8704.78238044054, 8717.041125476066, 6083.939160608515, 6182.752689892533, 6293.181886354744, 6711.832204194934, 6842.349976752201, 7385.187629360874, 7399.926000739923, 7404.407647388089, 7407.851842963219, 7444.627768611439, 6450.387213214737, 6522.836929076811, 6579.17760279965, 6694.330566943461, 6697.665116744046, 6459.61242325462, 6505.2518960318275, 6531.183602049744, 6558.967205163944, 6589.406953374028, 6942.51402401827, 6952.270011648907, 6991.860162796817, 6994.440444764305, 7022.157341118894, 6089.147519347206, 6402.391772781578, 6411.839704007437, 6437.25971513282, 6490.837729056811, 6562.245341785565, 6576.967115164393, 6581.80254592363, 6601.933980660132, 6627.536072474881], "unit": "score", "name": "mootools.html", "value": 4363.171548651596}, {"lowerIsBetter": false, "replicates": [331.8141840569281, 334.8643799261299, 338.74594054459146, 339.50940890413364, 346.923676791106, 6405.103285540023, 6425.7509871544935, 6465.288818229991, 6489.091527186186, 6515.087887695727, 6325.4307112359875, 6382.234131904166, 6398.2322121345505, 6412.743490260395, 6421.261554921185, 4727.621790256789, 4797.544233297848, 4815.975920120412, 4850.175470170079, 4885.022995400916, 4801.615870730333, 4811.109944660231, 4819.831305904294, 4828.87927801806, 4832.9275060874115, 4753.47711751707, 4766.428028636568, 4771.475137734864, 4788.6887352322165, 4791.736454495001, 4748.525147485241, 4752.881177970544, 4755.571998520132, 4767.404074490689, 4776.188048031843, 4181.038361176947, 4199.958000420018, 4221.493420789494, 4222.725522841006, 4226.408302837574, 6092.086187071975, 6245.219347581552, 6255.24937007562, 6257.436830685215, 6258.374162583706, 5609.579281553859, 5626.352969408529, 5627.634203776742, 5629.774809007635, 5644.491995720364, 6741.157355330583, 6772.18733751948, 6775.0514927910135, 6782.287859774702, 6782.660866956632, 4596.103759766846, 4628.09752098341, 4631.930521042187, 4637.953620463786, 4641.466231383401, 7022.12223472066, 7030.0, 7106.751263705745, 7112.502124851262, 7113.0, 4548.909021819545, 4718.9382388962895, 4723.551262630044, 4734.715917044989, 4752.358431611758, 4751.881202969954, 4752.073345697556, 4782.971661092882, 4793.304970779218, 4801.5438533339275, 5586.966411213938, 5609.5792815539, 5613.242212301368, 5624.931263060005, 5632.915506267409, 6863.897041544381, 6872.450203983669, 6883.8967415488805, 6884.965575172092, 6890.483213758988, 1670.9665806683797, 1694.2037242496008, 1694.9237284322235, 1697.7283634618402, 1703.2931333496708, 1047.1936608811325, 1079.7786453776957, 1085.5440714899603, 1092.1426680056118, 1100.2188446203124, 6489.7404103835315, 6507.479401647857, 6514.120593719787, 6523.0, 6578.63817490033, 7024.648767561602, 7030.2969703029285, 7034.6482675866, 7044.471664625174, 7061.964690176516, 6340.080688300171, 6464.5798023128345, 6560.245571759308, 6585.440237579859, 6667.0, 3808.3145033894166, 3810.542734871833, 3830.9042273943373, 3840.116773142193, 3840.2895464339185, 7361.190269070398, 7365.226651201654, 7372.705091796268, 7375.594342311224, 7382.815429614303, 7231.783046508614, 7233.89149162763, 7234.529755565976, 7239.674214660353, 7262.9273707262255, 7160.176579693298, 7361.6319184040585, 7361.852762944818, 7366.558006519519, 7415.480916335805, 7055.894161587683, 7091.43268538526, 7105.32499412555, 7108.680109395193, 7109.431245500244, 6939.271376505596, 6952.721891124298, 7013.438924886099, 7013.684384202825, 7025.0516180317045, 7341.3392794648735, 7358.411327093927, 7365.594892280762, 7367.484276100621, 7390.889136663062, 4561.49823519406, 4686.671932964659, 4687.0, 4690.92963605553, 4716.528347165256, 7003.894941575779, 7010.649467526501, 7052.753153639598, 7063.57618542889, 7069.752558660422, 6793.558418702769, 6794.898076528757, 6810.489213308922, 6815.761448349284, 6836.111305530249, 6812.216595091628, 6817.352351526597, 6824.965875170592, 6839.89740153908, 6853.828654283483, 6456.677166141768, 6706.6646667665445, 6734.6632668367365, 6784.3554862288, 6791.93208067913, 6959.0, 6978.406835418843, 7000.19497757744, 7007.439404847498, 7029.753958611424, 6731.259561448139, 6767.627780472121, 6788.151481064867, 6796.490263230178, 6799.762008329685], "unit": "score", "name": "prototype.html", "value": 5103.313051869334}, {"lowerIsBetter": false, "replicates": [632.7880160146348, 652.5171373183839, 668.5119862500375, 686.0738003695012, 709.6664567653204, 13350.933245333772, 13416.53042143525, 13508.05443618947, 13531.729365412686, 13564.796528052088, 11913.106517011216, 13347.0, 13504.459821607124, 13555.93222033891, 13558.593242202749, 792.0495405513378, 819.1971867569786, 833.9166083391673, 834.7245409015011, 834.7620928035511, 610.6214147228725, 612.1216054961122, 612.5681394616785, 612.874360756044, 613.1691557938996, 872.3413822563955, 874.6457684637732, 874.6457684637732, 876.3164731509432, 881.8412685716569, 854.107457706698, 855.4867079752161, 856.1053698884649, 857.2199298638241, 858.5664239559045, 608.2062907905182, 610.6061590274293, 615.9938400616026, 619.3991827926949, 619.4332186049759, 13276.336183190899, 13463.528776492874, 13470.52853150135, 13498.325083745773, 13498.32508374587, 12764.425600847984, 12852.0, 12931.0, 13056.347182640924, 13189.0, 10541.156707463384, 10576.206784491116, 10618.0, 10681.786364272748, 10685.03834654877, 3697.8705745299053, 3711.350513660099, 3745.325841348556, 3787.4129509926006, 3796.221774536241, 56930.715346423414, 57110.0, 57616.0, 57627.423725763045, 57914.71042644802, 9710.951445242728, 9812.313138080408, 10153.796924061477, 10161.136303414292, 10172.440515771703, 16940.23768930401, 17021.0, 17064.2321095551, 17130.657386852192, 17160.22778974949, 7318.158411782713, 7372.963135184397, 7412.221716719667, 7593.088829340514, 7778.805529861799, 4504.2793153095345, 4513.842015529506, 4579.129965306581, 4599.2871104978785, 4614.884627884263, 3213.9839300803346, 3233.3210025894828, 3264.5103234515013, 3265.265315304085, 3271.4275001875053, 528.2446102073994, 530.5728888244922, 538.7737150396842, 539.9433059528772, 560.5823661372303, 587.6973358720262, 633.0630666613438, 664.1465716554204, 682.6825526130373, 703.7958991892397, 8918.37571369998, 9157.404768690014, 9193.954030229806, 9446.197073248852, 9577.856332155023, 533.9279197308314, 578.4071326889972, 588.8586739182565, 629.804760524239, 674.6323253826677, 4066.959330406658, 4264.0832221072, 4320.78396080201, 4321.67587430944, 4411.18393097278, 67721.32278677249, 68401.31598684049, 68507.0, 68892.0, 69521.0, 59746.0, 60916.0, 60966.69516652388, 61523.6923815378, 61574.0, 47896.760516197195, 53388.46611533913, 53559.732201339524, 53695.731521342146, 54010.45989540133, 9318.673846415342, 9505.692060994204, 9869.605215791287, 9950.701478955643, 9954.950225248827, 38739.41890871696, 38744.6125538741, 39435.60564394319, 39558.40662390124, 41061.1787764249, 47131.0, 50508.747456262485, 50971.0, 51287.23069153891, 51846.22230666618, 11594.0, 11641.59254426091, 11657.591984280509, 11768.470418831344, 11971.580994665144, 12749.93625031869, 12949.935250323688, 13054.0, 13067.281299528237, 13309.86690133125, 12145.14983951115, 12356.62930112098, 12474.5010199591, 12654.810177847156, 13132.0, 11814.0, 11883.762324753283, 11927.165098443025, 11937.46281417321, 11988.0, 11626.244294120856, 11753.47109380097, 11809.0, 11979.640610781691, 12110.333931633493, 10131.752633807437, 10220.693379198636, 10342.069213770797, 10504.159667226757, 10543.420111893613, 9821.116099551075, 9906.405615662796, 10163.086714399305, 10182.726070046781, 10257.692269231935], "unit": "score", "name": "yui.html", "value": 6525.758398159172}], "name": "dromaeo_css", "value": 7057.678382018631}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 112.0, 110.0, 111.0, 123.0, 112.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [162.0, 135.0, 151.0, 175.0, 132.0, 154.0, 156.0, 128.0, 174.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [163.0, 165.0, 164.0, 165.0, 162.0, 163.0, 164.0, 168.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 78.0, 74.0, 77.0, 72.0, 73.0, 73.0, 140.0, 78.0], "unit": "score", "name": "audio-fft", "value": 81.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 151.0, 93.0, 93.0, 93.0, 139.0, 92.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.4}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 150.0, 148.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 56.0, 58.0, 57.0, 57.0, 55.0, 58.0, 54.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 60.0, 60.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 59.6}, {"lowerIsBetter": true, "replicates": [86.0, 78.0, 79.0, 80.0, 87.0, 80.0, 79.0, 80.0, 82.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [129.0, 119.0, 115.0, 112.0, 121.0, 111.0, 121.0, 120.0, 119.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.0}, {"lowerIsBetter": true, "replicates": [143.0, 143.0, 151.0, 143.0, 144.0, 143.0, 144.0, 144.0, 139.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.7}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 63.0, 63.0, 70.0, 63.0, 65.0, 62.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.4}], "name": "kraken", "value": 1500.7}]} 19:13:58 INFO - Return code: 0 19:13:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:58 ERROR - # TBPL SUCCESS # 19:13:58 INFO - Running post-action listener: _resource_record_post_action 19:13:58 INFO - Running post-run listener: _resource_record_post_run 19:13:59 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540098560; Read time: 124; Write time: 715848 19:13:59 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 242634752; Read time: 0; Write time: 448128 19:13:59 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296865792; Read time: 124; Write time: 267720 19:13:59 INFO - Running post-run listener: _upload_blobber_files 19:13:59 INFO - Blob upload gear active. 19:13:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:13:59 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 19:13:59 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'] 19:13:59 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 19:13:59 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:13:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:00 INFO - (blobuploader) - INFO - Done attempting. 19:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:01 INFO - (blobuploader) - INFO - Done attempting. 19:14:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:01 INFO - Return code: 0 19:14:01 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:14:01 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9171782f1fa771d2a910a21bec9c1410c4d4b0d66243f42ebf9bdf97d9b7060d4858a6725c5d9c07ecb479db21e7914a0571e98b872723839aa2b4558e24f344", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5bc9398a3d7693e52e1fc4adce490476348f8591e8e389bb4d8dc4adbe16b083c267abbefca7b17631c5429d46eedd0919f91352dde3b2c3753dc52309cab303"} 19:14:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:14:01 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:14:01 INFO - Contents: 19:14:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9171782f1fa771d2a910a21bec9c1410c4d4b0d66243f42ebf9bdf97d9b7060d4858a6725c5d9c07ecb479db21e7914a0571e98b872723839aa2b4558e24f344", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5bc9398a3d7693e52e1fc4adce490476348f8591e8e389bb4d8dc4adbe16b083c267abbefca7b17631c5429d46eedd0919f91352dde3b2c3753dc52309cab303"} 19:14:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:01 INFO - Copying logs to upload dir... 19:14:01 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 19:14:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.591219 ========= master_lag: 1.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-03-27 19:14:00.512380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 19:14:00.515980) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 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/9171782f1fa771d2a910a21bec9c1410c4d4b0d66243f42ebf9bdf97d9b7060d4858a6725c5d9c07ecb479db21e7914a0571e98b872723839aa2b4558e24f344", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5bc9398a3d7693e52e1fc4adce490476348f8591e8e389bb4d8dc4adbe16b083c267abbefca7b17631c5429d46eedd0919f91352dde3b2c3753dc52309cab303"} build_url:https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011425 build_url: 'https://queue.taskcluster.net/v1/task/G-jHTDHaRlyx0DiGiV7oIw/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/9171782f1fa771d2a910a21bec9c1410c4d4b0d66243f42ebf9bdf97d9b7060d4858a6725c5d9c07ecb479db21e7914a0571e98b872723839aa2b4558e24f344", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5bc9398a3d7693e52e1fc4adce490476348f8591e8e389bb4d8dc4adbe16b083c267abbefca7b17631c5429d46eedd0919f91352dde3b2c3753dc52309cab303"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-27 19:14:00.541959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 19:14:00.542234) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1459126712.203688-1672486929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-27 19:14:00.591015) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 19:14:00.591281) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-27 19:14:00.591555) ========= ========= Total master_lag: 1.36 =========