builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1457449193.58 results: success (0) buildid: 20160308043040 builduid: f280b13db40b4bb3a382062b3b7fee0b revision: 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.575978) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.576431) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.576732) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006245 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.598794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.599106) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.623271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.623588) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.010595 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.669654) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.669953) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.670340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.670614) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-08 06:59:53-- 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% 163M=0s 2016-03-08 06:59:53 (163 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137551 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.820333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.820646) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.164076 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:53.996357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 06:59:53.996700) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 --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 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 --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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-08 06:59:54,075 truncating revision to first 12 chars 2016-03-08 06:59:54,075 Setting DEBUG logging. 2016-03-08 06:59:54,075 attempt 1/10 2016-03-08 06:59:54,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1c4cf5562aa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 06:59:54,840 unpacking tar archive at: mozilla-inbound-1c4cf5562aa3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-08 06:59:55.068227) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:55.068580) ========= echo 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1c4cf5562aa37215e973f1c15b80c412ea9e7bd9'] 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 program finished with exit code 0 elapsedTime=0.004774 script_repo_revision: '1c4cf5562aa37215e973f1c15b80c412ea9e7bd9' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:55.119832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:55.120176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 06:59:55.130015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-08 06:59:55.130354) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:59:55 INFO - MultiFileLogger online at 20160308 06:59:55 in /builds/slave/test-pgo 06:59:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 06:59:55 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 06:59:55 INFO - {'append_to_log': False, 06:59:55 INFO - 'base_work_dir': '/builds/slave/test-pgo', 06:59:55 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 06:59:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 06:59:55 INFO - 'branch': 'Mozilla-Inbound', 06:59:55 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:55 INFO - 'config_files': ('talos/linux_config.py',), 06:59:55 INFO - 'default_actions': ('clobber', 06:59:55 INFO - 'read-buildbot-config', 06:59:55 INFO - 'download-and-extract', 06:59:55 INFO - 'populate-webroot', 06:59:55 INFO - 'create-virtualenv', 06:59:55 INFO - 'install', 06:59:55 INFO - 'run-tests'), 06:59:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:55 INFO - 'download_minidump_stackwalk': True, 06:59:55 INFO - 'download_symbols': 'ondemand', 06:59:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:55 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:55 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:55 INFO - 'installer_path': 'installer.exe', 06:59:55 INFO - 'log_level': 'info', 06:59:55 INFO - 'log_name': 'talos', 06:59:55 INFO - 'log_to_console': True, 06:59:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:59:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:59:55 INFO - 'opt_config_files': (), 06:59:55 INFO - 'pip_index': False, 06:59:55 INFO - 'sps_profile': False, 06:59:55 INFO - 'sps_profile_interval': 0, 06:59:55 INFO - 'suite': 'dromaeojs', 06:59:55 INFO - 'system_bits': '32', 06:59:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:55 INFO - 'title': 'talos-linux64-ix-026', 06:59:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:55 INFO - 'use_talos_json': True, 06:59:55 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 06:59:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:55 INFO - 'work_dir': 'build'} 06:59:55 INFO - ##### 06:59:55 INFO - ##### Running clobber step. 06:59:55 INFO - ##### 06:59:55 INFO - Running pre-action listener: _resource_record_pre_action 06:59:55 INFO - Running main action method: clobber 06:59:55 INFO - rmtree: /builds/slave/test-pgo/build 06:59:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 06:59:59 INFO - Running post-action listener: _resource_record_post_action 06:59:59 INFO - ##### 06:59:59 INFO - ##### Running read-buildbot-config step. 06:59:59 INFO - ##### 06:59:59 INFO - Running pre-action listener: _resource_record_pre_action 06:59:59 INFO - Running main action method: read_buildbot_config 06:59:59 INFO - Using buildbot properties: 06:59:59 INFO - { 06:59:59 INFO - "project": "", 06:59:59 INFO - "product": "firefox", 06:59:59 INFO - "script_repo_revision": "production", 06:59:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 06:59:59 INFO - "repository": "", 06:59:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 06:59:59 INFO - "buildid": "20160308043040", 06:59:59 INFO - "pgo_build": "True", 06:59:59 INFO - "basedir": "/builds/slave/test-pgo", 06:59:59 INFO - "buildnumber": 775, 06:59:59 INFO - "slavename": "talos-linux64-ix-026", 06:59:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:59:59 INFO - "platform": "ubuntu64_hw", 06:59:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 06:59:59 INFO - "branch": "mozilla-inbound", 06:59:59 INFO - "repo_path": "integration/mozilla-inbound", 06:59:59 INFO - "revision": "1c4cf5562aa37215e973f1c15b80c412ea9e7bd9", 06:59:59 INFO - "stage_platform": "linux64-pgo", 06:59:59 INFO - "builduid": "f280b13db40b4bb3a382062b3b7fee0b", 06:59:59 INFO - "slavebuilddir": "test" 06:59:59 INFO - } 06:59:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 06:59:59 INFO - Running post-action listener: _resource_record_post_action 06:59:59 INFO - ##### 06:59:59 INFO - ##### Running download-and-extract step. 06:59:59 INFO - ##### 06:59:59 INFO - Running pre-action listener: _resource_record_pre_action 06:59:59 INFO - Running main action method: download_and_extract 06:59:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 06:59:59 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')]} 06:59:59 INFO - https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:59:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:59:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:59:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 06:59:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:00:00 INFO - Downloaded 1361 bytes. 07:00:00 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.test_packages.json 07:00:00 INFO - Using the following test package requirements: 07:00:00 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:00 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:00 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:00 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'jsshell-linux-x86_64.zip'], 07:00:00 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:00 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:00 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:00 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:00 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:00 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:00 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:00 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:00 INFO - https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:01 INFO - Downloaded 23408186 bytes. 07:00:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:00:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:00:02 INFO - Return code: 0 07:00:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:02 INFO - https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:00:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:04 INFO - Downloaded 23408186 bytes. 07:00:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:00:04 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 07:00:06 INFO - Return code: 0 07:00: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')]} 07:00:06 INFO - https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:00:07 INFO - Downloaded 10845161 bytes. 07:00:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 07:00:07 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 07:00:07 INFO - Return code: 0 07:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:07 INFO - https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:00:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:00:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:00:09 INFO - Downloaded 56122646 bytes. 07:00:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:00:09 INFO - mkdir: /builds/slave/test-pgo/properties 07:00:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:00:09 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:00:09 INFO - Contents: 07:00:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:00:10 INFO - Running post-action listener: _resource_record_post_action 07:00:10 INFO - Running post-action listener: set_extra_try_arguments 07:00:10 INFO - ##### 07:00:10 INFO - ##### Running populate-webroot step. 07:00:10 INFO - ##### 07:00:10 INFO - Running pre-action listener: _resource_record_pre_action 07:00:10 INFO - Running main action method: populate_webroot 07:00:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:10 INFO - '--tppagecycles', 07:00:10 INFO - '7'], 07:00:10 INFO - 'tests': ['tsvgm']}}, 07:00:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:00:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:00:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'tests': ['damp', 'tps']}, 07:00:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['damp', 'tps']}, 07:00:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:00:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:10 INFO - 'other': {'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'other_l64': {'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'other_nol64': {'tests': ['a11yr', 07:00:10 INFO - 'ts_paint', 07:00:10 INFO - 'tpaint', 07:00:10 INFO - 'sessionrestore', 07:00:10 INFO - 'sessionrestore_no_auto_restore', 07:00:10 INFO - 'tabpaint']}, 07:00:10 INFO - 'svgr': {'tests': ['tsvgx', 07:00:10 INFO - 'tsvgr_opacity', 07:00:10 INFO - 'tart', 07:00:10 INFO - 'tscrollx', 07:00:10 INFO - 'cart']}, 07:00:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['tsvgx', 07:00:10 INFO - 'tsvgr_opacity', 07:00:10 INFO - 'tart', 07:00:10 INFO - 'tscrollx', 07:00:10 INFO - 'cart']}, 07:00:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'tests': ['tp5o']}, 07:00:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'talos_options': ['--e10s'], 07:00:10 INFO - 'tests': ['tp5o']}, 07:00:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'talos_options': ['--xperf_path', 07:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:10 INFO - 'tests': ['tp5n']}, 07:00:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:10 INFO - 'talos_options': ['--e10s', 07:00:10 INFO - '--xperf_path', 07:00:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:10 INFO - 'tests': ['tp5n']}}, 07:00:10 INFO - 'talos.zip': {'path': '', 07:00:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:10 INFO - Running post-action listener: _resource_record_post_action 07:00:10 INFO - ##### 07:00:10 INFO - ##### Running create-virtualenv step. 07:00:10 INFO - ##### 07:00:10 INFO - Running pre-action listener: _resource_record_pre_action 07:00:10 INFO - Running main action method: create_virtualenv 07:00:10 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:00:10 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 07:00:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:00:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:10 INFO - Using real prefix '/usr' 07:00:10 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:00:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:12 INFO - Installing pip.................done. 07:00:12 INFO - Return code: 0 07:00:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:00:12 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')]} 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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')]} 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:12 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 07:00:12 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 07:00:12 INFO - Using env: {'DISPLAY': ':0', 07:00:12 INFO - 'HOME': '/home/cltbld', 07:00:12 INFO - 'LANG': 'en_US.UTF-8', 07:00:12 INFO - 'LANGUAGE': 'en_US:en', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MAIL': '/var/mail/cltbld', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SHLVL': '1', 07:00:12 INFO - 'TERM': 'linux', 07:00:12 INFO - 'TMOUT': '86400', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - '_': '/tools/buildbot/bin/python'} 07:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:12 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 07:00:12 INFO - Cleaning up... 07:00:12 INFO - Return code: 0 07:00:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:00:12 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')]} 07:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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')]} 07:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:12 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:12 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 07:00:12 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 07:00:12 INFO - Using env: {'DISPLAY': ':0', 07:00:12 INFO - 'HOME': '/home/cltbld', 07:00:12 INFO - 'LANG': 'en_US.UTF-8', 07:00:12 INFO - 'LANGUAGE': 'en_US:en', 07:00:12 INFO - 'LOGNAME': 'cltbld', 07:00:12 INFO - 'MAIL': '/var/mail/cltbld', 07:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:12 INFO - 'MOZ_NO_REMOTE': '1', 07:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:12 INFO - 'NO_EM_RESTART': '1', 07:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:12 INFO - 'SHELL': '/bin/bash', 07:00:12 INFO - 'SHLVL': '1', 07:00:12 INFO - 'TERM': 'linux', 07:00:12 INFO - 'TMOUT': '86400', 07:00:12 INFO - 'USER': 'cltbld', 07:00:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:12 INFO - '_': '/tools/buildbot/bin/python'} 07:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:13 INFO - Downloading/unpacking psutil>=0.7.1 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:13 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 07:00:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:15 INFO - Installing collected packages: psutil 07:00:15 INFO - Running setup.py install for psutil 07:00:15 INFO - building 'psutil._psutil_linux' extension 07:00:15 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 07:00:15 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 07:00:15 INFO - building 'psutil._psutil_posix' extension 07:00:15 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 07:00:15 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 07:00:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:15 INFO - Successfully installed psutil 07:00:15 INFO - Cleaning up... 07:00:15 INFO - Return code: 0 07:00:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:00: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')]} 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:15 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:15 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 07:00:15 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 07:00:15 INFO - Using env: {'DISPLAY': ':0', 07:00:15 INFO - 'HOME': '/home/cltbld', 07:00:15 INFO - 'LANG': 'en_US.UTF-8', 07:00:15 INFO - 'LANGUAGE': 'en_US:en', 07:00:15 INFO - 'LOGNAME': 'cltbld', 07:00:15 INFO - 'MAIL': '/var/mail/cltbld', 07:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:15 INFO - 'MOZ_NO_REMOTE': '1', 07:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:15 INFO - 'NO_EM_RESTART': '1', 07:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:15 INFO - 'SHELL': '/bin/bash', 07:00:15 INFO - 'SHLVL': '1', 07:00:15 INFO - 'TERM': 'linux', 07:00:15 INFO - 'TMOUT': '86400', 07:00:15 INFO - 'USER': 'cltbld', 07:00:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:15 INFO - '_': '/tools/buildbot/bin/python'} 07:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:00:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:00:17 INFO - Installing collected packages: mozsystemmonitor 07:00:17 INFO - Running setup.py install for mozsystemmonitor 07:00:17 INFO - Successfully installed mozsystemmonitor 07:00:17 INFO - Cleaning up... 07:00:17 INFO - Return code: 0 07:00:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 07:00:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:00:17 INFO - Using env: {'DISPLAY': ':0', 07:00:17 INFO - 'HOME': '/home/cltbld', 07:00:17 INFO - 'LANG': 'en_US.UTF-8', 07:00:17 INFO - 'LANGUAGE': 'en_US:en', 07:00:17 INFO - 'LOGNAME': 'cltbld', 07:00:17 INFO - 'MAIL': '/var/mail/cltbld', 07:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:17 INFO - 'MOZ_NO_REMOTE': '1', 07:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:17 INFO - 'NO_EM_RESTART': '1', 07:00:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:17 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:17 INFO - 'SHELL': '/bin/bash', 07:00:17 INFO - 'SHLVL': '1', 07:00:17 INFO - 'TERM': 'linux', 07:00:17 INFO - 'TMOUT': '86400', 07:00:17 INFO - 'USER': 'cltbld', 07:00:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:17 INFO - '_': '/tools/buildbot/bin/python'} 07:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:19 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:00:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:20 INFO - Downloading docopt-0.6.1.tar.gz 07:00:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:20 INFO - Running setup.py install for blobuploader 07:00:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:20 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:00:20 INFO - Running setup.py install for requests 07:00:21 INFO - Running setup.py install for docopt 07:00:21 INFO - Successfully installed blobuploader requests docopt 07:00:21 INFO - Cleaning up... 07:00:21 INFO - Return code: 0 07:00:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:21 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')]} 07:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:21 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')]} 07:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:21 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:21 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 07:00:21 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 07:00:21 INFO - Using env: {'DISPLAY': ':0', 07:00:21 INFO - 'HOME': '/home/cltbld', 07:00:21 INFO - 'LANG': 'en_US.UTF-8', 07:00:21 INFO - 'LANGUAGE': 'en_US:en', 07:00:21 INFO - 'LOGNAME': 'cltbld', 07:00:21 INFO - 'MAIL': '/var/mail/cltbld', 07:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:21 INFO - 'MOZ_NO_REMOTE': '1', 07:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:21 INFO - 'NO_EM_RESTART': '1', 07:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:21 INFO - 'SHELL': '/bin/bash', 07:00:21 INFO - 'SHLVL': '1', 07:00:21 INFO - 'TERM': 'linux', 07:00:21 INFO - 'TMOUT': '86400', 07:00:21 INFO - 'USER': 'cltbld', 07:00:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:21 INFO - '_': '/tools/buildbot/bin/python'} 07:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:21 INFO - Running setup.py (path:/tmp/pip-nYcPHP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:21 INFO - Running setup.py (path:/tmp/pip-eprsNi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:21 INFO - Running setup.py (path:/tmp/pip-yWwCxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:21 INFO - Running setup.py (path:/tmp/pip-m2iKcH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:21 INFO - Running setup.py (path:/tmp/pip-mAXPHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:21 INFO - Running setup.py (path:/tmp/pip-Lzyf6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:21 INFO - Running setup.py (path:/tmp/pip-d0juhT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:21 INFO - Running setup.py (path:/tmp/pip-SLCc6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:22 INFO - Running setup.py (path:/tmp/pip-OWkCz_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:22 INFO - Running setup.py (path:/tmp/pip-NGSn4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:22 INFO - Running setup.py (path:/tmp/pip-kldVqp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:22 INFO - Running setup.py (path:/tmp/pip-EtVIBg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:22 INFO - Running setup.py (path:/tmp/pip-_zCw8b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:22 INFO - Running setup.py (path:/tmp/pip-Tz0zk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:22 INFO - Running setup.py (path:/tmp/pip-N_0Got-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:22 INFO - Running setup.py (path:/tmp/pip-bHnRHS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:22 INFO - Running setup.py (path:/tmp/pip-e3X2WV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:22 INFO - Running setup.py install for manifestparser 07:00:22 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:00:22 INFO - Running setup.py install for mozcrash 07:00:22 INFO - Running setup.py install for mozdebug 07:00:22 INFO - Running setup.py install for mozdevice 07:00:23 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozfile 07:00:23 INFO - Running setup.py install for mozhttpd 07:00:23 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozinfo 07:00:23 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozInstall 07:00:23 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozleak 07:00:23 INFO - Running setup.py install for mozlog 07:00:23 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for moznetwork 07:00:23 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozprocess 07:00:23 INFO - Running setup.py install for mozprofile 07:00:23 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:00:23 INFO - Running setup.py install for mozrunner 07:00:24 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:00:24 INFO - Running setup.py install for mozscreenshot 07:00:24 INFO - Running setup.py install for moztest 07:00:24 INFO - Running setup.py install for mozversion 07:00:24 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:00:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:24 INFO - Cleaning up... 07:00:24 INFO - Return code: 0 07:00:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:24 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')]} 07:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:24 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')]} 07:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:24 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:24 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 07:00:24 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 07:00:24 INFO - Using env: {'DISPLAY': ':0', 07:00:24 INFO - 'HOME': '/home/cltbld', 07:00:24 INFO - 'LANG': 'en_US.UTF-8', 07:00:24 INFO - 'LANGUAGE': 'en_US:en', 07:00:24 INFO - 'LOGNAME': 'cltbld', 07:00:24 INFO - 'MAIL': '/var/mail/cltbld', 07:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:24 INFO - 'MOZ_NO_REMOTE': '1', 07:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:24 INFO - 'NO_EM_RESTART': '1', 07:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:24 INFO - 'SHELL': '/bin/bash', 07:00:24 INFO - 'SHLVL': '1', 07:00:24 INFO - 'TERM': 'linux', 07:00:24 INFO - 'TMOUT': '86400', 07:00:24 INFO - 'USER': 'cltbld', 07:00:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:24 INFO - '_': '/tools/buildbot/bin/python'} 07:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:24 INFO - Running setup.py (path:/tmp/pip-QR7Gp0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:24 INFO - Running setup.py (path:/tmp/pip-TXpVMx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:24 INFO - Running setup.py (path:/tmp/pip-uR7DbD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:24 INFO - Running setup.py (path:/tmp/pip-lFnMxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:00:24 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)) 07:00:24 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:24 INFO - Running setup.py (path:/tmp/pip-cgg4xd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:25 INFO - Running setup.py (path:/tmp/pip-V1rwdN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:25 INFO - Running setup.py (path:/tmp/pip-oc2QSA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:25 INFO - Running setup.py (path:/tmp/pip-iskseQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:25 INFO - Running setup.py (path:/tmp/pip-_OCP4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:25 INFO - Running setup.py (path:/tmp/pip-34_jWM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:25 INFO - Running setup.py (path:/tmp/pip-qwYK13-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:25 INFO - Running setup.py (path:/tmp/pip-95cT2J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:25 INFO - Running setup.py (path:/tmp/pip-ByLfs3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:25 INFO - Running setup.py (path:/tmp/pip-VdZ35z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:25 INFO - Running setup.py (path:/tmp/pip-iUiltv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:25 INFO - Running setup.py (path:/tmp/pip-ouZTOw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:00:25 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)) 07:00:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:25 INFO - Running setup.py (path:/tmp/pip-U8DrPu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 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)) 07:00:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:25 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 07:00:25 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 07:00:25 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 07:00:25 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 07:00:25 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 07:00:25 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 07:00:27 INFO - Downloading blessings-1.6.tar.gz 07:00:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:27 INFO - Installing collected packages: blessings 07:00:27 INFO - Running setup.py install for blessings 07:00:27 INFO - Successfully installed blessings 07:00:27 INFO - Cleaning up... 07:00:27 INFO - Return code: 0 07:00:27 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:00:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:28 INFO - Reading from file tmpfile_stdout 07:00:28 INFO - Current package versions: 07:00:28 INFO - argparse == 1.2.1 07:00:28 INFO - blessings == 1.6 07:00:28 INFO - blobuploader == 1.2.4 07:00:28 INFO - docopt == 0.6.1 07:00:28 INFO - manifestparser == 1.1 07:00:28 INFO - mozInstall == 1.12 07:00:28 INFO - mozcrash == 0.17 07:00:28 INFO - mozdebug == 0.1 07:00:28 INFO - mozdevice == 0.48 07:00:28 INFO - mozfile == 1.2 07:00:28 INFO - mozhttpd == 0.7 07:00:28 INFO - mozinfo == 0.9 07:00:28 INFO - mozleak == 0.1 07:00:28 INFO - mozlog == 3.1 07:00:28 INFO - moznetwork == 0.27 07:00:28 INFO - mozprocess == 0.22 07:00:28 INFO - mozprofile == 0.28 07:00:28 INFO - mozrunner == 6.11 07:00:28 INFO - mozscreenshot == 0.1 07:00:28 INFO - mozsystemmonitor == 0.0 07:00:28 INFO - moztest == 0.7 07:00:28 INFO - mozversion == 1.4 07:00:28 INFO - psutil == 3.1.1 07:00:28 INFO - requests == 1.2.3 07:00:28 INFO - wsgiref == 0.1.2 07:00:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 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)) 07:00:28 INFO - Cleaning up... 07:00:28 INFO - Return code: 0 07:00:28 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:28 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:28 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 07:00:28 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 07:00:28 INFO - Using env: {'DISPLAY': ':0', 07:00:28 INFO - 'HOME': '/home/cltbld', 07:00:28 INFO - 'LANG': 'en_US.UTF-8', 07:00:28 INFO - 'LANGUAGE': 'en_US:en', 07:00:28 INFO - 'LOGNAME': 'cltbld', 07:00:28 INFO - 'MAIL': '/var/mail/cltbld', 07:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:28 INFO - 'MOZ_NO_REMOTE': '1', 07:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:28 INFO - 'NO_EM_RESTART': '1', 07:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:28 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:28 INFO - 'SHELL': '/bin/bash', 07:00:28 INFO - 'SHLVL': '1', 07:00:28 INFO - 'TERM': 'linux', 07:00:28 INFO - 'TMOUT': '86400', 07:00:28 INFO - 'USER': 'cltbld', 07:00:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:28 INFO - '_': '/tools/buildbot/bin/python'} 07:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:28 INFO - Downloading/unpacking jsonschema 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:28 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 07:00:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:30 INFO - Downloading/unpacking functools32 (from jsonschema) 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 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 07:00:30 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:30 INFO - warning: no files found matching '*.txt' 07:00:30 INFO - no previously-included directories found matching 'build' 07:00:30 INFO - no previously-included directories found matching 'dist' 07:00:30 INFO - no previously-included directories found matching '.git*' 07:00:30 INFO - Installing collected packages: jsonschema, functools32 07:00:30 INFO - Running setup.py install for functools32 07:00:30 INFO - warning: no files found matching '*.txt' 07:00:30 INFO - no previously-included directories found matching 'build' 07:00:30 INFO - no previously-included directories found matching 'dist' 07:00:30 INFO - no previously-included directories found matching '.git*' 07:00:30 INFO - Successfully installed jsonschema functools32 07:00:30 INFO - Cleaning up... 07:00:30 INFO - Return code: 0 07:00:30 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:30 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 0x7f6713486f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be96d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, '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': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', '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 07:00:30 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 07:00:30 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 07:00:30 INFO - Using env: {'DISPLAY': ':0', 07:00:30 INFO - 'HOME': '/home/cltbld', 07:00:30 INFO - 'LANG': 'en_US.UTF-8', 07:00:30 INFO - 'LANGUAGE': 'en_US:en', 07:00:30 INFO - 'LOGNAME': 'cltbld', 07:00:30 INFO - 'MAIL': '/var/mail/cltbld', 07:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:30 INFO - 'MOZ_NO_REMOTE': '1', 07:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:30 INFO - 'NO_EM_RESTART': '1', 07:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:30 INFO - 'SHELL': '/bin/bash', 07:00:30 INFO - 'SHLVL': '1', 07:00:30 INFO - 'TERM': 'linux', 07:00:30 INFO - 'TMOUT': '86400', 07:00:30 INFO - 'USER': 'cltbld', 07:00:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:30 INFO - '_': '/tools/buildbot/bin/python'} 07:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:31 INFO - Downloading/unpacking flake8 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:31 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 07:00:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:00:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:33 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 07:00:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:00:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:00:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:34 INFO - no previously-included directories found matching 'docs/_build' 07:00:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:00:34 INFO - Running setup.py install for pep8 07:00:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:00:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:00:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:00:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:00:34 INFO - no previously-included directories found matching 'docs/_build' 07:00:34 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:00:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:00:34 INFO - Cleaning up... 07:00:34 INFO - Return code: 0 07:00:34 INFO - Running post-action listener: _resource_record_post_action 07:00:34 INFO - Running post-action listener: _start_resource_monitoring 07:00:34 INFO - Starting resource monitoring. 07:00:34 INFO - ##### 07:00:34 INFO - ##### Running install step. 07:00:34 INFO - ##### 07:00:34 INFO - Running pre-action listener: _resource_record_pre_action 07:00:34 INFO - Running main action method: install 07:00:34 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:00:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:00:35 INFO - Reading from file tmpfile_stdout 07:00:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:00:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:00:35 INFO - Reading from file tmpfile_stdout 07:00:35 INFO - Output received: 07:00:35 INFO - Usage: mozinstall [options] installer 07:00:35 INFO - Options: 07:00:35 INFO - -h, --help show this help message and exit 07:00:35 INFO - -d DEST, --destination=DEST 07:00:35 INFO - Directory to install application into. [default: 07:00:35 INFO - "/builds/slave/test-pgo"] 07:00:35 INFO - --app=APP Application being installed. [default: firefox] 07:00:35 INFO - mkdir: /builds/slave/test-pgo/build/application 07:00:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 07:00:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 07:00:51 INFO - Reading from file tmpfile_stdout 07:00:51 INFO - Output received: 07:00:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:00:51 INFO - Running post-action listener: _resource_record_post_action 07:00:51 INFO - ##### 07:00:51 INFO - ##### Running run-tests step. 07:00:51 INFO - ##### 07:00:51 INFO - Running pre-action listener: _resource_record_pre_action 07:00:51 INFO - Running main action method: run_tests 07:00:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:00:51 INFO - Python 2.7.3 07:00:51 INFO - Return code: 0 07:00:51 INFO - grabbing minidump binary from tooltool 07:00: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')]} 07:00:51 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 0x2c78920>, '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 0x2c79820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c79cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:00:51 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 07:00:51 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 07:00:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:51 INFO - Return code: 0 07:00:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:00:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:00:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:00:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:00:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:00:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:00:52 INFO - Return code: 0 07:00:52 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 07:00:52 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 07:00:52 INFO - Using env: {'DISPLAY': ':0', 07:00:52 INFO - 'HOME': '/home/cltbld', 07:00:52 INFO - 'LANG': 'en_US.UTF-8', 07:00:52 INFO - 'LANGUAGE': 'en_US:en', 07:00:52 INFO - 'LOGNAME': 'cltbld', 07:00:52 INFO - 'MAIL': '/var/mail/cltbld', 07:00:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:52 INFO - 'MOZ_NO_REMOTE': '1', 07:00:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:52 INFO - 'NO_EM_RESTART': '1', 07:00:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 07:00:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:00:52 INFO - 'SHELL': '/bin/bash', 07:00:52 INFO - 'SHLVL': '1', 07:00:52 INFO - 'TERM': 'linux', 07:00:52 INFO - 'TMOUT': '86400', 07:00:52 INFO - 'USER': 'cltbld', 07:00:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094', 07:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:52 INFO - '_': '/tools/buildbot/bin/python'} 07:00:52 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:00:52 INFO - mozversion application_buildid: 20160308043040 07:00:52 INFO - mozversion application_changeset: 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 07:00:52 INFO - mozversion application_display_name: Nightly 07:00:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:52 INFO - mozversion application_name: Firefox 07:00:52 INFO - mozversion application_remotingname: firefox 07:00:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:52 INFO - mozversion application_vendor: Mozilla 07:00:52 INFO - mozversion application_version: 47.0a1 07:00:52 INFO - mozversion platform_buildid: 20160308043040 07:00:52 INFO - mozversion platform_changeset: 1c4cf5562aa37215e973f1c15b80c412ea9e7bd9 07:00:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:00:52 INFO - mozversion platform_version: 47.0a1 07:00:52 INFO - using testdate: 1457449252 07:00:52 INFO - actual date: 1457449252 07:00:52 INFO - starting webserver on 'localhost:37059' 07:00:52 INFO - SUITE-START | Running 2 tests 07:00:52 INFO - TEST-START | dromaeo_css 07:00:52 INFO - operating with platform_type : linux_ 07:00:52 INFO - Initialising browser for dromaeo_css test... 07:00:52 INFO - TEST-INFO | started process 18770 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3UC7Y5/profile http://localhost:37059/getInfo.html) 07:00:56 INFO - PROCESS | 18770 | __metrics Screen width/height:1600/1200 07:00:56 INFO - PROCESS | 18770 | colorDepth:24 07:00:56 INFO - PROCESS | 18770 | Browser inner width/height: 1024/697 07:00:56 INFO - PROCESS | 18770 | __metrics 07:00:57 ERROR - PROCESS | 18770 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:00:58 INFO - TEST-INFO | 18770: exit 0 07:00:58 INFO - Browser initialized. 07:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:58 INFO - TEST-INFO | started process 18864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3UC7Y5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:10 INFO - PROCESS | 18864 | RSS: Main: 154066944 07:01:10 INFO - PROCESS | 18864 | 07:02:01 INFO - PROCESS | 18864 | 1457449321573 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] 07:04:09 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37059/tests/dromaeo/cssquery-ext.html) 07:04:10 INFO - PROCESS | 18864 | RSS: Main: 254205952 07:04:10 INFO - PROCESS | 18864 | 07:07:12 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-ext.html (next: http://localhost:37059/tests/dromaeo/cssquery-jquery.html) 07:07:13 INFO - PROCESS | 18864 | RSS: Main: 240824320 07:07:13 INFO - PROCESS | 18864 | 07:10:15 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37059/tests/dromaeo/cssquery-mootools.html) 07:10:15 INFO - PROCESS | 18864 | RSS: Main: 240140288 07:10:15 INFO - PROCESS | 18864 | 07:13:17 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37059/tests/dromaeo/cssquery-prototype.html) 07:13:18 INFO - PROCESS | 18864 | RSS: Main: 206299136 07:13:18 INFO - PROCESS | 18864 | 07:16:20 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37059/tests/dromaeo/cssquery-yui.html) 07:16:21 INFO - PROCESS | 18864 | RSS: Main: 218783744 07:16:21 INFO - PROCESS | 18864 | 07:19:23 INFO - PROCESS | 18864 | Cycle 1(1): loaded http://localhost:37059/tests/dromaeo/cssquery-yui.html (next: http://localhost:37059/tests/dromaeo/cssquery-dojo.html) 07:19:24 INFO - PROCESS | 18864 | RSS: Main: 261820416 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | __start_tp_report 07:19:24 INFO - PROCESS | 18864 | _x_x_mozilla_page_load 07:19:24 INFO - PROCESS | 18864 | _x_x_mozilla_page_load_details 07:19:24 INFO - PROCESS | 18864 | |i|pagename|runs| 07:19:24 INFO - PROCESS | 18864 | |0;dojo.html;3151.3382189740155;3200.775945683803;3230.4185246655593;3232.838358082097;3259.6740325967407;5150.407703114143;5244.344456942882;5254.894902101961;5263.131583288762;5316.069687804633;5217.895642087156;5244;5253.8949221015655;5281.155015197569;5320.920186197211;4662.7901744421415;4725.338452616628;4819.879503012417;4897.926531102036;4916.213405855064;4732.290156476522;4778.952210477903;4876.122297986379;4878.975605121969;4997.575206107485;4787.8563643090765;4788.80844766209;4800.207965685658;4839.854804355858;4849.321095046678;4799.784009719571;4802.495737947535;4823.831165909176;4832.613390928717;4834;4665.813367465297;4738.739369334685;4810.542998415145;4819.903601927942;4849.466558678542;5178.249153872667;5196.714180720097;5201.713905735183;5203.453637368098;5212.687238765686;5651.886962260773;5685.914711279334;5693.032184528599;5695.77216911323;5709.971450142764;5514.91727624086;5675.3757086720425;5703.429657034305;5727.3699893011735;5767.5962682612235;5223.843284701465;5252.947470525322;5261.105612045962;5262.815801446969;5264.921026184572;5723.570732195102;5728;5744.856378590569;5753.654780713171;5778.393268706809;5452.509274165344;5521.033819081645;5529.4470552944385;5542.4734650208975;5579.525740312038;5671.347795003628;5676.460736230051;5681.715914204273;5685.857853553694;5692.0323544997445;5499.395066542677;5628.774849005994;5640.633358831663;5646.915296270559;5649.322081350182;5574.9721251393485;5605.243292155506;5608.747606357723;5614.550835933115;5669.092945128842;4241.130568233505;4244.172386384687;4251.29853574163;4252.128313695685;4283.7429754214845;3728.7203459740626;3857.8649747259274;3877.786721730332;3896.357101078347;3899.473571067926;5209.088409528393;5221.347331583552;5221.973890130601;5230.08473517133;5255.369355677343;5626.803061892896;5642.802501912413;5649.576281778883;5662.037453632893;5662.433756624387;5128.820491282787;5240.71176085319;5243.816466423733;5245.606579506552;5292.2326262691695;4857.0528746894015;4858.076965376567;4864.124457597666;4865.95134048662;4906.852794416173;5949.762009519657;5956.344802071855;5964.343922168558;5965.761369545169;5966.164736936832;5463.672179669233;5611.579131565068;5726.770929162787;5732.34078081026;5780.017397042597;5831.766729330949;5836.445537673914;5837.0368889132815;5842.941570584409;5886.823395298148;5487.4238204987905;5532.834014979557;5533.335999680065;5537.5569954404355;5552.500274975271;5493.642913210629;5630.408807075198;5634.802781902614;5635.746391412315;5636.1827535008015;5527.005139074844;5529.529989950899;5532.944670553243;5538.196961440649;5581.49766521015;5509.559235261089;5510.752016159202;5516.475934786189;5520.420355862577;5525.696086715269;5315.787368505216;5332.653377530603;5404.621676482609;5424.1321388577635;5447.863803404946;5523.7790488380015;5531.059719847555;5537.584681149011;5561.3882472927135;5585.441455854545;5362.865928351823;5368.275282836923;5370.892582148414;5375.3280839895015;5376.59675524345 07:19:24 INFO - PROCESS | 18864 | |1;ext.html;512.3390825834673;526.7550588976126;552.1469329885326;606.5753972219446;613.4417679911279;30061.24846878829;30659.233519162004;38301.42547861784;38905.80547097268;38970.22059558807;35491.4676279856;35558.11104722383;35782.82108589453;35875.82062089693;36148.27703445936;8583.742487725378;8744.30045596354;8790.34072444566;8805;8807.603657835381;8579.571021448903;8665.870011949826;8720.040795512488;8725.127487251288;8734.432261902988;8694.260987816044;8794.208521233088;9012.188902998729;9026.593803278869;9032.729018129467;8908.064653211384;8968.910310896872;8979.416337938013;8983.10168983103;8987.64049438025;8848.380613357067;8939;8966.68616598416;8985.640574377017;8991.640334386617;42325.78837105795;42780.144397111886;42906.57093429057;42937.78531107325;42963.35554966678;2922.649282086163;3298.6371499135075;3605.2068544920076;3612.584552776438;3723.94414083789;29906.252343691365;31057.22356941072;31221.219469513217;31282.687173128204;31299.37401251985;3975;3981.1838573092737;4082.755034697928;4104;4158.189153115144;275758;277066;277515;278761;278940;62097;62542.687286563276;62861.68569157125;62915.685421573515;63060.36939630637;50506.74746626243;50634;50872.675822555495;51040.74479627652;51138.232926506134;15769.605759856095;15970.680586388207;15976.600584985468;15990.920045399931;16008.119553424673;12017.278963262232;12057.698557536132;12073.698157545956;12076.818847717292;12095.818562721566;18587.469582807982;20261.493462663257;20333.59332813365;20478.078486468145;20568.588628227353;5252.842414727565;7144.642767861586;7236.565806051653;7352.669129889167;7402.444816638774;936.9203617692436;1002.5839276700234;1005.597760895633;1018.7300365403174;1025.1491262252312;27397.589036164474;27736;29307;30074.849625751733;30174;1028.922830787694;1070.0797314309686;1107.4075369677184;1148.104478506766;1158.2702897174727;15391.3073911672;15452.38190472391;15531.5340539784;15724.213789310488;15783.842161578466;339909;345674.53115547914;346380;346719;346860;55199.44800551943;56048;56189;56204.71897640486;56285.7185714077;1147.2485521983115;1235.215638069814;1307.6730817295677;1339.7588434081763;1348.265195468472;26137.215883523524;26547;27033.45933081367;27172.864135679196;27258.45483090367;39279.41080883846;39498.40752388774;39576.80211599039;39627.60372396239;39663.603363965995;184282;188859;189372;189743;189843;28079.43841123207;32005.35989280155;32265.838670806497;33301.16747081342;33345.49981750227;39049.414258785575;39568.80215598903;39644.801775990934;40310.39534406928;40655.7967210162;33056.83471582627;33347.33305333831;33512;33609.327813444084;33880.3223935515;33624.49563256602;34053.148671283416;34352.82823585866;34412.82793586116;36917.26165476622;33324;33354.499682505266;33432.665673342955;33472.163195919326;33899;30902;31230.21924451907;32355.51466728048;32416.67583324231;32630.83684581562;24547.140850070162;25191.622125667764;25265.242042738748;25454.872725636254;25663.871680641478 07:19:24 INFO - PROCESS | 18864 | |2;jquery.html;360.9909752256194;365.7366695978896;370.46282889809777;376.2456275168289;377.945197946298;16860.83139168608;17543.298268069262;18667.439976800702;19129.139188736506;19136.617267654638;14644.633884152901;14647.780283295759;14654.633634159125;14673.413063477476;14750.778738318933;4009.954922989282;5500.28496295481;5617.466340697627;5666.631668941526;5680.403557626451;5575.581831362644;5578.470045345706;5582.692951887645;5607.719614019303;5632.183333416652;5395.244665746799;5515.448455154473;5550.056490396622;5557.166425036236;5608.831735047955;5476.507114359707;5537.58468114891;5538.47384498472;5540.058190107691;5552.583556233279;4899.6080313575185;4925.310456536088;5094.4650811664615;5269.578433725331;5277.70972596507;12330.5067797288;12378;12440.626781196579;12547.309897955609;15438.922805386013;2060.206820374152;2109.546447513792;2133.9466513337134;2138.2729871843494;2245.6631505274177;9515.952420237923;9796.069373409515;10402.427866467342;11019.063379612742;13277.53528626503;1856.1090676475233;1865.3750993417223;1915.4636701723539;1966.6066786642587;2096.14058236124;62002.68998655023;63597;63775.36224637741;64614.67692661554;66888.6655566724;10330.173586113093;10332.225083118796;10409.479526023668;10666;10804.945975270231;14119.71760564783;14203.218822964629;14206.502772402917;14217.573472795833;14248.643783905485;7510.962445187739;7548.5470871747875;7603.885941710879;7659.234076592296;7870.134285228621;7189.856202876018;7209.0628218331285;7429.591372474566;7550.35821955129;7553.697852085855;4597.678162528591;4682.297655351656;4709.905801883943;4741.2176990796825;4741.810327586858;1754.921028553718;1760.9911950440166;1878.8778729382545;1905.4855189098867;1908.2557802457052;881.6120906800987;892.5403417240127;925.4262357338494;927.7077720518015;931.9906800931903;16589.17054147288;17351.39270125565;17437.73843392325;17474.912625437046;17739;899.1817446124127;933.6405483888616;956.0487315121499;979.7256768104942;1003.7039073473343;9355.812883742286;9669.419834809934;9711;9952.10431061208;10093.845482322195;336049;342257;345111;345493;405273.52538271697;63916;75980;80969.59515202386;81020.59489702631;85618.14381856102;1007.7027276953316;1023.6110278094277;1033.8190816607064;1039.9168066554657;1048.926575139733;15791.526254212393;15919.28363223681;16219.18904054816;16236.02583844973;16315.102669352826;35056;35484.29031419409;36155.63844361628;36417.63582364142;36798;45495.54504454913;47026;51647.483525164265;52729;53177.7341113292;7859.882101768592;8135.75592732219;8151.877721834296;8206.384521161057;8215.301699355383;8493;10427.94786026065;12023.398830058637;12681.492740290285;12859.549915753278;10919.945400272947;11103.111751060058;11179.385133817717;11289.830652540382;11389.12079506872;10696.732581685521;10804.891951080703;11045;11160.162987775788;11380.089592832388;11011.174161937726;11227;11234.775304494027;11459.369734664673;11477.08183345347;7843.137254901842;7969.72105976288;8004;8161.836763264582;8282.047564529916;10525.684229473129;11163.051140653135;11295;11305.491252893804;11348.092152627605 07:19:24 INFO - PROCESS | 18864 | |3;mootools.html;1276.8531618863833;1478.844721304263;1508.8792896568275;1680.4286542575521;1810.3844692804444;6733.39399454049;7292.9635351823235;7419.962900185492;7423.703051877925;7428.1086269647585;7397.63011849408;7603.619819009041;7613.314801667849;7617.3906087513005;7623.923760762391;1989.2341448542343;2031.0454086579284;2198.5163264081875;2202.2622421488823;2226.220822712046;2260.683504309398;2268.931932042033;2269.8184145268337;2270.5004898922293;2271.3072512883564;2183.279517759144;2212.126210146991;2220.66689996501;2248.9662655060188;2250.729912410513;2204.4599073227164;2232.4976880201907;2235.228846048119;2237.3511681612313;2237.8209743220505;2192.254633424643;2213.3249358945513;2213.8007579317937;2213.900374483152;2217.2904670505445;7771.805704857424;7841.372690184771;7845.9607701961695;7849.960750196269;7852.882206766903;4423.402840616508;4514.616257618107;4520.570545798144;4531.864044078683;4556.749378784166;2928.7803414743767;2970.376220993594;3112.817129490779;3116.0963320637215;3137.200013996416;947.2989987409268;954.656323723459;998.4957596413765;1004.4877112672517;1005.4168582222294;10447.05976462122;10449.373037617692;10462.790744185073;10467.528961196764;10477.79044419115;4180.728252663567;4236.491621005499;4283.87148385549;4302.655787537052;4307.224699554048;8737.475751454933;8746.037935827182;8772.03507614162;8777.956110219407;8784.462719024144;4552.11233809404;4603.838865639686;4607.7004994675235;4611.432113081569;4611.654125940501;3697.574778900407;4063.2076745034433;4108.034611866209;4134.255833949918;4171.791410429527;3631.6368363164;3694.9630503695157;3695.316366472211;3712.7029837612927;3745.9812700936322;1184.8281999110081;1193.0336427493758;1198.6344165029575;1199.2145144930084;1223.4311045363947;1069.1126365116934;1070.0904231403244;1072.84443755655;1224.6693392784077;1348.1304558559675;7287.417006639456;7361.30067643573;7396.96301518489;7397.741079062207;7414.221506741822;460.7120549656465;461.2619808306682;465.32527834639234;466.4961841211551;476.91653960556766;5588.469095435927;5637.774489020475;5661.34894487131;5700.657960522382;5703.543716502752;9030.096990300917;9275.21160701348;9534.380265282734;9538.189253913357;9553.713388598353;9241.907580924239;9258.120478554527;9261.629534818667;9279.72160835176;9304.72085837426;6900.378965893094;7065.964670176616;7221.638918054076;7362.558246505227;7366.889496657447;6900.965495172492;6931.445484361138;6947.895781563179;6956.234814170336;7075.646217688992;7982.521048737094;8138.064122625974;8315.210055044761;8376.706815261681;8406.369522285975;8051.074126475296;8098.87851682237;8119.675212991414;8272.090070092405;8301.169883011651;6379.936200637934;6511.38141876521;6512.348765123639;6525.869482610226;6746.359095885883;6983.476239281973;7005.964970175117;7020.613866237406;7024.227334993249;7024.5082844200415;6291.716872740646;6420.036994450869;6469.159009328757;6487.610743355413;6567.146270984741;6324.810255692337;6376.330485298977;6402.327755585597;6412.038194270896;6453.515986300952;6661.900071499028;6665.900011499928;6700.329967003456;6706.530542861953;6713.328667133248;6347.523935704933;6377.394147555975;6381.744730210739;6395.328490508429;6406.775762848278;6347.904781428375;6356.269029061532;6360.395762402564;6378.872422551616;6397.456216221487 07:19:24 INFO - PROCESS | 18864 | |4;prototype.html;348.5660352860688;349.38682612015907;349.46357341480825;349.8653018587843;356.5151394104018;5848.6490810551395;5857.26784151981;5871.2367392239;5909.497692696115;5928.288605367351;5851.297844258695;5853.268341457318;5853.76584936602;5853.970730146343;5860.912086318698;4369.825206991733;4422.402975598286;4509.909801803962;4537.115262523809;4579.839705610304;4502.77486125694;4526;4528.04910968697;4540.614047805941;4548.31775233716;4442.044960333527;4470.664700147486;4480.574345437179;4480.910381792362;4485.372047913294;4315.395844581761;4402.801873915681;4462.107578484283;4500.054988452429;4511.368408422791;3955.782431966241;3957.6240257175523;3962.881113566598;3963.425303331001;3970.7021973351825;5606.243157173811;5615.2700148980375;5625.353084395306;5635.267415236034;5643.153526970947;5244.842654720364;5265.183896496049;5273.551748101416;5277.973610131963;5284.788608455658;6221.066839973995;6224.875502489925;6225.28409232935;6233.750649973996;6234.594751341194;4135.545090040093;4251.171021650779;4259.233337999159;4412.514623391457;4422.115576884636;6389.872202555923;6417.294097649255;6425.261094974045;6457.483401327882;6492.675366231717;4365.869023929287;4368.847090351886;4370.694051416434;4371.540988196257;4383.408239887574;4439.823446786604;4442.089371678798;4444.266695995125;4444.711093778894;4447.065526495984;5154.123798954187;5160.406553246425;5160.845174644766;5165.690058596496;5166.9224961625605;6052.303985041688;6244.625322480666;6250.9062364064575;6260.874782504325;6266.49868010558;1547.8916475846584;1585.2549301828121;1592.3153044190879;1592.585927658794;1598.328701945186;980.5538479991586;1011.7268337548968;1014.2798612984864;1037.4812593703148;1050.9842352364722;5809.88380232393;5820.650760954356;5860.765569377178;5862.355140934494;5874.236349274567;6355.237371515448;6357.8383349661335;6362.6500542469685;6372.203474565679;6374.171357723466;5857.824265272048;5864.2083318752275;5870.5890587659305;5871.207387002785;5872.207252021008;3393.474011528217;3424.0241531163997;3427.503012063237;3429.416999110157;3429.6913277805115;6505.3819887111595;6596.505262105361;6607.174103237096;6745.258021617618;6753.763618273337;6615.073889655452;6652.567583107082;6653.667316634149;6656.234533028667;6665.233498147678;6648.700808463534;6704.296048914891;6708.899366509506;6727.831804204836;6733.494987875831;6472.579282346633;6487;6544.44372228366;6552.115464412243;6559.540832141895;6148.631082135086;6354.682265886595;6399.712012959521;6406;6410.423061924449;6643.368879956396;6686.197656281277;6689.832754181184;6698.698558564974;6702.061711360316;4409;4435.846679863194;4436.423264975532;4453.042595841909;4453.0871171409135;6433.099366088845;6447.194100737408;6452.935470645421;6483.805485835433;6529.5102867284195;6211.254649442096;6256.7810126645345;6258.342873998165;6261.060840873905;6264.091706702594;6068.302145253352;6280;6292.748290068529;6305.716242768995;6307.274663413767;6095.695215239131;6131.724072416663;6133.417325354084;6136.048912418582;6143.877122457437;6277.2781130170615;6303.779367722108;6306.054091886253;6316.210473690789;6316.557840951273;5887.087501437284;5955.821325360246;6133.202683651275;6146;6154.692265386623 07:19:24 INFO - PROCESS | 18864 | |5;yui.html;683.2723149845415;685.2873012067447;714.2000958926004;718.5114122396768;779.5283853268771;13342.799858002125;13609;13626.863731362684;13638.249896255715;13640.863591364083;13415.262160581164;13468.326583670801;13498.797518037238;13511.391987360568;13516.93241533791;844.4933040175891;866.5234121233328;867.3234876796078;867.8437881181385;868.2099289646424;852.8933883264592;854.2311919272643;857.9742607721778;860.2558786649535;860.7116615933638;890.1276748786194;892.1435421994893;892.4243862708549;892.8258989497051;893.1559676106083;879.0198928195049;880.1638443478721;882.2368651116802;884.7168905950099;885.0927799006038;649.9285078641345;652.1456891472187;652.6932341799394;653.2781276689237;653.6731634182909;14396.856031439656;14448.71102577953;14484.1309521428;14499.42002319906;14509;12076.456559454758;12167;12229.694257643541;12358.505659773598;12622.81065784014;10377.481125943748;10554.630587929385;10596.629117980834;10896.18278629106;11237.943810280978;3521.4893840393;3587.246678197582;3607.080194550399;3722.1997270586953;3726.2920045191327;47736.52263477355;48007.519924800654;48029.51970480286;48217.75891120557;48277;9433.198178154933;9444.244460443148;9930.106290433896;10146.797064058677;10164;16972;17010.938031154263;17014.57463563421;17022.40421585263;17048.14759262032;7589.924100758922;7675.846483070307;7848.0974687910475;7969.203079692101;8022.1175670676175;4343.131373725268;4390.4511936008;4427.446569178853;4467.5755803198645;4686.015936653273;3140.2149462634343;3142.4500712375243;3164.5886034815326;3172.6034245719284;3190.3619276144864;564.1481363141686;565.8755073883739;573.4408951272559;574.1072632057108;579.495838620403;590.7282649980971;601.6209787833724;621.9937800622026;636.0935666674969;652.1749986267375;7836.882446763303;7995.1605081465605;8001.719939802079;8017.118117007125;8051.315638170704;559.3930585314897;603.1345019896463;611.3275397063195;619.6746707978257;632.9493640508748;3598.395175558802;3651.1602331463914;3762.3415902217002;3764.661180493769;3858.498395208605;58322.41677583255;59122;59696;59766.70116649476;60069.39930600638;41883.58116418797;44291.55708442939;51438.22842657363;52383;52587.474125259025;43577.34633980493;43764.562354376685;44109.55890441054;44329;44563.33155002613;7776.144624091232;7856.764297071097;8160.30637395828;8176.100628930694;8178.591070446335;32805.83597081999;33422.164445889044;33459.498107528896;33808.830955845064;33893.83053084817;42465.787671061444;42518;46590.53409465862;47394.76302618465;48077;10922.18083643714;11006.944965275123;11014.724631884266;11130.610428634958;11372.260803047775;10981.286216395909;11036.944815275872;11117.388543630179;11211.439428028729;11316.717082073013;10071.312771650011;10266.332688375232;10274.178065754872;10291.073803357735;10701.946490267499;10147.137493313152;10298;10619.522121504706;10627.202959777893;10817.657736729505;10065.547050382604;10509.632162874263;10740.140788737039;10753.354798712102;11188.944055279671;8057.453840610369;8330.333573314;8555.272801811667;9006.189442950166;9097.818043639223;8584.442011269248;8602;8673.739787806377;9200.769980750534;9236.635551043759 07:19:24 INFO - PROCESS | 18864 | __end_tp_report 07:19:24 INFO - PROCESS | 18864 | __start_cc_report 07:19:24 INFO - PROCESS | 18864 | _x_x_mozilla_cycle_collect,822 07:19:24 INFO - PROCESS | 18864 | __end_cc_report 07:19:24 INFO - PROCESS | 18864 | __startTimestamp1457450364225__endTimestamp 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | ------- Summary: start ------- 07:19:24 INFO - PROCESS | 18864 | Number of tests: 6 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#0] dojo.html Cycles:165 Average:5237.50 Median:5404.62 stddev:581.15 (10.8%) stddev-sans-first:559.41 07:19:24 INFO - PROCESS | 18864 | Values: 3151.3 3200.8 3230.4 3232.8 3259.7 5150.4 5244.3 5254.9 5263.1 5316.1 5217.9 5244.0 5253.9 5281.2 5320.9 4662.8 4725.3 4819.9 4897.9 4916.2 4732.3 4779.0 4876.1 4879.0 4997.6 4787.9 4788.8 4800.2 4839.9 4849.3 4799.8 4802.5 4823.8 4832.6 4834.0 4665.8 4738.7 4810.5 4819.9 4849.5 5178.2 5196.7 5201.7 5203.5 5212.7 5651.9 5685.9 5693.0 5695.8 5710.0 5514.9 5675.4 5703.4 5727.4 5767.6 5223.8 5252.9 5261.1 5262.8 5264.9 5723.6 5728.0 5744.9 5753.7 5778.4 5452.5 5521.0 5529.4 5542.5 5579.5 5671.3 5676.5 5681.7 5685.9 5692.0 5499.4 5628.8 5640.6 5646.9 5649.3 5575.0 5605.2 5608.7 5614.6 5669.1 4241.1 4244.2 4251.3 4252.1 4283.7 3728.7 3857.9 3877.8 3896.4 3899.5 5209.1 5221.3 5222.0 5230.1 5255.4 5626.8 5642.8 5649.6 5662.0 5662.4 5128.8 5240.7 5243.8 5245.6 5292.2 4857.1 4858.1 4864.1 4866.0 4906.9 5949.8 5956.3 5964.3 5965.8 5966.2 5463.7 5611.6 5726.8 5732.3 5780.0 5831.8 5836.4 5837.0 5842.9 5886.8 5487.4 5532.8 5533.3 5537.6 5552.5 5493.6 5630.4 5634.8 5635.7 5636.2 5527.0 5529.5 5532.9 5538.2 5581.5 5509.6 5510.8 5516.5 5520.4 5525.7 5315.8 5332.7 5404.6 5424.1 5447.9 5523.8 5531.1 5537.6 5561.4 5585.4 5362.9 5368.3 5370.9 5375.3 5376.6 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#1] ext.html Cycles:180 Average:43818.33 Median:34202.99 stddev:72829.70 (212.9%) stddev-sans-first:72961.43 07:19:24 INFO - PROCESS | 18864 | Values: 512.3 526.8 552.1 606.6 613.4 30061.2 30659.2 38301.4 38905.8 38970.2 35491.5 35558.1 35782.8 35875.8 36148.3 8583.7 8744.3 8790.3 8805.0 8807.6 8579.6 8665.9 8720.0 8725.1 8734.4 8694.3 8794.2 9012.2 9026.6 9032.7 8908.1 8968.9 8979.4 8983.1 8987.6 8848.4 8939.0 8966.7 8985.6 8991.6 42325.8 42780.1 42906.6 42937.8 42963.4 2922.6 3298.6 3605.2 3612.6 3723.9 29906.3 31057.2 31221.2 31282.7 31299.4 3975.0 3981.2 4082.8 4104.0 4158.2 275758.0 277066.0 277515.0 278761.0 278940.0 62097.0 62542.7 62861.7 62915.7 63060.4 50506.7 50634.0 50872.7 51040.7 51138.2 15769.6 15970.7 15976.6 15990.9 16008.1 12017.3 12057.7 12073.7 12076.8 12095.8 18587.5 20261.5 20333.6 20478.1 20568.6 5252.8 7144.6 7236.6 7352.7 7402.4 936.9 1002.6 1005.6 1018.7 1025.1 27397.6 27736.0 29307.0 30074.8 30174.0 1028.9 1070.1 1107.4 1148.1 1158.3 15391.3 15452.4 15531.5 15724.2 15783.8 339909.0 345674.5 346380.0 346719.0 346860.0 55199.4 56048.0 56189.0 56204.7 56285.7 1147.2 1235.2 1307.7 1339.8 1348.3 26137.2 26547.0 27033.5 27172.9 27258.5 39279.4 39498.4 39576.8 39627.6 39663.6 184282.0 188859.0 189372.0 189743.0 189843.0 28079.4 32005.4 32265.8 33301.2 33345.5 39049.4 39568.8 39644.8 40310.4 40655.8 33056.8 33347.3 33512.0 33609.3 33880.3 33624.5 34053.1 34352.8 34412.8 36917.3 33324.0 33354.5 33432.7 33472.2 33899.0 30902.0 31230.2 32355.5 32416.7 32630.8 24547.1 25191.6 25265.2 25454.9 25663.9 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#2] jquery.html Cycles:180 Average:23199.19 Median:18258.31 stddev:58860.65 (322.4%) stddev-sans-first:59000.79 07:19:24 INFO - PROCESS | 18864 | Values: 361.0 365.7 370.5 376.2 377.9 16860.8 17543.3 18667.4 19129.1 19136.6 14644.6 14647.8 14654.6 14673.4 14750.8 4010.0 5500.3 5617.5 5666.6 5680.4 5575.6 5578.5 5582.7 5607.7 5632.2 5395.2 5515.4 5550.1 5557.2 5608.8 5476.5 5537.6 5538.5 5540.1 5552.6 4899.6 4925.3 5094.5 5269.6 5277.7 12330.5 12378.0 12440.6 12547.3 15438.9 2060.2 2109.5 2133.9 2138.3 2245.7 9516.0 9796.1 10402.4 11019.1 13277.5 1856.1 1865.4 1915.5 1966.6 2096.1 62002.7 63597.0 63775.4 64614.7 66888.7 10330.2 10332.2 10409.5 10666.0 10804.9 14119.7 14203.2 14206.5 14217.6 14248.6 7511.0 7548.5 7603.9 7659.2 7870.1 7189.9 7209.1 7429.6 7550.4 7553.7 4597.7 4682.3 4709.9 4741.2 4741.8 1754.9 1761.0 1878.9 1905.5 1908.3 881.6 892.5 925.4 927.7 932.0 16589.2 17351.4 17437.7 17474.9 17739.0 899.2 933.6 956.0 979.7 1003.7 9355.8 9669.4 9711.0 9952.1 10093.8 336049.0 342257.0 345111.0 345493.0 405273.5 63916.0 75980.0 80969.6 81020.6 85618.1 1007.7 1023.6 1033.8 1039.9 1048.9 15791.5 15919.3 16219.2 16236.0 16315.1 35056.0 35484.3 36155.6 36417.6 36798.0 45495.5 47026.0 51647.5 52729.0 53177.7 7859.9 8135.8 8151.9 8206.4 8215.3 8493.0 10427.9 12023.4 12681.5 12859.5 10919.9 11103.1 11179.4 11289.8 11389.1 10696.7 10804.9 11045.0 11160.2 11380.1 11011.2 11227.0 11234.8 11459.4 11477.1 7843.1 7969.7 8004.0 8161.8 8282.0 10525.7 11163.1 11295.0 11305.5 11348.1 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#3] mootools.html Cycles:180 Average:5292.46 Median:6352.09 stddev:2770.55 (43.6%) stddev-sans-first:2761.88 07:19:24 INFO - PROCESS | 18864 | Values: 1276.9 1478.8 1508.9 1680.4 1810.4 6733.4 7293.0 7420.0 7423.7 7428.1 7397.6 7603.6 7613.3 7617.4 7623.9 1989.2 2031.0 2198.5 2202.3 2226.2 2260.7 2268.9 2269.8 2270.5 2271.3 2183.3 2212.1 2220.7 2249.0 2250.7 2204.5 2232.5 2235.2 2237.4 2237.8 2192.3 2213.3 2213.8 2213.9 2217.3 7771.8 7841.4 7846.0 7850.0 7852.9 4423.4 4514.6 4520.6 4531.9 4556.7 2928.8 2970.4 3112.8 3116.1 3137.2 947.3 954.7 998.5 1004.5 1005.4 10447.1 10449.4 10462.8 10467.5 10477.8 4180.7 4236.5 4283.9 4302.7 4307.2 8737.5 8746.0 8772.0 8778.0 8784.5 4552.1 4603.8 4607.7 4611.4 4611.7 3697.6 4063.2 4108.0 4134.3 4171.8 3631.6 3695.0 3695.3 3712.7 3746.0 1184.8 1193.0 1198.6 1199.2 1223.4 1069.1 1070.1 1072.8 1224.7 1348.1 7287.4 7361.3 7397.0 7397.7 7414.2 460.7 461.3 465.3 466.5 476.9 5588.5 5637.8 5661.3 5700.7 5703.5 9030.1 9275.2 9534.4 9538.2 9553.7 9241.9 9258.1 9261.6 9279.7 9304.7 6900.4 7066.0 7221.6 7362.6 7366.9 6901.0 6931.4 6947.9 6956.2 7075.6 7982.5 8138.1 8315.2 8376.7 8406.4 8051.1 8098.9 8119.7 8272.1 8301.2 6379.9 6511.4 6512.3 6525.9 6746.4 6983.5 7006.0 7020.6 7024.2 7024.5 6291.7 6420.0 6469.2 6487.6 6567.1 6324.8 6376.3 6402.3 6412.0 6453.5 6661.9 6665.9 6700.3 6706.5 6713.3 6347.5 6377.4 6381.7 6395.3 6406.8 6347.9 6356.3 6360.4 6378.9 6397.5 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#4] prototype.html Cycles:180 Average:5210.07 Median:5863.28 stddev:1575.19 (26.9%) stddev-sans-first:1536.76 07:19:24 INFO - PROCESS | 18864 | Values: 348.6 349.4 349.5 349.9 356.5 5848.6 5857.3 5871.2 5909.5 5928.3 5851.3 5853.3 5853.8 5854.0 5860.9 4369.8 4422.4 4509.9 4537.1 4579.8 4502.8 4526.0 4528.0 4540.6 4548.3 4442.0 4470.7 4480.6 4480.9 4485.4 4315.4 4402.8 4462.1 4500.1 4511.4 3955.8 3957.6 3962.9 3963.4 3970.7 5606.2 5615.3 5625.4 5635.3 5643.2 5244.8 5265.2 5273.6 5278.0 5284.8 6221.1 6224.9 6225.3 6233.8 6234.6 4135.5 4251.2 4259.2 4412.5 4422.1 6389.9 6417.3 6425.3 6457.5 6492.7 4365.9 4368.8 4370.7 4371.5 4383.4 4439.8 4442.1 4444.3 4444.7 4447.1 5154.1 5160.4 5160.8 5165.7 5166.9 6052.3 6244.6 6250.9 6260.9 6266.5 1547.9 1585.3 1592.3 1592.6 1598.3 980.6 1011.7 1014.3 1037.5 1051.0 5809.9 5820.7 5860.8 5862.4 5874.2 6355.2 6357.8 6362.7 6372.2 6374.2 5857.8 5864.2 5870.6 5871.2 5872.2 3393.5 3424.0 3427.5 3429.4 3429.7 6505.4 6596.5 6607.2 6745.3 6753.8 6615.1 6652.6 6653.7 6656.2 6665.2 6648.7 6704.3 6708.9 6727.8 6733.5 6472.6 6487.0 6544.4 6552.1 6559.5 6148.6 6354.7 6399.7 6406.0 6410.4 6643.4 6686.2 6689.8 6698.7 6702.1 4409.0 4435.8 4436.4 4453.0 4453.1 6433.1 6447.2 6452.9 6483.8 6529.5 6211.3 6256.8 6258.3 6261.1 6264.1 6068.3 6280.0 6292.7 6305.7 6307.3 6095.7 6131.7 6133.4 6136.0 6143.9 6277.3 6303.8 6306.1 6316.2 6316.6 5887.1 5955.8 6133.2 6146.0 6154.7 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - PROCESS | 18864 | [#5] yui.html Cycles:180 Average:13526.26 Median:25638.28 stddev:15825.19 (61.7%) stddev-sans-first:15840.20 07:19:24 INFO - PROCESS | 18864 | Values: 683.3 685.3 714.2 718.5 779.5 13342.8 13609.0 13626.9 13638.2 13640.9 13415.3 13468.3 13498.8 13511.4 13516.9 844.5 866.5 867.3 867.8 868.2 852.9 854.2 858.0 860.3 860.7 890.1 892.1 892.4 892.8 893.2 879.0 880.2 882.2 884.7 885.1 649.9 652.1 652.7 653.3 653.7 14396.9 14448.7 14484.1 14499.4 14509.0 12076.5 12167.0 12229.7 12358.5 12622.8 10377.5 10554.6 10596.6 10896.2 11237.9 3521.5 3587.2 3607.1 3722.2 3726.3 47736.5 48007.5 48029.5 48217.8 48277.0 9433.2 9444.2 9930.1 10146.8 10164.0 16972.0 17010.9 17014.6 17022.4 17048.1 7589.9 7675.8 7848.1 7969.2 8022.1 4343.1 4390.5 4427.4 4467.6 4686.0 3140.2 3142.5 3164.6 3172.6 3190.4 564.1 565.9 573.4 574.1 579.5 590.7 601.6 622.0 636.1 652.2 7836.9 7995.2 8001.7 8017.1 8051.3 559.4 603.1 611.3 619.7 632.9 3598.4 3651.2 3762.3 3764.7 3858.5 58322.4 59122.0 59696.0 59766.7 60069.4 41883.6 44291.6 51438.2 52383.0 52587.5 43577.3 43764.6 44109.6 44329.0 44563.3 7776.1 7856.8 8160.3 8176.1 8178.6 32805.8 33422.2 33459.5 33808.8 33893.8 42465.8 42518.0 46590.5 47394.8 48077.0 10922.2 11006.9 11014.7 11130.6 11372.3 10981.3 11036.9 11117.4 11211.4 11316.7 10071.3 10266.3 10274.2 10291.1 10701.9 10147.1 10298.0 10619.5 10627.2 10817.7 10065.5 10509.6 10740.1 10753.4 11188.9 8057.5 8330.3 8555.3 9006.2 9097.8 8584.4 8602.0 8673.7 9200.8 9236.6 07:19:24 INFO - PROCESS | 18864 | -------- Summary: end -------- 07:19:24 INFO - PROCESS | 18864 | 07:19:24 INFO - TEST-INFO | 18864: exit 0 07:19:24 INFO - TEST-OK | dromaeo_css | took 1112362ms 07:19:24 INFO - TEST-START | kraken 07:19:24 INFO - operating with platform_type : linux_ 07:19:24 INFO - Initialising browser for kraken test... 07:19:24 INFO - TEST-INFO | started process 19047 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJS0lVE/profile http://localhost:37059/getInfo.html) 07:19:28 INFO - PROCESS | 19047 | __metrics Screen width/height:1600/1200 07:19:28 INFO - PROCESS | 19047 | colorDepth:24 07:19:28 INFO - PROCESS | 19047 | Browser inner width/height: 1024/697 07:19:28 INFO - PROCESS | 19047 | __metrics 07:19:29 ERROR - PROCESS | 19047 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:19:30 INFO - TEST-INFO | 19047: exit 0 07:19:30 INFO - Browser initialized. 07:19:30 INFO - Running cycle 1/1 for kraken test... 07:19:30 INFO - TEST-INFO | started process 19131 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJS0lVE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:42 INFO - PROCESS | 19131 | RSS: Main: 154103808 07:19:42 INFO - PROCESS | 19131 | 07:19:44 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37059/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:45 INFO - PROCESS | 19131 | RSS: Main: 194994176 07:19:45 INFO - PROCESS | 19131 | 07:19:48 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37059/tests/kraken/driver.html?testName=audio-dft) 07:19:48 INFO - PROCESS | 19131 | RSS: Main: 185548800 07:19:48 INFO - PROCESS | 19131 | 07:19:51 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37059/tests/kraken/driver.html?testName=audio-fft) 07:19:52 INFO - PROCESS | 19131 | RSS: Main: 172015616 07:19:52 INFO - PROCESS | 19131 | 07:19:54 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37059/tests/kraken/driver.html?testName=audio-oscillator) 07:19:54 INFO - PROCESS | 19131 | RSS: Main: 172429312 07:19:54 INFO - PROCESS | 19131 | 07:19:56 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:57 INFO - PROCESS | 19131 | RSS: Main: 175771648 07:19:57 INFO - PROCESS | 19131 | 07:20:00 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37059/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:01 INFO - PROCESS | 19131 | RSS: Main: 173961216 07:20:01 INFO - PROCESS | 19131 | 07:20:04 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37059/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:05 INFO - PROCESS | 19131 | RSS: Main: 176062464 07:20:05 INFO - PROCESS | 19131 | 07:20:07 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37059/tests/kraken/driver.html?testName=json-parse-financial) 07:20:08 INFO - PROCESS | 19131 | RSS: Main: 176513024 07:20:08 INFO - PROCESS | 19131 | 07:20:10 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:10 INFO - PROCESS | 19131 | RSS: Main: 183631872 07:20:10 INFO - PROCESS | 19131 | 07:20:12 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:20:13 INFO - PROCESS | 19131 | RSS: Main: 181784576 07:20:13 INFO - PROCESS | 19131 | 07:20:15 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:20:15 INFO - PROCESS | 19131 | RSS: Main: 190566400 07:20:15 INFO - PROCESS | 19131 | 07:20:18 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:18 INFO - PROCESS | 19131 | RSS: Main: 196370432 07:20:18 INFO - PROCESS | 19131 | 07:20:21 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:21 INFO - PROCESS | 19131 | RSS: Main: 197529600 07:20:21 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | Cycle 1(1): loaded http://localhost:37059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37059/tests/kraken/driver.html?testName=ai-astar) 07:20:23 INFO - PROCESS | 19131 | RSS: Main: 257531904 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | __start_tp_report 07:20:23 INFO - PROCESS | 19131 | _x_x_mozilla_page_load 07:20:23 INFO - PROCESS | 19131 | _x_x_mozilla_page_load_details 07:20:23 INFO - PROCESS | 19131 | |i|pagename|runs| 07:20:23 INFO - PROCESS | 19131 | |0;ai-astar;109;111;106;113;113;110;100;110;111;110 07:20:23 INFO - PROCESS | 19131 | |1;audio-beat-detection;147;136;153;162;126;156;155;127;178;128 07:20:23 INFO - PROCESS | 19131 | |2;audio-dft;159;161;160;159;158;160;159;163;162;160 07:20:23 INFO - PROCESS | 19131 | |3;audio-fft;75;76;114;95;76;72;75;116;94;76 07:20:23 INFO - PROCESS | 19131 | |4;audio-oscillator;93;93;148;94;93;93;143;93;94;138 07:20:23 INFO - PROCESS | 19131 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 07:20:23 INFO - PROCESS | 19131 | |6;imaging-darkroom;145;145;145;146;146;145;145;146;145;144 07:20:23 INFO - PROCESS | 19131 | |7;imaging-desaturate;96;95;95;95;95;95;96;95;95;95 07:20:23 INFO - PROCESS | 19131 | |8;json-parse-financial;57;56;57;57;57;56;58;65;54;54 07:20:23 INFO - PROCESS | 19131 | |9;json-stringify-tinderbox;69;69;68;67;68;70;69;69;69;68 07:20:23 INFO - PROCESS | 19131 | |10;stanford-crypto-aes;82;83;83;81;81;81;82;82;89;81 07:20:23 INFO - PROCESS | 19131 | |11;stanford-crypto-ccm;123;117;116;121;118;116;127;127;113;117 07:20:23 INFO - PROCESS | 19131 | |12;stanford-crypto-pbkdf2;153;143;149;149;150;141;150;148;150;148 07:20:23 INFO - PROCESS | 19131 | |13;stanford-crypto-sha256-iterative;67;67;70;71;68;71;67;68;66;67 07:20:23 INFO - PROCESS | 19131 | __end_tp_report 07:20:23 INFO - PROCESS | 19131 | __start_cc_report 07:20:23 INFO - PROCESS | 19131 | _x_x_mozilla_cycle_collect,1080 07:20:23 INFO - PROCESS | 19131 | __end_cc_report 07:20:23 INFO - PROCESS | 19131 | __startTimestamp1457450423812__endTimestamp 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | ------- Summary: start ------- 07:20:23 INFO - PROCESS | 19131 | Number of tests: 14 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:3.83 (3.5%) stddev-sans-first:4.06 07:20:23 INFO - PROCESS | 19131 | Values: 109.0 111.0 106.0 113.0 113.0 110.0 100.0 110.0 111.0 110.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:154.00 stddev:17.29 (11.2%) stddev-sans-first:18.34 07:20:23 INFO - PROCESS | 19131 | Values: 147.0 136.0 153.0 162.0 126.0 156.0 155.0 127.0 178.0 128.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:1.52 (1.0%) stddev-sans-first:1.56 07:20:23 INFO - PROCESS | 19131 | Values: 159.0 161.0 160.0 159.0 158.0 160.0 159.0 163.0 162.0 160.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#3] audio-fft Cycles:10 Average:86.90 Median:76.00 stddev:16.86 (22.2%) stddev-sans-first:17.33 07:20:23 INFO - PROCESS | 19131 | Values: 75.0 76.0 114.0 95.0 76.0 72.0 75.0 116.0 94.0 76.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.00 stddev:24.13 (25.9%) stddev-sans-first:24.96 07:20:23 INFO - PROCESS | 19131 | Values: 93.0 93.0 148.0 94.0 93.0 93.0 143.0 93.0 94.0 138.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:20:23 INFO - PROCESS | 19131 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:20:23 INFO - PROCESS | 19131 | Values: 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 144.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:20:23 INFO - PROCESS | 19131 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.07 (5.4%) stddev-sans-first:3.26 07:20:23 INFO - PROCESS | 19131 | Values: 57.0 56.0 57.0 57.0 57.0 56.0 58.0 65.0 54.0 54.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 07:20:23 INFO - PROCESS | 19131 | Values: 69.0 69.0 68.0 67.0 68.0 70.0 69.0 69.0 69.0 68.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.00 stddev:2.42 (2.9%) stddev-sans-first:2.55 07:20:23 INFO - PROCESS | 19131 | Values: 82.0 83.0 83.0 81.0 81.0 81.0 82.0 82.0 89.0 81.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:119.50 stddev:4.81 (4.0%) stddev-sans-first:4.94 07:20:23 INFO - PROCESS | 19131 | Values: 123.0 117.0 116.0 121.0 118.0 116.0 127.0 127.0 113.0 117.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.50 stddev:3.54 (2.4%) stddev-sans-first:3.28 07:20:23 INFO - PROCESS | 19131 | Values: 153.0 143.0 149.0 149.0 150.0 141.0 150.0 148.0 150.0 148.0 07:20:23 INFO - PROCESS | 19131 | 07:20:23 INFO - PROCESS | 19131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.81 (2.7%) stddev-sans-first:1.87 07:20:23 INFO - PROCESS | 19131 | Values: 67.0 67.0 70.0 71.0 68.0 71.0 67.0 68.0 66.0 67.0 07:20:23 INFO - PROCESS | 19131 | -------- Summary: end -------- 07:20:23 INFO - PROCESS | 19131 | 07:20:24 INFO - TEST-INFO | 19131: exit 0 07:20:24 INFO - TEST-OK | kraken | took 60032ms 07:20:24 INFO - SUITE-END | took 1172s 07:20:24 INFO - Completed test suite (00:19:32) 07:20:24 INFO - javascript benchmark 07:20:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3151.3382189740155, 3200.775945683803, 3230.4185246655593, 3232.838358082097, 3259.6740325967407, 5150.407703114143, 5244.344456942882, 5254.894902101961, 5263.131583288762, 5316.069687804633, 5217.895642087156, 5244.0, 5253.8949221015655, 5281.155015197569, 5320.920186197211, 4662.7901744421415, 4725.338452616628, 4819.879503012417, 4897.926531102036, 4916.213405855064, 4732.290156476522, 4778.952210477903, 4876.122297986379, 4878.975605121969, 4997.575206107485, 4787.8563643090765, 4788.80844766209, 4800.207965685658, 4839.854804355858, 4849.321095046678, 4799.784009719571, 4802.495737947535, 4823.831165909176, 4832.613390928717, 4834.0, 4665.813367465297, 4738.739369334685, 4810.542998415145, 4819.903601927942, 4849.466558678542, 5178.249153872667, 5196.714180720097, 5201.713905735183, 5203.453637368098, 5212.687238765686, 5651.886962260773, 5685.914711279334, 5693.032184528599, 5695.77216911323, 5709.971450142764, 5514.91727624086, 5675.3757086720425, 5703.429657034305, 5727.3699893011735, 5767.5962682612235, 5223.843284701465, 5252.947470525322, 5261.105612045962, 5262.815801446969, 5264.921026184572, 5723.570732195102, 5728.0, 5744.856378590569, 5753.654780713171, 5778.393268706809, 5452.509274165344, 5521.033819081645, 5529.4470552944385, 5542.4734650208975, 5579.525740312038, 5671.347795003628, 5676.460736230051, 5681.715914204273, 5685.857853553694, 5692.0323544997445, 5499.395066542677, 5628.774849005994, 5640.633358831663, 5646.915296270559, 5649.322081350182, 5574.9721251393485, 5605.243292155506, 5608.747606357723, 5614.550835933115, 5669.092945128842, 4241.130568233505, 4244.172386384687, 4251.29853574163, 4252.128313695685, 4283.7429754214845, 3728.7203459740626, 3857.8649747259274, 3877.786721730332, 3896.357101078347, 3899.473571067926, 5209.088409528393, 5221.347331583552, 5221.973890130601, 5230.08473517133, 5255.369355677343, 5626.803061892896, 5642.802501912413, 5649.576281778883, 5662.037453632893, 5662.433756624387, 5128.820491282787, 5240.71176085319, 5243.816466423733, 5245.606579506552, 5292.2326262691695, 4857.0528746894015, 4858.076965376567, 4864.124457597666, 4865.95134048662, 4906.852794416173, 5949.762009519657, 5956.344802071855, 5964.343922168558, 5965.761369545169, 5966.164736936832, 5463.672179669233, 5611.579131565068, 5726.770929162787, 5732.34078081026, 5780.017397042597, 5831.766729330949, 5836.445537673914, 5837.0368889132815, 5842.941570584409, 5886.823395298148, 5487.4238204987905, 5532.834014979557, 5533.335999680065, 5537.5569954404355, 5552.500274975271, 5493.642913210629, 5630.408807075198, 5634.802781902614, 5635.746391412315, 5636.1827535008015, 5527.005139074844, 5529.529989950899, 5532.944670553243, 5538.196961440649, 5581.49766521015, 5509.559235261089, 5510.752016159202, 5516.475934786189, 5520.420355862577, 5525.696086715269, 5315.787368505216, 5332.653377530603, 5404.621676482609, 5424.1321388577635, 5447.863803404946, 5523.7790488380015, 5531.059719847555, 5537.584681149011, 5561.3882472927135, 5585.441455854545, 5362.865928351823, 5368.275282836923, 5370.892582148414, 5375.3280839895015, 5376.59675524345], "unit": "score", "name": "dojo.html", "value": 5200.1578572381595}, {"lowerIsBetter": false, "replicates": [512.3390825834673, 526.7550588976126, 552.1469329885326, 606.5753972219446, 613.4417679911279, 30061.24846878829, 30659.233519162004, 38301.42547861784, 38905.80547097268, 38970.22059558807, 35491.4676279856, 35558.11104722383, 35782.82108589453, 35875.82062089693, 36148.27703445936, 8583.742487725378, 8744.30045596354, 8790.34072444566, 8805.0, 8807.603657835381, 8579.571021448903, 8665.870011949826, 8720.040795512488, 8725.127487251288, 8734.432261902988, 8694.260987816044, 8794.208521233088, 9012.188902998729, 9026.593803278869, 9032.729018129467, 8908.064653211384, 8968.910310896872, 8979.416337938013, 8983.10168983103, 8987.64049438025, 8848.380613357067, 8939.0, 8966.68616598416, 8985.640574377017, 8991.640334386617, 42325.78837105795, 42780.144397111886, 42906.57093429057, 42937.78531107325, 42963.35554966678, 2922.649282086163, 3298.6371499135075, 3605.2068544920076, 3612.584552776438, 3723.94414083789, 29906.252343691365, 31057.22356941072, 31221.219469513217, 31282.687173128204, 31299.37401251985, 3975.0, 3981.1838573092737, 4082.755034697928, 4104.0, 4158.189153115144, 275758.0, 277066.0, 277515.0, 278761.0, 278940.0, 62097.0, 62542.687286563276, 62861.68569157125, 62915.685421573515, 63060.36939630637, 50506.74746626243, 50634.0, 50872.675822555495, 51040.74479627652, 51138.232926506134, 15769.605759856095, 15970.680586388207, 15976.600584985468, 15990.920045399931, 16008.119553424673, 12017.278963262232, 12057.698557536132, 12073.698157545956, 12076.818847717292, 12095.818562721566, 18587.469582807982, 20261.493462663257, 20333.59332813365, 20478.078486468145, 20568.588628227353, 5252.842414727565, 7144.642767861586, 7236.565806051653, 7352.669129889167, 7402.444816638774, 936.9203617692436, 1002.5839276700234, 1005.597760895633, 1018.7300365403174, 1025.1491262252312, 27397.589036164474, 27736.0, 29307.0, 30074.849625751733, 30174.0, 1028.922830787694, 1070.0797314309686, 1107.4075369677184, 1148.104478506766, 1158.2702897174727, 15391.3073911672, 15452.38190472391, 15531.5340539784, 15724.213789310488, 15783.842161578466, 339909.0, 345674.53115547914, 346380.0, 346719.0, 346860.0, 55199.44800551943, 56048.0, 56189.0, 56204.71897640486, 56285.7185714077, 1147.2485521983115, 1235.215638069814, 1307.6730817295677, 1339.7588434081763, 1348.265195468472, 26137.215883523524, 26547.0, 27033.45933081367, 27172.864135679196, 27258.45483090367, 39279.41080883846, 39498.40752388774, 39576.80211599039, 39627.60372396239, 39663.603363965995, 184282.0, 188859.0, 189372.0, 189743.0, 189843.0, 28079.43841123207, 32005.35989280155, 32265.838670806497, 33301.16747081342, 33345.49981750227, 39049.414258785575, 39568.80215598903, 39644.801775990934, 40310.39534406928, 40655.7967210162, 33056.83471582627, 33347.33305333831, 33512.0, 33609.327813444084, 33880.3223935515, 33624.49563256602, 34053.148671283416, 34352.82823585866, 34412.82793586116, 36917.26165476622, 33324.0, 33354.499682505266, 33432.665673342955, 33472.163195919326, 33899.0, 30902.0, 31230.21924451907, 32355.51466728048, 32416.67583324231, 32630.83684581562, 24547.140850070162, 25191.622125667764, 25265.242042738748, 25454.872725636254, 25663.871680641478], "unit": "score", "name": "ext.html", "value": 18025.096533290583}, {"lowerIsBetter": false, "replicates": [360.9909752256194, 365.7366695978896, 370.46282889809777, 376.2456275168289, 377.945197946298, 16860.83139168608, 17543.298268069262, 18667.439976800702, 19129.139188736506, 19136.617267654638, 14644.633884152901, 14647.780283295759, 14654.633634159125, 14673.413063477476, 14750.778738318933, 4009.954922989282, 5500.28496295481, 5617.466340697627, 5666.631668941526, 5680.403557626451, 5575.581831362644, 5578.470045345706, 5582.692951887645, 5607.719614019303, 5632.183333416652, 5395.244665746799, 5515.448455154473, 5550.056490396622, 5557.166425036236, 5608.831735047955, 5476.507114359707, 5537.58468114891, 5538.47384498472, 5540.058190107691, 5552.583556233279, 4899.6080313575185, 4925.310456536088, 5094.4650811664615, 5269.578433725331, 5277.70972596507, 12330.5067797288, 12378.0, 12440.626781196579, 12547.309897955609, 15438.922805386013, 2060.206820374152, 2109.546447513792, 2133.9466513337134, 2138.2729871843494, 2245.6631505274177, 9515.952420237923, 9796.069373409515, 10402.427866467342, 11019.063379612742, 13277.53528626503, 1856.1090676475233, 1865.3750993417223, 1915.4636701723539, 1966.6066786642587, 2096.14058236124, 62002.68998655023, 63597.0, 63775.36224637741, 64614.67692661554, 66888.6655566724, 10330.173586113093, 10332.225083118796, 10409.479526023668, 10666.0, 10804.945975270231, 14119.71760564783, 14203.218822964629, 14206.502772402917, 14217.573472795833, 14248.643783905485, 7510.962445187739, 7548.5470871747875, 7603.885941710879, 7659.234076592296, 7870.134285228621, 7189.856202876018, 7209.0628218331285, 7429.591372474566, 7550.35821955129, 7553.697852085855, 4597.678162528591, 4682.297655351656, 4709.905801883943, 4741.2176990796825, 4741.810327586858, 1754.921028553718, 1760.9911950440166, 1878.8778729382545, 1905.4855189098867, 1908.2557802457052, 881.6120906800987, 892.5403417240127, 925.4262357338494, 927.7077720518015, 931.9906800931903, 16589.17054147288, 17351.39270125565, 17437.73843392325, 17474.912625437046, 17739.0, 899.1817446124127, 933.6405483888616, 956.0487315121499, 979.7256768104942, 1003.7039073473343, 9355.812883742286, 9669.419834809934, 9711.0, 9952.10431061208, 10093.845482322195, 336049.0, 342257.0, 345111.0, 345493.0, 405273.52538271697, 63916.0, 75980.0, 80969.59515202386, 81020.59489702631, 85618.14381856102, 1007.7027276953316, 1023.6110278094277, 1033.8190816607064, 1039.9168066554657, 1048.926575139733, 15791.526254212393, 15919.28363223681, 16219.18904054816, 16236.02583844973, 16315.102669352826, 35056.0, 35484.29031419409, 36155.63844361628, 36417.63582364142, 36798.0, 45495.54504454913, 47026.0, 51647.483525164265, 52729.0, 53177.7341113292, 7859.882101768592, 8135.75592732219, 8151.877721834296, 8206.384521161057, 8215.301699355383, 8493.0, 10427.94786026065, 12023.398830058637, 12681.492740290285, 12859.549915753278, 10919.945400272947, 11103.111751060058, 11179.385133817717, 11289.830652540382, 11389.12079506872, 10696.732581685521, 10804.891951080703, 11045.0, 11160.162987775788, 11380.089592832388, 11011.174161937726, 11227.0, 11234.775304494027, 11459.369734664673, 11477.08183345347, 7843.137254901842, 7969.72105976288, 8004.0, 8161.836763264582, 8282.047564529916, 10525.684229473129, 11163.051140653135, 11295.0, 11305.491252893804, 11348.092152627605], "unit": "score", "name": "jquery.html", "value": 8380.483852307894}, {"lowerIsBetter": false, "replicates": [1276.8531618863833, 1478.844721304263, 1508.8792896568275, 1680.4286542575521, 1810.3844692804444, 6733.39399454049, 7292.9635351823235, 7419.962900185492, 7423.703051877925, 7428.1086269647585, 7397.63011849408, 7603.619819009041, 7613.314801667849, 7617.3906087513005, 7623.923760762391, 1989.2341448542343, 2031.0454086579284, 2198.5163264081875, 2202.2622421488823, 2226.220822712046, 2260.683504309398, 2268.931932042033, 2269.8184145268337, 2270.5004898922293, 2271.3072512883564, 2183.279517759144, 2212.126210146991, 2220.66689996501, 2248.9662655060188, 2250.729912410513, 2204.4599073227164, 2232.4976880201907, 2235.228846048119, 2237.3511681612313, 2237.8209743220505, 2192.254633424643, 2213.3249358945513, 2213.8007579317937, 2213.900374483152, 2217.2904670505445, 7771.805704857424, 7841.372690184771, 7845.9607701961695, 7849.960750196269, 7852.882206766903, 4423.402840616508, 4514.616257618107, 4520.570545798144, 4531.864044078683, 4556.749378784166, 2928.7803414743767, 2970.376220993594, 3112.817129490779, 3116.0963320637215, 3137.200013996416, 947.2989987409268, 954.656323723459, 998.4957596413765, 1004.4877112672517, 1005.4168582222294, 10447.05976462122, 10449.373037617692, 10462.790744185073, 10467.528961196764, 10477.79044419115, 4180.728252663567, 4236.491621005499, 4283.87148385549, 4302.655787537052, 4307.224699554048, 8737.475751454933, 8746.037935827182, 8772.03507614162, 8777.956110219407, 8784.462719024144, 4552.11233809404, 4603.838865639686, 4607.7004994675235, 4611.432113081569, 4611.654125940501, 3697.574778900407, 4063.2076745034433, 4108.034611866209, 4134.255833949918, 4171.791410429527, 3631.6368363164, 3694.9630503695157, 3695.316366472211, 3712.7029837612927, 3745.9812700936322, 1184.8281999110081, 1193.0336427493758, 1198.6344165029575, 1199.2145144930084, 1223.4311045363947, 1069.1126365116934, 1070.0904231403244, 1072.84443755655, 1224.6693392784077, 1348.1304558559675, 7287.417006639456, 7361.30067643573, 7396.96301518489, 7397.741079062207, 7414.221506741822, 460.7120549656465, 461.2619808306682, 465.32527834639234, 466.4961841211551, 476.91653960556766, 5588.469095435927, 5637.774489020475, 5661.34894487131, 5700.657960522382, 5703.543716502752, 9030.096990300917, 9275.21160701348, 9534.380265282734, 9538.189253913357, 9553.713388598353, 9241.907580924239, 9258.120478554527, 9261.629534818667, 9279.72160835176, 9304.72085837426, 6900.378965893094, 7065.964670176616, 7221.638918054076, 7362.558246505227, 7366.889496657447, 6900.965495172492, 6931.445484361138, 6947.895781563179, 6956.234814170336, 7075.646217688992, 7982.521048737094, 8138.064122625974, 8315.210055044761, 8376.706815261681, 8406.369522285975, 8051.074126475296, 8098.87851682237, 8119.675212991414, 8272.090070092405, 8301.169883011651, 6379.936200637934, 6511.38141876521, 6512.348765123639, 6525.869482610226, 6746.359095885883, 6983.476239281973, 7005.964970175117, 7020.613866237406, 7024.227334993249, 7024.5082844200415, 6291.716872740646, 6420.036994450869, 6469.159009328757, 6487.610743355413, 6567.146270984741, 6324.810255692337, 6376.330485298977, 6402.327755585597, 6412.038194270896, 6453.515986300952, 6661.900071499028, 6665.900011499928, 6700.329967003456, 6706.530542861953, 6713.328667133248, 6347.523935704933, 6377.394147555975, 6381.744730210739, 6395.328490508429, 6406.775762848278, 6347.904781428375, 6356.269029061532, 6360.395762402564, 6378.872422551616, 6397.456216221487], "unit": "score", "name": "mootools.html", "value": 4276.004309674882}, {"lowerIsBetter": false, "replicates": [348.5660352860688, 349.38682612015907, 349.46357341480825, 349.8653018587843, 356.5151394104018, 5848.6490810551395, 5857.26784151981, 5871.2367392239, 5909.497692696115, 5928.288605367351, 5851.297844258695, 5853.268341457318, 5853.76584936602, 5853.970730146343, 5860.912086318698, 4369.825206991733, 4422.402975598286, 4509.909801803962, 4537.115262523809, 4579.839705610304, 4502.77486125694, 4526.0, 4528.04910968697, 4540.614047805941, 4548.31775233716, 4442.044960333527, 4470.664700147486, 4480.574345437179, 4480.910381792362, 4485.372047913294, 4315.395844581761, 4402.801873915681, 4462.107578484283, 4500.054988452429, 4511.368408422791, 3955.782431966241, 3957.6240257175523, 3962.881113566598, 3963.425303331001, 3970.7021973351825, 5606.243157173811, 5615.2700148980375, 5625.353084395306, 5635.267415236034, 5643.153526970947, 5244.842654720364, 5265.183896496049, 5273.551748101416, 5277.973610131963, 5284.788608455658, 6221.066839973995, 6224.875502489925, 6225.28409232935, 6233.750649973996, 6234.594751341194, 4135.545090040093, 4251.171021650779, 4259.233337999159, 4412.514623391457, 4422.115576884636, 6389.872202555923, 6417.294097649255, 6425.261094974045, 6457.483401327882, 6492.675366231717, 4365.869023929287, 4368.847090351886, 4370.694051416434, 4371.540988196257, 4383.408239887574, 4439.823446786604, 4442.089371678798, 4444.266695995125, 4444.711093778894, 4447.065526495984, 5154.123798954187, 5160.406553246425, 5160.845174644766, 5165.690058596496, 5166.9224961625605, 6052.303985041688, 6244.625322480666, 6250.9062364064575, 6260.874782504325, 6266.49868010558, 1547.8916475846584, 1585.2549301828121, 1592.3153044190879, 1592.585927658794, 1598.328701945186, 980.5538479991586, 1011.7268337548968, 1014.2798612984864, 1037.4812593703148, 1050.9842352364722, 5809.88380232393, 5820.650760954356, 5860.765569377178, 5862.355140934494, 5874.236349274567, 6355.237371515448, 6357.8383349661335, 6362.6500542469685, 6372.203474565679, 6374.171357723466, 5857.824265272048, 5864.2083318752275, 5870.5890587659305, 5871.207387002785, 5872.207252021008, 3393.474011528217, 3424.0241531163997, 3427.503012063237, 3429.416999110157, 3429.6913277805115, 6505.3819887111595, 6596.505262105361, 6607.174103237096, 6745.258021617618, 6753.763618273337, 6615.073889655452, 6652.567583107082, 6653.667316634149, 6656.234533028667, 6665.233498147678, 6648.700808463534, 6704.296048914891, 6708.899366509506, 6727.831804204836, 6733.494987875831, 6472.579282346633, 6487.0, 6544.44372228366, 6552.115464412243, 6559.540832141895, 6148.631082135086, 6354.682265886595, 6399.712012959521, 6406.0, 6410.423061924449, 6643.368879956396, 6686.197656281277, 6689.832754181184, 6698.698558564974, 6702.061711360316, 4409.0, 4435.846679863194, 4436.423264975532, 4453.042595841909, 4453.0871171409135, 6433.099366088845, 6447.194100737408, 6452.935470645421, 6483.805485835433, 6529.5102867284195, 6211.254649442096, 6256.7810126645345, 6258.342873998165, 6261.060840873905, 6264.091706702594, 6068.302145253352, 6280.0, 6292.748290068529, 6305.716242768995, 6307.274663413767, 6095.695215239131, 6131.724072416663, 6133.417325354084, 6136.048912418582, 6143.877122457437, 6277.2781130170615, 6303.779367722108, 6306.054091886253, 6316.210473690789, 6316.557840951273, 5887.087501437284, 5955.821325360246, 6133.202683651275, 6146.0, 6154.692265386623], "unit": "score", "name": "prototype.html", "value": 4702.035276175922}, {"lowerIsBetter": false, "replicates": [683.2723149845415, 685.2873012067447, 714.2000958926004, 718.5114122396768, 779.5283853268771, 13342.799858002125, 13609.0, 13626.863731362684, 13638.249896255715, 13640.863591364083, 13415.262160581164, 13468.326583670801, 13498.797518037238, 13511.391987360568, 13516.93241533791, 844.4933040175891, 866.5234121233328, 867.3234876796078, 867.8437881181385, 868.2099289646424, 852.8933883264592, 854.2311919272643, 857.9742607721778, 860.2558786649535, 860.7116615933638, 890.1276748786194, 892.1435421994893, 892.4243862708549, 892.8258989497051, 893.1559676106083, 879.0198928195049, 880.1638443478721, 882.2368651116802, 884.7168905950099, 885.0927799006038, 649.9285078641345, 652.1456891472187, 652.6932341799394, 653.2781276689237, 653.6731634182909, 14396.856031439656, 14448.71102577953, 14484.1309521428, 14499.42002319906, 14509.0, 12076.456559454758, 12167.0, 12229.694257643541, 12358.505659773598, 12622.81065784014, 10377.481125943748, 10554.630587929385, 10596.629117980834, 10896.18278629106, 11237.943810280978, 3521.4893840393, 3587.246678197582, 3607.080194550399, 3722.1997270586953, 3726.2920045191327, 47736.52263477355, 48007.519924800654, 48029.51970480286, 48217.75891120557, 48277.0, 9433.198178154933, 9444.244460443148, 9930.106290433896, 10146.797064058677, 10164.0, 16972.0, 17010.938031154263, 17014.57463563421, 17022.40421585263, 17048.14759262032, 7589.924100758922, 7675.846483070307, 7848.0974687910475, 7969.203079692101, 8022.1175670676175, 4343.131373725268, 4390.4511936008, 4427.446569178853, 4467.5755803198645, 4686.015936653273, 3140.2149462634343, 3142.4500712375243, 3164.5886034815326, 3172.6034245719284, 3190.3619276144864, 564.1481363141686, 565.8755073883739, 573.4408951272559, 574.1072632057108, 579.495838620403, 590.7282649980971, 601.6209787833724, 621.9937800622026, 636.0935666674969, 652.1749986267375, 7836.882446763303, 7995.1605081465605, 8001.719939802079, 8017.118117007125, 8051.315638170704, 559.3930585314897, 603.1345019896463, 611.3275397063195, 619.6746707978257, 632.9493640508748, 3598.395175558802, 3651.1602331463914, 3762.3415902217002, 3764.661180493769, 3858.498395208605, 58322.41677583255, 59122.0, 59696.0, 59766.70116649476, 60069.39930600638, 41883.58116418797, 44291.55708442939, 51438.22842657363, 52383.0, 52587.474125259025, 43577.34633980493, 43764.562354376685, 44109.55890441054, 44329.0, 44563.33155002613, 7776.144624091232, 7856.764297071097, 8160.30637395828, 8176.100628930694, 8178.591070446335, 32805.83597081999, 33422.164445889044, 33459.498107528896, 33808.830955845064, 33893.83053084817, 42465.787671061444, 42518.0, 46590.53409465862, 47394.76302618465, 48077.0, 10922.18083643714, 11006.944965275123, 11014.724631884266, 11130.610428634958, 11372.260803047775, 10981.286216395909, 11036.944815275872, 11117.388543630179, 11211.439428028729, 11316.717082073013, 10071.312771650011, 10266.332688375232, 10274.178065754872, 10291.073803357735, 10701.946490267499, 10147.137493313152, 10298.0, 10619.522121504706, 10627.202959777893, 10817.657736729505, 10065.547050382604, 10509.632162874263, 10740.140788737039, 10753.354798712102, 11188.944055279671, 8057.453840610369, 8330.333573314, 8555.272801811667, 9006.189442950166, 9097.818043639223, 8584.442011269248, 8602.0, 8673.739787806377, 9200.769980750534, 9236.635551043759], "unit": "score", "name": "yui.html", "value": 6198.132075183737}], "name": "dromaeo_css", "value": 6788.877029748858}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 113.0, 113.0, 110.0, 100.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 153.0, 162.0, 126.0, 156.0, 155.0, 127.0, 178.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 159.0, 158.0, 160.0, 159.0, 163.0, 162.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.1}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 114.0, 95.0, 76.0, 72.0, 75.0, 116.0, 94.0, 76.0], "unit": "score", "name": "audio-fft", "value": 86.9}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 94.0, 93.0, 93.0, 143.0, 93.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 56.0, 58.0, 65.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 67.0, 68.0, 70.0, 69.0, 69.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 81.0, 81.0, 81.0, 82.0, 82.0, 89.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 116.0, 121.0, 118.0, 116.0, 127.0, 127.0, 113.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.5}, {"lowerIsBetter": true, "replicates": [153.0, 143.0, 149.0, 149.0, 150.0, 141.0, 150.0, 148.0, 150.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 71.0, 68.0, 71.0, 67.0, 68.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1512.4999999999998}]} 07:20:25 INFO - Return code: 0 07:20:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:20:25 ERROR - # TBPL SUCCESS # 07:20:25 INFO - Running post-action listener: _resource_record_post_action 07:20:25 INFO - Running post-run listener: _resource_record_post_run 07:20:26 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 20480; Write bytes: 536711168; Read time: 32; Write time: 495748 07:20:26 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247033856; Read time: 0; Write time: 268036 07:20:26 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 20480; Write bytes: 289677312; Read time: 32; Write time: 227712 07:20:26 INFO - Running post-run listener: _upload_blobber_files 07:20:26 INFO - Blob upload gear active. 07:20:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:20:26 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 07:20:26 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'] 07:20:26 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 07:20:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:27 INFO - (blobuploader) - INFO - Done attempting. 07:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 07:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:28 INFO - (blobuploader) - INFO - Done attempting. 07:20:28 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:28 INFO - Return code: 0 07:20:28 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:20:28 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6514c5740ecb283de0fd8cd52dc1762bea8fe286a4b4ac61295e0a6320caacbfe4efd4081da449db22ebd2377cca92b0c028c17eeb0f0acf0091627cda780345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ebcd1623ec506b36bbe78086ed0ebec62d4258bd9f9dd5bb4aac9b0b07ff641ab7d8bd4933dfeee43777f25dbcc857c2c6608bf79f66939f12d05537fdf5baa"} 07:20:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:20:28 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:20:28 INFO - Contents: 07:20:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6514c5740ecb283de0fd8cd52dc1762bea8fe286a4b4ac61295e0a6320caacbfe4efd4081da449db22ebd2377cca92b0c028c17eeb0f0acf0091627cda780345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ebcd1623ec506b36bbe78086ed0ebec62d4258bd9f9dd5bb4aac9b0b07ff641ab7d8bd4933dfeee43777f25dbcc857c2c6608bf79f66939f12d05537fdf5baa"} 07:20:28 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:28 INFO - Copying logs to upload dir... 07:20:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:20:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.109886 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-03-08 07:20:28.255177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 07:20:28.258355) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6514c5740ecb283de0fd8cd52dc1762bea8fe286a4b4ac61295e0a6320caacbfe4efd4081da449db22ebd2377cca92b0c028c17eeb0f0acf0091627cda780345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ebcd1623ec506b36bbe78086ed0ebec62d4258bd9f9dd5bb4aac9b0b07ff641ab7d8bd4933dfeee43777f25dbcc857c2c6608bf79f66939f12d05537fdf5baa"} build_url:https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/Fqm-HCQeSKWGlrE-6yUjxA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6514c5740ecb283de0fd8cd52dc1762bea8fe286a4b4ac61295e0a6320caacbfe4efd4081da449db22ebd2377cca92b0c028c17eeb0f0acf0091627cda780345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8ebcd1623ec506b36bbe78086ed0ebec62d4258bd9f9dd5bb4aac9b0b07ff641ab7d8bd4933dfeee43777f25dbcc857c2c6608bf79f66939f12d05537fdf5baa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 07:20:28.282617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 07:20:28.282909) ========= 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=41bf3e9aed84707956354da8000001c5-1457449192.940562-356302094 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 07:20:28.368724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 07:20:28.369116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 07:20:28.369419) ========= ========= Total master_lag: 0.24 =========