builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1447803815.27 results: success (0) buildid: 20151117133030 builduid: 8f6413f1844842e4858535cfb30c1769 revision: 233f67378440e5495a636e6fffc02ec1f1eaffce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.273899) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.274485) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.274820) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006674 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.296522) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.296844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.310484) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.310868) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004659 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.367187) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.367456) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.367805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.368323) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 15:43:36-- 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% 223M=0s 2015-11-17 15:43:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191902 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.572637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.572946) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.625605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:35.625951) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 233f67378440e5495a636e6fffc02ec1f1eaffce --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 233f67378440e5495a636e6fffc02ec1f1eaffce --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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 15:43:36,917 truncating revision to first 12 chars 2015-11-17 15:43:36,917 Setting DEBUG logging. 2015-11-17 15:43:36,917 attempt 1/10 2015-11-17 15:43:36,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/233f67378440?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 15:43:37,162 unpacking tar archive at: mozilla-inbound-233f67378440/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:36.161966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:36.162294) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:36.175084) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:36.175412) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:43:36.175872) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-17 15:43:36.176188) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:43:37 INFO - MultiFileLogger online at 20151117 15:43:37 in /builds/slave/test-pgo 15:43:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 15:43:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:43:37 INFO - {'append_to_log': False, 15:43:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:43:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:43:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:43:37 INFO - 'branch': 'Mozilla-Inbound', 15:43:37 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:37 INFO - 'config_files': ('talos/linux_config.py',), 15:43:37 INFO - 'default_actions': ('clobber', 15:43:37 INFO - 'read-buildbot-config', 15:43:37 INFO - 'download-and-extract', 15:43:37 INFO - 'populate-webroot', 15:43:37 INFO - 'create-virtualenv', 15:43:37 INFO - 'install', 15:43:37 INFO - 'run-tests'), 15:43:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:37 INFO - 'download_minidump_stackwalk': True, 15:43:37 INFO - 'download_symbols': 'ondemand', 15:43:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:37 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:37 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:37 INFO - 'installer_path': 'installer.exe', 15:43:37 INFO - 'log_level': 'info', 15:43:37 INFO - 'log_name': 'talos', 15:43:37 INFO - 'log_to_console': True, 15:43:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:43:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:43:37 INFO - 'opt_config_files': (), 15:43:37 INFO - 'pip_index': False, 15:43:37 INFO - 'sps_profile': False, 15:43:37 INFO - 'sps_profile_interval': 0, 15:43:37 INFO - 'suite': 'dromaeojs', 15:43:37 INFO - 'system_bits': '64', 15:43:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:37 INFO - 'title': 'talos-linux64-ix-068', 15:43:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:37 INFO - 'use_talos_json': True, 15:43:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:43:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:37 INFO - 'work_dir': 'build'} 15:43:37 INFO - ##### 15:43:37 INFO - ##### Running clobber step. 15:43:37 INFO - ##### 15:43:37 INFO - Running pre-action listener: _resource_record_pre_action 15:43:37 INFO - Running main action method: clobber 15:43:37 INFO - rmtree: /builds/slave/test-pgo/build 15:43:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:43:38 INFO - Running post-action listener: _resource_record_post_action 15:43:38 INFO - ##### 15:43:38 INFO - ##### Running read-buildbot-config step. 15:43:38 INFO - ##### 15:43:38 INFO - Running pre-action listener: _resource_record_pre_action 15:43:38 INFO - Running main action method: read_buildbot_config 15:43:38 INFO - Using buildbot properties: 15:43:38 INFO - { 15:43:38 INFO - "properties": { 15:43:38 INFO - "buildnumber": 1273, 15:43:38 INFO - "product": "firefox", 15:43:38 INFO - "script_repo_revision": "production", 15:43:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 15:43:38 INFO - "repository": "", 15:43:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 15:43:38 INFO - "buildid": "20151117133030", 15:43:38 INFO - "slavename": "talos-linux64-ix-068", 15:43:38 INFO - "pgo_build": "True", 15:43:38 INFO - "basedir": "/builds/slave/test-pgo", 15:43:38 INFO - "project": "", 15:43:38 INFO - "platform": "ubuntu64_hw", 15:43:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:43:38 INFO - "slavebuilddir": "test", 15:43:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:43:38 INFO - "branch": "mozilla-inbound", 15:43:38 INFO - "repo_path": "integration/mozilla-inbound", 15:43:38 INFO - "stage_platform": "linux64-pgo", 15:43:38 INFO - "builduid": "8f6413f1844842e4858535cfb30c1769", 15:43:38 INFO - "revision": "233f67378440e5495a636e6fffc02ec1f1eaffce" 15:43:38 INFO - }, 15:43:38 INFO - "sourcestamp": { 15:43:38 INFO - "repository": "", 15:43:38 INFO - "hasPatch": false, 15:43:38 INFO - "project": "", 15:43:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:43:38 INFO - "changes": [ 15:43:38 INFO - { 15:43:38 INFO - "category": null, 15:43:38 INFO - "files": [ 15:43:38 INFO - { 15:43:38 INFO - "url": null, 15:43:38 INFO - "name": "https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:43:38 INFO - } 15:43:38 INFO - ], 15:43:38 INFO - "repository": "", 15:43:38 INFO - "rev": "233f67378440e5495a636e6fffc02ec1f1eaffce", 15:43:38 INFO - "who": "sendchange", 15:43:38 INFO - "when": 1447803741, 15:43:38 INFO - "number": 6674678, 15:43:38 INFO - "comments": "", 15:43:38 INFO - "project": "", 15:43:38 INFO - "at": "Tue 17 Nov 2015 15:42:21", 15:43:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 15:43:38 INFO - "revlink": "", 15:43:38 INFO - "properties": [ 15:43:38 INFO - [ 15:43:38 INFO - "buildid", 15:43:38 INFO - "20151117133030", 15:43:38 INFO - "Change" 15:43:38 INFO - ], 15:43:38 INFO - [ 15:43:38 INFO - "builduid", 15:43:38 INFO - "8f6413f1844842e4858535cfb30c1769", 15:43:38 INFO - "Change" 15:43:38 INFO - ], 15:43:38 INFO - [ 15:43:38 INFO - "pgo_build", 15:43:38 INFO - "True", 15:43:38 INFO - "Change" 15:43:38 INFO - ] 15:43:38 INFO - ], 15:43:38 INFO - "revision": "233f67378440e5495a636e6fffc02ec1f1eaffce" 15:43:38 INFO - } 15:43:38 INFO - ], 15:43:38 INFO - "revision": "233f67378440e5495a636e6fffc02ec1f1eaffce" 15:43:38 INFO - } 15:43:38 INFO - } 15:43:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:43:38 INFO - Running post-action listener: _resource_record_post_action 15:43:38 INFO - ##### 15:43:38 INFO - ##### Running download-and-extract step. 15:43:38 INFO - ##### 15:43:38 INFO - Running pre-action listener: _resource_record_pre_action 15:43:38 INFO - Running main action method: download_and_extract 15:43:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:43: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')]} 15:43:38 INFO - https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/test_packages.json 15:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/test_packages.json 15:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:43:40 INFO - Downloaded 1302 bytes. 15:43:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:43:40 INFO - Using the following test package requirements: 15:43:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:43:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'jsshell-linux-x86_64.zip'], 15:43:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:43:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:43:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:43:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:43:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:43:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:43:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:43:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:43:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:40 INFO - https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:43:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:41 INFO - Downloaded 22461712 bytes. 15:43:41 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 15:43:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:41 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 15:43:43 INFO - Return code: 0 15:43:43 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 15:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:43 INFO - https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:43:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:54 INFO - Downloaded 22461712 bytes. 15:43:54 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 15:43:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:43:54 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 15:43:55 INFO - Return code: 0 15:43: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')]} 15:43:55 INFO - https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:56 INFO - Downloaded 11130997 bytes. 15:43:56 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 15:43:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:43:56 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 15:43:56 INFO - Return code: 0 15:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:56 INFO - https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:43:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:43:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:43:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DOkrBgfjRuGqS9shzxC_1w/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 15:43:58 INFO - Downloaded 57201206 bytes. 15:43:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:43:58 INFO - mkdir: /builds/slave/test-pgo/properties 15:43:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:43:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:43:58 INFO - Contents: 15:43:58 INFO - build_url:https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:43:58 INFO - Running post-action listener: _resource_record_post_action 15:43:58 INFO - Running post-action listener: set_extra_try_arguments 15:43:58 INFO - ##### 15:43:58 INFO - ##### Running populate-webroot step. 15:43:58 INFO - ##### 15:43:58 INFO - Running pre-action listener: _resource_record_pre_action 15:43:58 INFO - Running main action method: populate_webroot 15:43:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:43:58 INFO - '../fennec_ids.txt'], 15:43:58 INFO - 'tests': ['tcheck2']}, 15:43:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:58 INFO - '--tppagecycles', 15:43:58 INFO - '7'], 15:43:58 INFO - 'tests': ['tsvgm']}}, 15:43:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:43:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:43:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:43:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:58 INFO - 'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:58 INFO - 'tests': ['damp', 'tps']}, 15:43:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:58 INFO - 'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['damp', 'tps']}, 15:43:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:43:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:58 INFO - 'other': {'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'other_l64': {'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'other_nol64': {'tests': ['a11yr', 15:43:58 INFO - 'ts_paint', 15:43:58 INFO - 'tpaint', 15:43:58 INFO - 'sessionrestore', 15:43:58 INFO - 'sessionrestore_no_auto_restore']}, 15:43:58 INFO - 'svgr': {'tests': ['tsvgx', 15:43:58 INFO - 'tsvgr_opacity', 15:43:58 INFO - 'tart', 15:43:58 INFO - 'tscrollx', 15:43:58 INFO - 'cart']}, 15:43:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:43:58 INFO - 'tests': ['tsvgx', 15:43:58 INFO - 'tsvgr_opacity', 15:43:58 INFO - 'tart', 15:43:58 INFO - 'tscrollx', 15:43:58 INFO - 'cart']}, 15:43:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:59 INFO - 'tests': ['tp5o']}, 15:43:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:59 INFO - 'talos_options': ['--e10s'], 15:43:59 INFO - 'tests': ['tp5o']}, 15:43:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:59 INFO - 'talos_options': ['--xperf_path', 15:43:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:59 INFO - 'tests': ['tp5n']}, 15:43:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:43:59 INFO - 'talos_options': ['--e10s', 15:43:59 INFO - '--xperf_path', 15:43:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:59 INFO - 'tests': ['tp5n']}}, 15:43:59 INFO - 'talos.zip': {'path': '', 15:43:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:59 INFO - Running post-action listener: _resource_record_post_action 15:43:59 INFO - ##### 15:43:59 INFO - ##### Running create-virtualenv step. 15:43:59 INFO - ##### 15:43:59 INFO - Running pre-action listener: _resource_record_pre_action 15:43:59 INFO - Running main action method: create_virtualenv 15:43:59 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:43:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:43:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:43:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:59 INFO - Using real prefix '/usr' 15:43:59 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:43:59 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:01 INFO - Installing pip.................done. 15:44:01 INFO - Return code: 0 15:44:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:44: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')]} 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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', '--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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:01 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 15:44:01 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 15:44:01 INFO - Using env: {'DISPLAY': ':0', 15:44:01 INFO - 'HOME': '/home/cltbld', 15:44:01 INFO - 'LANG': 'en_US.UTF-8', 15:44:01 INFO - 'LANGUAGE': 'en_US:en', 15:44:01 INFO - 'LOGNAME': 'cltbld', 15:44:01 INFO - 'MAIL': '/var/mail/cltbld', 15:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:01 INFO - 'MOZ_NO_REMOTE': '1', 15:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:01 INFO - 'NO_EM_RESTART': '1', 15:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:01 INFO - 'SHELL': '/bin/bash', 15:44:01 INFO - 'SHLVL': '1', 15:44:01 INFO - 'TERM': 'linux', 15:44:01 INFO - 'TMOUT': '86400', 15:44:01 INFO - 'USER': 'cltbld', 15:44:01 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:01 INFO - '_': '/tools/buildbot/bin/python'} 15:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:44:01 INFO - Cleaning up... 15:44:01 INFO - Return code: 0 15:44:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:44: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')]} 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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', '--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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:01 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 15:44:01 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 15:44:01 INFO - Using env: {'DISPLAY': ':0', 15:44:01 INFO - 'HOME': '/home/cltbld', 15:44:01 INFO - 'LANG': 'en_US.UTF-8', 15:44:01 INFO - 'LANGUAGE': 'en_US:en', 15:44:01 INFO - 'LOGNAME': 'cltbld', 15:44:01 INFO - 'MAIL': '/var/mail/cltbld', 15:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:01 INFO - 'MOZ_NO_REMOTE': '1', 15:44:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:01 INFO - 'NO_EM_RESTART': '1', 15:44:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:01 INFO - 'SHELL': '/bin/bash', 15:44:01 INFO - 'SHLVL': '1', 15:44:01 INFO - 'TERM': 'linux', 15:44:01 INFO - 'TMOUT': '86400', 15:44:01 INFO - 'USER': 'cltbld', 15:44:01 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:01 INFO - '_': '/tools/buildbot/bin/python'} 15:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:01 INFO - Downloading/unpacking psutil>=0.7.1 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:44:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:44:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:03 INFO - Installing collected packages: psutil 15:44:03 INFO - Running setup.py install for psutil 15:44:03 INFO - building 'psutil._psutil_linux' extension 15:44:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:44:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:44:04 INFO - building 'psutil._psutil_posix' extension 15:44:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:44:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:44:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:04 INFO - Successfully installed psutil 15:44:04 INFO - Cleaning up... 15:44:04 INFO - Return code: 0 15:44:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:04 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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:04 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 15:44:04 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 15:44:04 INFO - Using env: {'DISPLAY': ':0', 15:44:04 INFO - 'HOME': '/home/cltbld', 15:44:04 INFO - 'LANG': 'en_US.UTF-8', 15:44:04 INFO - 'LANGUAGE': 'en_US:en', 15:44:04 INFO - 'LOGNAME': 'cltbld', 15:44:04 INFO - 'MAIL': '/var/mail/cltbld', 15:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:04 INFO - 'MOZ_NO_REMOTE': '1', 15:44:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:04 INFO - 'NO_EM_RESTART': '1', 15:44:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:04 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:04 INFO - 'SHELL': '/bin/bash', 15:44:04 INFO - 'SHLVL': '1', 15:44:04 INFO - 'TERM': 'linux', 15:44:04 INFO - 'TMOUT': '86400', 15:44:04 INFO - 'USER': 'cltbld', 15:44:04 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:04 INFO - '_': '/tools/buildbot/bin/python'} 15:44:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:44:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:44:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:44:06 INFO - Installing collected packages: mozsystemmonitor 15:44:06 INFO - Running setup.py install for mozsystemmonitor 15:44:06 INFO - Successfully installed mozsystemmonitor 15:44:06 INFO - Cleaning up... 15:44:06 INFO - Return code: 0 15:44:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:06 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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:06 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 15:44:06 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 15:44:06 INFO - Using env: {'DISPLAY': ':0', 15:44:06 INFO - 'HOME': '/home/cltbld', 15:44:06 INFO - 'LANG': 'en_US.UTF-8', 15:44:06 INFO - 'LANGUAGE': 'en_US:en', 15:44:06 INFO - 'LOGNAME': 'cltbld', 15:44:06 INFO - 'MAIL': '/var/mail/cltbld', 15:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:06 INFO - 'MOZ_NO_REMOTE': '1', 15:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:06 INFO - 'NO_EM_RESTART': '1', 15:44:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:06 INFO - 'SHELL': '/bin/bash', 15:44:06 INFO - 'SHLVL': '1', 15:44:06 INFO - 'TERM': 'linux', 15:44:06 INFO - 'TMOUT': '86400', 15:44:06 INFO - 'USER': 'cltbld', 15:44:06 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:06 INFO - '_': '/tools/buildbot/bin/python'} 15:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:06 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:44:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:44:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:44:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:09 INFO - Downloading docopt-0.6.1.tar.gz 15:44:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:44:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:09 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:09 INFO - Running setup.py install for blobuploader 15:44:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:10 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:44:10 INFO - Running setup.py install for requests 15:44:10 INFO - Running setup.py install for docopt 15:44:10 INFO - Successfully installed blobuploader requests docopt 15:44:10 INFO - Cleaning up... 15:44:10 INFO - Return code: 0 15:44:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:10 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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:10 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 15:44:10 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 15:44:10 INFO - Using env: {'DISPLAY': ':0', 15:44:10 INFO - 'HOME': '/home/cltbld', 15:44:10 INFO - 'LANG': 'en_US.UTF-8', 15:44:10 INFO - 'LANGUAGE': 'en_US:en', 15:44:10 INFO - 'LOGNAME': 'cltbld', 15:44:10 INFO - 'MAIL': '/var/mail/cltbld', 15:44:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:10 INFO - 'MOZ_NO_REMOTE': '1', 15:44:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:10 INFO - 'NO_EM_RESTART': '1', 15:44:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:10 INFO - 'SHELL': '/bin/bash', 15:44:10 INFO - 'SHLVL': '1', 15:44:10 INFO - 'TERM': 'linux', 15:44:10 INFO - 'TMOUT': '86400', 15:44:10 INFO - 'USER': 'cltbld', 15:44:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:10 INFO - '_': '/tools/buildbot/bin/python'} 15:44:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:10 INFO - Running setup.py (path:/tmp/pip-VYuA1B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:10 INFO - Running setup.py (path:/tmp/pip-FP2SSJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:10 INFO - Running setup.py (path:/tmp/pip-NIUtxj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:10 INFO - Running setup.py (path:/tmp/pip-1Xm1Dz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:11 INFO - Running setup.py (path:/tmp/pip-HkxSXd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:11 INFO - Running setup.py (path:/tmp/pip-9IQG1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:11 INFO - Running setup.py (path:/tmp/pip-9az1Wg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:11 INFO - Running setup.py (path:/tmp/pip-mI3Ad3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:11 INFO - Running setup.py (path:/tmp/pip-EO4yGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:11 INFO - Running setup.py (path:/tmp/pip-HmvvOp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:11 INFO - Running setup.py (path:/tmp/pip-QwuebO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:11 INFO - Running setup.py (path:/tmp/pip-fnmvIZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:11 INFO - Running setup.py (path:/tmp/pip-Y9cOB2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:11 INFO - Running setup.py (path:/tmp/pip-FJ3aT_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:11 INFO - Running setup.py (path:/tmp/pip-0oS7NQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:11 INFO - Running setup.py (path:/tmp/pip-ABzulL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:11 INFO - Running setup.py (path:/tmp/pip-cW_kLJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:11 INFO - Running setup.py install for manifestparser 15:44:12 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for mozcrash 15:44:12 INFO - Running setup.py install for mozdebug 15:44:12 INFO - Running setup.py install for mozdevice 15:44:12 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for mozfile 15:44:12 INFO - Running setup.py install for mozhttpd 15:44:12 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for mozinfo 15:44:12 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for mozInstall 15:44:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for mozleak 15:44:12 INFO - Running setup.py install for mozlog 15:44:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:44:12 INFO - Running setup.py install for moznetwork 15:44:13 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Running setup.py install for mozprocess 15:44:13 INFO - Running setup.py install for mozprofile 15:44:13 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Running setup.py install for mozrunner 15:44:13 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Running setup.py install for mozscreenshot 15:44:13 INFO - Running setup.py install for moztest 15:44:13 INFO - Running setup.py install for mozversion 15:44:13 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:44:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:13 INFO - Cleaning up... 15:44:13 INFO - Return code: 0 15:44:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:13 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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:13 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 15:44:13 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 15:44:13 INFO - Using env: {'DISPLAY': ':0', 15:44:13 INFO - 'HOME': '/home/cltbld', 15:44:13 INFO - 'LANG': 'en_US.UTF-8', 15:44:13 INFO - 'LANGUAGE': 'en_US:en', 15:44:13 INFO - 'LOGNAME': 'cltbld', 15:44:13 INFO - 'MAIL': '/var/mail/cltbld', 15:44:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:13 INFO - 'MOZ_NO_REMOTE': '1', 15:44:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:13 INFO - 'NO_EM_RESTART': '1', 15:44:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:13 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:13 INFO - 'SHELL': '/bin/bash', 15:44:13 INFO - 'SHLVL': '1', 15:44:13 INFO - 'TERM': 'linux', 15:44:13 INFO - 'TMOUT': '86400', 15:44:13 INFO - 'USER': 'cltbld', 15:44:13 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:13 INFO - '_': '/tools/buildbot/bin/python'} 15:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:13 INFO - Running setup.py (path:/tmp/pip-D7CL4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:14 INFO - Running setup.py (path:/tmp/pip-02YVfN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:14 INFO - Running setup.py (path:/tmp/pip-_Y2O6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:14 INFO - Running setup.py (path:/tmp/pip-RcQdKd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:14 INFO - Running setup.py (path:/tmp/pip-aKRuEG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:14 INFO - Running setup.py (path:/tmp/pip-Z_pSYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:14 INFO - Running setup.py (path:/tmp/pip-dq8EcM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:14 INFO - Running setup.py (path:/tmp/pip-x63LWJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:14 INFO - Running setup.py (path:/tmp/pip-wZ4ITi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:14 INFO - Running setup.py (path:/tmp/pip-hB29Ds-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:14 INFO - Running setup.py (path:/tmp/pip-KEyYSc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:14 INFO - Running setup.py (path:/tmp/pip-aZcFXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:14 INFO - Running setup.py (path:/tmp/pip-WWfnEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:44:14 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)) 15:44:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:14 INFO - Running setup.py (path:/tmp/pip-SsjHTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:44:15 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)) 15:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:15 INFO - Running setup.py (path:/tmp/pip-rMq3Cv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:44:15 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)) 15:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:15 INFO - Running setup.py (path:/tmp/pip-GSoCW8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:44:15 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)) 15:44:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:15 INFO - Running setup.py (path:/tmp/pip-EvG2r4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:44:15 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)) 15:44:15 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)) 15:44:15 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)) 15:44:15 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)) 15:44:15 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)) 15:44:15 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)) 15:44:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:16 INFO - Downloading blessings-1.5.1.tar.gz 15:44:16 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 15:44:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:16 INFO - Installing collected packages: blessings 15:44:16 INFO - Running setup.py install for blessings 15:44:17 INFO - Successfully installed blessings 15:44:17 INFO - Cleaning up... 15:44:17 INFO - Return code: 0 15:44:17 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:44:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:44:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:44:17 INFO - Reading from file tmpfile_stdout 15:44:17 INFO - Current package versions: 15:44:17 INFO - argparse == 1.2.1 15:44:17 INFO - blessings == 1.5.1 15:44:17 INFO - blobuploader == 1.2.4 15:44:17 INFO - docopt == 0.6.1 15:44:17 INFO - manifestparser == 1.1 15:44:17 INFO - mozInstall == 1.12 15:44:17 INFO - mozcrash == 0.16 15:44:17 INFO - mozdebug == 0.1 15:44:17 INFO - mozdevice == 0.47 15:44:17 INFO - mozfile == 1.2 15:44:17 INFO - mozhttpd == 0.7 15:44:17 INFO - mozinfo == 0.9 15:44:17 INFO - mozleak == 0.1 15:44:17 INFO - mozlog == 3.0 15:44:17 INFO - moznetwork == 0.27 15:44:17 INFO - mozprocess == 0.22 15:44:17 INFO - mozprofile == 0.27 15:44:17 INFO - mozrunner == 6.11 15:44:17 INFO - mozscreenshot == 0.1 15:44:17 INFO - mozsystemmonitor == 0.0 15:44:17 INFO - moztest == 0.7 15:44:17 INFO - mozversion == 1.4 15:44:17 INFO - psutil == 3.1.1 15:44:17 INFO - requests == 1.2.3 15:44:17 INFO - wsgiref == 0.1.2 15:44:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:17 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 0x7f0a7916ec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121d6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de6e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:17 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 15:44:17 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 15:44:17 INFO - Using env: {'DISPLAY': ':0', 15:44:17 INFO - 'HOME': '/home/cltbld', 15:44:17 INFO - 'LANG': 'en_US.UTF-8', 15:44:17 INFO - 'LANGUAGE': 'en_US:en', 15:44:17 INFO - 'LOGNAME': 'cltbld', 15:44:17 INFO - 'MAIL': '/var/mail/cltbld', 15:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:17 INFO - 'MOZ_NO_REMOTE': '1', 15:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:17 INFO - 'NO_EM_RESTART': '1', 15:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:17 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:17 INFO - 'SHELL': '/bin/bash', 15:44:17 INFO - 'SHLVL': '1', 15:44:17 INFO - 'TERM': 'linux', 15:44:17 INFO - 'TMOUT': '86400', 15:44:17 INFO - 'USER': 'cltbld', 15:44:17 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:17 INFO - '_': '/tools/buildbot/bin/python'} 15:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 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)) 15:44:17 INFO - Cleaning up... 15:44:17 INFO - Return code: 0 15:44:17 INFO - Running post-action listener: _resource_record_post_action 15:44:17 INFO - Running post-action listener: _start_resource_monitoring 15:44:17 INFO - Starting resource monitoring. 15:44:17 INFO - ##### 15:44:17 INFO - ##### Running install step. 15:44:17 INFO - ##### 15:44:17 INFO - Running pre-action listener: _resource_record_pre_action 15:44:17 INFO - Running main action method: install 15:44:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:44:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:44:17 INFO - Reading from file tmpfile_stdout 15:44:17 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:44:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:44:17 INFO - Reading from file tmpfile_stdout 15:44:17 INFO - Output received: 15:44:17 INFO - Usage: mozinstall [options] installer 15:44:17 INFO - Options: 15:44:17 INFO - -h, --help show this help message and exit 15:44:17 INFO - -d DEST, --destination=DEST 15:44:17 INFO - Directory to install application into. [default: 15:44:17 INFO - "/builds/slave/test-pgo"] 15:44:17 INFO - --app=APP Application being installed. [default: firefox] 15:44:17 INFO - mkdir: /builds/slave/test-pgo/build/application 15:44:17 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'] 15:44:17 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 15:44:32 INFO - Reading from file tmpfile_stdout 15:44:32 INFO - Output received: 15:44:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:44:32 INFO - Running post-action listener: _resource_record_post_action 15:44:32 INFO - ##### 15:44:32 INFO - ##### Running run-tests step. 15:44:32 INFO - ##### 15:44:32 INFO - Running pre-action listener: _resource_record_pre_action 15:44:32 INFO - Running main action method: run_tests 15:44:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:44:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:44:32 INFO - Python 2.7.3 15:44:32 INFO - Return code: 0 15:44:32 INFO - grabbing minidump binary from tooltool 15:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:32 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 0x1314a90>, '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 0x1366f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13672e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:44:32 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 15:44:32 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 15:44:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:32 INFO - Return code: 0 15:44:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:44:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:44:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:44:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:44:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:44:32 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 15:44:32 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 15:44:32 INFO - Using env: {'DISPLAY': ':0', 15:44:32 INFO - 'HOME': '/home/cltbld', 15:44:32 INFO - 'LANG': 'en_US.UTF-8', 15:44:32 INFO - 'LANGUAGE': 'en_US:en', 15:44:32 INFO - 'LOGNAME': 'cltbld', 15:44:32 INFO - 'MAIL': '/var/mail/cltbld', 15:44:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:44:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:44:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:32 INFO - 'MOZ_NO_REMOTE': '1', 15:44:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:44:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:32 INFO - 'NO_EM_RESTART': '1', 15:44:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:44:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:44:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:44:32 INFO - 'SHELL': '/bin/bash', 15:44:32 INFO - 'SHLVL': '1', 15:44:32 INFO - 'TERM': 'linux', 15:44:32 INFO - 'TMOUT': '86400', 15:44:32 INFO - 'USER': 'cltbld', 15:44:32 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266', 15:44:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:32 INFO - '_': '/tools/buildbot/bin/python'} 15:44:32 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 15:44:32 INFO - mozversion INFO | application_buildid: 20151117133030 15:44:32 INFO - mozversion INFO | application_changeset: 233f67378440e5495a636e6fffc02ec1f1eaffce 15:44:32 INFO - mozversion INFO | application_display_name: Nightly 15:44:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:32 INFO - mozversion INFO | application_name: Firefox 15:44:32 INFO - mozversion INFO | application_remotingname: firefox 15:44:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:44:32 INFO - mozversion INFO | application_vendor: Mozilla 15:44:32 INFO - mozversion INFO | application_version: 45.0a1 15:44:32 INFO - mozversion INFO | platform_buildid: 20151117133030 15:44:32 INFO - mozversion INFO | platform_changeset: 233f67378440e5495a636e6fffc02ec1f1eaffce 15:44:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:44:32 INFO - mozversion INFO | platform_version: 45.0a1 15:44:32 INFO - 2015-11-17 15:44:32,551 DEBUG : using testdate: 1447803872 15:44:32 INFO - 2015-11-17 15:44:32,551 DEBUG : actual date: 1447803872 15:44:32 INFO - 2015-11-17 15:44:32,559 INFO : starting webserver on 'localhost:51237' 15:44:32 INFO - 2015-11-17 15:44:32,560 INFO : Starting test suite talos-linux64-ix-068 15:44:32 INFO - 2015-11-17 15:44:32,561 INFO : Starting test dromaeo_css 15:44:32 INFO - 2015-11-17 15:44:32,561 DEBUG : operating with platform_type : linux_ 15:44:32 INFO - 2015-11-17 15:44:32,562 INFO : Initialising browser for dromaeo_css test... 15:44:32 INFO - 2015-11-17 15:44:32,574 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2yMMi4/profile http://localhost:51237/getInfo.html 15:44:37 INFO - 2015-11-17 15:44:37,181 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:44:37 INFO - 2015-11-17 15:44:37,181 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:44:37 INFO - 2015-11-17 15:44:37,181 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:44:37 INFO - 2015-11-17 15:44:37,182 DEBUG : BROWSER_OUTPUT: __metrics 15:44:37 INFO - 2015-11-17 15:44:37,343 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:44:38 INFO - 2015-11-17 15:44:38,495 INFO : Browser initialized. 15:44:38 INFO - 2015-11-17 15:44:38,495 INFO : Running cycle 1/1 for dromaeo_css test... 15:44:38 INFO - 2015-11-17 15:44:38,496 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2yMMi4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:44:50 INFO - 2015-11-17 15:44:50,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 140001280 15:44:50 INFO - 2015-11-17 15:44:50,252 DEBUG : BROWSER_OUTPUT: 15:45:41 INFO - 2015-11-17 15:45:41,847 DEBUG : BROWSER_OUTPUT: 1447803941846 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] 15:47:50 INFO - 2015-11-17 15:47:50,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51237/tests/dromaeo/cssquery-ext.html) 15:47:51 INFO - 2015-11-17 15:47:51,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 261865472 15:47:51 INFO - 2015-11-17 15:47:51,774 DEBUG : BROWSER_OUTPUT: 15:50:54 INFO - 2015-11-17 15:50:54,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-ext.html (next: http://localhost:51237/tests/dromaeo/cssquery-jquery.html) 15:50:54 INFO - 2015-11-17 15:50:54,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 220594176 15:50:54 INFO - 2015-11-17 15:50:54,632 DEBUG : BROWSER_OUTPUT: 15:53:56 INFO - 2015-11-17 15:53:56,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51237/tests/dromaeo/cssquery-mootools.html) 15:53:57 INFO - 2015-11-17 15:53:57,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 205172736 15:53:57 INFO - 2015-11-17 15:53:57,035 DEBUG : BROWSER_OUTPUT: 15:56:58 INFO - 2015-11-17 15:56:58,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51237/tests/dromaeo/cssquery-prototype.html) 15:56:59 INFO - 2015-11-17 15:56:59,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 199266304 15:56:59 INFO - 2015-11-17 15:56:59,516 DEBUG : BROWSER_OUTPUT: 16:00:01 INFO - 2015-11-17 16:00:01,958 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51237/tests/dromaeo/cssquery-yui.html) 16:00:02 INFO - 2015-11-17 16:00:02,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 202403840 16:00:02 INFO - 2015-11-17 16:00:02,525 DEBUG : BROWSER_OUTPUT: 16:03:04 INFO - 2015-11-17 16:03:04,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/dromaeo/cssquery-yui.html (next: http://localhost:51237/tests/dromaeo/cssquery-dojo.html) 16:03:05 INFO - 2015-11-17 16:03:05,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 294670336 16:03:05 INFO - 2015-11-17 16:03:05,234 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,235 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:03:05 INFO - 2015-11-17 16:03:05,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:03:05 INFO - 2015-11-17 16:03:05,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:03:05 INFO - 2015-11-17 16:03:05,235 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:03:05 INFO - 2015-11-17 16:03:05,235 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3167.9524807127896;3244.7404207663403;3275.1648329675927;3280.360329735701;3289.2599165187835;5153.407358153813;5291.3385826771655;5317.46825317468;5338.839834804957;5393.757280922358;5288.338957630296;5321.787128514855;5373.059714549958;5373.704446255454;5436.809711660093;4878.243872199815;4914.582260507861;4994;5048.747562621873;5070.822521211759;4986.900261994758;5008.649394542384;5084.720340381277;5091.032703786287;5134.409542902558;4803.951960480403;4921.80312787488;4922.704637721748;4995.425526064477;5001.974595207974;4970.900581988376;4980;4989.201727723546;4990.925136122961;5028.974855125737;4938.456769755324;4966.975165124188;4971.055499455092;4978.054169707781;5014.924776128361;5126.333576635014;5224;5246.317978662788;5260.789568417297;5353.544948679367;5814.040683287252;5817.709114544298;5818.8254352369495;5828.0966450200285;5841.240638716982;5680.005998950167;5864.5894787364905;5867.794627188071;5882.529397648221;5893.675847828367;5422.40353561108;5426.294581704393;5520.337559492887;5531.640443371168;5537.944620553823;5792.768289268466;5818;5821.039528477754;5853.1220316952795;5876.265466816648;5655.462731040545;5657.971710141423;5660.575456840671;5666.97166514173;5673.290838645169;5623.6906970116215;5743.2246646703;5756.827295181068;5881.617694849821;5897.085951677497;5783.624064435799;5783.971080144656;5784.334801497882;5789.94210057894;5811.593188476766;5777.884442311214;5779.450952159538;5784.797532086357;5794.101914203306;5794.942050579524;4361.542038085955;4389.31965545341;4474.507804141542;4497.437820272466;4500.459944806644;4015.13674559971;4026.778527181033;4030.717849750489;4035.899102522402;4072.552019277877;5482.616216864782;5484.424135465799;5496.065668836308;5499.532539734168;5508.614396992252;5763;5808.128780682931;5906.379830117861;5911;5922.822315330461;5520.06158952979;5528.087865502228;5537.695426751487;5542.501174894279;5547.029269877755;5033.295338652591;5035.370578677665;5038.773255203525;5069.898602027939;5077.238414237894;5824.475797178275;5876.294844618673;5894.616849904743;5935.109733540004;5943.851403714855;5839.270091238595;5861.267341582302;5863.765449381977;5875.089361149029;5878.529717622494;5925.05199168131;5934.584579079423;5937.9406205937385;5940.673262970578;6008.609440386361;5543.501084902378;5614.719264036864;5635.520980716685;5700.3444603871085;5760.884782304247;5770.3652598215;5782.479576838105;5795.971020144872;5796.188533605215;5803.216565763568;5416.9729151353995;5663.150527420919;5685.687287199078;5687.744051517609;5701.714914254354;5515.145152501369;5561.972190139023;5683.204351390726;5832.533397328289;5854.765809367577;5550.8057217997175;5551.7779288828;5564.749586268708;5572.944270557243;5589.888202236014;5615.971920140373;5620.634658747168;5639.54883609302;5661.547076233809;5661.858453538694;5454.699991500347;5569.860753481195;5611.551075913999;5614.719264036864;5625.437456254342 16:03:05 INFO - 2015-11-17 16:03:05,236 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.1349149293075;590.7843637072468;607.7994261893575;617.5337620096826;629.2669040567739;32537;33171.17072073199;33233.5014974775;33237.005779653235;33240.33519329618;33338.33323333532;41912.58087419125;42626;42686.35970460445;42780.57219427805;8787.12128787121;8946.284297256236;8946.702728104421;8947.597358118901;8949.194572488475;7748.070231572219;7815.765527034198;8709.129087091304;8859.069797671249;8866.512341821197;10632.362058276529;10818.08046316064;10821.080208182313;10833.133349332034;10876.075533579655;10412.739681507946;10526.42104684242;10531.104856087242;10535.789284214312;10545.367277963347;7896.289333959914;8078.838423231561;10317.84523232152;10601.151907847354;10880.619178328721;40786.79606601978;41151.58848411508;41334.379984300256;41419.585804141876;41441.79279103585;3438.9656103438897;3466.687998080185;3517.4547945068557;3759.3797023491093;3773.3773927301963;30740.846295768377;30953.53569696456;31014.224644383845;31164.53253201204;31637.367252655047;3678.319510890467;3682.815859207029;3684;3744.6936023572835;3794.753341032824;274148;277611;277778;278215;278740.6062969692;60318;60554;60618.09072863911;60663.39336606666;60746;64259.67870160619;64363;64423.35576644174;64431.8454523637;64491;16328.34686612546;16387.508374748777;16390.508284751475;16570.58573535671;16616.66766664684;11681.474333655005;11699.23954942943;11710.063194944383;11767;11780.17538772295;18817.90591047036;20131.39605811828;20137.39587812368;20145.294914677917;20154.69767953482;7664.923350766532;7724.497907635986;7781.299683028441;7861.095973962953;7898.565578893101;931.5249222896372;937.6765016069445;986.5511192407438;1049.506731836036;1065.1159537583787;28322.71677283242;28468.715312846605;28610.14169574916;28741.56887646687;28769.424611507653;861.2421069458836;1004.2719028704277;1015.2436434855932;1045.3884477580548;1196.186593116689;13765.38055787492;13869;13925.303734813218;14200.715985680436;14276.072055316372;319765;326659;328090;432564;446977;49883.75058124686;51584;51595;51601;52236.47763522392;1332.0342751505275;1339.145283781969;1340.249460302234;1346.5421756602607;1365.0512893539094;25503.36241593901;26161;29916;30704.232394189432;30856.53715194229;48401.757991209815;48821;48845;48847.755761220964;48858;269338;273970;274616;274880;274899;30502.237444063187;30867.845660771553;31014.68985310118;31041.689583104784;31108.22229444282;42748.358774619024;42903.14193716171;43383.56616433795;43478.347824782024;43822.56177438185;35543.82228088843;36696.26607467889;36820.44769328516;36957.445638315985;37136.07159821026;35288.29423411466;35679.28641427105;36198.27603447969;36590.451143233404;36703.632963670025;36155;36170;36706.81646591857;36804.81597591995;36823;28093.173943693593;30438.695613043586;32018.51972220372;33679.83160084184;33693;24658.753412465645;24974.750252497244;25018.98481215057;25042.248732538053;25321.620175697746 16:03:05 INFO - 2015-11-17 16:03:05,236 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.2178510681811;331.4034737472549;354.82790846439474;358.64673296802647;358.73274410564125;15836.208189590518;16706.498805035837;16718.83281167188;17056.744148837748;17065.80539362245;15609.219539023032;15897.84102158978;15981.200939953014;16043.759343609856;16121.516354509355;4698.2482802751565;5369.62412631116;5390.56875449965;5394.676319420828;5397.62216644835;5186.636935414523;5363.249145119687;5383.111786555213;5398.649087809299;5401.405845357008;3965.6430921217084;4153.54311025787;5307.946920530803;5317.255584218213;5337.279467271907;5820.476157145856;5969.373215812364;6013.1581578579035;6013.939860601382;6019.578629495959;5171.5087066728975;5224.8693782655355;5246.029484545371;5246.7901283948595;5254.7635356409055;16355.754663680054;18023.549411264692;19878;20574.485637859023;21148.5770284595;2093.3824521766114;2115.7989990950837;2117.2695420080204;2141;2281.281396360141;12898.613041608673;12992.895603873681;13009.479620815157;13053.412596433183;13151.408186631625;1771.7165253559497;1799.3252530301138;1810.3663717698832;1851.5186051626674;1860.2744929477515;60056.69971650158;60706;60774.088388674645;61308.69345653243;62038.37961620371;9446.055394460636;9702.90297097034;9992.40045597252;10005.649802256887;10067;12848.550300739429;12925.676858078436;12930.418131184118;12949.54676586315;12950.870491295154;7448.925510744823;7532.887006694904;7602;7630.542167469969;7642.923570764332;7332.706691732271;7360.815979600553;7385.4460915431555;7414.518056326321;7418.072740907387;5920.615160014585;6029.095635654687;6042.758289668452;6047.304559975659;6083.178770865965;1707.7865266841645;1767.7878654561534;1771.5393997560727;1772.2822256985942;1783.3669047488215;920.4247345409119;946.6071580294239;994.4083270454068;1025.6871654145557;1070.82866741321;14823;17501.562460938323;17507.387241446744;17591.208395622227;18031;935.2985261054209;962.7063745557532;963.5182408795603;975.6585195181772;980.4509474694194;10018;10266.076053155251;10333.689989300334;10340.689779306633;10350.792984140275;365623;368415;551568;570991;578361.1638836083;36830.63169368326;36884.446733299024;36952.63047369492;51835.96328073418;61996.690016549626;1137.7212582917239;1139.4701463819363;1142.7543078238218;1157.3171828620987;1159.1885680024018;15847.762283565526;15858.682826343178;16144.515664530083;16237.119782924032;16324.67350653004;34189.31621367609;34195.65804342024;35093.64906350904;35105;35842.64157358497;46629.30056049094;46837.29744053774;46986.530134699584;47120.29319560278;47151.52848471609;9389.342746007715;9521;9672;9695.563699633392;9704;17858.642827143645;17882.55293617618;18286.817131829044;18355.246712992623;18412.63174736471;14751;14884.62788430298;15198.544043678707;15268.923655381652;15277.923610382322;14433.855661443671;14519;14594.409447646482;14755.409783608964;15012.549623511311;15174.393024278905;15478.5356439307;15655.452059177875;15753.369865205721;15868.76196857025;9437.433753974783;9437.952810235905;9621.27840411958;9623.326367154232;9634.518274086407;10214.948925255327;10702.678919632424;10778.73053173677;10943.45282735876;15365.692686146438 16:03:05 INFO - 2015-11-17 16:03:05,237 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1611.6212690017837;1722.4918648998544;1771.1498480729254;1784.3754685859951;1809.3215044358374;6795.524313298065;7549.773506794798;7770.3783697304225;7782.533048017123;7814.570198639072;7683.6158192090315;7705.614719264043;7729.304362607364;7731.613419329039;7749.53502789833;2003.3489116037347;2055.07521615273;2315.270689732733;2337.3922780077132;2341.321016905104;2283.600369935263;2335.054303007285;2335.4628435459854;2335.9371485973843;2336.8481048731865;2263.094762095167;2303.0442366417915;2303.67748515208;2307.3885420363617;2309.1340747219792;1981.3164458261876;2056.167252262836;2214.9889250553806;2256.751757306695;2300.1949317738827;2200.658897870833;2210.767869373709;2216.645336746129;2218.866867987926;2219.933401997943;7740.729074482422;7768.456208065438;7806;7815.570143642098;7819.6481158348015;4799.112164249625;4908.950910490885;4910.459849416561;4911.607071434277;4916.237983112587;2925.9853700731574;2988.8804447822063;3013.352129292213;3028.0764366868098;3038.6809385014476;961.9615215391376;969.60730903984;982.2829334585792;1003.1573478278282;1003.6136087606324;10800.5679772809;10982.945085274523;10991.340519568852;11008.834867476995;11013.889861101447;4336.82652693895;4405.0969551241915;4466.821327146943;4467.061916997467;4506.864794056183;9381.577828997575;9425.952870235742;9510.239180865514;9534.618615255313;9562.665306714232;4773.832915847928;4785.210440277385;4857.854264372075;4872.902541949141;4899.5590396863745;4368.5194628590825;4405.427294451765;4408.713433626868;4434.312681534368;4438.7114837535455;3599.7480176387926;3640.5995340512522;3643.85424583019;3664.835082421244;3691.9815400922826;1170.1750266062406;1177.3406892140429;1192.6605504587121;1196.6051203102954;1210.328267811373;1235.975280494385;1258.2702032820941;1267.0687045021903;1362.7615167345675;1362.8364596248316;6698.497612679069;6856.897146542806;7379.188289288174;7559.773206803805;7566.31903128721;639.8688268904864;643.7392855893371;657.0538424668462;712.4300559552337;722.9638518074075;5738.5982981191755;5768.9711551442815;5796.594238403356;5808.651480911159;5815.41845815415;8981.865272020925;9034;9121.17909388145;9329.580168892417;9334.953325233331;9116.088391160964;9121.179093881583;9170.95414522923;9177.265818734486;9212.585433655502;7248.96375518119;7339.522931009574;7401.370883474858;7434.219406962191;7434.925650743531;6952.0267162596265;7016.403605693573;7049.048378468841;7054.365107140382;7060.964695176492;8160.755177344689;8352.498850069016;8490.108538603357;8494.405391622528;8509.106543813057;8526.957365213135;8601.65593376283;8634.438761480484;8771.210591046836;8779.868301975348;6699.598024118569;6855.383015528427;6892.379685828299;6902.171739391305;6903.309669033258;7313.085864266966;7352.4485663576515;7360.668769905475;7368.815779605553;7373.078365204349;6829.590224586541;7037.964810175917;7076.32774886385;7117.537360071578;7235.384992275715;6872.072270243453;6895.620740859301;6965.686544105426;6996.6151861648095;7025.192102908231;6032.939670603413;6191.514036631086;6729.865402692017;6735.562188457735;6969.895451568129;6168.475679567107;6290.937090629035;6307.716152773228;6337.36626337381;6343.492520598434;6512.6743662815725;6537.444317232898;6541.70562324687;6551.312112228147;6568.211814582281 16:03:05 INFO - 2015-11-17 16:03:05,238 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.06354848519595;322.78373489761856;328.3433133732534;337.0696876620528;337.8108259374749;5799.652020878751;5962.433568810961;5964.314103878055;6024.397560243973;6064.969675151629;5800.245968024162;5877.265341832271;5925.259342582177;5943.702814859251;5964.194833697449;4587.655925805561;4592.609628181609;4593.494715581283;4597.287420449836;4600.42494688164;4409.977950110245;4493.41585593874;4516.638668906479;4591.65562582806;4603.355530225755;4520.3219517072375;4528.954710452903;4531.116432295687;4541.341505481703;4553.749543775091;4541.159885421208;4545.659075569312;4546.772661366918;4557.908841823161;4559;3959.8812035638975;3960.4455376247347;3969.960300396988;3971.4241434992055;3983.5618082010956;5552.472515111099;5573.303337082864;5639.915401268984;5645.661260324394;5652.604317697763;5244.580433565306;5247.947520524784;5252.684838909678;5257.263983042377;5269.2886460327745;6290.119383286344;6293.213348331458;6295.905561416583;6296.338884417116;6298.779542715983;4384.956150438518;4388.42950416447;4391.560843915615;4402.84590039347;4410.1179764047;6403.327650596667;6562.868742625168;6588.077669126326;6602.636854972975;6609.900851487231;4408.647308215335;4424.80088396023;4433.8226470941445;4437.023854751949;4441;4496.437945256843;4498.347739577743;4500.234960056799;4501.527339629357;4501.932471012938;5236.528712415825;5238.554722848525;5240;5242.633015688865;5250.789968401221;6249.96875015622;6407.679616019181;6416.037594360883;6417.197850268716;6422.133012043314;1580.8023997000375;1592.0925072708444;1593.8326475719882;1594.186964648038;1594.9122798245976;996.8903420623726;1026.2610920137488;1028.2442404832443;1053.1943063556384;1055.4933631856597;6068.120122582201;6093.329733729286;6095.7866474674065;6098.14625952367;6100.298465676416;6401.615903045739;6523.086767852505;6528.477721782246;6530.183727034121;6557.278699343068;6083.904897118561;6208.81373558794;6212.751489940351;6246.843828904223;6259.280182779039;3559.893203203908;3587.6412358764437;3591.3535563598803;3592.3713350163616;3595.676389124991;6763.72945082201;6883.3116688330765;6901.62041087735;6905.102336696197;6911.861762764716;6811.148606424197;6811.761588344384;6818.249992500821;6828.658567071627;6828.658567071726;6833.487488438288;6835.487338449636;6878.931210687829;6901.447884169254;6903.482238832108;6448.161738973903;6611.768588099393;6617.933820661732;6639.2364878037715;6641;6536.3136870627895;6546.378094081055;6547.083408322934;6552.641049222181;6553.04980777775;6884.311568843276;6897.55165914214;6898;6900.551464154814;6901.137357830271;4389.40742999691;4479.104179164246;4480.14877173336;4481.775911204492;4490.034642551867;6604.438622716931;6607.108040414482;6608.339166083353;6616.437602803816;6624.436922861611;6381.106645069787;6396.584222025554;6419.165508483868;6425.4217120457515;6425.935740642721;6272.811815645356;6340.904886426615;6385.648789316632;6391.744330226739;6416.967915160394;6295.905561416491;6299.874002520016;6300.401461861299;6303.36966303366;6311.211098612674;6447.290798012121;6448.645324507197;6449.226092868886;6450.322716114741;6461.870762584816;6105.8168254952425;6182.567220294536;6296.307406185224;6303.558750887394;6317.4630156437215 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: |5;yui.html;857.3227150551065;865.1737590600977;879.4327658660164;879.9208071273586;895.6193617712474;13847.446102155915;14204.50284240053;14205.218712970782;14212.928935355309;14268.714625707506;13258.734825303489;13301.201927884309;13337.399817008234;13337.733245335088;13365.398557064931;834.2450082675189;849.8215374771305;852.3649880838752;852.40757673417;852.7186028610574;687.5221720903974;697.4072038767058;837.1753822484848;837.6900546797693;853.2448782827212;881.0220655072864;884.3897710579712;891.7101941868887;892.4288455388556;893.3612467086032;724.7028718225555;882.8278485695292;885.7874110213567;886.162576365335;886.4193952960788;540.6296686769575;640.4172203294979;648.5395369287811;651.3226244705501;652.6540933305308;13745.450181992708;13974.720505589832;13987.860121398757;13988.230647314496;13993;12587.307698076602;13252.933735331359;13254.343207099113;13339.19964802115;13365.66585835352;10324.277300588961;10531.26281160319;10539.314944528582;10590.841137382946;10639.308444951132;3171.9682803172136;3195.408849362852;3228.338190670907;3232.159638493985;3250.756193285513;47141.528584714055;47636;47641.04717905657;47698.28452573214;47879.28181077287;7532.322091011835;7742.14836367999;7749.418793590503;7829.138794732575;7965.362770978308;11464.426778661034;11513.194076414571;11533.711657208469;11558.826617600742;11634.952854243158;6493.935060649427;6573.671316434159;6676.899846502306;6761.121054262914;7083.7520686775715;4400.69195156336;4488.483824360175;4491.820327186876;4503.932441013388;4672.696274742131;2780.4439112177647;2825.166575860126;2829.2643912582876;2833.0367674990603;2834.0364276145797;451.51687694166924;456.80129143822546;457.7185031205851;458;458.58956234170233;529.1190168369621;646.9353064693587;650.3723906430317;661.6658587413325;680.0683064202075;8355.749327520183;8813;9023.323250756219;9051.185393314501;9282;630.4704048599107;633.9413179989428;683.7401787320787;691.6230654293422;695.8782213112786;3952.505936757905;4012.35802271641;4145;4177.352510360899;4271.615554600101;52786.47213527892;53635.46364536383;53673.1949020765;53700;53783.46216537863;48957.75521122372;51711.74144129255;53295;53757;54357.1846422304;48002.5199748005;48669.5133048665;49323;49621.75189124031;49953.25070123951;9255.537223138681;9355.906440935503;9535.570899309687;9602.231821454407;9605.327627066039;32428.513572295964;33187;34168.48747268843;38041.61958380381;38270.617293826705;41282.1743565133;41314.380284295155;44399.334009990525;48051.5194848047;48828.26757598568;8167.79580510492;8175.7138500152205;8199.836003280021;8200.507969521848;8279.62741676614;11968.401579920795;12294.631161065183;12535.623931282076;12756.61730148097;13270.27013514266;11145.2198346115;11721.824172637247;11810.350430726392;12206.633800985985;12215.938920305342;11038.613648522263;11819.172657913863;11839.940800296288;12216.75566488683;12244.571439999914;7208.125887269242;10798.67603971882;11606.825897611712;11802.94098529502;12136.75726485483;9571.33000689945;10231.334963227366;10236;10380.169586433218;10614.469276536296;8539.274161696077;9499;9842.852357214791;10036.849447258443;10241.487925603838 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,947 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:03:05 INFO - 2015-11-17 16:03:05,240 DEBUG : BROWSER_OUTPUT: __startTimestamp1447804985229__endTimestamp 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5386.80 Median:5564.75 stddev:580.60 (10.4%) stddev-sans-first:555.67 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: Values: 3168.0 3244.7 3275.2 3280.4 3289.3 5153.4 5291.3 5317.5 5338.8 5393.8 5288.3 5321.8 5373.1 5373.7 5436.8 4878.2 4914.6 4994.0 5048.7 5070.8 4986.9 5008.6 5084.7 5091.0 5134.4 4804.0 4921.8 4922.7 4995.4 5002.0 4970.9 4980.0 4989.2 4990.9 5029.0 4938.5 4967.0 4971.1 4978.1 5014.9 5126.3 5224.0 5246.3 5260.8 5353.5 5814.0 5817.7 5818.8 5828.1 5841.2 5680.0 5864.6 5867.8 5882.5 5893.7 5422.4 5426.3 5520.3 5531.6 5537.9 5792.8 5818.0 5821.0 5853.1 5876.3 5655.5 5658.0 5660.6 5667.0 5673.3 5623.7 5743.2 5756.8 5881.6 5897.1 5783.6 5784.0 5784.3 5789.9 5811.6 5777.9 5779.5 5784.8 5794.1 5794.9 4361.5 4389.3 4474.5 4497.4 4500.5 4015.1 4026.8 4030.7 4035.9 4072.6 5482.6 5484.4 5496.1 5499.5 5508.6 5763.0 5808.1 5906.4 5911.0 5922.8 5520.1 5528.1 5537.7 5542.5 5547.0 5033.3 5035.4 5038.8 5069.9 5077.2 5824.5 5876.3 5894.6 5935.1 5943.9 5839.3 5861.3 5863.8 5875.1 5878.5 5925.1 5934.6 5937.9 5940.7 6008.6 5543.5 5614.7 5635.5 5700.3 5760.9 5770.4 5782.5 5796.0 5796.2 5803.2 5417.0 5663.2 5685.7 5687.7 5701.7 5515.1 5562.0 5683.2 5832.5 5854.8 5550.8 5551.8 5564.7 5572.9 5589.9 5616.0 5620.6 5639.5 5661.5 5661.9 5454.7 5569.9 5611.6 5614.7 5625.4 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47760.42 Median:33509.08 stddev:81913.14 (244.5%) stddev-sans-first:82066.30 16:03:05 INFO - 2015-11-17 16:03:05,241 DEBUG : BROWSER_OUTPUT: Values: 569.1 590.8 607.8 617.5 629.3 32537.0 33171.2 33233.5 33237.0 33240.3 33338.3 41912.6 42626.0 42686.4 42780.6 8787.1 8946.3 8946.7 8947.6 8949.2 7748.1 7815.8 8709.1 8859.1 8866.5 10632.4 10818.1 10821.1 10833.1 10876.1 10412.7 10526.4 10531.1 10535.8 10545.4 7896.3 8078.8 10317.8 10601.2 10880.6 40786.8 41151.6 41334.4 41419.6 41441.8 3439.0 3466.7 3517.5 3759.4 3773.4 30740.8 30953.5 31014.2 31164.5 31637.4 3678.3 3682.8 3684.0 3744.7 3794.8 274148.0 277611.0 277778.0 278215.0 278740.6 60318.0 60554.0 60618.1 60663.4 60746.0 64259.7 64363.0 64423.4 64431.8 64491.0 16328.3 16387.5 16390.5 16570.6 16616.7 11681.5 11699.2 11710.1 11767.0 11780.2 18817.9 20131.4 20137.4 20145.3 20154.7 7664.9 7724.5 7781.3 7861.1 7898.6 931.5 937.7 986.6 1049.5 1065.1 28322.7 28468.7 28610.1 28741.6 28769.4 861.2 1004.3 1015.2 1045.4 1196.2 13765.4 13869.0 13925.3 14200.7 14276.1 319765.0 326659.0 328090.0 432564.0 446977.0 49883.8 51584.0 51595.0 51601.0 52236.5 1332.0 1339.1 1340.2 1346.5 1365.1 25503.4 26161.0 29916.0 30704.2 30856.5 48401.8 48821.0 48845.0 48847.8 48858.0 269338.0 273970.0 274616.0 274880.0 274899.0 30502.2 30867.8 31014.7 31041.7 31108.2 42748.4 42903.1 43383.6 43478.3 43822.6 35543.8 36696.3 36820.4 36957.4 37136.1 35288.3 35679.3 36198.3 36590.5 36703.6 36155.0 36170.0 36706.8 36804.8 36823.0 28093.2 30438.7 32018.5 33679.8 33693.0 24658.8 24974.8 25019.0 25042.2 25321.6 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26575.56 Median:17260.36 stddev:80900.58 (468.7%) stddev-sans-first:81103.52 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: Values: 325.2 331.4 354.8 358.6 358.7 15836.2 16706.5 16718.8 17056.7 17065.8 15609.2 15897.8 15981.2 16043.8 16121.5 4698.2 5369.6 5390.6 5394.7 5397.6 5186.6 5363.2 5383.1 5398.6 5401.4 3965.6 4153.5 5307.9 5317.3 5337.3 5820.5 5969.4 6013.2 6013.9 6019.6 5171.5 5224.9 5246.0 5246.8 5254.8 16355.8 18023.5 19878.0 20574.5 21148.6 2093.4 2115.8 2117.3 2141.0 2281.3 12898.6 12992.9 13009.5 13053.4 13151.4 1771.7 1799.3 1810.4 1851.5 1860.3 60056.7 60706.0 60774.1 61308.7 62038.4 9446.1 9702.9 9992.4 10005.6 10067.0 12848.6 12925.7 12930.4 12949.5 12950.9 7448.9 7532.9 7602.0 7630.5 7642.9 7332.7 7360.8 7385.4 7414.5 7418.1 5920.6 6029.1 6042.8 6047.3 6083.2 1707.8 1767.8 1771.5 1772.3 1783.4 920.4 946.6 994.4 1025.7 1070.8 14823.0 17501.6 17507.4 17591.2 18031.0 935.3 962.7 963.5 975.7 980.5 10018.0 10266.1 10333.7 10340.7 10350.8 365623.0 368415.0 551568.0 570991.0 578361.2 36830.6 36884.4 36952.6 51836.0 61996.7 1137.7 1139.5 1142.8 1157.3 1159.2 15847.8 15858.7 16144.5 16237.1 16324.7 34189.3 34195.7 35093.6 35105.0 35842.6 46629.3 46837.3 46986.5 47120.3 47151.5 9389.3 9521.0 9672.0 9695.6 9704.0 17858.6 17882.6 18286.8 18355.2 18412.6 14751.0 14884.6 15198.5 15268.9 15277.9 14433.9 14519.0 14594.4 14755.4 15012.5 15174.4 15478.5 15655.5 15753.4 15868.8 9437.4 9438.0 9621.3 9623.3 9634.5 10214.9 10702.7 10778.7 10943.5 15365.7 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5449.17 Median:3578.21 stddev:2831.83 (79.1%) stddev-sans-first:2825.09 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: Values: 1611.6 1722.5 1771.1 1784.4 1809.3 6795.5 7549.8 7770.4 7782.5 7814.6 7683.6 7705.6 7729.3 7731.6 7749.5 2003.3 2055.1 2315.3 2337.4 2341.3 2283.6 2335.1 2335.5 2335.9 2336.8 2263.1 2303.0 2303.7 2307.4 2309.1 1981.3 2056.2 2215.0 2256.8 2300.2 2200.7 2210.8 2216.6 2218.9 2219.9 7740.7 7768.5 7806.0 7815.6 7819.6 4799.1 4909.0 4910.5 4911.6 4916.2 2926.0 2988.9 3013.4 3028.1 3038.7 962.0 969.6 982.3 1003.2 1003.6 10800.6 10982.9 10991.3 11008.8 11013.9 4336.8 4405.1 4466.8 4467.1 4506.9 9381.6 9426.0 9510.2 9534.6 9562.7 4773.8 4785.2 4857.9 4872.9 4899.6 4368.5 4405.4 4408.7 4434.3 4438.7 3599.7 3640.6 3643.9 3664.8 3692.0 1170.2 1177.3 1192.7 1196.6 1210.3 1236.0 1258.3 1267.1 1362.8 1362.8 6698.5 6856.9 7379.2 7559.8 7566.3 639.9 643.7 657.1 712.4 723.0 5738.6 5769.0 5796.6 5808.7 5815.4 8981.9 9034.0 9121.2 9329.6 9335.0 9116.1 9121.2 9171.0 9177.3 9212.6 7249.0 7339.5 7401.4 7434.2 7434.9 6952.0 7016.4 7049.0 7054.4 7061.0 8160.8 8352.5 8490.1 8494.4 8509.1 8527.0 8601.7 8634.4 8771.2 8779.9 6699.6 6855.4 6892.4 6902.2 6903.3 7313.1 7352.4 7360.7 7368.8 7373.1 6829.6 7038.0 7076.3 7117.5 7235.4 6872.1 6895.6 6965.7 6996.6 7025.2 6032.9 6191.5 6729.9 6735.6 6969.9 6168.5 6290.9 6307.7 6337.4 6343.5 6512.7 6537.4 6541.7 6551.3 6568.2 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,242 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5318.91 Median:6088.62 stddev:1624.36 (26.7%) stddev-sans-first:1584.97 16:03:05 INFO - 2015-11-17 16:03:05,244 DEBUG : BROWSER_OUTPUT: Values: 319.1 322.8 328.3 337.1 337.8 5799.7 5962.4 5964.3 6024.4 6065.0 5800.2 5877.3 5925.3 5943.7 5964.2 4587.7 4592.6 4593.5 4597.3 4600.4 4410.0 4493.4 4516.6 4591.7 4603.4 4520.3 4529.0 4531.1 4541.3 4553.7 4541.2 4545.7 4546.8 4557.9 4559.0 3959.9 3960.4 3970.0 3971.4 3983.6 5552.5 5573.3 5639.9 5645.7 5652.6 5244.6 5247.9 5252.7 5257.3 5269.3 6290.1 6293.2 6295.9 6296.3 6298.8 4385.0 4388.4 4391.6 4402.8 4410.1 6403.3 6562.9 6588.1 6602.6 6609.9 4408.6 4424.8 4433.8 4437.0 4441.0 4496.4 4498.3 4500.2 4501.5 4501.9 5236.5 5238.6 5240.0 5242.6 5250.8 6250.0 6407.7 6416.0 6417.2 6422.1 1580.8 1592.1 1593.8 1594.2 1594.9 996.9 1026.3 1028.2 1053.2 1055.5 6068.1 6093.3 6095.8 6098.1 6100.3 6401.6 6523.1 6528.5 6530.2 6557.3 6083.9 6208.8 6212.8 6246.8 6259.3 3559.9 3587.6 3591.4 3592.4 3595.7 6763.7 6883.3 6901.6 6905.1 6911.9 6811.1 6811.8 6818.2 6828.7 6828.7 6833.5 6835.5 6878.9 6901.4 6903.5 6448.2 6611.8 6617.9 6639.2 6641.0 6536.3 6546.4 6547.1 6552.6 6553.0 6884.3 6897.6 6898.0 6900.6 6901.1 4389.4 4479.1 4480.1 4481.8 4490.0 6604.4 6607.1 6608.3 6616.4 6624.4 6381.1 6396.6 6419.2 6425.4 6425.9 6272.8 6340.9 6385.6 6391.7 6417.0 6295.9 6299.9 6300.4 6303.4 6311.2 6447.3 6448.6 6449.2 6450.3 6461.9 6105.8 6182.6 6296.3 6303.6 6317.5 16:03:05 INFO - 2015-11-17 16:03:05,244 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,244 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13566.41 Median:47669.67 stddev:15921.19 (33.4%) stddev-sans-first:15937.25 16:03:05 INFO - 2015-11-17 16:03:05,245 DEBUG : BROWSER_OUTPUT: Values: 857.3 865.2 879.4 879.9 895.6 13847.4 14204.5 14205.2 14212.9 14268.7 13258.7 13301.2 13337.4 13337.7 13365.4 834.2 849.8 852.4 852.4 852.7 687.5 697.4 837.2 837.7 853.2 881.0 884.4 891.7 892.4 893.4 724.7 882.8 885.8 886.2 886.4 540.6 640.4 648.5 651.3 652.7 13745.5 13974.7 13987.9 13988.2 13993.0 12587.3 13252.9 13254.3 13339.2 13365.7 10324.3 10531.3 10539.3 10590.8 10639.3 3172.0 3195.4 3228.3 3232.2 3250.8 47141.5 47636.0 47641.0 47698.3 47879.3 7532.3 7742.1 7749.4 7829.1 7965.4 11464.4 11513.2 11533.7 11558.8 11635.0 6493.9 6573.7 6676.9 6761.1 7083.8 4400.7 4488.5 4491.8 4503.9 4672.7 2780.4 2825.2 2829.3 2833.0 2834.0 451.5 456.8 457.7 458.0 458.6 529.1 646.9 650.4 661.7 680.1 8355.7 8813.0 9023.3 9051.2 9282.0 630.5 633.9 683.7 691.6 695.9 3952.5 4012.4 4145.0 4177.4 4271.6 52786.5 53635.5 53673.2 53700.0 53783.5 48957.8 51711.7 53295.0 53757.0 54357.2 48002.5 48669.5 49323.0 49621.8 49953.3 9255.5 9355.9 9535.6 9602.2 9605.3 32428.5 33187.0 34168.5 38041.6 38270.6 41282.2 41314.4 44399.3 48051.5 48828.3 8167.8 8175.7 8199.8 8200.5 8279.6 11968.4 12294.6 12535.6 12756.6 13270.3 11145.2 11721.8 11810.4 12206.6 12215.9 11038.6 11819.2 11839.9 12216.8 12244.6 7208.1 10798.7 11606.8 11802.9 12136.8 9571.3 10231.3 10236.0 10380.2 10614.5 8539.3 9499.0 9842.9 10036.8 10241.5 16:03:05 INFO - 2015-11-17 16:03:05,245 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:03:05 INFO - 2015-11-17 16:03:05,245 DEBUG : BROWSER_OUTPUT: 16:03:05 INFO - 2015-11-17 16:03:05,868 INFO : Browser exited with error code: 0 16:03:05 INFO - 2015-11-17 16:03:05,891 INFO : Completed test dromaeo_css (00:18:33) 16:03:05 INFO - 2015-11-17 16:03:05,891 INFO : Starting test kraken 16:03:05 INFO - 2015-11-17 16:03:05,891 DEBUG : operating with platform_type : linux_ 16:03:05 INFO - 2015-11-17 16:03:05,891 INFO : Initialising browser for kraken test... 16:03:05 INFO - 2015-11-17 16:03:05,897 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmPVGbc/profile http://localhost:51237/getInfo.html 16:03:09 INFO - 2015-11-17 16:03:09,521 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:03:09 INFO - 2015-11-17 16:03:09,521 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:03:09 INFO - 2015-11-17 16:03:09,521 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:03:09 INFO - 2015-11-17 16:03:09,522 DEBUG : BROWSER_OUTPUT: __metrics 16:03:09 INFO - 2015-11-17 16:03:09,618 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:03:10 INFO - 2015-11-17 16:03:10,902 INFO : Browser initialized. 16:03:10 INFO - 2015-11-17 16:03:10,903 INFO : Running cycle 1/1 for kraken test... 16:03:10 INFO - 2015-11-17 16:03:10,903 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmPVGbc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:03:22 INFO - 2015-11-17 16:03:22,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 140693504 16:03:22 INFO - 2015-11-17 16:03:22,682 DEBUG : BROWSER_OUTPUT: 16:03:25 INFO - 2015-11-17 16:03:25,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51237/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:25 INFO - 2015-11-17 16:03:25,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 179970048 16:03:25 INFO - 2015-11-17 16:03:25,733 DEBUG : BROWSER_OUTPUT: 16:03:28 INFO - 2015-11-17 16:03:28,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51237/tests/kraken/driver.html?testName=audio-dft) 16:03:28 INFO - 2015-11-17 16:03:28,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 169820160 16:03:28 INFO - 2015-11-17 16:03:28,913 DEBUG : BROWSER_OUTPUT: 16:03:31 INFO - 2015-11-17 16:03:31,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51237/tests/kraken/driver.html?testName=audio-fft) 16:03:32 INFO - 2015-11-17 16:03:32,385 DEBUG : BROWSER_OUTPUT: RSS: Main: 151519232 16:03:32 INFO - 2015-11-17 16:03:32,386 DEBUG : BROWSER_OUTPUT: 16:03:34 INFO - 2015-11-17 16:03:34,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51237/tests/kraken/driver.html?testName=audio-oscillator) 16:03:34 INFO - 2015-11-17 16:03:34,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 154980352 16:03:34 INFO - 2015-11-17 16:03:34,939 DEBUG : BROWSER_OUTPUT: 16:03:37 INFO - 2015-11-17 16:03:37,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:37 INFO - 2015-11-17 16:03:37,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 156733440 16:03:37 INFO - 2015-11-17 16:03:37,685 DEBUG : BROWSER_OUTPUT: 16:03:40 INFO - 2015-11-17 16:03:40,624 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51237/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:41 INFO - 2015-11-17 16:03:41,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 156762112 16:03:41 INFO - 2015-11-17 16:03:41,205 DEBUG : BROWSER_OUTPUT: 16:03:44 INFO - 2015-11-17 16:03:44,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51237/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:45 INFO - 2015-11-17 16:03:45,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 157704192 16:03:45 INFO - 2015-11-17 16:03:45,166 DEBUG : BROWSER_OUTPUT: 16:03:47 INFO - 2015-11-17 16:03:47,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51237/tests/kraken/driver.html?testName=json-parse-financial) 16:03:48 INFO - 2015-11-17 16:03:48,521 DEBUG : BROWSER_OUTPUT: RSS: Main: 157380608 16:03:48 INFO - 2015-11-17 16:03:48,521 DEBUG : BROWSER_OUTPUT: 16:03:50 INFO - 2015-11-17 16:03:50,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:50 INFO - 2015-11-17 16:03:50,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 166006784 16:03:50 INFO - 2015-11-17 16:03:50,630 DEBUG : BROWSER_OUTPUT: 16:03:52 INFO - 2015-11-17 16:03:52,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:53 INFO - 2015-11-17 16:03:53,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 166748160 16:03:53 INFO - 2015-11-17 16:03:53,022 DEBUG : BROWSER_OUTPUT: 16:03:55 INFO - 2015-11-17 16:03:55,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:55 INFO - 2015-11-17 16:03:55,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 172797952 16:03:55 INFO - 2015-11-17 16:03:55,648 DEBUG : BROWSER_OUTPUT: 16:03:58 INFO - 2015-11-17 16:03:58,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:58 INFO - 2015-11-17 16:03:58,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 176328704 16:03:58 INFO - 2015-11-17 16:03:58,664 DEBUG : BROWSER_OUTPUT: 16:04:01 INFO - 2015-11-17 16:04:01,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:01 INFO - 2015-11-17 16:04:01,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 173817856 16:04:01 INFO - 2015-11-17 16:04:01,779 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51237/tests/kraken/driver.html?testName=ai-astar) 16:04:03 INFO - 2015-11-17 16:04:03,698 DEBUG : BROWSER_OUTPUT: RSS: Main: 233852928 16:04:03 INFO - 2015-11-17 16:04:03,698 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;111;113;121;111;109;110;110 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;123;146;175;126;159;155;125;166;124 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;160;161;160;160;164;161;162 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;103;71;73;73;111;97;73 16:04:03 INFO - 2015-11-17 16:04:03,699 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;91;132;90;91;91;137;91;90;131 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;109;109;109;110;109 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;145;146;145;146;145;145;145;145 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;95;96;97;95;96 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;58;57;56;58;58;57;67;55;55 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;70;68;69;74;70;69;70;69 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;83;84;83;86;86;85;85;84 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;131;117;116;127;120;126;126;125;126 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;147;149;149;139;150;148;147;138 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;69;67;66;67;66;66;68;67;66 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805043696__endTimestamp 16:04:03 INFO - 2015-11-17 16:04:03,700 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.03 (3.6%) stddev-sans-first:4.27 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 111.0 113.0 121.0 111.0 109.0 110.0 110.0 16:04:03 INFO - 2015-11-17 16:04:03,702 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,703 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.70 Median:151.50 stddev:19.24 (12.7%) stddev-sans-first:20.37 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: Values: 148.0 123.0 146.0 175.0 126.0 159.0 155.0 125.0 166.0 124.0 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 160.0 161.0 160.0 160.0 164.0 161.0 162.0 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.00 Median:73.00 stddev:15.17 (20.8%) stddev-sans-first:15.55 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 103.0 71.0 73.0 73.0 111.0 97.0 73.0 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.40 Median:90.50 stddev:20.72 (22.9%) stddev-sans-first:21.40 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: Values: 90.0 91.0 132.0 90.0 91.0 91.0 137.0 91.0 90.0 131.0 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,704 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:04:03 INFO - 2015-11-17 16:04:03,705 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 16:04:03 INFO - 2015-11-17 16:04:03,705 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,705 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 16:04:03 INFO - 2015-11-17 16:04:03,705 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 16:04:03 INFO - 2015-11-17 16:04:03,705 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 97.0 95.0 96.0 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:3.41 (5.9%) stddev-sans-first:3.62 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: Values: 58.0 58.0 57.0 56.0 58.0 58.0 57.0 67.0 55.0 55.0 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:1.70 (2.4%) stddev-sans-first:1.69 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 68.0 69.0 74.0 70.0 69.0 70.0 69.0 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 16:04:03 INFO - 2015-11-17 16:04:03,706 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 83.0 84.0 83.0 86.0 86.0 85.0 85.0 84.0 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.00 Median:126.00 stddev:5.31 (4.2%) stddev-sans-first:4.99 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: Values: 116.0 131.0 117.0 116.0 127.0 120.0 126.0 126.0 125.0 126.0 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:148.00 stddev:4.90 (3.3%) stddev-sans-first:4.43 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 147.0 149.0 149.0 139.0 150.0 148.0 147.0 138.0 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.05 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: Values: 66.0 69.0 67.0 66.0 67.0 66.0 66.0 68.0 67.0 66.0 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:04:03 INFO - 2015-11-17 16:04:03,707 DEBUG : BROWSER_OUTPUT: 16:04:04 INFO - 2015-11-17 16:04:04,520 INFO : Browser exited with error code: 0 16:04:04 INFO - 2015-11-17 16:04:04,569 INFO : Completed test kraken (00:00:58) 16:04:04 INFO - 2015-11-17 16:04:04,569 INFO : Starting test v8_7 16:04:04 INFO - 2015-11-17 16:04:04,569 DEBUG : operating with platform_type : linux_ 16:04:04 INFO - 2015-11-17 16:04:04,570 INFO : Initialising browser for v8_7 test... 16:04:04 INFO - 2015-11-17 16:04:04,576 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplkiURf/profile http://localhost:51237/getInfo.html 16:04:08 INFO - 2015-11-17 16:04:08,126 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:04:08 INFO - 2015-11-17 16:04:08,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:04:08 INFO - 2015-11-17 16:04:08,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:04:08 INFO - 2015-11-17 16:04:08,127 DEBUG : BROWSER_OUTPUT: __metrics 16:04:08 INFO - 2015-11-17 16:04:08,235 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:04:09 INFO - 2015-11-17 16:04:09,446 INFO : Browser initialized. 16:04:09 INFO - 2015-11-17 16:04:09,447 INFO : Running cycle 1/1 for v8_7 test... 16:04:09 INFO - 2015-11-17 16:04:09,447 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplkiURf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:04:21 INFO - 2015-11-17 16:04:21,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 140111872 16:04:21 INFO - 2015-11-17 16:04:21,248 DEBUG : BROWSER_OUTPUT: 16:04:42 INFO - 2015-11-17 16:04:42,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51237/tests/v8_7/run.html (next: http://localhost:51237/tests/v8_7/run.html) 16:04:42 INFO - 2015-11-17 16:04:42,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 558632960 16:04:42 INFO - 2015-11-17 16:04:42,990 DEBUG : BROWSER_OUTPUT: 16:04:42 INFO - 2015-11-17 16:04:42,991 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:04:42 INFO - 2015-11-17 16:04:42,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:04:42 INFO - 2015-11-17 16:04:42,992 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:04:42 INFO - 2015-11-17 16:04:42,992 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |0;Richards;163.02575806977504 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.0359168241966 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 16:04:42 INFO - 2015-11-17 16:04:42,993 DEBUG : BROWSER_OUTPUT: |5;Earley;764.1221374045801 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: |8;Splay;615.8088235294117 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:04:42 INFO - 2015-11-17 16:04:42,994 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805082990__endTimestamp 16:04:42 INFO - 2015-11-17 16:04:42,995 DEBUG : BROWSER_OUTPUT: 16:04:42 INFO - 2015-11-17 16:04:42,995 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:04:42 INFO - 2015-11-17 16:04:42,995 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:04:42 INFO - 2015-11-17 16:04:42,995 DEBUG : BROWSER_OUTPUT: 16:04:42 INFO - 2015-11-17 16:04:42,995 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.03 Median:163.03 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,996 DEBUG : BROWSER_OUTPUT: Values: 163.0 16:04:43 INFO - 2015-11-17 16:04:42,996 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,996 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.04 Median:189.04 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,996 DEBUG : BROWSER_OUTPUT: Values: 189.0 16:04:43 INFO - 2015-11-17 16:04:42,997 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,997 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,997 DEBUG : BROWSER_OUTPUT: Values: 281.2 16:04:43 INFO - 2015-11-17 16:04:42,997 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,998 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,998 DEBUG : BROWSER_OUTPUT: Values: 5035.2 16:04:43 INFO - 2015-11-17 16:04:42,998 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,998 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,998 DEBUG : BROWSER_OUTPUT: Values: 1998.0 16:04:43 INFO - 2015-11-17 16:04:42,999 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,999 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:764.12 Median:764.12 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:42,999 DEBUG : BROWSER_OUTPUT: Values: 764.1 16:04:43 INFO - 2015-11-17 16:04:42,999 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:42,999 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: Values: 12231.7 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: Values: 25425.0 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.81 Median:615.81 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: Values: 615.8 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:43,000 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 16:04:43 INFO - 2015-11-17 16:04:43,001 DEBUG : BROWSER_OUTPUT: Values: 4850.2 16:04:43 INFO - 2015-11-17 16:04:43,001 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:04:43 INFO - 2015-11-17 16:04:43,001 DEBUG : BROWSER_OUTPUT: 16:04:43 INFO - 2015-11-17 16:04:43,816 INFO : Browser exited with error code: 0 16:04:43 INFO - 2015-11-17 16:04:43,830 INFO : Completed test v8_7 (00:00:39) 16:04:43 INFO - 2015-11-17 16:04:43,893 INFO : Completed test suite (00:20:11) 16:04:43 INFO - 2015-11-17 16:04:43,894 DEBUG : Working with test: dromaeo_css 16:04:43 INFO - 2015-11-17 16:04:43,894 DEBUG : Generating results file: dromaeo_css 16:04:43 INFO - 2015-11-17 16:04:43,895 DEBUG : Working with test: kraken 16:04:43 INFO - 2015-11-17 16:04:43,895 DEBUG : Generating results file: kraken 16:04:43 INFO - 2015-11-17 16:04:43,895 INFO : javascript benchmark 16:04:43 INFO - 2015-11-17 16:04:43,895 DEBUG : Working with test: v8_7 16:04:43 INFO - 2015-11-17 16:04:43,895 DEBUG : Generating results file: v8_7 16:04:43 INFO - 2015-11-17 16:04:43,896 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:04:43 INFO - 2015-11-17 16:04:43,950 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 16:04:43 INFO - 2015-11-17 16:04:43,950 DEBUG : process_Request line: dromaeo_css 6991.32 graph.html#tests=[[72,63,35]] 16:04:43 INFO - 2015-11-17 16:04:43,950 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:04:43 INFO - 2015-11-17 16:04:43,980 DEBUG : process_Request line: kraken 1501.60 graph.html#tests=[[232,63,35]] 16:04:43 INFO - 2015-11-17 16:04:43,981 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:04:44 INFO - 2015-11-17 16:04:44,010 DEBUG : process_Request line: v8_7 19962.18 graph.html#tests=[[230,63,35]] 16:04:44 INFO - 2015-11-17 16:04:44,011 INFO : javascript benchmark 16:04:44 INFO - 2015-11-17 16:04:44,015 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3167.9524807127896, 3244.7404207663403, 3275.1648329675927, 3280.360329735701, 3289.2599165187835, 5153.407358153813, 5291.3385826771655, 5317.46825317468, 5338.839834804957, 5393.757280922358, 5288.338957630296, 5321.787128514855, 5373.059714549958, 5373.704446255454, 5436.809711660093, 4878.243872199815, 4914.582260507861, 4994.0, 5048.747562621873, 5070.822521211759, 4986.900261994758, 5008.649394542384, 5084.720340381277, 5091.032703786287, 5134.409542902558, 4803.951960480403, 4921.80312787488, 4922.704637721748, 4995.425526064477, 5001.974595207974, 4970.900581988376, 4980.0, 4989.201727723546, 4990.925136122961, 5028.974855125737, 4938.456769755324, 4966.975165124188, 4971.055499455092, 4978.054169707781, 5014.924776128361, 5126.333576635014, 5224.0, 5246.317978662788, 5260.789568417297, 5353.544948679367, 5814.040683287252, 5817.709114544298, 5818.8254352369495, 5828.0966450200285, 5841.240638716982, 5680.005998950167, 5864.5894787364905, 5867.794627188071, 5882.529397648221, 5893.675847828367, 5422.40353561108, 5426.294581704393, 5520.337559492887, 5531.640443371168, 5537.944620553823, 5792.768289268466, 5818.0, 5821.039528477754, 5853.1220316952795, 5876.265466816648, 5655.462731040545, 5657.971710141423, 5660.575456840671, 5666.97166514173, 5673.290838645169, 5623.6906970116215, 5743.2246646703, 5756.827295181068, 5881.617694849821, 5897.085951677497, 5783.624064435799, 5783.971080144656, 5784.334801497882, 5789.94210057894, 5811.593188476766, 5777.884442311214, 5779.450952159538, 5784.797532086357, 5794.101914203306, 5794.942050579524, 4361.542038085955, 4389.31965545341, 4474.507804141542, 4497.437820272466, 4500.459944806644, 4015.13674559971, 4026.778527181033, 4030.717849750489, 4035.899102522402, 4072.552019277877, 5482.616216864782, 5484.424135465799, 5496.065668836308, 5499.532539734168, 5508.614396992252, 5763.0, 5808.128780682931, 5906.379830117861, 5911.0, 5922.822315330461, 5520.06158952979, 5528.087865502228, 5537.695426751487, 5542.501174894279, 5547.029269877755, 5033.295338652591, 5035.370578677665, 5038.773255203525, 5069.898602027939, 5077.238414237894, 5824.475797178275, 5876.294844618673, 5894.616849904743, 5935.109733540004, 5943.851403714855, 5839.270091238595, 5861.267341582302, 5863.765449381977, 5875.089361149029, 5878.529717622494, 5925.05199168131, 5934.584579079423, 5937.9406205937385, 5940.673262970578, 6008.609440386361, 5543.501084902378, 5614.719264036864, 5635.520980716685, 5700.3444603871085, 5760.884782304247, 5770.3652598215, 5782.479576838105, 5795.971020144872, 5796.188533605215, 5803.216565763568, 5416.9729151353995, 5663.150527420919, 5685.687287199078, 5687.744051517609, 5701.714914254354, 5515.145152501369, 5561.972190139023, 5683.204351390726, 5832.533397328289, 5854.765809367577, 5550.8057217997175, 5551.7779288828, 5564.749586268708, 5572.944270557243, 5589.888202236014, 5615.971920140373, 5620.634658747168, 5639.54883609302, 5661.547076233809, 5661.858453538694, 5454.699991500347, 5569.860753481195, 5611.551075913999, 5614.719264036864, 5625.437456254342], "unit": "ms", "name": "dojo.html", "value": 5350.098257012882}, {"lowerIsBetter": false, "replicates": [569.1349149293075, 590.7843637072468, 607.7994261893575, 617.5337620096826, 629.2669040567739, 32537.0, 33171.17072073199, 33233.5014974775, 33237.005779653235, 33240.33519329618, 33338.33323333532, 41912.58087419125, 42626.0, 42686.35970460445, 42780.57219427805, 8787.12128787121, 8946.284297256236, 8946.702728104421, 8947.597358118901, 8949.194572488475, 7748.070231572219, 7815.765527034198, 8709.129087091304, 8859.069797671249, 8866.512341821197, 10632.362058276529, 10818.08046316064, 10821.080208182313, 10833.133349332034, 10876.075533579655, 10412.739681507946, 10526.42104684242, 10531.104856087242, 10535.789284214312, 10545.367277963347, 7896.289333959914, 8078.838423231561, 10317.84523232152, 10601.151907847354, 10880.619178328721, 40786.79606601978, 41151.58848411508, 41334.379984300256, 41419.585804141876, 41441.79279103585, 3438.9656103438897, 3466.687998080185, 3517.4547945068557, 3759.3797023491093, 3773.3773927301963, 30740.846295768377, 30953.53569696456, 31014.224644383845, 31164.53253201204, 31637.367252655047, 3678.319510890467, 3682.815859207029, 3684.0, 3744.6936023572835, 3794.753341032824, 274148.0, 277611.0, 277778.0, 278215.0, 278740.6062969692, 60318.0, 60554.0, 60618.09072863911, 60663.39336606666, 60746.0, 64259.67870160619, 64363.0, 64423.35576644174, 64431.8454523637, 64491.0, 16328.34686612546, 16387.508374748777, 16390.508284751475, 16570.58573535671, 16616.66766664684, 11681.474333655005, 11699.23954942943, 11710.063194944383, 11767.0, 11780.17538772295, 18817.90591047036, 20131.39605811828, 20137.39587812368, 20145.294914677917, 20154.69767953482, 7664.923350766532, 7724.497907635986, 7781.299683028441, 7861.095973962953, 7898.565578893101, 931.5249222896372, 937.6765016069445, 986.5511192407438, 1049.506731836036, 1065.1159537583787, 28322.71677283242, 28468.715312846605, 28610.14169574916, 28741.56887646687, 28769.424611507653, 861.2421069458836, 1004.2719028704277, 1015.2436434855932, 1045.3884477580548, 1196.186593116689, 13765.38055787492, 13869.0, 13925.303734813218, 14200.715985680436, 14276.072055316372, 319765.0, 326659.0, 328090.0, 432564.0, 446977.0, 49883.75058124686, 51584.0, 51595.0, 51601.0, 52236.47763522392, 1332.0342751505275, 1339.145283781969, 1340.249460302234, 1346.5421756602607, 1365.0512893539094, 25503.36241593901, 26161.0, 29916.0, 30704.232394189432, 30856.53715194229, 48401.757991209815, 48821.0, 48845.0, 48847.755761220964, 48858.0, 269338.0, 273970.0, 274616.0, 274880.0, 274899.0, 30502.237444063187, 30867.845660771553, 31014.68985310118, 31041.689583104784, 31108.22229444282, 42748.358774619024, 42903.14193716171, 43383.56616433795, 43478.347824782024, 43822.56177438185, 35543.82228088843, 36696.26607467889, 36820.44769328516, 36957.445638315985, 37136.07159821026, 35288.29423411466, 35679.28641427105, 36198.27603447969, 36590.451143233404, 36703.632963670025, 36155.0, 36170.0, 36706.81646591857, 36804.81597591995, 36823.0, 28093.173943693593, 30438.695613043586, 32018.51972220372, 33679.83160084184, 33693.0, 24658.753412465645, 24974.750252497244, 25018.98481215057, 25042.248732538053, 25321.620175697746], "unit": "ms", "name": "ext.html", "value": 18802.43596569389}, {"lowerIsBetter": false, "replicates": [325.2178510681811, 331.4034737472549, 354.82790846439474, 358.64673296802647, 358.73274410564125, 15836.208189590518, 16706.498805035837, 16718.83281167188, 17056.744148837748, 17065.80539362245, 15609.219539023032, 15897.84102158978, 15981.200939953014, 16043.759343609856, 16121.516354509355, 4698.2482802751565, 5369.62412631116, 5390.56875449965, 5394.676319420828, 5397.62216644835, 5186.636935414523, 5363.249145119687, 5383.111786555213, 5398.649087809299, 5401.405845357008, 3965.6430921217084, 4153.54311025787, 5307.946920530803, 5317.255584218213, 5337.279467271907, 5820.476157145856, 5969.373215812364, 6013.1581578579035, 6013.939860601382, 6019.578629495959, 5171.5087066728975, 5224.8693782655355, 5246.029484545371, 5246.7901283948595, 5254.7635356409055, 16355.754663680054, 18023.549411264692, 19878.0, 20574.485637859023, 21148.5770284595, 2093.3824521766114, 2115.7989990950837, 2117.2695420080204, 2141.0, 2281.281396360141, 12898.613041608673, 12992.895603873681, 13009.479620815157, 13053.412596433183, 13151.408186631625, 1771.7165253559497, 1799.3252530301138, 1810.3663717698832, 1851.5186051626674, 1860.2744929477515, 60056.69971650158, 60706.0, 60774.088388674645, 61308.69345653243, 62038.37961620371, 9446.055394460636, 9702.90297097034, 9992.40045597252, 10005.649802256887, 10067.0, 12848.550300739429, 12925.676858078436, 12930.418131184118, 12949.54676586315, 12950.870491295154, 7448.925510744823, 7532.887006694904, 7602.0, 7630.542167469969, 7642.923570764332, 7332.706691732271, 7360.815979600553, 7385.4460915431555, 7414.518056326321, 7418.072740907387, 5920.615160014585, 6029.095635654687, 6042.758289668452, 6047.304559975659, 6083.178770865965, 1707.7865266841645, 1767.7878654561534, 1771.5393997560727, 1772.2822256985942, 1783.3669047488215, 920.4247345409119, 946.6071580294239, 994.4083270454068, 1025.6871654145557, 1070.82866741321, 14823.0, 17501.562460938323, 17507.387241446744, 17591.208395622227, 18031.0, 935.2985261054209, 962.7063745557532, 963.5182408795603, 975.6585195181772, 980.4509474694194, 10018.0, 10266.076053155251, 10333.689989300334, 10340.689779306633, 10350.792984140275, 365623.0, 368415.0, 551568.0, 570991.0, 578361.1638836083, 36830.63169368326, 36884.446733299024, 36952.63047369492, 51835.96328073418, 61996.690016549626, 1137.7212582917239, 1139.4701463819363, 1142.7543078238218, 1157.3171828620987, 1159.1885680024018, 15847.762283565526, 15858.682826343178, 16144.515664530083, 16237.119782924032, 16324.67350653004, 34189.31621367609, 34195.65804342024, 35093.64906350904, 35105.0, 35842.64157358497, 46629.30056049094, 46837.29744053774, 46986.530134699584, 47120.29319560278, 47151.52848471609, 9389.342746007715, 9521.0, 9672.0, 9695.563699633392, 9704.0, 17858.642827143645, 17882.55293617618, 18286.817131829044, 18355.246712992623, 18412.63174736471, 14751.0, 14884.62788430298, 15198.544043678707, 15268.923655381652, 15277.923610382322, 14433.855661443671, 14519.0, 14594.409447646482, 14755.409783608964, 15012.549623511311, 15174.393024278905, 15478.5356439307, 15655.452059177875, 15753.369865205721, 15868.76196857025, 9437.433753974783, 9437.952810235905, 9621.27840411958, 9623.326367154232, 9634.518274086407, 10214.948925255327, 10702.678919632424, 10778.73053173677, 10943.45282735876, 15365.692686146438], "unit": "ms", "name": "jquery.html", "value": 8861.701624325982}, {"lowerIsBetter": false, "replicates": [1611.6212690017837, 1722.4918648998544, 1771.1498480729254, 1784.3754685859951, 1809.3215044358374, 6795.524313298065, 7549.773506794798, 7770.3783697304225, 7782.533048017123, 7814.570198639072, 7683.6158192090315, 7705.614719264043, 7729.304362607364, 7731.613419329039, 7749.53502789833, 2003.3489116037347, 2055.07521615273, 2315.270689732733, 2337.3922780077132, 2341.321016905104, 2283.600369935263, 2335.054303007285, 2335.4628435459854, 2335.9371485973843, 2336.8481048731865, 2263.094762095167, 2303.0442366417915, 2303.67748515208, 2307.3885420363617, 2309.1340747219792, 1981.3164458261876, 2056.167252262836, 2214.9889250553806, 2256.751757306695, 2300.1949317738827, 2200.658897870833, 2210.767869373709, 2216.645336746129, 2218.866867987926, 2219.933401997943, 7740.729074482422, 7768.456208065438, 7806.0, 7815.570143642098, 7819.6481158348015, 4799.112164249625, 4908.950910490885, 4910.459849416561, 4911.607071434277, 4916.237983112587, 2925.9853700731574, 2988.8804447822063, 3013.352129292213, 3028.0764366868098, 3038.6809385014476, 961.9615215391376, 969.60730903984, 982.2829334585792, 1003.1573478278282, 1003.6136087606324, 10800.5679772809, 10982.945085274523, 10991.340519568852, 11008.834867476995, 11013.889861101447, 4336.82652693895, 4405.0969551241915, 4466.821327146943, 4467.061916997467, 4506.864794056183, 9381.577828997575, 9425.952870235742, 9510.239180865514, 9534.618615255313, 9562.665306714232, 4773.832915847928, 4785.210440277385, 4857.854264372075, 4872.902541949141, 4899.5590396863745, 4368.5194628590825, 4405.427294451765, 4408.713433626868, 4434.312681534368, 4438.7114837535455, 3599.7480176387926, 3640.5995340512522, 3643.85424583019, 3664.835082421244, 3691.9815400922826, 1170.1750266062406, 1177.3406892140429, 1192.6605504587121, 1196.6051203102954, 1210.328267811373, 1235.975280494385, 1258.2702032820941, 1267.0687045021903, 1362.7615167345675, 1362.8364596248316, 6698.497612679069, 6856.897146542806, 7379.188289288174, 7559.773206803805, 7566.31903128721, 639.8688268904864, 643.7392855893371, 657.0538424668462, 712.4300559552337, 722.9638518074075, 5738.5982981191755, 5768.9711551442815, 5796.594238403356, 5808.651480911159, 5815.41845815415, 8981.865272020925, 9034.0, 9121.17909388145, 9329.580168892417, 9334.953325233331, 9116.088391160964, 9121.179093881583, 9170.95414522923, 9177.265818734486, 9212.585433655502, 7248.96375518119, 7339.522931009574, 7401.370883474858, 7434.219406962191, 7434.925650743531, 6952.0267162596265, 7016.403605693573, 7049.048378468841, 7054.365107140382, 7060.964695176492, 8160.755177344689, 8352.498850069016, 8490.108538603357, 8494.405391622528, 8509.106543813057, 8526.957365213135, 8601.65593376283, 8634.438761480484, 8771.210591046836, 8779.868301975348, 6699.598024118569, 6855.383015528427, 6892.379685828299, 6902.171739391305, 6903.309669033258, 7313.085864266966, 7352.4485663576515, 7360.668769905475, 7368.815779605553, 7373.078365204349, 6829.590224586541, 7037.964810175917, 7076.32774886385, 7117.537360071578, 7235.384992275715, 6872.072270243453, 6895.620740859301, 6965.686544105426, 6996.6151861648095, 7025.192102908231, 6032.939670603413, 6191.514036631086, 6729.865402692017, 6735.562188457735, 6969.895451568129, 6168.475679567107, 6290.937090629035, 6307.716152773228, 6337.36626337381, 6343.492520598434, 6512.6743662815725, 6537.444317232898, 6541.70562324687, 6551.312112228147, 6568.211814582281], "unit": "ms", "name": "mootools.html", "value": 4445.652364487647}, {"lowerIsBetter": false, "replicates": [319.06354848519595, 322.78373489761856, 328.3433133732534, 337.0696876620528, 337.8108259374749, 5799.652020878751, 5962.433568810961, 5964.314103878055, 6024.397560243973, 6064.969675151629, 5800.245968024162, 5877.265341832271, 5925.259342582177, 5943.702814859251, 5964.194833697449, 4587.655925805561, 4592.609628181609, 4593.494715581283, 4597.287420449836, 4600.42494688164, 4409.977950110245, 4493.41585593874, 4516.638668906479, 4591.65562582806, 4603.355530225755, 4520.3219517072375, 4528.954710452903, 4531.116432295687, 4541.341505481703, 4553.749543775091, 4541.159885421208, 4545.659075569312, 4546.772661366918, 4557.908841823161, 4559.0, 3959.8812035638975, 3960.4455376247347, 3969.960300396988, 3971.4241434992055, 3983.5618082010956, 5552.472515111099, 5573.303337082864, 5639.915401268984, 5645.661260324394, 5652.604317697763, 5244.580433565306, 5247.947520524784, 5252.684838909678, 5257.263983042377, 5269.2886460327745, 6290.119383286344, 6293.213348331458, 6295.905561416583, 6296.338884417116, 6298.779542715983, 4384.956150438518, 4388.42950416447, 4391.560843915615, 4402.84590039347, 4410.1179764047, 6403.327650596667, 6562.868742625168, 6588.077669126326, 6602.636854972975, 6609.900851487231, 4408.647308215335, 4424.80088396023, 4433.8226470941445, 4437.023854751949, 4441.0, 4496.437945256843, 4498.347739577743, 4500.234960056799, 4501.527339629357, 4501.932471012938, 5236.528712415825, 5238.554722848525, 5240.0, 5242.633015688865, 5250.789968401221, 6249.96875015622, 6407.679616019181, 6416.037594360883, 6417.197850268716, 6422.133012043314, 1580.8023997000375, 1592.0925072708444, 1593.8326475719882, 1594.186964648038, 1594.9122798245976, 996.8903420623726, 1026.2610920137488, 1028.2442404832443, 1053.1943063556384, 1055.4933631856597, 6068.120122582201, 6093.329733729286, 6095.7866474674065, 6098.14625952367, 6100.298465676416, 6401.615903045739, 6523.086767852505, 6528.477721782246, 6530.183727034121, 6557.278699343068, 6083.904897118561, 6208.81373558794, 6212.751489940351, 6246.843828904223, 6259.280182779039, 3559.893203203908, 3587.6412358764437, 3591.3535563598803, 3592.3713350163616, 3595.676389124991, 6763.72945082201, 6883.3116688330765, 6901.62041087735, 6905.102336696197, 6911.861762764716, 6811.148606424197, 6811.761588344384, 6818.249992500821, 6828.658567071627, 6828.658567071726, 6833.487488438288, 6835.487338449636, 6878.931210687829, 6901.447884169254, 6903.482238832108, 6448.161738973903, 6611.768588099393, 6617.933820661732, 6639.2364878037715, 6641.0, 6536.3136870627895, 6546.378094081055, 6547.083408322934, 6552.641049222181, 6553.04980777775, 6884.311568843276, 6897.55165914214, 6898.0, 6900.551464154814, 6901.137357830271, 4389.40742999691, 4479.104179164246, 4480.14877173336, 4481.775911204492, 4490.034642551867, 6604.438622716931, 6607.108040414482, 6608.339166083353, 6616.437602803816, 6624.436922861611, 6381.106645069787, 6396.584222025554, 6419.165508483868, 6425.4217120457515, 6425.935740642721, 6272.811815645356, 6340.904886426615, 6385.648789316632, 6391.744330226739, 6416.967915160394, 6295.905561416491, 6299.874002520016, 6300.401461861299, 6303.36966303366, 6311.211098612674, 6447.290798012121, 6448.645324507197, 6449.226092868886, 6450.322716114741, 6461.870762584816, 6105.8168254952425, 6182.567220294536, 6296.307406185224, 6303.558750887394, 6317.4630156437215], "unit": "ms", "name": "prototype.html", "value": 4784.836736764267}, {"lowerIsBetter": false, "replicates": [857.3227150551065, 865.1737590600977, 879.4327658660164, 879.9208071273586, 895.6193617712474, 13847.446102155915, 14204.50284240053, 14205.218712970782, 14212.928935355309, 14268.714625707506, 13258.734825303489, 13301.201927884309, 13337.399817008234, 13337.733245335088, 13365.398557064931, 834.2450082675189, 849.8215374771305, 852.3649880838752, 852.40757673417, 852.7186028610574, 687.5221720903974, 697.4072038767058, 837.1753822484848, 837.6900546797693, 853.2448782827212, 881.0220655072864, 884.3897710579712, 891.7101941868887, 892.4288455388556, 893.3612467086032, 724.7028718225555, 882.8278485695292, 885.7874110213567, 886.162576365335, 886.4193952960788, 540.6296686769575, 640.4172203294979, 648.5395369287811, 651.3226244705501, 652.6540933305308, 13745.450181992708, 13974.720505589832, 13987.860121398757, 13988.230647314496, 13993.0, 12587.307698076602, 13252.933735331359, 13254.343207099113, 13339.19964802115, 13365.66585835352, 10324.277300588961, 10531.26281160319, 10539.314944528582, 10590.841137382946, 10639.308444951132, 3171.9682803172136, 3195.408849362852, 3228.338190670907, 3232.159638493985, 3250.756193285513, 47141.528584714055, 47636.0, 47641.04717905657, 47698.28452573214, 47879.28181077287, 7532.322091011835, 7742.14836367999, 7749.418793590503, 7829.138794732575, 7965.362770978308, 11464.426778661034, 11513.194076414571, 11533.711657208469, 11558.826617600742, 11634.952854243158, 6493.935060649427, 6573.671316434159, 6676.899846502306, 6761.121054262914, 7083.7520686775715, 4400.69195156336, 4488.483824360175, 4491.820327186876, 4503.932441013388, 4672.696274742131, 2780.4439112177647, 2825.166575860126, 2829.2643912582876, 2833.0367674990603, 2834.0364276145797, 451.51687694166924, 456.80129143822546, 457.7185031205851, 458.0, 458.58956234170233, 529.1190168369621, 646.9353064693587, 650.3723906430317, 661.6658587413325, 680.0683064202075, 8355.749327520183, 8813.0, 9023.323250756219, 9051.185393314501, 9282.0, 630.4704048599107, 633.9413179989428, 683.7401787320787, 691.6230654293422, 695.8782213112786, 3952.505936757905, 4012.35802271641, 4145.0, 4177.352510360899, 4271.615554600101, 52786.47213527892, 53635.46364536383, 53673.1949020765, 53700.0, 53783.46216537863, 48957.75521122372, 51711.74144129255, 53295.0, 53757.0, 54357.1846422304, 48002.5199748005, 48669.5133048665, 49323.0, 49621.75189124031, 49953.25070123951, 9255.537223138681, 9355.906440935503, 9535.570899309687, 9602.231821454407, 9605.327627066039, 32428.513572295964, 33187.0, 34168.48747268843, 38041.61958380381, 38270.617293826705, 41282.1743565133, 41314.380284295155, 44399.334009990525, 48051.5194848047, 48828.26757598568, 8167.79580510492, 8175.7138500152205, 8199.836003280021, 8200.507969521848, 8279.62741676614, 11968.401579920795, 12294.631161065183, 12535.623931282076, 12756.61730148097, 13270.27013514266, 11145.2198346115, 11721.824172637247, 11810.350430726392, 12206.633800985985, 12215.938920305342, 11038.613648522263, 11819.172657913863, 11839.940800296288, 12216.75566488683, 12244.571439999914, 7208.125887269242, 10798.67603971882, 11606.825897611712, 11802.94098529502, 12136.75726485483, 9571.33000689945, 10231.334963227366, 10236.0, 10380.169586433218, 10614.469276536296, 8539.274161696077, 9499.0, 9842.852357214791, 10036.849447258443, 10241.487925603838], "unit": "ms", "name": "yui.html", "value": 6157.7447449070905}], "name": "dromaeo_css", "value": 6991.324720472879}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 111.0, 113.0, 121.0, 111.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [148.0, 123.0, 146.0, 175.0, 126.0, 159.0, 155.0, 125.0, 166.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 160.0, 161.0, 160.0, 160.0, 164.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 103.0, 71.0, 73.0, 73.0, 111.0, 97.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [90.0, 91.0, 132.0, 90.0, 91.0, 91.0, 137.0, 91.0, 90.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 103.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 57.0, 56.0, 58.0, 58.0, 57.0, 67.0, 55.0, 55.0], "unit": "ms", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 68.0, 69.0, 74.0, 70.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 83.0, 84.0, 83.0, 86.0, 86.0, 85.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [116.0, 131.0, 117.0, 116.0, 127.0, 120.0, 126.0, 126.0, 125.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.0}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 147.0, 149.0, 149.0, 139.0, 150.0, 148.0, 147.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1501.5999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.02575806977504], "unit": "score", "name": "Richards", "value": 216.5424679999999}, {"lowerIsBetter": false, "replicates": [189.0359168241966], "unit": "score", "name": "DeltaBlue", "value": 349.7642200000001}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [764.1221374045801], "unit": "score", "name": "Earley", "value": 872.1943356643354}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [615.8088235294117], "unit": "score", "name": "Splay", "value": 132.33165373134324}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19962.18311449639}]} 16:04:44 INFO - RETURN: dromaeo_css: 6991.32 16:04:44 INFO - RETURN: kraken: 1501.60 16:04:44 INFO - RETURN: v8_7: 19962.18 16:04:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "19962.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1501.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6991.32"}}} 16:04:44 INFO - Return code: 0 16:04:44 INFO - # TBPL SUCCESS # 16:04:44 INFO - Running post-action listener: _resource_record_post_action 16:04:44 INFO - Running post-run listener: _resource_record_post_run 16:04:45 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 8192; Write bytes: 496156672; Read time: 24; Write time: 473812 16:04:45 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 164184064; Read time: 0; Write time: 209652 16:04:45 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 331972608; Read time: 24; Write time: 264160 16:04:45 INFO - Running post-run listener: _upload_blobber_files 16:04:45 INFO - Blob upload gear active. 16:04:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:04:45 INFO - Copying logs to upload dir... 16:04:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.791704 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-11-17 16:04:43.972790) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 16:04:43.976513) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009850 build_url: 'https://queue.taskcluster.net/v1/task/DOkrBgfjRuGqS9shzxC_1w/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-17 16:04:44.027183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:04:44.027558) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1447803570.326003-367212266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:04:44.077188) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:04:44.077508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:04:44.077812) ========= ========= Total master_lag: 0.22 =========