builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1447934375.49 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.494252) ========= 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.494685) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.494962) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006484 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.519664) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.519943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.552491) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.552744) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019960 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.603646) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.603925) ========= 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.604279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.604564) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-19 03:59:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 215M=0s 2015-11-19 03:59:35 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131951 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.748285) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.748600) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.156680 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.917367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:35.917680) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-19 03:59:35,999 truncating revision to first 12 chars 2015-11-19 03:59:35,999 Setting DEBUG logging. 2015-11-19 03:59:35,999 attempt 1/10 2015-11-19 03:59:35,999 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,233 unpacking tar archive at: fx-team-9b28207cf3e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.503052 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.432931) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.433231) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.444513) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 03:59:36.444759) ========= 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.445186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2015-11-19 03:59:36.445472) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:36 INFO - MultiFileLogger online at 20151119 03:59:36 in /builds/slave/test-pgo 03:59:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:59:36 INFO - {'append_to_log': False, 03:59:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:59:36 INFO - 'blob_upload_branch': 'Fx-Team', 03:59:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:59:36 INFO - 'branch': 'Fx-Team', 03:59:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:36 INFO - 'config_files': ('talos/linux_config.py',), 03:59:36 INFO - 'default_actions': ('clobber', 03:59:36 INFO - 'read-buildbot-config', 03:59:36 INFO - 'download-and-extract', 03:59:36 INFO - 'populate-webroot', 03:59:36 INFO - 'create-virtualenv', 03:59:36 INFO - 'install', 03:59:36 INFO - 'run-tests'), 03:59:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:36 INFO - 'download_minidump_stackwalk': True, 03:59:36 INFO - 'download_symbols': 'ondemand', 03:59:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:36 INFO - 'installer_path': 'installer.exe', 03:59:36 INFO - 'log_level': 'info', 03:59:36 INFO - 'log_name': 'talos', 03:59:36 INFO - 'log_to_console': True, 03:59:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:36 INFO - 'opt_config_files': (), 03:59:36 INFO - 'pip_index': False, 03:59:36 INFO - 'sps_profile': False, 03:59:36 INFO - 'sps_profile_interval': 0, 03:59:36 INFO - 'suite': 'dromaeojs-e10s', 03:59:36 INFO - 'system_bits': '64', 03:59:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:36 INFO - 'title': 'talos-linux64-ix-001', 03:59:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:36 INFO - 'use_talos_json': True, 03:59:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:59:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:36 INFO - 'work_dir': 'build'} 03:59:36 INFO - ##### 03:59:36 INFO - ##### Running clobber step. 03:59:36 INFO - ##### 03:59:36 INFO - Running pre-action listener: _resource_record_pre_action 03:59:36 INFO - Running main action method: clobber 03:59:36 INFO - rmtree: /builds/slave/test-pgo/build 03:59:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:59:41 INFO - Running post-action listener: _resource_record_post_action 03:59:41 INFO - ##### 03:59:41 INFO - ##### Running read-buildbot-config step. 03:59:41 INFO - ##### 03:59:41 INFO - Running pre-action listener: _resource_record_pre_action 03:59:41 INFO - Running main action method: read_buildbot_config 03:59:41 INFO - Using buildbot properties: 03:59:41 INFO - { 03:59:41 INFO - "properties": { 03:59:41 INFO - "buildnumber": 345, 03:59:41 INFO - "product": "firefox", 03:59:41 INFO - "script_repo_revision": "production", 03:59:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:59:41 INFO - "repository": "", 03:59:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 03:59:41 INFO - "buildid": "20151119023034", 03:59:41 INFO - "slavename": "talos-linux64-ix-001", 03:59:41 INFO - "pgo_build": "True", 03:59:41 INFO - "basedir": "/builds/slave/test-pgo", 03:59:41 INFO - "project": "", 03:59:41 INFO - "platform": "ubuntu64_hw", 03:59:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:41 INFO - "slavebuilddir": "test", 03:59:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:59:41 INFO - "branch": "fx-team", 03:59:41 INFO - "repo_path": "integration/fx-team", 03:59:41 INFO - "stage_platform": "linux64-pgo", 03:59:41 INFO - "builduid": "6e932f3f2459448b85328de9bde29884", 03:59:41 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:41 INFO - }, 03:59:41 INFO - "sourcestamp": { 03:59:41 INFO - "repository": "", 03:59:41 INFO - "hasPatch": false, 03:59:41 INFO - "project": "", 03:59:41 INFO - "branch": "fx-team-linux64-pgo-talos", 03:59:41 INFO - "changes": [ 03:59:41 INFO - { 03:59:41 INFO - "category": null, 03:59:41 INFO - "files": [ 03:59:41 INFO - { 03:59:41 INFO - "url": null, 03:59:41 INFO - "name": "https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:59:41 INFO - } 03:59:41 INFO - ], 03:59:41 INFO - "repository": "", 03:59:41 INFO - "rev": "9b28207cf3e3ae95bed79d9da9e45152a9a66387", 03:59:41 INFO - "who": "sendchange", 03:59:41 INFO - "when": 1447934328, 03:59:41 INFO - "number": 6682258, 03:59:41 INFO - "comments": "", 03:59:41 INFO - "project": "", 03:59:41 INFO - "at": "Thu 19 Nov 2015 03:58:48", 03:59:41 INFO - "branch": "fx-team-linux64-pgo-talos", 03:59:41 INFO - "revlink": "", 03:59:41 INFO - "properties": [ 03:59:41 INFO - [ 03:59:41 INFO - "buildid", 03:59:41 INFO - "20151119023034", 03:59:41 INFO - "Change" 03:59:41 INFO - ], 03:59:41 INFO - [ 03:59:41 INFO - "builduid", 03:59:41 INFO - "6e932f3f2459448b85328de9bde29884", 03:59:41 INFO - "Change" 03:59:41 INFO - ], 03:59:41 INFO - [ 03:59:41 INFO - "pgo_build", 03:59:41 INFO - "True", 03:59:41 INFO - "Change" 03:59:41 INFO - ] 03:59:41 INFO - ], 03:59:41 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:41 INFO - } 03:59:41 INFO - ], 03:59:41 INFO - "revision": "9b28207cf3e3ae95bed79d9da9e45152a9a66387" 03:59:41 INFO - } 03:59:41 INFO - } 03:59:41 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:41 INFO - Running post-action listener: _resource_record_post_action 03:59:41 INFO - ##### 03:59:41 INFO - ##### Running download-and-extract step. 03:59:41 INFO - ##### 03:59:41 INFO - Running pre-action listener: _resource_record_pre_action 03:59:41 INFO - Running main action method: download_and_extract 03:59:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:59: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')]} 03:59:41 INFO - https://queue.taskcluster.net/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json 03:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnCwvQjwSmawFu2HK0d7mQ/artifacts/public/build/test_packages.json 03:59:41 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:41 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 04:00:02 INFO - Downloaded 22475277 bytes. 04:00:02 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:02 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:00:02 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:03 INFO - Return code: 0 04:00:03 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 04:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:03 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 04:00:03 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 04:00:03 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 04:00:03 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 04:00:03 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:17 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:18 INFO - Downloaded 11130997 bytes. 04:00:18 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:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:18 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:18 INFO - Return code: 0 04:00:18 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:18 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:18 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:18 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:18 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:18 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:26 INFO - Downloaded 57210179 bytes. 04:00:26 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:26 INFO - mkdir: /builds/slave/test-pgo/properties 04:00:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:00:26 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:00:26 INFO - Contents: 04:00:26 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:26 INFO - Running post-action listener: _resource_record_post_action 04:00:26 INFO - Running post-action listener: set_extra_try_arguments 04:00:26 INFO - ##### 04:00:26 INFO - ##### Running populate-webroot step. 04:00:26 INFO - ##### 04:00:26 INFO - Running pre-action listener: _resource_record_pre_action 04:00:26 INFO - Running main action method: populate_webroot 04:00:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:00:26 INFO - '../fennec_ids.txt'], 04:00:26 INFO - 'tests': ['tcheck2']}, 04:00:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:26 INFO - '--tppagecycles', 04:00:26 INFO - '7'], 04:00:26 INFO - 'tests': ['tsvgm']}}, 04:00:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:00:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:00:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'tests': ['damp', 'tps']}, 04:00:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['damp', 'tps']}, 04:00:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:00:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:26 INFO - 'other': {'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'other_l64': {'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'other_nol64': {'tests': ['a11yr', 04:00:26 INFO - 'ts_paint', 04:00:26 INFO - 'tpaint', 04:00:26 INFO - 'sessionrestore', 04:00:26 INFO - 'sessionrestore_no_auto_restore']}, 04:00:26 INFO - 'svgr': {'tests': ['tsvgx', 04:00:26 INFO - 'tsvgr_opacity', 04:00:26 INFO - 'tart', 04:00:26 INFO - 'tscrollx', 04:00:26 INFO - 'cart']}, 04:00:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['tsvgx', 04:00:26 INFO - 'tsvgr_opacity', 04:00:26 INFO - 'tart', 04:00:26 INFO - 'tscrollx', 04:00:26 INFO - 'cart']}, 04:00:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'tests': ['tp5o']}, 04:00:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'talos_options': ['--e10s'], 04:00:26 INFO - 'tests': ['tp5o']}, 04:00:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'talos_options': ['--xperf_path', 04:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:26 INFO - 'tests': ['tp5n']}, 04:00:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:26 INFO - 'talos_options': ['--e10s', 04:00:26 INFO - '--xperf_path', 04:00:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:26 INFO - 'tests': ['tp5n']}}, 04:00:26 INFO - 'talos.zip': {'path': '', 04:00:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:26 INFO - Running post-action listener: _resource_record_post_action 04:00:26 INFO - ##### 04:00:26 INFO - ##### Running create-virtualenv step. 04:00:26 INFO - ##### 04:00:26 INFO - Running pre-action listener: _resource_record_pre_action 04:00:26 INFO - Running main action method: create_virtualenv 04:00:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:00:26 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:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:00:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:26 INFO - Using real prefix '/usr' 04:00:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:00:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:29 INFO - Installing pip.................done. 04:00:29 INFO - Return code: 0 04:00:29 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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', 'pip>=1.5'] 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 pip>=1.5 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:29 INFO - 'MOZ_NO_REMOTE': '1', 04:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:29 INFO - 'NO_EM_RESTART': '1', 04:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:29 INFO - 'SHELL': '/bin/bash', 04:00:29 INFO - 'SHLVL': '1', 04:00:29 INFO - 'TERM': 'linux', 04:00:29 INFO - 'TMOUT': '86400', 04:00:29 INFO - 'USER': 'cltbld', 04:00:29 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:29 INFO - '_': '/tools/buildbot/bin/python'} 04:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:29 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:29 INFO - Cleaning up... 04:00:29 INFO - Return code: 0 04:00:29 INFO - Installing psutil>=0.7.1 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', '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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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', 'psutil>=0.7.1'] 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 psutil>=0.7.1 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:29 INFO - 'MOZ_NO_REMOTE': '1', 04:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:29 INFO - 'NO_EM_RESTART': '1', 04:00:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:29 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:29 INFO - 'SHELL': '/bin/bash', 04:00:29 INFO - 'SHLVL': '1', 04:00:29 INFO - 'TERM': 'linux', 04:00:29 INFO - 'TMOUT': '86400', 04:00:29 INFO - 'USER': 'cltbld', 04:00:29 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:29 INFO - '_': '/tools/buildbot/bin/python'} 04:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:29 INFO - Downloading/unpacking psutil>=0.7.1 04:00:29 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:29 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 - 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:29 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:29 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:29 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 - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:00:31 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:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:31 INFO - Installing collected packages: psutil 04:00:31 INFO - Running setup.py install for psutil 04:00:31 INFO - building 'psutil._psutil_linux' extension 04:00:31 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:31 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:31 INFO - building 'psutil._psutil_posix' extension 04:00:31 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:31 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:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:31 INFO - Successfully installed psutil 04:00:31 INFO - Cleaning up... 04:00:31 INFO - Return code: 0 04:00:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:00:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:31 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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 04:00:31 INFO - 'HOME': '/home/cltbld', 04:00:31 INFO - 'LANG': 'en_US.UTF-8', 04:00:31 INFO - 'LANGUAGE': 'en_US:en', 04:00:31 INFO - 'LOGNAME': 'cltbld', 04:00:31 INFO - 'MAIL': '/var/mail/cltbld', 04:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:31 INFO - 'MOZ_NO_REMOTE': '1', 04:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:31 INFO - 'NO_EM_RESTART': '1', 04:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:31 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:31 INFO - 'SHELL': '/bin/bash', 04:00:31 INFO - 'SHLVL': '1', 04:00:31 INFO - 'TERM': 'linux', 04:00:31 INFO - 'TMOUT': '86400', 04:00:31 INFO - 'USER': 'cltbld', 04:00:31 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:31 INFO - '_': '/tools/buildbot/bin/python'} 04:00:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 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 mozsystemmonitor-0.0.tar.gz 04:00:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:33 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:33 INFO - Installing collected packages: mozsystemmonitor 04:00:33 INFO - Running setup.py install for mozsystemmonitor 04:00:33 INFO - Successfully installed mozsystemmonitor 04:00:33 INFO - Cleaning up... 04:00:33 INFO - Return code: 0 04:00:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:00:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:33 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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 04:00:33 INFO - 'HOME': '/home/cltbld', 04:00:33 INFO - 'LANG': 'en_US.UTF-8', 04:00:33 INFO - 'LANGUAGE': 'en_US:en', 04:00:33 INFO - 'LOGNAME': 'cltbld', 04:00:33 INFO - 'MAIL': '/var/mail/cltbld', 04:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:33 INFO - 'MOZ_NO_REMOTE': '1', 04:00:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:33 INFO - 'NO_EM_RESTART': '1', 04:00:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:33 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:33 INFO - 'SHELL': '/bin/bash', 04:00:33 INFO - 'SHLVL': '1', 04:00:33 INFO - 'TERM': 'linux', 04:00:33 INFO - 'TMOUT': '86400', 04:00:33 INFO - 'USER': 'cltbld', 04:00:33 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:33 INFO - '_': '/tools/buildbot/bin/python'} 04:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:34 INFO - Downloading/unpacking 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:35 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:35 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:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:35 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:35 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:35 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:35 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:35 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:35 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:36 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:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:00:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading docopt-0.6.1.tar.gz 04:00:36 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:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:36 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:36 INFO - Running setup.py install for blobuploader 04:00:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:00:36 INFO - Running setup.py install for requests 04:00:37 INFO - Running setup.py install for docopt 04:00:37 INFO - Successfully installed blobuploader requests docopt 04:00:37 INFO - Cleaning up... 04:00:37 INFO - Return code: 0 04:00:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:37 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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 04:00:37 INFO - 'HOME': '/home/cltbld', 04:00:37 INFO - 'LANG': 'en_US.UTF-8', 04:00:37 INFO - 'LANGUAGE': 'en_US:en', 04:00:37 INFO - 'LOGNAME': 'cltbld', 04:00:37 INFO - 'MAIL': '/var/mail/cltbld', 04:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:37 INFO - 'MOZ_NO_REMOTE': '1', 04:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:37 INFO - 'NO_EM_RESTART': '1', 04:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:37 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:37 INFO - 'SHELL': '/bin/bash', 04:00:37 INFO - 'SHLVL': '1', 04:00:37 INFO - 'TERM': 'linux', 04:00:37 INFO - 'TMOUT': '86400', 04:00:37 INFO - 'USER': 'cltbld', 04:00:37 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:37 INFO - '_': '/tools/buildbot/bin/python'} 04:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:37 INFO - Running setup.py (path:/tmp/pip-fGjbA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:37 INFO - Running setup.py (path:/tmp/pip-3FO2i5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:37 INFO - Running setup.py (path:/tmp/pip-X6QORi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:37 INFO - Running setup.py (path:/tmp/pip-Azj3X4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:37 INFO - Running setup.py (path:/tmp/pip-agWVbf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:37 INFO - Running setup.py (path:/tmp/pip-umGvtg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:37 INFO - Running setup.py (path:/tmp/pip-tSbj75-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:37 INFO - Running setup.py (path:/tmp/pip-wcKqEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:37 INFO - Running setup.py (path:/tmp/pip-Z70TqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:38 INFO - Running setup.py (path:/tmp/pip-frVCnM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:38 INFO - Running setup.py (path:/tmp/pip-KxlkI9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:38 INFO - Running setup.py (path:/tmp/pip-hlJETA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:38 INFO - Running setup.py (path:/tmp/pip-MD85Nb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:38 INFO - Running setup.py (path:/tmp/pip-PGcQAa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:38 INFO - Running setup.py (path:/tmp/pip-47LUqJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:38 INFO - Running setup.py (path:/tmp/pip-AeQ8dB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:38 INFO - Running setup.py (path:/tmp/pip-HFIfE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:38 INFO - Running setup.py install for manifestparser 04:00:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:00:38 INFO - Running setup.py install for mozcrash 04:00:38 INFO - Running setup.py install for mozdebug 04:00:38 INFO - Running setup.py install for mozdevice 04:00:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozfile 04:00:39 INFO - Running setup.py install for mozhttpd 04:00:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozinfo 04:00:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozInstall 04:00:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozleak 04:00:39 INFO - Running setup.py install for mozlog 04:00:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for moznetwork 04:00:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozprocess 04:00:39 INFO - Running setup.py install for mozprofile 04:00:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:00:39 INFO - Running setup.py install for mozrunner 04:00:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:00:40 INFO - Running setup.py install for mozscreenshot 04:00:40 INFO - Running setup.py install for moztest 04:00:40 INFO - Running setup.py install for mozversion 04:00:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:00:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:40 INFO - Cleaning up... 04:00:40 INFO - Return code: 0 04:00:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:40 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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 04:00:40 INFO - 'HOME': '/home/cltbld', 04:00:40 INFO - 'LANG': 'en_US.UTF-8', 04:00:40 INFO - 'LANGUAGE': 'en_US:en', 04:00:40 INFO - 'LOGNAME': 'cltbld', 04:00:40 INFO - 'MAIL': '/var/mail/cltbld', 04:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:40 INFO - 'MOZ_NO_REMOTE': '1', 04:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:40 INFO - 'NO_EM_RESTART': '1', 04:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:40 INFO - 'SHELL': '/bin/bash', 04:00:40 INFO - 'SHLVL': '1', 04:00:40 INFO - 'TERM': 'linux', 04:00:40 INFO - 'TMOUT': '86400', 04:00:40 INFO - 'USER': 'cltbld', 04:00:40 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:40 INFO - '_': '/tools/buildbot/bin/python'} 04:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:40 INFO - Running setup.py (path:/tmp/pip-H8OixB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:00:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:40 INFO - Running setup.py (path:/tmp/pip-Nj8SgR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:00:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:40 INFO - Running setup.py (path:/tmp/pip-9AlZ6F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:00:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:40 INFO - Running setup.py (path:/tmp/pip-V1TJj9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:00:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:40 INFO - Running setup.py (path:/tmp/pip-SufTsY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:00:40 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:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:40 INFO - Running setup.py (path:/tmp/pip-8EKKz6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:41 INFO - Running setup.py (path:/tmp/pip-D13G96-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:41 INFO - Running setup.py (path:/tmp/pip-MybWoa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:41 INFO - Running setup.py (path:/tmp/pip-Vq9Vyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:41 INFO - Running setup.py (path:/tmp/pip-9qjUwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:41 INFO - Running setup.py (path:/tmp/pip-FOXopY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:41 INFO - Running setup.py (path:/tmp/pip-Zb0UTi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:41 INFO - Running setup.py (path:/tmp/pip-wSjDhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:41 INFO - Running setup.py (path:/tmp/pip-yMs_Db-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:41 INFO - Running setup.py (path:/tmp/pip-at8O_3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:41 INFO - Running setup.py (path:/tmp/pip-rkMpIv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:00:41 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:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:41 INFO - Running setup.py (path:/tmp/pip-MhAJKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:00:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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 - 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:41 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:41 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:41 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:43 INFO - Downloading blessings-1.5.1.tar.gz 04:00:43 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:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:43 INFO - Installing collected packages: blessings 04:00:43 INFO - Running setup.py install for blessings 04:00:43 INFO - Successfully installed blessings 04:00:43 INFO - Cleaning up... 04:00:43 INFO - Return code: 0 04:00:43 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:00:43 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:00:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:00:43 INFO - Reading from file tmpfile_stdout 04:00:43 INFO - Current package versions: 04:00:43 INFO - argparse == 1.2.1 04:00:43 INFO - blessings == 1.5.1 04:00:43 INFO - blobuploader == 1.2.4 04:00:43 INFO - docopt == 0.6.1 04:00:43 INFO - manifestparser == 1.1 04:00:43 INFO - mozInstall == 1.12 04:00:43 INFO - mozcrash == 0.16 04:00:43 INFO - mozdebug == 0.1 04:00:43 INFO - mozdevice == 0.47 04:00:43 INFO - mozfile == 1.2 04:00:43 INFO - mozhttpd == 0.7 04:00:43 INFO - mozinfo == 0.9 04:00:43 INFO - mozleak == 0.1 04:00:43 INFO - mozlog == 3.0 04:00:43 INFO - moznetwork == 0.27 04:00:43 INFO - mozprocess == 0.22 04:00:43 INFO - mozprofile == 0.27 04:00:43 INFO - mozrunner == 6.11 04:00:43 INFO - mozscreenshot == 0.1 04:00:43 INFO - mozsystemmonitor == 0.0 04:00:43 INFO - moztest == 0.7 04:00:43 INFO - mozversion == 1.4 04:00:43 INFO - psutil == 3.1.1 04:00:43 INFO - requests == 1.2.3 04:00:43 INFO - wsgiref == 0.1.2 04:00:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:43 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 0x7f0055eabc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20176c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 04:00:43 INFO - 'HOME': '/home/cltbld', 04:00:43 INFO - 'LANG': 'en_US.UTF-8', 04:00:43 INFO - 'LANGUAGE': 'en_US:en', 04:00:43 INFO - 'LOGNAME': 'cltbld', 04:00:43 INFO - 'MAIL': '/var/mail/cltbld', 04:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:43 INFO - 'MOZ_NO_REMOTE': '1', 04:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:43 INFO - 'NO_EM_RESTART': '1', 04:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:43 INFO - 'SHELL': '/bin/bash', 04:00:43 INFO - 'SHLVL': '1', 04:00:43 INFO - 'TERM': 'linux', 04:00:43 INFO - 'TMOUT': '86400', 04:00:43 INFO - 'USER': 'cltbld', 04:00:43 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:43 INFO - '_': '/tools/buildbot/bin/python'} 04:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 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:44 INFO - Cleaning up... 04:00:44 INFO - Return code: 0 04:00:44 INFO - Running post-action listener: _resource_record_post_action 04:00:44 INFO - Running post-action listener: _start_resource_monitoring 04:00:44 INFO - Starting resource monitoring. 04:00:44 INFO - ##### 04:00:44 INFO - ##### Running install step. 04:00:44 INFO - ##### 04:00:44 INFO - Running pre-action listener: _resource_record_pre_action 04:00:44 INFO - Running main action method: install 04:00:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:00:44 INFO - Reading from file tmpfile_stdout 04:00:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:00:44 INFO - Reading from file tmpfile_stdout 04:00:44 INFO - Output received: 04:00:44 INFO - Usage: mozinstall [options] installer 04:00:44 INFO - Options: 04:00:44 INFO - -h, --help show this help message and exit 04:00:44 INFO - -d DEST, --destination=DEST 04:00:44 INFO - Directory to install application into. [default: 04:00:44 INFO - "/builds/slave/test-pgo"] 04:00:44 INFO - --app=APP Application being installed. [default: firefox] 04:00:44 INFO - mkdir: /builds/slave/test-pgo/build/application 04:00:44 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:44 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:58 INFO - Reading from file tmpfile_stdout 04:00:58 INFO - Output received: 04:00:58 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:00:58 INFO - Running post-action listener: _resource_record_post_action 04:00:58 INFO - ##### 04:00:58 INFO - ##### Running run-tests step. 04:00:58 INFO - ##### 04:00:58 INFO - Running pre-action listener: _resource_record_pre_action 04:00:58 INFO - Running main action method: run_tests 04:00:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:00:58 INFO - Python 2.7.3 04:00:58 INFO - Return code: 0 04:00:58 INFO - grabbing minidump binary from tooltool 04:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:58 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 0x210dd70>, '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 0x210eb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210efb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:00:58 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:58 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:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:58 INFO - Return code: 0 04:00:58 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:00:58 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:00:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:00:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:00:58 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-e10s', '--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-001', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 04:00:58 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-e10s --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-001 --webServer localhost 04:00:58 INFO - Using env: {'DISPLAY': ':0', 04:00:58 INFO - 'HOME': '/home/cltbld', 04:00:58 INFO - 'LANG': 'en_US.UTF-8', 04:00:58 INFO - 'LANGUAGE': 'en_US:en', 04:00:58 INFO - 'LOGNAME': 'cltbld', 04:00:58 INFO - 'MAIL': '/var/mail/cltbld', 04:00:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:58 INFO - 'MOZ_NO_REMOTE': '1', 04:00:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:58 INFO - 'NO_EM_RESTART': '1', 04:00:58 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:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 04:00:58 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:00:58 INFO - 'SHELL': '/bin/bash', 04:00:58 INFO - 'SHLVL': '1', 04:00:58 INFO - 'TERM': 'linux', 04:00:58 INFO - 'TMOUT': '86400', 04:00:58 INFO - 'USER': 'cltbld', 04:00:58 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994', 04:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:58 INFO - '_': '/tools/buildbot/bin/python'} 04:00:58 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-e10s', '--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-001', '--webServer', 'localhost'] with output_timeout 3600 04:00:59 INFO - mozversion INFO | application_buildid: 20151119023034 04:00:59 INFO - mozversion INFO | application_changeset: 9b28207cf3e3ae95bed79d9da9e45152a9a66387 04:00:59 INFO - mozversion INFO | application_display_name: Nightly 04:00:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:59 INFO - mozversion INFO | application_name: Firefox 04:00:59 INFO - mozversion INFO | application_remotingname: firefox 04:00:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:00:59 INFO - mozversion INFO | application_vendor: Mozilla 04:00:59 INFO - mozversion INFO | application_version: 45.0a1 04:00:59 INFO - mozversion INFO | platform_buildid: 20151119023034 04:00:59 INFO - mozversion INFO | platform_changeset: 9b28207cf3e3ae95bed79d9da9e45152a9a66387 04:00:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:00:59 INFO - mozversion INFO | platform_version: 45.0a1 04:00:59 INFO - 2015-11-19 04:00:59,146 DEBUG : using testdate: 1447934459 04:00:59 INFO - 2015-11-19 04:00:59,146 DEBUG : actual date: 1447934459 04:00:59 INFO - 2015-11-19 04:00:59,155 INFO : starting webserver on 'localhost:46634' 04:00:59 INFO - 2015-11-19 04:00:59,156 INFO : Starting test suite talos-linux64-ix-001.e 04:00:59 INFO - 2015-11-19 04:00:59,156 INFO : Starting test dromaeo_css 04:00:59 INFO - 2015-11-19 04:00:59,156 DEBUG : operating with platform_type : linux_ 04:00:59 INFO - 2015-11-19 04:00:59,157 INFO : Initialising browser for dromaeo_css test... 04:00:59 INFO - 2015-11-19 04:00:59,171 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCpOdAc/profile http://localhost:46634/getInfo.html 04:01:04 INFO - 2015-11-19 04:01:04,029 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:01:04 INFO - 2015-11-19 04:01:04,029 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:01:04 INFO - 2015-11-19 04:01:04,030 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:01:04 INFO - 2015-11-19 04:01:04,030 DEBUG : BROWSER_OUTPUT: __metrics 04:01:05 INFO - 2015-11-19 04:01:05,101 INFO : Browser initialized. 04:01:05 INFO - 2015-11-19 04:01:05,102 INFO : Running cycle 1/1 for dromaeo_css test... 04:01:05 INFO - 2015-11-19 04:01:05,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCpOdAc/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:01:16 INFO - 2015-11-19 04:01:16,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 141946880 04:01:16 INFO - 2015-11-19 04:01:16,881 DEBUG : BROWSER_OUTPUT: 04:02:06 INFO - 2015-11-19 04:02:06,497 DEBUG : BROWSER_OUTPUT: 1447934526496 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,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46634/tests/dromaeo/cssquery-ext.html) 04:04:15 INFO - 2015-11-19 04:04:15,859 DEBUG : BROWSER_OUTPUT: RSS: Main: 148582400 04:04:15 INFO - 2015-11-19 04:04:15,859 DEBUG : BROWSER_OUTPUT: 04:07:17 INFO - 2015-11-19 04:07:17,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-ext.html (next: http://localhost:46634/tests/dromaeo/cssquery-jquery.html) 04:07:18 INFO - 2015-11-19 04:07:18,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 141172736 04:07:18 INFO - 2015-11-19 04:07:18,386 DEBUG : BROWSER_OUTPUT: 04:10:20 INFO - 2015-11-19 04:10:20,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46634/tests/dromaeo/cssquery-mootools.html) 04:10:20 INFO - 2015-11-19 04:10:20,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 142315520 04:10:20 INFO - 2015-11-19 04:10:20,667 DEBUG : BROWSER_OUTPUT: 04:13:22 INFO - 2015-11-19 04:13:22,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46634/tests/dromaeo/cssquery-prototype.html) 04:13:22 INFO - 2015-11-19 04:13:22,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 04:13:22 INFO - 2015-11-19 04:13:22,853 DEBUG : BROWSER_OUTPUT: 04:16:25 INFO - 2015-11-19 04:16:25,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46634/tests/dromaeo/cssquery-yui.html) 04:16:25 INFO - 2015-11-19 04:16:25,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 141717504 04:16:25 INFO - 2015-11-19 04:16:25,773 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/dromaeo/cssquery-yui.html (next: http://localhost:46634/tests/dromaeo/cssquery-dojo.html) 04:19:28 INFO - 2015-11-19 04:19:28,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 144384000 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:19:28 INFO - 2015-11-19 04:19:28,564 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3259.8207098609573;3283.40898638245;3288.6053673559177;3307.5534802801612;3322;5326;5428.212909128174;5433.185022246665;5436.72816359182;5439.129739241722;5311.920321195185;5355.464453554642;5368.570514358852;5417.3770016448125;5447.536959358459;4889.095517329297;4973.278874563186;5009.949900501003;5024.371953505812;5025.798968041292;4984.700917944917;5028.7485625718755;5045.016221836725;5067.1385864402955;5068.518490743373;4907.803687852482;4947.356843610343;5010.69935803853;5072;5075.568576670988;5006;5008.974955125237;5009.273655319995;5040.143175660147;5062.063518249136;4905.803767849282;4993.90012199754;5009.949900501021;5010.038054714914;5016.473270306638;5272.472752724735;5302.416734159278;5320.813771518017;5343;5368.516833485005;5909.556783241274;5957.046872500379;5959.046552551571;5964.075568286922;5973.462388385066;5729.770809167629;5830.271216097988;5993.340732519419;6008.3390827009;6009.248843894513;5516.724163791794;5564.054110801133;5571.164325351189;5575.470330318613;5608.10270356741;6009.969950150221;6034.215551978303;6045.183900173508;6048.5765996380715;6051.243594550681;5609.158626206102;5706.3722990471015;5728.341240757366;5860.501857342174;5870.765169393262;5839.211706419664;5900;5924.259467566554;5930.7924222652;5967.850803729854;5881.441263080001;5972.313183983811;5988.520918326523;5990.580659353891;6007.15899774032;5785.4793068623185;5797.8550536236935;5915.349311575723;5958.910616340759;5972.044472884318;4562.840300589463;4570.451545814523;4574.45106587205;4575.542445755398;4614.446266447981;4077.7757223353;4082.2856000199845;4089.0595163112057;4098.897527561835;4140.4617399737845;5488.53347465462;5546.334439867242;5573.721313934287;5628.859278517988;5727;5833;5870.442307980735;5881.9705901470215;5914.408559144051;5918.053111502139;5588.720563971785;5624.690642014647;5634.915476267859;5644.096944488862;5645.858853528694;4955.306257124005;5026.321446604735;5043;5087.592992560586;5134.974325128351;6028.2766068072115;6076.058210977306;6079.969600151971;6087.634741915499;6090.847728806727;5734.139879018181;5911.935851546763;5915.763369465173;5922.082077278029;5937.821865344046;5917.970410147922;5990.430909063632;6037.939620603914;6048.21373221496;6087.9391206087375;5845.532357411482;5894.263217097863;5898;5899.734511947058;5909.793157239476;5753.884922301614;5834.124881267844;5970.910436343545;5986.16193732869;5986.610870293417;5770.855728606651;5808.36108028125;5812.622179558484;5835.44563266489;5867.823965281048;5696.658200507983;5705.7147142643535;5720.170575266647;5721.22763426932;5730.426957304237;5586.301712285965;5601.6358936668985;5645.745941432728;5648.265725455829;5667.744951477276;5718.1708652246025;5744;5761.135829625589;5774.595778295647;5804.477597016289;5711;5758.222639943554;5775.33583637887;5792.247007888947;5796.768129274782 04:19:28 INFO - 2015-11-19 04:19:28,568 DEBUG : BROWSER_OUTPUT: |1;ext.html;596.0939372154326;604.4710877981768;621.2638023941629;637.4517914593449;655.2170156662789;39718;40345.394819077665;40361.798191009;40451.190976180456;40499.39250911235;40944.79527602358;41316.17367652652;41374.379384309184;41374.58625413745;41551.37672934908;8549.316054715624;8738.956305218466;8743.737687869343;8746.737597872043;8762.12378762125;8483.194096560817;8511.361647876434;8539.1887770662;8571.14288571144;8587.871181932276;8491.490510569354;8586;8635.870461943075;8661.913380866205;8663.913360866374;8512.404131710782;8514.446560973578;8531.658733650647;8560.400771945966;8583.613737381864;8448.23965843077;8507.957460212721;8556.61495232716;8613.870791938127;8624.353173511949;38334.42498362527;38533;38583.22833543314;38715.61284387148;38756.80621596874;3337.9499307510405;3402.4556071028514;3627.6372362763514;4095.9180816383805;4151.982764222755;30121.698783012107;30128.698713012807;30350.241243968856;31357.52963705546;31491.37017259642;3563.55455568054;3571.0715214044276;3579.194681196736;3661.3226553087766;3688.668019878197;267433;268013;269185;269980;270444.64777676185;41705.165896681894;42155.15689686189;59681.50796230129;60192.38845669274;60214.69892650509;42104.78947605304;42116.78941605334;42119.78802119825;42206.78896605497;42368.36447453291;15153.393864245527;15213.771793423108;15222.314995824992;15378.769318460232;15399.384024638888;12137.817932731015;12148.939255303667;12149.331786751636;12178.208416453079;12247.632571022883;14322.212278324583;14471.78292325616;14531.166422547501;14549.490767823076;14605.488807891672;5926.644401335933;5944.484156540141;5954.374790647006;6028.608140470856;6064.393560643988;977.237754551451;985.9795112058985;994.105305225303;1049.5906596427399;1085.3433672627946;28700.569491457645;28721.712782871902;28833.71166288352;29109.85445072761;29110.272243193667;1083.8049151152868;1084.6474895658941;1098.9999100818218;1149.8390225368455;1161.2219812725493;14897.808175345946;15023.924880375529;15056.569625885524;15280.541583752505;15291.770623440658;393826;397275;397680;397786;400732;53917.1912421314;54276.657867370515;54291.72854135783;54407.455925441034;54434.45565544373;1356.071091302461;1361.1968938326238;1372.7529044771836;1381.896357773171;1392.1229625335973;27751.583726244527;28482;28505.857470712515;28701.712982869903;28998.710012899603;44677.32984005308;44760.77619611881;45103.09793804171;45125.77437112793;45186.774066130776;307451;308144;310150;311954;314703;28289.15132546027;28799.136025919255;31155.53266700956;32063.519047214777;32209.67790322067;38668.419973699856;38859;39310.2137957245;39446.60553394429;39672.40491392689;31910;32208;32554.34891302208;32916.50625240671;33052.50421243635;34824.30351392907;35272.29455410826;35296.11759706028;35546.28907421889;35770.64229357673;35069;35716.64283357237;35966.280674386886;35987;36030.8198459006;30109.397812044073;32422.35155296928;32697.836510817295;32845.178870527474;33016.66983330136;24830.25509234726;24857.87571062133;24998.75001249964;25047.12335068264;25181.118660846783 04:19:28 INFO - 2015-11-19 04:19:28,568 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.99105022374437;358.63598447575697;359.6673077403401;360.8863208089452;361.2449979542756;12397.752044959096;12755.234685918827;16679;16783.328666853326;17672.116394180273;11682.707932301697;11747.941260293686;11752.529898804038;11831.822522662167;12110.636680899564;4540.341650460681;4656.301554766778;4660.533946605329;4680;4686.179918514246;4321.308590625501;4335.588119128678;4351.521332653406;4355.085432059255;4359.847405340814;4558.179527685015;4648.070385922812;4676.181668208067;6384;6544.051112588696;6423.197100362455;6539.6730163491875;6566.67166641666;6572.835679108012;6867.725290988355;6549.115869357671;6567.802965911031;6576.539642224999;6580.4406625436895;6594.208694956636;21747.456313592127;22715.886420567957;22778.088876444923;22889.31332060041;23778.286651400485;2255.8872056397113;2280.3501002214457;2323.6514522821544;2336.1706594159;2546.3379521324405;14223.359948802328;14406.207658578774;14567.125972441687;14701.1914344711;14815.111093334435;2001.6497113005166;2028.148177765342;2037.6739721644465;2041.5508588110592;2087.405089549486;59734.402655973754;60306.39693603096;60847.695761521354;66471.66764166196;69380.30619693789;15287.159206243541;16087;16184.109873957046;16185.67628647444;16211.351545938267;23769.762302376756;23770.524589508113;24007.759922400553;24233.39416514601;24286.392840179138;9315.72052838416;9422;9431.717048488556;9469.721587585587;9470.668526601536;7494.437917156126;7545.094588649287;7545.849083018309;7557.206493318233;7835.843283134305;7875.409344299086;8053.798655033671;8068.112507624157;8113.959430202811;8138.755837324889;1235.3267469229293;3328.9667103328657;3368.646292139339;3411.300683359905;3458.7060099891287;462.4589230600206;472.8085125524168;482.5946205187659;492.6403725280565;493.91603427417425;10783.730406739738;11159.386233757059;11258.32450052983;11328.660140195807;11331.32012079278;497.81580815098647;501.9974900125476;504.0045909329119;504.72744717851947;510.3671447405191;6010.158577799111;6064.151018857364;6081.939180608226;6120.969395152996;6157.876842463125;578092;582658;589726;591618;592654;70786.64606677036;75938.24061759422;76503;77311.2268877304;78199.60900195462;549.7471163264943;559.7061542690038;559.8712296171904;565.3978512883766;565.4712843491267;10948.34309941406;11261.155413344195;11264.887351126385;11334.60328888485;11435.942820285845;33819.830900846326;34702.652973470955;34952.300953980266;35577.822110890316;35846.10384740298;45136;45932;46158.538414615425;46649.53350466588;46795.29807052965;6608.273089960197;6755.966220168868;7014.368706816411;7062.646867656699;7062.8940565890525;12510;12644.051696122644;12792.552260670831;12823;12917.418716157983;8743.34424918121;10028.899711002796;10804.297720648132;10881.673549793519;11068.557257709923;10480.790384192425;10487.580496780043;10535.63125290611;10582;10715.571377144826;9668.854967175357;10641.882602326645;10694.091002264895;10736.194785390971;11352.886471135183;6546.24718157418;6698.866022679422;6709.194896612437;6734.764283250062;6769.93230067693;10044.196464282986;10115.14021308197;10410.1671866249;10434.739131521468;10448.634297799541 04:19:28 INFO - 2015-11-19 04:19:28,571 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1509.7886295918565;1713.520214339985;1776.271728591277;1788.9284428622855;1803.6302557975616;7203.5317704349245;7482.5510469371875;7515.436342274324;7611.429142814283;7764.378849692025;7374.225706300842;7473.850522989537;7483.513571617841;7550.244975502447;7565;2140.047678782942;2160.8811515366647;2163.524024714568;2164.491344534033;2173.847830651855;2275.476640372707;2301.723793144825;2322.140807901079;2322.222055611364;2327.93016209514;2107.546877421354;2129.4569884679386;2203.327984964585;2216.445888527868;2223.021870377037;2170.728658917635;2247.045005872514;2256.548690261946;2258.0967612954787;2258.446680563256;2231.141010710872;2311.5261371418987;2319.431739223901;2330.673705681206;2332.825038122148;7500.624968751596;7513.962430187868;7529.962350188269;7623.313901748814;7651.770446886602;4574.839880604163;4677.672562920597;4723.551262630044;4724.4330680318235;4724.5984091352275;3033.6662967073603;3157.1317887580867;3225.4679027462003;3232.2404235004756;3263.2983908459796;1061.5488417422641;1085.8045551800674;1103.1175059952006;1132.6941725734005;1147.8966892979672;10319.948400258027;10379.636712715093;10388.37669739818;10403.427811470367;10415.843762343571;4070.9796451018146;4110.527289361702;4163.437935878678;4169.437125988014;4181.184668989578;8531.616077276538;8560.443571167854;8576.271016963503;8608.483490990435;8612.311015118776;4645.790939407735;4663.207254766698;4667.883302917387;4669.813207471731;4679.391679081766;4205;4248.957510424856;4265.1469706058915;4309.827606895752;4314.266574682249;3489.7382696297373;3520.876769313113;3544.5392099026963;3563.7883119739413;3576.40989236773;1091.1925175370327;1121.9270747401392;1131.4342828585707;1133.331334512625;1145.570411095839;1030.9329893556894;1043.6921108273077;1081.210716177195;1102.856628638288;1189.7025743564109;7068.611226382495;7145.535540189871;7147.8570428592175;7152.856942861114;7157.6779044943105;1128.424503503203;1142.9657110286705;1151.3494875395543;1158.9081707517842;1171.6075114836456;5572.944270557243;5577.470140336662;5604.355499117653;5618.803341883015;5633.042382794934;8969.058248883905;9158.86261706075;9355.391899526508;9409.858852117224;9415.293852961055;9204.815903682023;9243.861342079874;9259.537023148816;9289.163975242125;9304.16262536375;7026.26224246457;7055.858882822315;7154.678039488132;7168.498205125696;7185.604791736505;6835.863282734417;6842.965785171043;6860.588364698134;6864.519483636098;6880.518363714492;7856.882146767917;7950.7217247396065;8022.237887400687;8042.87935680977;8098;8067.717629882926;8167.224113709188;8181.468204566684;8187.754367368989;8282.544460054514;6194.907076393768;6528.347165283433;6566.868662626816;6601.702923368364;6643.069970204272;7047.189573199148;7294.671739771829;7297.744578939924;7298.96350518244;7306.7077316906725;6750.763723269662;6837.794866154023;6849.863002739818;6965.268646792014;7009.12385951756;6553.475721942328;6620.172478440195;6650.96909978954;6657.600543967377;6668.333166683293;6943.062686537252;6976.5465244758925;6978.162620485574;7007.894881576678;7013.018177455262;6117.1130186123655;6172.259328880563;6179.752809887555;6185.84535386619;6201.10084037803;6278.215223097113;6305.684715764285;6347.460465860454;6353.078803573549;6361.936380636134 04:19:28 INFO - 2015-11-19 04:19:28,573 DEBUG : BROWSER_OUTPUT: |4;prototype.html;328.8848902883991;329.8202479648591;333.8647847621714;338.9813610101645;341.7061327258557;6163.876722465548;6258.812235632932;6261.3425590313045;6277.811665650032;6305.684715764216;6117.66352850593;6192.41172088652;6212.471939885115;6250.40621140992;6271.216097987752;4724.645651576128;4737.502562230968;4756.1914474539235;4765.475797662254;4770.6422018348585;4726.629277509518;4762.28565715142;4771.069641419925;4773.71357718538;4775.11660342836;4637.350770892078;4656.4877863434995;4711;4712.858614241578;4726.8581942541605;4673.299005149221;4684.8360307389075;4692.41344831896;4697.271922851964;4702.106599746037;3950;4043.6158564936286;4080.6327430531096;4112.568180341081;4125.525564560084;5856.238688970407;5880.794172203952;5884.323302820188;5886;5917;5414.864628384322;5442.346918369782;5460.863478413032;5472.315960504937;5472.315960504937;6572.047053177311;6578.3092775258865;6595;6605.900911486331;6606.1412016438035;4375.496817865923;4455.688101832873;4489.855086952839;4491.483479399878;4515.525869783691;6824.351686589766;6866.382025617669;6903.620300883449;6935.4104901082965;6944.965275173642;4594.448666160082;4610.561996610317;4610.792514336863;4614.976925115353;4630.236011058205;4607.76961151941;4649.163150632851;4680.812767489262;4691.7654117294;4693.084848454519;5457.072297709399;5460.481254280837;5465.371482279509;5468.48049435303;5473.67157970523;6622.569532980341;6686.1642294713165;6694.933050669431;6697.3637504437;6717.764878229238;1654.7186978213733;1670.323518974817;1672;1675.9329626815036;1676.0530300380246;1102.2449622008949;1103.9668809935715;1112.9554817807198;1125.3754166437707;1129.5877004893318;6496.830570497262;6513.185851768529;6514.088027676129;6519.4132528072705;6523.11937888379;6925.480588955747;6929;6934.237233904267;6935.791926242221;6946.6179360134665;6412.35876412355;6464.903026454607;6477.222733272038;6477.995910633859;6496.350364963466;3747.5502939647417;3768.453574231721;3773.3208022555655;3775.716821238418;3779.2063666629765;6930.3762661360715;7051.29487051301;7160;7250.7462238822445;7251.1661158966335;7103.857922841515;7125.53684010548;7141.464390170758;7155.17715462718;7174.139103307636;7077.73512476013;7188;7197.496175267681;7207.387372073327;7223.747168849065;6932.653367331714;6939.653017349011;6947.166340039228;6955.826104347432;6958.652067396712;6835.282295358916;6875.243723190545;6883.896741548981;6888.070110535214;6891.620960847202;7010.649467526705;7190.604516751629;7191.820204494929;7204.387627051549;7204.387627051759;4628.166929952641;4639.257718764981;4640.953590464187;4645.047765208192;4651.162790697707;6901.62041087745;6910.585364878123;6929.965350173217;6930.995005724242;6962.7911162665205;6525.967370163119;6675.165604299463;6694.464442844658;6702.631355275506;6723.462123030048;6630.3038180992235;6657.933420665731;6693.933060669331;6711.228208756055;6718.361755633207;6524;6578.736850525926;6583.80248592543;6584.242812076673;6593.703283352164;6633;6703.8324041897395;6740.898886516608;6759.087523184504;6767.221769496571;6543.836404089936;6581.703823327866;6589.604623722592;6591.802245932629;6599.274079851309 04:19:28 INFO - 2015-11-19 04:19:28,574 DEBUG : BROWSER_OUTPUT: |5;yui.html;782.6908371193379;795.4988357334878;869.8782170496131;880.8458519759045;893.7318804358691;14748.262586870655;14890.404383824634;14943.701125977488;15039.473618423357;15094;14632.561023169295;14720.337584808682;14746.410143594243;14756.967012309142;14802.185879776634;689.7723751162105;692.3906961873545;811.1766556944691;821.995890020549;823.8146417056145;800.1478425476878;802.0615879421063;804.1154729797234;807.0355924670022;811.180707485441;848.817504236589;854.2482615298528;860;866.0603245478663;867.8698195270697;849.8342823149488;854.7307598106607;855.6149732620314;857.3698331726176;858.7767180533107;614.0053113955377;616.2574098211644;621.3972446726668;622.0948519903529;623.382850977529;13064.150830196008;13099.672508187276;13152.342382880817;13168.144070635473;13215.074944753871;10204.74488137795;10286.279960402775;10488.160947124288;10506.317089389166;10561.049505544537;10065.094141527297;10067.5469603868;10076;10095.495225238708;10228.488575571266;3154.9684503154904;3191.872325106993;3209;3225.048610659861;3237.9838100809343;45053.32420013735;45063.77468112671;45276.54723452756;45421;45647.77176114132;7418.146913104954;7504.849903001909;7931.365490760725;7955.24425179607;7981.08217554977;11878.465469053914;11896.345700986529;11914.166008379503;11920.165588408901;11975.341356225317;6710.295418981034;6733.9326606734285;6776.05135281061;6788.93211067883;6795.524313298021;4366.825326986885;4372.322290045048;4377.9124417511475;4450.376947227391;4494.505604383515;2717.592361145844;2744.9039283625375;2761.9309517262227;2762.240383894445;2763.8203516771346;452.984145554904;467.4624182190508;471.3777813286429;471.86551832728196;471.92636751390177;612.9304363885049;643.173522024206;651.5211319680031;688.1192074145102;735.400648471494;8801.25189358899;8850.557472126367;8925.821483570293;8960.372773905894;9017.909820901838;569.1718549510452;578.4706993101265;687.6355531568277;695.7495301691387;741.4253953186216;3974.5429275633096;4434.423524941737;4531.68278220528;4590.8163673453355;4603.033362993742;58916;59738.402615974155;60194.097088543705;60757.69621151866;62099.6895015522;51956.48043519592;52276.47723522716;52741.73629131907;53039.20441193385;57751.133732994036;50968;51485.74257128765;52195.478045219825;53086;54718.726406367714;8760.912390876265;8865.911340886509;8892;9022.548872556477;9231.86152207704;33750.83124584361;33967;34729;36245.27509449849;36546.45180322351;38672;41296.587034129276;44992.77503612461;45316.77341613271;45566.54433455623;11144.275622084539;11927.642170734893;12122.878771212176;12255.203411778206;12584.433700483683;12451.564195253122;12649.114561980941;12706.68233294138;12757.744845103232;12811.231326120462;11272.66182014541;11402.144839136932;11472.770544589228;11534.134939879375;11718.179727419;11852.940735296614;11874.287542747463;12194.756104877675;12415.62753117408;12587.370631468573;11110.555577777122;11205.103591712807;11226.382548959558;11303.604373846876;11536.307821530734;10044.447555384524;10212.131968782736;10374.22193335518;10574.524146413276;10710;9303.906960930575;9959.850602241117;10128.240381971234;10181.287309888237;10186.388816671024 04:19:28 INFO - 2015-11-19 04:19:28,574 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:19:28 INFO - 2015-11-19 04:19:28,574 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935568561__endTimestamp 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:19:28 INFO - 2015-11-19 04:19:28,575 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:19:28 INFO - 2015-11-19 04:19:28,576 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,576 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5476.64 Median:5706.37 stddev:605.74 (10.6%) stddev-sans-first:582.10 04:19:28 INFO - 2015-11-19 04:19:28,577 DEBUG : BROWSER_OUTPUT: Values: 3259.8 3283.4 3288.6 3307.6 3322.0 5326.0 5428.2 5433.2 5436.7 5439.1 5311.9 5355.5 5368.6 5417.4 5447.5 4889.1 4973.3 5009.9 5024.4 5025.8 4984.7 5028.7 5045.0 5067.1 5068.5 4907.8 4947.4 5010.7 5072.0 5075.6 5006.0 5009.0 5009.3 5040.1 5062.1 4905.8 4993.9 5009.9 5010.0 5016.5 5272.5 5302.4 5320.8 5343.0 5368.5 5909.6 5957.0 5959.0 5964.1 5973.5 5729.8 5830.3 5993.3 6008.3 6009.2 5516.7 5564.1 5571.2 5575.5 5608.1 6010.0 6034.2 6045.2 6048.6 6051.2 5609.2 5706.4 5728.3 5860.5 5870.8 5839.2 5900.0 5924.3 5930.8 5967.9 5881.4 5972.3 5988.5 5990.6 6007.2 5785.5 5797.9 5915.3 5958.9 5972.0 4562.8 4570.5 4574.5 4575.5 4614.4 4077.8 4082.3 4089.1 4098.9 4140.5 5488.5 5546.3 5573.7 5628.9 5727.0 5833.0 5870.4 5882.0 5914.4 5918.1 5588.7 5624.7 5634.9 5644.1 5645.9 4955.3 5026.3 5043.0 5087.6 5135.0 6028.3 6076.1 6080.0 6087.6 6090.8 5734.1 5911.9 5915.8 5922.1 5937.8 5918.0 5990.4 6037.9 6048.2 6087.9 5845.5 5894.3 5898.0 5899.7 5909.8 5753.9 5834.1 5970.9 5986.2 5986.6 5770.9 5808.4 5812.6 5835.4 5867.8 5696.7 5705.7 5720.2 5721.2 5730.4 5586.3 5601.6 5645.7 5648.3 5667.7 5718.2 5744.0 5761.1 5774.6 5804.5 5711.0 5758.2 5775.3 5792.2 5796.8 04:19:28 INFO - 2015-11-19 04:19:28,577 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,578 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47982.58 Median:36008.91 stddev:86821.93 (241.1%) stddev-sans-first:86992.59 04:19:28 INFO - 2015-11-19 04:19:28,579 DEBUG : BROWSER_OUTPUT: Values: 596.1 604.5 621.3 637.5 655.2 39718.0 40345.4 40361.8 40451.2 40499.4 40944.8 41316.2 41374.4 41374.6 41551.4 8549.3 8739.0 8743.7 8746.7 8762.1 8483.2 8511.4 8539.2 8571.1 8587.9 8491.5 8586.0 8635.9 8661.9 8663.9 8512.4 8514.4 8531.7 8560.4 8583.6 8448.2 8508.0 8556.6 8613.9 8624.4 38334.4 38533.0 38583.2 38715.6 38756.8 3337.9 3402.5 3627.6 4095.9 4152.0 30121.7 30128.7 30350.2 31357.5 31491.4 3563.6 3571.1 3579.2 3661.3 3688.7 267433.0 268013.0 269185.0 269980.0 270444.6 41705.2 42155.2 59681.5 60192.4 60214.7 42104.8 42116.8 42119.8 42206.8 42368.4 15153.4 15213.8 15222.3 15378.8 15399.4 12137.8 12148.9 12149.3 12178.2 12247.6 14322.2 14471.8 14531.2 14549.5 14605.5 5926.6 5944.5 5954.4 6028.6 6064.4 977.2 986.0 994.1 1049.6 1085.3 28700.6 28721.7 28833.7 29109.9 29110.3 1083.8 1084.6 1099.0 1149.8 1161.2 14897.8 15023.9 15056.6 15280.5 15291.8 393826.0 397275.0 397680.0 397786.0 400732.0 53917.2 54276.7 54291.7 54407.5 54434.5 1356.1 1361.2 1372.8 1381.9 1392.1 27751.6 28482.0 28505.9 28701.7 28998.7 44677.3 44760.8 45103.1 45125.8 45186.8 307451.0 308144.0 310150.0 311954.0 314703.0 28289.2 28799.1 31155.5 32063.5 32209.7 38668.4 38859.0 39310.2 39446.6 39672.4 31910.0 32208.0 32554.3 32916.5 33052.5 34824.3 35272.3 35296.1 35546.3 35770.6 35069.0 35716.6 35966.3 35987.0 36030.8 30109.4 32422.4 32697.8 32845.2 33016.7 24830.3 24857.9 24998.8 25047.1 25181.1 04:19:28 INFO - 2015-11-19 04:19:28,579 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,579 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29722.89 Median:4353.30 stddev:95889.32 (2202.7%) stddev-sans-first:96132.96 04:19:28 INFO - 2015-11-19 04:19:28,581 DEBUG : BROWSER_OUTPUT: Values: 358.0 358.6 359.7 360.9 361.2 12397.8 12755.2 16679.0 16783.3 17672.1 11682.7 11747.9 11752.5 11831.8 12110.6 4540.3 4656.3 4660.5 4680.0 4686.2 4321.3 4335.6 4351.5 4355.1 4359.8 4558.2 4648.1 4676.2 6384.0 6544.1 6423.2 6539.7 6566.7 6572.8 6867.7 6549.1 6567.8 6576.5 6580.4 6594.2 21747.5 22715.9 22778.1 22889.3 23778.3 2255.9 2280.4 2323.7 2336.2 2546.3 14223.4 14406.2 14567.1 14701.2 14815.1 2001.6 2028.1 2037.7 2041.6 2087.4 59734.4 60306.4 60847.7 66471.7 69380.3 15287.2 16087.0 16184.1 16185.7 16211.4 23769.8 23770.5 24007.8 24233.4 24286.4 9315.7 9422.0 9431.7 9469.7 9470.7 7494.4 7545.1 7545.8 7557.2 7835.8 7875.4 8053.8 8068.1 8114.0 8138.8 1235.3 3329.0 3368.6 3411.3 3458.7 462.5 472.8 482.6 492.6 493.9 10783.7 11159.4 11258.3 11328.7 11331.3 497.8 502.0 504.0 504.7 510.4 6010.2 6064.2 6081.9 6121.0 6157.9 578092.0 582658.0 589726.0 591618.0 592654.0 70786.6 75938.2 76503.0 77311.2 78199.6 549.7 559.7 559.9 565.4 565.5 10948.3 11261.2 11264.9 11334.6 11435.9 33819.8 34702.7 34952.3 35577.8 35846.1 45136.0 45932.0 46158.5 46649.5 46795.3 6608.3 6756.0 7014.4 7062.6 7062.9 12510.0 12644.1 12792.6 12823.0 12917.4 8743.3 10028.9 10804.3 10881.7 11068.6 10480.8 10487.6 10535.6 10582.0 10715.6 9668.9 10641.9 10694.1 10736.2 11352.9 6546.2 6698.9 6709.2 6734.8 6769.9 10044.2 10115.1 10410.2 10434.7 10448.6 04:19:28 INFO - 2015-11-19 04:19:28,581 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,581 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5320.67 Median:6144.69 stddev:2706.87 (44.1%) stddev-sans-first:2699.31 04:19:28 INFO - 2015-11-19 04:19:28,582 DEBUG : BROWSER_OUTPUT: Values: 1509.8 1713.5 1776.3 1788.9 1803.6 7203.5 7482.6 7515.4 7611.4 7764.4 7374.2 7473.9 7483.5 7550.2 7565.0 2140.0 2160.9 2163.5 2164.5 2173.8 2275.5 2301.7 2322.1 2322.2 2327.9 2107.5 2129.5 2203.3 2216.4 2223.0 2170.7 2247.0 2256.5 2258.1 2258.4 2231.1 2311.5 2319.4 2330.7 2332.8 7500.6 7514.0 7530.0 7623.3 7651.8 4574.8 4677.7 4723.6 4724.4 4724.6 3033.7 3157.1 3225.5 3232.2 3263.3 1061.5 1085.8 1103.1 1132.7 1147.9 10319.9 10379.6 10388.4 10403.4 10415.8 4071.0 4110.5 4163.4 4169.4 4181.2 8531.6 8560.4 8576.3 8608.5 8612.3 4645.8 4663.2 4667.9 4669.8 4679.4 4205.0 4249.0 4265.1 4309.8 4314.3 3489.7 3520.9 3544.5 3563.8 3576.4 1091.2 1121.9 1131.4 1133.3 1145.6 1030.9 1043.7 1081.2 1102.9 1189.7 7068.6 7145.5 7147.9 7152.9 7157.7 1128.4 1143.0 1151.3 1158.9 1171.6 5572.9 5577.5 5604.4 5618.8 5633.0 8969.1 9158.9 9355.4 9409.9 9415.3 9204.8 9243.9 9259.5 9289.2 9304.2 7026.3 7055.9 7154.7 7168.5 7185.6 6835.9 6843.0 6860.6 6864.5 6880.5 7856.9 7950.7 8022.2 8042.9 8098.0 8067.7 8167.2 8181.5 8187.8 8282.5 6194.9 6528.3 6566.9 6601.7 6643.1 7047.2 7294.7 7297.7 7299.0 7306.7 6750.8 6837.8 6849.9 6965.3 7009.1 6553.5 6620.2 6651.0 6657.6 6668.3 6943.1 6976.5 6978.2 7007.9 7013.0 6117.1 6172.3 6179.8 6185.8 6201.1 6278.2 6305.7 6347.5 6353.1 6361.9 04:19:28 INFO - 2015-11-19 04:19:28,583 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,583 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5559.78 Median:6438.63 stddev:1709.03 (26.5%) stddev-sans-first:1668.12 04:19:28 INFO - 2015-11-19 04:19:28,584 DEBUG : BROWSER_OUTPUT: Values: 328.9 329.8 333.9 339.0 341.7 6163.9 6258.8 6261.3 6277.8 6305.7 6117.7 6192.4 6212.5 6250.4 6271.2 4724.6 4737.5 4756.2 4765.5 4770.6 4726.6 4762.3 4771.1 4773.7 4775.1 4637.4 4656.5 4711.0 4712.9 4726.9 4673.3 4684.8 4692.4 4697.3 4702.1 3950.0 4043.6 4080.6 4112.6 4125.5 5856.2 5880.8 5884.3 5886.0 5917.0 5414.9 5442.3 5460.9 5472.3 5472.3 6572.0 6578.3 6595.0 6605.9 6606.1 4375.5 4455.7 4489.9 4491.5 4515.5 6824.4 6866.4 6903.6 6935.4 6945.0 4594.4 4610.6 4610.8 4615.0 4630.2 4607.8 4649.2 4680.8 4691.8 4693.1 5457.1 5460.5 5465.4 5468.5 5473.7 6622.6 6686.2 6694.9 6697.4 6717.8 1654.7 1670.3 1672.0 1675.9 1676.1 1102.2 1104.0 1113.0 1125.4 1129.6 6496.8 6513.2 6514.1 6519.4 6523.1 6925.5 6929.0 6934.2 6935.8 6946.6 6412.4 6464.9 6477.2 6478.0 6496.4 3747.6 3768.5 3773.3 3775.7 3779.2 6930.4 7051.3 7160.0 7250.7 7251.2 7103.9 7125.5 7141.5 7155.2 7174.1 7077.7 7188.0 7197.5 7207.4 7223.7 6932.7 6939.7 6947.2 6955.8 6958.7 6835.3 6875.2 6883.9 6888.1 6891.6 7010.6 7190.6 7191.8 7204.4 7204.4 4628.2 4639.3 4641.0 4645.0 4651.2 6901.6 6910.6 6930.0 6931.0 6962.8 6526.0 6675.2 6694.5 6702.6 6723.5 6630.3 6657.9 6693.9 6711.2 6718.4 6524.0 6578.7 6583.8 6584.2 6593.7 6633.0 6703.8 6740.9 6759.1 6767.2 6543.8 6581.7 6589.6 6591.8 6599.3 04:19:28 INFO - 2015-11-19 04:19:28,585 DEBUG : BROWSER_OUTPUT: 04:19:28 INFO - 2015-11-19 04:19:28,585 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13856.04 Median:22864.77 stddev:16481.62 (72.1%) stddev-sans-first:16498.62 04:19:28 INFO - 2015-11-19 04:19:28,585 DEBUG : BROWSER_OUTPUT: Values: 782.7 795.5 869.9 880.8 893.7 14748.3 14890.4 14943.7 15039.5 15094.0 14632.6 14720.3 14746.4 14757.0 14802.2 689.8 692.4 811.2 822.0 823.8 800.1 802.1 804.1 807.0 811.2 848.8 854.2 860.0 866.1 867.9 849.8 854.7 855.6 857.4 858.8 614.0 616.3 621.4 622.1 623.4 13064.2 13099.7 13152.3 13168.1 13215.1 10204.7 10286.3 10488.2 10506.3 10561.0 10065.1 10067.5 10076.0 10095.5 10228.5 3155.0 3191.9 3209.0 3225.0 3238.0 45053.3 45063.8 45276.5 45421.0 45647.8 7418.1 7504.8 7931.4 7955.2 7981.1 11878.5 11896.3 11914.2 11920.2 11975.3 6710.3 6733.9 6776.1 6788.9 6795.5 4366.8 4372.3 4377.9 4450.4 4494.5 2717.6 2744.9 2761.9 2762.2 2763.8 453.0 467.5 471.4 471.9 471.9 612.9 643.2 651.5 688.1 735.4 8801.3 8850.6 8925.8 8960.4 9017.9 569.2 578.5 687.6 695.7 741.4 3974.5 4434.4 4531.7 4590.8 4603.0 58916.0 59738.4 60194.1 60757.7 62099.7 51956.5 52276.5 52741.7 53039.2 57751.1 50968.0 51485.7 52195.5 53086.0 54718.7 8760.9 8865.9 8892.0 9022.5 9231.9 33750.8 33967.0 34729.0 36245.3 36546.5 38672.0 41296.6 44992.8 45316.8 45566.5 11144.3 11927.6 12122.9 12255.2 12584.4 12451.6 12649.1 12706.7 12757.7 12811.2 11272.7 11402.1 11472.8 11534.1 11718.2 11852.9 11874.3 12194.8 12415.6 12587.4 11110.6 11205.1 11226.4 11303.6 11536.3 10044.4 10212.1 10374.2 10574.5 10710.0 9303.9 9959.9 10128.2 10181.3 10186.4 04:19:28 INFO - 2015-11-19 04:19:28,585 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:19:28 INFO - 2015-11-19 04:19:28,586 DEBUG : BROWSER_OUTPUT: 04:19:29 INFO - 2015-11-19 04:19:29,273 INFO : Browser exited with error code: 0 04:19:29 INFO - 2015-11-19 04:19:29,295 INFO : Completed test dromaeo_css (00:18:30) 04:19:29 INFO - 2015-11-19 04:19:29,295 INFO : Starting test kraken 04:19:29 INFO - 2015-11-19 04:19:29,295 DEBUG : operating with platform_type : linux_ 04:19:29 INFO - 2015-11-19 04:19:29,295 INFO : Initialising browser for kraken test... 04:19:29 INFO - 2015-11-19 04:19:29,301 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphtfRh0/profile http://localhost:46634/getInfo.html 04:19:34 INFO - 2015-11-19 04:19:34,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:19:34 INFO - 2015-11-19 04:19:34,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:19:34 INFO - 2015-11-19 04:19:34,356 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:19:34 INFO - 2015-11-19 04:19:34,356 DEBUG : BROWSER_OUTPUT: __metrics 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/tmphtfRh0/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,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 142577664 04:19:47 INFO - 2015-11-19 04:19:47,233 DEBUG : BROWSER_OUTPUT: 04:19:49 INFO - 2015-11-19 04:19:49,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:50 INFO - 2015-11-19 04:19:50,323 DEBUG : BROWSER_OUTPUT: RSS: Main: 142139392 04:19:50 INFO - 2015-11-19 04:19:50,323 DEBUG : BROWSER_OUTPUT: 04:19:52 INFO - 2015-11-19 04:19:52,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-dft) 04:19:53 INFO - 2015-11-19 04:19:53,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 141844480 04:19:53 INFO - 2015-11-19 04:19:53,547 DEBUG : BROWSER_OUTPUT: 04:19:56 INFO - 2015-11-19 04:19:56,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-fft) 04:19:56 INFO - 2015-11-19 04:19:56,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 135933952 04:19:56 INFO - 2015-11-19 04:19:56,991 DEBUG : BROWSER_OUTPUT: 04:19:58 INFO - 2015-11-19 04:19:58,984 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46634/tests/kraken/driver.html?testName=audio-oscillator) 04:19:59 INFO - 2015-11-19 04:19:59,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 136785920 04:19:59 INFO - 2015-11-19 04:19:59,557 DEBUG : BROWSER_OUTPUT: 04:20:01 INFO - 2015-11-19 04:20:01,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:02 INFO - 2015-11-19 04:20:02,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 137256960 04:20:02 INFO - 2015-11-19 04:20:02,378 DEBUG : BROWSER_OUTPUT: 04:20:05 INFO - 2015-11-19 04:20:05,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:05 INFO - 2015-11-19 04:20:05,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 137629696 04:20:05 INFO - 2015-11-19 04:20:05,979 DEBUG : BROWSER_OUTPUT: 04:20:09 INFO - 2015-11-19 04:20:09,447 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46634/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:10 INFO - 2015-11-19 04:20:10,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 136814592 04:20:10 INFO - 2015-11-19 04:20:10,034 DEBUG : BROWSER_OUTPUT: 04:20:12 INFO - 2015-11-19 04:20:12,957 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46634/tests/kraken/driver.html?testName=json-parse-financial) 04:20:13 INFO - 2015-11-19 04:20:13,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 137805824 04:20:13 INFO - 2015-11-19 04:20:13,552 DEBUG : BROWSER_OUTPUT: 04:20:15 INFO - 2015-11-19 04:20:15,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:15 INFO - 2015-11-19 04:20:15,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 139407360 04:20:15 INFO - 2015-11-19 04:20:15,701 DEBUG : BROWSER_OUTPUT: 04:20:17 INFO - 2015-11-19 04:20:17,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:18 INFO - 2015-11-19 04:20:18,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 138149888 04:20:18 INFO - 2015-11-19 04:20:18,132 DEBUG : BROWSER_OUTPUT: 04:20:20 INFO - 2015-11-19 04:20:20,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:20 INFO - 2015-11-19 04:20:20,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 140091392 04:20:20 INFO - 2015-11-19 04:20:20,779 DEBUG : BROWSER_OUTPUT: 04:20:23 INFO - 2015-11-19 04:20:23,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:23 INFO - 2015-11-19 04:20:23,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 04:20:23 INFO - 2015-11-19 04:20:23,845 DEBUG : BROWSER_OUTPUT: 04:20:26 INFO - 2015-11-19 04:20:26,452 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:27 INFO - 2015-11-19 04:20:27,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 140267520 04:20:27 INFO - 2015-11-19 04:20:27,034 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,735 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46634/tests/kraken/driver.html?testName=ai-astar) 04:20:28 INFO - 2015-11-19 04:20:28,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 139644928 04:20:28 INFO - 2015-11-19 04:20:28,993 DEBUG : BROWSER_OUTPUT: 04:20:28 INFO - 2015-11-19 04:20:28,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:20:28 INFO - 2015-11-19 04:20:28,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:20:28 INFO - 2015-11-19 04:20:28,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;107;112;111;113;122;110;110;111;110 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;159;123;153;165;133;162;151;126;164;125 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;163;165;159;159;165;168;162 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;73;73;75;153;72;71;72;72 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;142;91;91;91;143;96;90;143 04:20:28 INFO - 2015-11-19 04:20:28,994 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;109;109;110;109;110;110;110;110 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;145;146;146;147;146;145;146 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;97;96;96;96;95;96 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;62;61;62;62;61;61;60;62;61 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;70;69;68;68;69;69 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;87;86;86;85;85;86;87 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;125;132;126;131;133;126;131;118;122 04:20:28 INFO - 2015-11-19 04:20:28,995 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;152;154;163;153;151;153;151;156;150 04:20:28 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;72;69;71;68;72;69;70;69;68 04:20:28 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:20:28 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935628987__endTimestamp 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:20:29 INFO - 2015-11-19 04:20:28,996 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:3.94 (3.5%) stddev-sans-first:4.18 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: Values: 112.0 107.0 112.0 111.0 113.0 122.0 110.0 110.0 111.0 110.0 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:156.00 stddev:17.39 (11.1%) stddev-sans-first:17.81 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: Values: 159.0 123.0 153.0 165.0 133.0 162.0 151.0 126.0 164.0 125.0 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.80 (1.7%) stddev-sans-first:2.96 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 163.0 165.0 159.0 159.0 165.0 168.0 162.0 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:72.50 stddev:25.43 (35.1%) stddev-sans-first:26.78 04:20:29 INFO - 2015-11-19 04:20:28,997 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 73.0 73.0 75.0 153.0 72.0 71.0 72.0 72.0 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:91.00 stddev:24.74 (27.2%) stddev-sans-first:25.56 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 142.0 91.0 91.0 91.0 143.0 96.0 90.0 143.0 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 109.0 109.0 110.0 109.0 110.0 110.0 110.0 110.0 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:20:29 INFO - 2015-11-19 04:20:28,998 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 96.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.71 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: Values: 63.0 62.0 61.0 62.0 62.0 61.0 61.0 60.0 62.0 61.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 70.0 69.0 68.0 68.0 69.0 69.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 87.0 86.0 86.0 85.0 85.0 86.0 87.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:129.50 stddev:4.78 (3.7%) stddev-sans-first:5.06 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: Values: 128.0 125.0 132.0 126.0 131.0 133.0 126.0 131.0 118.0 122.0 04:20:29 INFO - 2015-11-19 04:20:28,999 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:153.00 stddev:4.27 (2.8%) stddev-sans-first:3.94 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: Values: 147.0 152.0 154.0 163.0 153.0 151.0 153.0 151.0 156.0 150.0 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.63 (2.3%) stddev-sans-first:1.56 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 69.0 71.0 68.0 72.0 69.0 70.0 69.0 68.0 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:20:29 INFO - 2015-11-19 04:20:29,000 DEBUG : BROWSER_OUTPUT: 04:20:29 INFO - 2015-11-19 04:20:29,830 INFO : Browser exited with error code: 0 04:20:29 INFO - 2015-11-19 04:20:29,880 INFO : Completed test kraken (00:01:00) 04:20:29 INFO - 2015-11-19 04:20:29,880 INFO : Starting test v8_7 04:20:29 INFO - 2015-11-19 04:20:29,880 DEBUG : operating with platform_type : linux_ 04:20:29 INFO - 2015-11-19 04:20:29,880 INFO : Initialising browser for v8_7 test... 04:20:29 INFO - 2015-11-19 04:20:29,886 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOJnBm1/profile http://localhost:46634/getInfo.html 04:20:34 INFO - 2015-11-19 04:20:34,330 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:20:34 INFO - 2015-11-19 04:20:34,330 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:20:34 INFO - 2015-11-19 04:20:34,331 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:20:34 INFO - 2015-11-19 04:20:34,331 DEBUG : BROWSER_OUTPUT: __metrics 04:20:35 INFO - 2015-11-19 04:20:35,345 INFO : Browser initialized. 04:20:35 INFO - 2015-11-19 04:20:35,346 INFO : Running cycle 1/1 for v8_7 test... 04:20:35 INFO - 2015-11-19 04:20:35,346 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOJnBm1/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:47 INFO - 2015-11-19 04:20:47,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 141590528 04:20:47 INFO - 2015-11-19 04:20:47,186 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:46634/tests/v8_7/run.html (next: http://localhost:46634/tests/v8_7/run.html) 04:21:08 INFO - 2015-11-19 04:21:08,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 04:21:08 INFO - 2015-11-19 04:21:08,879 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,879 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:21:08 INFO - 2015-11-19 04:21:08,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:21:08 INFO - 2015-11-19 04:21:08,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:21:08 INFO - 2015-11-19 04:21:08,880 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:21:08 INFO - 2015-11-19 04:21:08,880 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 04:21:08 INFO - 2015-11-19 04:21:08,881 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.53590090961873 04:21:08 INFO - 2015-11-19 04:21:08,881 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.2253280091272 04:21:08 INFO - 2015-11-19 04:21:08,881 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5040.201005025126 04:21:08 INFO - 2015-11-19 04:21:08,881 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1076.3440860215053 04:21:08 INFO - 2015-11-19 04:21:08,882 DEBUG : BROWSER_OUTPUT: |5;Earley;700.4898530440868 04:21:08 INFO - 2015-11-19 04:21:08,882 DEBUG : BROWSER_OUTPUT: |6;Boyer;12204.819277108434 04:21:08 INFO - 2015-11-19 04:21:08,882 DEBUG : BROWSER_OUTPUT: |7;RegExp;25025 04:21:08 INFO - 2015-11-19 04:21:08,882 DEBUG : BROWSER_OUTPUT: |8;Splay;639.6683673469388 04:21:08 INFO - 2015-11-19 04:21:08,883 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4887.804878048781 04:21:08 INFO - 2015-11-19 04:21:08,883 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:21:08 INFO - 2015-11-19 04:21:08,883 DEBUG : BROWSER_OUTPUT: __startTimestamp1447935668876__endTimestamp 04:21:08 INFO - 2015-11-19 04:21:08,883 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,884 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:21:08 INFO - 2015-11-19 04:21:08,884 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:21:08 INFO - 2015-11-19 04:21:08,884 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,884 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: Values: 166.0 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.54 Median:193.54 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: Values: 193.5 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.23 Median:285.23 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,885 DEBUG : BROWSER_OUTPUT: Values: 285.2 04:21:08 INFO - 2015-11-19 04:21:08,886 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,886 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5040.20 Median:5040.20 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,886 DEBUG : BROWSER_OUTPUT: Values: 5040.2 04:21:08 INFO - 2015-11-19 04:21:08,887 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,887 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1076.34 Median:1076.34 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,887 DEBUG : BROWSER_OUTPUT: Values: 1076.3 04:21:08 INFO - 2015-11-19 04:21:08,887 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,888 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:700.49 Median:700.49 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,888 DEBUG : BROWSER_OUTPUT: Values: 700.5 04:21:08 INFO - 2015-11-19 04:21:08,888 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,888 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12204.82 Median:12204.82 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,888 DEBUG : BROWSER_OUTPUT: Values: 12204.8 04:21:08 INFO - 2015-11-19 04:21:08,889 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,889 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25025.00 Median:25025.00 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,889 DEBUG : BROWSER_OUTPUT: Values: 25025.0 04:21:08 INFO - 2015-11-19 04:21:08,889 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,890 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:639.67 Median:639.67 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,890 DEBUG : BROWSER_OUTPUT: Values: 639.7 04:21:08 INFO - 2015-11-19 04:21:08,890 DEBUG : BROWSER_OUTPUT: 04:21:08 INFO - 2015-11-19 04:21:08,891 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4887.80 Median:4887.80 stddev:0.00 (0.0%) 04:21:08 INFO - 2015-11-19 04:21:08,891 DEBUG : BROWSER_OUTPUT: Values: 4887.8 04:21:08 INFO - 2015-11-19 04:21:08,891 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:21:08 INFO - 2015-11-19 04:21:08,891 DEBUG : BROWSER_OUTPUT: 04:21:09 INFO - 2015-11-19 04:21:09,739 INFO : Browser exited with error code: 0 04:21:09 INFO - 2015-11-19 04:21:09,755 INFO : Completed test v8_7 (00:00:39) 04:21:09 INFO - 2015-11-19 04:21:09,869 INFO : Completed test suite (00:20:10) 04:21:09 INFO - 2015-11-19 04:21:09,869 DEBUG : Working with test: dromaeo_css 04:21:09 INFO - 2015-11-19 04:21:09,869 DEBUG : Generating results file: dromaeo_css 04:21:09 INFO - 2015-11-19 04:21:09,870 DEBUG : Working with test: kraken 04:21:09 INFO - 2015-11-19 04:21:09,870 DEBUG : Generating results file: kraken 04:21:09 INFO - 2015-11-19 04:21:09,870 INFO : javascript benchmark 04:21:09 INFO - 2015-11-19 04:21:09,871 DEBUG : Working with test: v8_7 04:21:09 INFO - 2015-11-19 04:21:09,871 DEBUG : Generating results file: v8_7 04:21:09 INFO - 2015-11-19 04:21:09,871 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,926 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 04:21:09 INFO - 2015-11-19 04:21:09,926 DEBUG : process_Request line: dromaeo_css 6934.69 graph.html#tests=[[72,64,43]] 04:21:09 INFO - 2015-11-19 04:21:09,926 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,960 DEBUG : process_Request line: kraken 1526.10 graph.html#tests=[[232,64,43]] 04:21:09 INFO - 2015-11-19 04:21:09,961 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:21:10 INFO - 2015-11-19 04:21:10,005 DEBUG : process_Request line: v8_7 21245.28 graph.html#tests=[[230,64,43]] 04:21:10 INFO - 2015-11-19 04:21:10,006 INFO : javascript benchmark 04:21:10 INFO - 2015-11-19 04:21:10,010 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3259.8207098609573, 3283.40898638245, 3288.6053673559177, 3307.5534802801612, 3322.0, 5326.0, 5428.212909128174, 5433.185022246665, 5436.72816359182, 5439.129739241722, 5311.920321195185, 5355.464453554642, 5368.570514358852, 5417.3770016448125, 5447.536959358459, 4889.095517329297, 4973.278874563186, 5009.949900501003, 5024.371953505812, 5025.798968041292, 4984.700917944917, 5028.7485625718755, 5045.016221836725, 5067.1385864402955, 5068.518490743373, 4907.803687852482, 4947.356843610343, 5010.69935803853, 5072.0, 5075.568576670988, 5006.0, 5008.974955125237, 5009.273655319995, 5040.143175660147, 5062.063518249136, 4905.803767849282, 4993.90012199754, 5009.949900501021, 5010.038054714914, 5016.473270306638, 5272.472752724735, 5302.416734159278, 5320.813771518017, 5343.0, 5368.516833485005, 5909.556783241274, 5957.046872500379, 5959.046552551571, 5964.075568286922, 5973.462388385066, 5729.770809167629, 5830.271216097988, 5993.340732519419, 6008.3390827009, 6009.248843894513, 5516.724163791794, 5564.054110801133, 5571.164325351189, 5575.470330318613, 5608.10270356741, 6009.969950150221, 6034.215551978303, 6045.183900173508, 6048.5765996380715, 6051.243594550681, 5609.158626206102, 5706.3722990471015, 5728.341240757366, 5860.501857342174, 5870.765169393262, 5839.211706419664, 5900.0, 5924.259467566554, 5930.7924222652, 5967.850803729854, 5881.441263080001, 5972.313183983811, 5988.520918326523, 5990.580659353891, 6007.15899774032, 5785.4793068623185, 5797.8550536236935, 5915.349311575723, 5958.910616340759, 5972.044472884318, 4562.840300589463, 4570.451545814523, 4574.45106587205, 4575.542445755398, 4614.446266447981, 4077.7757223353, 4082.2856000199845, 4089.0595163112057, 4098.897527561835, 4140.4617399737845, 5488.53347465462, 5546.334439867242, 5573.721313934287, 5628.859278517988, 5727.0, 5833.0, 5870.442307980735, 5881.9705901470215, 5914.408559144051, 5918.053111502139, 5588.720563971785, 5624.690642014647, 5634.915476267859, 5644.096944488862, 5645.858853528694, 4955.306257124005, 5026.321446604735, 5043.0, 5087.592992560586, 5134.974325128351, 6028.2766068072115, 6076.058210977306, 6079.969600151971, 6087.634741915499, 6090.847728806727, 5734.139879018181, 5911.935851546763, 5915.763369465173, 5922.082077278029, 5937.821865344046, 5917.970410147922, 5990.430909063632, 6037.939620603914, 6048.21373221496, 6087.9391206087375, 5845.532357411482, 5894.263217097863, 5898.0, 5899.734511947058, 5909.793157239476, 5753.884922301614, 5834.124881267844, 5970.910436343545, 5986.16193732869, 5986.610870293417, 5770.855728606651, 5808.36108028125, 5812.622179558484, 5835.44563266489, 5867.823965281048, 5696.658200507983, 5705.7147142643535, 5720.170575266647, 5721.22763426932, 5730.426957304237, 5586.301712285965, 5601.6358936668985, 5645.745941432728, 5648.265725455829, 5667.744951477276, 5718.1708652246025, 5744.0, 5761.135829625589, 5774.595778295647, 5804.477597016289, 5711.0, 5758.222639943554, 5775.33583637887, 5792.247007888947, 5796.768129274782], "unit": "ms", "name": "dojo.html", "value": 5437.534068715647}, {"lowerIsBetter": false, "replicates": [596.0939372154326, 604.4710877981768, 621.2638023941629, 637.4517914593449, 655.2170156662789, 39718.0, 40345.394819077665, 40361.798191009, 40451.190976180456, 40499.39250911235, 40944.79527602358, 41316.17367652652, 41374.379384309184, 41374.58625413745, 41551.37672934908, 8549.316054715624, 8738.956305218466, 8743.737687869343, 8746.737597872043, 8762.12378762125, 8483.194096560817, 8511.361647876434, 8539.1887770662, 8571.14288571144, 8587.871181932276, 8491.490510569354, 8586.0, 8635.870461943075, 8661.913380866205, 8663.913360866374, 8512.404131710782, 8514.446560973578, 8531.658733650647, 8560.400771945966, 8583.613737381864, 8448.23965843077, 8507.957460212721, 8556.61495232716, 8613.870791938127, 8624.353173511949, 38334.42498362527, 38533.0, 38583.22833543314, 38715.61284387148, 38756.80621596874, 3337.9499307510405, 3402.4556071028514, 3627.6372362763514, 4095.9180816383805, 4151.982764222755, 30121.698783012107, 30128.698713012807, 30350.241243968856, 31357.52963705546, 31491.37017259642, 3563.55455568054, 3571.0715214044276, 3579.194681196736, 3661.3226553087766, 3688.668019878197, 267433.0, 268013.0, 269185.0, 269980.0, 270444.64777676185, 41705.165896681894, 42155.15689686189, 59681.50796230129, 60192.38845669274, 60214.69892650509, 42104.78947605304, 42116.78941605334, 42119.78802119825, 42206.78896605497, 42368.36447453291, 15153.393864245527, 15213.771793423108, 15222.314995824992, 15378.769318460232, 15399.384024638888, 12137.817932731015, 12148.939255303667, 12149.331786751636, 12178.208416453079, 12247.632571022883, 14322.212278324583, 14471.78292325616, 14531.166422547501, 14549.490767823076, 14605.488807891672, 5926.644401335933, 5944.484156540141, 5954.374790647006, 6028.608140470856, 6064.393560643988, 977.237754551451, 985.9795112058985, 994.105305225303, 1049.5906596427399, 1085.3433672627946, 28700.569491457645, 28721.712782871902, 28833.71166288352, 29109.85445072761, 29110.272243193667, 1083.8049151152868, 1084.6474895658941, 1098.9999100818218, 1149.8390225368455, 1161.2219812725493, 14897.808175345946, 15023.924880375529, 15056.569625885524, 15280.541583752505, 15291.770623440658, 393826.0, 397275.0, 397680.0, 397786.0, 400732.0, 53917.1912421314, 54276.657867370515, 54291.72854135783, 54407.455925441034, 54434.45565544373, 1356.071091302461, 1361.1968938326238, 1372.7529044771836, 1381.896357773171, 1392.1229625335973, 27751.583726244527, 28482.0, 28505.857470712515, 28701.712982869903, 28998.710012899603, 44677.32984005308, 44760.77619611881, 45103.09793804171, 45125.77437112793, 45186.774066130776, 307451.0, 308144.0, 310150.0, 311954.0, 314703.0, 28289.15132546027, 28799.136025919255, 31155.53266700956, 32063.519047214777, 32209.67790322067, 38668.419973699856, 38859.0, 39310.2137957245, 39446.60553394429, 39672.40491392689, 31910.0, 32208.0, 32554.34891302208, 32916.50625240671, 33052.50421243635, 34824.30351392907, 35272.29455410826, 35296.11759706028, 35546.28907421889, 35770.64229357673, 35069.0, 35716.64283357237, 35966.280674386886, 35987.0, 36030.8198459006, 30109.397812044073, 32422.35155296928, 32697.836510817295, 32845.178870527474, 33016.66983330136, 24830.25509234726, 24857.87571062133, 24998.75001249964, 25047.12335068264, 25181.118660846783], "unit": "ms", "name": "ext.html", "value": 18055.581990709303}, {"lowerIsBetter": false, "replicates": [357.99105022374437, 358.63598447575697, 359.6673077403401, 360.8863208089452, 361.2449979542756, 12397.752044959096, 12755.234685918827, 16679.0, 16783.328666853326, 17672.116394180273, 11682.707932301697, 11747.941260293686, 11752.529898804038, 11831.822522662167, 12110.636680899564, 4540.341650460681, 4656.301554766778, 4660.533946605329, 4680.0, 4686.179918514246, 4321.308590625501, 4335.588119128678, 4351.521332653406, 4355.085432059255, 4359.847405340814, 4558.179527685015, 4648.070385922812, 4676.181668208067, 6384.0, 6544.051112588696, 6423.197100362455, 6539.6730163491875, 6566.67166641666, 6572.835679108012, 6867.725290988355, 6549.115869357671, 6567.802965911031, 6576.539642224999, 6580.4406625436895, 6594.208694956636, 21747.456313592127, 22715.886420567957, 22778.088876444923, 22889.31332060041, 23778.286651400485, 2255.8872056397113, 2280.3501002214457, 2323.6514522821544, 2336.1706594159, 2546.3379521324405, 14223.359948802328, 14406.207658578774, 14567.125972441687, 14701.1914344711, 14815.111093334435, 2001.6497113005166, 2028.148177765342, 2037.6739721644465, 2041.5508588110592, 2087.405089549486, 59734.402655973754, 60306.39693603096, 60847.695761521354, 66471.66764166196, 69380.30619693789, 15287.159206243541, 16087.0, 16184.109873957046, 16185.67628647444, 16211.351545938267, 23769.762302376756, 23770.524589508113, 24007.759922400553, 24233.39416514601, 24286.392840179138, 9315.72052838416, 9422.0, 9431.717048488556, 9469.721587585587, 9470.668526601536, 7494.437917156126, 7545.094588649287, 7545.849083018309, 7557.206493318233, 7835.843283134305, 7875.409344299086, 8053.798655033671, 8068.112507624157, 8113.959430202811, 8138.755837324889, 1235.3267469229293, 3328.9667103328657, 3368.646292139339, 3411.300683359905, 3458.7060099891287, 462.4589230600206, 472.8085125524168, 482.5946205187659, 492.6403725280565, 493.91603427417425, 10783.730406739738, 11159.386233757059, 11258.32450052983, 11328.660140195807, 11331.32012079278, 497.81580815098647, 501.9974900125476, 504.0045909329119, 504.72744717851947, 510.3671447405191, 6010.158577799111, 6064.151018857364, 6081.939180608226, 6120.969395152996, 6157.876842463125, 578092.0, 582658.0, 589726.0, 591618.0, 592654.0, 70786.64606677036, 75938.24061759422, 76503.0, 77311.2268877304, 78199.60900195462, 549.7471163264943, 559.7061542690038, 559.8712296171904, 565.3978512883766, 565.4712843491267, 10948.34309941406, 11261.155413344195, 11264.887351126385, 11334.60328888485, 11435.942820285845, 33819.830900846326, 34702.652973470955, 34952.300953980266, 35577.822110890316, 35846.10384740298, 45136.0, 45932.0, 46158.538414615425, 46649.53350466588, 46795.29807052965, 6608.273089960197, 6755.966220168868, 7014.368706816411, 7062.646867656699, 7062.8940565890525, 12510.0, 12644.051696122644, 12792.552260670831, 12823.0, 12917.418716157983, 8743.34424918121, 10028.899711002796, 10804.297720648132, 10881.673549793519, 11068.557257709923, 10480.790384192425, 10487.580496780043, 10535.63125290611, 10582.0, 10715.571377144826, 9668.854967175357, 10641.882602326645, 10694.091002264895, 10736.194785390971, 11352.886471135183, 6546.24718157418, 6698.866022679422, 6709.194896612437, 6734.764283250062, 6769.93230067693, 10044.196464282986, 10115.14021308197, 10410.1671866249, 10434.739131521468, 10448.634297799541], "unit": "ms", "name": "jquery.html", "value": 8265.792426864891}, {"lowerIsBetter": false, "replicates": [1509.7886295918565, 1713.520214339985, 1776.271728591277, 1788.9284428622855, 1803.6302557975616, 7203.5317704349245, 7482.5510469371875, 7515.436342274324, 7611.429142814283, 7764.378849692025, 7374.225706300842, 7473.850522989537, 7483.513571617841, 7550.244975502447, 7565.0, 2140.047678782942, 2160.8811515366647, 2163.524024714568, 2164.491344534033, 2173.847830651855, 2275.476640372707, 2301.723793144825, 2322.140807901079, 2322.222055611364, 2327.93016209514, 2107.546877421354, 2129.4569884679386, 2203.327984964585, 2216.445888527868, 2223.021870377037, 2170.728658917635, 2247.045005872514, 2256.548690261946, 2258.0967612954787, 2258.446680563256, 2231.141010710872, 2311.5261371418987, 2319.431739223901, 2330.673705681206, 2332.825038122148, 7500.624968751596, 7513.962430187868, 7529.962350188269, 7623.313901748814, 7651.770446886602, 4574.839880604163, 4677.672562920597, 4723.551262630044, 4724.4330680318235, 4724.5984091352275, 3033.6662967073603, 3157.1317887580867, 3225.4679027462003, 3232.2404235004756, 3263.2983908459796, 1061.5488417422641, 1085.8045551800674, 1103.1175059952006, 1132.6941725734005, 1147.8966892979672, 10319.948400258027, 10379.636712715093, 10388.37669739818, 10403.427811470367, 10415.843762343571, 4070.9796451018146, 4110.527289361702, 4163.437935878678, 4169.437125988014, 4181.184668989578, 8531.616077276538, 8560.443571167854, 8576.271016963503, 8608.483490990435, 8612.311015118776, 4645.790939407735, 4663.207254766698, 4667.883302917387, 4669.813207471731, 4679.391679081766, 4205.0, 4248.957510424856, 4265.1469706058915, 4309.827606895752, 4314.266574682249, 3489.7382696297373, 3520.876769313113, 3544.5392099026963, 3563.7883119739413, 3576.40989236773, 1091.1925175370327, 1121.9270747401392, 1131.4342828585707, 1133.331334512625, 1145.570411095839, 1030.9329893556894, 1043.6921108273077, 1081.210716177195, 1102.856628638288, 1189.7025743564109, 7068.611226382495, 7145.535540189871, 7147.8570428592175, 7152.856942861114, 7157.6779044943105, 1128.424503503203, 1142.9657110286705, 1151.3494875395543, 1158.9081707517842, 1171.6075114836456, 5572.944270557243, 5577.470140336662, 5604.355499117653, 5618.803341883015, 5633.042382794934, 8969.058248883905, 9158.86261706075, 9355.391899526508, 9409.858852117224, 9415.293852961055, 9204.815903682023, 9243.861342079874, 9259.537023148816, 9289.163975242125, 9304.16262536375, 7026.26224246457, 7055.858882822315, 7154.678039488132, 7168.498205125696, 7185.604791736505, 6835.863282734417, 6842.965785171043, 6860.588364698134, 6864.519483636098, 6880.518363714492, 7856.882146767917, 7950.7217247396065, 8022.237887400687, 8042.87935680977, 8098.0, 8067.717629882926, 8167.224113709188, 8181.468204566684, 8187.754367368989, 8282.544460054514, 6194.907076393768, 6528.347165283433, 6566.868662626816, 6601.702923368364, 6643.069970204272, 7047.189573199148, 7294.671739771829, 7297.744578939924, 7298.96350518244, 7306.7077316906725, 6750.763723269662, 6837.794866154023, 6849.863002739818, 6965.268646792014, 7009.12385951756, 6553.475721942328, 6620.172478440195, 6650.96909978954, 6657.600543967377, 6668.333166683293, 6943.062686537252, 6976.5465244758925, 6978.162620485574, 7007.894881576678, 7013.018177455262, 6117.1130186123655, 6172.259328880563, 6179.752809887555, 6185.84535386619, 6201.10084037803, 6278.215223097113, 6305.684715764285, 6347.460465860454, 6353.078803573549, 6361.936380636134], "unit": "ms", "name": "mootools.html", "value": 4410.767580584983}, {"lowerIsBetter": false, "replicates": [328.8848902883991, 329.8202479648591, 333.8647847621714, 338.9813610101645, 341.7061327258557, 6163.876722465548, 6258.812235632932, 6261.3425590313045, 6277.811665650032, 6305.684715764216, 6117.66352850593, 6192.41172088652, 6212.471939885115, 6250.40621140992, 6271.216097987752, 4724.645651576128, 4737.502562230968, 4756.1914474539235, 4765.475797662254, 4770.6422018348585, 4726.629277509518, 4762.28565715142, 4771.069641419925, 4773.71357718538, 4775.11660342836, 4637.350770892078, 4656.4877863434995, 4711.0, 4712.858614241578, 4726.8581942541605, 4673.299005149221, 4684.8360307389075, 4692.41344831896, 4697.271922851964, 4702.106599746037, 3950.0, 4043.6158564936286, 4080.6327430531096, 4112.568180341081, 4125.525564560084, 5856.238688970407, 5880.794172203952, 5884.323302820188, 5886.0, 5917.0, 5414.864628384322, 5442.346918369782, 5460.863478413032, 5472.315960504937, 5472.315960504937, 6572.047053177311, 6578.3092775258865, 6595.0, 6605.900911486331, 6606.1412016438035, 4375.496817865923, 4455.688101832873, 4489.855086952839, 4491.483479399878, 4515.525869783691, 6824.351686589766, 6866.382025617669, 6903.620300883449, 6935.4104901082965, 6944.965275173642, 4594.448666160082, 4610.561996610317, 4610.792514336863, 4614.976925115353, 4630.236011058205, 4607.76961151941, 4649.163150632851, 4680.812767489262, 4691.7654117294, 4693.084848454519, 5457.072297709399, 5460.481254280837, 5465.371482279509, 5468.48049435303, 5473.67157970523, 6622.569532980341, 6686.1642294713165, 6694.933050669431, 6697.3637504437, 6717.764878229238, 1654.7186978213733, 1670.323518974817, 1672.0, 1675.9329626815036, 1676.0530300380246, 1102.2449622008949, 1103.9668809935715, 1112.9554817807198, 1125.3754166437707, 1129.5877004893318, 6496.830570497262, 6513.185851768529, 6514.088027676129, 6519.4132528072705, 6523.11937888379, 6925.480588955747, 6929.0, 6934.237233904267, 6935.791926242221, 6946.6179360134665, 6412.35876412355, 6464.903026454607, 6477.222733272038, 6477.995910633859, 6496.350364963466, 3747.5502939647417, 3768.453574231721, 3773.3208022555655, 3775.716821238418, 3779.2063666629765, 6930.3762661360715, 7051.29487051301, 7160.0, 7250.7462238822445, 7251.1661158966335, 7103.857922841515, 7125.53684010548, 7141.464390170758, 7155.17715462718, 7174.139103307636, 7077.73512476013, 7188.0, 7197.496175267681, 7207.387372073327, 7223.747168849065, 6932.653367331714, 6939.653017349011, 6947.166340039228, 6955.826104347432, 6958.652067396712, 6835.282295358916, 6875.243723190545, 6883.896741548981, 6888.070110535214, 6891.620960847202, 7010.649467526705, 7190.604516751629, 7191.820204494929, 7204.387627051549, 7204.387627051759, 4628.166929952641, 4639.257718764981, 4640.953590464187, 4645.047765208192, 4651.162790697707, 6901.62041087745, 6910.585364878123, 6929.965350173217, 6930.995005724242, 6962.7911162665205, 6525.967370163119, 6675.165604299463, 6694.464442844658, 6702.631355275506, 6723.462123030048, 6630.3038180992235, 6657.933420665731, 6693.933060669331, 6711.228208756055, 6718.361755633207, 6524.0, 6578.736850525926, 6583.80248592543, 6584.242812076673, 6593.703283352164, 6633.0, 6703.8324041897395, 6740.898886516608, 6759.087523184504, 6767.221769496571, 6543.836404089936, 6581.703823327866, 6589.604623722592, 6591.802245932629, 6599.274079851309], "unit": "ms", "name": "prototype.html", "value": 4998.187766611661}, {"lowerIsBetter": false, "replicates": [782.6908371193379, 795.4988357334878, 869.8782170496131, 880.8458519759045, 893.7318804358691, 14748.262586870655, 14890.404383824634, 14943.701125977488, 15039.473618423357, 15094.0, 14632.561023169295, 14720.337584808682, 14746.410143594243, 14756.967012309142, 14802.185879776634, 689.7723751162105, 692.3906961873545, 811.1766556944691, 821.995890020549, 823.8146417056145, 800.1478425476878, 802.0615879421063, 804.1154729797234, 807.0355924670022, 811.180707485441, 848.817504236589, 854.2482615298528, 860.0, 866.0603245478663, 867.8698195270697, 849.8342823149488, 854.7307598106607, 855.6149732620314, 857.3698331726176, 858.7767180533107, 614.0053113955377, 616.2574098211644, 621.3972446726668, 622.0948519903529, 623.382850977529, 13064.150830196008, 13099.672508187276, 13152.342382880817, 13168.144070635473, 13215.074944753871, 10204.74488137795, 10286.279960402775, 10488.160947124288, 10506.317089389166, 10561.049505544537, 10065.094141527297, 10067.5469603868, 10076.0, 10095.495225238708, 10228.488575571266, 3154.9684503154904, 3191.872325106993, 3209.0, 3225.048610659861, 3237.9838100809343, 45053.32420013735, 45063.77468112671, 45276.54723452756, 45421.0, 45647.77176114132, 7418.146913104954, 7504.849903001909, 7931.365490760725, 7955.24425179607, 7981.08217554977, 11878.465469053914, 11896.345700986529, 11914.166008379503, 11920.165588408901, 11975.341356225317, 6710.295418981034, 6733.9326606734285, 6776.05135281061, 6788.93211067883, 6795.524313298021, 4366.825326986885, 4372.322290045048, 4377.9124417511475, 4450.376947227391, 4494.505604383515, 2717.592361145844, 2744.9039283625375, 2761.9309517262227, 2762.240383894445, 2763.8203516771346, 452.984145554904, 467.4624182190508, 471.3777813286429, 471.86551832728196, 471.92636751390177, 612.9304363885049, 643.173522024206, 651.5211319680031, 688.1192074145102, 735.400648471494, 8801.25189358899, 8850.557472126367, 8925.821483570293, 8960.372773905894, 9017.909820901838, 569.1718549510452, 578.4706993101265, 687.6355531568277, 695.7495301691387, 741.4253953186216, 3974.5429275633096, 4434.423524941737, 4531.68278220528, 4590.8163673453355, 4603.033362993742, 58916.0, 59738.402615974155, 60194.097088543705, 60757.69621151866, 62099.6895015522, 51956.48043519592, 52276.47723522716, 52741.73629131907, 53039.20441193385, 57751.133732994036, 50968.0, 51485.74257128765, 52195.478045219825, 53086.0, 54718.726406367714, 8760.912390876265, 8865.911340886509, 8892.0, 9022.548872556477, 9231.86152207704, 33750.83124584361, 33967.0, 34729.0, 36245.27509449849, 36546.45180322351, 38672.0, 41296.587034129276, 44992.77503612461, 45316.77341613271, 45566.54433455623, 11144.275622084539, 11927.642170734893, 12122.878771212176, 12255.203411778206, 12584.433700483683, 12451.564195253122, 12649.114561980941, 12706.68233294138, 12757.744845103232, 12811.231326120462, 11272.66182014541, 11402.144839136932, 11472.770544589228, 11534.134939879375, 11718.179727419, 11852.940735296614, 11874.287542747463, 12194.756104877675, 12415.62753117408, 12587.370631468573, 11110.555577777122, 11205.103591712807, 11226.382548959558, 11303.604373846876, 11536.307821530734, 10044.447555384524, 10212.131968782736, 10374.22193335518, 10574.524146413276, 10710.0, 9303.906960930575, 9959.850602241117, 10128.240381971234, 10181.287309888237, 10186.388816671024], "unit": "ms", "name": "yui.html", "value": 6215.872343656538}], "name": "dromaeo_css", "value": 6934.691099581292}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 112.0, 111.0, 113.0, 122.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [159.0, 123.0, 153.0, 165.0, 133.0, 162.0, 151.0, 126.0, 164.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 163.0, 165.0, 159.0, 159.0, 165.0, 168.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 73.0, 75.0, 153.0, 72.0, 71.0, 72.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 142.0, 91.0, 91.0, 91.0, 143.0, 96.0, 90.0, 143.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 61.0, 60.0, 62.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 61.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 70.0, 69.0, 68.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 132.0, 126.0, 131.0, 133.0, 126.0, 131.0, 118.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [147.0, 152.0, 154.0, 163.0, 153.0, 151.0, 153.0, 151.0, 156.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 69.0, 71.0, 68.0, 72.0, 69.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1526.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [193.53590090961873], "unit": "score", "name": "DeltaBlue", "value": 341.6317059999999}, {"lowerIsBetter": false, "replicates": [285.2253280091272], "unit": "score", "name": "Encrypt", "value": 933.2305859999998}, {"lowerIsBetter": false, "replicates": [5040.201005025126], "unit": "score", "name": "Decrypt", "value": 52.81158424725827}, {"lowerIsBetter": false, "replicates": [1076.3440860215053], "unit": "score", "name": "RayTrace", "value": 687.5022677322679}, {"lowerIsBetter": false, "replicates": [700.4898530440868], "unit": "score", "name": "Earley", "value": 951.4242027972025}, {"lowerIsBetter": false, "replicates": [12204.819277108434], "unit": "score", "name": "Boyer", "value": 54.606543928923976}, {"lowerIsBetter": false, "replicates": [25025.0], "unit": "score", "name": "RegExp", "value": 36.40299700299697}, {"lowerIsBetter": false, "replicates": [639.6683673469388], "unit": "score", "name": "Splay", "value": 127.39570089730803}, {"lowerIsBetter": false, "replicates": [4887.804878048781], "unit": "score", "name": "NavierStokes", "value": 303.61277445109783}], "name": "v8_7", "value": 21245.275047647134}]} 04:21:10 INFO - RETURN: dromaeo_css: 6934.69 04:21:10 INFO - RETURN: kraken: 1526.10 04:21:10 INFO - RETURN: v8_7: 21245.28 04:21:10 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21245.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1526.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6934.69"}}} 04:21:10 INFO - Return code: 0 04:21:10 INFO - # TBPL SUCCESS # 04:21:10 INFO - Running post-action listener: _resource_record_post_action 04:21:10 INFO - Running post-run listener: _resource_record_post_run 04:21:11 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 16384; Write bytes: 515641344; Read time: 36; Write time: 394540 04:21:11 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238505984; Read time: 0; Write time: 251764 04:21:11 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 16384; Write bytes: 277135360; Read time: 36; Write time: 142776 04:21:11 INFO - Running post-run listener: _upload_blobber_files 04:21:11 INFO - Blob upload gear active. 04:21:11 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:21:11 INFO - Copying logs to upload dir... 04:21:11 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1294.725243 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2015-11-19 04:21:11.603912) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:11.611537) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 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.009951 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.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:11.638032) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:11.638451) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1447932030.752885-1468656994 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.20 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 04:21:11.846554) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:21:11.846884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 04:21:11.847190) ========= ========= Total master_lag: 0.74 =========