builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1447934375.67 results: success (0) buildid: 20151119023034 builduid: 6e932f3f2459448b85328de9bde29884 revision: 9b28207cf3e3ae95bed79d9da9e45152a9a66387 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.666048) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.666420) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.666692) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006715 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.689845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.690131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.727881) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.728161) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004763 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.783372) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.783631) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.784054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.784353) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 03:59: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% 227M=0s 2015-11-19 03:59:36 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.998274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.998554) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.047622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.047942) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9b28207cf3e3ae95bed79d9da9e45152a9a66387 --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/fx-team --rev 9b28207cf3e3ae95bed79d9da9e45152a9a66387 --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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 03:59:36,682 truncating revision to first 12 chars 2015-11-19 03:59:36,682 Setting DEBUG logging. 2015-11-19 03:59:36,682 attempt 1/10 2015-11-19 03:59:36,682 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9b28207cf3e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 03:59:36,939 unpacking tar archive at: fx-team-9b28207cf3e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.570698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.571006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.577274) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.577532) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.577913) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-19 03:59:36.578206) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:37 INFO - MultiFileLogger online at 20151119 03:59:37 in /builds/slave/test-pgo 03:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 03:59:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:59:37 INFO - {'append_to_log': False, 03:59:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:59:37 INFO - 'blob_upload_branch': 'Fx-Team', 03:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:59:37 INFO - 'branch': 'Fx-Team', 03:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:37 INFO - 'config_files': ('talos/linux_config.py',), 03:59:37 INFO - 'default_actions': ('clobber', 03:59:37 INFO - 'read-buildbot-config', 03:59:37 INFO - 'download-and-extract', 03:59:37 INFO - 'populate-webroot', 03:59:37 INFO - 'create-virtualenv', 03:59:37 INFO - 'install', 03:59:37 INFO - 'run-tests'), 03:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:37 INFO - 'download_minidump_stackwalk': True, 03:59:37 INFO - 'download_symbols': 'ondemand', 03:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:37 INFO - 'installer_path': 'installer.exe', 03:59:37 INFO - 'log_level': 'info', 03:59:37 INFO - 'log_name': 'talos', 03:59:37 INFO - 'log_to_console': True, 03:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:37 INFO - 'opt_config_files': (), 03:59:37 INFO - 'pip_index': False, 03:59:37 INFO - 'sps_profile': False, 03:59:37 INFO - 'sps_profile_interval': 0, 03:59:37 INFO - 'suite': 'dromaeojs', 03:59:37 INFO - 'system_bits': '64', 03:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:37 INFO - 'title': 'talos-linux64-ix-058', 03:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:37 INFO - 'use_talos_json': True, 03:59:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:37 INFO - 'work_dir': 'build'} 03:59:37 INFO - ##### 03:59:37 INFO - ##### Running clobber step. 03:59:37 INFO - ##### 03:59:37 INFO - Running pre-action listener: _resource_record_pre_action 03:59:37 INFO - Running main action method: clobber 03:59:37 INFO - rmtree: /builds/slave/test-pgo/build 03:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:59:37 INFO - Running post-action listener: _resource_record_post_action 03:59:37 INFO - ##### 03:59:37 INFO - ##### Running read-buildbot-config step. 03:59:37 INFO - ##### 03:59:37 INFO - Running pre-action listener: _resource_record_pre_action 03:59:37 INFO - Running main action method: read_buildbot_config 03:59:37 INFO - Using buildbot properties: 03:59:37 INFO - { 03:59:37 INFO - "properties": { 03:59:37 INFO - "buildnumber": 792, 03:59:37 INFO - "product": "firefox", 03:59:37 INFO - "script_repo_revision": "production", 03:59:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:59:37 INFO - "repository": "", 03:59:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:59:37 INFO - "buildid": "20151119023034", 03:59:37 INFO - "slavename": "talos-linux64-ix-058", 03:59:37 INFO - "pgo_build": "True", 03:59:37 INFO - "basedir": "/builds/slave/test-pgo", 03:59:37 INFO - "project": "", 03:59:37 INFO - "platform": "ubuntu64_hw", 03:59:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:37 INFO - "slavebuilddir": "test", 03:59:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:59:37 INFO - "branch": "fx-team", 03:59:37 INFO - "repo_path": "integration/fx-team", 03:59:37 INFO - "stage_platform": "linux64-pgo", 03:59:37 INFO - "builduid": "6e932f3f2459448b85328de9bde29884", 03:59:37 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:37 INFO - }, 03:59:37 INFO - "sourcestamp": { 03:59:37 INFO - "repository": "", 03:59:37 INFO - "hasPatch": false, 03:59:37 INFO - "project": "", 03:59:37 INFO - "branch": "fx-team-linux64-pgo-talos", 03:59:37 INFO - "changes": [ 03:59:37 INFO - { 03:59:37 INFO - "category": null, 03:59:37 INFO - "files": [ 03:59:37 INFO - { 03:59:37 INFO - "url": null, 03:59:37 INFO - "name": "https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:59:37 INFO - } 03:59:37 INFO - ], 03:59:37 INFO - "repository": "", 03:59:37 INFO - "rev": "9b28207cf3e3ae95bed79d9da9e45152a9a66387", 03:59:37 INFO - "who": "sendchange", 03:59:37 INFO - "when": 1447934328, 03:59:37 INFO - "number": 6682258, 03:59:37 INFO - "comments": "", 03:59:37 INFO - "project": "", 03:59:37 INFO - "at": "Thu 19 Nov 2015 03:58:48", 03:59:37 INFO - "branch": "fx-team-linux64-pgo-talos", 03:59:37 INFO - "revlink": "", 03:59:37 INFO - "properties": [ 03:59:37 INFO - [ 03:59:37 INFO - "buildid", 03:59:37 INFO - "20151119023034", 03:59:37 INFO - "Change" 03:59:37 INFO - ], 03:59:37 INFO - [ 03:59:37 INFO - "builduid", 03:59:37 INFO - "6e932f3f2459448b85328de9bde29884", 03:59:37 INFO - "Change" 03:59:37 INFO - ], 03:59:37 INFO - [ 03:59:37 INFO - "pgo_build", 03:59:37 INFO - "True", 03:59:37 INFO - "Change" 03:59:37 INFO - ] 03:59:37 INFO - ], 03:59:37 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:37 INFO - } 03:59:37 INFO - ], 03:59:37 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:37 INFO - } 03:59:37 INFO - } 03:59:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:59:37 INFO - Running post-action listener: _resource_record_post_action 03:59:37 INFO - ##### 03:59:37 INFO - ##### Running download-and-extract step. 03:59:37 INFO - ##### 03:59:37 INFO - Running pre-action listener: _resource_record_pre_action 03:59:37 INFO - Running main action method: download_and_extract 03:59:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:59: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')]} 03:59:37 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json 03:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json 03:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:59:52 INFO - Downloaded 1302 bytes. 03:59:52 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:59:52 INFO - Using the following test package requirements: 03:59:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:59:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'jsshell-linux-x86_64.zip'], 03:59:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:59:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:59:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:59:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:59:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:59:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:59:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:59:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:59:52 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')]} 03:59:52 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:59:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:59:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 03:59:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 03:59:55 INFO - Downloaded 22475277 bytes. 03:59:55 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 03:59:55 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:59:55 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 03:59:56 INFO - Return code: 0 03:59:56 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 03:59:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:59:56 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:59:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:59:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:59:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 03:59:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 04:00:15 INFO - Downloaded 22475277 bytes. 04:00:15 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 04:00:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:00:15 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 04:00:16 INFO - Return code: 0 04:00:16 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')]} 04:00:16 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 04:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 04:00:17 INFO - Downloaded 11130997 bytes. 04:00:17 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 04:00:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:17 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 04:00:17 INFO - Return code: 0 04:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:17 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 04:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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 04:00:24 INFO - Downloaded 57210179 bytes. 04:00:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:00:24 INFO - mkdir: /builds/slave/test-pgo/properties 04:00:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:00:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:00:24 INFO - Contents: 04:00:24 INFO - build_url:https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:00:24 INFO - Running post-action listener: _resource_record_post_action 04:00:24 INFO - Running post-action listener: set_extra_try_arguments 04:00:24 INFO - ##### 04:00:24 INFO - ##### Running populate-webroot step. 04:00:24 INFO - ##### 04:00:24 INFO - Running pre-action listener: _resource_record_pre_action 04:00:24 INFO - Running main action method: populate_webroot 04:00:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:24 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:00:24 INFO - '../fennec_ids.txt'], 04:00:24 INFO - 'tests': ['tcheck2']}, 04:00:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:24 INFO - '--tppagecycles', 04:00:24 INFO - '7'], 04:00:24 INFO - 'tests': ['tsvgm']}}, 04:00:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:00:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'tests': ['damp', 'tps']}, 04:00:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['damp', 'tps']}, 04:00:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:00:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:24 INFO - 'other': {'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'other_l64': {'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'other_nol64': {'tests': ['a11yr', 04:00:24 INFO - 'ts_paint', 04:00:24 INFO - 'tpaint', 04:00:24 INFO - 'sessionrestore', 04:00:24 INFO - 'sessionrestore_no_auto_restore']}, 04:00:24 INFO - 'svgr': {'tests': ['tsvgx', 04:00:24 INFO - 'tsvgr_opacity', 04:00:24 INFO - 'tart', 04:00:24 INFO - 'tscrollx', 04:00:24 INFO - 'cart']}, 04:00:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['tsvgx', 04:00:24 INFO - 'tsvgr_opacity', 04:00:24 INFO - 'tart', 04:00:24 INFO - 'tscrollx', 04:00:24 INFO - 'cart']}, 04:00:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'tests': ['tp5o']}, 04:00:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'talos_options': ['--e10s'], 04:00:24 INFO - 'tests': ['tp5o']}, 04:00:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'talos_options': ['--xperf_path', 04:00:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:24 INFO - 'tests': ['tp5n']}, 04:00:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:24 INFO - 'talos_options': ['--e10s', 04:00:24 INFO - '--xperf_path', 04:00:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:24 INFO - 'tests': ['tp5n']}}, 04:00:24 INFO - 'talos.zip': {'path': '', 04:00:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:24 INFO - Running post-action listener: _resource_record_post_action 04:00:24 INFO - ##### 04:00:24 INFO - ##### Running create-virtualenv step. 04:00:24 INFO - ##### 04:00:24 INFO - Running pre-action listener: _resource_record_pre_action 04:00:24 INFO - Running main action method: create_virtualenv 04:00:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:00:24 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 04:00:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:00:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:24 INFO - Using real prefix '/usr' 04:00:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:00:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:27 INFO - Installing pip.................done. 04:00:27 INFO - Return code: 0 04:00:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:00:27 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')]} 04:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:27 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')]} 04:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:27 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:27 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 04:00:27 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 04:00:27 INFO - Using env: {'DISPLAY': ':0', 04:00:27 INFO - 'HOME': '/home/cltbld', 04:00:27 INFO - 'LANG': 'en_US.UTF-8', 04:00:27 INFO - 'LANGUAGE': 'en_US:en', 04:00:27 INFO - 'LOGNAME': 'cltbld', 04:00:27 INFO - 'MAIL': '/var/mail/cltbld', 04:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:27 INFO - 'MOZ_NO_REMOTE': '1', 04:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:27 INFO - 'NO_EM_RESTART': '1', 04:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:27 INFO - 'SHELL': '/bin/bash', 04:00:27 INFO - 'SHLVL': '1', 04:00:27 INFO - 'TERM': 'linux', 04:00:27 INFO - 'TMOUT': '86400', 04:00:27 INFO - 'USER': 'cltbld', 04:00:27 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:27 INFO - '_': '/tools/buildbot/bin/python'} 04:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:27 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 04:00:27 INFO - Cleaning up... 04:00:27 INFO - Return code: 0 04:00:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:00:27 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')]} 04:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:27 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')]} 04:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:27 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:27 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 04:00:27 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 04:00:27 INFO - Using env: {'DISPLAY': ':0', 04:00:27 INFO - 'HOME': '/home/cltbld', 04:00:27 INFO - 'LANG': 'en_US.UTF-8', 04:00:27 INFO - 'LANGUAGE': 'en_US:en', 04:00:27 INFO - 'LOGNAME': 'cltbld', 04:00:27 INFO - 'MAIL': '/var/mail/cltbld', 04:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:27 INFO - 'MOZ_NO_REMOTE': '1', 04:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:27 INFO - 'NO_EM_RESTART': '1', 04:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:27 INFO - 'SHELL': '/bin/bash', 04:00:27 INFO - 'SHLVL': '1', 04:00:27 INFO - 'TERM': 'linux', 04:00:27 INFO - 'TMOUT': '86400', 04:00:27 INFO - 'USER': 'cltbld', 04:00:27 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:27 INFO - '_': '/tools/buildbot/bin/python'} 04:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:27 INFO - Downloading/unpacking psutil>=0.7.1 04:00:27 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 04:00:27 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 04:00:27 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 04:00:27 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 04:00:27 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 04:00:27 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 04:00:29 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:00:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:00:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:29 INFO - Installing collected packages: psutil 04:00:29 INFO - Running setup.py install for psutil 04:00:29 INFO - building 'psutil._psutil_linux' extension 04:00:29 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 04:00:29 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 04:00:29 INFO - building 'psutil._psutil_posix' extension 04:00:29 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 04:00:29 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 04:00:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:29 INFO - Successfully installed psutil 04:00:29 INFO - Cleaning up... 04:00:29 INFO - Return code: 0 04:00:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:00:29 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')]} 04:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:29 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')]} 04:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:29 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:29 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 04:00:29 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 04:00:29 INFO - Using env: {'DISPLAY': ':0', 04:00:29 INFO - 'HOME': '/home/cltbld', 04:00:29 INFO - 'LANG': 'en_US.UTF-8', 04:00:29 INFO - 'LANGUAGE': 'en_US:en', 04:00:29 INFO - 'LOGNAME': 'cltbld', 04:00:29 INFO - 'MAIL': '/var/mail/cltbld', 04:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:30 INFO - 'MOZ_NO_REMOTE': '1', 04:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:30 INFO - 'NO_EM_RESTART': '1', 04:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:30 INFO - 'SHELL': '/bin/bash', 04:00:30 INFO - 'SHLVL': '1', 04:00:30 INFO - 'TERM': 'linux', 04:00:30 INFO - 'TMOUT': '86400', 04:00:30 INFO - 'USER': 'cltbld', 04:00:30 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:30 INFO - '_': '/tools/buildbot/bin/python'} 04:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:00:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:00:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:00:31 INFO - Installing collected packages: mozsystemmonitor 04:00:31 INFO - Running setup.py install for mozsystemmonitor 04:00:31 INFO - Successfully installed mozsystemmonitor 04:00:31 INFO - Cleaning up... 04:00:32 INFO - Return code: 0 04:00:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:32 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:32 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 04:00:32 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 04:00:32 INFO - Using env: {'DISPLAY': ':0', 04:00:32 INFO - 'HOME': '/home/cltbld', 04:00:32 INFO - 'LANG': 'en_US.UTF-8', 04:00:32 INFO - 'LANGUAGE': 'en_US:en', 04:00:32 INFO - 'LOGNAME': 'cltbld', 04:00:32 INFO - 'MAIL': '/var/mail/cltbld', 04:00:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:32 INFO - 'MOZ_NO_REMOTE': '1', 04:00:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:32 INFO - 'NO_EM_RESTART': '1', 04:00:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:32 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:32 INFO - 'SHELL': '/bin/bash', 04:00:32 INFO - 'SHLVL': '1', 04:00:32 INFO - 'TERM': 'linux', 04:00:32 INFO - 'TMOUT': '86400', 04:00:32 INFO - 'USER': 'cltbld', 04:00:32 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:32 INFO - '_': '/tools/buildbot/bin/python'} 04:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:32 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:32 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 04:00:32 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 04:00:32 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 04:00:32 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 04:00:32 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 04:00:32 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 04:00:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:00:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:00:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:34 INFO - Downloading docopt-0.6.1.tar.gz 04:00:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:00:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:34 INFO - Running setup.py install for blobuploader 04:00:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:34 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:00:34 INFO - Running setup.py install for requests 04:00:35 INFO - Running setup.py install for docopt 04:00:35 INFO - Successfully installed blobuploader requests docopt 04:00:35 INFO - Cleaning up... 04:00:35 INFO - Return code: 0 04:00:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:35 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')]} 04:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:35 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')]} 04:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:35 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:35 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 04:00:35 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 04:00:35 INFO - Using env: {'DISPLAY': ':0', 04:00:35 INFO - 'HOME': '/home/cltbld', 04:00:35 INFO - 'LANG': 'en_US.UTF-8', 04:00:35 INFO - 'LANGUAGE': 'en_US:en', 04:00:35 INFO - 'LOGNAME': 'cltbld', 04:00:35 INFO - 'MAIL': '/var/mail/cltbld', 04:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:35 INFO - 'MOZ_NO_REMOTE': '1', 04:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:35 INFO - 'NO_EM_RESTART': '1', 04:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:35 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:35 INFO - 'SHELL': '/bin/bash', 04:00:35 INFO - 'SHLVL': '1', 04:00:35 INFO - 'TERM': 'linux', 04:00:35 INFO - 'TMOUT': '86400', 04:00:35 INFO - 'USER': 'cltbld', 04:00:35 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:35 INFO - '_': '/tools/buildbot/bin/python'} 04:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:35 INFO - Running setup.py (path:/tmp/pip-nWVHsC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:35 INFO - Running setup.py (path:/tmp/pip-KoQ1yi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:35 INFO - Running setup.py (path:/tmp/pip-uxOFBN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:35 INFO - Running setup.py (path:/tmp/pip-_kzvnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:35 INFO - Running setup.py (path:/tmp/pip-RUeXLP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:35 INFO - Running setup.py (path:/tmp/pip-VsgFb_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:35 INFO - Running setup.py (path:/tmp/pip-MTYneB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:35 INFO - Running setup.py (path:/tmp/pip-cp0iX8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:36 INFO - Running setup.py (path:/tmp/pip-b2cqcR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:36 INFO - Running setup.py (path:/tmp/pip-AfC1Yj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:36 INFO - Running setup.py (path:/tmp/pip-2USoqT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:36 INFO - Running setup.py (path:/tmp/pip-6U7bva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:36 INFO - Running setup.py (path:/tmp/pip-SGraHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:36 INFO - Running setup.py (path:/tmp/pip-n86tac-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:36 INFO - Running setup.py (path:/tmp/pip-6Zz1m4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:36 INFO - Running setup.py (path:/tmp/pip-wPA8pI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:36 INFO - Running setup.py (path:/tmp/pip-cEudEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:36 INFO - Running setup.py install for manifestparser 04:00:36 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:00:36 INFO - Running setup.py install for mozcrash 04:00:36 INFO - Running setup.py install for mozdebug 04:00:36 INFO - Running setup.py install for mozdevice 04:00:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozfile 04:00:37 INFO - Running setup.py install for mozhttpd 04:00:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozinfo 04:00:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozInstall 04:00:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozleak 04:00:37 INFO - Running setup.py install for mozlog 04:00:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for moznetwork 04:00:37 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozprocess 04:00:37 INFO - Running setup.py install for mozprofile 04:00:37 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:00:37 INFO - Running setup.py install for mozrunner 04:00:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:00:38 INFO - Running setup.py install for mozscreenshot 04:00:38 INFO - Running setup.py install for moztest 04:00:38 INFO - Running setup.py install for mozversion 04:00:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:00:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:38 INFO - Cleaning up... 04:00:38 INFO - Return code: 0 04:00:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:38 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:38 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 04:00:38 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 04:00:38 INFO - Using env: {'DISPLAY': ':0', 04:00:38 INFO - 'HOME': '/home/cltbld', 04:00:38 INFO - 'LANG': 'en_US.UTF-8', 04:00:38 INFO - 'LANGUAGE': 'en_US:en', 04:00:38 INFO - 'LOGNAME': 'cltbld', 04:00:38 INFO - 'MAIL': '/var/mail/cltbld', 04:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:38 INFO - 'MOZ_NO_REMOTE': '1', 04:00:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:38 INFO - 'NO_EM_RESTART': '1', 04:00:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:38 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:38 INFO - 'SHELL': '/bin/bash', 04:00:38 INFO - 'SHLVL': '1', 04:00:38 INFO - 'TERM': 'linux', 04:00:38 INFO - 'TMOUT': '86400', 04:00:38 INFO - 'USER': 'cltbld', 04:00:38 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:38 INFO - '_': '/tools/buildbot/bin/python'} 04:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:38 INFO - Running setup.py (path:/tmp/pip-b8aHdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:38 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)) 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:38 INFO - Running setup.py (path:/tmp/pip-vMEC0u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:38 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)) 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:38 INFO - Running setup.py (path:/tmp/pip-HRCFMt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:38 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)) 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:38 INFO - Running setup.py (path:/tmp/pip-QIug4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:38 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)) 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:38 INFO - Running setup.py (path:/tmp/pip-A4VN1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:38 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)) 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:39 INFO - Running setup.py (path:/tmp/pip-xyjsty-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:39 INFO - Running setup.py (path:/tmp/pip-GGul08-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:39 INFO - Running setup.py (path:/tmp/pip-04uCLC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:39 INFO - Running setup.py (path:/tmp/pip-Honq5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:39 INFO - Running setup.py (path:/tmp/pip-QgWXs5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:39 INFO - Running setup.py (path:/tmp/pip-czULjC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:39 INFO - Running setup.py (path:/tmp/pip-yNY_DC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:39 INFO - Running setup.py (path:/tmp/pip-94PLwb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:39 INFO - Running setup.py (path:/tmp/pip-W6kuFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:39 INFO - Running setup.py (path:/tmp/pip-RLrw5X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:39 INFO - Running setup.py (path:/tmp/pip-vyPvH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:39 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)) 04:00:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:39 INFO - Running setup.py (path:/tmp/pip-HEb8xs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:39 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)) 04:00:39 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)) 04:00:39 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)) 04:00:39 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)) 04:00:39 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)) 04:00:39 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)) 04:00:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:39 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 04:00:39 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 04:00:39 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 04:00:39 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 04:00:39 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 04:00:39 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 04:00:41 INFO - Downloading blessings-1.5.1.tar.gz 04:00:41 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 04:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:41 INFO - Installing collected packages: blessings 04:00:41 INFO - Running setup.py install for blessings 04:00:41 INFO - Successfully installed blessings 04:00:41 INFO - Cleaning up... 04:00:41 INFO - Return code: 0 04:00:41 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:00:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:00:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:00:41 INFO - Reading from file tmpfile_stdout 04:00:41 INFO - Current package versions: 04:00:41 INFO - argparse == 1.2.1 04:00:41 INFO - blessings == 1.5.1 04:00:41 INFO - blobuploader == 1.2.4 04:00:41 INFO - docopt == 0.6.1 04:00:41 INFO - manifestparser == 1.1 04:00:41 INFO - mozInstall == 1.12 04:00:41 INFO - mozcrash == 0.16 04:00:41 INFO - mozdebug == 0.1 04:00:41 INFO - mozdevice == 0.47 04:00:41 INFO - mozfile == 1.2 04:00:41 INFO - mozhttpd == 0.7 04:00:41 INFO - mozinfo == 0.9 04:00:41 INFO - mozleak == 0.1 04:00:41 INFO - mozlog == 3.0 04:00:41 INFO - moznetwork == 0.27 04:00:41 INFO - mozprocess == 0.22 04:00:41 INFO - mozprofile == 0.27 04:00:41 INFO - mozrunner == 6.11 04:00:41 INFO - mozscreenshot == 0.1 04:00:41 INFO - mozsystemmonitor == 0.0 04:00:41 INFO - moztest == 0.7 04:00:41 INFO - mozversion == 1.4 04:00:41 INFO - psutil == 3.1.1 04:00:41 INFO - requests == 1.2.3 04:00:41 INFO - wsgiref == 0.1.2 04:00:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:41 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 0x7f3772f8cc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20836c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21357c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', '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 04:00:41 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 04:00:41 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 04:00:41 INFO - Using env: {'DISPLAY': ':0', 04:00:41 INFO - 'HOME': '/home/cltbld', 04:00:41 INFO - 'LANG': 'en_US.UTF-8', 04:00:41 INFO - 'LANGUAGE': 'en_US:en', 04:00:41 INFO - 'LOGNAME': 'cltbld', 04:00:41 INFO - 'MAIL': '/var/mail/cltbld', 04:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:41 INFO - 'MOZ_NO_REMOTE': '1', 04:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:41 INFO - 'NO_EM_RESTART': '1', 04:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:41 INFO - 'SHELL': '/bin/bash', 04:00:41 INFO - 'SHLVL': '1', 04:00:41 INFO - 'TERM': 'linux', 04:00:41 INFO - 'TMOUT': '86400', 04:00:41 INFO - 'USER': 'cltbld', 04:00:41 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:41 INFO - '_': '/tools/buildbot/bin/python'} 04:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 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)) 04:00:42 INFO - Cleaning up... 04:00:42 INFO - Return code: 0 04:00:42 INFO - Running post-action listener: _resource_record_post_action 04:00:42 INFO - Running post-action listener: _start_resource_monitoring 04:00:42 INFO - Starting resource monitoring. 04:00:42 INFO - ##### 04:00:42 INFO - ##### Running install step. 04:00:42 INFO - ##### 04:00:42 INFO - Running pre-action listener: _resource_record_pre_action 04:00:42 INFO - Running main action method: install 04:00:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:00:42 INFO - Reading from file tmpfile_stdout 04:00:42 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:00:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:00:42 INFO - Reading from file tmpfile_stdout 04:00:42 INFO - Output received: 04:00:42 INFO - Usage: mozinstall [options] installer 04:00:42 INFO - Options: 04:00:42 INFO - -h, --help show this help message and exit 04:00:42 INFO - -d DEST, --destination=DEST 04:00:42 INFO - Directory to install application into. [default: 04:00:42 INFO - "/builds/slave/test-pgo"] 04:00:42 INFO - --app=APP Application being installed. [default: firefox] 04:00:42 INFO - mkdir: /builds/slave/test-pgo/build/application 04:00:42 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'] 04:00:42 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 04:00:56 INFO - Reading from file tmpfile_stdout 04:00:56 INFO - Output received: 04:00:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:00:56 INFO - Running post-action listener: _resource_record_post_action 04:00:56 INFO - ##### 04:00:56 INFO - ##### Running run-tests step. 04:00:56 INFO - ##### 04:00:56 INFO - Running pre-action listener: _resource_record_pre_action 04:00:56 INFO - Running main action method: run_tests 04:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:00:56 INFO - Python 2.7.3 04:00:56 INFO - Return code: 0 04:00:56 INFO - grabbing minidump binary from tooltool 04:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:56 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 0x2179d70>, '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 0x217ab20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x217afb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:00:56 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 04:00:56 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 04:00:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:57 INFO - Return code: 0 04:00:57 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:00:57 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:00:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:00:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 04:00:57 INFO - Using env: {'DISPLAY': ':0', 04:00:57 INFO - 'HOME': '/home/cltbld', 04:00:57 INFO - 'LANG': 'en_US.UTF-8', 04:00:57 INFO - 'LANGUAGE': 'en_US:en', 04:00:57 INFO - 'LOGNAME': 'cltbld', 04:00:57 INFO - 'MAIL': '/var/mail/cltbld', 04:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:57 INFO - 'MOZ_NO_REMOTE': '1', 04:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:57 INFO - 'NO_EM_RESTART': '1', 04:00:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:00:57 INFO - 'SHELL': '/bin/bash', 04:00:57 INFO - 'SHLVL': '1', 04:00:57 INFO - 'TERM': 'linux', 04:00:57 INFO - 'TMOUT': '86400', 04:00:57 INFO - 'USER': 'cltbld', 04:00:57 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576', 04:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:57 INFO - '_': '/tools/buildbot/bin/python'} 04:00:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 04:00:57 INFO - mozversion INFO | application_buildid: 20151119023034 04:00:57 INFO - mozversion INFO | application_changeset: 9b28207cf3e3ae95bed79d9da9e45152a9a66387 04:00:57 INFO - mozversion INFO | application_display_name: Nightly 04:00:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:57 INFO - mozversion INFO | application_name: Firefox 04:00:57 INFO - mozversion INFO | application_remotingname: firefox 04:00:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:00:57 INFO - mozversion INFO | application_vendor: Mozilla 04:00:57 INFO - mozversion INFO | application_version: 45.0a1 04:00:57 INFO - mozversion INFO | platform_buildid: 20151119023034 04:00:57 INFO - mozversion INFO | platform_changeset: 9b28207cf3e3ae95bed79d9da9e45152a9a66387 04:00:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:00:57 INFO - mozversion INFO | platform_version: 45.0a1 04:00:57 INFO - 2015-11-19 04:00:57,230 DEBUG : using testdate: 1447934457 04:00:57 INFO - 2015-11-19 04:00:57,230 DEBUG : actual date: 1447934457 04:00:57 INFO - 2015-11-19 04:00:57,279 INFO : starting webserver on 'localhost:40514' 04:00:57 INFO - 2015-11-19 04:00:57,280 INFO : Starting test suite talos-linux64-ix-058 04:00:57 INFO - 2015-11-19 04:00:57,280 INFO : Starting test dromaeo_css 04:00:57 INFO - 2015-11-19 04:00:57,280 DEBUG : operating with platform_type : linux_ 04:00:57 INFO - 2015-11-19 04:00:57,281 INFO : Initialising browser for dromaeo_css test... 04:00:57 INFO - 2015-11-19 04:00:57,298 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ5Bj6y/profile http://localhost:40514/getInfo.html 04:01:01 INFO - 2015-11-19 04:01:01,932 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:01:01 INFO - 2015-11-19 04:01:01,932 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:01:01 INFO - 2015-11-19 04:01:01,932 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:01:01 INFO - 2015-11-19 04:01:01,932 DEBUG : BROWSER_OUTPUT: __metrics 04:01:02 INFO - 2015-11-19 04:01:02,053 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:01:03 INFO - 2015-11-19 04:01:03,220 INFO : Browser initialized. 04:01:03 INFO - 2015-11-19 04:01:03,220 INFO : Running cycle 1/1 for dromaeo_css test... 04:01:03 INFO - 2015-11-19 04:01:03,220 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ5Bj6y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:01:14 INFO - 2015-11-19 04:01:14,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 140169216 04:01:14 INFO - 2015-11-19 04:01:14,918 DEBUG : BROWSER_OUTPUT: 04:02:06 INFO - 2015-11-19 04:02:06,462 DEBUG : BROWSER_OUTPUT: 1447934526461 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] 04:04:14 INFO - 2015-11-19 04:04:14,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40514/tests/dromaeo/cssquery-ext.html) 04:04:15 INFO - 2015-11-19 04:04:15,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 233934848 04:04:15 INFO - 2015-11-19 04:04:15,822 DEBUG : BROWSER_OUTPUT: 04:07:18 INFO - 2015-11-19 04:07:18,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-ext.html (next: http://localhost:40514/tests/dromaeo/cssquery-jquery.html) 04:07:18 INFO - 2015-11-19 04:07:18,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 227880960 04:07:18 INFO - 2015-11-19 04:07:18,653 DEBUG : BROWSER_OUTPUT: 04:10:20 INFO - 2015-11-19 04:10:20,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40514/tests/dromaeo/cssquery-mootools.html) 04:10:20 INFO - 2015-11-19 04:10:20,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 211169280 04:10:20 INFO - 2015-11-19 04:10:20,998 DEBUG : BROWSER_OUTPUT: 04:13:22 INFO - 2015-11-19 04:13:22,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40514/tests/dromaeo/cssquery-prototype.html) 04:13:23 INFO - 2015-11-19 04:13:23,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 198000640 04:13:23 INFO - 2015-11-19 04:13:23,448 DEBUG : BROWSER_OUTPUT: 04:16:25 INFO - 2015-11-19 04:16:25,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40514/tests/dromaeo/cssquery-yui.html) 04:16:26 INFO - 2015-11-19 04:16:26,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 203702272 04:16:26 INFO - 2015-11-19 04:16:26,511 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,018 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/dromaeo/cssquery-yui.html (next: http://localhost:40514/tests/dromaeo/cssquery-dojo.html) 04:19:29 INFO - 2015-11-19 04:19:29,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 250028032 04:19:29 INFO - 2015-11-19 04:19:29,268 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,269 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:19:29 INFO - 2015-11-19 04:19:29,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:19:29 INFO - 2015-11-19 04:19:29,269 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:19:29 INFO - 2015-11-19 04:19:29,269 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:19:29 INFO - 2015-11-19 04:19:29,271 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3210.197450637341;3244.15651930498;3276.2955964467633;3287.8356082195883;3300.7524435667333;5245.082110630634;5322.893542129155;5350.822818979823;5360.919586206205;5365.651232669874;5330.573554115671;5413.377461591918;5485.890282194354;5489.972550137244;5496.890062198753;4908.63185261106;4946.431160416544;5019.347484826967;5098.643094983353;5154.974225128869;4834.178189707741;5101.744912754348;5125.3080834087295;5128.53843154116;5171.4311425743135;4865.27020946859;4903.705777653335;4985.302057711923;4991;5018.774155163026;4929.433115191727;4938.925916111261;4959.504049595048;4964.751762411865;4976.178930476467;4901.852944411673;4934.703917764946;4937.753112344404;4958.727270000149;4985.376827896513;5154.304168937183;5217.243499692561;5250.159974404077;5340.305760251143;5378.354597448331;5887.381824908366;5917.497012753921;5918.585699001072;5923.17075609415;5930.614510056833;5749.051406517961;5957.136215248808;5960.940390596125;5962.07587823888;5963.165156877997;5504.2018907258225;5560.249366335493;5561.138023606267;5569.610127291091;5605.887882242373;6030.819075427744;6058.1518587397795;6079.179310792986;6086.908696369558;6139.4781443577795;5598.944010559842;5706.400827913092;5871.823845284648;5880.441358070976;5920.378360272195;5692.117721753135;5741.282339707536;5802.564807639444;5810.6513609183585;5855.648661080349;5901.321348044944;5926.525877929756;5927.585069045212;5930.318013428425;5930.436608522184;5663.688497132614;5719;5801.593888427854;5872.471477567039;5873.295204575478;4451.354553589711;4462.709923855004;4496.572825581565;4502.099580083996;4575.839845605455;3954.6638535724787;3958.129211573449;3979.1047014421524;3979.46277252573;3998.9600103998587;5328.413874473805;5427.83716488506;5437;5499.50504454601;5515.531179849758;5809.448102430262;5826.621269617462;5847.736851841677;5850.5027072699295;5854.531637468992;5514.779408823682;5535.446455354513;5535.916961245584;5536.252605898233;5537.640053396516;5040.193569028937;5105.463926287686;5152.587792976553;5175.637705360664;5206.97396513015;5998.640081595118;6004.249468816398;6006.489448396936;6007.15899774032;6007.879842403215;5677.290338707661;5822.912656310074;5830.854228644318;5833.533317334518;5841.883162336644;5975.940240597713;6026.7287972040485;6034.275886893425;6050.818475445743;6070.423309785563;5818.185454036354;5828.562857785599;5831.7375718093635;5834.066549352084;5846;5659.603827732184;5792.652440853562;5976.9103463448955;5993.430624090704;6004.459598636144;5722.828315150552;5791.478766910998;5792.362840087671;5796.507296879644;5844.094165404369;5676.659400435987;5679.233303503974;5680.176374425768;5693.089105743061;5708.172315014383;5402.270693456333;5507.03626865289;5571;5654.434556544313;5661.603687741818;5746.224259725051;5756.884862302814;5764.596478246483;5771.249737534094;5800.970995144998;5603.7758489659955;5618.129189975561;5623.156526520891;5623.775048997994;5635.380108188014 04:19:29 INFO - 2015-11-19 04:19:29,274 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.0954827050853;604.0667169223549;607.5595193484721;614.0696844280914;617.1729881958175;31752.523712144306;32526.349473010527;40027;40451.59548404515;40564;43983.78008109963;44429.555704442944;44643.33035004469;44665;44673.77663111688;7513.511621744597;7637.045369328834;8663.263622592087;8842.690505832297;8852.645894164225;10421.374717516974;10630;10643.308184967991;10644.254902156852;10644.893551064506;10327.948360258226;10428.113610343129;10432.165426765878;10442.947785261063;10450.05949464548;7646.197149299327;7782.610869456505;7796.415268854802;10169.898301017007;10247.38515689061;9761.902380976171;9867.506624668738;9868.309218354718;9870.802583948353;9886.060824221688;36831.263374732625;37293.44059839105;37323.25353492915;37382;37383.4392484113;3330.4837750148768;3392.0671815251003;3409.335179639971;3445.9827700861333;3723.3484140275345;29735.25661858471;30449;30720;30912.845435772902;31479;3530.8058056806867;3550.378683730363;3590.299891521154;3594.6405359464106;3642.690371318441;257108;259325;259407;264033;264487;57573.712131439075;58093.70953145207;58548.70725646344;58589.121163182586;58702.412975870546;60695.69652151711;61383.69308153431;61856.38143618596;61931.690341548005;61945.69027154835;15430.845691543165;15983.920080399523;16091.839081609269;16093.275802588678;16170.35318587267;12484.313362765135;12571.18287311322;12577.496900124075;12584.937075314565;12589.496420143092;19131.426057218305;19925.900370498053;19938.501537461678;19970.10134543949;19983;8060.274575288252;8134.959325203455;8189;8304.384119002494;8380.312662428512;954.9379290346105;959.9088086631759;1006.8389057750725;1033.4625994482826;1092.6776600902754;25488.235352939442;25568.48863022729;26006.34984125412;26030.34924126874;26287.868560657458;969.8302797010637;1004.3421558878946;1035.2028937717914;1067.0260018964852;1088.5917780832187;13927.58217253484;14235.715285694228;15284.770728439082;15547.30037148331;15817.022872140982;317153;322129;322445;322632;323243;45149;45840.3123953141;56390.71804640951;56748.432515674314;57038.42961570414;1347.5014244729514;1366.3441548056987;1367.4803574641574;1368.117564171104;1510.3731951240331;24298.63552046756;27338;27870.16389508318;28304.575431368958;28468.430631386844;48102.27846582234;48169.518304816505;48715.756421217666;48723.5127648719;48755.512444875094;264260;267089;267173;267308;267351;30803.53794693126;31239.68760312459;31275.68724312728;31309.53035704421;32423.513647294836;38858.61141388663;40065.399019014156;40069.79965100156;40177.79911100426;40210.39684404795;32163.35673286568;33243.66756332503;34940;35862.820685896404;36662;35104;35488.290234194654;35970.28059438849;36165.276694465436;36188.09529761777;35058.64941350554;35534.46698299579;35627.64372356347;35894.28211435705;36162.4575631371;31046.68953310438;32510.18724531811;32599.837000814845;32858;32876.342473149925;24412.26763197107;24557.140500082412;24749;25010;25020.49959000846 04:19:29 INFO - 2015-11-19 04:19:29,274 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.3094734320731;353.94159963606006;354.55503343304156;355.17599169925774;355.8114199474276;14332.785008224859;14573.641873059634;16327.75508367374;16738.246778894947;17434.38979635713;15875.285612147452;17006.82993170068;17370.826291737078;17412.477625671218;17430.128493575336;5344.118220493614;5488.835334939959;5490.423505531921;5493.92868390664;5495.642783219078;4028.7582745035393;4156.54278029418;5437.32033495813;5499.587530935176;5919.911201331984;6024.96987515064;6089.299730531001;6091.42131497507;6124.265088189423;6146.6312021278645;4746.121967436035;4827.517248275197;4836;4838.298446725205;6055.182550355689;3993.7204395692315;4199.139176468817;4202.579742025773;4203.62167404935;4225.450691410128;13451.32743362828;13598.728025439535;13820;13843.515476958259;13907.930460347734;2008.839292856568;2017.3443630819895;2025.5138766696034;2063.4119276006268;2128.88291143987;9796.510174491246;10107.191424686007;10191.89808101917;10281.383117013003;10342.37945723259;1729.455221605203;1789.6510180514804;1807.1235450806348;1823.5714607067328;1893.6212757448427;59115.113273300936;60965.47586310333;65510.67244663794;66465.66767166181;66529;12151.817722734166;14766.040207386486;15200.087994720352;15546.611334716496;16219.756703649455;23752;23769.881150594138;23881.40296492567;23890.88054559716;23930.88034559816;9374.625014999323;9399;9451.432914025181;9471.052894710612;9513.952430237805;8063.435559510778;8068.556229407322;8149.714759983491;8160.5103693778565;8199.262066414052;7695.307422332017;7859.607019649109;7878.763637090782;7925.445218834626;7969.840603187904;1146.18620779246;1147.8909503597145;1157.1148071725138;2119.1311562259707;3047.024952015334;466.216755850175;468.67192964924686;493.1714719271586;496.2704823908848;513.4095789841712;11500.827487587692;11534.538618455168;11659.06727461801;11678.941605291919;12020.218685785396;491.0449176351961;493.33892583937694;497.1349851258856;513.537815965634;522.9372475302988;6241.065269766387;6555.147830781968;6581.473482121419;6594.934050659432;6604.537682362188;479098;479375;527974;542172.0479566471;548948;71799.28200717927;76458.61770691111;77118.6144069276;77634.6118269405;78192.60903695445;541.6452223793422;551.2750732786374;552.149689478207;553.2061491759338;553.8393865779041;10498.47507624631;10553.736156596147;10560.894391056298;10785.730356741144;10805.51375188134;34767.82616086904;35012;36053;36060.45909311415;36444.81777591095;45793;47101;47304.7634761824;47553.28670069882;47599.52400475951;6677.465802735673;6703.195616526048;6785.59286442815;6796.694148763218;6803.115594972622;11822.231554948901;12089.455974480994;12226.44980975876;12368.75262494763;12443.128980971245;10566.8943310569;10578.629747958785;10820.188485863435;10822.837657435302;10865.674029779118;10395.480225988518;10548.789024219319;10798.568057277935;10841.783164336512;11013.669589912315;11304.604338848101;11480.368579727861;11554.884451155382;11560.132990025613;11615.361155136548;6471.288158302677;6733.091032710521;6735.0570920072205;6737.124173857564;6740.685566314522;10239;10261.692149235534;10513.369197848153;10576.524056417325;10638.308509946828 04:19:29 INFO - 2015-11-19 04:19:29,278 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1285.0362228328754;1731.4545918035817;1737.6698427298813;1773.4768243368205;1797.9730304045443;6719.328067193284;7127.2160062393095;7167.89248161278;7231.132264128299;7237.131544214689;7062.788116356504;7260.818479538014;7263.527870688415;7266.636668166597;7267.309605587474;1940.1463356123331;1972.36884197057;2224.510607666311;2229.8662080275235;2249.5275992041693;2233.0286325448483;2234.7988681018705;2236.932892013234;2239.9552008959813;2241.1371621925596;2187.1907394264144;2247.6291411917014;2250.5386395788823;2251.966220506694;2252.200468833565;1910.8853468791847;1954.7458830352034;2168.793964573363;2227.1425501182;2235.251190851067;2215.789499997498;2226.866388016724;2247.1573160064977;2248.022110381989;2268.852524585897;7198.064251647304;7221.602811845346;7237.3848222901115;7284.599347035911;7348.412127029825;4643.233866412072;4677.532246775329;4703.15343238217;4707.176244157293;4719.032598317371;3168.8732450701946;3178.1895616617844;3190.633077196129;3223.2425380035675;3241.173500757315;1151.4070253819207;1900.6198760247867;1934.8742331748392;1962.9705554416696;1980.3761815028365;10170.745731356701;10246.692599222035;10262;10277.126444252248;10286.639967601099;4095.2628526864855;4157.438745769343;4201.970517223239;4222.577742225752;4235.02594403289;8430.957845210734;8437.156284371637;8440.198181172778;8443.704470343508;8445.071042185355;4614.930776038362;4636.4899861015265;4643.117807616542;4647.721136731807;4649.372334734835;4271.978640106841;4274.572542745701;4275.016746148403;4278.122984788173;4283.828646854154;3451.9827400863337;3481.164520515058;3512.840762548353;3513.1217195701074;3518.4546395308766;1092.5520536580123;1105.2926127278547;1111.1777284809184;1121.0751130317522;1130.1862658885589;938.4041133880036;1277.6997405609675;1304.2761267496442;1332.2938842413537;1335.3857225676297;6202.038684003986;6304.338044505261;6938.583684978817;7024.473164512682;7041.753538626226;675.7195763758084;676.7157793726647;684.6337209592843;701.1866235167182;706.8515611721596;5613.691246981455;5651.124075768263;5651.463111004448;5654.660720356792;5659.292588426447;8389.664413423518;8470.957645211734;8580.742577722678;8698.217160455462;8769.473831570127;8600.8709869352;8609.61256743448;8624.353173511887;8626.051134375213;8627.352948528885;6704.094947182166;6831.795046148524;6838.427161752825;6896.379325860697;6910.654467276616;6502.447291980235;6525.1517302750335;6531.902021469777;6547.410733034049;6575.704093315908;7542.622868856425;7604.543727376154;7614.619269036637;7715.074191097105;7750.7674769756995;7644.464887457824;7844.843103137791;7850.803729906798;7851.254130857559;7902.24928631779;6399.6800159992745;6449.258335291313;6454.903176452451;6460.967695161494;6464.903026454513;7108.502404831612;7236.312550307713;7242.094738157731;7253;7264.055672762507;6780.457563395015;6833.077534532775;6865.897011544731;6921.342472465108;6938.375546200866;6652.467802575686;6740.831479212863;6745.86508269822;6793.592384456949;6853.4859885507785;6013.9097913532205;6109.541784366102;6743.325667433218;6804.6257455840405;6805.183377994672;6259.655718935503;6375;6424.38968298011;6428.389303016206;6429.485641148791;6054.66699331541;6059.242594675666;6062.42406971337;6063.878722425438;6072.392760723892 04:19:29 INFO - 2015-11-19 04:19:29,278 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.55125478095016;329.27230819888047;329.6555099920584;333.6546674192211;334.3346739987424;6083;6139.109829074787;6143.8156855294355;6170.105334726468;6239.84562855872;5978.790742324019;6084.178635884155;6124.510039196864;6130.509559235262;6165.16770236018;4732.597729193014;4734.952650473486;4735.242361222206;4736.9526304736855;4738.502457241992;4543.3639290499195;4577.33628623851;4642.721436713791;4727.22000869856;4732.100900828848;4655.511171327013;4660.16117098922;4666.2767271073035;4669.556392142758;4676.041411510632;4629.907401851961;4648.674592778507;4651.046535460223;4663.953360466386;4695.976520117411;4071.3485842265095;4084.8774536763945;4087.346024636044;4095.631393174599;4097.303458412077;5736.110902810071;5835.124731290298;5856.677882716449;5870.148828419855;5893.410658934115;5437.265969094161;5476.780928762844;5482.80810171646;5487.75305111271;5511.807086751945;6219.129321894939;6533.41199292066;6544.312847151075;6547;6547.214334279917;4410.580994805488;4461.910761784746;4565.794539245742;4578.267477203632;4582.381378513891;6769.7292108315605;6795.7961261162245;6805.523613347018;6810.216825065131;6814.386705196556;4675.859724208279;4691.1001044577;4694.248920172824;4696.412948381452;4702.224133018014;4652.930206046912;4739.620830333565;4742.099001189763;4752.619790416758;4774.164521208774;5464.7814087436855;5476.315460567429;5480.451954804567;5482.725863706878;5490.69801160932;6535.019747037983;6583.308752581006;6589.6375699336995;6599.340065993362;6613.074169616258;1659;1692.2384926782997;1692.6445446456137;1694.5594145522252;1695.6439147779104;1105.182165197748;1128.6219116596033;1138.0497284767146;1139.5100106953923;1139.8575178102737;6377.5216858735785;6392.808215753442;6399.8080057598345;6402.231732192166;6413.647249401234;6757.831054223586;6790.32096790317;6796.898046529306;6803.523753337317;6804.11546498952;6296.6851657417865;6394;6397.392247736458;6402.391772781578;6407.967960160169;3671.284099600552;3693.722970777149;3699.9260014800093;3700.7779533227554;3703.7407381483577;6988.126484189476;6997.195322537973;6999.475039372068;7000.439964802804;7007.789766307019;6810.6254156020905;6952.7403593831195;6955.6869940852785;6956.060931774247;6961.61711105894;6992.370686638227;6999.370056694922;7000;7017.508774385744;7022.40309573692;6567.638779867153;6654.035164900965;6754.12196414463;6770.187577490733;6770.255271919987;6711.362420570038;6725.798226053226;6810.046593476818;6811.421029212573;6816.318368163144;7014.088168538057;7022.894656580258;7025.964870175617;7036.648167591497;7104.756667583256;4652.55800698933;4727.101850648366;4728.976355118202;4742.099001189763;4744.810207591658;6806.727730890907;6822.283660215606;6829.624370659462;6833.658317084225;6836.555623884432;6637.502187335873;6639.900401494078;6661.233958094881;6663.466922646274;6677.3656502632175;6473.449756770538;6634.933650663625;6642.269350371552;6649.534532582673;6651.0023496475915;6512.544121911421;6516.413522782972;6519;6521.413072823469;6522.967385163044;6644.634545100066;6661.533692641468;6674.632895190811;6678.799636010927;6684.131062961784;6335.1130841683125;6473.546851720334;6478.546501744832;6481.546291759721;6506.284308726131 04:19:29 INFO - 2015-11-19 04:19:29,279 DEBUG : BROWSER_OUTPUT: |5;yui.html;785.2971590426572;805.2310043908068;828.3249151941171;872.995635021825;881.4887365328109;13968.6507837304;14221;14222;14262.144271343714;14298.28508574571;12872.678183045406;12942.611721648342;13388;13414.26221557814;13417.798733018988;689.9068625735512;694.6422592364936;821.8191997760498;829.713748756681;841.9915800841975;844.7254642241265;847.5677404523707;854;855.7646647172046;856.3320609924269;887;894.592960203106;894.7092195036606;895.4269267668698;896.2292428511475;716.3517017099533;723.4827098624482;860.7934095817021;883.3066043156092;883.7216276872829;651.9608823470606;653.343389893159;653.506602515098;653.5359894474929;653.9509536784713;13064.934675326658;13097.083204175711;13145.21128732279;13172.143810652276;13178.406971686201;12572.874271257262;12653.177543459646;12846.550370737074;13213.273269970148;13313.871813010059;9894.703158905173;9929.851052234222;10078.697639070839;10256.179505639606;10275.89724102757;3224.0650211438656;3255.2187475006067;3281.3109247058146;3343.665633436661;3353;40350.192996140206;40549.9999999997;40583.39124913129;40618.18763624741;40781.9999999997;7342.339189472973;7404.777856664308;7405.407567394704;7420.109586849612;7431.554106753612;11508.827367589492;11763.764724705628;11783.705407364885;11797.115216358807;11800.055995520337;6692.364225398579;6913.032175495435;6948.409385202314;6978.267281935425;7024.483325796641;4195.181939521825;4231.703780735381;4269.103488267437;4317.935230971538;4322.654187664979;2788.344738986337;2805.9719402806118;2811.451766905475;2821.3792965547545;2826.3358110843933;446.1033323020687;446.4642429085111;460.49115727121716;473.5296903115776;479.51089888313726;578.3580225949192;581.6451964301773;689.8309914070984;690.9378155965987;718.3104219948907;8833.056333318294;8931.374803763803;9013.594388252544;9020.639174433081;9099.954500227457;582.9504492118133;602.2652364115771;678.2640834694412;701.8982247574073;711.5766119159196;4173.290540608104;4223.239816832999;4406.449193850769;4478.552144785495;4578.381918441034;54667.179992300145;55559.72220138874;60023;60175.09737353943;60217.397826022054;51312.74343628332;52218.47781522212;52336.47663523316;52357.47642523526;52738.47261527412;46555.767221163675;46806.76596616995;47755;47852.7607361961;48429.75785121052;8805.295576353748;8963.193312601898;9198.586063627019;9199.678011269574;9227.584758685742;33666.15834604154;34216.315673686884;34626.48060279148;34777;35147.82426087853;44319.33520997252;44788.77605611951;44947.32579011383;45947;46813.76593117149;8003.5197888126895;8029.434260319415;8169.632366543401;8308.044574873968;8407.915920840713;12518.436670350038;12543.372831358212;12655.493780248687;12783.552575659807;12838.16551924122;11542.94228528852;11840.76318473643;11913.761724765283;12199.14605977573;12227.205231659913;10951.598246075668;11934.104942129548;12084.274943503418;12086.758264834478;12452.252864828139;7701.653425595974;10598.576056957943;10937;11284.887151128383;11763.47064382122;9742.366746161477;9751.707448776548;9863.901360986298;10294.588216471257;10399.94800025995;8125.634346454542;9463.195628371666;9640.276979226446;9711.115553778545;9940.701778946643 04:19:29 INFO - 2015-11-19 04:19:29,279 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:19:29 INFO - 2015-11-19 04:19:29,279 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:19:29 INFO - 2015-11-19 04:19:29,279 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,788 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935569268__endTimestamp 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5436.67 Median:5623.78 stddev:609.50 (10.8%) stddev-sans-first:585.80 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: Values: 3210.2 3244.2 3276.3 3287.8 3300.8 5245.1 5322.9 5350.8 5360.9 5365.7 5330.6 5413.4 5485.9 5490.0 5496.9 4908.6 4946.4 5019.3 5098.6 5155.0 4834.2 5101.7 5125.3 5128.5 5171.4 4865.3 4903.7 4985.3 4991.0 5018.8 4929.4 4938.9 4959.5 4964.8 4976.2 4901.9 4934.7 4937.8 4958.7 4985.4 5154.3 5217.2 5250.2 5340.3 5378.4 5887.4 5917.5 5918.6 5923.2 5930.6 5749.1 5957.1 5960.9 5962.1 5963.2 5504.2 5560.2 5561.1 5569.6 5605.9 6030.8 6058.2 6079.2 6086.9 6139.5 5598.9 5706.4 5871.8 5880.4 5920.4 5692.1 5741.3 5802.6 5810.7 5855.6 5901.3 5926.5 5927.6 5930.3 5930.4 5663.7 5719.0 5801.6 5872.5 5873.3 4451.4 4462.7 4496.6 4502.1 4575.8 3954.7 3958.1 3979.1 3979.5 3999.0 5328.4 5427.8 5437.0 5499.5 5515.5 5809.4 5826.6 5847.7 5850.5 5854.5 5514.8 5535.4 5535.9 5536.3 5537.6 5040.2 5105.5 5152.6 5175.6 5207.0 5998.6 6004.2 6006.5 6007.2 6007.9 5677.3 5822.9 5830.9 5833.5 5841.9 5975.9 6026.7 6034.3 6050.8 6070.4 5818.2 5828.6 5831.7 5834.1 5846.0 5659.6 5792.7 5976.9 5993.4 6004.5 5722.8 5791.5 5792.4 5796.5 5844.1 5676.7 5679.2 5680.2 5693.1 5708.2 5402.3 5507.0 5571.0 5654.4 5661.6 5746.2 5756.9 5764.6 5771.2 5801.0 5603.8 5618.1 5623.2 5623.8 5635.4 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45474.42 Median:32867.17 stddev:74196.52 (225.7%) stddev-sans-first:74328.04 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: Values: 567.1 604.1 607.6 614.1 617.2 31752.5 32526.3 40027.0 40451.6 40564.0 43983.8 44429.6 44643.3 44665.0 44673.8 7513.5 7637.0 8663.3 8842.7 8852.6 10421.4 10630.0 10643.3 10644.3 10644.9 10327.9 10428.1 10432.2 10442.9 10450.1 7646.2 7782.6 7796.4 10169.9 10247.4 9761.9 9867.5 9868.3 9870.8 9886.1 36831.3 37293.4 37323.3 37382.0 37383.4 3330.5 3392.1 3409.3 3446.0 3723.3 29735.3 30449.0 30720.0 30912.8 31479.0 3530.8 3550.4 3590.3 3594.6 3642.7 257108.0 259325.0 259407.0 264033.0 264487.0 57573.7 58093.7 58548.7 58589.1 58702.4 60695.7 61383.7 61856.4 61931.7 61945.7 15430.8 15983.9 16091.8 16093.3 16170.4 12484.3 12571.2 12577.5 12584.9 12589.5 19131.4 19925.9 19938.5 19970.1 19983.0 8060.3 8135.0 8189.0 8304.4 8380.3 954.9 959.9 1006.8 1033.5 1092.7 25488.2 25568.5 26006.3 26030.3 26287.9 969.8 1004.3 1035.2 1067.0 1088.6 13927.6 14235.7 15284.8 15547.3 15817.0 317153.0 322129.0 322445.0 322632.0 323243.0 45149.0 45840.3 56390.7 56748.4 57038.4 1347.5 1366.3 1367.5 1368.1 1510.4 24298.6 27338.0 27870.2 28304.6 28468.4 48102.3 48169.5 48715.8 48723.5 48755.5 264260.0 267089.0 267173.0 267308.0 267351.0 30803.5 31239.7 31275.7 31309.5 32423.5 38858.6 40065.4 40069.8 40177.8 40210.4 32163.4 33243.7 34940.0 35862.8 36662.0 35104.0 35488.3 35970.3 36165.3 36188.1 35058.6 35534.5 35627.6 35894.3 36162.5 31046.7 32510.2 32599.8 32858.0 32876.3 24412.3 24557.1 24749.0 25010.0 25020.5 04:19:29 INFO - 2015-11-19 04:19:29,280 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,281 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27504.60 Median:4092.65 stddev:84531.34 (2065.4%) stddev-sans-first:84743.89 04:19:29 INFO - 2015-11-19 04:19:29,282 DEBUG : BROWSER_OUTPUT: Values: 352.3 353.9 354.6 355.2 355.8 14332.8 14573.6 16327.8 16738.2 17434.4 15875.3 17006.8 17370.8 17412.5 17430.1 5344.1 5488.8 5490.4 5493.9 5495.6 4028.8 4156.5 5437.3 5499.6 5919.9 6025.0 6089.3 6091.4 6124.3 6146.6 4746.1 4827.5 4836.0 4838.3 6055.2 3993.7 4199.1 4202.6 4203.6 4225.5 13451.3 13598.7 13820.0 13843.5 13907.9 2008.8 2017.3 2025.5 2063.4 2128.9 9796.5 10107.2 10191.9 10281.4 10342.4 1729.5 1789.7 1807.1 1823.6 1893.6 59115.1 60965.5 65510.7 66465.7 66529.0 12151.8 14766.0 15200.1 15546.6 16219.8 23752.0 23769.9 23881.4 23890.9 23930.9 9374.6 9399.0 9451.4 9471.1 9514.0 8063.4 8068.6 8149.7 8160.5 8199.3 7695.3 7859.6 7878.8 7925.4 7969.8 1146.2 1147.9 1157.1 2119.1 3047.0 466.2 468.7 493.2 496.3 513.4 11500.8 11534.5 11659.1 11678.9 12020.2 491.0 493.3 497.1 513.5 522.9 6241.1 6555.1 6581.5 6594.9 6604.5 479098.0 479375.0 527974.0 542172.0 548948.0 71799.3 76458.6 77118.6 77634.6 78192.6 541.6 551.3 552.1 553.2 553.8 10498.5 10553.7 10560.9 10785.7 10805.5 34767.8 35012.0 36053.0 36060.5 36444.8 45793.0 47101.0 47304.8 47553.3 47599.5 6677.5 6703.2 6785.6 6796.7 6803.1 11822.2 12089.5 12226.4 12368.8 12443.1 10566.9 10578.6 10820.2 10822.8 10865.7 10395.5 10548.8 10798.6 10841.8 11013.7 11304.6 11480.4 11554.9 11560.1 11615.4 6471.3 6733.1 6735.1 6737.1 6740.7 10239.0 10261.7 10513.4 10576.5 10638.3 04:19:29 INFO - 2015-11-19 04:19:29,282 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,282 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5188.81 Median:6155.79 stddev:2576.67 (41.9%) stddev-sans-first:2567.18 04:19:29 INFO - 2015-11-19 04:19:29,282 DEBUG : BROWSER_OUTPUT: Values: 1285.0 1731.5 1737.7 1773.5 1798.0 6719.3 7127.2 7167.9 7231.1 7237.1 7062.8 7260.8 7263.5 7266.6 7267.3 1940.1 1972.4 2224.5 2229.9 2249.5 2233.0 2234.8 2236.9 2240.0 2241.1 2187.2 2247.6 2250.5 2252.0 2252.2 1910.9 1954.7 2168.8 2227.1 2235.3 2215.8 2226.9 2247.2 2248.0 2268.9 7198.1 7221.6 7237.4 7284.6 7348.4 4643.2 4677.5 4703.2 4707.2 4719.0 3168.9 3178.2 3190.6 3223.2 3241.2 1151.4 1900.6 1934.9 1963.0 1980.4 10170.7 10246.7 10262.0 10277.1 10286.6 4095.3 4157.4 4202.0 4222.6 4235.0 8431.0 8437.2 8440.2 8443.7 8445.1 4614.9 4636.5 4643.1 4647.7 4649.4 4272.0 4274.6 4275.0 4278.1 4283.8 3452.0 3481.2 3512.8 3513.1 3518.5 1092.6 1105.3 1111.2 1121.1 1130.2 938.4 1277.7 1304.3 1332.3 1335.4 6202.0 6304.3 6938.6 7024.5 7041.8 675.7 676.7 684.6 701.2 706.9 5613.7 5651.1 5651.5 5654.7 5659.3 8389.7 8471.0 8580.7 8698.2 8769.5 8600.9 8609.6 8624.4 8626.1 8627.4 6704.1 6831.8 6838.4 6896.4 6910.7 6502.4 6525.2 6531.9 6547.4 6575.7 7542.6 7604.5 7614.6 7715.1 7750.8 7644.5 7844.8 7850.8 7851.3 7902.2 6399.7 6449.3 6454.9 6461.0 6464.9 7108.5 7236.3 7242.1 7253.0 7264.1 6780.5 6833.1 6865.9 6921.3 6938.4 6652.5 6740.8 6745.9 6793.6 6853.5 6013.9 6109.5 6743.3 6804.6 6805.2 6259.7 6375.0 6424.4 6428.4 6429.5 6054.7 6059.2 6062.4 6063.9 6072.4 04:19:29 INFO - 2015-11-19 04:19:29,282 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,283 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5498.85 Median:6268.27 stddev:1661.43 (26.5%) stddev-sans-first:1620.12 04:19:29 INFO - 2015-11-19 04:19:29,283 DEBUG : BROWSER_OUTPUT: Values: 327.6 329.3 329.7 333.7 334.3 6083.0 6139.1 6143.8 6170.1 6239.8 5978.8 6084.2 6124.5 6130.5 6165.2 4732.6 4735.0 4735.2 4737.0 4738.5 4543.4 4577.3 4642.7 4727.2 4732.1 4655.5 4660.2 4666.3 4669.6 4676.0 4629.9 4648.7 4651.0 4664.0 4696.0 4071.3 4084.9 4087.3 4095.6 4097.3 5736.1 5835.1 5856.7 5870.1 5893.4 5437.3 5476.8 5482.8 5487.8 5511.8 6219.1 6533.4 6544.3 6547.0 6547.2 4410.6 4461.9 4565.8 4578.3 4582.4 6769.7 6795.8 6805.5 6810.2 6814.4 4675.9 4691.1 4694.2 4696.4 4702.2 4652.9 4739.6 4742.1 4752.6 4774.2 5464.8 5476.3 5480.5 5482.7 5490.7 6535.0 6583.3 6589.6 6599.3 6613.1 1659.0 1692.2 1692.6 1694.6 1695.6 1105.2 1128.6 1138.0 1139.5 1139.9 6377.5 6392.8 6399.8 6402.2 6413.6 6757.8 6790.3 6796.9 6803.5 6804.1 6296.7 6394.0 6397.4 6402.4 6408.0 3671.3 3693.7 3699.9 3700.8 3703.7 6988.1 6997.2 6999.5 7000.4 7007.8 6810.6 6952.7 6955.7 6956.1 6961.6 6992.4 6999.4 7000.0 7017.5 7022.4 6567.6 6654.0 6754.1 6770.2 6770.3 6711.4 6725.8 6810.0 6811.4 6816.3 7014.1 7022.9 7026.0 7036.6 7104.8 4652.6 4727.1 4729.0 4742.1 4744.8 6806.7 6822.3 6829.6 6833.7 6836.6 6637.5 6639.9 6661.2 6663.5 6677.4 6473.4 6634.9 6642.3 6649.5 6651.0 6512.5 6516.4 6519.0 6521.4 6523.0 6644.6 6661.5 6674.6 6678.8 6684.1 6335.1 6473.5 6478.5 6481.5 6506.3 04:19:29 INFO - 2015-11-19 04:19:29,283 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,284 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13381.77 Median:47803.88 stddev:15772.52 (33.0%) stddev-sans-first:15788.40 04:19:29 INFO - 2015-11-19 04:19:29,286 DEBUG : BROWSER_OUTPUT: Values: 785.3 805.2 828.3 873.0 881.5 13968.7 14221.0 14222.0 14262.1 14298.3 12872.7 12942.6 13388.0 13414.3 13417.8 689.9 694.6 821.8 829.7 842.0 844.7 847.6 854.0 855.8 856.3 887.0 894.6 894.7 895.4 896.2 716.4 723.5 860.8 883.3 883.7 652.0 653.3 653.5 653.5 654.0 13064.9 13097.1 13145.2 13172.1 13178.4 12572.9 12653.2 12846.6 13213.3 13313.9 9894.7 9929.9 10078.7 10256.2 10275.9 3224.1 3255.2 3281.3 3343.7 3353.0 40350.2 40550.0 40583.4 40618.2 40782.0 7342.3 7404.8 7405.4 7420.1 7431.6 11508.8 11763.8 11783.7 11797.1 11800.1 6692.4 6913.0 6948.4 6978.3 7024.5 4195.2 4231.7 4269.1 4317.9 4322.7 2788.3 2806.0 2811.5 2821.4 2826.3 446.1 446.5 460.5 473.5 479.5 578.4 581.6 689.8 690.9 718.3 8833.1 8931.4 9013.6 9020.6 9100.0 583.0 602.3 678.3 701.9 711.6 4173.3 4223.2 4406.4 4478.6 4578.4 54667.2 55559.7 60023.0 60175.1 60217.4 51312.7 52218.5 52336.5 52357.5 52738.5 46555.8 46806.8 47755.0 47852.8 48429.8 8805.3 8963.2 9198.6 9199.7 9227.6 33666.2 34216.3 34626.5 34777.0 35147.8 44319.3 44788.8 44947.3 45947.0 46813.8 8003.5 8029.4 8169.6 8308.0 8407.9 12518.4 12543.4 12655.5 12783.6 12838.2 11542.9 11840.8 11913.8 12199.1 12227.2 10951.6 11934.1 12084.3 12086.8 12452.3 7701.7 10598.6 10937.0 11284.9 11763.5 9742.4 9751.7 9863.9 10294.6 10399.9 8125.6 9463.2 9640.3 9711.1 9940.7 04:19:29 INFO - 2015-11-19 04:19:29,286 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:19:29 INFO - 2015-11-19 04:19:29,286 DEBUG : BROWSER_OUTPUT: 04:19:30 INFO - 2015-11-19 04:19:30,001 INFO : Browser exited with error code: 0 04:19:30 INFO - 2015-11-19 04:19:30,017 INFO : Completed test dromaeo_css (00:18:32) 04:19:30 INFO - 2015-11-19 04:19:30,018 INFO : Starting test kraken 04:19:30 INFO - 2015-11-19 04:19:30,018 DEBUG : operating with platform_type : linux_ 04:19:30 INFO - 2015-11-19 04:19:30,018 INFO : Initialising browser for kraken test... 04:19:30 INFO - 2015-11-19 04:19:30,024 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRr7l6v/profile http://localhost:40514/getInfo.html 04:19:34 INFO - 2015-11-19 04:19:34,050 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:19:34 INFO - 2015-11-19 04:19:34,050 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:19:34 INFO - 2015-11-19 04:19:34,050 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:19:34 INFO - 2015-11-19 04:19:34,050 DEBUG : BROWSER_OUTPUT: __metrics 04:19:34 INFO - 2015-11-19 04:19:34,227 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:19:35 INFO - 2015-11-19 04:19:35,393 INFO : Browser initialized. 04:19:35 INFO - 2015-11-19 04:19:35,394 INFO : Running cycle 1/1 for kraken test... 04:19:35 INFO - 2015-11-19 04:19:35,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpRr7l6v/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:19:47 INFO - 2015-11-19 04:19:47,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 139452416 04:19:47 INFO - 2015-11-19 04:19:47,177 DEBUG : BROWSER_OUTPUT: 04:19:49 INFO - 2015-11-19 04:19:49,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40514/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:50 INFO - 2015-11-19 04:19:50,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 178827264 04:19:50 INFO - 2015-11-19 04:19:50,217 DEBUG : BROWSER_OUTPUT: 04:19:52 INFO - 2015-11-19 04:19:52,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40514/tests/kraken/driver.html?testName=audio-dft) 04:19:53 INFO - 2015-11-19 04:19:53,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 169213952 04:19:53 INFO - 2015-11-19 04:19:53,416 DEBUG : BROWSER_OUTPUT: 04:19:56 INFO - 2015-11-19 04:19:56,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40514/tests/kraken/driver.html?testName=audio-fft) 04:19:56 INFO - 2015-11-19 04:19:56,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 150753280 04:19:56 INFO - 2015-11-19 04:19:56,821 DEBUG : BROWSER_OUTPUT: 04:19:58 INFO - 2015-11-19 04:19:58,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40514/tests/kraken/driver.html?testName=audio-oscillator) 04:19:59 INFO - 2015-11-19 04:19:59,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 153595904 04:19:59 INFO - 2015-11-19 04:19:59,383 DEBUG : BROWSER_OUTPUT: 04:20:01 INFO - 2015-11-19 04:20:01,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40514/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:02 INFO - 2015-11-19 04:20:02,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 156962816 04:20:02 INFO - 2015-11-19 04:20:02,113 DEBUG : BROWSER_OUTPUT: 04:20:05 INFO - 2015-11-19 04:20:05,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40514/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:05 INFO - 2015-11-19 04:20:05,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 157847552 04:20:05 INFO - 2015-11-19 04:20:05,626 DEBUG : BROWSER_OUTPUT: 04:20:09 INFO - 2015-11-19 04:20:09,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40514/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:09 INFO - 2015-11-19 04:20:09,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 156647424 04:20:09 INFO - 2015-11-19 04:20:09,611 DEBUG : BROWSER_OUTPUT: 04:20:12 INFO - 2015-11-19 04:20:12,388 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40514/tests/kraken/driver.html?testName=json-parse-financial) 04:20:12 INFO - 2015-11-19 04:20:12,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 04:20:12 INFO - 2015-11-19 04:20:12,958 DEBUG : BROWSER_OUTPUT: 04:20:14 INFO - 2015-11-19 04:20:14,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40514/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:15 INFO - 2015-11-19 04:20:15,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 168091648 04:20:15 INFO - 2015-11-19 04:20:15,067 DEBUG : BROWSER_OUTPUT: 04:20:16 INFO - 2015-11-19 04:20:16,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:17 INFO - 2015-11-19 04:20:17,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 165482496 04:20:17 INFO - 2015-11-19 04:20:17,458 DEBUG : BROWSER_OUTPUT: 04:20:19 INFO - 2015-11-19 04:20:19,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:20 INFO - 2015-11-19 04:20:20,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 175517696 04:20:20 INFO - 2015-11-19 04:20:20,103 DEBUG : BROWSER_OUTPUT: 04:20:22 INFO - 2015-11-19 04:20:22,523 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:23 INFO - 2015-11-19 04:20:23,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 181288960 04:20:23 INFO - 2015-11-19 04:20:23,108 DEBUG : BROWSER_OUTPUT: 04:20:25 INFO - 2015-11-19 04:20:25,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:26 INFO - 2015-11-19 04:20:26,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 180449280 04:20:26 INFO - 2015-11-19 04:20:26,250 DEBUG : BROWSER_OUTPUT: 04:20:27 INFO - 2015-11-19 04:20:27,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40514/tests/kraken/driver.html?testName=ai-astar) 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: RSS: Main: 239722496 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:20:28 INFO - 2015-11-19 04:20:28,206 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;111;112;112;119;110;110;112;112 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;125;158;161;125;156;149;130;175;129 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;160;159;160;160;166;161;162 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;85;98;72;72;71;97;89;72 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;134;91;92;93;129;91;92;133 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;109;109;109;110;109 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;145;144;146;147;145;145;145;145 04:20:28 INFO - 2015-11-19 04:20:28,207 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;95 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;56;56;57;56;56;57;65;54;54 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;69;68;69;70;70;68;69 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;83;85;85;84;85;86;86;86;86 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;124;118;124;117;116;125;125;119;124 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;153;149;149;155;148;152;150;148;140 04:20:28 INFO - 2015-11-19 04:20:28,208 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;70;68;68;69;69;68;69;68 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,915 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935628201__endTimestamp 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:20:28 INFO - 2015-11-19 04:20:28,209 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:20:28 INFO - 2015-11-19 04:20:28,210 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,210 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:3.20 04:20:28 INFO - 2015-11-19 04:20:28,210 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 111.0 112.0 112.0 119.0 110.0 110.0 112.0 112.0 04:20:28 INFO - 2015-11-19 04:20:28,210 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,210 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.80 Median:153.00 stddev:17.52 (11.4%) stddev-sans-first:18.51 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: Values: 150.0 125.0 158.0 161.0 125.0 156.0 149.0 130.0 175.0 129.0 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:160.50 stddev:2.04 (1.3%) stddev-sans-first:2.15 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 160.0 159.0 160.0 160.0 166.0 161.0 162.0 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:78.50 stddev:11.16 (14.2%) stddev-sans-first:11.45 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 85.0 98.0 72.0 72.0 71.0 97.0 89.0 72.0 04:20:28 INFO - 2015-11-19 04:20:28,211 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.90 Median:92.00 stddev:19.44 (21.1%) stddev-sans-first:20.14 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 134.0 91.0 92.0 93.0 129.0 91.0 92.0 133.0 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.25 (0.9%) stddev-sans-first:1.24 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 145.0 144.0 146.0 147.0 145.0 145.0 145.0 145.0 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.08 (5.5%) stddev-sans-first:3.27 04:20:28 INFO - 2015-11-19 04:20:28,212 DEBUG : BROWSER_OUTPUT: Values: 57.0 56.0 56.0 57.0 56.0 56.0 57.0 65.0 54.0 54.0 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 69.0 68.0 69.0 70.0 70.0 68.0 69.0 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:0.99 (1.2%) stddev-sans-first:1.05 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: Values: 85.0 83.0 85.0 85.0 84.0 85.0 86.0 86.0 86.0 86.0 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:124.00 stddev:3.55 (2.9%) stddev-sans-first:3.74 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: Values: 120.0 124.0 118.0 124.0 117.0 116.0 125.0 125.0 119.0 124.0 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:149.50 stddev:4.47 (3.0%) stddev-sans-first:4.24 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: Values: 143.0 153.0 149.0 149.0 155.0 148.0 152.0 150.0 148.0 140.0 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 04:20:28 INFO - 2015-11-19 04:20:28,213 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 68.0 68.0 69.0 69.0 68.0 69.0 68.0 04:20:28 INFO - 2015-11-19 04:20:28,214 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:20:28 INFO - 2015-11-19 04:20:28,214 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:29,117 INFO : Browser exited with error code: 0 04:20:29 INFO - 2015-11-19 04:20:29,171 INFO : Completed test kraken (00:00:59) 04:20:29 INFO - 2015-11-19 04:20:29,171 INFO : Starting test v8_7 04:20:29 INFO - 2015-11-19 04:20:29,171 DEBUG : operating with platform_type : linux_ 04:20:29 INFO - 2015-11-19 04:20:29,172 INFO : Initialising browser for v8_7 test... 04:20:29 INFO - 2015-11-19 04:20:29,178 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmBServ/profile http://localhost:40514/getInfo.html 04:20:33 INFO - 2015-11-19 04:20:33,174 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:20:33 INFO - 2015-11-19 04:20:33,174 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:20:33 INFO - 2015-11-19 04:20:33,174 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:20:33 INFO - 2015-11-19 04:20:33,174 DEBUG : BROWSER_OUTPUT: __metrics 04:20:33 INFO - 2015-11-19 04:20:33,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:20:34 INFO - 2015-11-19 04:20:34,548 INFO : Browser initialized. 04:20:34 INFO - 2015-11-19 04:20:34,548 INFO : Running cycle 1/1 for v8_7 test... 04:20:34 INFO - 2015-11-19 04:20:34,548 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmBServ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:20:46 INFO - 2015-11-19 04:20:46,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 04:20:46 INFO - 2015-11-19 04:20:46,275 DEBUG : BROWSER_OUTPUT: 04:21:07 INFO - 2015-11-19 04:21:07,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40514/tests/v8_7/run.html (next: http://localhost:40514/tests/v8_7/run.html) 04:21:08 INFO - 2015-11-19 04:21:08,021 DEBUG : BROWSER_OUTPUT: RSS: Main: 589778944 04:21:08 INFO - 2015-11-19 04:21:08,021 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,021 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |0;Richards;163.96130513198884 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |2;Encrypt;287.1912693854107 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1108.6474501108648 04:21:08 INFO - 2015-11-19 04:21:08,023 DEBUG : BROWSER_OUTPUT: |5;Earley;790.5138339920949 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: |7;RegExp;26179.48717948718 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: |8;Splay;633.5012594458439 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935668021__endTimestamp 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:21:08 INFO - 2015-11-19 04:21:08,024 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:21:08 INFO - 2015-11-19 04:21:08,025 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,025 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.96 Median:163.96 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,025 DEBUG : BROWSER_OUTPUT: Values: 164.0 04:21:08 INFO - 2015-11-19 04:21:08,025 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,026 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,026 DEBUG : BROWSER_OUTPUT: Values: 194.4 04:21:08 INFO - 2015-11-19 04:21:08,026 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:287.19 Median:287.19 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: Values: 287.2 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: Values: 5050.5 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1108.65 Median:1108.65 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,027 DEBUG : BROWSER_OUTPUT: Values: 1108.6 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.51 Median:790.51 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: Values: 790.5 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: Values: 12120.5 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: Values: 26179.5 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,028 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:633.50 Median:633.50 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: Values: 633.5 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:21:08 INFO - 2015-11-19 04:21:08,029 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,873 INFO : Browser exited with error code: 0 04:21:08 INFO - 2015-11-19 04:21:08,890 INFO : Completed test v8_7 (00:00:39) 04:21:08 INFO - 2015-11-19 04:21:08,948 INFO : Completed test suite (00:20:11) 04:21:08 INFO - 2015-11-19 04:21:08,948 DEBUG : Working with test: dromaeo_css 04:21:08 INFO - 2015-11-19 04:21:08,948 DEBUG : Generating results file: dromaeo_css 04:21:08 INFO - 2015-11-19 04:21:08,949 DEBUG : Working with test: kraken 04:21:08 INFO - 2015-11-19 04:21:08,950 DEBUG : Generating results file: kraken 04:21:08 INFO - 2015-11-19 04:21:08,950 INFO : javascript benchmark 04:21:08 INFO - 2015-11-19 04:21:08,950 DEBUG : Working with test: v8_7 04:21:08 INFO - 2015-11-19 04:21:08,950 DEBUG : Generating results file: v8_7 04:21:08 INFO - 2015-11-19 04:21:08,951 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:21:09 INFO - 2015-11-19 04:21:09,004 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 04:21:09 INFO - 2015-11-19 04:21:09,004 DEBUG : process_Request line: dromaeo_css 6856.95 graph.html#tests=[[72,64,35]] 04:21:09 INFO - 2015-11-19 04:21:09,004 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:21:09 INFO - 2015-11-19 04:21:09,108 DEBUG : process_Request line: kraken 1502.00 graph.html#tests=[[232,64,35]] 04:21:09 INFO - 2015-11-19 04:21:09,108 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:21:09 INFO - 2015-11-19 04:21:09,140 DEBUG : process_Request line: v8_7 20890.87 graph.html#tests=[[230,64,35]] 04:21:09 INFO - 2015-11-19 04:21:09,141 INFO : javascript benchmark 04:21:09 INFO - 2015-11-19 04:21:09,145 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3210.197450637341, 3244.15651930498, 3276.2955964467633, 3287.8356082195883, 3300.7524435667333, 5245.082110630634, 5322.893542129155, 5350.822818979823, 5360.919586206205, 5365.651232669874, 5330.573554115671, 5413.377461591918, 5485.890282194354, 5489.972550137244, 5496.890062198753, 4908.63185261106, 4946.431160416544, 5019.347484826967, 5098.643094983353, 5154.974225128869, 4834.178189707741, 5101.744912754348, 5125.3080834087295, 5128.53843154116, 5171.4311425743135, 4865.27020946859, 4903.705777653335, 4985.302057711923, 4991.0, 5018.774155163026, 4929.433115191727, 4938.925916111261, 4959.504049595048, 4964.751762411865, 4976.178930476467, 4901.852944411673, 4934.703917764946, 4937.753112344404, 4958.727270000149, 4985.376827896513, 5154.304168937183, 5217.243499692561, 5250.159974404077, 5340.305760251143, 5378.354597448331, 5887.381824908366, 5917.497012753921, 5918.585699001072, 5923.17075609415, 5930.614510056833, 5749.051406517961, 5957.136215248808, 5960.940390596125, 5962.07587823888, 5963.165156877997, 5504.2018907258225, 5560.249366335493, 5561.138023606267, 5569.610127291091, 5605.887882242373, 6030.819075427744, 6058.1518587397795, 6079.179310792986, 6086.908696369558, 6139.4781443577795, 5598.944010559842, 5706.400827913092, 5871.823845284648, 5880.441358070976, 5920.378360272195, 5692.117721753135, 5741.282339707536, 5802.564807639444, 5810.6513609183585, 5855.648661080349, 5901.321348044944, 5926.525877929756, 5927.585069045212, 5930.318013428425, 5930.436608522184, 5663.688497132614, 5719.0, 5801.593888427854, 5872.471477567039, 5873.295204575478, 4451.354553589711, 4462.709923855004, 4496.572825581565, 4502.099580083996, 4575.839845605455, 3954.6638535724787, 3958.129211573449, 3979.1047014421524, 3979.46277252573, 3998.9600103998587, 5328.413874473805, 5427.83716488506, 5437.0, 5499.50504454601, 5515.531179849758, 5809.448102430262, 5826.621269617462, 5847.736851841677, 5850.5027072699295, 5854.531637468992, 5514.779408823682, 5535.446455354513, 5535.916961245584, 5536.252605898233, 5537.640053396516, 5040.193569028937, 5105.463926287686, 5152.587792976553, 5175.637705360664, 5206.97396513015, 5998.640081595118, 6004.249468816398, 6006.489448396936, 6007.15899774032, 6007.879842403215, 5677.290338707661, 5822.912656310074, 5830.854228644318, 5833.533317334518, 5841.883162336644, 5975.940240597713, 6026.7287972040485, 6034.275886893425, 6050.818475445743, 6070.423309785563, 5818.185454036354, 5828.562857785599, 5831.7375718093635, 5834.066549352084, 5846.0, 5659.603827732184, 5792.652440853562, 5976.9103463448955, 5993.430624090704, 6004.459598636144, 5722.828315150552, 5791.478766910998, 5792.362840087671, 5796.507296879644, 5844.094165404369, 5676.659400435987, 5679.233303503974, 5680.176374425768, 5693.089105743061, 5708.172315014383, 5402.270693456333, 5507.03626865289, 5571.0, 5654.434556544313, 5661.603687741818, 5746.224259725051, 5756.884862302814, 5764.596478246483, 5771.249737534094, 5800.970995144998, 5603.7758489659955, 5618.129189975561, 5623.156526520891, 5623.775048997994, 5635.380108188014], "unit": "ms", "name": "dojo.html", "value": 5396.77253879567}, {"lowerIsBetter": false, "replicates": [567.0954827050853, 604.0667169223549, 607.5595193484721, 614.0696844280914, 617.1729881958175, 31752.523712144306, 32526.349473010527, 40027.0, 40451.59548404515, 40564.0, 43983.78008109963, 44429.555704442944, 44643.33035004469, 44665.0, 44673.77663111688, 7513.511621744597, 7637.045369328834, 8663.263622592087, 8842.690505832297, 8852.645894164225, 10421.374717516974, 10630.0, 10643.308184967991, 10644.254902156852, 10644.893551064506, 10327.948360258226, 10428.113610343129, 10432.165426765878, 10442.947785261063, 10450.05949464548, 7646.197149299327, 7782.610869456505, 7796.415268854802, 10169.898301017007, 10247.38515689061, 9761.902380976171, 9867.506624668738, 9868.309218354718, 9870.802583948353, 9886.060824221688, 36831.263374732625, 37293.44059839105, 37323.25353492915, 37382.0, 37383.4392484113, 3330.4837750148768, 3392.0671815251003, 3409.335179639971, 3445.9827700861333, 3723.3484140275345, 29735.25661858471, 30449.0, 30720.0, 30912.845435772902, 31479.0, 3530.8058056806867, 3550.378683730363, 3590.299891521154, 3594.6405359464106, 3642.690371318441, 257108.0, 259325.0, 259407.0, 264033.0, 264487.0, 57573.712131439075, 58093.70953145207, 58548.70725646344, 58589.121163182586, 58702.412975870546, 60695.69652151711, 61383.69308153431, 61856.38143618596, 61931.690341548005, 61945.69027154835, 15430.845691543165, 15983.920080399523, 16091.839081609269, 16093.275802588678, 16170.35318587267, 12484.313362765135, 12571.18287311322, 12577.496900124075, 12584.937075314565, 12589.496420143092, 19131.426057218305, 19925.900370498053, 19938.501537461678, 19970.10134543949, 19983.0, 8060.274575288252, 8134.959325203455, 8189.0, 8304.384119002494, 8380.312662428512, 954.9379290346105, 959.9088086631759, 1006.8389057750725, 1033.4625994482826, 1092.6776600902754, 25488.235352939442, 25568.48863022729, 26006.34984125412, 26030.34924126874, 26287.868560657458, 969.8302797010637, 1004.3421558878946, 1035.2028937717914, 1067.0260018964852, 1088.5917780832187, 13927.58217253484, 14235.715285694228, 15284.770728439082, 15547.30037148331, 15817.022872140982, 317153.0, 322129.0, 322445.0, 322632.0, 323243.0, 45149.0, 45840.3123953141, 56390.71804640951, 56748.432515674314, 57038.42961570414, 1347.5014244729514, 1366.3441548056987, 1367.4803574641574, 1368.117564171104, 1510.3731951240331, 24298.63552046756, 27338.0, 27870.16389508318, 28304.575431368958, 28468.430631386844, 48102.27846582234, 48169.518304816505, 48715.756421217666, 48723.5127648719, 48755.512444875094, 264260.0, 267089.0, 267173.0, 267308.0, 267351.0, 30803.53794693126, 31239.68760312459, 31275.68724312728, 31309.53035704421, 32423.513647294836, 38858.61141388663, 40065.399019014156, 40069.79965100156, 40177.79911100426, 40210.39684404795, 32163.35673286568, 33243.66756332503, 34940.0, 35862.820685896404, 36662.0, 35104.0, 35488.290234194654, 35970.28059438849, 36165.276694465436, 36188.09529761777, 35058.64941350554, 35534.46698299579, 35627.64372356347, 35894.28211435705, 36162.4575631371, 31046.68953310438, 32510.18724531811, 32599.837000814845, 32858.0, 32876.342473149925, 24412.26763197107, 24557.140500082412, 24749.0, 25010.0, 25020.49959000846], "unit": "ms", "name": "ext.html", "value": 18595.111132533384}, {"lowerIsBetter": false, "replicates": [352.3094734320731, 353.94159963606006, 354.55503343304156, 355.17599169925774, 355.8114199474276, 14332.785008224859, 14573.641873059634, 16327.75508367374, 16738.246778894947, 17434.38979635713, 15875.285612147452, 17006.82993170068, 17370.826291737078, 17412.477625671218, 17430.128493575336, 5344.118220493614, 5488.835334939959, 5490.423505531921, 5493.92868390664, 5495.642783219078, 4028.7582745035393, 4156.54278029418, 5437.32033495813, 5499.587530935176, 5919.911201331984, 6024.96987515064, 6089.299730531001, 6091.42131497507, 6124.265088189423, 6146.6312021278645, 4746.121967436035, 4827.517248275197, 4836.0, 4838.298446725205, 6055.182550355689, 3993.7204395692315, 4199.139176468817, 4202.579742025773, 4203.62167404935, 4225.450691410128, 13451.32743362828, 13598.728025439535, 13820.0, 13843.515476958259, 13907.930460347734, 2008.839292856568, 2017.3443630819895, 2025.5138766696034, 2063.4119276006268, 2128.88291143987, 9796.510174491246, 10107.191424686007, 10191.89808101917, 10281.383117013003, 10342.37945723259, 1729.455221605203, 1789.6510180514804, 1807.1235450806348, 1823.5714607067328, 1893.6212757448427, 59115.113273300936, 60965.47586310333, 65510.67244663794, 66465.66767166181, 66529.0, 12151.817722734166, 14766.040207386486, 15200.087994720352, 15546.611334716496, 16219.756703649455, 23752.0, 23769.881150594138, 23881.40296492567, 23890.88054559716, 23930.88034559816, 9374.625014999323, 9399.0, 9451.432914025181, 9471.052894710612, 9513.952430237805, 8063.435559510778, 8068.556229407322, 8149.714759983491, 8160.5103693778565, 8199.262066414052, 7695.307422332017, 7859.607019649109, 7878.763637090782, 7925.445218834626, 7969.840603187904, 1146.18620779246, 1147.8909503597145, 1157.1148071725138, 2119.1311562259707, 3047.024952015334, 466.216755850175, 468.67192964924686, 493.1714719271586, 496.2704823908848, 513.4095789841712, 11500.827487587692, 11534.538618455168, 11659.06727461801, 11678.941605291919, 12020.218685785396, 491.0449176351961, 493.33892583937694, 497.1349851258856, 513.537815965634, 522.9372475302988, 6241.065269766387, 6555.147830781968, 6581.473482121419, 6594.934050659432, 6604.537682362188, 479098.0, 479375.0, 527974.0, 542172.0479566471, 548948.0, 71799.28200717927, 76458.61770691111, 77118.6144069276, 77634.6118269405, 78192.60903695445, 541.6452223793422, 551.2750732786374, 552.149689478207, 553.2061491759338, 553.8393865779041, 10498.47507624631, 10553.736156596147, 10560.894391056298, 10785.730356741144, 10805.51375188134, 34767.82616086904, 35012.0, 36053.0, 36060.45909311415, 36444.81777591095, 45793.0, 47101.0, 47304.7634761824, 47553.28670069882, 47599.52400475951, 6677.465802735673, 6703.195616526048, 6785.59286442815, 6796.694148763218, 6803.115594972622, 11822.231554948901, 12089.455974480994, 12226.44980975876, 12368.75262494763, 12443.128980971245, 10566.8943310569, 10578.629747958785, 10820.188485863435, 10822.837657435302, 10865.674029779118, 10395.480225988518, 10548.789024219319, 10798.568057277935, 10841.783164336512, 11013.669589912315, 11304.604338848101, 11480.368579727861, 11554.884451155382, 11560.132990025613, 11615.361155136548, 6471.288158302677, 6733.091032710521, 6735.0570920072205, 6737.124173857564, 6740.685566314522, 10239.0, 10261.692149235534, 10513.369197848153, 10576.524056417325, 10638.308509946828], "unit": "ms", "name": "jquery.html", "value": 7918.7187486839375}, {"lowerIsBetter": false, "replicates": [1285.0362228328754, 1731.4545918035817, 1737.6698427298813, 1773.4768243368205, 1797.9730304045443, 6719.328067193284, 7127.2160062393095, 7167.89248161278, 7231.132264128299, 7237.131544214689, 7062.788116356504, 7260.818479538014, 7263.527870688415, 7266.636668166597, 7267.309605587474, 1940.1463356123331, 1972.36884197057, 2224.510607666311, 2229.8662080275235, 2249.5275992041693, 2233.0286325448483, 2234.7988681018705, 2236.932892013234, 2239.9552008959813, 2241.1371621925596, 2187.1907394264144, 2247.6291411917014, 2250.5386395788823, 2251.966220506694, 2252.200468833565, 1910.8853468791847, 1954.7458830352034, 2168.793964573363, 2227.1425501182, 2235.251190851067, 2215.789499997498, 2226.866388016724, 2247.1573160064977, 2248.022110381989, 2268.852524585897, 7198.064251647304, 7221.602811845346, 7237.3848222901115, 7284.599347035911, 7348.412127029825, 4643.233866412072, 4677.532246775329, 4703.15343238217, 4707.176244157293, 4719.032598317371, 3168.8732450701946, 3178.1895616617844, 3190.633077196129, 3223.2425380035675, 3241.173500757315, 1151.4070253819207, 1900.6198760247867, 1934.8742331748392, 1962.9705554416696, 1980.3761815028365, 10170.745731356701, 10246.692599222035, 10262.0, 10277.126444252248, 10286.639967601099, 4095.2628526864855, 4157.438745769343, 4201.970517223239, 4222.577742225752, 4235.02594403289, 8430.957845210734, 8437.156284371637, 8440.198181172778, 8443.704470343508, 8445.071042185355, 4614.930776038362, 4636.4899861015265, 4643.117807616542, 4647.721136731807, 4649.372334734835, 4271.978640106841, 4274.572542745701, 4275.016746148403, 4278.122984788173, 4283.828646854154, 3451.9827400863337, 3481.164520515058, 3512.840762548353, 3513.1217195701074, 3518.4546395308766, 1092.5520536580123, 1105.2926127278547, 1111.1777284809184, 1121.0751130317522, 1130.1862658885589, 938.4041133880036, 1277.6997405609675, 1304.2761267496442, 1332.2938842413537, 1335.3857225676297, 6202.038684003986, 6304.338044505261, 6938.583684978817, 7024.473164512682, 7041.753538626226, 675.7195763758084, 676.7157793726647, 684.6337209592843, 701.1866235167182, 706.8515611721596, 5613.691246981455, 5651.124075768263, 5651.463111004448, 5654.660720356792, 5659.292588426447, 8389.664413423518, 8470.957645211734, 8580.742577722678, 8698.217160455462, 8769.473831570127, 8600.8709869352, 8609.61256743448, 8624.353173511887, 8626.051134375213, 8627.352948528885, 6704.094947182166, 6831.795046148524, 6838.427161752825, 6896.379325860697, 6910.654467276616, 6502.447291980235, 6525.1517302750335, 6531.902021469777, 6547.410733034049, 6575.704093315908, 7542.622868856425, 7604.543727376154, 7614.619269036637, 7715.074191097105, 7750.7674769756995, 7644.464887457824, 7844.843103137791, 7850.803729906798, 7851.254130857559, 7902.24928631779, 6399.6800159992745, 6449.258335291313, 6454.903176452451, 6460.967695161494, 6464.903026454513, 7108.502404831612, 7236.312550307713, 7242.094738157731, 7253.0, 7264.055672762507, 6780.457563395015, 6833.077534532775, 6865.897011544731, 6921.342472465108, 6938.375546200866, 6652.467802575686, 6740.831479212863, 6745.86508269822, 6793.592384456949, 6853.4859885507785, 6013.9097913532205, 6109.541784366102, 6743.325667433218, 6804.6257455840405, 6805.183377994672, 6259.655718935503, 6375.0, 6424.38968298011, 6428.389303016206, 6429.485641148791, 6054.66699331541, 6059.242594675666, 6062.42406971337, 6063.878722425438, 6072.392760723892], "unit": "ms", "name": "mootools.html", "value": 4327.737239669077}, {"lowerIsBetter": false, "replicates": [327.55125478095016, 329.27230819888047, 329.6555099920584, 333.6546674192211, 334.3346739987424, 6083.0, 6139.109829074787, 6143.8156855294355, 6170.105334726468, 6239.84562855872, 5978.790742324019, 6084.178635884155, 6124.510039196864, 6130.509559235262, 6165.16770236018, 4732.597729193014, 4734.952650473486, 4735.242361222206, 4736.9526304736855, 4738.502457241992, 4543.3639290499195, 4577.33628623851, 4642.721436713791, 4727.22000869856, 4732.100900828848, 4655.511171327013, 4660.16117098922, 4666.2767271073035, 4669.556392142758, 4676.041411510632, 4629.907401851961, 4648.674592778507, 4651.046535460223, 4663.953360466386, 4695.976520117411, 4071.3485842265095, 4084.8774536763945, 4087.346024636044, 4095.631393174599, 4097.303458412077, 5736.110902810071, 5835.124731290298, 5856.677882716449, 5870.148828419855, 5893.410658934115, 5437.265969094161, 5476.780928762844, 5482.80810171646, 5487.75305111271, 5511.807086751945, 6219.129321894939, 6533.41199292066, 6544.312847151075, 6547.0, 6547.214334279917, 4410.580994805488, 4461.910761784746, 4565.794539245742, 4578.267477203632, 4582.381378513891, 6769.7292108315605, 6795.7961261162245, 6805.523613347018, 6810.216825065131, 6814.386705196556, 4675.859724208279, 4691.1001044577, 4694.248920172824, 4696.412948381452, 4702.224133018014, 4652.930206046912, 4739.620830333565, 4742.099001189763, 4752.619790416758, 4774.164521208774, 5464.7814087436855, 5476.315460567429, 5480.451954804567, 5482.725863706878, 5490.69801160932, 6535.019747037983, 6583.308752581006, 6589.6375699336995, 6599.340065993362, 6613.074169616258, 1659.0, 1692.2384926782997, 1692.6445446456137, 1694.5594145522252, 1695.6439147779104, 1105.182165197748, 1128.6219116596033, 1138.0497284767146, 1139.5100106953923, 1139.8575178102737, 6377.5216858735785, 6392.808215753442, 6399.8080057598345, 6402.231732192166, 6413.647249401234, 6757.831054223586, 6790.32096790317, 6796.898046529306, 6803.523753337317, 6804.11546498952, 6296.6851657417865, 6394.0, 6397.392247736458, 6402.391772781578, 6407.967960160169, 3671.284099600552, 3693.722970777149, 3699.9260014800093, 3700.7779533227554, 3703.7407381483577, 6988.126484189476, 6997.195322537973, 6999.475039372068, 7000.439964802804, 7007.789766307019, 6810.6254156020905, 6952.7403593831195, 6955.6869940852785, 6956.060931774247, 6961.61711105894, 6992.370686638227, 6999.370056694922, 7000.0, 7017.508774385744, 7022.40309573692, 6567.638779867153, 6654.035164900965, 6754.12196414463, 6770.187577490733, 6770.255271919987, 6711.362420570038, 6725.798226053226, 6810.046593476818, 6811.421029212573, 6816.318368163144, 7014.088168538057, 7022.894656580258, 7025.964870175617, 7036.648167591497, 7104.756667583256, 4652.55800698933, 4727.101850648366, 4728.976355118202, 4742.099001189763, 4744.810207591658, 6806.727730890907, 6822.283660215606, 6829.624370659462, 6833.658317084225, 6836.555623884432, 6637.502187335873, 6639.900401494078, 6661.233958094881, 6663.466922646274, 6677.3656502632175, 6473.449756770538, 6634.933650663625, 6642.269350371552, 6649.534532582673, 6651.0023496475915, 6512.544121911421, 6516.413522782972, 6519.0, 6521.413072823469, 6522.967385163044, 6644.634545100066, 6661.533692641468, 6674.632895190811, 6678.799636010927, 6684.131062961784, 6335.1130841683125, 6473.546851720334, 6478.546501744832, 6481.546291759721, 6506.284308726131], "unit": "ms", "name": "prototype.html", "value": 4954.395015679244}, {"lowerIsBetter": false, "replicates": [785.2971590426572, 805.2310043908068, 828.3249151941171, 872.995635021825, 881.4887365328109, 13968.6507837304, 14221.0, 14222.0, 14262.144271343714, 14298.28508574571, 12872.678183045406, 12942.611721648342, 13388.0, 13414.26221557814, 13417.798733018988, 689.9068625735512, 694.6422592364936, 821.8191997760498, 829.713748756681, 841.9915800841975, 844.7254642241265, 847.5677404523707, 854.0, 855.7646647172046, 856.3320609924269, 887.0, 894.592960203106, 894.7092195036606, 895.4269267668698, 896.2292428511475, 716.3517017099533, 723.4827098624482, 860.7934095817021, 883.3066043156092, 883.7216276872829, 651.9608823470606, 653.343389893159, 653.506602515098, 653.5359894474929, 653.9509536784713, 13064.934675326658, 13097.083204175711, 13145.21128732279, 13172.143810652276, 13178.406971686201, 12572.874271257262, 12653.177543459646, 12846.550370737074, 13213.273269970148, 13313.871813010059, 9894.703158905173, 9929.851052234222, 10078.697639070839, 10256.179505639606, 10275.89724102757, 3224.0650211438656, 3255.2187475006067, 3281.3109247058146, 3343.665633436661, 3353.0, 40350.192996140206, 40549.9999999997, 40583.39124913129, 40618.18763624741, 40781.9999999997, 7342.339189472973, 7404.777856664308, 7405.407567394704, 7420.109586849612, 7431.554106753612, 11508.827367589492, 11763.764724705628, 11783.705407364885, 11797.115216358807, 11800.055995520337, 6692.364225398579, 6913.032175495435, 6948.409385202314, 6978.267281935425, 7024.483325796641, 4195.181939521825, 4231.703780735381, 4269.103488267437, 4317.935230971538, 4322.654187664979, 2788.344738986337, 2805.9719402806118, 2811.451766905475, 2821.3792965547545, 2826.3358110843933, 446.1033323020687, 446.4642429085111, 460.49115727121716, 473.5296903115776, 479.51089888313726, 578.3580225949192, 581.6451964301773, 689.8309914070984, 690.9378155965987, 718.3104219948907, 8833.056333318294, 8931.374803763803, 9013.594388252544, 9020.639174433081, 9099.954500227457, 582.9504492118133, 602.2652364115771, 678.2640834694412, 701.8982247574073, 711.5766119159196, 4173.290540608104, 4223.239816832999, 4406.449193850769, 4478.552144785495, 4578.381918441034, 54667.179992300145, 55559.72220138874, 60023.0, 60175.09737353943, 60217.397826022054, 51312.74343628332, 52218.47781522212, 52336.47663523316, 52357.47642523526, 52738.47261527412, 46555.767221163675, 46806.76596616995, 47755.0, 47852.7607361961, 48429.75785121052, 8805.295576353748, 8963.193312601898, 9198.586063627019, 9199.678011269574, 9227.584758685742, 33666.15834604154, 34216.315673686884, 34626.48060279148, 34777.0, 35147.82426087853, 44319.33520997252, 44788.77605611951, 44947.32579011383, 45947.0, 46813.76593117149, 8003.5197888126895, 8029.434260319415, 8169.632366543401, 8308.044574873968, 8407.915920840713, 12518.436670350038, 12543.372831358212, 12655.493780248687, 12783.552575659807, 12838.16551924122, 11542.94228528852, 11840.76318473643, 11913.761724765283, 12199.14605977573, 12227.205231659913, 10951.598246075668, 11934.104942129548, 12084.274943503418, 12086.758264834478, 12452.252864828139, 7701.653425595974, 10598.576056957943, 10937.0, 11284.887151128383, 11763.47064382122, 9742.366746161477, 9751.707448776548, 9863.901360986298, 10294.588216471257, 10399.94800025995, 8125.634346454542, 9463.195628371666, 9640.276979226446, 9711.115553778545, 9940.701778946643], "unit": "ms", "name": "yui.html", "value": 6099.678610869171}], "name": "dromaeo_css", "value": 6856.945355516296}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 112.0, 112.0, 119.0, 110.0, 110.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 158.0, 161.0, 125.0, 156.0, 149.0, 130.0, 175.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.8}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 160.0, 159.0, 160.0, 160.0, 166.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 85.0, 98.0, 72.0, 72.0, 71.0, 97.0, 89.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 134.0, 91.0, 92.0, 93.0, 129.0, 91.0, 92.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 145.0, 144.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 65.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 70.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 85.0, 85.0, 84.0, 85.0, 86.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [120.0, 124.0, 118.0, 124.0, 117.0, 116.0, 125.0, 125.0, 119.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [143.0, 153.0, 149.0, 149.0, 155.0, 148.0, 152.0, 150.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 68.0, 68.0, 69.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1502.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.96130513198884], "unit": "score", "name": "Richards", "value": 215.306898}, {"lowerIsBetter": false, "replicates": [194.43904335990666], "unit": "score", "name": "DeltaBlue", "value": 340.0448739999999}, {"lowerIsBetter": false, "replicates": [287.1912693854107], "unit": "score", "name": "Encrypt", "value": 926.8422419999996}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1108.6474501108648], "unit": "score", "name": "RayTrace", "value": 667.4700779999998}, {"lowerIsBetter": false, "replicates": [790.5138339920949], "unit": "score", "name": "Earley", "value": 843.0756950000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [633.5012594458439], "unit": "score", "name": "Splay", "value": 128.6358926441352}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20890.867140815062}]} 04:21:09 INFO - RETURN: dromaeo_css: 6856.95 04:21:09 INFO - RETURN: kraken: 1502.00 04:21:09 INFO - RETURN: v8_7: 20890.87 04:21:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20890.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1502.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6856.95"}}} 04:21:09 INFO - Return code: 0 04:21:09 INFO - # TBPL SUCCESS # 04:21:09 INFO - Running post-action listener: _resource_record_post_action 04:21:09 INFO - Running post-run listener: _resource_record_post_run 04:21:10 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 514281472; Read time: 28; Write time: 590832 04:21:10 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 170520576; Read time: 0; Write time: 348588 04:21:10 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 343719936; Read time: 28; Write time: 242228 04:21:10 INFO - Running post-run listener: _upload_blobber_files 04:21:10 INFO - Blob upload gear active. 04:21:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:21:10 INFO - Copying logs to upload dir... 04:21:10 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1293.166784 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2015-11-19 04:21:09.756835) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:09.760569) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009996 build_url: 'https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/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-19 04:21:09.812309) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:09.812637) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1447931163.136155-1138212576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:09.862270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:21:09.862583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:21:09.862878) ========= ========= Total master_lag: 0.23 =========