builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1447531235.41 results: success (0) buildid: 20151114103013 builduid: c86d1fb163514282bee862bdb06b7309 revision: 50b5e58fd4cd039010f8dc46e7739aee8d8ba68a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.413489) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.413873) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.414178) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.008971 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.463782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.464068) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.553088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.553378) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.602382) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.602658) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.603045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.603317) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-14 12:00:35-- 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% 221M=0s 2015-11-14 12:00:36 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.819228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.819507) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021929 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.868482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:35.868820) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 50b5e58fd4cd039010f8dc46e7739aee8d8ba68a --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 50b5e58fd4cd039010f8dc46e7739aee8d8ba68a --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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-14 12:00:36,147 truncating revision to first 12 chars 2015-11-14 12:00:36,147 Setting DEBUG logging. 2015-11-14 12:00:36,147 attempt 1/10 2015-11-14 12:00:36,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/50b5e58fd4cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 12:00:36,386 unpacking tar archive at: mozilla-inbound-50b5e58fd4cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:36.422424) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:36.422715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:36.429224) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:36.429475) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 12:00:36.429836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-14 12:00:36.430140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:00:36 INFO - MultiFileLogger online at 20151114 12:00:36 in /builds/slave/test-pgo 12:00:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:00:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:00:36 INFO - {'append_to_log': False, 12:00:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:00:36 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:00:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:00:36 INFO - 'branch': 'Mozilla-Inbound', 12:00:36 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:36 INFO - 'config_files': ('talos/linux_config.py',), 12:00:36 INFO - 'default_actions': ('clobber', 12:00:36 INFO - 'read-buildbot-config', 12:00:36 INFO - 'download-and-extract', 12:00:36 INFO - 'populate-webroot', 12:00:36 INFO - 'create-virtualenv', 12:00:36 INFO - 'install', 12:00:36 INFO - 'run-tests'), 12:00:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:36 INFO - 'download_minidump_stackwalk': True, 12:00:36 INFO - 'download_symbols': 'ondemand', 12:00:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:36 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:36 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:36 INFO - 'installer_path': 'installer.exe', 12:00:36 INFO - 'log_level': 'info', 12:00:36 INFO - 'log_name': 'talos', 12:00:36 INFO - 'log_to_console': True, 12:00:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:00:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:00:36 INFO - 'opt_config_files': (), 12:00:36 INFO - 'pip_index': False, 12:00:36 INFO - 'sps_profile': False, 12:00:36 INFO - 'sps_profile_interval': 0, 12:00:36 INFO - 'suite': 'dromaeojs-e10s', 12:00:36 INFO - 'system_bits': '64', 12:00:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:36 INFO - 'title': 'talos-linux64-ix-033', 12:00:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:36 INFO - 'use_talos_json': True, 12:00:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:00:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:36 INFO - 'work_dir': 'build'} 12:00:36 INFO - ##### 12:00:36 INFO - ##### Running clobber step. 12:00:36 INFO - ##### 12:00:36 INFO - Running pre-action listener: _resource_record_pre_action 12:00:36 INFO - Running main action method: clobber 12:00:36 INFO - rmtree: /builds/slave/test-pgo/build 12:00:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:00:37 INFO - Running post-action listener: _resource_record_post_action 12:00:37 INFO - ##### 12:00:37 INFO - ##### Running read-buildbot-config step. 12:00:37 INFO - ##### 12:00:37 INFO - Running pre-action listener: _resource_record_pre_action 12:00:37 INFO - Running main action method: read_buildbot_config 12:00:37 INFO - Using buildbot properties: 12:00:37 INFO - { 12:00:37 INFO - "properties": { 12:00:37 INFO - "buildnumber": 427, 12:00:37 INFO - "product": "firefox", 12:00:37 INFO - "script_repo_revision": "production", 12:00:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:00:37 INFO - "repository": "", 12:00:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:00:37 INFO - "buildid": "20151114103013", 12:00:37 INFO - "slavename": "talos-linux64-ix-033", 12:00:37 INFO - "pgo_build": "True", 12:00:37 INFO - "basedir": "/builds/slave/test-pgo", 12:00:37 INFO - "project": "", 12:00:37 INFO - "platform": "ubuntu64_hw", 12:00:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:00:37 INFO - "slavebuilddir": "test", 12:00:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:00:37 INFO - "branch": "mozilla-inbound", 12:00:37 INFO - "repo_path": "integration/mozilla-inbound", 12:00:37 INFO - "stage_platform": "linux64-pgo", 12:00:37 INFO - "builduid": "c86d1fb163514282bee862bdb06b7309", 12:00:37 INFO - "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a" 12:00:37 INFO - }, 12:00:37 INFO - "sourcestamp": { 12:00:37 INFO - "repository": "", 12:00:37 INFO - "hasPatch": false, 12:00:37 INFO - "project": "", 12:00:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 12:00:37 INFO - "changes": [ 12:00:37 INFO - { 12:00:37 INFO - "category": null, 12:00:37 INFO - "files": [ 12:00:37 INFO - { 12:00:37 INFO - "url": null, 12:00:37 INFO - "name": "https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:00:37 INFO - } 12:00:37 INFO - ], 12:00:37 INFO - "repository": "", 12:00:37 INFO - "rev": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a", 12:00:37 INFO - "who": "sendchange", 12:00:37 INFO - "when": 1447531191, 12:00:37 INFO - "number": 6662468, 12:00:37 INFO - "comments": "", 12:00:37 INFO - "project": "", 12:00:37 INFO - "at": "Sat 14 Nov 2015 11:59:51", 12:00:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 12:00:37 INFO - "revlink": "", 12:00:37 INFO - "properties": [ 12:00:37 INFO - [ 12:00:37 INFO - "buildid", 12:00:37 INFO - "20151114103013", 12:00:37 INFO - "Change" 12:00:37 INFO - ], 12:00:37 INFO - [ 12:00:37 INFO - "builduid", 12:00:37 INFO - "c86d1fb163514282bee862bdb06b7309", 12:00:37 INFO - "Change" 12:00:37 INFO - ], 12:00:37 INFO - [ 12:00:37 INFO - "pgo_build", 12:00:37 INFO - "True", 12:00:37 INFO - "Change" 12:00:37 INFO - ] 12:00:37 INFO - ], 12:00:37 INFO - "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a" 12:00:37 INFO - } 12:00:37 INFO - ], 12:00:37 INFO - "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a" 12:00:37 INFO - } 12:00:37 INFO - } 12:00:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:00:37 INFO - Running post-action listener: _resource_record_post_action 12:00:37 INFO - ##### 12:00:37 INFO - ##### Running download-and-extract step. 12:00:37 INFO - ##### 12:00:37 INFO - Running pre-action listener: _resource_record_pre_action 12:00:37 INFO - Running main action method: download_and_extract 12:00:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:00:37 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')]} 12:00:37 INFO - https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:00:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/test_packages.json 12:00:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/test_packages.json 12:00:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:00:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:00:38 INFO - Downloaded 1302 bytes. 12:00:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:00:38 INFO - Using the following test package requirements: 12:00:38 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:38 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:00:38 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'jsshell-linux-x86_64.zip'], 12:00:38 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:00:38 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:38 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:00:38 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:00:38 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:00:38 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:38 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:38 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:00:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:38 INFO - https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:00:40 INFO - Downloaded 22461553 bytes. 12:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:00:41 INFO - Return code: 0 12:00:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:00:41 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')]} 12:00:41 INFO - https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:00:42 INFO - Downloaded 22461553 bytes. 12:00:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:00:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:00:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:00:43 INFO - Return code: 0 12:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:43 INFO - https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:00:44 INFO - Downloaded 11131693 bytes. 12:00:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:00:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:00:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:00:45 INFO - Return code: 0 12:00:45 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')]} 12:00:45 INFO - https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:00:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:00:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:00:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:00:48 INFO - Downloaded 57158512 bytes. 12:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:00:48 INFO - mkdir: /builds/slave/test-pgo/properties 12:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:00:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:00:48 INFO - Contents: 12:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:00:48 INFO - Running post-action listener: _resource_record_post_action 12:00:48 INFO - Running post-action listener: set_extra_try_arguments 12:00:48 INFO - ##### 12:00:48 INFO - ##### Running populate-webroot step. 12:00:48 INFO - ##### 12:00:48 INFO - Running pre-action listener: _resource_record_pre_action 12:00:48 INFO - Running main action method: populate_webroot 12:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:00:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:00:48 INFO - '../fennec_ids.txt'], 12:00:48 INFO - 'tests': ['tcheck2']}, 12:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:00:48 INFO - '--tppagecycles', 12:00:48 INFO - '7'], 12:00:48 INFO - 'tests': ['tsvgm']}}, 12:00:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:00:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:00:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'tests': ['damp', 'tps']}, 12:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['damp', 'tps']}, 12:00:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:00:48 INFO - 'other': {'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'other_l64': {'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'other_nol64': {'tests': ['a11yr', 12:00:48 INFO - 'ts_paint', 12:00:48 INFO - 'tpaint', 12:00:48 INFO - 'sessionrestore', 12:00:48 INFO - 'sessionrestore_no_auto_restore']}, 12:00:48 INFO - 'svgr': {'tests': ['tsvgx', 12:00:48 INFO - 'tsvgr_opacity', 12:00:48 INFO - 'tart', 12:00:48 INFO - 'tscrollx', 12:00:48 INFO - 'cart']}, 12:00:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['tsvgx', 12:00:48 INFO - 'tsvgr_opacity', 12:00:48 INFO - 'tart', 12:00:48 INFO - 'tscrollx', 12:00:48 INFO - 'cart']}, 12:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'tests': ['tp5o']}, 12:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'talos_options': ['--e10s'], 12:00:48 INFO - 'tests': ['tp5o']}, 12:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'talos_options': ['--xperf_path', 12:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:48 INFO - 'tests': ['tp5n']}, 12:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:48 INFO - 'talos_options': ['--e10s', 12:00:48 INFO - '--xperf_path', 12:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:48 INFO - 'tests': ['tp5n']}}, 12:00:48 INFO - 'talos.zip': {'path': '', 12:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:00:48 INFO - Running post-action listener: _resource_record_post_action 12:00:48 INFO - ##### 12:00:48 INFO - ##### Running create-virtualenv step. 12:00:48 INFO - ##### 12:00:48 INFO - Running pre-action listener: _resource_record_pre_action 12:00:48 INFO - Running main action method: create_virtualenv 12:00:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:00:48 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 12:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:00:48 INFO - Using real prefix '/usr' 12:00:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:00:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:00:50 INFO - Installing pip.................done. 12:00:50 INFO - Return code: 0 12:00:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:00:50 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')]} 12:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:50 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')]} 12:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:00:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:00:50 INFO - Using env: {'DISPLAY': ':0', 12:00:50 INFO - 'HOME': '/home/cltbld', 12:00:50 INFO - 'LANG': 'en_US.UTF-8', 12:00:50 INFO - 'LANGUAGE': 'en_US:en', 12:00:50 INFO - 'LOGNAME': 'cltbld', 12:00:50 INFO - 'MAIL': '/var/mail/cltbld', 12:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:50 INFO - 'MOZ_NO_REMOTE': '1', 12:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:50 INFO - 'NO_EM_RESTART': '1', 12:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 12:00:50 INFO - 'SHELL': '/bin/bash', 12:00:50 INFO - 'SHLVL': '1', 12:00:50 INFO - 'TERM': 'linux', 12:00:50 INFO - 'TMOUT': '86400', 12:00:50 INFO - 'USER': 'cltbld', 12:00:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:50 INFO - '_': '/tools/buildbot/bin/python'} 12:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:50 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 12:00:50 INFO - Cleaning up... 12:00:50 INFO - Return code: 0 12:00:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:00:50 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')]} 12:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:50 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')]} 12:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:00:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:00:50 INFO - Using env: {'DISPLAY': ':0', 12:00:50 INFO - 'HOME': '/home/cltbld', 12:00:50 INFO - 'LANG': 'en_US.UTF-8', 12:00:50 INFO - 'LANGUAGE': 'en_US:en', 12:00:50 INFO - 'LOGNAME': 'cltbld', 12:00:50 INFO - 'MAIL': '/var/mail/cltbld', 12:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:50 INFO - 'MOZ_NO_REMOTE': '1', 12:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:50 INFO - 'NO_EM_RESTART': '1', 12:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 12:00:50 INFO - 'SHELL': '/bin/bash', 12:00:50 INFO - 'SHLVL': '1', 12:00:50 INFO - 'TERM': 'linux', 12:00:50 INFO - 'TMOUT': '86400', 12:00:50 INFO - 'USER': 'cltbld', 12:00:50 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:50 INFO - '_': '/tools/buildbot/bin/python'} 12:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:51 INFO - Downloading/unpacking psutil>=0.7.1 12:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:52 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:00:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:00:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:52 INFO - Installing collected packages: psutil 12:00:52 INFO - Running setup.py install for psutil 12:00:52 INFO - building 'psutil._psutil_linux' extension 12:00:52 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 12:00:53 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 12:00:53 INFO - building 'psutil._psutil_posix' extension 12:00:53 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 12:00:53 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 12:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:00:53 INFO - Successfully installed psutil 12:00:53 INFO - Cleaning up... 12:00:53 INFO - Return code: 0 12:00:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:00:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:00:53 INFO - Using env: {'DISPLAY': ':0', 12:00:53 INFO - 'HOME': '/home/cltbld', 12:00:53 INFO - 'LANG': 'en_US.UTF-8', 12:00:53 INFO - 'LANGUAGE': 'en_US:en', 12:00:53 INFO - 'LOGNAME': 'cltbld', 12:00:53 INFO - 'MAIL': '/var/mail/cltbld', 12:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:53 INFO - 'MOZ_NO_REMOTE': '1', 12:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:53 INFO - 'NO_EM_RESTART': '1', 12:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 12:00:53 INFO - 'SHELL': '/bin/bash', 12:00:53 INFO - 'SHLVL': '1', 12:00:53 INFO - 'TERM': 'linux', 12:00:53 INFO - 'TMOUT': '86400', 12:00:53 INFO - 'USER': 'cltbld', 12:00:53 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:53 INFO - '_': '/tools/buildbot/bin/python'} 12:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:00:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:00:55 INFO - Installing collected packages: mozsystemmonitor 12:00:55 INFO - Running setup.py install for mozsystemmonitor 12:00:55 INFO - Successfully installed mozsystemmonitor 12:00:55 INFO - Cleaning up... 12:00:55 INFO - Return code: 0 12:00:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:00:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:00:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:00:55 INFO - Using env: {'DISPLAY': ':0', 12:00:55 INFO - 'HOME': '/home/cltbld', 12:00:55 INFO - 'LANG': 'en_US.UTF-8', 12:00:55 INFO - 'LANGUAGE': 'en_US:en', 12:00:55 INFO - 'LOGNAME': 'cltbld', 12:00:55 INFO - 'MAIL': '/var/mail/cltbld', 12:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:55 INFO - 'MOZ_NO_REMOTE': '1', 12:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:55 INFO - 'NO_EM_RESTART': '1', 12:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:00:55 INFO - 'PWD': '/builds/slave/test-pgo', 12:00:55 INFO - 'SHELL': '/bin/bash', 12:00:55 INFO - 'SHLVL': '1', 12:00:55 INFO - 'TERM': 'linux', 12:00:55 INFO - 'TMOUT': '86400', 12:00:55 INFO - 'USER': 'cltbld', 12:00:55 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:55 INFO - '_': '/tools/buildbot/bin/python'} 12:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:00:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:00:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:00:57 INFO - Downloading docopt-0.6.1.tar.gz 12:00:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:00:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:00:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:00:57 INFO - Running setup.py install for blobuploader 12:00:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:00:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:00:58 INFO - Running setup.py install for requests 12:00:58 INFO - Running setup.py install for docopt 12:00:58 INFO - Successfully installed blobuploader requests docopt 12:00:58 INFO - Cleaning up... 12:00:58 INFO - Return code: 0 12:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:00:58 INFO - Using env: {'DISPLAY': ':0', 12:00:58 INFO - 'HOME': '/home/cltbld', 12:00:58 INFO - 'LANG': 'en_US.UTF-8', 12:00:58 INFO - 'LANGUAGE': 'en_US:en', 12:00:58 INFO - 'LOGNAME': 'cltbld', 12:00:58 INFO - 'MAIL': '/var/mail/cltbld', 12:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:58 INFO - 'MOZ_NO_REMOTE': '1', 12:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:00:58 INFO - 'NO_EM_RESTART': '1', 12:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 12:00:58 INFO - 'SHELL': '/bin/bash', 12:00:58 INFO - 'SHLVL': '1', 12:00:58 INFO - 'TERM': 'linux', 12:00:58 INFO - 'TMOUT': '86400', 12:00:58 INFO - 'USER': 'cltbld', 12:00:58 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:58 INFO - '_': '/tools/buildbot/bin/python'} 12:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:00:58 INFO - Running setup.py (path:/tmp/pip-cbg_ao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:00:58 INFO - Running setup.py (path:/tmp/pip-nPYxQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:00:58 INFO - Running setup.py (path:/tmp/pip-qCP4wg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:00:58 INFO - Running setup.py (path:/tmp/pip-S1niqC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:00:59 INFO - Running setup.py (path:/tmp/pip-s801AL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:00:59 INFO - Running setup.py (path:/tmp/pip-JtgfP7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:00:59 INFO - Running setup.py (path:/tmp/pip-rM3_XA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:00:59 INFO - Running setup.py (path:/tmp/pip-pqcOjS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:00:59 INFO - Running setup.py (path:/tmp/pip-lKlDPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:00:59 INFO - Running setup.py (path:/tmp/pip-2x6jVq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:00:59 INFO - Running setup.py (path:/tmp/pip-txwElO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:00:59 INFO - Running setup.py (path:/tmp/pip-FpuDbq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:00:59 INFO - Running setup.py (path:/tmp/pip-Mfsokd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:00:59 INFO - Running setup.py (path:/tmp/pip-TnieuT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:00:59 INFO - Running setup.py (path:/tmp/pip-dfSaau-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:00:59 INFO - Running setup.py (path:/tmp/pip-Io4l4I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:00:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:00:59 INFO - Running setup.py (path:/tmp/pip-eEqKiT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:00:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:00:59 INFO - Running setup.py install for manifestparser 12:01:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Running setup.py install for mozcrash 12:01:00 INFO - Running setup.py install for mozdebug 12:01:00 INFO - Running setup.py install for mozdevice 12:01:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Running setup.py install for mozfile 12:01:00 INFO - Running setup.py install for mozhttpd 12:01:00 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Running setup.py install for mozinfo 12:01:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Running setup.py install for mozInstall 12:01:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:01:00 INFO - Running setup.py install for mozleak 12:01:00 INFO - Running setup.py install for mozlog 12:01:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Running setup.py install for moznetwork 12:01:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Running setup.py install for mozprocess 12:01:01 INFO - Running setup.py install for mozprofile 12:01:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Running setup.py install for mozrunner 12:01:01 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Running setup.py install for mozscreenshot 12:01:01 INFO - Running setup.py install for moztest 12:01:01 INFO - Running setup.py install for mozversion 12:01:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:01:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:01 INFO - Cleaning up... 12:01:01 INFO - Return code: 0 12:01:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:01:01 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')]} 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 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')]} 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:01:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 12:01:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:01:01 INFO - Using env: {'DISPLAY': ':0', 12:01:01 INFO - 'HOME': '/home/cltbld', 12:01:01 INFO - 'LANG': 'en_US.UTF-8', 12:01:01 INFO - 'LANGUAGE': 'en_US:en', 12:01:01 INFO - 'LOGNAME': 'cltbld', 12:01:01 INFO - 'MAIL': '/var/mail/cltbld', 12:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:01 INFO - 'MOZ_NO_REMOTE': '1', 12:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:01 INFO - 'NO_EM_RESTART': '1', 12:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:01 INFO - 'SHELL': '/bin/bash', 12:01:01 INFO - 'SHLVL': '1', 12:01:01 INFO - 'TERM': 'linux', 12:01:01 INFO - 'TMOUT': '86400', 12:01:01 INFO - 'USER': 'cltbld', 12:01:01 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:01 INFO - '_': '/tools/buildbot/bin/python'} 12:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:01 INFO - Running setup.py (path:/tmp/pip-U69Mkm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:02 INFO - Running setup.py (path:/tmp/pip-Jci3h7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:02 INFO - Running setup.py (path:/tmp/pip-WVBVG0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:02 INFO - Running setup.py (path:/tmp/pip-ZtQ4z9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:02 INFO - Running setup.py (path:/tmp/pip-cOcuSv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:02 INFO - Running setup.py (path:/tmp/pip-pbs71h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:02 INFO - Running setup.py (path:/tmp/pip-BZjiah-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:02 INFO - Running setup.py (path:/tmp/pip-XN75AC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:02 INFO - Running setup.py (path:/tmp/pip-PG3okV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:02 INFO - Running setup.py (path:/tmp/pip-OHsCvO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:02 INFO - Running setup.py (path:/tmp/pip-KjaVWO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:02 INFO - Running setup.py (path:/tmp/pip-IK_vld-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:01:02 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)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:02 INFO - Running setup.py (path:/tmp/pip-2HB_3n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 12:01:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:02 INFO - Running setup.py (path:/tmp/pip-zJOoD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:01:03 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)) 12:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:03 INFO - Running setup.py (path:/tmp/pip-fwqlUr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:01:03 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)) 12:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:03 INFO - Running setup.py (path:/tmp/pip-WuGC5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:01:03 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)) 12:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:03 INFO - Running setup.py (path:/tmp/pip-eJ39J4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:01:03 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)) 12:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 12:01:03 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)) 12:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:01:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:01:03 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 12:01:03 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 12:01:03 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 12:01:03 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 12:01:03 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 12:01:03 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 12:01:04 INFO - Downloading blessings-1.5.1.tar.gz 12:01:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:01:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:04 INFO - Installing collected packages: blessings 12:01:04 INFO - Running setup.py install for blessings 12:01:05 INFO - Successfully installed blessings 12:01:05 INFO - Cleaning up... 12:01:05 INFO - Return code: 0 12:01:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:01:05 INFO - Reading from file tmpfile_stdout 12:01:05 INFO - Current package versions: 12:01:05 INFO - argparse == 1.2.1 12:01:05 INFO - blessings == 1.5.1 12:01:05 INFO - blobuploader == 1.2.4 12:01:05 INFO - docopt == 0.6.1 12:01:05 INFO - manifestparser == 1.1 12:01:05 INFO - mozInstall == 1.12 12:01:05 INFO - mozcrash == 0.16 12:01:05 INFO - mozdebug == 0.1 12:01:05 INFO - mozdevice == 0.47 12:01:05 INFO - mozfile == 1.2 12:01:05 INFO - mozhttpd == 0.7 12:01:05 INFO - mozinfo == 0.9 12:01:05 INFO - mozleak == 0.1 12:01:05 INFO - mozlog == 3.0 12:01:05 INFO - moznetwork == 0.27 12:01:05 INFO - mozprocess == 0.22 12:01:05 INFO - mozprofile == 0.27 12:01:05 INFO - mozrunner == 6.11 12:01:05 INFO - mozscreenshot == 0.1 12:01:05 INFO - mozsystemmonitor == 0.0 12:01:05 INFO - moztest == 0.7 12:01:05 INFO - mozversion == 1.4 12:01:05 INFO - psutil == 3.1.1 12:01:05 INFO - requests == 1.2.3 12:01:05 INFO - wsgiref == 0.1.2 12:01:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0edf076c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271c6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27dd3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, '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': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', '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 12:01:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 12:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:01:05 INFO - Using env: {'DISPLAY': ':0', 12:01:05 INFO - 'HOME': '/home/cltbld', 12:01:05 INFO - 'LANG': 'en_US.UTF-8', 12:01:05 INFO - 'LANGUAGE': 'en_US:en', 12:01:05 INFO - 'LOGNAME': 'cltbld', 12:01:05 INFO - 'MAIL': '/var/mail/cltbld', 12:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:05 INFO - 'MOZ_NO_REMOTE': '1', 12:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:05 INFO - 'NO_EM_RESTART': '1', 12:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:05 INFO - 'SHELL': '/bin/bash', 12:01:05 INFO - 'SHLVL': '1', 12:01:05 INFO - 'TERM': 'linux', 12:01:05 INFO - 'TMOUT': '86400', 12:01:05 INFO - 'USER': 'cltbld', 12:01:05 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:05 INFO - '_': '/tools/buildbot/bin/python'} 12:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 12:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:01:05 INFO - Cleaning up... 12:01:05 INFO - Return code: 0 12:01:05 INFO - Running post-action listener: _resource_record_post_action 12:01:05 INFO - Running post-action listener: _start_resource_monitoring 12:01:05 INFO - Starting resource monitoring. 12:01:05 INFO - ##### 12:01:05 INFO - ##### Running install step. 12:01:05 INFO - ##### 12:01:05 INFO - Running pre-action listener: _resource_record_pre_action 12:01:05 INFO - Running main action method: install 12:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:01:05 INFO - Reading from file tmpfile_stdout 12:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:01:05 INFO - Reading from file tmpfile_stdout 12:01:05 INFO - Output received: 12:01:05 INFO - Usage: mozinstall [options] installer 12:01:05 INFO - Options: 12:01:05 INFO - -h, --help show this help message and exit 12:01:05 INFO - -d DEST, --destination=DEST 12:01:05 INFO - Directory to install application into. [default: 12:01:05 INFO - "/builds/slave/test-pgo"] 12:01:05 INFO - --app=APP Application being installed. [default: firefox] 12:01:05 INFO - mkdir: /builds/slave/test-pgo/build/application 12:01:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:01:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:01:22 INFO - Reading from file tmpfile_stdout 12:01:22 INFO - Output received: 12:01:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:01:22 INFO - Running post-action listener: _resource_record_post_action 12:01:22 INFO - ##### 12:01:22 INFO - ##### Running run-tests step. 12:01:22 INFO - ##### 12:01:22 INFO - Running pre-action listener: _resource_record_pre_action 12:01:22 INFO - Running main action method: run_tests 12:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:01:22 INFO - Python 2.7.3 12:01:22 INFO - Return code: 0 12:01:22 INFO - grabbing minidump binary from tooltool 12:01:22 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')]} 12:01:22 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 0x28668c0>, '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 0x2813420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28138b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:01:22 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 12:01:22 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 12:01:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:22 INFO - Return code: 0 12:01:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:01:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:01:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:01:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:01:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost 12:01:22 INFO - Using env: {'DISPLAY': ':0', 12:01:22 INFO - 'HOME': '/home/cltbld', 12:01:22 INFO - 'LANG': 'en_US.UTF-8', 12:01:22 INFO - 'LANGUAGE': 'en_US:en', 12:01:22 INFO - 'LOGNAME': 'cltbld', 12:01:22 INFO - 'MAIL': '/var/mail/cltbld', 12:01:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:01:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:22 INFO - 'MOZ_NO_REMOTE': '1', 12:01:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:22 INFO - 'NO_EM_RESTART': '1', 12:01:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:01:22 INFO - 'PWD': '/builds/slave/test-pgo', 12:01:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:01:22 INFO - 'SHELL': '/bin/bash', 12:01:22 INFO - 'SHLVL': '1', 12:01:22 INFO - 'TERM': 'linux', 12:01:22 INFO - 'TMOUT': '86400', 12:01:22 INFO - 'USER': 'cltbld', 12:01:22 INFO - 'XDG_SESSION_COOKIE': 'a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710', 12:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:22 INFO - '_': '/tools/buildbot/bin/python'} 12:01:22 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost'] with output_timeout 3600 12:01:22 INFO - mozversion INFO | application_buildid: 20151114103013 12:01:22 INFO - mozversion INFO | application_changeset: 50b5e58fd4cd039010f8dc46e7739aee8d8ba68a 12:01:22 INFO - mozversion INFO | application_display_name: Nightly 12:01:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:22 INFO - mozversion INFO | application_name: Firefox 12:01:22 INFO - mozversion INFO | application_remotingname: firefox 12:01:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:01:22 INFO - mozversion INFO | application_vendor: Mozilla 12:01:22 INFO - mozversion INFO | application_version: 45.0a1 12:01:22 INFO - mozversion INFO | platform_buildid: 20151114103013 12:01:22 INFO - mozversion INFO | platform_changeset: 50b5e58fd4cd039010f8dc46e7739aee8d8ba68a 12:01:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:01:22 INFO - mozversion INFO | platform_version: 45.0a1 12:01:22 INFO - 2015-11-14 12:01:22,965 DEBUG : using testdate: 1447531282 12:01:22 INFO - 2015-11-14 12:01:22,965 DEBUG : actual date: 1447531282 12:01:23 INFO - 2015-11-14 12:01:23,057 INFO : starting webserver on 'localhost:32943' 12:01:23 INFO - 2015-11-14 12:01:23,058 INFO : Starting test suite talos-linux64-ix-033.e 12:01:23 INFO - 2015-11-14 12:01:23,058 INFO : Starting test dromaeo_css 12:01:23 INFO - 2015-11-14 12:01:23,058 DEBUG : operating with platform_type : linux_ 12:01:23 INFO - 2015-11-14 12:01:23,058 INFO : Initialising browser for dromaeo_css test... 12:01:23 INFO - 2015-11-14 12:01:23,065 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pWOne/profile http://localhost:32943/getInfo.html 12:01:28 INFO - 2015-11-14 12:01:28,949 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:01:28 INFO - 2015-11-14 12:01:28,949 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:01:28 INFO - 2015-11-14 12:01:28,949 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:01:28 INFO - 2015-11-14 12:01:28,949 DEBUG : BROWSER_OUTPUT: __metrics 12:01:30 INFO - 2015-11-14 12:01:30,293 INFO : Browser initialized. 12:01:30 INFO - 2015-11-14 12:01:30,294 INFO : Running cycle 1/1 for dromaeo_css test... 12:01:30 INFO - 2015-11-14 12:01:30,294 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_pWOne/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:01:42 INFO - 2015-11-14 12:01:42,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 140632064 12:01:42 INFO - 2015-11-14 12:01:42,056 DEBUG : BROWSER_OUTPUT: 12:02:31 INFO - 2015-11-14 12:02:31,668 DEBUG : BROWSER_OUTPUT: 1447531351668 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] 12:04:40 INFO - 2015-11-14 12:04:40,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32943/tests/dromaeo/cssquery-ext.html) 12:04:41 INFO - 2015-11-14 12:04:41,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 146841600 12:04:41 INFO - 2015-11-14 12:04:41,219 DEBUG : BROWSER_OUTPUT: 12:07:43 INFO - 2015-11-14 12:07:43,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-ext.html (next: http://localhost:32943/tests/dromaeo/cssquery-jquery.html) 12:07:43 INFO - 2015-11-14 12:07:43,724 DEBUG : BROWSER_OUTPUT: RSS: Main: 140660736 12:07:43 INFO - 2015-11-14 12:07:43,725 DEBUG : BROWSER_OUTPUT: 12:10:45 INFO - 2015-11-14 12:10:45,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32943/tests/dromaeo/cssquery-mootools.html) 12:10:46 INFO - 2015-11-14 12:10:46,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 12:10:46 INFO - 2015-11-14 12:10:46,006 DEBUG : BROWSER_OUTPUT: 12:13:47 INFO - 2015-11-14 12:13:47,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32943/tests/dromaeo/cssquery-prototype.html) 12:13:48 INFO - 2015-11-14 12:13:48,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 140177408 12:13:48 INFO - 2015-11-14 12:13:48,201 DEBUG : BROWSER_OUTPUT: 12:16:50 INFO - 2015-11-14 12:16:50,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32943/tests/dromaeo/cssquery-yui.html) 12:16:51 INFO - 2015-11-14 12:16:51,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 141389824 12:16:51 INFO - 2015-11-14 12:16:51,069 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/dromaeo/cssquery-yui.html (next: http://localhost:32943/tests/dromaeo/cssquery-dojo.html) 12:19:53 INFO - 2015-11-14 12:19:53,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 143597568 12:19:53 INFO - 2015-11-14 12:19:53,514 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,515 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:19:53 INFO - 2015-11-14 12:19:53,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:19:53 INFO - 2015-11-14 12:19:53,516 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:19:53 INFO - 2015-11-14 12:19:53,516 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:19:53 INFO - 2015-11-14 12:19:53,519 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3222.871085156593;3265.6407795142545;3289.4407950648388;3305.6033276006883;3306.735461163107;5367.677939323634;5428.212909128179;5441.483059109388;5468.781248750045;5483.780648774049;5455.372632147304;5465.152901300295;5490.588205884555;5553.805616803413;5591;4893.29047288143;5008.373953255825;5037.345145131146;5046.54581087702;5065.240213967897;5036.068327359432;5040.949590504085;5058.038972595214;5107.744612769366;5125.282460455539;4830.903381932377;4923.926141107886;5003.849884503471;5005.649604527666;5168.198929165967;4897.608191344684;4995.625328100407;5000.774965126578;5004.649674522785;5035.899282014339;4870.975645121752;4969.204927211665;4999;5014.52362025607;5034.672746271481;5027.3464449621315;5145.614078944057;5153.742312884341;5262.2632831403635;5274.26160337553;5882.705864706791;5924.5260379169995;5925.4963328117165;5927.407259274081;5929.1995580596495;5924;5928.644281343133;5932.555058370596;5941.940580594225;5945.554083443716;5331.173668081454;5445.319335083114;5450.754716037788;5570.41510641385;5592.748326325325;5921.526277897758;5957.463828255478;5960.37416071315;5985.581009329392;6055.7274922628585;5770.336411312753;5773.913391299134;5783.479486846204;5790.855228619318;5802.941970580325;5698.914516282259;5770.826875193751;5857.7656893724625;5887.264091988502;5910.083936989773;5747.224124743189;5772.509336706343;5776.797812076641;5824.650520968671;5949.286085669661;5696.11710184922;5745.023346031185;5748.080307150836;5748.7125643717645;5806.970965145148;4442.2892337225885;4508.278675411918;4511;4512.796924138422;4547.931781023221;4063.329550624173;4065.6747460203114;4068.8372465101656;4082.6733861291027;4105.178964207111;5447.319085114361;5525;5654.264945557051;5674.120511320752;5681.687507187145;5783.277090363705;5826.621269617462;5858.443447872445;5918.408159184047;5943.435373639497;5624.156376543551;5647.29408823897;5648.406917273627;5652.095664693629;5675;5042.193249080129;5124.948750512522;5137.229415587692;5164.690118592896;5165.096108181053;5973.163757074013;6099.878002439927;6104.8779024420155;6110.419510146529;6141.416565426277;5921.082232254007;5943.58394912352;5948.791792287249;5952.970235148797;5962.821115366546;5952.107183922273;6024.337322894566;6153.538484613761;6160.291566469913;6167.5682702210415;5712.885742285214;5780.508656764222;5788.652680839163;5788.82633520995;5838.299404071538;5919;5943.257092863392;5946.970265148647;5961.016432288798;5968.46283834457;5638.887222255614;5731.197632331394;5744.684042377542;5784.248047753765;5802.332731735735;5758.1650660654805;5774.816162686555;5788.681622510802;5806.709664516842;5843.94156058434;5596.1605759136455;5615.129654903497;5636.2954630671165;5640.576956728344;5671.149327600893;5585.720713964367;5659.151127330769;5763.625364351304;5792.681402522733;5957.523398128226;5615.354234263112;5661.858453538694;5670.064439367458;5672.234248376416;5687.260656114844 12:19:53 INFO - 2015-11-14 12:19:53,521 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.7021643420769;569.7720911635346;584.1529781816367;584.8479395357206;587.5358466811222;39686.40470392943;40380.79809600955;40855.97860053497;40913.59086409135;41011.58988410115;44053.77973110138;44485.332720009224;44784.55215447844;44917.10165796682;45060;8697.478151310941;8822.470651760883;8857.734267971971;8858.822823543525;8885.822283554326;8644.481331120152;8736.694215702451;8742.4754514729;8788.16512431318;8803.207711306013;8644.956775216115;8670.52312122833;8699.478031318109;8730.432521886089;8733.03936566977;8583.14168583143;8740.562971851414;8761.430507017056;8797.47215167092;8838.734837954871;8608.612612432393;8698.69519572063;8713.259372953307;8776.78058048554;8808.25129863956;40231.39652905209;40758.18483630311;41054.178916421806;41166;41301.79349103265;3286.1784553861535;3314.330510198504;3387.6951074403178;3478.652134786501;3802.9120235186597;29583.70416295831;29660.8516957416;29931.25171870699;30618.387632247453;31217.21956951072;3181.9340520925516;3184.283536204359;3191.3617276544783;3194.0896844399467;3242.238074052596;286776;287329;288531;289145;290003;42070.57929420728;60594.394056059755;60684.393156067876;61029.38970610326;61073.38926610677;42619.57380426156;42753.35869961953;42946;42963;43010.13979720388;14735.484258050918;15007.474738384322;15091.245437728288;15150.772738408932;15219.695606087816;11060.502277397536;11111.944440277908;11168.050715689094;11176.944115279533;11228.943855280835;14588.781168282485;14651.34068966899;14654.19401932904;14716;14854.777178342334;5805.651660900359;5957.4042595740075;5995;6036.426539478743;6066.696665166724;863.7063398444434;920.9907900920905;959.2326139088701;1071.6838532632892;1072.785442911421;27958.3010424741;28618;29121.7087829119;29173.85413072921;29417.411651766844;996.9252306077074;1031.4481752262654;1041.317936751429;1064.840273958897;1130.9708165569293;15074.321655525528;15118.546443606709;15157.62105947338;15217.163056032025;15219.315130819139;343512;348840;349442;350649;351513;53421;53530.464695352544;53694;53716;53865.461345386044;1254.6612414647993;1300.959232613905;1316.3418290854572;1321.6431563477806;1334.0394915660709;27509.587356190073;28415.43169136647;28644.42711145807;28827.42345153127;28865.42269154647;47745.76127119342;47865.76067119642;48171.5182848167;48207.75896120497;48216.758916205195;313398;316070;316665;318180;318603;27691.446171076062;28660.283492912844;31721.682783172797;32544.674553254164;33223.33553328968;38630;39132.608673912895;40091;40111.59888401195;41468.170636586496;35906.64093359033;36072.27855442929;36463;36617.45073823948;37277.440838387985;35141.82429087838;35855.75328564773;36172.81913590415;36277.818610906776;36389.27221455609;35269.470957936166;35590;36365.63634363622;36382;36415;31406;32713.672863271062;33257.83371083226;33266.501002485464;33268.1682957928;26119.216423507325;26439.33901652474;27983.16050518488;28342.291442714097;28462.715372846007 12:19:53 INFO - 2015-11-14 12:19:53,524 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.28805947806995;349.37810696959406;349.4670627293377;352.6332614081355;355.445505012181;13864.722705545882;14243.14541127533;16301.918490407561;16802.579935501602;17478.388256411014;15448.613784655388;15647.921760391211;17039.233234504445;17064.146792660347;17093;4331.45856767904;4415.470143582775;4442.2448183808665;4452.376667266585;4454.53227411122;4452.8441504547345;4721.315409265654;4820.8071677132875;4844.539768721984;4865.318855360252;4703.012367402849;4713.222318317474;4734.053189362124;4742.620590352763;4910.140725373063;4955.876103097434;5028.069807085701;5048.7980480780725;5052.69683818972;5055.418626857903;4323.092150648367;4348.478182618074;4349.717268377545;4352.455943007124;4419.756913369763;13560.389782459813;13685.384157712926;14179.574612761633;14248.643783905381;14265.144091354552;1816.3551939061706;1817.1822679794145;1899.3921944977612;1966.0955960258298;2121.501447159916;9985.45080020606;10001.59993600255;10154.249300220365;10191.54138063789;10440.791184176274;1672.7323628219426;1687.7890263717036;1700.8214137515506;1714.3828221840129;1760.155125539748;63655;64310.356896431374;64545.67727161381;64866.35133648697;65590.67204663994;6955.93044069563;7044.682989265393;7052.977318288922;7096.219415864251;7125.42996560274;8469.830603387898;8491.065982741893;8506.489610623383;8512.063672995966;8558.400911936229;5547.44525547442;5549.639273447213;5564.916526252109;5572.414896435897;5584.888302233932;5644.181593668895;5657.43425657431;5847.649141051551;5848.356680765112;5910.911336329958;3166.7149956503563;3188.234823642309;3199.9200019999685;3206.695363940422;3220.6457289698114;1187.2223693480785;1189.3874654552912;1190.2978740401136;1201.567435723139;1237.0907383073434;448.2894612039953;465.3252783463991;485.45628895636406;507.7841917185182;511.744127936032;10655.520501577448;11449.542018319175;11584.189106762615;11642.24325418862;12110.515579376726;490.2988726121609;490.4335492506161;508.6719066202353;511.9513646203605;529.5789847071587;6441.677916104176;6623.4701223901975;6664.300248473937;6677.165354330708;6725.899111513331;530986;532729;536287;545611;550280;76198.61900690461;78749.60625196838;79615;79822;80524.59737701275;549.1680104641472;550.4605486623132;554.0359773993223;554.1715135871897;554.5037191713475;10457.320274182153;10932.125429965425;10983.835242471529;11190.552377904793;11251.043661288883;36371.45442818413;37187.25625487529;37210.441843372915;37367.065823354635;37613.623863761015;44751.77624111858;45505.77247113743;48158.27762583494;48213;48827.75586122047;6580.21037475506;6616.536842420985;6672.5329226953645;6680.766173183915;6691.9962005699535;11732.12009099304;11829.940850295694;11964.820527691918;12223.69440763988;12471.5011399543;10613.522391492555;10673.519691613741;10698.946505267424;10808.621698240524;10866.239363244496;10310.278280520592;10428.634997775041;10762.246642734934;10827.566897324334;10856.077233434931;10594.735131621772;10674.46627668629;10790.460476975963;11015.228933974546;11022.944885275523;6710.362515561014;6878.449724021966;6922.688479018356;6932.826679332855;7074.045003924404;10949.178811589321;11186.049185819296;11249.887501124884;11268.38023908693;11278.210525263154 12:19:53 INFO - 2015-11-14 12:19:53,526 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.9398424063038;1655.917204139793;1746.3189356151104;1749.623830876362;1762.2246211666866;7016.298370162987;7166.5700057996555;7193.856122877546;7221.133463984329;7403.740869069584;7320.158181809094;7347.191808901017;7446.404287656988;7446.627668616561;7476;2204.129368899288;2220.2673117871145;2220.4448887778058;2232.3749350181974;2233.932982010542;2190.3866917263113;2196.4838263008182;2205.9448513787124;2226.465648244418;2234.8323875709307;2182.1162429216192;2191.079746506463;2192.2765487389124;2221.144859229192;2231.6429371300596;2198.1537108213374;2215.9778402215934;2232.7097477327925;2233.564454931289;2235.2400183937457;2191.0468946008536;2195.6926030355603;2209.5470428562267;2209.845310828243;2219.1012639880873;7160.391366733834;7292.67182976762;7298.562086274787;7330.303621155982;7334.523255988343;4415.646748260131;4471.597556219924;4482.350059241425;4482.843100491467;4513.413256276663;2926.5024945759274;2982.492976194052;3006.1733023418733;3009.3981203759117;3027.2734543709353;931.0828833598899;945.1729736480579;961.1253759079274;961.1397798969883;972.7811242470458;9829.3610915291;9884.357516761387;9892.505374731234;9911.40531568101;9914.851277230848;3931.3709806430834;3946.664533514626;3962.5046869141356;3963;4035.273650742836;8080;8136.430449868571;8137.3490120791375;8146.2261085196815;8147.633356498972;4296.5273819879785;4321.2005778931;4323.178596066738;4324.913501729948;4334.241507736134;3894.805259737002;3957.1689945111275;3980.641742243212;4082.795860206978;4099.364598487239;3408;3422.709069729051;3435.519027336175;3445.87939422119;3459.619441861393;1075.5912753153752;1089.934603923767;1093.1801149138146;1098.2531878322657;1098.961536346224;935.1209862729013;940.7130825098274;941.1200527506803;997.9002099790108;1277.9680507987189;6883.7590684325805;6899.965500172467;6918.515703900779;6924.134483189601;6924.688389022506;465.864899179241;467.5161208149549;478.63384510849227;478.77258302306126;478.7749757613916;5204.297419848272;5233.058049551118;5249.632525723239;5255.290535777697;5277.683338999673;8364.707235246737;8453.070162282143;8489.787755306043;8496.66013359471;8595.871061934076;8454.239118479243;8462.830743385099;8481.363897707697;8547.743567692854;8566.571671416405;6699.464042876558;6728.932710672831;6768.763093291711;6773.254941956479;6848;6716;6727.293634168537;6739.73041078371;6756.662166891734;6759.695813688298;7431.962840185981;7720.884186737091;7798;7835.764927052198;7877.369810415038;7835.921640783519;7967.083785364757;7999.120096789232;8046.0344758627;8083.110857805519;6246.219222597176;6525.3800888915475;6544.051112588743;6601.3728695773825;6621.900671489835;7034.2965703429245;7042.823929401806;7059.611721355374;7059.823504412226;7068.151821781419;6386.010168423902;6504.837379065561;6577.868442631217;6627.867442651216;6712.194536655633;6440.806775796734;6521.6087034776165;6542.803715888531;6563.573367731273;6581.308962559054;6355.968220158869;6403.679816009274;6419.646919419477;6459.935400645933;6478.870422591616;6026.216591843032;6064.909026364697;6251.6561589113035;6263.843403914939;6264.686765661608;6225.595336303307;6255.155554000152;6269.12232287471;6274.184356033869;6279.246490421178 12:19:53 INFO - 2015-11-14 12:19:53,527 DEBUG : BROWSER_OUTPUT: |4;prototype.html;316.73710820019386;319.55741298301854;323.25812260861323;325.1691927126193;328.510519326204;6266.498680105592;6297.622142671437;6341.302456729762;6344.302126766052;6442.838929026765;6233.719482623282;6276.309605943343;6289.811305660837;6311.147995020671;6323.936760632392;4585.151746926813;4685.601723853477;4687.742174180418;4699.412573428322;4702.741349225791;4680.531946805327;4704.424017953989;4704.576588107069;4723.740194289313;4723.763811809413;4672.532746725335;4674;4687.414073240845;4689.531046895318;4700.271457924027;4668.043051174501;4670.252759558488;4671.369365135697;4679.415073115861;4686.2267725825195;3916.2167566486532;4028.274910516106;4033.2135233629456;4052;4082.5917408259234;5854;5871.647701137946;5889.7644094236175;5890.263717035371;5894.469497745224;5464.754086066137;5474.233607294982;5476.972615136899;5478.342598888159;5481.314835645544;6564.277929427759;6589.80230593083;6589.80230593083;6622.238442579117;6633.635150066744;4395.956040439619;4444.444444444444;4462.330650402433;4505.279155335131;4514.14231296056;6903.344182302673;6908.861822763517;6917.308269173092;6954.9304506955295;6987.231404545496;4533.32000199966;4539.568740969603;4540.8637740867825;4541.931871021938;4558.2251017327135;4482.058767658828;4592.127495775792;4613.077384523109;4615.976920115445;4618.122556714214;5399.83800485986;5408.91886621701;5418.864528386743;5421.728913554307;5425.83722488326;6659.567128136656;6691.498137639696;6700.296468870698;6708.429783468362;6743.460523158135;1630.624956260067;1642.6550424410768;1656.0477725307996;1662.6508433228917;1662.9357211384724;1075.542894269932;1085.2457542008385;1085.9674209773718;1098.6429410441638;1107.983380249297;6461.256955450183;6480.31956644555;6501.284858665543;6522.021696745526;6582.156996041116;7031.050808140938;7047.612381319077;7058.11773528309;7071.717131314793;7078.646067696594;6588.374104460068;6588.604683718992;6595;6598.8350291243105;6606.933930660728;3724.2179142380405;3755.080005398695;3782.205736795249;3797.468354430382;3802.1825307559006;7309.671064802096;7314.890276645855;7343.70625174987;7354.521956072945;7356.816079598053;7215.654912153571;7236;7247.818804529929;7259.201487836333;7266.527675701062;7191.065161528968;7314.26857314275;7332.450066245053;7348.375388092072;7378.631068446556;6953.965230173817;6975.651217439209;6980.685869135799;7009.2990700929495;7013.649317534205;6819.181698196248;6872.518923675295;6887.345702158287;6920.134983127109;6927.653617319214;7178.102737157856;7319.963400182965;7332.853342933005;7371.152317483558;7371.373433258019;4497.123061003073;4514.977425112854;4518.548145185455;4518.570735780096;4544.863654090383;6929.653517324013;6978.337057979484;6982.825429364103;6991.007562844565;6993.195782484876;6552.115464412243;6735.966320168368;6744.426723728538;6748.93251067483;6805.149356330458;6731.697073631601;6777.830554236183;6781.050652908695;6796.35434633709;6825.829354265985;6533.771318003847;6647.169103862017;6658.267590564937;6659.334066593302;6692.364225398579;6666.066750654815;6795.966020170065;6839.794806155824;6840.589564626139;6860.656967151523;6615.4376877965915;6647.335266473314;6676.198856137295;6694.531382803157;6699 12:19:53 INFO - 2015-11-14 12:19:53,528 DEBUG : BROWSER_OUTPUT: |5;yui.html;733.4499125655758;743.6058888788943;752.5296689569019;867.7657032601198;889.1064480197402;13203.867961320384;13405.329733513321;13441.395137218824;13479.3260336983;13493.865061349383;11824.645260642174;13329.066965312431;13415.932920335408;13416.932915335434;13452.730945381087;805.0621026504116;806.9556174410405;812.5368539932241;816.3673153306175;819.6885183630242;821.5317269156583;830.5639539241886;830.7466222802043;830.7881490219985;833.150186809454;863.3524856357732;871.1332224436694;871.8822958900562;872.5331947408138;874.1389731114879;851.1020872979036;857.1128881607568;859.1065292096213;862.1895418306802;862.3101518784978;631.0156156396037;632.2065807411669;632.7880160146357;633.5343522510951;635.4725577770439;12450.875491245153;12492.125551211418;12569.685757856036;12608.684782880502;12639.684007899785;10570.894291057068;10719.946400268027;10769.138468922467;10804.729881753019;11213.607523736711;9900.653477128266;10010.788344610513;10029.949850250776;10035.86017027349;10156.949215253877;3582.17609949713;3622.655847694491;3650.470681751158;3656.3784156693428;3659.2132691471197;38734.61265387338;40888.38667419991;41208.38187427221;42656.78671606622;45299.320510192374;10175;10274.537645805956;10308.072273495422;10315.226358023177;10353.9482302588;17985.190666420043;17986.730199047026;18036.2785488579;18091.366802162123;18226.45320640383;7398.704051837974;7539.623018849145;7650.73222437212;7729.033870766154;7776.183500732454;4272.957270427318;4337.8481753138485;4371.038371558252;4394.472663280427;4425.269830477935;2953.74893134086;3048.4360393327306;3049;3058.1742929408933;3058.250728571514;456.3086923311186;456.9383133276965;469.24217388917333;472.1359911362199;475.4223618303777;561.8651523634298;590.3918963467635;596.6956852005509;623.8939380305359;640.6636515829134;8422.620982055822;8461.40770146084;8608.655653773903;8832.602532885907;9282.48946307946;557.85495771099;566.0151336674157;575.4849409778309;586.1939832729996;630.7287866217571;4024.8993775155855;4048.7975601219823;4063.7358571692744;4107.466029416157;4214.1150358425075;56967.71516142393;57445;57786.13320800191;58014.419855801745;58072.709636451546;49388;49614.75192624086;49750.75124624354;49843.25235121476;49889.25166122511;43206;43299.134017318844;43603;44019.11961760811;44702;8074.273315401642;8415.242628163494;8557.015943166616;8702.564871756513;8856.025837157778;34328.313433730684;34873.47689784604;34961.82519087388;34971.30057398787;36383;43863.56136438595;44127.558724413626;44317.77841110774;44429.555704442544;44691;8068.636911338886;8159.510429374256;8187.3040791533385;8305.875411868707;8407.285380742705;12261.141720079866;12414.813777793159;12449.315287659265;12499.625011249676;12973.675658108623;11317.660470185907;11409;11553.24903881245;11914.40427978615;11915.344656043653;10630.681079567625;10898.182636302468;10925.125989920629;10927.398993055458;11286.435678216221;10088.899111008795;10224.182065434896;10368.326058806153;10955.56177752881;11646.184767066563;9580.856287155559;9624.615015399306;9624.773467750643;9781.462019588991;10235.948820255851;9094.454332740057;9116.817663646823;9242.630294788134;10051.145652619316;10112.59549618007 12:19:53 INFO - 2015-11-14 12:19:53,528 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:19:53 INFO - 2015-11-14 12:19:53,528 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:19:53 INFO - 2015-11-14 12:19:53,528 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 12:19:53 INFO - 2015-11-14 12:19:53,528 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: __startTimestamp1447532393514__endTimestamp 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,529 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5459.60 Median:5671.15 stddev:605.07 (10.7%) stddev-sans-first:580.92 12:19:53 INFO - 2015-11-14 12:19:53,530 DEBUG : BROWSER_OUTPUT: Values: 3222.9 3265.6 3289.4 3305.6 3306.7 5367.7 5428.2 5441.5 5468.8 5483.8 5455.4 5465.2 5490.6 5553.8 5591.0 4893.3 5008.4 5037.3 5046.5 5065.2 5036.1 5040.9 5058.0 5107.7 5125.3 4830.9 4923.9 5003.8 5005.6 5168.2 4897.6 4995.6 5000.8 5004.6 5035.9 4871.0 4969.2 4999.0 5014.5 5034.7 5027.3 5145.6 5153.7 5262.3 5274.3 5882.7 5924.5 5925.5 5927.4 5929.2 5924.0 5928.6 5932.6 5941.9 5945.6 5331.2 5445.3 5450.8 5570.4 5592.7 5921.5 5957.5 5960.4 5985.6 6055.7 5770.3 5773.9 5783.5 5790.9 5802.9 5698.9 5770.8 5857.8 5887.3 5910.1 5747.2 5772.5 5776.8 5824.7 5949.3 5696.1 5745.0 5748.1 5748.7 5807.0 4442.3 4508.3 4511.0 4512.8 4547.9 4063.3 4065.7 4068.8 4082.7 4105.2 5447.3 5525.0 5654.3 5674.1 5681.7 5783.3 5826.6 5858.4 5918.4 5943.4 5624.2 5647.3 5648.4 5652.1 5675.0 5042.2 5124.9 5137.2 5164.7 5165.1 5973.2 6099.9 6104.9 6110.4 6141.4 5921.1 5943.6 5948.8 5953.0 5962.8 5952.1 6024.3 6153.5 6160.3 6167.6 5712.9 5780.5 5788.7 5788.8 5838.3 5919.0 5943.3 5947.0 5961.0 5968.5 5638.9 5731.2 5744.7 5784.2 5802.3 5758.2 5774.8 5788.7 5806.7 5843.9 5596.2 5615.1 5636.3 5640.6 5671.1 5585.7 5659.2 5763.6 5792.7 5957.5 5615.4 5661.9 5670.1 5672.2 5687.3 12:19:53 INFO - 2015-11-14 12:19:53,530 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,530 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47907.35 Median:36122.55 stddev:83592.77 (231.4%) stddev-sans-first:83751.67 12:19:53 INFO - 2015-11-14 12:19:53,531 DEBUG : BROWSER_OUTPUT: Values: 556.7 569.8 584.2 584.8 587.5 39686.4 40380.8 40856.0 40913.6 41011.6 44053.8 44485.3 44784.6 44917.1 45060.0 8697.5 8822.5 8857.7 8858.8 8885.8 8644.5 8736.7 8742.5 8788.2 8803.2 8645.0 8670.5 8699.5 8730.4 8733.0 8583.1 8740.6 8761.4 8797.5 8838.7 8608.6 8698.7 8713.3 8776.8 8808.3 40231.4 40758.2 41054.2 41166.0 41301.8 3286.2 3314.3 3387.7 3478.7 3802.9 29583.7 29660.9 29931.3 30618.4 31217.2 3181.9 3184.3 3191.4 3194.1 3242.2 286776.0 287329.0 288531.0 289145.0 290003.0 42070.6 60594.4 60684.4 61029.4 61073.4 42619.6 42753.4 42946.0 42963.0 43010.1 14735.5 15007.5 15091.2 15150.8 15219.7 11060.5 11111.9 11168.1 11176.9 11228.9 14588.8 14651.3 14654.2 14716.0 14854.8 5805.7 5957.4 5995.0 6036.4 6066.7 863.7 921.0 959.2 1071.7 1072.8 27958.3 28618.0 29121.7 29173.9 29417.4 996.9 1031.4 1041.3 1064.8 1131.0 15074.3 15118.5 15157.6 15217.2 15219.3 343512.0 348840.0 349442.0 350649.0 351513.0 53421.0 53530.5 53694.0 53716.0 53865.5 1254.7 1301.0 1316.3 1321.6 1334.0 27509.6 28415.4 28644.4 28827.4 28865.4 47745.8 47865.8 48171.5 48207.8 48216.8 313398.0 316070.0 316665.0 318180.0 318603.0 27691.4 28660.3 31721.7 32544.7 33223.3 38630.0 39132.6 40091.0 40111.6 41468.2 35906.6 36072.3 36463.0 36617.5 37277.4 35141.8 35855.8 36172.8 36277.8 36389.3 35269.5 35590.0 36365.6 36382.0 36415.0 31406.0 32713.7 33257.8 33266.5 33268.2 26119.2 26439.3 27983.2 28342.3 28462.7 12:19:53 INFO - 2015-11-14 12:19:53,531 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,531 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27264.50 Median:4431.00 stddev:88463.26 (1996.5%) stddev-sans-first:88688.33 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: Values: 347.3 349.4 349.5 352.6 355.4 13864.7 14243.1 16301.9 16802.6 17478.4 15448.6 15647.9 17039.2 17064.1 17093.0 4331.5 4415.5 4442.2 4452.4 4454.5 4452.8 4721.3 4820.8 4844.5 4865.3 4703.0 4713.2 4734.1 4742.6 4910.1 4955.9 5028.1 5048.8 5052.7 5055.4 4323.1 4348.5 4349.7 4352.5 4419.8 13560.4 13685.4 14179.6 14248.6 14265.1 1816.4 1817.2 1899.4 1966.1 2121.5 9985.5 10001.6 10154.2 10191.5 10440.8 1672.7 1687.8 1700.8 1714.4 1760.2 63655.0 64310.4 64545.7 64866.4 65590.7 6955.9 7044.7 7053.0 7096.2 7125.4 8469.8 8491.1 8506.5 8512.1 8558.4 5547.4 5549.6 5564.9 5572.4 5584.9 5644.2 5657.4 5847.6 5848.4 5910.9 3166.7 3188.2 3199.9 3206.7 3220.6 1187.2 1189.4 1190.3 1201.6 1237.1 448.3 465.3 485.5 507.8 511.7 10655.5 11449.5 11584.2 11642.2 12110.5 490.3 490.4 508.7 512.0 529.6 6441.7 6623.5 6664.3 6677.2 6725.9 530986.0 532729.0 536287.0 545611.0 550280.0 76198.6 78749.6 79615.0 79822.0 80524.6 549.2 550.5 554.0 554.2 554.5 10457.3 10932.1 10983.8 11190.6 11251.0 36371.5 37187.3 37210.4 37367.1 37613.6 44751.8 45505.8 48158.3 48213.0 48827.8 6580.2 6616.5 6672.5 6680.8 6692.0 11732.1 11829.9 11964.8 12223.7 12471.5 10613.5 10673.5 10698.9 10808.6 10866.2 10310.3 10428.6 10762.2 10827.6 10856.1 10594.7 10674.5 10790.5 11015.2 11022.9 6710.4 6878.4 6922.7 6932.8 7074.0 10949.2 11186.0 11249.9 11268.4 11278.2 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5090.34 Median:6430.23 stddev:2607.28 (40.5%) stddev-sans-first:2600.66 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: Values: 1503.9 1655.9 1746.3 1749.6 1762.2 7016.3 7166.6 7193.9 7221.1 7403.7 7320.2 7347.2 7446.4 7446.6 7476.0 2204.1 2220.3 2220.4 2232.4 2233.9 2190.4 2196.5 2205.9 2226.5 2234.8 2182.1 2191.1 2192.3 2221.1 2231.6 2198.2 2216.0 2232.7 2233.6 2235.2 2191.0 2195.7 2209.5 2209.8 2219.1 7160.4 7292.7 7298.6 7330.3 7334.5 4415.6 4471.6 4482.4 4482.8 4513.4 2926.5 2982.5 3006.2 3009.4 3027.3 931.1 945.2 961.1 961.1 972.8 9829.4 9884.4 9892.5 9911.4 9914.9 3931.4 3946.7 3962.5 3963.0 4035.3 8080.0 8136.4 8137.3 8146.2 8147.6 4296.5 4321.2 4323.2 4324.9 4334.2 3894.8 3957.2 3980.6 4082.8 4099.4 3408.0 3422.7 3435.5 3445.9 3459.6 1075.6 1089.9 1093.2 1098.3 1099.0 935.1 940.7 941.1 997.9 1278.0 6883.8 6900.0 6918.5 6924.1 6924.7 465.9 467.5 478.6 478.8 478.8 5204.3 5233.1 5249.6 5255.3 5277.7 8364.7 8453.1 8489.8 8496.7 8595.9 8454.2 8462.8 8481.4 8547.7 8566.6 6699.5 6728.9 6768.8 6773.3 6848.0 6716.0 6727.3 6739.7 6756.7 6759.7 7432.0 7720.9 7798.0 7835.8 7877.4 7835.9 7967.1 7999.1 8046.0 8083.1 6246.2 6525.4 6544.1 6601.4 6621.9 7034.3 7042.8 7059.6 7059.8 7068.2 6386.0 6504.8 6577.9 6627.9 6712.2 6440.8 6521.6 6542.8 6563.6 6581.3 6356.0 6403.7 6419.6 6459.9 6478.9 6026.2 6064.9 6251.7 6263.8 6264.7 6225.6 6255.2 6269.1 6274.2 6279.2 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5587.85 Median:6470.79 stddev:1753.33 (27.1%) stddev-sans-first:1713.03 12:19:53 INFO - 2015-11-14 12:19:53,532 DEBUG : BROWSER_OUTPUT: Values: 316.7 319.6 323.3 325.2 328.5 6266.5 6297.6 6341.3 6344.3 6442.8 6233.7 6276.3 6289.8 6311.1 6323.9 4585.2 4685.6 4687.7 4699.4 4702.7 4680.5 4704.4 4704.6 4723.7 4723.8 4672.5 4674.0 4687.4 4689.5 4700.3 4668.0 4670.3 4671.4 4679.4 4686.2 3916.2 4028.3 4033.2 4052.0 4082.6 5854.0 5871.6 5889.8 5890.3 5894.5 5464.8 5474.2 5477.0 5478.3 5481.3 6564.3 6589.8 6589.8 6622.2 6633.6 4396.0 4444.4 4462.3 4505.3 4514.1 6903.3 6908.9 6917.3 6954.9 6987.2 4533.3 4539.6 4540.9 4541.9 4558.2 4482.1 4592.1 4613.1 4616.0 4618.1 5399.8 5408.9 5418.9 5421.7 5425.8 6659.6 6691.5 6700.3 6708.4 6743.5 1630.6 1642.7 1656.0 1662.7 1662.9 1075.5 1085.2 1086.0 1098.6 1108.0 6461.3 6480.3 6501.3 6522.0 6582.2 7031.1 7047.6 7058.1 7071.7 7078.6 6588.4 6588.6 6595.0 6598.8 6606.9 3724.2 3755.1 3782.2 3797.5 3802.2 7309.7 7314.9 7343.7 7354.5 7356.8 7215.7 7236.0 7247.8 7259.2 7266.5 7191.1 7314.3 7332.5 7348.4 7378.6 6954.0 6975.7 6980.7 7009.3 7013.6 6819.2 6872.5 6887.3 6920.1 6927.7 7178.1 7320.0 7332.9 7371.2 7371.4 4497.1 4515.0 4518.5 4518.6 4544.9 6929.7 6978.3 6982.8 6991.0 6993.2 6552.1 6736.0 6744.4 6748.9 6805.1 6731.7 6777.8 6781.1 6796.4 6825.8 6533.8 6647.2 6658.3 6659.3 6692.4 6666.1 6796.0 6839.8 6840.6 6860.7 6615.4 6647.3 6676.2 6694.5 6699.0 12:19:53 INFO - 2015-11-14 12:19:53,533 DEBUG : BROWSER_OUTPUT: 12:19:53 INFO - 2015-11-14 12:19:53,533 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13338.60 Median:24276.41 stddev:15368.44 (63.3%) stddev-sans-first:15382.40 12:19:53 INFO - 2015-11-14 12:19:53,534 DEBUG : BROWSER_OUTPUT: Values: 733.4 743.6 752.5 867.8 889.1 13203.9 13405.3 13441.4 13479.3 13493.9 11824.6 13329.1 13415.9 13416.9 13452.7 805.1 807.0 812.5 816.4 819.7 821.5 830.6 830.7 830.8 833.2 863.4 871.1 871.9 872.5 874.1 851.1 857.1 859.1 862.2 862.3 631.0 632.2 632.8 633.5 635.5 12450.9 12492.1 12569.7 12608.7 12639.7 10570.9 10719.9 10769.1 10804.7 11213.6 9900.7 10010.8 10029.9 10035.9 10156.9 3582.2 3622.7 3650.5 3656.4 3659.2 38734.6 40888.4 41208.4 42656.8 45299.3 10175.0 10274.5 10308.1 10315.2 10353.9 17985.2 17986.7 18036.3 18091.4 18226.5 7398.7 7539.6 7650.7 7729.0 7776.2 4273.0 4337.8 4371.0 4394.5 4425.3 2953.7 3048.4 3049.0 3058.2 3058.3 456.3 456.9 469.2 472.1 475.4 561.9 590.4 596.7 623.9 640.7 8422.6 8461.4 8608.7 8832.6 9282.5 557.9 566.0 575.5 586.2 630.7 4024.9 4048.8 4063.7 4107.5 4214.1 56967.7 57445.0 57786.1 58014.4 58072.7 49388.0 49614.8 49750.8 49843.3 49889.3 43206.0 43299.1 43603.0 44019.1 44702.0 8074.3 8415.2 8557.0 8702.6 8856.0 34328.3 34873.5 34961.8 34971.3 36383.0 43863.6 44127.6 44317.8 44429.6 44691.0 8068.6 8159.5 8187.3 8305.9 8407.3 12261.1 12414.8 12449.3 12499.6 12973.7 11317.7 11409.0 11553.2 11914.4 11915.3 10630.7 10898.2 10925.1 10927.4 11286.4 10088.9 10224.2 10368.3 10955.6 11646.2 9580.9 9624.6 9624.8 9781.5 10235.9 9094.5 9116.8 9242.6 10051.1 10112.6 12:19:53 INFO - 2015-11-14 12:19:53,534 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:19:53 INFO - 2015-11-14 12:19:53,534 DEBUG : BROWSER_OUTPUT: 12:19:54 INFO - 2015-11-14 12:19:54,341 INFO : Browser exited with error code: 0 12:19:54 INFO - 2015-11-14 12:19:54,360 INFO : Completed test dromaeo_css (00:18:31) 12:19:54 INFO - 2015-11-14 12:19:54,360 INFO : Starting test kraken 12:19:54 INFO - 2015-11-14 12:19:54,360 DEBUG : operating with platform_type : linux_ 12:19:54 INFO - 2015-11-14 12:19:54,360 INFO : Initialising browser for kraken test... 12:19:54 INFO - 2015-11-14 12:19:54,367 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSSZyPW/profile http://localhost:32943/getInfo.html 12:20:00 INFO - 2015-11-14 12:20:00,032 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:20:00 INFO - 2015-11-14 12:20:00,032 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:20:00 INFO - 2015-11-14 12:20:00,032 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:20:00 INFO - 2015-11-14 12:20:00,032 DEBUG : BROWSER_OUTPUT: __metrics 12:20:01 INFO - 2015-11-14 12:20:01,281 INFO : Browser initialized. 12:20:01 INFO - 2015-11-14 12:20:01,282 INFO : Running cycle 1/1 for kraken test... 12:20:01 INFO - 2015-11-14 12:20:01,282 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSSZyPW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:20:13 INFO - 2015-11-14 12:20:13,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 140906496 12:20:13 INFO - 2015-11-14 12:20:13,088 DEBUG : BROWSER_OUTPUT: 12:20:15 INFO - 2015-11-14 12:20:15,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:16 INFO - 2015-11-14 12:20:16,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 12:20:16 INFO - 2015-11-14 12:20:16,170 DEBUG : BROWSER_OUTPUT: 12:20:18 INFO - 2015-11-14 12:20:18,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-dft) 12:20:19 INFO - 2015-11-14 12:20:19,389 DEBUG : BROWSER_OUTPUT: RSS: Main: 141332480 12:20:19 INFO - 2015-11-14 12:20:19,389 DEBUG : BROWSER_OUTPUT: 12:20:22 INFO - 2015-11-14 12:20:22,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-fft) 12:20:22 INFO - 2015-11-14 12:20:22,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 136908800 12:20:22 INFO - 2015-11-14 12:20:22,832 DEBUG : BROWSER_OUTPUT: 12:20:24 INFO - 2015-11-14 12:20:24,772 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32943/tests/kraken/driver.html?testName=audio-oscillator) 12:20:25 INFO - 2015-11-14 12:20:25,353 DEBUG : BROWSER_OUTPUT: RSS: Main: 137052160 12:20:25 INFO - 2015-11-14 12:20:25,353 DEBUG : BROWSER_OUTPUT: 12:20:27 INFO - 2015-11-14 12:20:27,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:20:28 INFO - 2015-11-14 12:20:28,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 12:20:28 INFO - 2015-11-14 12:20:28,096 DEBUG : BROWSER_OUTPUT: 12:20:31 INFO - 2015-11-14 12:20:31,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-darkroom) 12:20:31 INFO - 2015-11-14 12:20:31,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 12:20:31 INFO - 2015-11-14 12:20:31,677 DEBUG : BROWSER_OUTPUT: 12:20:35 INFO - 2015-11-14 12:20:35,105 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32943/tests/kraken/driver.html?testName=imaging-desaturate) 12:20:35 INFO - 2015-11-14 12:20:35,706 DEBUG : BROWSER_OUTPUT: RSS: Main: 139067392 12:20:35 INFO - 2015-11-14 12:20:35,707 DEBUG : BROWSER_OUTPUT: 12:20:38 INFO - 2015-11-14 12:20:38,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32943/tests/kraken/driver.html?testName=json-parse-financial) 12:20:39 INFO - 2015-11-14 12:20:39,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 137547776 12:20:39 INFO - 2015-11-14 12:20:39,108 DEBUG : BROWSER_OUTPUT: 12:20:40 INFO - 2015-11-14 12:20:40,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:20:41 INFO - 2015-11-14 12:20:41,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 138670080 12:20:41 INFO - 2015-11-14 12:20:41,271 DEBUG : BROWSER_OUTPUT: 12:20:43 INFO - 2015-11-14 12:20:43,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:20:43 INFO - 2015-11-14 12:20:43,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 138260480 12:20:43 INFO - 2015-11-14 12:20:43,737 DEBUG : BROWSER_OUTPUT: 12:20:45 INFO - 2015-11-14 12:20:45,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:20:46 INFO - 2015-11-14 12:20:46,427 DEBUG : BROWSER_OUTPUT: RSS: Main: 139001856 12:20:46 INFO - 2015-11-14 12:20:46,428 DEBUG : BROWSER_OUTPUT: 12:20:48 INFO - 2015-11-14 12:20:48,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:20:49 INFO - 2015-11-14 12:20:49,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 138190848 12:20:49 INFO - 2015-11-14 12:20:49,436 DEBUG : BROWSER_OUTPUT: 12:20:52 INFO - 2015-11-14 12:20:52,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:20:52 INFO - 2015-11-14 12:20:52,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 12:20:52 INFO - 2015-11-14 12:20:52,623 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32943/tests/kraken/driver.html?testName=ai-astar) 12:20:54 INFO - 2015-11-14 12:20:54,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 139177984 12:20:54 INFO - 2015-11-14 12:20:54,547 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,549 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:20:54 INFO - 2015-11-14 12:20:54,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:20:54 INFO - 2015-11-14 12:20:54,549 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:20:54 INFO - 2015-11-14 12:20:54,549 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;112;113;113;123;115;112;111;113 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;132;152;162;125;151;149;135;161;128 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;165;162;167;164;163;164;165;172;163 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;73;71;130;73;72;73;73 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;145;92;91;90;132;90;91;131 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;110;111;111;110 12:20:54 INFO - 2015-11-14 12:20:54,550 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;150;147;146;146;147;147;147 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;97;96;96;97;97;97 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;62;62;62;65;64;62;63;60;61 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;75;70;69;69;69 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;91;83;85;87;87;87;86;85;87;84 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;114;119;120;126;119;124;121;115;114;115 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;153;153;158;150;156;148;147;157;149;138 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;69;66;67;66;70;66;66;66 12:20:54 INFO - 2015-11-14 12:20:54,551 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:20:54 INFO - 2015-11-14 12:20:54,552 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:20:54 INFO - 2015-11-14 12:20:54,552 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 12:20:54 INFO - 2015-11-14 12:20:54,552 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:20:54 INFO - 2015-11-14 12:20:54,552 DEBUG : BROWSER_OUTPUT: __startTimestamp1447532454548__endTimestamp 12:20:54 INFO - 2015-11-14 12:20:54,552 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:4.04 (3.6%) stddev-sans-first:4.27 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 112.0 113.0 113.0 123.0 115.0 112.0 111.0 113.0 12:20:54 INFO - 2015-11-14 12:20:54,556 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:13.55 (8.9%) stddev-sans-first:14.11 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: Values: 152.0 132.0 152.0 162.0 125.0 151.0 149.0 135.0 161.0 128.0 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.90 (1.8%) stddev-sans-first:3.00 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: Values: 163.0 165.0 162.0 167.0 164.0 163.0 164.0 165.0 172.0 163.0 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.20 Median:73.00 stddev:18.21 (25.0%) stddev-sans-first:19.22 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 73.0 71.0 130.0 73.0 72.0 73.0 73.0 12:20:54 INFO - 2015-11-14 12:20:54,557 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.30 Median:90.50 stddev:22.19 (24.5%) stddev-sans-first:23.01 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 145.0 92.0 91.0 90.0 132.0 90.0 91.0 131.0 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 110.0 111.0 111.0 110.0 12:20:54 INFO - 2015-11-14 12:20:54,558 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,559 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 12:20:54 INFO - 2015-11-14 12:20:54,559 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 150.0 147.0 146.0 146.0 147.0 147.0 147.0 12:20:54 INFO - 2015-11-14 12:20:54,559 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 97.0 97.0 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:1.43 (2.3%) stddev-sans-first:1.50 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 62.0 62.0 65.0 64.0 62.0 63.0 60.0 61.0 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:1.95 (2.8%) stddev-sans-first:1.96 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 75.0 70.0 69.0 69.0 69.0 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:87.00 stddev:2.20 (2.5%) stddev-sans-first:1.50 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: Values: 91.0 83.0 85.0 87.0 87.0 87.0 86.0 85.0 87.0 84.0 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:119.50 stddev:4.22 (3.5%) stddev-sans-first:4.12 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: Values: 114.0 119.0 120.0 126.0 119.0 124.0 121.0 115.0 114.0 115.0 12:20:54 INFO - 2015-11-14 12:20:54,560 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.90 Median:153.00 stddev:5.93 (3.9%) stddev-sans-first:6.24 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: Values: 153.0 153.0 158.0 150.0 156.0 148.0 147.0 157.0 149.0 138.0 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.54 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 69.0 66.0 67.0 66.0 70.0 66.0 66.0 66.0 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:20:54 INFO - 2015-11-14 12:20:54,561 DEBUG : BROWSER_OUTPUT: 12:20:55 INFO - 2015-11-14 12:20:55,458 INFO : Browser exited with error code: 0 12:20:55 INFO - 2015-11-14 12:20:55,508 INFO : Completed test kraken (00:01:01) 12:20:55 INFO - 2015-11-14 12:20:55,508 INFO : Starting test v8_7 12:20:55 INFO - 2015-11-14 12:20:55,508 DEBUG : operating with platform_type : linux_ 12:20:55 INFO - 2015-11-14 12:20:55,508 INFO : Initialising browser for v8_7 test... 12:20:55 INFO - 2015-11-14 12:20:55,514 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu_1XRq/profile http://localhost:32943/getInfo.html 12:21:01 INFO - 2015-11-14 12:21:01,349 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:21:01 INFO - 2015-11-14 12:21:01,349 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:21:01 INFO - 2015-11-14 12:21:01,350 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:21:01 INFO - 2015-11-14 12:21:01,350 DEBUG : BROWSER_OUTPUT: __metrics 12:21:02 INFO - 2015-11-14 12:21:02,733 INFO : Browser initialized. 12:21:02 INFO - 2015-11-14 12:21:02,734 INFO : Running cycle 1/1 for v8_7 test... 12:21:02 INFO - 2015-11-14 12:21:02,734 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu_1XRq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:21:14 INFO - 2015-11-14 12:21:14,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 141287424 12:21:14 INFO - 2015-11-14 12:21:14,498 DEBUG : BROWSER_OUTPUT: 12:21:35 INFO - 2015-11-14 12:21:35,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32943/tests/v8_7/run.html (next: http://localhost:32943/tests/v8_7/run.html) 12:21:36 INFO - 2015-11-14 12:21:36,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 137588736 12:21:36 INFO - 2015-11-14 12:21:36,186 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:36 INFO - 2015-11-14 12:21:36,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |0;Richards;163.1321370309951 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.57336430507164 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.2253280091272 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5045.226130653266 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1052.6315789473683 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |5;Earley;717.3601147776184 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |6;Boyer;12280.487804878048 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |7;RegExp;25225 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |8;Splay;655.7377049180328 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: __startTimestamp1447532496183__endTimestamp 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,187 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.13 Median:163.13 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: Values: 163.1 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.57 Median:193.57 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: Values: 193.6 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.23 Median:285.23 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: Values: 285.2 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5045.23 Median:5045.23 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: Values: 5045.2 12:21:36 INFO - 2015-11-14 12:21:36,188 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1052.63 Median:1052.63 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: Values: 1052.6 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.36 Median:717.36 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: Values: 717.4 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12280.49 Median:12280.49 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,189 DEBUG : BROWSER_OUTPUT: Values: 12280.5 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25225.00 Median:25225.00 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: Values: 25225.0 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:655.74 Median:655.74 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: Values: 655.7 12:21:36 INFO - 2015-11-14 12:21:36,190 DEBUG : BROWSER_OUTPUT: 12:21:36 INFO - 2015-11-14 12:21:36,191 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 12:21:36 INFO - 2015-11-14 12:21:36,191 DEBUG : BROWSER_OUTPUT: Values: 4817.3 12:21:36 INFO - 2015-11-14 12:21:36,191 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:36 INFO - 2015-11-14 12:21:36,191 DEBUG : BROWSER_OUTPUT: 12:21:37 INFO - 2015-11-14 12:21:37,145 INFO : Browser exited with error code: 0 12:21:37 INFO - 2015-11-14 12:21:37,160 INFO : Completed test v8_7 (00:00:41) 12:21:37 INFO - 2015-11-14 12:21:37,206 INFO : Completed test suite (00:20:14) 12:21:37 INFO - 2015-11-14 12:21:37,207 DEBUG : Working with test: dromaeo_css 12:21:37 INFO - 2015-11-14 12:21:37,207 DEBUG : Generating results file: dromaeo_css 12:21:37 INFO - 2015-11-14 12:21:37,208 DEBUG : Working with test: kraken 12:21:37 INFO - 2015-11-14 12:21:37,208 DEBUG : Generating results file: kraken 12:21:37 INFO - 2015-11-14 12:21:37,209 INFO : javascript benchmark 12:21:37 INFO - 2015-11-14 12:21:37,209 DEBUG : Working with test: v8_7 12:21:37 INFO - 2015-11-14 12:21:37,209 DEBUG : Generating results file: v8_7 12:21:37 INFO - 2015-11-14 12:21:37,209 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:37 INFO - 2015-11-14 12:21:37,354 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 12:21:37 INFO - 2015-11-14 12:21:37,354 DEBUG : process_Request line: dromaeo_css 6661.03 graph.html#tests=[[72,63,43]] 12:21:37 INFO - 2015-11-14 12:21:37,354 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:37 INFO - 2015-11-14 12:21:37,481 DEBUG : process_Request line: kraken 1513.40 graph.html#tests=[[232,63,43]] 12:21:37 INFO - 2015-11-14 12:21:37,482 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:37 INFO - 2015-11-14 12:21:37,620 DEBUG : process_Request line: v8_7 21225.11 graph.html#tests=[[230,63,43]] 12:21:37 INFO - 2015-11-14 12:21:37,622 INFO : javascript benchmark 12:21:37 INFO - 2015-11-14 12:21:37,625 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [347.28805947806995, 349.37810696959406, 349.4670627293377, 352.6332614081355, 355.445505012181, 13864.722705545882, 14243.14541127533, 16301.918490407561, 16802.579935501602, 17478.388256411014, 15448.613784655388, 15647.921760391211, 17039.233234504445, 17064.146792660347, 17093.0, 4331.45856767904, 4415.470143582775, 4442.2448183808665, 4452.376667266585, 4454.53227411122, 4452.8441504547345, 4721.315409265654, 4820.8071677132875, 4844.539768721984, 4865.318855360252, 4703.012367402849, 4713.222318317474, 4734.053189362124, 4742.620590352763, 4910.140725373063, 4955.876103097434, 5028.069807085701, 5048.7980480780725, 5052.69683818972, 5055.418626857903, 4323.092150648367, 4348.478182618074, 4349.717268377545, 4352.455943007124, 4419.756913369763, 13560.389782459813, 13685.384157712926, 14179.574612761633, 14248.643783905381, 14265.144091354552, 1816.3551939061706, 1817.1822679794145, 1899.3921944977612, 1966.0955960258298, 2121.501447159916, 9985.45080020606, 10001.59993600255, 10154.249300220365, 10191.54138063789, 10440.791184176274, 1672.7323628219426, 1687.7890263717036, 1700.8214137515506, 1714.3828221840129, 1760.155125539748, 63655.0, 64310.356896431374, 64545.67727161381, 64866.35133648697, 65590.67204663994, 6955.93044069563, 7044.682989265393, 7052.977318288922, 7096.219415864251, 7125.42996560274, 8469.830603387898, 8491.065982741893, 8506.489610623383, 8512.063672995966, 8558.400911936229, 5547.44525547442, 5549.639273447213, 5564.916526252109, 5572.414896435897, 5584.888302233932, 5644.181593668895, 5657.43425657431, 5847.649141051551, 5848.356680765112, 5910.911336329958, 3166.7149956503563, 3188.234823642309, 3199.9200019999685, 3206.695363940422, 3220.6457289698114, 1187.2223693480785, 1189.3874654552912, 1190.2978740401136, 1201.567435723139, 1237.0907383073434, 448.2894612039953, 465.3252783463991, 485.45628895636406, 507.7841917185182, 511.744127936032, 10655.520501577448, 11449.542018319175, 11584.189106762615, 11642.24325418862, 12110.515579376726, 490.2988726121609, 490.4335492506161, 508.6719066202353, 511.9513646203605, 529.5789847071587, 6441.677916104176, 6623.4701223901975, 6664.300248473937, 6677.165354330708, 6725.899111513331, 530986.0, 532729.0, 536287.0, 545611.0, 550280.0, 76198.61900690461, 78749.60625196838, 79615.0, 79822.0, 80524.59737701275, 549.1680104641472, 550.4605486623132, 554.0359773993223, 554.1715135871897, 554.5037191713475, 10457.320274182153, 10932.125429965425, 10983.835242471529, 11190.552377904793, 11251.043661288883, 36371.45442818413, 37187.25625487529, 37210.441843372915, 37367.065823354635, 37613.623863761015, 44751.77624111858, 45505.77247113743, 48158.27762583494, 48213.0, 48827.75586122047, 6580.21037475506, 6616.536842420985, 6672.5329226953645, 6680.766173183915, 6691.9962005699535, 11732.12009099304, 11829.940850295694, 11964.820527691918, 12223.69440763988, 12471.5011399543, 10613.522391492555, 10673.519691613741, 10698.946505267424, 10808.621698240524, 10866.239363244496, 10310.278280520592, 10428.634997775041, 10762.246642734934, 10827.566897324334, 10856.077233434931, 10594.735131621772, 10674.46627668629, 10790.460476975963, 11015.228933974546, 11022.944885275523, 6710.362515561014, 6878.449724021966, 6922.688479018356, 6932.826679332855, 7074.045003924404, 10949.178811589321, 11186.049185819296, 11249.887501124884, 11268.38023908693, 11278.210525263154], "dojo.html": [3222.871085156593, 3265.6407795142545, 3289.4407950648388, 3305.6033276006883, 3306.735461163107, 5367.677939323634, 5428.212909128179, 5441.483059109388, 5468.781248750045, 5483.780648774049, 5455.372632147304, 5465.152901300295, 5490.588205884555, 5553.805616803413, 5591.0, 4893.29047288143, 5008.373953255825, 5037.345145131146, 5046.54581087702, 5065.240213967897, 5036.068327359432, 5040.949590504085, 5058.038972595214, 5107.744612769366, 5125.282460455539, 4830.903381932377, 4923.926141107886, 5003.849884503471, 5005.649604527666, 5168.198929165967, 4897.608191344684, 4995.625328100407, 5000.774965126578, 5004.649674522785, 5035.899282014339, 4870.975645121752, 4969.204927211665, 4999.0, 5014.52362025607, 5034.672746271481, 5027.3464449621315, 5145.614078944057, 5153.742312884341, 5262.2632831403635, 5274.26160337553, 5882.705864706791, 5924.5260379169995, 5925.4963328117165, 5927.407259274081, 5929.1995580596495, 5924.0, 5928.644281343133, 5932.555058370596, 5941.940580594225, 5945.554083443716, 5331.173668081454, 5445.319335083114, 5450.754716037788, 5570.41510641385, 5592.748326325325, 5921.526277897758, 5957.463828255478, 5960.37416071315, 5985.581009329392, 6055.7274922628585, 5770.336411312753, 5773.913391299134, 5783.479486846204, 5790.855228619318, 5802.941970580325, 5698.914516282259, 5770.826875193751, 5857.7656893724625, 5887.264091988502, 5910.083936989773, 5747.224124743189, 5772.509336706343, 5776.797812076641, 5824.650520968671, 5949.286085669661, 5696.11710184922, 5745.023346031185, 5748.080307150836, 5748.7125643717645, 5806.970965145148, 4442.2892337225885, 4508.278675411918, 4511.0, 4512.796924138422, 4547.931781023221, 4063.329550624173, 4065.6747460203114, 4068.8372465101656, 4082.6733861291027, 4105.178964207111, 5447.319085114361, 5525.0, 5654.264945557051, 5674.120511320752, 5681.687507187145, 5783.277090363705, 5826.621269617462, 5858.443447872445, 5918.408159184047, 5943.435373639497, 5624.156376543551, 5647.29408823897, 5648.406917273627, 5652.095664693629, 5675.0, 5042.193249080129, 5124.948750512522, 5137.229415587692, 5164.690118592896, 5165.096108181053, 5973.163757074013, 6099.878002439927, 6104.8779024420155, 6110.419510146529, 6141.416565426277, 5921.082232254007, 5943.58394912352, 5948.791792287249, 5952.970235148797, 5962.821115366546, 5952.107183922273, 6024.337322894566, 6153.538484613761, 6160.291566469913, 6167.5682702210415, 5712.885742285214, 5780.508656764222, 5788.652680839163, 5788.82633520995, 5838.299404071538, 5919.0, 5943.257092863392, 5946.970265148647, 5961.016432288798, 5968.46283834457, 5638.887222255614, 5731.197632331394, 5744.684042377542, 5784.248047753765, 5802.332731735735, 5758.1650660654805, 5774.816162686555, 5788.681622510802, 5806.709664516842, 5843.94156058434, 5596.1605759136455, 5615.129654903497, 5636.2954630671165, 5640.576956728344, 5671.149327600893, 5585.720713964367, 5659.151127330769, 5763.625364351304, 5792.681402522733, 5957.523398128226, 5615.354234263112, 5661.858453538694, 5670.064439367458, 5672.234248376416, 5687.260656114844], "mootools.html": [1503.9398424063038, 1655.917204139793, 1746.3189356151104, 1749.623830876362, 1762.2246211666866, 7016.298370162987, 7166.5700057996555, 7193.856122877546, 7221.133463984329, 7403.740869069584, 7320.158181809094, 7347.191808901017, 7446.404287656988, 7446.627668616561, 7476.0, 2204.129368899288, 2220.2673117871145, 2220.4448887778058, 2232.3749350181974, 2233.932982010542, 2190.3866917263113, 2196.4838263008182, 2205.9448513787124, 2226.465648244418, 2234.8323875709307, 2182.1162429216192, 2191.079746506463, 2192.2765487389124, 2221.144859229192, 2231.6429371300596, 2198.1537108213374, 2215.9778402215934, 2232.7097477327925, 2233.564454931289, 2235.2400183937457, 2191.0468946008536, 2195.6926030355603, 2209.5470428562267, 2209.845310828243, 2219.1012639880873, 7160.391366733834, 7292.67182976762, 7298.562086274787, 7330.303621155982, 7334.523255988343, 4415.646748260131, 4471.597556219924, 4482.350059241425, 4482.843100491467, 4513.413256276663, 2926.5024945759274, 2982.492976194052, 3006.1733023418733, 3009.3981203759117, 3027.2734543709353, 931.0828833598899, 945.1729736480579, 961.1253759079274, 961.1397798969883, 972.7811242470458, 9829.3610915291, 9884.357516761387, 9892.505374731234, 9911.40531568101, 9914.851277230848, 3931.3709806430834, 3946.664533514626, 3962.5046869141356, 3963.0, 4035.273650742836, 8080.0, 8136.430449868571, 8137.3490120791375, 8146.2261085196815, 8147.633356498972, 4296.5273819879785, 4321.2005778931, 4323.178596066738, 4324.913501729948, 4334.241507736134, 3894.805259737002, 3957.1689945111275, 3980.641742243212, 4082.795860206978, 4099.364598487239, 3408.0, 3422.709069729051, 3435.519027336175, 3445.87939422119, 3459.619441861393, 1075.5912753153752, 1089.934603923767, 1093.1801149138146, 1098.2531878322657, 1098.961536346224, 935.1209862729013, 940.7130825098274, 941.1200527506803, 997.9002099790108, 1277.9680507987189, 6883.7590684325805, 6899.965500172467, 6918.515703900779, 6924.134483189601, 6924.688389022506, 465.864899179241, 467.5161208149549, 478.63384510849227, 478.77258302306126, 478.7749757613916, 5204.297419848272, 5233.058049551118, 5249.632525723239, 5255.290535777697, 5277.683338999673, 8364.707235246737, 8453.070162282143, 8489.787755306043, 8496.66013359471, 8595.871061934076, 8454.239118479243, 8462.830743385099, 8481.363897707697, 8547.743567692854, 8566.571671416405, 6699.464042876558, 6728.932710672831, 6768.763093291711, 6773.254941956479, 6848.0, 6716.0, 6727.293634168537, 6739.73041078371, 6756.662166891734, 6759.695813688298, 7431.962840185981, 7720.884186737091, 7798.0, 7835.764927052198, 7877.369810415038, 7835.921640783519, 7967.083785364757, 7999.120096789232, 8046.0344758627, 8083.110857805519, 6246.219222597176, 6525.3800888915475, 6544.051112588743, 6601.3728695773825, 6621.900671489835, 7034.2965703429245, 7042.823929401806, 7059.611721355374, 7059.823504412226, 7068.151821781419, 6386.010168423902, 6504.837379065561, 6577.868442631217, 6627.867442651216, 6712.194536655633, 6440.806775796734, 6521.6087034776165, 6542.803715888531, 6563.573367731273, 6581.308962559054, 6355.968220158869, 6403.679816009274, 6419.646919419477, 6459.935400645933, 6478.870422591616, 6026.216591843032, 6064.909026364697, 6251.6561589113035, 6263.843403914939, 6264.686765661608, 6225.595336303307, 6255.155554000152, 6269.12232287471, 6274.184356033869, 6279.246490421178], "ext.html": [556.7021643420769, 569.7720911635346, 584.1529781816367, 584.8479395357206, 587.5358466811222, 39686.40470392943, 40380.79809600955, 40855.97860053497, 40913.59086409135, 41011.58988410115, 44053.77973110138, 44485.332720009224, 44784.55215447844, 44917.10165796682, 45060.0, 8697.478151310941, 8822.470651760883, 8857.734267971971, 8858.822823543525, 8885.822283554326, 8644.481331120152, 8736.694215702451, 8742.4754514729, 8788.16512431318, 8803.207711306013, 8644.956775216115, 8670.52312122833, 8699.478031318109, 8730.432521886089, 8733.03936566977, 8583.14168583143, 8740.562971851414, 8761.430507017056, 8797.47215167092, 8838.734837954871, 8608.612612432393, 8698.69519572063, 8713.259372953307, 8776.78058048554, 8808.25129863956, 40231.39652905209, 40758.18483630311, 41054.178916421806, 41166.0, 41301.79349103265, 3286.1784553861535, 3314.330510198504, 3387.6951074403178, 3478.652134786501, 3802.9120235186597, 29583.70416295831, 29660.8516957416, 29931.25171870699, 30618.387632247453, 31217.21956951072, 3181.9340520925516, 3184.283536204359, 3191.3617276544783, 3194.0896844399467, 3242.238074052596, 286776.0, 287329.0, 288531.0, 289145.0, 290003.0, 42070.57929420728, 60594.394056059755, 60684.393156067876, 61029.38970610326, 61073.38926610677, 42619.57380426156, 42753.35869961953, 42946.0, 42963.0, 43010.13979720388, 14735.484258050918, 15007.474738384322, 15091.245437728288, 15150.772738408932, 15219.695606087816, 11060.502277397536, 11111.944440277908, 11168.050715689094, 11176.944115279533, 11228.943855280835, 14588.781168282485, 14651.34068966899, 14654.19401932904, 14716.0, 14854.777178342334, 5805.651660900359, 5957.4042595740075, 5995.0, 6036.426539478743, 6066.696665166724, 863.7063398444434, 920.9907900920905, 959.2326139088701, 1071.6838532632892, 1072.785442911421, 27958.3010424741, 28618.0, 29121.7087829119, 29173.85413072921, 29417.411651766844, 996.9252306077074, 1031.4481752262654, 1041.317936751429, 1064.840273958897, 1130.9708165569293, 15074.321655525528, 15118.546443606709, 15157.62105947338, 15217.163056032025, 15219.315130819139, 343512.0, 348840.0, 349442.0, 350649.0, 351513.0, 53421.0, 53530.464695352544, 53694.0, 53716.0, 53865.461345386044, 1254.6612414647993, 1300.959232613905, 1316.3418290854572, 1321.6431563477806, 1334.0394915660709, 27509.587356190073, 28415.43169136647, 28644.42711145807, 28827.42345153127, 28865.42269154647, 47745.76127119342, 47865.76067119642, 48171.5182848167, 48207.75896120497, 48216.758916205195, 313398.0, 316070.0, 316665.0, 318180.0, 318603.0, 27691.446171076062, 28660.283492912844, 31721.682783172797, 32544.674553254164, 33223.33553328968, 38630.0, 39132.608673912895, 40091.0, 40111.59888401195, 41468.170636586496, 35906.64093359033, 36072.27855442929, 36463.0, 36617.45073823948, 37277.440838387985, 35141.82429087838, 35855.75328564773, 36172.81913590415, 36277.818610906776, 36389.27221455609, 35269.470957936166, 35590.0, 36365.63634363622, 36382.0, 36415.0, 31406.0, 32713.672863271062, 33257.83371083226, 33266.501002485464, 33268.1682957928, 26119.216423507325, 26439.33901652474, 27983.16050518488, 28342.291442714097, 28462.715372846007], "prototype.html": [316.73710820019386, 319.55741298301854, 323.25812260861323, 325.1691927126193, 328.510519326204, 6266.498680105592, 6297.622142671437, 6341.302456729762, 6344.302126766052, 6442.838929026765, 6233.719482623282, 6276.309605943343, 6289.811305660837, 6311.147995020671, 6323.936760632392, 4585.151746926813, 4685.601723853477, 4687.742174180418, 4699.412573428322, 4702.741349225791, 4680.531946805327, 4704.424017953989, 4704.576588107069, 4723.740194289313, 4723.763811809413, 4672.532746725335, 4674.0, 4687.414073240845, 4689.531046895318, 4700.271457924027, 4668.043051174501, 4670.252759558488, 4671.369365135697, 4679.415073115861, 4686.2267725825195, 3916.2167566486532, 4028.274910516106, 4033.2135233629456, 4052.0, 4082.5917408259234, 5854.0, 5871.647701137946, 5889.7644094236175, 5890.263717035371, 5894.469497745224, 5464.754086066137, 5474.233607294982, 5476.972615136899, 5478.342598888159, 5481.314835645544, 6564.277929427759, 6589.80230593083, 6589.80230593083, 6622.238442579117, 6633.635150066744, 4395.956040439619, 4444.444444444444, 4462.330650402433, 4505.279155335131, 4514.14231296056, 6903.344182302673, 6908.861822763517, 6917.308269173092, 6954.9304506955295, 6987.231404545496, 4533.32000199966, 4539.568740969603, 4540.8637740867825, 4541.931871021938, 4558.2251017327135, 4482.058767658828, 4592.127495775792, 4613.077384523109, 4615.976920115445, 4618.122556714214, 5399.83800485986, 5408.91886621701, 5418.864528386743, 5421.728913554307, 5425.83722488326, 6659.567128136656, 6691.498137639696, 6700.296468870698, 6708.429783468362, 6743.460523158135, 1630.624956260067, 1642.6550424410768, 1656.0477725307996, 1662.6508433228917, 1662.9357211384724, 1075.542894269932, 1085.2457542008385, 1085.9674209773718, 1098.6429410441638, 1107.983380249297, 6461.256955450183, 6480.31956644555, 6501.284858665543, 6522.021696745526, 6582.156996041116, 7031.050808140938, 7047.612381319077, 7058.11773528309, 7071.717131314793, 7078.646067696594, 6588.374104460068, 6588.604683718992, 6595.0, 6598.8350291243105, 6606.933930660728, 3724.2179142380405, 3755.080005398695, 3782.205736795249, 3797.468354430382, 3802.1825307559006, 7309.671064802096, 7314.890276645855, 7343.70625174987, 7354.521956072945, 7356.816079598053, 7215.654912153571, 7236.0, 7247.818804529929, 7259.201487836333, 7266.527675701062, 7191.065161528968, 7314.26857314275, 7332.450066245053, 7348.375388092072, 7378.631068446556, 6953.965230173817, 6975.651217439209, 6980.685869135799, 7009.2990700929495, 7013.649317534205, 6819.181698196248, 6872.518923675295, 6887.345702158287, 6920.134983127109, 6927.653617319214, 7178.102737157856, 7319.963400182965, 7332.853342933005, 7371.152317483558, 7371.373433258019, 4497.123061003073, 4514.977425112854, 4518.548145185455, 4518.570735780096, 4544.863654090383, 6929.653517324013, 6978.337057979484, 6982.825429364103, 6991.007562844565, 6993.195782484876, 6552.115464412243, 6735.966320168368, 6744.426723728538, 6748.93251067483, 6805.149356330458, 6731.697073631601, 6777.830554236183, 6781.050652908695, 6796.35434633709, 6825.829354265985, 6533.771318003847, 6647.169103862017, 6658.267590564937, 6659.334066593302, 6692.364225398579, 6666.066750654815, 6795.966020170065, 6839.794806155824, 6840.589564626139, 6860.656967151523, 6615.4376877965915, 6647.335266473314, 6676.198856137295, 6694.531382803157, 6699.0], "yui.html": [733.4499125655758, 743.6058888788943, 752.5296689569019, 867.7657032601198, 889.1064480197402, 13203.867961320384, 13405.329733513321, 13441.395137218824, 13479.3260336983, 13493.865061349383, 11824.645260642174, 13329.066965312431, 13415.932920335408, 13416.932915335434, 13452.730945381087, 805.0621026504116, 806.9556174410405, 812.5368539932241, 816.3673153306175, 819.6885183630242, 821.5317269156583, 830.5639539241886, 830.7466222802043, 830.7881490219985, 833.150186809454, 863.3524856357732, 871.1332224436694, 871.8822958900562, 872.5331947408138, 874.1389731114879, 851.1020872979036, 857.1128881607568, 859.1065292096213, 862.1895418306802, 862.3101518784978, 631.0156156396037, 632.2065807411669, 632.7880160146357, 633.5343522510951, 635.4725577770439, 12450.875491245153, 12492.125551211418, 12569.685757856036, 12608.684782880502, 12639.684007899785, 10570.894291057068, 10719.946400268027, 10769.138468922467, 10804.729881753019, 11213.607523736711, 9900.653477128266, 10010.788344610513, 10029.949850250776, 10035.86017027349, 10156.949215253877, 3582.17609949713, 3622.655847694491, 3650.470681751158, 3656.3784156693428, 3659.2132691471197, 38734.61265387338, 40888.38667419991, 41208.38187427221, 42656.78671606622, 45299.320510192374, 10175.0, 10274.537645805956, 10308.072273495422, 10315.226358023177, 10353.9482302588, 17985.190666420043, 17986.730199047026, 18036.2785488579, 18091.366802162123, 18226.45320640383, 7398.704051837974, 7539.623018849145, 7650.73222437212, 7729.033870766154, 7776.183500732454, 4272.957270427318, 4337.8481753138485, 4371.038371558252, 4394.472663280427, 4425.269830477935, 2953.74893134086, 3048.4360393327306, 3049.0, 3058.1742929408933, 3058.250728571514, 456.3086923311186, 456.9383133276965, 469.24217388917333, 472.1359911362199, 475.4223618303777, 561.8651523634298, 590.3918963467635, 596.6956852005509, 623.8939380305359, 640.6636515829134, 8422.620982055822, 8461.40770146084, 8608.655653773903, 8832.602532885907, 9282.48946307946, 557.85495771099, 566.0151336674157, 575.4849409778309, 586.1939832729996, 630.7287866217571, 4024.8993775155855, 4048.7975601219823, 4063.7358571692744, 4107.466029416157, 4214.1150358425075, 56967.71516142393, 57445.0, 57786.13320800191, 58014.419855801745, 58072.709636451546, 49388.0, 49614.75192624086, 49750.75124624354, 49843.25235121476, 49889.25166122511, 43206.0, 43299.134017318844, 43603.0, 44019.11961760811, 44702.0, 8074.273315401642, 8415.242628163494, 8557.015943166616, 8702.564871756513, 8856.025837157778, 34328.313433730684, 34873.47689784604, 34961.82519087388, 34971.30057398787, 36383.0, 43863.56136438595, 44127.558724413626, 44317.77841110774, 44429.555704442544, 44691.0, 8068.636911338886, 8159.510429374256, 8187.3040791533385, 8305.875411868707, 8407.285380742705, 12261.141720079866, 12414.813777793159, 12449.315287659265, 12499.625011249676, 12973.675658108623, 11317.660470185907, 11409.0, 11553.24903881245, 11914.40427978615, 11915.344656043653, 10630.681079567625, 10898.182636302468, 10925.125989920629, 10927.398993055458, 11286.435678216221, 10088.899111008795, 10224.182065434896, 10368.326058806153, 10955.56177752881, 11646.184767066563, 9580.856287155559, 9624.615015399306, 9624.773467750643, 9781.462019588991, 10235.948820255851, 9094.454332740057, 9116.817663646823, 9242.630294788134, 10051.145652619316, 10112.59549618007]}, "summary": {"lowerIsBetter": false, "suite": 6661.035368253329, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7015.863766837766, "unit": "ms", "value": 7015.863766837766}, "dojo.html": {"lowerIsBetter": false, "filtered": 5420.460146276989, "unit": "ms", "value": 5420.460146276989}, "mootools.html": {"lowerIsBetter": false, "filtered": 4137.432238175824, "unit": "ms", "value": 4137.432238175824}, "ext.html": {"lowerIsBetter": false, "filtered": 18100.175353623472, "unit": "ms", "value": 18100.175353623472}, "prototype.html": {"lowerIsBetter": false, "filtered": 5005.237928435009, "unit": "ms", "value": 5005.237928435009}, "yui.html": {"lowerIsBetter": false, "filtered": 6127.132958092071, "unit": "ms", "value": 6127.132958092071}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-033.e"}, "testrun": {"date": 1447531282, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114103013", "branch": "Mozilla-Inbound", "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a"}}, {"talos_counters": {}, "results": {"audio-dft": [163.0, 165.0, 162.0, 167.0, 164.0, 163.0, 164.0, 165.0, 172.0, 163.0], "ai-astar": [112.0, 107.0, 112.0, 113.0, 113.0, 123.0, 115.0, 112.0, 111.0, 113.0], "imaging-gaussian-blur": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0, 110.0], "audio-beat-detection": [152.0, 132.0, 152.0, 162.0, 125.0, 151.0, 149.0, 135.0, 161.0, 128.0], "json-stringify-tinderbox": [68.0, 69.0, 69.0, 69.0, 70.0, 75.0, 70.0, 69.0, 69.0, 69.0], "stanford-crypto-pbkdf2": [153.0, 153.0, 158.0, 150.0, 156.0, 148.0, 147.0, 157.0, 149.0, 138.0], "json-parse-financial": [63.0, 62.0, 62.0, 62.0, 65.0, 64.0, 62.0, 63.0, 60.0, 61.0], "stanford-crypto-sha256-iterative": [67.0, 66.0, 69.0, 66.0, 67.0, 66.0, 70.0, 66.0, 66.0, 66.0], "audio-fft": [73.0, 72.0, 72.0, 73.0, 71.0, 130.0, 73.0, 72.0, 73.0, 73.0], "imaging-darkroom": [146.0, 147.0, 146.0, 150.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "stanford-crypto-ccm": [114.0, 119.0, 120.0, 126.0, 119.0, 124.0, 121.0, 115.0, 114.0, 115.0], "audio-oscillator": [91.0, 90.0, 145.0, 92.0, 91.0, 90.0, 132.0, 90.0, 91.0, 131.0], "stanford-crypto-aes": [91.0, 83.0, 85.0, 87.0, 87.0, 87.0, 86.0, 85.0, 87.0, 84.0], "imaging-desaturate": [96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0]}, "summary": {"lowerIsBetter": true, "suite": 1513.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.2, "unit": "ms", "value": 78.2}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 150.9, "unit": "ms", "value": 150.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.7, "unit": "ms", "value": 144.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 118.7, "unit": "ms", "value": 118.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 146.9, "unit": "ms", "value": 146.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.4, "unit": "ms", "value": 62.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 104.3, "unit": "ms", "value": 104.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 113.1, "unit": "ms", "value": 113.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 164.8, "unit": "ms", "value": 164.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.9, "unit": "ms", "value": 66.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.7, "unit": "ms", "value": 69.7}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 110.1, "unit": "ms", "value": 110.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.2, "unit": "ms", "value": 86.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-033.e"}, "testrun": {"date": 1447531282, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114103013", "branch": "Mozilla-Inbound", "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [193.57336430507164], "Encrypt": [285.2253280091272], "NavierStokes": [4817.307692307692], "Decrypt": [5045.226130653266], "Splay": [655.7377049180328], "Richards": [163.1321370309951], "RegExp": [25225.0], "Earley": [717.3601147776184], "Boyer": [12280.487804878048], "RayTrace": [1052.6315789473683]}, "summary": {"lowerIsBetter": false, "suite": 21225.108537894914, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 341.56558799999993, "unit": "score", "value": 341.56558799999993}, "Encrypt": {"lowerIsBetter": false, "filtered": 933.2305859999998, "unit": "score", "value": 933.2305859999998}, "NavierStokes": {"lowerIsBetter": false, "filtered": 308.055888223553, "unit": "score", "value": 308.055888223553}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.75898306772911, "unit": "score", "value": 52.75898306772911}, "Splay": {"lowerIsBetter": false, "filtered": 124.27377499999997, "unit": "score", "value": 124.27377499999997}, "RegExp": {"lowerIsBetter": false, "filtered": 36.11437066402381, "unit": "score", "value": 36.11437066402381}, "Richards": {"lowerIsBetter": false, "filtered": 216.40126, "unit": "score", "value": 216.40126}, "Earley": {"lowerIsBetter": false, "filtered": 929.0494220000003, "unit": "score", "value": 929.0494220000003}, "Boyer": {"lowerIsBetter": false, "filtered": 54.27007547169812, "unit": "score", "value": 54.27007547169812}, "RayTrace": {"lowerIsBetter": false, "filtered": 702.9895499999999, "unit": "score", "value": 702.9895499999999}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04.e", "os": "linux", "name": "talos-linux64-ix-033.e"}, "testrun": {"date": 1447531282, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151114103013", "branch": "Mozilla-Inbound", "revision": "50b5e58fd4cd039010f8dc46e7739aee8d8ba68a"}}] 12:21:37 INFO - RETURN: dromaeo_css: 6661.03 12:21:37 INFO - RETURN: kraken: 1513.40 12:21:37 INFO - RETURN: v8_7: 21225.11 12:21:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21225.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6661.03"}}} 12:21:37 INFO - Return code: 0 12:21:37 INFO - # TBPL SUCCESS # 12:21:37 INFO - Running post-action listener: _resource_record_post_action 12:21:37 INFO - Running post-run listener: _resource_record_post_run 12:21:38 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 512544768; Read time: 0; Write time: 1350252 12:21:38 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 213286912; Read time: 0; Write time: 624304 12:21:38 INFO - run-tests - Wall time: 1215s; CPU: 13.0%; Read bytes: 0; Write bytes: 271687680; Read time: 0; Write time: 501504 12:21:38 INFO - Running post-run listener: _upload_blobber_files 12:21:38 INFO - Blob upload gear active. 12:21:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:21:38 INFO - Copying logs to upload dir... 12:21:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.182818 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-14 12:21:38.636597) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 12:21:38.640358) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010046 build_url: 'https://queue.taskcluster.net/v1/task/JwSW23R0Q3SDiDmpHBt8kA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 12:21:38.692258) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:21:38.692634) ========= 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=a194aa7faa1be204aaca7d660000020b-1447525372.456859-140261710 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 12:21:38.743229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 12:21:38.743580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 12:21:38.743921) ========= ========= Total master_lag: 0.25 =========