builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1447887095.91 results: success (0) buildid: 20151118133104 builduid: 10cb8191a16a4e988a66fdb7719d1890 revision: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.909316) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.909806) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.910159) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006486 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.933030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.933387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.952526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.952964) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.001817) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.002107) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.002454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.002811) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 14:51: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-11-18 14:51:36 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100106 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.116120) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.116449) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022324 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.166171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.166535) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 --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 a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 --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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 14:51:36,350 truncating revision to first 12 chars 2015-11-18 14:51:36,350 Setting DEBUG logging. 2015-11-18 14:51:36,350 attempt 1/10 2015-11-18 14:51:36,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a2ccdf48529b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 14:51:36,599 unpacking tar archive at: mozilla-inbound-a2ccdf48529b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.541989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.722313) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.722630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.731636) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.731946) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.732385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-18 14:51:36.732683) ========= /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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:51:36 INFO - MultiFileLogger online at 20151118 14:51:36 in /builds/slave/test-pgo 14:51:36 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 14:51:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:51:37 INFO - {'append_to_log': False, 14:51:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:51:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:51:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:51:37 INFO - 'branch': 'Mozilla-Inbound', 14:51:37 INFO - 'buildbot_json_path': 'buildprops.json', 14:51:37 INFO - 'config_files': ('talos/linux_config.py',), 14:51:37 INFO - 'default_actions': ('clobber', 14:51:37 INFO - 'read-buildbot-config', 14:51:37 INFO - 'download-and-extract', 14:51:37 INFO - 'populate-webroot', 14:51:37 INFO - 'create-virtualenv', 14:51:37 INFO - 'install', 14:51:37 INFO - 'run-tests'), 14:51:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:51:37 INFO - 'download_minidump_stackwalk': True, 14:51:37 INFO - 'download_symbols': 'ondemand', 14:51:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:51:37 INFO - 'tooltool.py': '/tools/tooltool.py', 14:51:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:51:37 INFO - '/tools/misc-python/virtualenv.py')}, 14:51:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:51:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:51:37 INFO - 'installer_path': 'installer.exe', 14:51:37 INFO - 'log_level': 'info', 14:51:37 INFO - 'log_name': 'talos', 14:51:37 INFO - 'log_to_console': True, 14:51:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:51:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:51:37 INFO - 'opt_config_files': (), 14:51:37 INFO - 'pip_index': False, 14:51:37 INFO - 'sps_profile': False, 14:51:37 INFO - 'sps_profile_interval': 0, 14:51:37 INFO - 'suite': 'dromaeojs', 14:51:37 INFO - 'system_bits': '64', 14:51:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:51:37 INFO - 'title': 'talos-linux64-ix-031', 14:51:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:51:37 INFO - 'use_talos_json': True, 14:51:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:51:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:51:37 INFO - 'work_dir': 'build'} 14:51:37 INFO - ##### 14:51:37 INFO - ##### Running clobber step. 14:51:37 INFO - ##### 14:51:37 INFO - Running pre-action listener: _resource_record_pre_action 14:51:37 INFO - Running main action method: clobber 14:51:37 INFO - rmtree: /builds/slave/test-pgo/build 14:51:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:51:37 INFO - Running post-action listener: _resource_record_post_action 14:51:37 INFO - ##### 14:51:37 INFO - ##### Running read-buildbot-config step. 14:51:37 INFO - ##### 14:51:37 INFO - Running pre-action listener: _resource_record_pre_action 14:51:37 INFO - Running main action method: read_buildbot_config 14:51:37 INFO - Using buildbot properties: 14:51:37 INFO - { 14:51:37 INFO - "properties": { 14:51:37 INFO - "buildnumber": 1278, 14:51:37 INFO - "product": "firefox", 14:51:37 INFO - "script_repo_revision": "production", 14:51:37 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 14:51:37 INFO - "repository": "", 14:51:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 14:51:37 INFO - "buildid": "20151118133104", 14:51:37 INFO - "slavename": "talos-linux64-ix-031", 14:51:37 INFO - "pgo_build": "True", 14:51:37 INFO - "basedir": "/builds/slave/test-pgo", 14:51:37 INFO - "project": "", 14:51:37 INFO - "platform": "ubuntu64_hw", 14:51:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:51:37 INFO - "slavebuilddir": "test", 14:51:37 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 14:51:37 INFO - "branch": "mozilla-inbound", 14:51:37 INFO - "repo_path": "integration/mozilla-inbound", 14:51:37 INFO - "stage_platform": "linux64-pgo", 14:51:37 INFO - "builduid": "10cb8191a16a4e988a66fdb7719d1890", 14:51:37 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:37 INFO - }, 14:51:37 INFO - "sourcestamp": { 14:51:37 INFO - "repository": "", 14:51:37 INFO - "hasPatch": false, 14:51:37 INFO - "project": "", 14:51:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 14:51:37 INFO - "changes": [ 14:51:37 INFO - { 14:51:37 INFO - "category": null, 14:51:37 INFO - "files": [ 14:51:37 INFO - { 14:51:37 INFO - "url": null, 14:51:37 INFO - "name": "https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:51:37 INFO - } 14:51:37 INFO - ], 14:51:37 INFO - "repository": "", 14:51:37 INFO - "rev": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0", 14:51:37 INFO - "who": "sendchange", 14:51:37 INFO - "when": 1447887055, 14:51:37 INFO - "number": 6679155, 14:51:37 INFO - "comments": "", 14:51:37 INFO - "project": "", 14:51:37 INFO - "at": "Wed 18 Nov 2015 14:50:55", 14:51:37 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 14:51:37 INFO - "revlink": "", 14:51:37 INFO - "properties": [ 14:51:37 INFO - [ 14:51:37 INFO - "buildid", 14:51:37 INFO - "20151118133104", 14:51:37 INFO - "Change" 14:51:37 INFO - ], 14:51:37 INFO - [ 14:51:37 INFO - "builduid", 14:51:37 INFO - "10cb8191a16a4e988a66fdb7719d1890", 14:51:37 INFO - "Change" 14:51:37 INFO - ], 14:51:37 INFO - [ 14:51:37 INFO - "pgo_build", 14:51:37 INFO - "True", 14:51:37 INFO - "Change" 14:51:37 INFO - ] 14:51:37 INFO - ], 14:51:37 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:37 INFO - } 14:51:37 INFO - ], 14:51:37 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:37 INFO - } 14:51:37 INFO - } 14:51:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:51:37 INFO - Running post-action listener: _resource_record_post_action 14:51:37 INFO - ##### 14:51:37 INFO - ##### Running download-and-extract step. 14:51:37 INFO - ##### 14:51:37 INFO - Running pre-action listener: _resource_record_pre_action 14:51:37 INFO - Running main action method: download_and_extract 14:51:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:37 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json 14:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json 14:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:51:42 INFO - Downloaded 1302 bytes. 14:51:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:51:42 INFO - Using the following test package requirements: 14:51:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:51:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'jsshell-linux-x86_64.zip'], 14:51:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:51:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:51:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:51:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:51:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:51:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:42 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:45 INFO - Downloaded 22506947 bytes. 14:51:45 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 14:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:45 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 14:51:46 INFO - Return code: 0 14:51:46 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 14:51:46 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')]} 14:51:46 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:51:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:48 INFO - Downloaded 22506947 bytes. 14:51:48 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 14:51:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:48 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 14:51:50 INFO - Return code: 0 14:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:50 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:51 INFO - Downloaded 11130997 bytes. 14:51:51 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 14:51:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:51 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 14:51:51 INFO - Return code: 0 14:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:51 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/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 14:51:52 INFO - Downloaded 57319325 bytes. 14:51:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:52 INFO - mkdir: /builds/slave/test-pgo/properties 14:51:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:51:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:51:52 INFO - Contents: 14:51:52 INFO - build_url:https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:52 INFO - Running post-action listener: _resource_record_post_action 14:51:52 INFO - Running post-action listener: set_extra_try_arguments 14:51:52 INFO - ##### 14:51:52 INFO - ##### Running populate-webroot step. 14:51:52 INFO - ##### 14:51:52 INFO - Running pre-action listener: _resource_record_pre_action 14:51:52 INFO - Running main action method: populate_webroot 14:51:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:51:52 INFO - '../fennec_ids.txt'], 14:51:52 INFO - 'tests': ['tcheck2']}, 14:51:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:52 INFO - '--tppagecycles', 14:51:52 INFO - '7'], 14:51:52 INFO - 'tests': ['tsvgm']}}, 14:51:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:51:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:51:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:51:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'tests': ['damp', 'tps']}, 14:51:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['damp', 'tps']}, 14:51:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:51:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:52 INFO - 'other': {'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'other_l64': {'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'other_nol64': {'tests': ['a11yr', 14:51:52 INFO - 'ts_paint', 14:51:52 INFO - 'tpaint', 14:51:52 INFO - 'sessionrestore', 14:51:52 INFO - 'sessionrestore_no_auto_restore']}, 14:51:52 INFO - 'svgr': {'tests': ['tsvgx', 14:51:52 INFO - 'tsvgr_opacity', 14:51:52 INFO - 'tart', 14:51:52 INFO - 'tscrollx', 14:51:52 INFO - 'cart']}, 14:51:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['tsvgx', 14:51:52 INFO - 'tsvgr_opacity', 14:51:52 INFO - 'tart', 14:51:52 INFO - 'tscrollx', 14:51:52 INFO - 'cart']}, 14:51:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'tests': ['tp5o']}, 14:51:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'talos_options': ['--e10s'], 14:51:52 INFO - 'tests': ['tp5o']}, 14:51:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'talos_options': ['--xperf_path', 14:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:52 INFO - 'tests': ['tp5n']}, 14:51:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:52 INFO - 'talos_options': ['--e10s', 14:51:52 INFO - '--xperf_path', 14:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:52 INFO - 'tests': ['tp5n']}}, 14:51:52 INFO - 'talos.zip': {'path': '', 14:51:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:52 INFO - Running post-action listener: _resource_record_post_action 14:51:52 INFO - ##### 14:51:52 INFO - ##### Running create-virtualenv step. 14:51:52 INFO - ##### 14:51:52 INFO - Running pre-action listener: _resource_record_pre_action 14:51:52 INFO - Running main action method: create_virtualenv 14:51:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:51:52 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 14:51:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:51:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:52 INFO - Using real prefix '/usr' 14:51:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:55 INFO - Installing pip.................done. 14:51:55 INFO - Return code: 0 14:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:51: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')]} 14:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:51:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:51:55 INFO - Using env: {'DISPLAY': ':0', 14:51:55 INFO - 'HOME': '/home/cltbld', 14:51:55 INFO - 'LANG': 'en_US.UTF-8', 14:51:55 INFO - 'LANGUAGE': 'en_US:en', 14:51:55 INFO - 'LOGNAME': 'cltbld', 14:51:55 INFO - 'MAIL': '/var/mail/cltbld', 14:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:55 INFO - 'MOZ_NO_REMOTE': '1', 14:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:55 INFO - 'NO_EM_RESTART': '1', 14:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:55 INFO - 'SHELL': '/bin/bash', 14:51:55 INFO - 'SHLVL': '1', 14:51:55 INFO - 'TERM': 'linux', 14:51:55 INFO - 'TMOUT': '86400', 14:51:55 INFO - 'USER': 'cltbld', 14:51:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:55 INFO - '_': '/tools/buildbot/bin/python'} 14:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:55 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 14:51:55 INFO - Cleaning up... 14:51:55 INFO - Return code: 0 14:51:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:51: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')]} 14:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51: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')]} 14:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:51:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:51:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:51:55 INFO - Using env: {'DISPLAY': ':0', 14:51:55 INFO - 'HOME': '/home/cltbld', 14:51:55 INFO - 'LANG': 'en_US.UTF-8', 14:51:55 INFO - 'LANGUAGE': 'en_US:en', 14:51:55 INFO - 'LOGNAME': 'cltbld', 14:51:55 INFO - 'MAIL': '/var/mail/cltbld', 14:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:55 INFO - 'MOZ_NO_REMOTE': '1', 14:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:55 INFO - 'NO_EM_RESTART': '1', 14:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:55 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:55 INFO - 'SHELL': '/bin/bash', 14:51:55 INFO - 'SHLVL': '1', 14:51:55 INFO - 'TERM': 'linux', 14:51:55 INFO - 'TMOUT': '86400', 14:51:55 INFO - 'USER': 'cltbld', 14:51:55 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:55 INFO - '_': '/tools/buildbot/bin/python'} 14:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:55 INFO - Downloading/unpacking psutil>=0.7.1 14:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:57 INFO - Installing collected packages: psutil 14:51:57 INFO - Running setup.py install for psutil 14:51:57 INFO - building 'psutil._psutil_linux' extension 14:51:57 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 14:51:57 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 14:51:57 INFO - building 'psutil._psutil_posix' extension 14:51:57 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 14:51:58 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 14:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:58 INFO - Successfully installed psutil 14:51:58 INFO - Cleaning up... 14:51:58 INFO - Return code: 0 14:51:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:58 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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:51:58 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 14:51:58 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 14:51:58 INFO - Using env: {'DISPLAY': ':0', 14:51:58 INFO - 'HOME': '/home/cltbld', 14:51:58 INFO - 'LANG': 'en_US.UTF-8', 14:51:58 INFO - 'LANGUAGE': 'en_US:en', 14:51:58 INFO - 'LOGNAME': 'cltbld', 14:51:58 INFO - 'MAIL': '/var/mail/cltbld', 14:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:58 INFO - 'MOZ_NO_REMOTE': '1', 14:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:58 INFO - 'NO_EM_RESTART': '1', 14:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:58 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:58 INFO - 'SHELL': '/bin/bash', 14:51:58 INFO - 'SHLVL': '1', 14:51:58 INFO - 'TERM': 'linux', 14:51:58 INFO - 'TMOUT': '86400', 14:51:58 INFO - 'USER': 'cltbld', 14:51:58 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:58 INFO - '_': '/tools/buildbot/bin/python'} 14:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:51:58 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 14:51:58 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 14:51:58 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 14:51:58 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 14:51:58 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 14:51:58 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 14:52:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:52:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:52:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:52:00 INFO - Installing collected packages: mozsystemmonitor 14:52:00 INFO - Running setup.py install for mozsystemmonitor 14:52:00 INFO - Successfully installed mozsystemmonitor 14:52:00 INFO - Cleaning up... 14:52:00 INFO - Return code: 0 14:52:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:00 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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:52:00 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 14:52:00 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 14:52:00 INFO - Using env: {'DISPLAY': ':0', 14:52:00 INFO - 'HOME': '/home/cltbld', 14:52:00 INFO - 'LANG': 'en_US.UTF-8', 14:52:00 INFO - 'LANGUAGE': 'en_US:en', 14:52:00 INFO - 'LOGNAME': 'cltbld', 14:52:00 INFO - 'MAIL': '/var/mail/cltbld', 14:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:00 INFO - 'MOZ_NO_REMOTE': '1', 14:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:00 INFO - 'NO_EM_RESTART': '1', 14:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:00 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:00 INFO - 'SHELL': '/bin/bash', 14:52:00 INFO - 'SHLVL': '1', 14:52:00 INFO - 'TERM': 'linux', 14:52:00 INFO - 'TMOUT': '86400', 14:52:00 INFO - 'USER': 'cltbld', 14:52:00 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:00 INFO - '_': '/tools/buildbot/bin/python'} 14:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:00 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:00 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 14:52:00 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 14:52:00 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 14:52:00 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 14:52:00 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 14:52:00 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 14:52:02 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:52:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 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 14:52:02 INFO - Downloading docopt-0.6.1.tar.gz 14:52:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:52:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:02 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:02 INFO - Running setup.py install for blobuploader 14:52:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:52:02 INFO - Running setup.py install for requests 14:52:03 INFO - Running setup.py install for docopt 14:52:03 INFO - Successfully installed blobuploader requests docopt 14:52:03 INFO - Cleaning up... 14:52:03 INFO - Return code: 0 14:52:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52:03 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')]} 14:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:03 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')]} 14:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:03 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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:52:03 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 14:52:03 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 14:52:03 INFO - Using env: {'DISPLAY': ':0', 14:52:03 INFO - 'HOME': '/home/cltbld', 14:52:03 INFO - 'LANG': 'en_US.UTF-8', 14:52:03 INFO - 'LANGUAGE': 'en_US:en', 14:52:03 INFO - 'LOGNAME': 'cltbld', 14:52:03 INFO - 'MAIL': '/var/mail/cltbld', 14:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:03 INFO - 'MOZ_NO_REMOTE': '1', 14:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:03 INFO - 'NO_EM_RESTART': '1', 14:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:03 INFO - 'SHELL': '/bin/bash', 14:52:03 INFO - 'SHLVL': '1', 14:52:03 INFO - 'TERM': 'linux', 14:52:03 INFO - 'TMOUT': '86400', 14:52:03 INFO - 'USER': 'cltbld', 14:52:03 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:03 INFO - '_': '/tools/buildbot/bin/python'} 14:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:03 INFO - Running setup.py (path:/tmp/pip-TP0I7C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:03 INFO - Running setup.py (path:/tmp/pip-DpUqq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:03 INFO - Running setup.py (path:/tmp/pip-f0d5Dy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:03 INFO - Running setup.py (path:/tmp/pip-ZtTFhc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:03 INFO - Running setup.py (path:/tmp/pip-Je093f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:04 INFO - Running setup.py (path:/tmp/pip-xfQoLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:04 INFO - Running setup.py (path:/tmp/pip-q2VFpP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:04 INFO - Running setup.py (path:/tmp/pip-WNXLgN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:04 INFO - Running setup.py (path:/tmp/pip-r3TBi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:04 INFO - Running setup.py (path:/tmp/pip-xlqhHr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:04 INFO - Running setup.py (path:/tmp/pip-1d1Dm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:04 INFO - Running setup.py (path:/tmp/pip-Dg_jBL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:04 INFO - Running setup.py (path:/tmp/pip-z0y2FZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:04 INFO - Running setup.py (path:/tmp/pip-kfEsU0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:04 INFO - Running setup.py (path:/tmp/pip-qaI1YU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:04 INFO - Running setup.py (path:/tmp/pip-WJTqry-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:04 INFO - Running setup.py (path:/tmp/pip-gEiZLl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:04 INFO - Running setup.py install for manifestparser 14:52:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:52:04 INFO - Running setup.py install for mozcrash 14:52:05 INFO - Running setup.py install for mozdebug 14:52:05 INFO - Running setup.py install for mozdevice 14:52:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Running setup.py install for mozfile 14:52:05 INFO - Running setup.py install for mozhttpd 14:52:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Running setup.py install for mozinfo 14:52:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Running setup.py install for mozInstall 14:52:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Running setup.py install for mozleak 14:52:05 INFO - Running setup.py install for mozlog 14:52:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:52:05 INFO - Running setup.py install for moznetwork 14:52:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Running setup.py install for mozprocess 14:52:06 INFO - Running setup.py install for mozprofile 14:52:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Running setup.py install for mozrunner 14:52:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Running setup.py install for mozscreenshot 14:52:06 INFO - Running setup.py install for moztest 14:52:06 INFO - Running setup.py install for mozversion 14:52:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:52:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:06 INFO - Cleaning up... 14:52:06 INFO - Return code: 0 14:52:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52: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')]} 14:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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', '-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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:52:06 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 14:52:06 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 14:52:06 INFO - Using env: {'DISPLAY': ':0', 14:52:06 INFO - 'HOME': '/home/cltbld', 14:52:06 INFO - 'LANG': 'en_US.UTF-8', 14:52:06 INFO - 'LANGUAGE': 'en_US:en', 14:52:06 INFO - 'LOGNAME': 'cltbld', 14:52:06 INFO - 'MAIL': '/var/mail/cltbld', 14:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:06 INFO - 'MOZ_NO_REMOTE': '1', 14:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:06 INFO - 'NO_EM_RESTART': '1', 14:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:06 INFO - 'SHELL': '/bin/bash', 14:52:06 INFO - 'SHLVL': '1', 14:52:06 INFO - 'TERM': 'linux', 14:52:06 INFO - 'TMOUT': '86400', 14:52:06 INFO - 'USER': 'cltbld', 14:52:06 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:06 INFO - '_': '/tools/buildbot/bin/python'} 14:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:06 INFO - Running setup.py (path:/tmp/pip-5G18Oo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:06 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)) 14:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:06 INFO - Running setup.py (path:/tmp/pip-YhB69Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:07 INFO - Running setup.py (path:/tmp/pip-z3oMWh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:07 INFO - Running setup.py (path:/tmp/pip-teTvvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:07 INFO - Running setup.py (path:/tmp/pip-7re7do-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:07 INFO - Running setup.py (path:/tmp/pip-tjSu7k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:07 INFO - Running setup.py (path:/tmp/pip-mrNLoc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:07 INFO - Running setup.py (path:/tmp/pip-HZqIAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:07 INFO - Running setup.py (path:/tmp/pip-6Z098m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:07 INFO - Running setup.py (path:/tmp/pip-2nwreb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:07 INFO - Running setup.py (path:/tmp/pip-TbtpOW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:07 INFO - Running setup.py (path:/tmp/pip-55WMmT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:07 INFO - Running setup.py (path:/tmp/pip-P6ty7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:07 INFO - Running setup.py (path:/tmp/pip-2guefO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:07 INFO - Running setup.py (path:/tmp/pip-VgMH6n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:07 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)) 14:52:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:07 INFO - Running setup.py (path:/tmp/pip-CLSLl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:08 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)) 14:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:08 INFO - Running setup.py (path:/tmp/pip-ZGahZO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:08 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)) 14:52:08 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)) 14:52:08 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)) 14:52:08 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)) 14:52:08 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)) 14:52:08 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)) 14:52:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:08 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 14:52:08 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 14:52:08 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 14:52:08 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 14:52:08 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 14:52:08 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 14:52:09 INFO - Downloading blessings-1.5.1.tar.gz 14:52:09 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 14:52:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:09 INFO - Installing collected packages: blessings 14:52:09 INFO - Running setup.py install for blessings 14:52:09 INFO - Successfully installed blessings 14:52:09 INFO - Cleaning up... 14:52:10 INFO - Return code: 0 14:52:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:52:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:52:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:52:10 INFO - Reading from file tmpfile_stdout 14:52:10 INFO - Current package versions: 14:52:10 INFO - argparse == 1.2.1 14:52:10 INFO - blessings == 1.5.1 14:52:10 INFO - blobuploader == 1.2.4 14:52:10 INFO - docopt == 0.6.1 14:52:10 INFO - manifestparser == 1.1 14:52:10 INFO - mozInstall == 1.12 14:52:10 INFO - mozcrash == 0.16 14:52:10 INFO - mozdebug == 0.1 14:52:10 INFO - mozdevice == 0.47 14:52:10 INFO - mozfile == 1.2 14:52:10 INFO - mozhttpd == 0.7 14:52:10 INFO - mozinfo == 0.9 14:52:10 INFO - mozleak == 0.1 14:52:10 INFO - mozlog == 3.0 14:52:10 INFO - moznetwork == 0.27 14:52:10 INFO - mozprocess == 0.22 14:52:10 INFO - mozprofile == 0.27 14:52:10 INFO - mozrunner == 6.11 14:52:10 INFO - mozscreenshot == 0.1 14:52:10 INFO - mozsystemmonitor == 0.0 14:52:10 INFO - moztest == 0.7 14:52:10 INFO - mozversion == 1.4 14:52:10 INFO - psutil == 3.1.1 14:52:10 INFO - requests == 1.2.3 14:52:10 INFO - wsgiref == 0.1.2 14:52:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52: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')]} 14:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:10 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 0x7fec2a190c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23326c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23e47c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, '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': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', '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 14:52:10 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 14:52:10 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 14:52:10 INFO - Using env: {'DISPLAY': ':0', 14:52:10 INFO - 'HOME': '/home/cltbld', 14:52:10 INFO - 'LANG': 'en_US.UTF-8', 14:52:10 INFO - 'LANGUAGE': 'en_US:en', 14:52:10 INFO - 'LOGNAME': 'cltbld', 14:52:10 INFO - 'MAIL': '/var/mail/cltbld', 14:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:10 INFO - 'MOZ_NO_REMOTE': '1', 14:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:10 INFO - 'NO_EM_RESTART': '1', 14:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:10 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:10 INFO - 'SHELL': '/bin/bash', 14:52:10 INFO - 'SHLVL': '1', 14:52:10 INFO - 'TERM': 'linux', 14:52:10 INFO - 'TMOUT': '86400', 14:52:10 INFO - 'USER': 'cltbld', 14:52:10 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:10 INFO - '_': '/tools/buildbot/bin/python'} 14:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 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)) 14:52:10 INFO - Cleaning up... 14:52:10 INFO - Return code: 0 14:52:10 INFO - Running post-action listener: _resource_record_post_action 14:52:10 INFO - Running post-action listener: _start_resource_monitoring 14:52:10 INFO - Starting resource monitoring. 14:52:10 INFO - ##### 14:52:10 INFO - ##### Running install step. 14:52:10 INFO - ##### 14:52:10 INFO - Running pre-action listener: _resource_record_pre_action 14:52:10 INFO - Running main action method: install 14:52:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:52:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:52:10 INFO - Reading from file tmpfile_stdout 14:52:10 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:52:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:52:10 INFO - Reading from file tmpfile_stdout 14:52:10 INFO - Output received: 14:52:10 INFO - Usage: mozinstall [options] installer 14:52:10 INFO - Options: 14:52:10 INFO - -h, --help show this help message and exit 14:52:10 INFO - -d DEST, --destination=DEST 14:52:10 INFO - Directory to install application into. [default: 14:52:10 INFO - "/builds/slave/test-pgo"] 14:52:10 INFO - --app=APP Application being installed. [default: firefox] 14:52:10 INFO - mkdir: /builds/slave/test-pgo/build/application 14:52:10 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'] 14:52:10 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 14:52:25 INFO - Reading from file tmpfile_stdout 14:52:25 INFO - Output received: 14:52:25 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:52:25 INFO - Running post-action listener: _resource_record_post_action 14:52:25 INFO - ##### 14:52:25 INFO - ##### Running run-tests step. 14:52:25 INFO - ##### 14:52:25 INFO - Running pre-action listener: _resource_record_pre_action 14:52:25 INFO - Running main action method: run_tests 14:52:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:52:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:52:25 INFO - Python 2.7.3 14:52:25 INFO - Return code: 0 14:52:25 INFO - grabbing minidump binary from tooltool 14:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:25 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 0x2428d70>, '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 0x2429b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2429fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:52:25 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 14:52:25 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 14:52:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:25 INFO - Return code: 0 14:52:25 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:52:25 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:52:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:52:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:52:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:52:25 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:52:25 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost 14:52:25 INFO - Using env: {'DISPLAY': ':0', 14:52:25 INFO - 'HOME': '/home/cltbld', 14:52:25 INFO - 'LANG': 'en_US.UTF-8', 14:52:25 INFO - 'LANGUAGE': 'en_US:en', 14:52:25 INFO - 'LOGNAME': 'cltbld', 14:52:25 INFO - 'MAIL': '/var/mail/cltbld', 14:52:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:52:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:25 INFO - 'MOZ_NO_REMOTE': '1', 14:52:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:25 INFO - 'NO_EM_RESTART': '1', 14:52:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:25 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:52:25 INFO - 'SHELL': '/bin/bash', 14:52:25 INFO - 'SHLVL': '1', 14:52:25 INFO - 'TERM': 'linux', 14:52:25 INFO - 'TMOUT': '86400', 14:52:25 INFO - 'USER': 'cltbld', 14:52:25 INFO - 'XDG_SESSION_COOKIE': 'a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193', 14:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:25 INFO - '_': '/tools/buildbot/bin/python'} 14:52:25 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost'] with output_timeout 3600 14:52:25 INFO - mozversion INFO | application_buildid: 20151118133104 14:52:25 INFO - mozversion INFO | application_changeset: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 14:52:25 INFO - mozversion INFO | application_display_name: Nightly 14:52:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:25 INFO - mozversion INFO | application_name: Firefox 14:52:25 INFO - mozversion INFO | application_remotingname: firefox 14:52:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:52:25 INFO - mozversion INFO | application_vendor: Mozilla 14:52:25 INFO - mozversion INFO | application_version: 45.0a1 14:52:25 INFO - mozversion INFO | platform_buildid: 20151118133104 14:52:25 INFO - mozversion INFO | platform_changeset: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 14:52:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:52:25 INFO - mozversion INFO | platform_version: 45.0a1 14:52:25 INFO - 2015-11-18 14:52:25,682 DEBUG : using testdate: 1447887145 14:52:25 INFO - 2015-11-18 14:52:25,682 DEBUG : actual date: 1447887145 14:52:25 INFO - 2015-11-18 14:52:25,729 INFO : starting webserver on 'localhost:45241' 14:52:25 INFO - 2015-11-18 14:52:25,730 INFO : Starting test suite talos-linux64-ix-031 14:52:25 INFO - 2015-11-18 14:52:25,730 INFO : Starting test dromaeo_css 14:52:25 INFO - 2015-11-18 14:52:25,730 DEBUG : operating with platform_type : linux_ 14:52:25 INFO - 2015-11-18 14:52:25,731 INFO : Initialising browser for dromaeo_css test... 14:52:25 INFO - 2015-11-18 14:52:25,744 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpti7jGG/profile http://localhost:45241/getInfo.html 14:52:30 INFO - 2015-11-18 14:52:30,692 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:52:30 INFO - 2015-11-18 14:52:30,692 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:52:30 INFO - 2015-11-18 14:52:30,692 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:52:30 INFO - 2015-11-18 14:52:30,693 DEBUG : BROWSER_OUTPUT: __metrics 14:52:30 INFO - 2015-11-18 14:52:30,841 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:52:32 INFO - 2015-11-18 14:52:32,013 INFO : Browser initialized. 14:52:32 INFO - 2015-11-18 14:52:32,013 INFO : Running cycle 1/1 for dromaeo_css test... 14:52:32 INFO - 2015-11-18 14:52:32,013 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpti7jGG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:52:43 INFO - 2015-11-18 14:52:43,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 14:52:43 INFO - 2015-11-18 14:52:43,796 DEBUG : BROWSER_OUTPUT: 14:53:35 INFO - 2015-11-18 14:53:35,208 DEBUG : BROWSER_OUTPUT: 1447887215203 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] 14:55:43 INFO - 2015-11-18 14:55:43,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45241/tests/dromaeo/cssquery-ext.html) 14:55:44 INFO - 2015-11-18 14:55:44,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 232542208 14:55:44 INFO - 2015-11-18 14:55:44,412 DEBUG : BROWSER_OUTPUT: 14:58:46 INFO - 2015-11-18 14:58:46,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-ext.html (next: http://localhost:45241/tests/dromaeo/cssquery-jquery.html) 14:58:47 INFO - 2015-11-18 14:58:47,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 220454912 14:58:47 INFO - 2015-11-18 14:58:47,311 DEBUG : BROWSER_OUTPUT: 15:01:49 INFO - 2015-11-18 15:01:49,264 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45241/tests/dromaeo/cssquery-mootools.html) 15:01:49 INFO - 2015-11-18 15:01:49,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 207499264 15:01:49 INFO - 2015-11-18 15:01:49,837 DEBUG : BROWSER_OUTPUT: 15:04:51 INFO - 2015-11-18 15:04:51,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45241/tests/dromaeo/cssquery-prototype.html) 15:04:52 INFO - 2015-11-18 15:04:52,220 DEBUG : BROWSER_OUTPUT: RSS: Main: 198520832 15:04:52 INFO - 2015-11-18 15:04:52,220 DEBUG : BROWSER_OUTPUT: 15:07:54 INFO - 2015-11-18 15:07:54,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45241/tests/dromaeo/cssquery-yui.html) 15:07:55 INFO - 2015-11-18 15:07:55,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 200056832 15:07:55 INFO - 2015-11-18 15:07:55,311 DEBUG : BROWSER_OUTPUT: 15:10:57 INFO - 2015-11-18 15:10:57,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/dromaeo/cssquery-yui.html (next: http://localhost:45241/tests/dromaeo/cssquery-dojo.html) 15:10:58 INFO - 2015-11-18 15:10:58,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 270946304 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:10:58 INFO - 2015-11-18 15:10:58,017 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3150.8424578771064;3173.6667649896776;3224.8387580620965;3228.4673028950224;3244.610646722392;5072.213806859933;5152.948470515294;5251.238570407293;5298.417174110849;5310.575153987681;5226.686398816074;5255.316808814859;5322.121849894763;5334.226537152111;5345.037893179227;4865.513448655132;4917.385326834145;4927.236278376858;4946.703197808125;4987.376577927759;4679.110968915895;4951.207806750903;4961.107000739866;5011.273365362039;5025.844055867153;4744.098621261984;4848.2727590861305;4848.9757551212015;4850.975745121269;4879.512048795127;4898.314236006926;4912.091263116335;4917.72952487613;4919.335889654886;4931.235658472942;4665.906681866378;4890.095332363524;4898.902021959577;4920.335754673145;4954.653174277802;5020.322256495399;5069.290299358093;5107.616928730323;5117.5394214520875;5125.718085505296;5708.229389032511;5711.657300561938;5715.942550628147;5718.771249150029;5721.4850663440075;5577.888442231133;5686.0333743263745;5752.856178595527;5754.280714910637;5756.942430575725;5260.289860868772;5300.231466437345;5304.575633949275;5324.760385782688;5372.7313634318125;5784.334801497797;5797.623154494944;5811.82564523065;5815.156802263733;5860.531157507389;5425.972870135624;5479.643823151482;5552.639078459887;5636.859078522988;5640.85897852557;5765.336986246635;5769.163471296639;5775;5775.422457754275;5776.046952252916;5722.7424765885635;5728.112142617901;5729.742161602738;5731.656100633975;5738.942610573924;5483.588730845123;5564.805231816867;5606.074997625346;5698.686572238484;5706.400827913092;4459.175052615276;4464.888377790581;4472.619827314649;4481.305397663367;4502.774861256924;3980.980095099564;3987.5613682494904;3988.3020471417385;4010.1578668479365;4015.2371049501085;5300.045991721528;5394.1099718546;5395.919061214085;5467.480589344006;5544.279243698374;5770.42295770428;5783.277090363705;5795.39148389413;5799.4780469757925;5801.970990145022;5462.890742185214;5469.671819690831;5476.534494568006;5476.67139971603;5477.123660214346;4901.411830580282;4953.356063711766;5008.173651347487;5018.322526458955;5056.191009438472;5933;5933.199018132669;5933.643981361046;5933.762649493972;5938.6436813791315;5539.169124631338;5723.198752174782;5727.198192253005;5730.627509212055;5731.140328950691;5820.505257053029;5849.888521180962;5942.554308426972;5952.5833191676165;5995.250593675791;5644.85887852807;5681.857953551194;5682.37493875665;5687.829365119053;5691.943080569141;5457.481539253765;5566.888662226652;5744.3394009687745;5758.683272419889;5765.798197063083;5554.944450555443;5644.6330988485615;5655.377908430151;5655.745491452977;5704.401037890962;5625.353084395347;5639.774409023593;5644.6613203207935;5645.322561292671;5654.46282603152;5300.1254792958725;5369.946300536944;5409.134538473825;5577.693226872561;5590.133529302964;5625.353084395183;5674.9501342251815;5677.943220567907;5689.345725241485;5737.311522617312;5521.365043020104;5523.171524271392;5558.916616250679;5563.499285064364;5572.331320241597 15:10:58 INFO - 2015-11-18 15:10:58,018 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.1488230448565;562.6820846221883;564.966102033878;568.6502800777521;581.9330776960651;30995.225119372;31726.841365793167;39767.40348894769;40544;40549;42207.78896105523;42594.57405425945;42688.14623707524;42750.786246068725;42759;7603.771886843404;8666.480011199332;8823.382363234576;8843.60203790831;8847.292216622654;7702.614869256543;10254.282200245985;10579.418132002736;10579.576816927314;10582.206334524903;10268.845967310497;10324.432156231403;10347.068763811256;10350.275480716353;10355.430451325174;10268.589256429734;10357.378557286587;10369.274150809446;10377.740556486147;10381.117605003546;10152.187824973984;10289.3311934724;10291.125254353388;10298.7425314367;10309;39051.21897562033;39730.20539589192;39774;39835.60164398348;39892.800535997136;3370.3427831572853;3401.8809341672923;3491.8603255869734;3683.631636836322;3854.672352850011;29710;29993.550096748568;30131.246718831986;30165.09504714862;31048;3520.1727594015388;3553.875614353511;3600.513930619385;3619.2037751694847;3762.5673047599603;426090;432618.99999999686;432733;432820;433087;51930.48069519332;52833.207501887504;58033.70983145057;58648;58701;69450.65274673594;70284.29715702777;70692;70731;70769;14127.223002734743;14218.360173792204;14345.64135896611;14416.567502974927;14419;10242.283040187116;10356.326838755456;10382.896171038345;10625.415602141957;10749.355038697548;19915.701264481046;19976.800231997786;20015.599688006158;20123.195072197243;20188.69716954247;8055.798605034804;8228.382871284677;8302.633749381397;8310.958445207856;8315.584220788936;917.6283605139796;935.7379933618598;973.3478569358547;973.9372406767814;1106.253279036647;28649.074087824112;28770;29271.414571708447;29286.414271714446;29568.55647165294;1036.5076588620345;1046.795874804406;1073.0209055781359;1097.5609756097465;1116.8827273136367;14858.777118343234;14993;15176.772348414783;15282.847171528143;15286.388544458097;327127;331980;333621;333878;334077;43919.34120988188;44826.32760508595;52514;53185.468145318824;53466.198007029925;1310.9016823738068;1321.881030707241;1328.7807511760645;1331.4474493085454;1332.7201287729492;26827.195184144508;27003.459930801666;31786.205344866565;32788.50817237791;32935.67064329326;39583.60416395914;40185.39721904115;48747.26879096746;49742.25386619131;50591.193836585466;237152;237249;239696;240057;240301;41642.791786042086;41792.791036044626;42515.7874210627;42635.14729705451;42639;45317.773411134054;45379;46337.53662463332;46547.301790473844;47301;37285.4407183887;38180.6181938177;38451.230975380895;38740.80629596834;39829.80085099556;38023.42964855474;38100.61899380971;38285.808570958085;38799;39079.804600976815;37623.93068381156;38307;38314.80842595769;38371.42442863415;38680;33339.49990750092;34219.14452138716;34416.31167376688;36588.26823463569;38654.226915462095;25671.614925775753;25775.613365799152;25784.226473205836;25967.610485843106;26152.215433537025 15:10:58 INFO - 2015-11-18 15:10:58,020 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.88270377733585;353.88349756518164;355.64613209856196;358.07080625776115;359.33702319221044;14074.89567427495;14143.646408839784;16711.331546738133;17042.65914681707;17747.73378399325;14630.414783408678;15219.6956060879;15404.69190616187;15669.921650391761;17407.129643517837;5200.947990520084;5317.973410132944;5322.33470816148;5325.440828712987;5327;3886.5336159660737;4012.25773231953;5264.341957255343;5303.973480132613;5785.508231800302;5817;5854.151148083525;5866.765329386841;5872.17789509469;5873.735681894325;5702.515286200678;5820.417958204188;5828.854278643025;5837.1827944087645;5841.824745257649;5119.257707632372;5125.743712814345;5137.409197942247;5147.382314122292;5150.639455238135;19853.205871765113;20519.076641551164;20714;21038.474038149016;21144;2240.2047273217936;2250.3811451850706;2279.076973825603;2313.993412865392;2331.067572970825;9286.442813431217;9529;9663.13031827139;12875.227486350755;13409.798853017213;1563;1613.7175994200968;1690.4421540891476;1693.7798086248708;1695.448979081791;52430.213546796826;56746;57496.425035749526;57898.42101579015;58095.70952145255;6766.391024807791;6857.485688573377;6946.0622815919205;7017.087778588751;7064.364207221375;8415.579221039046;8429.241368276762;8432.873506897402;8453.577321134042;8463.49219046859;5232.581393488512;5279.340082489689;5372.3016007919505;5385.030694475032;5399.784008639689;5290.391604965478;5296.523312901857;5325.440828713007;5435.836924892181;5451.373092094381;3219.420504309247;3240.4815229563155;3251.886183983549;3257.299680568689;3262.0866157475944;1110.8278216876236;1164.5807509296646;1199.56215981168;2893.988677868861;2967.925801854971;463.2102265637081;482.80929033031754;502.78380296472136;509.152261484624;515.1602887293687;11870.406479675981;12197.573084941985;12234.632961011184;12401.62795116148;12401.875981240253;485.9902801944012;502.60043265603935;504.06999086685005;512.2163090471585;513.5660366989888;6585.6707164641575;6623.7350505980185;6664.500162487833;6685.966570167216;6996.090508233897;374354;375420;378334;383051;384767;59642;63836.36163638397;67737;73120.63439682768;73698.6315068432;544.7548603128529;557.0919401375812;557.3646043510402;557.6236040672529;558.3495228059346;10838.566457341618;10897.509612067635;11281.830772538255;11337;11457;34396.14009649779;34559;35108.29783404369;35275.29449411049;36057.0985725359;42151.7892410536;43532.782336088116;46863;47764;47841.28238076362;6769.153855768029;6804.863902721819;6929.3070692930305;6932.826679333057;6933;10479.633212837514;12243.816342755044;12274.570390036306;12571.371431428575;12583.874161258636;9284.118008789153;10314.845277320695;10394.272400931863;10528.526216320437;10541.104006159563;10482.423466709404;10497.42264175447;10578.947105264424;10593.629222977159;10620.468976551296;10471.738206544593;10553.419561924167;10705.090067344363;10809.243352965217;10925.453727313443;6571.769988050395;6685.933140668531;6709.731610735711;6767.627780472121;6771.559848609824;10569.524371403151;10571.682849514527;10783.51474183648;10811.297265677706;10824.350538967687 15:10:58 INFO - 2015-11-18 15:10:58,021 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1307.960761177165;1652.6612044530873;1695.2032544703993;1697.4652984309937;1731.2341411760012;6496.285408605049;7294.197638259794;7481.177070522238;7481.58851263181;7492.812679683011;7290.343869051784;7384.704611815521;7390.778276651709;7408;7409.777706668795;1946.1047917957756;1973.9506512337164;2230.996051776707;2254.1434254983083;2275.9886200568976;2283.2351162360546;2283.6574513822893;2284.908603655852;2285.8857057147075;2286.6798648189265;2162.156758864044;2222.7110475638146;2224.443889027743;2225.1766846266823;2225.2656623314347;1953.4042117154263;1986.9503262418411;2226.365485836537;2268.727752669674;2274.590573696734;2231.7433495147943;2263.3549438409973;2281.5208806150727;2308.5844547981524;2313.201945328859;7511.474196806225;7517.887231691529;7547.132079810783;7566.281203285679;7580.658870350792;4592.173408786451;4659.930101048487;4688;4690.0854333405;4694.741789201593;3074.8308843013624;3113.066080175938;3150.921226969321;3155.495120780687;3196.568463257477;1056.6618682021756;1072.6031368393667;1086.5327908999127;1104.745908441055;1143.2511704833264;10254.384736915808;10324.948375258076;10339.534720937576;10348.63779767712;10360.740981475448;4055.7160998730396;4168.874933751992;4181.121964387452;4197.706160568731;4209.031922657745;8455.450395724258;8459.915400845914;8460.450070745383;8464.06895241523;8470.025947016173;4715.056988602225;4717.268823332389;4720.527947205252;4727.692699974491;4729.196036673774;4295.914081718348;4311.482622085307;4341.175176716414;4345.521992580813;4347.282698354736;3428.451447768345;3442.225499262646;3463.2727127303547;3467.081223475781;3493.807840568793;1099.6096385783092;1120.5965852293168;1120.6750042487588;1121.6428121972342;1125.3416751200475;1310.9803352949714;1315.9473621055242;1329.8337707786527;1351.3716122003316;1365.215001374194;7117.6085315308155;7202.92797072033;7217.675204615805;7243.058402407653;7252.166000909858;500.48200112883717;509.2997128947697;519;519.7894852584709;520.8775937654648;5635.633683810539;5684.63049901755;5685.204071430003;5691.9715401423555;5694.829155125353;8750.82498350042;9049.276057915351;9068.455892646462;9073.81852362949;9144.81710365789;8947.731568052968;8952;9035.954820225988;9037.186653201243;9048.773780655536;6822.488313376517;6855.760048398282;7094.503384763017;7139.75054365484;7168.390686791577;6793.864122717617;6869.313068693091;6871.347222013901;6875.3124687532845;6877.105976223059;7864.6854125834325;7990.880136797837;8067.959660201662;8072.87890681652;8120;7989.560574168244;8124.187581241828;8307.210814972568;8326.791830204293;8328.791780205544;6325.683715814283;6325.936740632535;6441;6444.613323200623;6456.225252969673;7200.027996220443;7266.636668166676;7269.7455589054125;7286.417086633162;7316.414686825147;5426.810061647823;6728.259891412039;6854.9657251713425;6901.75843845463;7031.261717519586;6616.371444712745;6638.734450621921;6656.068150459037;6715.597064176165;6758.189017317954;6331.841703957438;6360.427561519486;6680.231773346128;6928.584284942919;6929.411000065051;6343.492520598249;6372.87254254903;6374.808755737336;6375.203099612549;6381.585196962183;6394.296627370893;6438.774642887476;6441.291457939529;6468.320826313357;6476.06097115925 15:10:58 INFO - 2015-11-18 15:10:58,022 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.85178521450564;338.2457120621015;342.6727475261126;343.02922728677845;349.58748676561646;5969.671668058255;6086.817395478131;6124.724387402566;6183.907241391377;6185.474234690051;5920.674362910038;6079.9664057110285;6087.269527656687;6094.939050609492;6097.268327800659;4693.6010439112715;4695;4699.060187962404;4705.082508910764;4709.246520556711;4474.6420286377015;4555.635549156076;4593.793279302439;4698.412698412699;4712.858614241578;4610.031893302394;4629.166749985018;4641.280601506755;4658.767061646921;4669.579737823595;4621.930671039937;4632.675712700112;4638.095571363586;4639.095376401603;4659.906801863977;4084.509858816961;4089.6319331260033;4090;4095.754254744695;4107.54816970133;5606.299212598426;5700.7719691212305;5710.71446427677;5718.399568045378;5719.942800571983;5402.216678581623;5404.540614047811;5426.348838139409;5429.429909859447;5434;6492.220933487964;6496.252930912959;6498.960166373357;6505.447037001813;6510.121133646944;4433.889152771174;4557.544245575449;4562.8631141065825;4568.725876447424;4575.359449677047;6721.663916804189;6729.697163627599;6746.089277947463;6746.156730408699;6746.156730408699;4643.419572553431;4662.067586482717;4664.346991421204;4667.556582124761;4680.602148817388;4725.621950243973;4728.881777955578;4729.4797572267025;4731.645126615517;4735.905281894412;5313.654612450178;5354.41101478837;5413.133898576209;5437.347518297751;5445.863853403617;6516.283208847023;6583.80248592543;6587.83530411734;6590.143281373391;6590.3080176581725;1663.7837081179368;1685.603883087498;1686.3591835102582;1688.6707092117165;1690;1113.1818113686434;1115.67087709126;1123.4495097402378;1143.0626885953438;1146.1461211397395;6340.270868850142;6346.587471814318;6365.904511432333;6366.586171898812;6366.904496432558;6542.967285163544;6620.172478440195;6700.698468568926;6769.559978601375;6778.22050464193;6401.967990160019;6418.358164183638;6421.197350331208;6422;6439.066335381437;3666.8899933002053;3696.7597106188014;3701.222743223899;3706.5181526401934;3707.4994875691978;6907.620080895498;7036.894446583306;7043.92956070443;7113;7127.89308160378;6912.170539535288;6915.446764258847;6918;7003.929960700328;7033.437325014089;7094.858102837914;7115.466340024519;7122.6438678066925;7123.358897699232;7128.144622645315;6605.504587155887;6824.931750682628;6839.555428897106;6840.384365407137;6848.109745733223;6791.524593278423;6797.4901882358035;6799.422049125879;6803.319668033157;6803.897941530782;7023.68393422287;7102.857942841218;7126.35862772353;7138.785836424916;7143.607101609461;4481.260592002283;4559.110973360163;4561.566651168134;4565.657575681771;4578.954210457853;6656.600603963778;6750.729970801113;6756.797296081126;6761.695723692544;6763.492738044568;6576.638284894186;6578.342165783383;6580.80257592273;6585.703643335965;6588.934110658832;6398.968005160131;6571.868562628816;6572.159795257336;6572.934270657232;6583.506237032338;6448.355164483514;6462.773802916875;6465.321141280097;6466.06242094903;6472.414258506696;6495.610263384212;6613.239477459962;6620.735170593315;6621.106150669598;6622.602643841385;6260.593061450991;6384.489240860813;6392.105105285171;6425.389587989133;6450.870982580416 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: |5;yui.html;858.3390789092399;862.8274345130967;868.6916144768609;869.5174178331026;895.4492986813108;12802.871971280285;12897.22616643002;12912.160709553873;12967.35163241839;12971.481140754371;13136.343182840843;13265.668358291048;13279.070465067425;13281.535146269882;13284.335783210825;668.9096971908779;681.5637991685301;802.6668932393079;816.4611356504709;816.4978538198994;778.1323823936299;807.2169995104739;809.3889113719134;816.8325493273894;817.1542453560565;709.8012556484192;817.264461984216;852.4586887326561;860.2859626509982;860.7030574451804;697.891826766852;831.1314676163423;846.1073567386405;846.834867200896;847.1147650704997;595.4373117404054;603.7403916315982;621.8041316985135;621.828997025817;622.4926684751958;12721.10952233344;12781.936090319581;12803.935980320039;12846.614601561969;12871.485140594365;11808.589686431878;11920.523179072827;11989.520419183222;12194.146409751322;12363.258204507758;10257.384556926609;10261.897381026169;10282.383057016528;10551.94724026375;10583.947080264626;3469.5663042119736;3470.4273794823825;3555.6977656899194;3632.691221246197;3652;45679.771601142114;45727.31409028867;45994.77002614999;46373.536264637594;47537;9940.751481213027;9950.402975821475;9962.402255864672;10008.599656013823;10040.096391324816;18250.36123735663;18357.81642183561;18479.076046197635;18577;18582.81417185838;7000.264972177848;7061.646917654097;7138;7319.34125928669;7523.586202758901;4010;4065.329220678614;4114.629683328515;4126.298529250034;4172.91654166921;2961.4077184563175;3002.9399412012076;3003.0990702789077;3003.8197708137145;3003.894863679761;458.2164498707181;467.7941705649503;472.8652334084769;477.3960939411647;480.5098799224771;632.9240491141093;651.9152510173742;662.3409707341131;673.4242222899351;742.3430264216207;7858.8428231435055;8663.393562450694;8809.11908809114;8860.202581767542;8966.462012279284;579.4524174654911;638.4286063972719;697.2156324135348;697.3756652596791;725.6045455226808;3783.697304215656;3973.205358928168;4000.7199496035;4012.538558065801;4147.315692910696;55728;56729;57088.42911570914;57320.71339643275;57343.42656573464;50240.24639630409;50856.23715644268;50976.23535646968;50994.49005509898;51049.744751276005;43203.78398108052;44533.77733111314;44867.102657946656;44902;45283.320750188774;7975.4018448615425;8123.390745694215;8162.755117346489;8192.836143276982;8194.139615340304;33507;33854.322913542084;33929.49105763465;34126.65873341235;34568.65431345654;39345.40981885331;40642.79678601588;44197.55802442063;45094.32358514559;45466.31800523061;7053.5540214254925;7425.217947692407;7461.664225109775;7493.475456717977;7558.659860306409;10702.411367374869;10752.731181720519;10835.837462438227;10863.67408977732;11255.380954047607;10478.37129772216;10581.4709264538;10748.355098694103;10750.892491074988;11077.446127693744;9858.359206651545;10445.477726113815;10676.733081673021;10682.465876706288;10697.411642359744;7755.72854950074;10751.086157676373;10755.516001780095;10887;10941.07000904932;9112.453252804853;9123.680671176477;9313.208377288007;9361.85957210656;9431.717048488556;8868.911310886808;8941.195292423714;9127;9143.13140251675;9153.853428837418 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,738 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888258015__endTimestamp 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:10:58 INFO - 2015-11-18 15:10:58,024 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5317.13 Median:5523.17 stddev:578.44 (10.5%) stddev-sans-first:554.68 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: Values: 3150.8 3173.7 3224.8 3228.5 3244.6 5072.2 5152.9 5251.2 5298.4 5310.6 5226.7 5255.3 5322.1 5334.2 5345.0 4865.5 4917.4 4927.2 4946.7 4987.4 4679.1 4951.2 4961.1 5011.3 5025.8 4744.1 4848.3 4849.0 4851.0 4879.5 4898.3 4912.1 4917.7 4919.3 4931.2 4665.9 4890.1 4898.9 4920.3 4954.7 5020.3 5069.3 5107.6 5117.5 5125.7 5708.2 5711.7 5715.9 5718.8 5721.5 5577.9 5686.0 5752.9 5754.3 5756.9 5260.3 5300.2 5304.6 5324.8 5372.7 5784.3 5797.6 5811.8 5815.2 5860.5 5426.0 5479.6 5552.6 5636.9 5640.9 5765.3 5769.2 5775.0 5775.4 5776.0 5722.7 5728.1 5729.7 5731.7 5738.9 5483.6 5564.8 5606.1 5698.7 5706.4 4459.2 4464.9 4472.6 4481.3 4502.8 3981.0 3987.6 3988.3 4010.2 4015.2 5300.0 5394.1 5395.9 5467.5 5544.3 5770.4 5783.3 5795.4 5799.5 5802.0 5462.9 5469.7 5476.5 5476.7 5477.1 4901.4 4953.4 5008.2 5018.3 5056.2 5933.0 5933.2 5933.6 5933.8 5938.6 5539.2 5723.2 5727.2 5730.6 5731.1 5820.5 5849.9 5942.6 5952.6 5995.3 5644.9 5681.9 5682.4 5687.8 5691.9 5457.5 5566.9 5744.3 5758.7 5765.8 5554.9 5644.6 5655.4 5655.7 5704.4 5625.4 5639.8 5644.7 5645.3 5654.5 5300.1 5369.9 5409.1 5577.7 5590.1 5625.4 5675.0 5677.9 5689.3 5737.3 5521.4 5523.2 5558.9 5563.5 5572.3 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50736.72 Median:3609.86 stddev:90442.58 (2505.4%) stddev-sans-first:90617.82 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: Values: 558.1 562.7 565.0 568.7 581.9 30995.2 31726.8 39767.4 40544.0 40549.0 42207.8 42594.6 42688.1 42750.8 42759.0 7603.8 8666.5 8823.4 8843.6 8847.3 7702.6 10254.3 10579.4 10579.6 10582.2 10268.8 10324.4 10347.1 10350.3 10355.4 10268.6 10357.4 10369.3 10377.7 10381.1 10152.2 10289.3 10291.1 10298.7 10309.0 39051.2 39730.2 39774.0 39835.6 39892.8 3370.3 3401.9 3491.9 3683.6 3854.7 29710.0 29993.6 30131.2 30165.1 31048.0 3520.2 3553.9 3600.5 3619.2 3762.6 426090.0 432619.0 432733.0 432820.0 433087.0 51930.5 52833.2 58033.7 58648.0 58701.0 69450.7 70284.3 70692.0 70731.0 70769.0 14127.2 14218.4 14345.6 14416.6 14419.0 10242.3 10356.3 10382.9 10625.4 10749.4 19915.7 19976.8 20015.6 20123.2 20188.7 8055.8 8228.4 8302.6 8311.0 8315.6 917.6 935.7 973.3 973.9 1106.3 28649.1 28770.0 29271.4 29286.4 29568.6 1036.5 1046.8 1073.0 1097.6 1116.9 14858.8 14993.0 15176.8 15282.8 15286.4 327127.0 331980.0 333621.0 333878.0 334077.0 43919.3 44826.3 52514.0 53185.5 53466.2 1310.9 1321.9 1328.8 1331.4 1332.7 26827.2 27003.5 31786.2 32788.5 32935.7 39583.6 40185.4 48747.3 49742.3 50591.2 237152.0 237249.0 239696.0 240057.0 240301.0 41642.8 41792.8 42515.8 42635.1 42639.0 45317.8 45379.0 46337.5 46547.3 47301.0 37285.4 38180.6 38451.2 38740.8 39829.8 38023.4 38100.6 38285.8 38799.0 39079.8 37623.9 38307.0 38314.8 38371.4 38680.0 33339.5 34219.1 34416.3 36588.3 38654.2 25671.6 25775.6 25784.2 25967.6 26152.2 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,025 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22474.81 Median:23663.11 stddev:62341.20 (263.5%) stddev-sans-first:62493.95 15:10:58 INFO - 2015-11-18 15:10:58,026 DEBUG : BROWSER_OUTPUT: Values: 352.9 353.9 355.6 358.1 359.3 14074.9 14143.6 16711.3 17042.7 17747.7 14630.4 15219.7 15404.7 15669.9 17407.1 5200.9 5318.0 5322.3 5325.4 5327.0 3886.5 4012.3 5264.3 5304.0 5785.5 5817.0 5854.2 5866.8 5872.2 5873.7 5702.5 5820.4 5828.9 5837.2 5841.8 5119.3 5125.7 5137.4 5147.4 5150.6 19853.2 20519.1 20714.0 21038.5 21144.0 2240.2 2250.4 2279.1 2314.0 2331.1 9286.4 9529.0 9663.1 12875.2 13409.8 1563.0 1613.7 1690.4 1693.8 1695.4 52430.2 56746.0 57496.4 57898.4 58095.7 6766.4 6857.5 6946.1 7017.1 7064.4 8415.6 8429.2 8432.9 8453.6 8463.5 5232.6 5279.3 5372.3 5385.0 5399.8 5290.4 5296.5 5325.4 5435.8 5451.4 3219.4 3240.5 3251.9 3257.3 3262.1 1110.8 1164.6 1199.6 2894.0 2967.9 463.2 482.8 502.8 509.2 515.2 11870.4 12197.6 12234.6 12401.6 12401.9 486.0 502.6 504.1 512.2 513.6 6585.7 6623.7 6664.5 6686.0 6996.1 374354.0 375420.0 378334.0 383051.0 384767.0 59642.0 63836.4 67737.0 73120.6 73698.6 544.8 557.1 557.4 557.6 558.3 10838.6 10897.5 11281.8 11337.0 11457.0 34396.1 34559.0 35108.3 35275.3 36057.1 42151.8 43532.8 46863.0 47764.0 47841.3 6769.2 6804.9 6929.3 6932.8 6933.0 10479.6 12243.8 12274.6 12571.4 12583.9 9284.1 10314.8 10394.3 10528.5 10541.1 10482.4 10497.4 10578.9 10593.6 10620.5 10471.7 10553.4 10705.1 10809.2 10925.5 6571.8 6685.9 6709.7 6767.6 6771.6 10569.5 10571.7 10783.5 10811.3 10824.4 15:10:58 INFO - 2015-11-18 15:10:58,026 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,026 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5265.95 Median:6010.26 stddev:2698.82 (44.9%) stddev-sans-first:2689.99 15:10:58 INFO - 2015-11-18 15:10:58,026 DEBUG : BROWSER_OUTPUT: Values: 1308.0 1652.7 1695.2 1697.5 1731.2 6496.3 7294.2 7481.2 7481.6 7492.8 7290.3 7384.7 7390.8 7408.0 7409.8 1946.1 1974.0 2231.0 2254.1 2276.0 2283.2 2283.7 2284.9 2285.9 2286.7 2162.2 2222.7 2224.4 2225.2 2225.3 1953.4 1987.0 2226.4 2268.7 2274.6 2231.7 2263.4 2281.5 2308.6 2313.2 7511.5 7517.9 7547.1 7566.3 7580.7 4592.2 4659.9 4688.0 4690.1 4694.7 3074.8 3113.1 3150.9 3155.5 3196.6 1056.7 1072.6 1086.5 1104.7 1143.3 10254.4 10324.9 10339.5 10348.6 10360.7 4055.7 4168.9 4181.1 4197.7 4209.0 8455.5 8459.9 8460.5 8464.1 8470.0 4715.1 4717.3 4720.5 4727.7 4729.2 4295.9 4311.5 4341.2 4345.5 4347.3 3428.5 3442.2 3463.3 3467.1 3493.8 1099.6 1120.6 1120.7 1121.6 1125.3 1311.0 1315.9 1329.8 1351.4 1365.2 7117.6 7202.9 7217.7 7243.1 7252.2 500.5 509.3 519.0 519.8 520.9 5635.6 5684.6 5685.2 5692.0 5694.8 8750.8 9049.3 9068.5 9073.8 9144.8 8947.7 8952.0 9036.0 9037.2 9048.8 6822.5 6855.8 7094.5 7139.8 7168.4 6793.9 6869.3 6871.3 6875.3 6877.1 7864.7 7990.9 8068.0 8072.9 8120.0 7989.6 8124.2 8307.2 8326.8 8328.8 6325.7 6325.9 6441.0 6444.6 6456.2 7200.0 7266.6 7269.7 7286.4 7316.4 5426.8 6728.3 6855.0 6901.8 7031.3 6616.4 6638.7 6656.1 6715.6 6758.2 6331.8 6360.4 6680.2 6928.6 6929.4 6343.5 6372.9 6374.8 6375.2 6381.6 6394.3 6438.8 6441.3 6468.3 6476.1 15:10:58 INFO - 2015-11-18 15:10:58,027 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,027 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5474.23 Median:6300.43 stddev:1660.90 (26.4%) stddev-sans-first:1620.18 15:10:58 INFO - 2015-11-18 15:10:58,027 DEBUG : BROWSER_OUTPUT: Values: 336.9 338.2 342.7 343.0 349.6 5969.7 6086.8 6124.7 6183.9 6185.5 5920.7 6080.0 6087.3 6094.9 6097.3 4693.6 4695.0 4699.1 4705.1 4709.2 4474.6 4555.6 4593.8 4698.4 4712.9 4610.0 4629.2 4641.3 4658.8 4669.6 4621.9 4632.7 4638.1 4639.1 4659.9 4084.5 4089.6 4090.0 4095.8 4107.5 5606.3 5700.8 5710.7 5718.4 5719.9 5402.2 5404.5 5426.3 5429.4 5434.0 6492.2 6496.3 6499.0 6505.4 6510.1 4433.9 4557.5 4562.9 4568.7 4575.4 6721.7 6729.7 6746.1 6746.2 6746.2 4643.4 4662.1 4664.3 4667.6 4680.6 4725.6 4728.9 4729.5 4731.6 4735.9 5313.7 5354.4 5413.1 5437.3 5445.9 6516.3 6583.8 6587.8 6590.1 6590.3 1663.8 1685.6 1686.4 1688.7 1690.0 1113.2 1115.7 1123.4 1143.1 1146.1 6340.3 6346.6 6365.9 6366.6 6366.9 6543.0 6620.2 6700.7 6769.6 6778.2 6402.0 6418.4 6421.2 6422.0 6439.1 3666.9 3696.8 3701.2 3706.5 3707.5 6907.6 7036.9 7043.9 7113.0 7127.9 6912.2 6915.4 6918.0 7003.9 7033.4 7094.9 7115.5 7122.6 7123.4 7128.1 6605.5 6824.9 6839.6 6840.4 6848.1 6791.5 6797.5 6799.4 6803.3 6803.9 7023.7 7102.9 7126.4 7138.8 7143.6 4481.3 4559.1 4561.6 4565.7 4579.0 6656.6 6750.7 6756.8 6761.7 6763.5 6576.6 6578.3 6580.8 6585.7 6588.9 6399.0 6571.9 6572.2 6572.9 6583.5 6448.4 6462.8 6465.3 6466.1 6472.4 6495.6 6613.2 6620.7 6621.1 6622.6 6260.6 6384.5 6392.1 6425.4 6450.9 15:10:58 INFO - 2015-11-18 15:10:58,027 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,027 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13288.27 Median:470.33 stddev:15601.72 (3317.2%) stddev-sans-first:15617.57 15:10:58 INFO - 2015-11-18 15:10:58,028 DEBUG : BROWSER_OUTPUT: Values: 858.3 862.8 868.7 869.5 895.4 12802.9 12897.2 12912.2 12967.4 12971.5 13136.3 13265.7 13279.1 13281.5 13284.3 668.9 681.6 802.7 816.5 816.5 778.1 807.2 809.4 816.8 817.2 709.8 817.3 852.5 860.3 860.7 697.9 831.1 846.1 846.8 847.1 595.4 603.7 621.8 621.8 622.5 12721.1 12781.9 12803.9 12846.6 12871.5 11808.6 11920.5 11989.5 12194.1 12363.3 10257.4 10261.9 10282.4 10551.9 10583.9 3469.6 3470.4 3555.7 3632.7 3652.0 45679.8 45727.3 45994.8 46373.5 47537.0 9940.8 9950.4 9962.4 10008.6 10040.1 18250.4 18357.8 18479.1 18577.0 18582.8 7000.3 7061.6 7138.0 7319.3 7523.6 4010.0 4065.3 4114.6 4126.3 4172.9 2961.4 3002.9 3003.1 3003.8 3003.9 458.2 467.8 472.9 477.4 480.5 632.9 651.9 662.3 673.4 742.3 7858.8 8663.4 8809.1 8860.2 8966.5 579.5 638.4 697.2 697.4 725.6 3783.7 3973.2 4000.7 4012.5 4147.3 55728.0 56729.0 57088.4 57320.7 57343.4 50240.2 50856.2 50976.2 50994.5 51049.7 43203.8 44533.8 44867.1 44902.0 45283.3 7975.4 8123.4 8162.8 8192.8 8194.1 33507.0 33854.3 33929.5 34126.7 34568.7 39345.4 40642.8 44197.6 45094.3 45466.3 7053.6 7425.2 7461.7 7493.5 7558.7 10702.4 10752.7 10835.8 10863.7 11255.4 10478.4 10581.5 10748.4 10750.9 11077.4 9858.4 10445.5 10676.7 10682.5 10697.4 7755.7 10751.1 10755.5 10887.0 10941.1 9112.5 9123.7 9313.2 9361.9 9431.7 8868.9 8941.2 9127.0 9143.1 9153.9 15:10:58 INFO - 2015-11-18 15:10:58,028 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:10:58 INFO - 2015-11-18 15:10:58,028 DEBUG : BROWSER_OUTPUT: 15:10:58 INFO - 2015-11-18 15:10:58,713 INFO : Browser exited with error code: 0 15:10:58 INFO - 2015-11-18 15:10:58,734 INFO : Completed test dromaeo_css (00:18:33) 15:10:58 INFO - 2015-11-18 15:10:58,734 INFO : Starting test kraken 15:10:58 INFO - 2015-11-18 15:10:58,734 DEBUG : operating with platform_type : linux_ 15:10:58 INFO - 2015-11-18 15:10:58,735 INFO : Initialising browser for kraken test... 15:10:58 INFO - 2015-11-18 15:10:58,740 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1R98mr/profile http://localhost:45241/getInfo.html 15:11:02 INFO - 2015-11-18 15:11:02,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:11:02 INFO - 2015-11-18 15:11:02,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:11:02 INFO - 2015-11-18 15:11:02,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:11:02 INFO - 2015-11-18 15:11:02,355 DEBUG : BROWSER_OUTPUT: __metrics 15:11:02 INFO - 2015-11-18 15:11:02,443 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:11:03 INFO - 2015-11-18 15:11:03,661 INFO : Browser initialized. 15:11:03 INFO - 2015-11-18 15:11:03,662 INFO : Running cycle 1/1 for kraken test... 15:11:03 INFO - 2015-11-18 15:11:03,662 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1R98mr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:11:15 INFO - 2015-11-18 15:11:15,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 141672448 15:11:15 INFO - 2015-11-18 15:11:15,437 DEBUG : BROWSER_OUTPUT: 15:11:17 INFO - 2015-11-18 15:11:17,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45241/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:18 INFO - 2015-11-18 15:11:18,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 180101120 15:11:18 INFO - 2015-11-18 15:11:18,512 DEBUG : BROWSER_OUTPUT: 15:11:21 INFO - 2015-11-18 15:11:21,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45241/tests/kraken/driver.html?testName=audio-dft) 15:11:21 INFO - 2015-11-18 15:11:21,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 169144320 15:11:21 INFO - 2015-11-18 15:11:21,666 DEBUG : BROWSER_OUTPUT: 15:11:24 INFO - 2015-11-18 15:11:24,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45241/tests/kraken/driver.html?testName=audio-fft) 15:11:25 INFO - 2015-11-18 15:11:25,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 151085056 15:11:25 INFO - 2015-11-18 15:11:25,106 DEBUG : BROWSER_OUTPUT: 15:11:27 INFO - 2015-11-18 15:11:27,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45241/tests/kraken/driver.html?testName=audio-oscillator) 15:11:27 INFO - 2015-11-18 15:11:27,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 154947584 15:11:27 INFO - 2015-11-18 15:11:27,639 DEBUG : BROWSER_OUTPUT: 15:11:29 INFO - 2015-11-18 15:11:29,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:30 INFO - 2015-11-18 15:11:30,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 154996736 15:11:30 INFO - 2015-11-18 15:11:30,378 DEBUG : BROWSER_OUTPUT: 15:11:33 INFO - 2015-11-18 15:11:33,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45241/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:33 INFO - 2015-11-18 15:11:33,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 155996160 15:11:33 INFO - 2015-11-18 15:11:33,846 DEBUG : BROWSER_OUTPUT: 15:11:37 INFO - 2015-11-18 15:11:37,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45241/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:37 INFO - 2015-11-18 15:11:37,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 155471872 15:11:37 INFO - 2015-11-18 15:11:37,821 DEBUG : BROWSER_OUTPUT: 15:11:40 INFO - 2015-11-18 15:11:40,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45241/tests/kraken/driver.html?testName=json-parse-financial) 15:11:41 INFO - 2015-11-18 15:11:41,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 157093888 15:11:41 INFO - 2015-11-18 15:11:41,135 DEBUG : BROWSER_OUTPUT: 15:11:42 INFO - 2015-11-18 15:11:42,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:43 INFO - 2015-11-18 15:11:43,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 166547456 15:11:43 INFO - 2015-11-18 15:11:43,279 DEBUG : BROWSER_OUTPUT: 15:11:45 INFO - 2015-11-18 15:11:45,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:45 INFO - 2015-11-18 15:11:45,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 167329792 15:11:45 INFO - 2015-11-18 15:11:45,690 DEBUG : BROWSER_OUTPUT: 15:11:47 INFO - 2015-11-18 15:11:47,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:48 INFO - 2015-11-18 15:11:48,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 171241472 15:11:48 INFO - 2015-11-18 15:11:48,328 DEBUG : BROWSER_OUTPUT: 15:11:50 INFO - 2015-11-18 15:11:50,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:51 INFO - 2015-11-18 15:11:51,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 181198848 15:11:51 INFO - 2015-11-18 15:11:51,278 DEBUG : BROWSER_OUTPUT: 15:11:53 INFO - 2015-11-18 15:11:53,817 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:54 INFO - 2015-11-18 15:11:54,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 180006912 15:11:54 INFO - 2015-11-18 15:11:54,390 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45241/tests/kraken/driver.html?testName=ai-astar) 15:11:56 INFO - 2015-11-18 15:11:56,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 238604288 15:11:56 INFO - 2015-11-18 15:11:56,308 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,309 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:11:56 INFO - 2015-11-18 15:11:56,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:11:56 INFO - 2015-11-18 15:11:56,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:11:56 INFO - 2015-11-18 15:11:56,310 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:11:56 INFO - 2015-11-18 15:11:56,310 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;103;111;113;111;101;112;111;107 15:11:56 INFO - 2015-11-18 15:11:56,310 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;130;154;161;125;157;147;126;163;124 15:11:56 INFO - 2015-11-18 15:11:56,311 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;161;160;161;160;163;162;161 15:11:56 INFO - 2015-11-18 15:11:56,312 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;87;91;72;74;72;98;91;71 15:11:56 INFO - 2015-11-18 15:11:56,312 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;135;89;92;90;132;90;91;133 15:11:56 INFO - 2015-11-18 15:11:56,312 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;110;109 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;145;144;145;145;145;145;145 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;96;96;95;95 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;60;60;60;61;60;59;69;58;59 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;70;68;69;69;68;69 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;94;95;85;86;87;89;85 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;125;122;114;115;121;124;117;115;116 15:11:56 INFO - 2015-11-18 15:11:56,313 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;150;152;149;150;139;151;146;149;139 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;68;66;66;67;65;65;65;67 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,924 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888316309__endTimestamp 15:11:56 INFO - 2015-11-18 15:11:56,314 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.00 stddev:4.03 (3.6%) stddev-sans-first:4.26 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 103.0 111.0 113.0 111.0 101.0 112.0 111.0 107.0 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.40 Median:150.50 stddev:15.69 (10.4%) stddev-sans-first:16.58 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: Values: 147.0 130.0 154.0 161.0 125.0 157.0 147.0 126.0 163.0 124.0 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,318 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 161.0 160.0 161.0 160.0 163.0 162.0 161.0 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:80.50 stddev:10.48 (13.0%) stddev-sans-first:10.71 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 87.0 91.0 72.0 74.0 72.0 98.0 91.0 71.0 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.50 stddev:20.62 (22.8%) stddev-sans-first:21.37 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 135.0 89.0 92.0 90.0 132.0 90.0 91.0 133.0 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 109.0 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:144.80 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 145.0 144.0 145.0 145.0 145.0 145.0 145.0 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:11:56 INFO - 2015-11-18 15:11:56,319 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.60 Median:60.00 stddev:3.06 (5.1%) stddev-sans-first:3.24 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: Values: 60.0 60.0 60.0 60.0 61.0 60.0 59.0 69.0 58.0 59.0 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.73 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 70.0 68.0 69.0 69.0 68.0 69.0 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,320 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:86.50 stddev:3.86 (4.5%) stddev-sans-first:3.98 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 94.0 95.0 85.0 86.0 87.0 89.0 85.0 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:121.50 stddev:4.21 (3.5%) stddev-sans-first:4.24 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: Values: 123.0 125.0 122.0 114.0 115.0 121.0 124.0 117.0 115.0 116.0 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.80 Median:149.50 stddev:4.85 (3.2%) stddev-sans-first:4.94 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: Values: 143.0 150.0 152.0 149.0 150.0 139.0 151.0 146.0 149.0 139.0 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 68.0 66.0 66.0 67.0 65.0 65.0 65.0 67.0 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:11:56 INFO - 2015-11-18 15:11:56,321 DEBUG : BROWSER_OUTPUT: 15:11:57 INFO - 2015-11-18 15:11:57,169 INFO : Browser exited with error code: 0 15:11:57 INFO - 2015-11-18 15:11:57,223 INFO : Completed test kraken (00:00:58) 15:11:57 INFO - 2015-11-18 15:11:57,223 INFO : Starting test v8_7 15:11:57 INFO - 2015-11-18 15:11:57,223 DEBUG : operating with platform_type : linux_ 15:11:57 INFO - 2015-11-18 15:11:57,223 INFO : Initialising browser for v8_7 test... 15:11:57 INFO - 2015-11-18 15:11:57,229 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppcAgI_/profile http://localhost:45241/getInfo.html 15:12:00 INFO - 2015-11-18 15:12:00,964 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:12:00 INFO - 2015-11-18 15:12:00,964 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:12:00 INFO - 2015-11-18 15:12:00,964 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:12:00 INFO - 2015-11-18 15:12:00,964 DEBUG : BROWSER_OUTPUT: __metrics 15:12:01 INFO - 2015-11-18 15:12:01,061 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:12:02 INFO - 2015-11-18 15:12:02,347 INFO : Browser initialized. 15:12:02 INFO - 2015-11-18 15:12:02,348 INFO : Running cycle 1/1 for v8_7 test... 15:12:02 INFO - 2015-11-18 15:12:02,348 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppcAgI_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:12:14 INFO - 2015-11-18 15:12:14,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 15:12:14 INFO - 2015-11-18 15:12:14,115 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45241/tests/v8_7/run.html (next: http://localhost:45241/tests/v8_7/run.html) 15:12:35 INFO - 2015-11-18 15:12:35,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 546828288 15:12:35 INFO - 2015-11-18 15:12:35,710 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 15:12:35 INFO - 2015-11-18 15:12:35,712 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.39487565938205 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1113.5857461024498 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |5;Earley;777.6049766718507 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 15:12:35 INFO - 2015-11-18 15:12:35,713 DEBUG : BROWSER_OUTPUT: |7;RegExp;25923.076923076922 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: |8;Splay;580.7200929152149 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888355711__endTimestamp 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,714 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,715 DEBUG : BROWSER_OUTPUT: Values: 165.1 15:12:35 INFO - 2015-11-18 15:12:35,715 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,715 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: Values: 188.4 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: Values: 281.0 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: Values: 5025.1 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,716 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1113.59 Median:1113.59 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 1113.6 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.60 Median:777.60 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 777.6 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 12000.0 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25923.08 Median:25923.08 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 25923.1 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.72 Median:580.72 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 580.7 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 15:12:35 INFO - 2015-11-18 15:12:35,717 DEBUG : BROWSER_OUTPUT: Values: 4840.6 15:12:35 INFO - 2015-11-18 15:12:35,718 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:12:35 INFO - 2015-11-18 15:12:35,718 DEBUG : BROWSER_OUTPUT: 15:12:36 INFO - 2015-11-18 15:12:36,581 INFO : Browser exited with error code: 0 15:12:36 INFO - 2015-11-18 15:12:36,600 INFO : Completed test v8_7 (00:00:39) 15:12:36 INFO - 2015-11-18 15:12:36,782 INFO : Completed test suite (00:20:11) 15:12:36 INFO - 2015-11-18 15:12:36,782 DEBUG : Working with test: dromaeo_css 15:12:36 INFO - 2015-11-18 15:12:36,782 DEBUG : Generating results file: dromaeo_css 15:12:36 INFO - 2015-11-18 15:12:36,783 DEBUG : Working with test: kraken 15:12:36 INFO - 2015-11-18 15:12:36,783 DEBUG : Generating results file: kraken 15:12:36 INFO - 2015-11-18 15:12:36,784 INFO : javascript benchmark 15:12:36 INFO - 2015-11-18 15:12:36,784 DEBUG : Working with test: v8_7 15:12:36 INFO - 2015-11-18 15:12:36,784 DEBUG : Generating results file: v8_7 15:12:36 INFO - 2015-11-18 15:12:36,784 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:36 INFO - 2015-11-18 15:12:36,840 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 15:12:36 INFO - 2015-11-18 15:12:36,840 DEBUG : process_Request line: dromaeo_css 6743.24 graph.html#tests=[[72,63,35]] 15:12:36 INFO - 2015-11-18 15:12:36,840 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:36 INFO - 2015-11-18 15:12:36,875 DEBUG : process_Request line: kraken 1495.50 graph.html#tests=[[232,63,35]] 15:12:36 INFO - 2015-11-18 15:12:36,875 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:36 INFO - 2015-11-18 15:12:36,911 DEBUG : process_Request line: v8_7 21245.03 graph.html#tests=[[230,63,35]] 15:12:36 INFO - 2015-11-18 15:12:36,913 INFO : javascript benchmark 15:12:36 INFO - 2015-11-18 15:12:36,916 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.8424578771064, 3173.6667649896776, 3224.8387580620965, 3228.4673028950224, 3244.610646722392, 5072.213806859933, 5152.948470515294, 5251.238570407293, 5298.417174110849, 5310.575153987681, 5226.686398816074, 5255.316808814859, 5322.121849894763, 5334.226537152111, 5345.037893179227, 4865.513448655132, 4917.385326834145, 4927.236278376858, 4946.703197808125, 4987.376577927759, 4679.110968915895, 4951.207806750903, 4961.107000739866, 5011.273365362039, 5025.844055867153, 4744.098621261984, 4848.2727590861305, 4848.9757551212015, 4850.975745121269, 4879.512048795127, 4898.314236006926, 4912.091263116335, 4917.72952487613, 4919.335889654886, 4931.235658472942, 4665.906681866378, 4890.095332363524, 4898.902021959577, 4920.335754673145, 4954.653174277802, 5020.322256495399, 5069.290299358093, 5107.616928730323, 5117.5394214520875, 5125.718085505296, 5708.229389032511, 5711.657300561938, 5715.942550628147, 5718.771249150029, 5721.4850663440075, 5577.888442231133, 5686.0333743263745, 5752.856178595527, 5754.280714910637, 5756.942430575725, 5260.289860868772, 5300.231466437345, 5304.575633949275, 5324.760385782688, 5372.7313634318125, 5784.334801497797, 5797.623154494944, 5811.82564523065, 5815.156802263733, 5860.531157507389, 5425.972870135624, 5479.643823151482, 5552.639078459887, 5636.859078522988, 5640.85897852557, 5765.336986246635, 5769.163471296639, 5775.0, 5775.422457754275, 5776.046952252916, 5722.7424765885635, 5728.112142617901, 5729.742161602738, 5731.656100633975, 5738.942610573924, 5483.588730845123, 5564.805231816867, 5606.074997625346, 5698.686572238484, 5706.400827913092, 4459.175052615276, 4464.888377790581, 4472.619827314649, 4481.305397663367, 4502.774861256924, 3980.980095099564, 3987.5613682494904, 3988.3020471417385, 4010.1578668479365, 4015.2371049501085, 5300.045991721528, 5394.1099718546, 5395.919061214085, 5467.480589344006, 5544.279243698374, 5770.42295770428, 5783.277090363705, 5795.39148389413, 5799.4780469757925, 5801.970990145022, 5462.890742185214, 5469.671819690831, 5476.534494568006, 5476.67139971603, 5477.123660214346, 4901.411830580282, 4953.356063711766, 5008.173651347487, 5018.322526458955, 5056.191009438472, 5933.0, 5933.199018132669, 5933.643981361046, 5933.762649493972, 5938.6436813791315, 5539.169124631338, 5723.198752174782, 5727.198192253005, 5730.627509212055, 5731.140328950691, 5820.505257053029, 5849.888521180962, 5942.554308426972, 5952.5833191676165, 5995.250593675791, 5644.85887852807, 5681.857953551194, 5682.37493875665, 5687.829365119053, 5691.943080569141, 5457.481539253765, 5566.888662226652, 5744.3394009687745, 5758.683272419889, 5765.798197063083, 5554.944450555443, 5644.6330988485615, 5655.377908430151, 5655.745491452977, 5704.401037890962, 5625.353084395347, 5639.774409023593, 5644.6613203207935, 5645.322561292671, 5654.46282603152, 5300.1254792958725, 5369.946300536944, 5409.134538473825, 5577.693226872561, 5590.133529302964, 5625.353084395183, 5674.9501342251815, 5677.943220567907, 5689.345725241485, 5737.311522617312, 5521.365043020104, 5523.171524271392, 5558.916616250679, 5563.499285064364, 5572.331320241597], "unit": "ms", "name": "dojo.html", "value": 5280.483890688815}, {"lowerIsBetter": false, "replicates": [558.1488230448565, 562.6820846221883, 564.966102033878, 568.6502800777521, 581.9330776960651, 30995.225119372, 31726.841365793167, 39767.40348894769, 40544.0, 40549.0, 42207.78896105523, 42594.57405425945, 42688.14623707524, 42750.786246068725, 42759.0, 7603.771886843404, 8666.480011199332, 8823.382363234576, 8843.60203790831, 8847.292216622654, 7702.614869256543, 10254.282200245985, 10579.418132002736, 10579.576816927314, 10582.206334524903, 10268.845967310497, 10324.432156231403, 10347.068763811256, 10350.275480716353, 10355.430451325174, 10268.589256429734, 10357.378557286587, 10369.274150809446, 10377.740556486147, 10381.117605003546, 10152.187824973984, 10289.3311934724, 10291.125254353388, 10298.7425314367, 10309.0, 39051.21897562033, 39730.20539589192, 39774.0, 39835.60164398348, 39892.800535997136, 3370.3427831572853, 3401.8809341672923, 3491.8603255869734, 3683.631636836322, 3854.672352850011, 29710.0, 29993.550096748568, 30131.246718831986, 30165.09504714862, 31048.0, 3520.1727594015388, 3553.875614353511, 3600.513930619385, 3619.2037751694847, 3762.5673047599603, 426090.0, 432618.99999999686, 432733.0, 432820.0, 433087.0, 51930.48069519332, 52833.207501887504, 58033.70983145057, 58648.0, 58701.0, 69450.65274673594, 70284.29715702777, 70692.0, 70731.0, 70769.0, 14127.223002734743, 14218.360173792204, 14345.64135896611, 14416.567502974927, 14419.0, 10242.283040187116, 10356.326838755456, 10382.896171038345, 10625.415602141957, 10749.355038697548, 19915.701264481046, 19976.800231997786, 20015.599688006158, 20123.195072197243, 20188.69716954247, 8055.798605034804, 8228.382871284677, 8302.633749381397, 8310.958445207856, 8315.584220788936, 917.6283605139796, 935.7379933618598, 973.3478569358547, 973.9372406767814, 1106.253279036647, 28649.074087824112, 28770.0, 29271.414571708447, 29286.414271714446, 29568.55647165294, 1036.5076588620345, 1046.795874804406, 1073.0209055781359, 1097.5609756097465, 1116.8827273136367, 14858.777118343234, 14993.0, 15176.772348414783, 15282.847171528143, 15286.388544458097, 327127.0, 331980.0, 333621.0, 333878.0, 334077.0, 43919.34120988188, 44826.32760508595, 52514.0, 53185.468145318824, 53466.198007029925, 1310.9016823738068, 1321.881030707241, 1328.7807511760645, 1331.4474493085454, 1332.7201287729492, 26827.195184144508, 27003.459930801666, 31786.205344866565, 32788.50817237791, 32935.67064329326, 39583.60416395914, 40185.39721904115, 48747.26879096746, 49742.25386619131, 50591.193836585466, 237152.0, 237249.0, 239696.0, 240057.0, 240301.0, 41642.791786042086, 41792.791036044626, 42515.7874210627, 42635.14729705451, 42639.0, 45317.773411134054, 45379.0, 46337.53662463332, 46547.301790473844, 47301.0, 37285.4407183887, 38180.6181938177, 38451.230975380895, 38740.80629596834, 39829.80085099556, 38023.42964855474, 38100.61899380971, 38285.808570958085, 38799.0, 39079.804600976815, 37623.93068381156, 38307.0, 38314.80842595769, 38371.42442863415, 38680.0, 33339.49990750092, 34219.14452138716, 34416.31167376688, 36588.26823463569, 38654.226915462095, 25671.614925775753, 25775.613365799152, 25784.226473205836, 25967.610485843106, 26152.215433537025], "unit": "ms", "name": "ext.html", "value": 19279.081703564145}, {"lowerIsBetter": false, "replicates": [352.88270377733585, 353.88349756518164, 355.64613209856196, 358.07080625776115, 359.33702319221044, 14074.89567427495, 14143.646408839784, 16711.331546738133, 17042.65914681707, 17747.73378399325, 14630.414783408678, 15219.6956060879, 15404.69190616187, 15669.921650391761, 17407.129643517837, 5200.947990520084, 5317.973410132944, 5322.33470816148, 5325.440828712987, 5327.0, 3886.5336159660737, 4012.25773231953, 5264.341957255343, 5303.973480132613, 5785.508231800302, 5817.0, 5854.151148083525, 5866.765329386841, 5872.17789509469, 5873.735681894325, 5702.515286200678, 5820.417958204188, 5828.854278643025, 5837.1827944087645, 5841.824745257649, 5119.257707632372, 5125.743712814345, 5137.409197942247, 5147.382314122292, 5150.639455238135, 19853.205871765113, 20519.076641551164, 20714.0, 21038.474038149016, 21144.0, 2240.2047273217936, 2250.3811451850706, 2279.076973825603, 2313.993412865392, 2331.067572970825, 9286.442813431217, 9529.0, 9663.13031827139, 12875.227486350755, 13409.798853017213, 1563.0, 1613.7175994200968, 1690.4421540891476, 1693.7798086248708, 1695.448979081791, 52430.213546796826, 56746.0, 57496.425035749526, 57898.42101579015, 58095.70952145255, 6766.391024807791, 6857.485688573377, 6946.0622815919205, 7017.087778588751, 7064.364207221375, 8415.579221039046, 8429.241368276762, 8432.873506897402, 8453.577321134042, 8463.49219046859, 5232.581393488512, 5279.340082489689, 5372.3016007919505, 5385.030694475032, 5399.784008639689, 5290.391604965478, 5296.523312901857, 5325.440828713007, 5435.836924892181, 5451.373092094381, 3219.420504309247, 3240.4815229563155, 3251.886183983549, 3257.299680568689, 3262.0866157475944, 1110.8278216876236, 1164.5807509296646, 1199.56215981168, 2893.988677868861, 2967.925801854971, 463.2102265637081, 482.80929033031754, 502.78380296472136, 509.152261484624, 515.1602887293687, 11870.406479675981, 12197.573084941985, 12234.632961011184, 12401.62795116148, 12401.875981240253, 485.9902801944012, 502.60043265603935, 504.06999086685005, 512.2163090471585, 513.5660366989888, 6585.6707164641575, 6623.7350505980185, 6664.500162487833, 6685.966570167216, 6996.090508233897, 374354.0, 375420.0, 378334.0, 383051.0, 384767.0, 59642.0, 63836.36163638397, 67737.0, 73120.63439682768, 73698.6315068432, 544.7548603128529, 557.0919401375812, 557.3646043510402, 557.6236040672529, 558.3495228059346, 10838.566457341618, 10897.509612067635, 11281.830772538255, 11337.0, 11457.0, 34396.14009649779, 34559.0, 35108.29783404369, 35275.29449411049, 36057.0985725359, 42151.7892410536, 43532.782336088116, 46863.0, 47764.0, 47841.28238076362, 6769.153855768029, 6804.863902721819, 6929.3070692930305, 6932.826679333057, 6933.0, 10479.633212837514, 12243.816342755044, 12274.570390036306, 12571.371431428575, 12583.874161258636, 9284.118008789153, 10314.845277320695, 10394.272400931863, 10528.526216320437, 10541.104006159563, 10482.423466709404, 10497.42264175447, 10578.947105264424, 10593.629222977159, 10620.468976551296, 10471.738206544593, 10553.419561924167, 10705.090067344363, 10809.243352965217, 10925.453727313443, 6571.769988050395, 6685.933140668531, 6709.731610735711, 6767.627780472121, 6771.559848609824, 10569.524371403151, 10571.682849514527, 10783.51474183648, 10811.297265677706, 10824.350538967687], "unit": "ms", "name": "jquery.html", "value": 7191.067957411759}, {"lowerIsBetter": false, "replicates": [1307.960761177165, 1652.6612044530873, 1695.2032544703993, 1697.4652984309937, 1731.2341411760012, 6496.285408605049, 7294.197638259794, 7481.177070522238, 7481.58851263181, 7492.812679683011, 7290.343869051784, 7384.704611815521, 7390.778276651709, 7408.0, 7409.777706668795, 1946.1047917957756, 1973.9506512337164, 2230.996051776707, 2254.1434254983083, 2275.9886200568976, 2283.2351162360546, 2283.6574513822893, 2284.908603655852, 2285.8857057147075, 2286.6798648189265, 2162.156758864044, 2222.7110475638146, 2224.443889027743, 2225.1766846266823, 2225.2656623314347, 1953.4042117154263, 1986.9503262418411, 2226.365485836537, 2268.727752669674, 2274.590573696734, 2231.7433495147943, 2263.3549438409973, 2281.5208806150727, 2308.5844547981524, 2313.201945328859, 7511.474196806225, 7517.887231691529, 7547.132079810783, 7566.281203285679, 7580.658870350792, 4592.173408786451, 4659.930101048487, 4688.0, 4690.0854333405, 4694.741789201593, 3074.8308843013624, 3113.066080175938, 3150.921226969321, 3155.495120780687, 3196.568463257477, 1056.6618682021756, 1072.6031368393667, 1086.5327908999127, 1104.745908441055, 1143.2511704833264, 10254.384736915808, 10324.948375258076, 10339.534720937576, 10348.63779767712, 10360.740981475448, 4055.7160998730396, 4168.874933751992, 4181.121964387452, 4197.706160568731, 4209.031922657745, 8455.450395724258, 8459.915400845914, 8460.450070745383, 8464.06895241523, 8470.025947016173, 4715.056988602225, 4717.268823332389, 4720.527947205252, 4727.692699974491, 4729.196036673774, 4295.914081718348, 4311.482622085307, 4341.175176716414, 4345.521992580813, 4347.282698354736, 3428.451447768345, 3442.225499262646, 3463.2727127303547, 3467.081223475781, 3493.807840568793, 1099.6096385783092, 1120.5965852293168, 1120.6750042487588, 1121.6428121972342, 1125.3416751200475, 1310.9803352949714, 1315.9473621055242, 1329.8337707786527, 1351.3716122003316, 1365.215001374194, 7117.6085315308155, 7202.92797072033, 7217.675204615805, 7243.058402407653, 7252.166000909858, 500.48200112883717, 509.2997128947697, 519.0, 519.7894852584709, 520.8775937654648, 5635.633683810539, 5684.63049901755, 5685.204071430003, 5691.9715401423555, 5694.829155125353, 8750.82498350042, 9049.276057915351, 9068.455892646462, 9073.81852362949, 9144.81710365789, 8947.731568052968, 8952.0, 9035.954820225988, 9037.186653201243, 9048.773780655536, 6822.488313376517, 6855.760048398282, 7094.503384763017, 7139.75054365484, 7168.390686791577, 6793.864122717617, 6869.313068693091, 6871.347222013901, 6875.3124687532845, 6877.105976223059, 7864.6854125834325, 7990.880136797837, 8067.959660201662, 8072.87890681652, 8120.0, 7989.560574168244, 8124.187581241828, 8307.210814972568, 8326.791830204293, 8328.791780205544, 6325.683715814283, 6325.936740632535, 6441.0, 6444.613323200623, 6456.225252969673, 7200.027996220443, 7266.636668166676, 7269.7455589054125, 7286.417086633162, 7316.414686825147, 5426.810061647823, 6728.259891412039, 6854.9657251713425, 6901.75843845463, 7031.261717519586, 6616.371444712745, 6638.734450621921, 6656.068150459037, 6715.597064176165, 6758.189017317954, 6331.841703957438, 6360.427561519486, 6680.231773346128, 6928.584284942919, 6929.411000065051, 6343.492520598249, 6372.87254254903, 6374.808755737336, 6375.203099612549, 6381.585196962183, 6394.296627370893, 6438.774642887476, 6441.291457939529, 6468.320826313357, 6476.06097115925], "unit": "ms", "name": "mootools.html", "value": 4300.313134298166}, {"lowerIsBetter": false, "replicates": [336.85178521450564, 338.2457120621015, 342.6727475261126, 343.02922728677845, 349.58748676561646, 5969.671668058255, 6086.817395478131, 6124.724387402566, 6183.907241391377, 6185.474234690051, 5920.674362910038, 6079.9664057110285, 6087.269527656687, 6094.939050609492, 6097.268327800659, 4693.6010439112715, 4695.0, 4699.060187962404, 4705.082508910764, 4709.246520556711, 4474.6420286377015, 4555.635549156076, 4593.793279302439, 4698.412698412699, 4712.858614241578, 4610.031893302394, 4629.166749985018, 4641.280601506755, 4658.767061646921, 4669.579737823595, 4621.930671039937, 4632.675712700112, 4638.095571363586, 4639.095376401603, 4659.906801863977, 4084.509858816961, 4089.6319331260033, 4090.0, 4095.754254744695, 4107.54816970133, 5606.299212598426, 5700.7719691212305, 5710.71446427677, 5718.399568045378, 5719.942800571983, 5402.216678581623, 5404.540614047811, 5426.348838139409, 5429.429909859447, 5434.0, 6492.220933487964, 6496.252930912959, 6498.960166373357, 6505.447037001813, 6510.121133646944, 4433.889152771174, 4557.544245575449, 4562.8631141065825, 4568.725876447424, 4575.359449677047, 6721.663916804189, 6729.697163627599, 6746.089277947463, 6746.156730408699, 6746.156730408699, 4643.419572553431, 4662.067586482717, 4664.346991421204, 4667.556582124761, 4680.602148817388, 4725.621950243973, 4728.881777955578, 4729.4797572267025, 4731.645126615517, 4735.905281894412, 5313.654612450178, 5354.41101478837, 5413.133898576209, 5437.347518297751, 5445.863853403617, 6516.283208847023, 6583.80248592543, 6587.83530411734, 6590.143281373391, 6590.3080176581725, 1663.7837081179368, 1685.603883087498, 1686.3591835102582, 1688.6707092117165, 1690.0, 1113.1818113686434, 1115.67087709126, 1123.4495097402378, 1143.0626885953438, 1146.1461211397395, 6340.270868850142, 6346.587471814318, 6365.904511432333, 6366.586171898812, 6366.904496432558, 6542.967285163544, 6620.172478440195, 6700.698468568926, 6769.559978601375, 6778.22050464193, 6401.967990160019, 6418.358164183638, 6421.197350331208, 6422.0, 6439.066335381437, 3666.8899933002053, 3696.7597106188014, 3701.222743223899, 3706.5181526401934, 3707.4994875691978, 6907.620080895498, 7036.894446583306, 7043.92956070443, 7113.0, 7127.89308160378, 6912.170539535288, 6915.446764258847, 6918.0, 7003.929960700328, 7033.437325014089, 7094.858102837914, 7115.466340024519, 7122.6438678066925, 7123.358897699232, 7128.144622645315, 6605.504587155887, 6824.931750682628, 6839.555428897106, 6840.384365407137, 6848.109745733223, 6791.524593278423, 6797.4901882358035, 6799.422049125879, 6803.319668033157, 6803.897941530782, 7023.68393422287, 7102.857942841218, 7126.35862772353, 7138.785836424916, 7143.607101609461, 4481.260592002283, 4559.110973360163, 4561.566651168134, 4565.657575681771, 4578.954210457853, 6656.600603963778, 6750.729970801113, 6756.797296081126, 6761.695723692544, 6763.492738044568, 6576.638284894186, 6578.342165783383, 6580.80257592273, 6585.703643335965, 6588.934110658832, 6398.968005160131, 6571.868562628816, 6572.159795257336, 6572.934270657232, 6583.506237032338, 6448.355164483514, 6462.773802916875, 6465.321141280097, 6466.06242094903, 6472.414258506696, 6495.610263384212, 6613.239477459962, 6620.735170593315, 6621.106150669598, 6622.602643841385, 6260.593061450991, 6384.489240860813, 6392.105105285171, 6425.389587989133, 6450.870982580416], "unit": "ms", "name": "prototype.html", "value": 4935.824236106427}, {"lowerIsBetter": false, "replicates": [858.3390789092399, 862.8274345130967, 868.6916144768609, 869.5174178331026, 895.4492986813108, 12802.871971280285, 12897.22616643002, 12912.160709553873, 12967.35163241839, 12971.481140754371, 13136.343182840843, 13265.668358291048, 13279.070465067425, 13281.535146269882, 13284.335783210825, 668.9096971908779, 681.5637991685301, 802.6668932393079, 816.4611356504709, 816.4978538198994, 778.1323823936299, 807.2169995104739, 809.3889113719134, 816.8325493273894, 817.1542453560565, 709.8012556484192, 817.264461984216, 852.4586887326561, 860.2859626509982, 860.7030574451804, 697.891826766852, 831.1314676163423, 846.1073567386405, 846.834867200896, 847.1147650704997, 595.4373117404054, 603.7403916315982, 621.8041316985135, 621.828997025817, 622.4926684751958, 12721.10952233344, 12781.936090319581, 12803.935980320039, 12846.614601561969, 12871.485140594365, 11808.589686431878, 11920.523179072827, 11989.520419183222, 12194.146409751322, 12363.258204507758, 10257.384556926609, 10261.897381026169, 10282.383057016528, 10551.94724026375, 10583.947080264626, 3469.5663042119736, 3470.4273794823825, 3555.6977656899194, 3632.691221246197, 3652.0, 45679.771601142114, 45727.31409028867, 45994.77002614999, 46373.536264637594, 47537.0, 9940.751481213027, 9950.402975821475, 9962.402255864672, 10008.599656013823, 10040.096391324816, 18250.36123735663, 18357.81642183561, 18479.076046197635, 18577.0, 18582.81417185838, 7000.264972177848, 7061.646917654097, 7138.0, 7319.34125928669, 7523.586202758901, 4010.0, 4065.329220678614, 4114.629683328515, 4126.298529250034, 4172.91654166921, 2961.4077184563175, 3002.9399412012076, 3003.0990702789077, 3003.8197708137145, 3003.894863679761, 458.2164498707181, 467.7941705649503, 472.8652334084769, 477.3960939411647, 480.5098799224771, 632.9240491141093, 651.9152510173742, 662.3409707341131, 673.4242222899351, 742.3430264216207, 7858.8428231435055, 8663.393562450694, 8809.11908809114, 8860.202581767542, 8966.462012279284, 579.4524174654911, 638.4286063972719, 697.2156324135348, 697.3756652596791, 725.6045455226808, 3783.697304215656, 3973.205358928168, 4000.7199496035, 4012.538558065801, 4147.315692910696, 55728.0, 56729.0, 57088.42911570914, 57320.71339643275, 57343.42656573464, 50240.24639630409, 50856.23715644268, 50976.23535646968, 50994.49005509898, 51049.744751276005, 43203.78398108052, 44533.77733111314, 44867.102657946656, 44902.0, 45283.320750188774, 7975.4018448615425, 8123.390745694215, 8162.755117346489, 8192.836143276982, 8194.139615340304, 33507.0, 33854.322913542084, 33929.49105763465, 34126.65873341235, 34568.65431345654, 39345.40981885331, 40642.79678601588, 44197.55802442063, 45094.32358514559, 45466.31800523061, 7053.5540214254925, 7425.217947692407, 7461.664225109775, 7493.475456717977, 7558.659860306409, 10702.411367374869, 10752.731181720519, 10835.837462438227, 10863.67408977732, 11255.380954047607, 10478.37129772216, 10581.4709264538, 10748.355098694103, 10750.892491074988, 11077.446127693744, 9858.359206651545, 10445.477726113815, 10676.733081673021, 10682.465876706288, 10697.411642359744, 7755.72854950074, 10751.086157676373, 10755.516001780095, 10887.0, 10941.07000904932, 9112.453252804853, 9123.680671176477, 9313.208377288007, 9361.85957210656, 9431.717048488556, 8868.911310886808, 8941.195292423714, 9127.0, 9143.13140251675, 9153.853428837418], "unit": "ms", "name": "yui.html", "value": 6050.041702998285}], "name": "dromaeo_css", "value": 6743.238404585398}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 111.0, 113.0, 111.0, 101.0, 112.0, 111.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [147.0, 130.0, 154.0, 161.0, 125.0, 157.0, 147.0, 126.0, 163.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 161.0, 160.0, 161.0, 160.0, 163.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 87.0, 91.0, 72.0, 74.0, 72.0, 98.0, 91.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 135.0, 89.0, 92.0, 90.0, 132.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 144.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 144.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 69.0, 58.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 94.0, 95.0, 85.0, 86.0, 87.0, 89.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.6}, {"lowerIsBetter": true, "replicates": [123.0, 125.0, 122.0, 114.0, 115.0, 121.0, 124.0, 117.0, 115.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [143.0, 150.0, 152.0, 149.0, 150.0, 139.0, 151.0, 146.0, 149.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 66.0, 66.0, 67.0, 65.0, 65.0, 65.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1495.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [1113.5857461024498], "unit": "score", "name": "RayTrace", "value": 664.510122}, {"lowerIsBetter": false, "replicates": [777.6049766718507], "unit": "score", "name": "Earley", "value": 857.0714179999998}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [25923.076923076922], "unit": "score", "name": "RegExp", "value": 35.14185459940652}, {"lowerIsBetter": false, "replicates": [580.7200929152149], "unit": "score", "name": "Splay", "value": 140.327502}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21245.029978945448}]} 15:12:36 INFO - RETURN: dromaeo_css: 6743.24 15:12:36 INFO - RETURN: kraken: 1495.50 15:12:36 INFO - RETURN: v8_7: 21245.03 15:12:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "21245.03"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1495.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6743.24"}}} 15:12:37 INFO - Return code: 0 15:12:37 INFO - # TBPL SUCCESS # 15:12:37 INFO - Running post-action listener: _resource_record_post_action 15:12:37 INFO - Running post-run listener: _resource_record_post_run 15:12:38 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 262144; Write bytes: 518025216; Read time: 28; Write time: 536636 15:12:38 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 176656384; Read time: 0; Write time: 196224 15:12:38 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 262144; Write bytes: 337420288; Read time: 28; Write time: 339632 15:12:38 INFO - Running post-run listener: _upload_blobber_files 15:12:38 INFO - Blob upload gear active. 15:12:38 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:12:38 INFO - Copying logs to upload dir... 15:12:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1261.258208 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-18 15:12:38.011994) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:38.015427) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009024 build_url: 'https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/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-18 15:12:38.065811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:38.066139) ========= 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=a9e534cca236dfa67d42a089000001c1-1447886361.696088-1858182193 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:38.115969) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:12:38.116289) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:12:38.116592) ========= ========= Total master_lag: 0.22 =========