builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1448290947.47 results: success (0) buildid: 20151123053004 builduid: 9a70f9f3da4e48dba348a20b2b3a12ae revision: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.469010) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.469473) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.469756) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006436 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.489666) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.489994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.502925) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.503362) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.556544) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.556837) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.557234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.557505) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 07:02:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-11-23 07:02:28 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180766 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.750558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.750941) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014603 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:27.800231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 07:02:27.800718) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b --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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 07:02:29,049 truncating revision to first 12 chars 2015-11-23 07:02:29,049 Setting DEBUG logging. 2015-11-23 07:02:29,049 attempt 1/10 2015-11-23 07:02:29,049 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5c614c8507b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 07:02:30,109 unpacking tar archive at: fx-team-5c614c8507b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.386225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 07:02:29.199631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:29.199930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:29.210282) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:29.210645) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 07:02:29.211095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 07:02:29.211415) ========= /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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:02:30 INFO - MultiFileLogger online at 20151123 07:02:30 in /builds/slave/test-pgo 07:02:30 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 07:02:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:02:30 INFO - {'append_to_log': False, 07:02:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:02:30 INFO - 'blob_upload_branch': 'Fx-Team', 07:02:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:02:30 INFO - 'branch': 'Fx-Team', 07:02:30 INFO - 'buildbot_json_path': 'buildprops.json', 07:02:30 INFO - 'config_files': ('talos/linux_config.py',), 07:02:30 INFO - 'default_actions': ('clobber', 07:02:30 INFO - 'read-buildbot-config', 07:02:30 INFO - 'download-and-extract', 07:02:30 INFO - 'populate-webroot', 07:02:30 INFO - 'create-virtualenv', 07:02:30 INFO - 'install', 07:02:30 INFO - 'run-tests'), 07:02:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:02:30 INFO - 'download_minidump_stackwalk': True, 07:02:30 INFO - 'download_symbols': 'ondemand', 07:02:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:02:30 INFO - 'tooltool.py': '/tools/tooltool.py', 07:02:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:02:30 INFO - '/tools/misc-python/virtualenv.py')}, 07:02:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:02:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:02:30 INFO - 'installer_path': 'installer.exe', 07:02:30 INFO - 'log_level': 'info', 07:02:30 INFO - 'log_name': 'talos', 07:02:30 INFO - 'log_to_console': True, 07:02:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:02:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:02:30 INFO - 'opt_config_files': (), 07:02:30 INFO - 'pip_index': False, 07:02:30 INFO - 'sps_profile': False, 07:02:30 INFO - 'sps_profile_interval': 0, 07:02:30 INFO - 'suite': 'dromaeojs-e10s', 07:02:30 INFO - 'system_bits': '64', 07:02:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:02:30 INFO - 'title': 'talos-linux64-ix-023', 07:02:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:02:30 INFO - 'use_talos_json': True, 07:02:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:02:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:02:30 INFO - 'work_dir': 'build'} 07:02:30 INFO - ##### 07:02:30 INFO - ##### Running clobber step. 07:02:30 INFO - ##### 07:02:30 INFO - Running pre-action listener: _resource_record_pre_action 07:02:30 INFO - Running main action method: clobber 07:02:30 INFO - rmtree: /builds/slave/test-pgo/build 07:02:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:02:31 INFO - Running post-action listener: _resource_record_post_action 07:02:31 INFO - ##### 07:02:31 INFO - ##### Running read-buildbot-config step. 07:02:31 INFO - ##### 07:02:31 INFO - Running pre-action listener: _resource_record_pre_action 07:02:31 INFO - Running main action method: read_buildbot_config 07:02:31 INFO - Using buildbot properties: 07:02:31 INFO - { 07:02:31 INFO - "properties": { 07:02:31 INFO - "buildnumber": 351, 07:02:31 INFO - "product": "firefox", 07:02:31 INFO - "script_repo_revision": "production", 07:02:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:02:31 INFO - "repository": "", 07:02:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 07:02:31 INFO - "buildid": "20151123053004", 07:02:31 INFO - "slavename": "talos-linux64-ix-023", 07:02:31 INFO - "pgo_build": "True", 07:02:31 INFO - "basedir": "/builds/slave/test-pgo", 07:02:31 INFO - "project": "", 07:02:31 INFO - "platform": "ubuntu64_hw", 07:02:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:02:31 INFO - "slavebuilddir": "test", 07:02:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:02:31 INFO - "branch": "fx-team", 07:02:31 INFO - "repo_path": "integration/fx-team", 07:02:31 INFO - "stage_platform": "linux64-pgo", 07:02:31 INFO - "builduid": "9a70f9f3da4e48dba348a20b2b3a12ae", 07:02:31 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 07:02:31 INFO - }, 07:02:31 INFO - "sourcestamp": { 07:02:31 INFO - "repository": "", 07:02:31 INFO - "hasPatch": false, 07:02:31 INFO - "project": "", 07:02:31 INFO - "branch": "fx-team-linux64-pgo-talos", 07:02:31 INFO - "changes": [ 07:02:31 INFO - { 07:02:31 INFO - "category": null, 07:02:31 INFO - "files": [ 07:02:31 INFO - { 07:02:31 INFO - "url": null, 07:02:31 INFO - "name": "https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:02:31 INFO - } 07:02:31 INFO - ], 07:02:31 INFO - "repository": "", 07:02:31 INFO - "rev": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b", 07:02:31 INFO - "who": "sendchange", 07:02:31 INFO - "when": 1448290629, 07:02:31 INFO - "number": 6695084, 07:02:31 INFO - "comments": "", 07:02:31 INFO - "project": "", 07:02:31 INFO - "at": "Mon 23 Nov 2015 06:57:09", 07:02:31 INFO - "branch": "fx-team-linux64-pgo-talos", 07:02:31 INFO - "revlink": "", 07:02:31 INFO - "properties": [ 07:02:31 INFO - [ 07:02:31 INFO - "buildid", 07:02:31 INFO - "20151123053004", 07:02:31 INFO - "Change" 07:02:31 INFO - ], 07:02:31 INFO - [ 07:02:31 INFO - "builduid", 07:02:31 INFO - "9a70f9f3da4e48dba348a20b2b3a12ae", 07:02:31 INFO - "Change" 07:02:31 INFO - ], 07:02:31 INFO - [ 07:02:31 INFO - "pgo_build", 07:02:31 INFO - "True", 07:02:31 INFO - "Change" 07:02:31 INFO - ] 07:02:31 INFO - ], 07:02:31 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 07:02:31 INFO - } 07:02:31 INFO - ], 07:02:31 INFO - "revision": "5c614c8507b7c7928ffbe5cc3a884d7c55c9405b" 07:02:31 INFO - } 07:02:31 INFO - } 07:02:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:02:31 INFO - Running post-action listener: _resource_record_post_action 07:02:31 INFO - ##### 07:02:31 INFO - ##### Running download-and-extract step. 07:02:31 INFO - ##### 07:02:31 INFO - Running pre-action listener: _resource_record_pre_action 07:02:31 INFO - Running main action method: download_and_extract 07:02:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:02: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')]} 07:02:31 INFO - https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:02:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/test_packages.json 07:02:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/test_packages.json 07:02:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:02:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:02:32 INFO - Downloaded 1302 bytes. 07:02:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:02:32 INFO - Using the following test package requirements: 07:02:32 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:02:32 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:02:32 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'jsshell-linux-x86_64.zip'], 07:02:32 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:02:32 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:02:32 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:02:32 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:02:32 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:02:32 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:02:32 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:02:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:02:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:32 INFO - https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:02:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:33 INFO - Downloaded 22523793 bytes. 07:02:33 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 07:02:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:33 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 07:02:34 INFO - Return code: 0 07:02:34 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 07:02:34 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')]} 07:02:34 INFO - https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:35 INFO - Downloaded 22523793 bytes. 07:02:35 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 07:02:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:02:35 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 07:02:36 INFO - Return code: 0 07:02:36 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')]} 07:02:36 INFO - https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:37 INFO - Downloaded 11130997 bytes. 07:02:37 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 07:02:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:37 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 07:02:37 INFO - Return code: 0 07:02: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')]} 07:02:37 INFO - https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/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 07:02:39 INFO - Downloaded 57451024 bytes. 07:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:02:39 INFO - mkdir: /builds/slave/test-pgo/properties 07:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:02:39 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:02:39 INFO - Contents: 07:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - Running post-action listener: set_extra_try_arguments 07:02:39 INFO - ##### 07:02:39 INFO - ##### Running populate-webroot step. 07:02:39 INFO - ##### 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: populate_webroot 07:02:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:02:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:02:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:02:39 INFO - '../fennec_ids.txt'], 07:02:39 INFO - 'tests': ['tcheck2']}, 07:02:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:02:39 INFO - '--tppagecycles', 07:02:39 INFO - '7'], 07:02:39 INFO - 'tests': ['tsvgm']}}, 07:02:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:02:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:02:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:02:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:02:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'tests': ['damp', 'tps']}, 07:02:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['damp', 'tps']}, 07:02:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:02:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:39 INFO - 'other': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'other_l64': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'other_nol64': {'tests': ['a11yr', 07:02:39 INFO - 'ts_paint', 07:02:39 INFO - 'tpaint', 07:02:39 INFO - 'sessionrestore', 07:02:39 INFO - 'sessionrestore_no_auto_restore']}, 07:02:39 INFO - 'svgr': {'tests': ['tsvgx', 07:02:39 INFO - 'tsvgr_opacity', 07:02:39 INFO - 'tart', 07:02:39 INFO - 'tscrollx', 07:02:39 INFO - 'cart']}, 07:02:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['tsvgx', 07:02:39 INFO - 'tsvgr_opacity', 07:02:39 INFO - 'tart', 07:02:39 INFO - 'tscrollx', 07:02:39 INFO - 'cart']}, 07:02:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'tests': ['tp5o']}, 07:02:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'talos_options': ['--e10s'], 07:02:39 INFO - 'tests': ['tp5o']}, 07:02:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'talos_options': ['--xperf_path', 07:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:39 INFO - 'tests': ['tp5n']}, 07:02:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:39 INFO - 'talos_options': ['--e10s', 07:02:39 INFO - '--xperf_path', 07:02:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:39 INFO - 'tests': ['tp5n']}}, 07:02:39 INFO - 'talos.zip': {'path': '', 07:02:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:02:39 INFO - Running post-action listener: _resource_record_post_action 07:02:39 INFO - ##### 07:02:39 INFO - ##### Running create-virtualenv step. 07:02:39 INFO - ##### 07:02:39 INFO - Running pre-action listener: _resource_record_pre_action 07:02:39 INFO - Running main action method: create_virtualenv 07:02:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:02:39 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 07:02:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:02:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:39 INFO - Using real prefix '/usr' 07:02:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:02:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:41 INFO - Installing pip.................done. 07:02:41 INFO - Return code: 0 07:02:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:02: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')]} 07:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:41 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 07:02:41 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 07:02:41 INFO - Using env: {'DISPLAY': ':0', 07:02:41 INFO - 'HOME': '/home/cltbld', 07:02:41 INFO - 'LANG': 'en_US.UTF-8', 07:02:41 INFO - 'LANGUAGE': 'en_US:en', 07:02:41 INFO - 'LOGNAME': 'cltbld', 07:02:41 INFO - 'MAIL': '/var/mail/cltbld', 07:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:41 INFO - 'MOZ_NO_REMOTE': '1', 07:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:41 INFO - 'NO_EM_RESTART': '1', 07:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:41 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:41 INFO - 'SHELL': '/bin/bash', 07:02:41 INFO - 'SHLVL': '1', 07:02:41 INFO - 'TERM': 'linux', 07:02:41 INFO - 'TMOUT': '86400', 07:02:41 INFO - 'USER': 'cltbld', 07:02:41 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:41 INFO - '_': '/tools/buildbot/bin/python'} 07:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:42 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 07:02:42 INFO - Cleaning up... 07:02:42 INFO - Return code: 0 07:02:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:42 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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:42 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 07:02:42 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 07:02:42 INFO - Using env: {'DISPLAY': ':0', 07:02:42 INFO - 'HOME': '/home/cltbld', 07:02:42 INFO - 'LANG': 'en_US.UTF-8', 07:02:42 INFO - 'LANGUAGE': 'en_US:en', 07:02:42 INFO - 'LOGNAME': 'cltbld', 07:02:42 INFO - 'MAIL': '/var/mail/cltbld', 07:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:42 INFO - 'MOZ_NO_REMOTE': '1', 07:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:42 INFO - 'NO_EM_RESTART': '1', 07:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:42 INFO - 'SHELL': '/bin/bash', 07:02:42 INFO - 'SHLVL': '1', 07:02:42 INFO - 'TERM': 'linux', 07:02:42 INFO - 'TMOUT': '86400', 07:02:42 INFO - 'USER': 'cltbld', 07:02:42 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:42 INFO - '_': '/tools/buildbot/bin/python'} 07:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:42 INFO - Downloading/unpacking psutil>=0.7.1 07:02:42 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 07:02:42 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 07:02:42 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 07:02:42 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 07:02:42 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 07:02:42 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 07:02:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:02:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:02:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:44 INFO - Installing collected packages: psutil 07:02:44 INFO - Running setup.py install for psutil 07:02:44 INFO - building 'psutil._psutil_linux' extension 07:02:44 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 07:02:44 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 07:02:44 INFO - building 'psutil._psutil_posix' extension 07:02:44 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 07:02:44 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 07:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:44 INFO - Successfully installed psutil 07:02:44 INFO - Cleaning up... 07:02:44 INFO - Return code: 0 07:02:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:02:44 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')]} 07:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:44 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')]} 07:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:44 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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:44 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 07:02:44 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 07:02:44 INFO - Using env: {'DISPLAY': ':0', 07:02:44 INFO - 'HOME': '/home/cltbld', 07:02:44 INFO - 'LANG': 'en_US.UTF-8', 07:02:44 INFO - 'LANGUAGE': 'en_US:en', 07:02:44 INFO - 'LOGNAME': 'cltbld', 07:02:44 INFO - 'MAIL': '/var/mail/cltbld', 07:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:44 INFO - 'MOZ_NO_REMOTE': '1', 07:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:44 INFO - 'NO_EM_RESTART': '1', 07:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:44 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:44 INFO - 'SHELL': '/bin/bash', 07:02:44 INFO - 'SHLVL': '1', 07:02:44 INFO - 'TERM': 'linux', 07:02:44 INFO - 'TMOUT': '86400', 07:02:44 INFO - 'USER': 'cltbld', 07:02:44 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:44 INFO - '_': '/tools/buildbot/bin/python'} 07:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:02:44 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 07:02:44 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 07:02:44 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 07:02:44 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 07:02:44 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 07:02:44 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 07:02:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:02:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:02:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:02:46 INFO - Installing collected packages: mozsystemmonitor 07:02:46 INFO - Running setup.py install for mozsystemmonitor 07:02:46 INFO - Successfully installed mozsystemmonitor 07:02:46 INFO - Cleaning up... 07:02:46 INFO - Return code: 0 07:02:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:46 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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:46 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 07:02:46 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 07:02:46 INFO - Using env: {'DISPLAY': ':0', 07:02:46 INFO - 'HOME': '/home/cltbld', 07:02:46 INFO - 'LANG': 'en_US.UTF-8', 07:02:46 INFO - 'LANGUAGE': 'en_US:en', 07:02:46 INFO - 'LOGNAME': 'cltbld', 07:02:46 INFO - 'MAIL': '/var/mail/cltbld', 07:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:46 INFO - 'MOZ_NO_REMOTE': '1', 07:02:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:46 INFO - 'NO_EM_RESTART': '1', 07:02:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:46 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:46 INFO - 'SHELL': '/bin/bash', 07:02:46 INFO - 'SHLVL': '1', 07:02:46 INFO - 'TERM': 'linux', 07:02:46 INFO - 'TMOUT': '86400', 07:02:46 INFO - 'USER': 'cltbld', 07:02:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:46 INFO - '_': '/tools/buildbot/bin/python'} 07:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:46 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 07:02:46 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 07:02:46 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 07:02:46 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 07:02:46 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 07:02:46 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 07:02:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:02:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 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 07:02:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:02:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:02:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 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 07:02:49 INFO - Downloading docopt-0.6.1.tar.gz 07:02:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:02:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:49 INFO - Running setup.py install for blobuploader 07:02:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:02:49 INFO - Running setup.py install for requests 07:02:49 INFO - Running setup.py install for docopt 07:02:49 INFO - Successfully installed blobuploader requests docopt 07:02:49 INFO - Cleaning up... 07:02:49 INFO - Return code: 0 07:02:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:49 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')]} 07:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:49 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')]} 07:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:49 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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:49 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 07:02:49 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 07:02:49 INFO - Using env: {'DISPLAY': ':0', 07:02:49 INFO - 'HOME': '/home/cltbld', 07:02:49 INFO - 'LANG': 'en_US.UTF-8', 07:02:49 INFO - 'LANGUAGE': 'en_US:en', 07:02:49 INFO - 'LOGNAME': 'cltbld', 07:02:49 INFO - 'MAIL': '/var/mail/cltbld', 07:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:49 INFO - 'MOZ_NO_REMOTE': '1', 07:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:49 INFO - 'NO_EM_RESTART': '1', 07:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:49 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:49 INFO - 'SHELL': '/bin/bash', 07:02:49 INFO - 'SHLVL': '1', 07:02:49 INFO - 'TERM': 'linux', 07:02:49 INFO - 'TMOUT': '86400', 07:02:49 INFO - 'USER': 'cltbld', 07:02:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:49 INFO - '_': '/tools/buildbot/bin/python'} 07:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:50 INFO - Running setup.py (path:/tmp/pip-RNLxpL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:50 INFO - Running setup.py (path:/tmp/pip-AFFTkX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:50 INFO - Running setup.py (path:/tmp/pip-Gsqvad-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:50 INFO - Running setup.py (path:/tmp/pip-OurWol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:50 INFO - Running setup.py (path:/tmp/pip-H05h6f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:50 INFO - Running setup.py (path:/tmp/pip-_r2waj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:50 INFO - Running setup.py (path:/tmp/pip-NbUvVg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:50 INFO - Running setup.py (path:/tmp/pip-yZCCH5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:50 INFO - Running setup.py (path:/tmp/pip-cPUgLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:50 INFO - Running setup.py (path:/tmp/pip-fq5KPe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:50 INFO - Running setup.py (path:/tmp/pip-Fdht7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:50 INFO - Running setup.py (path:/tmp/pip-oMhC6D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:51 INFO - Running setup.py (path:/tmp/pip-MV21hT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:51 INFO - Running setup.py (path:/tmp/pip-nzhdRQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Running setup.py (path:/tmp/pip-tOITHN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:51 INFO - Running setup.py (path:/tmp/pip-qmkuEs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:51 INFO - Running setup.py (path:/tmp/pip-QCwzui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:02:51 INFO - Running setup.py install for manifestparser 07:02:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:02:51 INFO - Running setup.py install for mozcrash 07:02:51 INFO - Running setup.py install for mozdebug 07:02:51 INFO - Running setup.py install for mozdevice 07:02:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:02:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:02:51 INFO - Running setup.py install for mozfile 07:02:51 INFO - Running setup.py install for mozhttpd 07:02:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozinfo 07:02:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozInstall 07:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozleak 07:02:52 INFO - Running setup.py install for mozlog 07:02:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for moznetwork 07:02:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozprocess 07:02:52 INFO - Running setup.py install for mozprofile 07:02:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozrunner 07:02:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:02:52 INFO - Running setup.py install for mozscreenshot 07:02:52 INFO - Running setup.py install for moztest 07:02:53 INFO - Running setup.py install for mozversion 07:02:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:02:53 INFO - Cleaning up... 07:02:53 INFO - Return code: 0 07:02:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:53 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 07:02:53 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 07:02:53 INFO - Using env: {'DISPLAY': ':0', 07:02:53 INFO - 'HOME': '/home/cltbld', 07:02:53 INFO - 'LANG': 'en_US.UTF-8', 07:02:53 INFO - 'LANGUAGE': 'en_US:en', 07:02:53 INFO - 'LOGNAME': 'cltbld', 07:02:53 INFO - 'MAIL': '/var/mail/cltbld', 07:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:53 INFO - 'MOZ_NO_REMOTE': '1', 07:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:53 INFO - 'NO_EM_RESTART': '1', 07:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:53 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:53 INFO - 'SHELL': '/bin/bash', 07:02:53 INFO - 'SHLVL': '1', 07:02:53 INFO - 'TERM': 'linux', 07:02:53 INFO - 'TMOUT': '86400', 07:02:53 INFO - 'USER': 'cltbld', 07:02:53 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:53 INFO - '_': '/tools/buildbot/bin/python'} 07:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:53 INFO - Running setup.py (path:/tmp/pip-wYjPKM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:53 INFO - Running setup.py (path:/tmp/pip-mFDtr7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:53 INFO - Running setup.py (path:/tmp/pip-K79qLK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:53 INFO - Running setup.py (path:/tmp/pip-0Fm0I7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:53 INFO - Running setup.py (path:/tmp/pip-Efnh41-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:53 INFO - Running setup.py (path:/tmp/pip-DjSWSn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:53 INFO - Running setup.py (path:/tmp/pip-dvGfvj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:02:53 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)) 07:02:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:53 INFO - Running setup.py (path:/tmp/pip-gsWmYM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:54 INFO - Running setup.py (path:/tmp/pip-cYzQuR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:54 INFO - Running setup.py (path:/tmp/pip-c8ZsuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:54 INFO - Running setup.py (path:/tmp/pip-kpI4c6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:54 INFO - Running setup.py (path:/tmp/pip-Tdtcsi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:54 INFO - Running setup.py (path:/tmp/pip-8cO6TO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:54 INFO - Running setup.py (path:/tmp/pip-UQhQyd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:54 INFO - Running setup.py (path:/tmp/pip-BuNmDF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:54 INFO - Running setup.py (path:/tmp/pip-wQmU36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:02:54 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)) 07:02:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:54 INFO - Running setup.py (path:/tmp/pip-shKJli-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:02:54 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)) 07:02:54 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)) 07:02:54 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)) 07:02:54 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)) 07:02:54 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)) 07:02:54 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)) 07:02:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:54 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 07:02:54 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 07:02:54 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 07:02:54 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 07:02:54 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 07:02:54 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 07:02:56 INFO - Downloading blessings-1.5.1.tar.gz 07:02:56 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 07:02:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:56 INFO - Installing collected packages: blessings 07:02:56 INFO - Running setup.py install for blessings 07:02:56 INFO - Successfully installed blessings 07:02:56 INFO - Cleaning up... 07:02:56 INFO - Return code: 0 07:02:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:02:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:02:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:02:56 INFO - Reading from file tmpfile_stdout 07:02:56 INFO - Current package versions: 07:02:56 INFO - argparse == 1.2.1 07:02:56 INFO - blessings == 1.5.1 07:02:56 INFO - blobuploader == 1.2.4 07:02:56 INFO - docopt == 0.6.1 07:02:56 INFO - manifestparser == 1.1 07:02:56 INFO - mozInstall == 1.12 07:02:56 INFO - mozcrash == 0.16 07:02:56 INFO - mozdebug == 0.1 07:02:56 INFO - mozdevice == 0.47 07:02:56 INFO - mozfile == 1.2 07:02:56 INFO - mozhttpd == 0.7 07:02:56 INFO - mozinfo == 0.9 07:02:56 INFO - mozleak == 0.1 07:02:56 INFO - mozlog == 3.0 07:02:56 INFO - moznetwork == 0.27 07:02:56 INFO - mozprocess == 0.22 07:02:56 INFO - mozprofile == 0.27 07:02:56 INFO - mozrunner == 6.11 07:02:56 INFO - mozscreenshot == 0.1 07:02:56 INFO - mozsystemmonitor == 0.0 07:02:56 INFO - moztest == 0.7 07:02:56 INFO - mozversion == 1.4 07:02:56 INFO - psutil == 3.1.1 07:02:56 INFO - requests == 1.2.3 07:02:56 INFO - wsgiref == 0.1.2 07:02:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:56 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 0x7f14e6314c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d956e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, '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': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', '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 07:02:56 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 07:02:56 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 07:02:56 INFO - Using env: {'DISPLAY': ':0', 07:02:56 INFO - 'HOME': '/home/cltbld', 07:02:56 INFO - 'LANG': 'en_US.UTF-8', 07:02:56 INFO - 'LANGUAGE': 'en_US:en', 07:02:56 INFO - 'LOGNAME': 'cltbld', 07:02:56 INFO - 'MAIL': '/var/mail/cltbld', 07:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:56 INFO - 'MOZ_NO_REMOTE': '1', 07:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:56 INFO - 'NO_EM_RESTART': '1', 07:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:02:56 INFO - 'PWD': '/builds/slave/test-pgo', 07:02:56 INFO - 'SHELL': '/bin/bash', 07:02:56 INFO - 'SHLVL': '1', 07:02:56 INFO - 'TERM': 'linux', 07:02:56 INFO - 'TMOUT': '86400', 07:02:56 INFO - 'USER': 'cltbld', 07:02:56 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:56 INFO - '_': '/tools/buildbot/bin/python'} 07:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 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)) 07:02:57 INFO - Cleaning up... 07:02:57 INFO - Return code: 0 07:02:57 INFO - Running post-action listener: _resource_record_post_action 07:02:57 INFO - Running post-action listener: _start_resource_monitoring 07:02:57 INFO - Starting resource monitoring. 07:02:57 INFO - ##### 07:02:57 INFO - ##### Running install step. 07:02:57 INFO - ##### 07:02:57 INFO - Running pre-action listener: _resource_record_pre_action 07:02:57 INFO - Running main action method: install 07:02:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:02:57 INFO - Reading from file tmpfile_stdout 07:02:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:02:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:02:57 INFO - Reading from file tmpfile_stdout 07:02:57 INFO - Output received: 07:02:57 INFO - Usage: mozinstall [options] installer 07:02:57 INFO - Options: 07:02:57 INFO - -h, --help show this help message and exit 07:02:57 INFO - -d DEST, --destination=DEST 07:02:57 INFO - Directory to install application into. [default: 07:02:57 INFO - "/builds/slave/test-pgo"] 07:02:57 INFO - --app=APP Application being installed. [default: firefox] 07:02:57 INFO - mkdir: /builds/slave/test-pgo/build/application 07:02:57 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'] 07:02:57 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 07:03:11 INFO - Reading from file tmpfile_stdout 07:03:11 INFO - Output received: 07:03:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:03:11 INFO - Running post-action listener: _resource_record_post_action 07:03:11 INFO - ##### 07:03:11 INFO - ##### Running run-tests step. 07:03:11 INFO - ##### 07:03:11 INFO - Running pre-action listener: _resource_record_pre_action 07:03:11 INFO - Running main action method: run_tests 07:03:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:03:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:03:11 INFO - Python 2.7.3 07:03:11 INFO - Return code: 0 07:03:11 INFO - grabbing minidump binary from tooltool 07:03:11 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')]} 07:03:11 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 0x1dcba90>, '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 0x1e1df70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e1e2e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:03:11 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 07:03:11 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 07:03:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:11 INFO - Return code: 0 07:03:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:03:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:03:11 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/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:03:11 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/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 07:03:11 INFO - Using env: {'DISPLAY': ':0', 07:03:11 INFO - 'HOME': '/home/cltbld', 07:03:11 INFO - 'LANG': 'en_US.UTF-8', 07:03:11 INFO - 'LANGUAGE': 'en_US:en', 07:03:11 INFO - 'LOGNAME': 'cltbld', 07:03:11 INFO - 'MAIL': '/var/mail/cltbld', 07:03:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:03:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:11 INFO - 'MOZ_NO_REMOTE': '1', 07:03:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:11 INFO - 'NO_EM_RESTART': '1', 07:03:11 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:03:11 INFO - 'PWD': '/builds/slave/test-pgo', 07:03:11 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:03:11 INFO - 'SHELL': '/bin/bash', 07:03:11 INFO - 'SHLVL': '1', 07:03:11 INFO - 'TERM': 'linux', 07:03:11 INFO - 'TMOUT': '86400', 07:03:11 INFO - 'USER': 'cltbld', 07:03:11 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734', 07:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:11 INFO - '_': '/tools/buildbot/bin/python'} 07:03:11 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/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 07:03:12 INFO - mozversion INFO | application_buildid: 20151123053004 07:03:12 INFO - mozversion INFO | application_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 07:03:12 INFO - mozversion INFO | application_display_name: Nightly 07:03:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:12 INFO - mozversion INFO | application_name: Firefox 07:03:12 INFO - mozversion INFO | application_remotingname: firefox 07:03:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:03:12 INFO - mozversion INFO | application_vendor: Mozilla 07:03:12 INFO - mozversion INFO | application_version: 45.0a1 07:03:12 INFO - mozversion INFO | platform_buildid: 20151123053004 07:03:12 INFO - mozversion INFO | platform_changeset: 5c614c8507b7c7928ffbe5cc3a884d7c55c9405b 07:03:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:03:12 INFO - mozversion INFO | platform_version: 45.0a1 07:03:12 INFO - 2015-11-23 07:03:12,038 DEBUG : using testdate: 1448290992 07:03:12 INFO - 2015-11-23 07:03:12,038 DEBUG : actual date: 1448290992 07:03:12 INFO - 2015-11-23 07:03:12,052 INFO : starting webserver on 'localhost:35695' 07:03:12 INFO - 2015-11-23 07:03:12,053 INFO : Starting test suite talos-linux64-ix-023.e 07:03:12 INFO - 2015-11-23 07:03:12,053 INFO : Starting test dromaeo_css 07:03:12 INFO - 2015-11-23 07:03:12,053 DEBUG : operating with platform_type : linux_ 07:03:12 INFO - 2015-11-23 07:03:12,054 INFO : Initialising browser for dromaeo_css test... 07:03:12 INFO - 2015-11-23 07:03:12,071 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplCPVj7/profile http://localhost:35695/getInfo.html 07:03:17 INFO - 2015-11-23 07:03:17,809 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:03:17 INFO - 2015-11-23 07:03:17,810 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:03:17 INFO - 2015-11-23 07:03:17,810 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:03:17 INFO - 2015-11-23 07:03:17,810 DEBUG : BROWSER_OUTPUT: __metrics 07:03:18 INFO - 2015-11-23 07:03:18,839 INFO : Browser initialized. 07:03:18 INFO - 2015-11-23 07:03:18,839 INFO : Running cycle 1/1 for dromaeo_css test... 07:03:18 INFO - 2015-11-23 07:03:18,840 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplCPVj7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:03:30 INFO - 2015-11-23 07:03:30,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 142401536 07:03:30 INFO - 2015-11-23 07:03:30,635 DEBUG : BROWSER_OUTPUT: 07:04:20 INFO - 2015-11-23 07:04:20,258 DEBUG : BROWSER_OUTPUT: 1448291060255 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] 07:06:29 INFO - 2015-11-23 07:06:29,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35695/tests/dromaeo/cssquery-ext.html) 07:06:30 INFO - 2015-11-23 07:06:30,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 145502208 07:06:30 INFO - 2015-11-23 07:06:30,092 DEBUG : BROWSER_OUTPUT: 07:09:31 INFO - 2015-11-23 07:09:31,952 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-ext.html (next: http://localhost:35695/tests/dromaeo/cssquery-jquery.html) 07:09:32 INFO - 2015-11-23 07:09:32,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 142069760 07:09:32 INFO - 2015-11-23 07:09:32,538 DEBUG : BROWSER_OUTPUT: 07:12:34 INFO - 2015-11-23 07:12:34,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35695/tests/dromaeo/cssquery-mootools.html) 07:12:34 INFO - 2015-11-23 07:12:34,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 07:12:34 INFO - 2015-11-23 07:12:34,828 DEBUG : BROWSER_OUTPUT: 07:15:36 INFO - 2015-11-23 07:15:36,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35695/tests/dromaeo/cssquery-prototype.html) 07:15:37 INFO - 2015-11-23 07:15:37,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 141090816 07:15:37 INFO - 2015-11-23 07:15:37,054 DEBUG : BROWSER_OUTPUT: 07:18:39 INFO - 2015-11-23 07:18:39,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35695/tests/dromaeo/cssquery-yui.html) 07:18:39 INFO - 2015-11-23 07:18:39,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 141271040 07:18:39 INFO - 2015-11-23 07:18:39,910 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/dromaeo/cssquery-yui.html (next: http://localhost:35695/tests/dromaeo/cssquery-dojo.html) 07:21:42 INFO - 2015-11-23 07:21:42,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 143728640 07:21:42 INFO - 2015-11-23 07:21:42,722 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,723 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:21:42 INFO - 2015-11-23 07:21:42,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:21:42 INFO - 2015-11-23 07:21:42,723 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:21:42 INFO - 2015-11-23 07:21:42,723 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:21:42 INFO - 2015-11-23 07:21:42,724 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3186.474231751761;3237.870485180593;3250.9349813003755;3274.5743053403053;3283.5731354923873;5285.550728188099;5346.224797404374;5356.946430535699;5368.624196306255;5393.919091213635;5258.237555554442;5387.272718183054;5406.513413792758;5414.945850541493;5440.755166017529;4885.242787367954;4975.378077740283;5079.4412614612365;5102.821401250957;5198.636095473318;4947.802087916479;5091.109055915219;5093.414257360414;5140.203268493371;5175.767090480918;4815.975920120412;4821.54195351441;4921.311016457699;4950.529699678525;5037.798488060474;4945.876353091166;4957.925631115536;4958.727270000149;4973.378327709036;5008.29883816266;4914.385701787277;4923.704577725348;4933.654644174909;4949.8020079196785;4966.279889416014;5063.392392912837;5074.5432911037815;5121.487851214886;5142.665726727751;5172.534471897509;5783.190353350492;5832.416758324176;5840.15317778924;5842.357340692521;5843.2695913010875;5746.597738158331;5868.2664666916635;5870.412958704138;5882.088276317178;5883.882322353529;5487.012337779198;5513.393526712059;5528.5577153828;5532.972335138339;5536.307961504812;5920.2007728956905;5991.340952495222;6005.3394126646035;6020.217371741734;6056.273247210363;5751.683657398883;5790.131480277992;5796.188533605298;5806.506446952057;5821.563382746311;5688.033034384164;5818.21454103699;5898.469137777621;5939.554533410012;5943.940560594425;5843.415658434123;5960;5972.193753843262;5981.222441082718;5992.580519363602;5740.397258287903;5745.425457454305;5762.74067666956;5769.048107062372;5770.221020162225;4386.978065109654;4404.405405270311;4443.4445694288215;4474.530174331713;4491.214037543416;4022.6178513041214;4032.737872038308;4041.555428902818;4056.229316429869;4072.7963601819793;5547.25112109868;5551.333839939233;5561.026820306431;5564.4991950724625;5601.131824567198;5760.855978600569;5908.615939963888;5910.379410161957;5918.112283157561;5922.052471604608;5510.862228444321;5554.333479982347;5555.972220138873;5572.442755724395;5581.525570326487;4877.902441951142;4946.332245146859;4951.752412379366;4966.081274964144;4986.127427700138;6098.054801505774;6117.571769976059;6118.938810611926;6140.508759299245;6143.938560614337;5913.881722365614;5926.762929482772;5928.4960778334325;5930.466258036711;5944.167816505779;5831.096180092092;5950.2264705587995;5983.431574000463;6011.549133815069;6069.635821850703;5834.474897259267;5839;5859.707014649336;5862.237909071793;5871.03127983895;5720.856978575569;5928.555358348055;5931.347551769388;5937.732802023833;5952.732127054206;5644.435556444487;5725.08398656213;5729.828105156852;5730.426957304237;5796.0436527972415;5754.827355179351;5786.566007549535;5787.508061814625;5788.27646544182;5794.449527294901;5556.583256255716;5661.235733175969;5680.488756011979;5706.771729130955;5712.143178523254;5739.942600574108;5824.126381042708;5826.621269617462;5828.6502809831545;5835.649861008353;5556.055470569932;5568.470995255444;5575.916361254665;5611.915821262766;5614.24207731951 07:21:42 INFO - 2015-11-23 07:21:42,728 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.4314199516493;589.787676436483;602.7438338706049;612.4212619074974;652.7780554611434;31703.36593268136;32531.186720332003;37387.756734595874;38007;38082.42876356857;42054.57945420545;42472.57527424725;42699.359509607304;42767;42902.141957160835;8736.388452808305;8809.119088091204;8885.95557022214;8912.24245939096;8914.375993680445;8586.27016703581;8627.396082274243;8672.13278672131;8681.869771953427;8686.3495935772;8739.038705742363;8774.780630484225;8813.1186881312;8844.778880528007;8877.911220887805;8669.089745576719;8698.695545655903;8756.299496040334;8814.691485797966;8822.161894620001;8675.436096653697;8787.209151176361;8789.868151977726;8809.867851982226;8814.647414103429;40507.39238911419;40528.392074118914;40533.59466405357;40552.797236013925;40793.79603101995;3057.2662560985204;3158.322432314601;3261.4129456697783;3296.571445712066;3334.899953001414;29230.269243268875;29740.70259297401;29755.948840719542;29876.55185172224;30333.24166895823;3425.811580363079;3446.724262059054;3531.0819187011307;3541.1678255609913;3576.445650924085;275723;275875.68870179093;276728;277571;279594.99999999796;40608.73608271148;41518.58481415208;57253.713731431075;57526.7123664379;57684.711576442685;44850.32724509135;44892.77553612211;45035.54964450314;45099.54900451019;45168.77415612901;13677.794833077513;13819.792703109462;13842.723145537033;13878.097923635134;13891.861081389057;10664.41345725977;10769.24615276923;10795;10796.838047429295;10803.13574914005;14346;14409.06341087826;14456.13263204211;14512.782308265385;14547.636309092357;5943;5978.222831031938;6031.577789554689;6052.6065805723365;6082.908756368658;969.8448248280241;996.8106059848606;1062.1555863088863;1066.3814987307344;1066.626680661762;28391.148265552067;28456.288592785346;28691.139265821643;28711;28734.568981465294;999.8750156230471;1012.0587853296505;1027.814993301213;1030.4538594544904;1133.8696049954196;14836.62908427298;14853;15092.471763488446;15291.24150722681;15295.15876626774;311091;313985;316319;316405;316591;52025;52622;52851;52860.47139528555;52917.7354113227;1247.133242396544;1255.152771878978;1261.9684507887375;1274.4519856461625;1277.6550331410467;27385;28360.85819570889;28435.289117771394;28471.572926405704;28514.85940562354;47134.528654714384;47175.76412117918;47406;47582.28626570535;47689.76155119341;293004;294260;294769;295343;295796;33111.83444082861;42437.363439547815;43093.784531077144;43545.56454435415;43939;43333.78333108314;44173.55826441823;44187.77906110577;44502.662300326956;44975.32537011882;37260.627393725714;37845;38836;39257.607423926536;39300.2139957205;37478.812605937885;38820.94419918064;38827;39042.80478597589;39305.803470982464;37376.252474950896;40867.386989194594;41764;41883;41905;30942.69057309398;34434.65565344415;34919.301613968084;35152.82423587866;37373.62626373702;25775.03895170013;26130.346741331618;26134.738652613232;26285.605715913895;26533.41798857207 07:21:42 INFO - 2015-11-23 07:21:42,728 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.8018768926333;337.07641063486057;337.56117047837813;341.2747910689784;348.1591955427642;16356.1004144772;16482.340706371746;17372.47882563522;17604.735928961076;18208.271669133217;10303.948480257588;10363.22275829314;10509.684709458728;10583.84124238137;10629.627963021296;4783.139034973695;4885.755712214375;4892;4897.608191344684;5104.157813960692;5383.246345511631;5403.945960540404;5412.9458705412835;5418.512333889949;5420.078586640261;4879.438864530571;5064.797408103672;5456.836294911139;5491.643043202179;5495.890082198353;4881.243407271879;4908.165611845995;4936.185529387647;4943.826966056189;4952.727599981999;4702.388689470347;5324.961632481668;5362.91955620666;5366.141417373241;5384.246205531229;11517.712057198552;11631.836816318386;11761.235519691192;12169.269843809312;12246.81629775554;2049.5388537579074;2069.596428696405;2075.7716651168357;2082.9479263018547;2198.5163264081875;8916;8985.23625491834;9011.188992990663;9042.954785226098;9072.36493445459;1730.2386949742074;1768.3722278591172;1786.7230579260236;1862.8230318119756;1865.4963159946874;59975.40024599785;62633.686831566;63402.36597634011;64539.67730161366;65020.67489662521;9853.211743060538;9916.355436896723;10222.926592707807;10284.485775711335;10326.48367581618;13486.730265394637;13531.59405217845;13539.39072741729;13546.932265338808;13549.119307244997;6969.337912898267;7057.258987806309;7137.714491420285;7243.311885370881;7338.156112047183;6785.201921490809;6804;6838.692258848364;6862.553933994274;6864.107666003388;4369.60673539383;4420.823167073346;4426.690131690815;4429.601335879786;4439.4228750262255;1753.0270699761754;1811.7101263797729;1818.2906272753632;1827.9817201827811;1844.5665268661853;372.51758972130614;383.8157684311546;386.6925793993782;400.98195581198917;879.9428037177563;9661.758456038515;9939.80120397588;9942.701718948443;10046;16415.91792041032;816.5386556595505;919.1635611593418;928.1414691410554;954.6801821389773;993.2749093162032;9293.860592091123;9345.299102567335;9438;9478.38390504615;9626.711198664052;550609;554034;554755;563933;565572;73519.63240183765;79952;80161.59919200366;81114.18885811184;81816;1110.6890070780194;1112.5327362507605;1139.2196345503357;1171.3381939204492;1185.9051275897907;15843.287052082453;15850.207489625242;15991.120488373252;16132.919335403249;16358.263878125275;34843;34997;35058.298834022666;36055;36358.8182059088;43676;43727.78136109299;43947.72627284746;46243.537564623926;47378;9361.157495825408;9530;9621.230301575997;9623.855642165514;9778.315517913677;18010.279588816302;18050.548736281173;18144.818551814315;18375.632487350445;18382.908085459487;14082.929585352007;14104.647383815487;14467.710645786814;14592.489262875748;14846.925765371105;14040.78938815898;14171.929140354232;14193.148411095368;14201.928990354982;14537.41850325975;14294.213818240096;14411.135331880121;14575.85424145745;14698.853011469748;14919.403223871357;8708.60811263482;9029.819403612022;9149.405288656217;9190.724278271662;9206.849143857018;9608.375455595364;11027.83458248111;14082.084664496775;14252.429902803771;14820.03669761462 07:21:42 INFO - 2015-11-23 07:21:42,731 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1499.9100053996754;1712.4092188195073;1734.4623166818287;1736.2620886123395;1772.2910835665732;7221.675024623892;7524.84950300995;7592.77221683349;7663.770086897395;7712.074551053867;7620.237976202377;7695.192004839495;7720.691172353099;7725.111612164589;7730.149683534821;2175.0973346061364;2202.130158587357;2203.911843526257;2205.9448513787124;2209.381373215494;2239.2162743039967;2266.05958527211;2310.376198426424;2311.503026849227;2311.56080344734;2193.265256139195;2227.8329125315586;2251.9437014074615;2258.796708296253;2261.852979556332;2216.4126506475795;2254.075828910139;2289.1530133850415;2290.8510946788488;2296.5292115116363;2249.550089981994;2266.9886650566805;2279.4529312964933;2279.589673858705;2290;7440.776776696708;7511.0986681598015;7533.4349923755935;7537.095548534211;7555.16893141754;4485.349624304457;4579.129965306581;4590.586847183736;4591.977040114778;4607.124646317223;2949.837758923258;2985.1790757541635;3058.709422604849;3067.340521787826;3092.6443459002276;956.712986104166;965.165132160683;973.7030205787232;978.6036655154674;990.8067926754286;10097.08155450462;10114.494275286279;10230.283880128394;10242.9487852561;10251.6411925583;3940.3695408734466;3971.841126354971;3978.42312864633;4001.6998725095737;4007.979960100181;8329.625166867505;8345.624446899905;8354.916450835535;8368.58157092143;8370.79073023167;4398.626116780046;4404.4494438195225;4414.84548040817;4449.310356894686;4459.9331010034875;4022.235775202702;4027.275090483741;4036.5156181258435;4038.434619153321;4045.858394956221;3415.6584341565645;3419.145213696576;3432.1762776933856;3436.639152888961;3457.9827100864836;1025.9025392587691;1048.4705223861902;1058.1534772182224;1061.7292590389402;1070.9518071686794;1012.9797404052025;1024.8513965474965;1086.1093902999623;1166.9066474682006;1311.1543054729646;6780.830479238059;6791.219009813836;6846.760363387357;6920.238773734885;6927;1140.0822338017808;1141.931484110956;1153.0775379696377;1158.0619698044611;1183.5206741269799;5564.137558678412;5573.331200255995;5613.129964855454;5646.57650676201;5648.293963254593;8711.303095752452;8833.425827321333;9121.45271283725;9127;9172.220361269234;8962.058983806606;9008.459492430475;9019.684311049083;9030.729078127666;9054.81890362189;6875.5530890491955;6909.792706218822;7049.718011279491;7128.536645118051;7145.82135446618;6908.827279317856;6923.861522769617;6934.341237582422;6947.930520694728;6951.617661028692;7656;7890.210978902293;7935.722249721232;7971.083325417651;8014.799630009064;7931.087924888711;8016;8136.83726325482;8162.265396114378;8198.754037378889;6745.3591908768585;6785.762498312535;6793.592384456949;6847;6893.75871844483;7371.41028717712;7398.223186565333;7408.03695519579;7412.592307423143;7440.181580026301;6716.597004179569;6728.966355168192;6735.595864248161;6788.626625535643;6803.625800581016;6330.461910737455;6387.137736405526;6635.8009259722285;6824.4199243064895;6946.270641582763;6923;6937.549059311129;6946.37482626566;6953.895691564529;6953.965230173817;6144.354842741448;6247.718852651551;6250.937490625218;6323;6329;6485.837854053686;6489.415952564292;6521.087047813215;6522.184726909137;6525.934740652722 07:21:42 INFO - 2015-11-23 07:21:42,732 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.89282804604363;309.0234857849196;314.6145971185297;321.82299735145665;326.1422458933006;6231.50147988161;6293.779717709881;6410.358964103593;6410.551261411703;6441.259255185655;6151.753929842812;6325.46233570146;6330.4935605151595;6340.778072767454;6359.173307470022;4775.188218002939;4802.159622066142;4811.735354555498;4814.422269327685;4815.975920120394;4804.759762011886;4807.35100761398;4807.735574543399;4816.759162041902;4817.132916075105;4666.883327916796;4704.0356726870905;4739.81040758371;4749.548792864673;4760.952390476103;4736.076465089309;4740.549647783455;4748.097861406339;4748.833790817339;4749.62003039756;4090.8363665453644;4124.05146816234;4126.071633882352;4132.152908653718;4138.193052354792;5965.910511342333;5968.37332080134;5975.043992961106;5998.640081595118;6000.399960004008;5429.511343979061;5514.393416724157;5546.195801608785;5548.639338442988;5560.026995275811;6666.699998500079;6674.098996635441;6705.765298214588;6711.060451536789;6727.091842601235;4569;4573.679842411033;4575.1993401155;4581.931271030904;4584.174848527264;6830.863382732367;6962.477814163958;6982.860342793167;7005.369516743517;7016.543924644881;4638.118757436144;4644.790984405642;4649.209634362167;4658.34783130362;4666.136764698542;4693.178693728584;4715.646326525456;4716.740579268105;4727.57451829337;4739.502352252964;5483.725813709299;5506.476884695948;5515.751791169407;5516.558675305966;5533.418991005967;6670.5664131832245;6786.423154031864;6788.59268443895;6805.523613347117;6807.400260938675;1594.4738236381966;1633.616100216448;1637;1637.1405012368602;1654.1811803157514;1055.1927775251938;1062.8193207154802;1067.9092277156374;1074.7689246811817;1078.5901357484106;6412.166418365583;6421.903671444932;6425.1968503937005;6431.5529005973285;6449.967750161313;6863.073485079451;6865.210500792373;6879.759208427681;6880.277570854988;6903.240643529208;6383;6384.265809431882;6394.808155755335;6404.903926441107;6404.935950640434;3815.618438156162;3823.5411750590106;3826.253880493277;3840.577536470986;3851.672607828366;7348.70605175787;7375.225601311892;7392.1499027611435;7402.629868506553;7403.629818509053;7060.8940865886025;7250.021247131675;7313.707451701873;7322.304381083789;7335.669894854745;7351.852962940711;7355.705771769176;7355.889661655079;7357.043584334002;7375.299346562068;7067.646617668993;7069.22238553769;7072.3634872861685;7075.858482830417;7081.327273909176;6835.69239384219;6959.721611135498;6988.79033628992;6992.545484543489;7002.684879180551;7301.452391070585;7314.743983960536;7315.48791584584;7319.780406587811;7320.96339518299;4551.271796512542;4560.452745670541;4603.171429142786;4609.1703493371515;4617.58441740245;6929.856573665289;6949.270326615632;7057.153141623038;7059.71761129549;7067.081279433641;6869.450443964371;6872.381485666314;6876.587404755731;6878.55289406187;6891.3797758202;6798.116244888331;6852;6852.931470685229;6857.622830744357;6874.243833178446;6601.867962640624;6646.2356828965285;6688.732450702112;6723.697433615597;6767.323267673193;6845.349691779273;6857.27998560164;6900.689468973807;6905.274946130785;6922.411595014481;6730.966345168243;6745.730170793114;6745.763898263537;6748.628825414649;6750.5274630775375 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: |5;yui.html;736.885782703681;823.7611092783093;824.3034635732804;832.3590835057006;861.5735211070524;13895.166290022593;14287.642808929782;14332.211728354936;14345.928270358634;14395.568132956016;13251.138675986054;13354.93322533386;13358.933205333984;13364.131331463472;13388.59834204973;817.7751118442417;831.4387788242942;836.4855613797502;836.7322456813822;836.9707060252862;814.7922279818638;815.5636734347125;815.7878951472601;819.713100414853;821.6590115102225;857.2584714222185;859.7635650196183;862.5859587398053;862.6980556805131;866.4974314897376;853.7012045783957;855.1320409784074;855.4952577978992;857.5626430520417;857.7984173719171;623.2832242920678;625.4902254662436;626.4174317884366;626.680392999569;628.8459327464755;14363.640908977255;14459.060161089601;14460.276986150755;14490.275486225752;14503.70992580153;12677.683057923534;12738.235705857585;13012.349382530836;13074.346282685829;13246.801297980537;9871.309008369417;10236.641717539926;10404.947975260151;10579.57681692739;10948;3595.7482976191677;3768.7550309229814;3772.4718539404507;3775.735698501106;3784.375578029622;46739.766301168616;47179;47329.29006064912;47448.5255147451;47461;9822.950885245527;10390.740231494274;10406.11548018427;10500.422476763852;10729.731756705989;19166.616667666567;19606.90196549008;19641.705374419395;19650.115744791517;19672.90163549173;7299.5620262784405;7347.338739513362;7378.40972722181;7528.1719010908755;7566.394688424913;4177.937330940038;4185.560516145761;4230.661547076226;4256.765877876746;4270.188664153801;3107.145534977854;3140.7016333448287;3151.5902932618615;3156.447621666199;3161.936761264762;513.4403500184817;520.10541867987;520.9661372010808;522.639378828607;531.7607076815449;496.92546118081856;664.867026594683;667.432682220109;690.5442408010689;696.1506961506954;7697.923020769833;8765.298776097898;8838.646454141763;8948.149925757043;9094.181523662903;585.1865906390121;677.4174210179242;679.1646275081678;680.904673345732;683;3992.181602771425;4034.455348527911;4093.3041382964966;4114.19773144234;4161.313383291784;61297.38702613006;61316.38683613107;61378.38621613727;61412;61944;46644;51197;54259.72870135624;54804;55203;48102.518974809806;48322.516774832504;48679;48893.51106488961;49497.50502495001;7854.6858125674335;8030.678772849021;8113.59432028408;8497;8791.560421979004;35583.82208088943;36263.456048159824;36451.27097458089;36983.41116121846;37257.441138382404;46195.3070703933;46316;46388.768056159504;46478.07043859171;46787.29819052785;10519.316244444086;10849.945750271198;11014.173936954921;11133.051715949838;11187.440627968732;11863.288202707865;12114.636560903187;12259.203151795105;12919.22484650924;13258.668533286746;10273.04328879987;10479;10484.895151048391;10573.4713264338;10912.727181820517;11853.229540079867;11953.282803031845;12030.879691203327;12123.272603643809;12547.058970577425;11111.444427778417;11254.480645113132;11327.773444531229;11395.943020284845;11679.299242045505;9799.755006124904;9803.754906127404;10094.444805535766;10307.330023548446;10507.369557826554;9491.335606507755;9491.572879220314;9542.809143816947;9568.808623827344;9620.75948101275 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292102721__endTimestamp 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,733 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5435.57 Median:5661.24 stddev:617.96 (10.9%) stddev-sans-first:594.13 07:21:42 INFO - 2015-11-23 07:21:42,734 DEBUG : BROWSER_OUTPUT: Values: 3186.5 3237.9 3250.9 3274.6 3283.6 5285.6 5346.2 5356.9 5368.6 5393.9 5258.2 5387.3 5406.5 5414.9 5440.8 4885.2 4975.4 5079.4 5102.8 5198.6 4947.8 5091.1 5093.4 5140.2 5175.8 4816.0 4821.5 4921.3 4950.5 5037.8 4945.9 4957.9 4958.7 4973.4 5008.3 4914.4 4923.7 4933.7 4949.8 4966.3 5063.4 5074.5 5121.5 5142.7 5172.5 5783.2 5832.4 5840.2 5842.4 5843.3 5746.6 5868.3 5870.4 5882.1 5883.9 5487.0 5513.4 5528.6 5533.0 5536.3 5920.2 5991.3 6005.3 6020.2 6056.3 5751.7 5790.1 5796.2 5806.5 5821.6 5688.0 5818.2 5898.5 5939.6 5943.9 5843.4 5960.0 5972.2 5981.2 5992.6 5740.4 5745.4 5762.7 5769.0 5770.2 4387.0 4404.4 4443.4 4474.5 4491.2 4022.6 4032.7 4041.6 4056.2 4072.8 5547.3 5551.3 5561.0 5564.5 5601.1 5760.9 5908.6 5910.4 5918.1 5922.1 5510.9 5554.3 5556.0 5572.4 5581.5 4877.9 4946.3 4951.8 4966.1 4986.1 6098.1 6117.6 6118.9 6140.5 6143.9 5913.9 5926.8 5928.5 5930.5 5944.2 5831.1 5950.2 5983.4 6011.5 6069.6 5834.5 5839.0 5859.7 5862.2 5871.0 5720.9 5928.6 5931.3 5937.7 5952.7 5644.4 5725.1 5729.8 5730.4 5796.0 5754.8 5786.6 5787.5 5788.3 5794.4 5556.6 5661.2 5680.5 5706.8 5712.1 5739.9 5824.1 5826.6 5828.7 5835.6 5556.1 5568.5 5575.9 5611.9 5614.2 07:21:42 INFO - 2015-11-23 07:21:42,734 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,734 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:46297.33 Median:38044.71 stddev:77299.76 (203.2%) stddev-sans-first:77440.32 07:21:42 INFO - 2015-11-23 07:21:42,735 DEBUG : BROWSER_OUTPUT: Values: 557.4 589.8 602.7 612.4 652.8 31703.4 32531.2 37387.8 38007.0 38082.4 42054.6 42472.6 42699.4 42767.0 42902.1 8736.4 8809.1 8886.0 8912.2 8914.4 8586.3 8627.4 8672.1 8681.9 8686.3 8739.0 8774.8 8813.1 8844.8 8877.9 8669.1 8698.7 8756.3 8814.7 8822.2 8675.4 8787.2 8789.9 8809.9 8814.6 40507.4 40528.4 40533.6 40552.8 40793.8 3057.3 3158.3 3261.4 3296.6 3334.9 29230.3 29740.7 29755.9 29876.6 30333.2 3425.8 3446.7 3531.1 3541.2 3576.4 275723.0 275875.7 276728.0 277571.0 279595.0 40608.7 41518.6 57253.7 57526.7 57684.7 44850.3 44892.8 45035.5 45099.5 45168.8 13677.8 13819.8 13842.7 13878.1 13891.9 10664.4 10769.2 10795.0 10796.8 10803.1 14346.0 14409.1 14456.1 14512.8 14547.6 5943.0 5978.2 6031.6 6052.6 6082.9 969.8 996.8 1062.2 1066.4 1066.6 28391.1 28456.3 28691.1 28711.0 28734.6 999.9 1012.1 1027.8 1030.5 1133.9 14836.6 14853.0 15092.5 15291.2 15295.2 311091.0 313985.0 316319.0 316405.0 316591.0 52025.0 52622.0 52851.0 52860.5 52917.7 1247.1 1255.2 1262.0 1274.5 1277.7 27385.0 28360.9 28435.3 28471.6 28514.9 47134.5 47175.8 47406.0 47582.3 47689.8 293004.0 294260.0 294769.0 295343.0 295796.0 33111.8 42437.4 43093.8 43545.6 43939.0 43333.8 44173.6 44187.8 44502.7 44975.3 37260.6 37845.0 38836.0 39257.6 39300.2 37478.8 38820.9 38827.0 39042.8 39305.8 37376.3 40867.4 41764.0 41883.0 41905.0 30942.7 34434.7 34919.3 35152.8 37373.6 25775.0 26130.3 26134.7 26285.6 26533.4 07:21:42 INFO - 2015-11-23 07:21:42,735 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,735 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28753.05 Median:43837.75 stddev:91222.78 (208.1%) stddev-sans-first:91453.73 07:21:42 INFO - 2015-11-23 07:21:42,735 DEBUG : BROWSER_OUTPUT: Values: 335.8 337.1 337.6 341.3 348.2 16356.1 16482.3 17372.5 17604.7 18208.3 10303.9 10363.2 10509.7 10583.8 10629.6 4783.1 4885.8 4892.0 4897.6 5104.2 5383.2 5403.9 5412.9 5418.5 5420.1 4879.4 5064.8 5456.8 5491.6 5495.9 4881.2 4908.2 4936.2 4943.8 4952.7 4702.4 5325.0 5362.9 5366.1 5384.2 11517.7 11631.8 11761.2 12169.3 12246.8 2049.5 2069.6 2075.8 2082.9 2198.5 8916.0 8985.2 9011.2 9043.0 9072.4 1730.2 1768.4 1786.7 1862.8 1865.5 59975.4 62633.7 63402.4 64539.7 65020.7 9853.2 9916.4 10222.9 10284.5 10326.5 13486.7 13531.6 13539.4 13546.9 13549.1 6969.3 7057.3 7137.7 7243.3 7338.2 6785.2 6804.0 6838.7 6862.6 6864.1 4369.6 4420.8 4426.7 4429.6 4439.4 1753.0 1811.7 1818.3 1828.0 1844.6 372.5 383.8 386.7 401.0 879.9 9661.8 9939.8 9942.7 10046.0 16415.9 816.5 919.2 928.1 954.7 993.3 9293.9 9345.3 9438.0 9478.4 9626.7 550609.0 554034.0 554755.0 563933.0 565572.0 73519.6 79952.0 80161.6 81114.2 81816.0 1110.7 1112.5 1139.2 1171.3 1185.9 15843.3 15850.2 15991.1 16132.9 16358.3 34843.0 34997.0 35058.3 36055.0 36358.8 43676.0 43727.8 43947.7 46243.5 47378.0 9361.2 9530.0 9621.2 9623.9 9778.3 18010.3 18050.5 18144.8 18375.6 18382.9 14082.9 14104.6 14467.7 14592.5 14846.9 14040.8 14171.9 14193.1 14201.9 14537.4 14294.2 14411.1 14575.9 14698.9 14919.4 8708.6 9029.8 9149.4 9190.7 9206.8 9608.4 11027.8 14082.1 14252.4 14820.0 07:21:42 INFO - 2015-11-23 07:21:42,736 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,736 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5270.85 Median:6358.80 stddev:2689.56 (42.3%) stddev-sans-first:2682.17 07:21:42 INFO - 2015-11-23 07:21:42,737 DEBUG : BROWSER_OUTPUT: Values: 1499.9 1712.4 1734.5 1736.3 1772.3 7221.7 7524.8 7592.8 7663.8 7712.1 7620.2 7695.2 7720.7 7725.1 7730.1 2175.1 2202.1 2203.9 2205.9 2209.4 2239.2 2266.1 2310.4 2311.5 2311.6 2193.3 2227.8 2251.9 2258.8 2261.9 2216.4 2254.1 2289.2 2290.9 2296.5 2249.6 2267.0 2279.5 2279.6 2290.0 7440.8 7511.1 7533.4 7537.1 7555.2 4485.3 4579.1 4590.6 4592.0 4607.1 2949.8 2985.2 3058.7 3067.3 3092.6 956.7 965.2 973.7 978.6 990.8 10097.1 10114.5 10230.3 10242.9 10251.6 3940.4 3971.8 3978.4 4001.7 4008.0 8329.6 8345.6 8354.9 8368.6 8370.8 4398.6 4404.4 4414.8 4449.3 4459.9 4022.2 4027.3 4036.5 4038.4 4045.9 3415.7 3419.1 3432.2 3436.6 3458.0 1025.9 1048.5 1058.2 1061.7 1071.0 1013.0 1024.9 1086.1 1166.9 1311.2 6780.8 6791.2 6846.8 6920.2 6927.0 1140.1 1141.9 1153.1 1158.1 1183.5 5564.1 5573.3 5613.1 5646.6 5648.3 8711.3 8833.4 9121.5 9127.0 9172.2 8962.1 9008.5 9019.7 9030.7 9054.8 6875.6 6909.8 7049.7 7128.5 7145.8 6908.8 6923.9 6934.3 6947.9 6951.6 7656.0 7890.2 7935.7 7971.1 8014.8 7931.1 8016.0 8136.8 8162.3 8198.8 6745.4 6785.8 6793.6 6847.0 6893.8 7371.4 7398.2 7408.0 7412.6 7440.2 6716.6 6729.0 6735.6 6788.6 6803.6 6330.5 6387.1 6635.8 6824.4 6946.3 6923.0 6937.5 6946.4 6953.9 6954.0 6144.4 6247.7 6250.9 6323.0 6329.0 6485.8 6489.4 6521.1 6522.2 6525.9 07:21:42 INFO - 2015-11-23 07:21:42,738 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,738 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5632.89 Median:6404.92 stddev:1752.48 (27.4%) stddev-sans-first:1711.11 07:21:42 INFO - 2015-11-23 07:21:42,738 DEBUG : BROWSER_OUTPUT: Values: 301.9 309.0 314.6 321.8 326.1 6231.5 6293.8 6410.4 6410.6 6441.3 6151.8 6325.5 6330.5 6340.8 6359.2 4775.2 4802.2 4811.7 4814.4 4816.0 4804.8 4807.4 4807.7 4816.8 4817.1 4666.9 4704.0 4739.8 4749.5 4761.0 4736.1 4740.5 4748.1 4748.8 4749.6 4090.8 4124.1 4126.1 4132.2 4138.2 5965.9 5968.4 5975.0 5998.6 6000.4 5429.5 5514.4 5546.2 5548.6 5560.0 6666.7 6674.1 6705.8 6711.1 6727.1 4569.0 4573.7 4575.2 4581.9 4584.2 6830.9 6962.5 6982.9 7005.4 7016.5 4638.1 4644.8 4649.2 4658.3 4666.1 4693.2 4715.6 4716.7 4727.6 4739.5 5483.7 5506.5 5515.8 5516.6 5533.4 6670.6 6786.4 6788.6 6805.5 6807.4 1594.5 1633.6 1637.0 1637.1 1654.2 1055.2 1062.8 1067.9 1074.8 1078.6 6412.2 6421.9 6425.2 6431.6 6450.0 6863.1 6865.2 6879.8 6880.3 6903.2 6383.0 6384.3 6394.8 6404.9 6404.9 3815.6 3823.5 3826.3 3840.6 3851.7 7348.7 7375.2 7392.1 7402.6 7403.6 7060.9 7250.0 7313.7 7322.3 7335.7 7351.9 7355.7 7355.9 7357.0 7375.3 7067.6 7069.2 7072.4 7075.9 7081.3 6835.7 6959.7 6988.8 6992.5 7002.7 7301.5 7314.7 7315.5 7319.8 7321.0 4551.3 4560.5 4603.2 4609.2 4617.6 6929.9 6949.3 7057.2 7059.7 7067.1 6869.5 6872.4 6876.6 6878.6 6891.4 6798.1 6852.0 6852.9 6857.6 6874.2 6601.9 6646.2 6688.7 6723.7 6767.3 6845.3 6857.3 6900.7 6905.3 6922.4 6731.0 6745.7 6745.8 6748.6 6750.5 07:21:42 INFO - 2015-11-23 07:21:42,738 DEBUG : BROWSER_OUTPUT: 07:21:42 INFO - 2015-11-23 07:21:42,740 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14203.60 Median:46691.88 stddev:16579.11 (35.5%) stddev-sans-first:16594.78 07:21:42 INFO - 2015-11-23 07:21:42,740 DEBUG : BROWSER_OUTPUT: Values: 736.9 823.8 824.3 832.4 861.6 13895.2 14287.6 14332.2 14345.9 14395.6 13251.1 13354.9 13358.9 13364.1 13388.6 817.8 831.4 836.5 836.7 837.0 814.8 815.6 815.8 819.7 821.7 857.3 859.8 862.6 862.7 866.5 853.7 855.1 855.5 857.6 857.8 623.3 625.5 626.4 626.7 628.8 14363.6 14459.1 14460.3 14490.3 14503.7 12677.7 12738.2 13012.3 13074.3 13246.8 9871.3 10236.6 10404.9 10579.6 10948.0 3595.7 3768.8 3772.5 3775.7 3784.4 46739.8 47179.0 47329.3 47448.5 47461.0 9823.0 10390.7 10406.1 10500.4 10729.7 19166.6 19606.9 19641.7 19650.1 19672.9 7299.6 7347.3 7378.4 7528.2 7566.4 4177.9 4185.6 4230.7 4256.8 4270.2 3107.1 3140.7 3151.6 3156.4 3161.9 513.4 520.1 521.0 522.6 531.8 496.9 664.9 667.4 690.5 696.2 7697.9 8765.3 8838.6 8948.1 9094.2 585.2 677.4 679.2 680.9 683.0 3992.2 4034.5 4093.3 4114.2 4161.3 61297.4 61316.4 61378.4 61412.0 61944.0 46644.0 51197.0 54259.7 54804.0 55203.0 48102.5 48322.5 48679.0 48893.5 49497.5 7854.7 8030.7 8113.6 8497.0 8791.6 35583.8 36263.5 36451.3 36983.4 37257.4 46195.3 46316.0 46388.8 46478.1 46787.3 10519.3 10849.9 11014.2 11133.1 11187.4 11863.3 12114.6 12259.2 12919.2 13258.7 10273.0 10479.0 10484.9 10573.5 10912.7 11853.2 11953.3 12030.9 12123.3 12547.1 11111.4 11254.5 11327.8 11395.9 11679.3 9799.8 9803.8 10094.4 10307.3 10507.4 9491.3 9491.6 9542.8 9568.8 9620.8 07:21:42 INFO - 2015-11-23 07:21:42,740 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:21:42 INFO - 2015-11-23 07:21:42,740 DEBUG : BROWSER_OUTPUT: 07:21:43 INFO - 2015-11-23 07:21:43,395 INFO : Browser exited with error code: 0 07:21:43 INFO - 2015-11-23 07:21:43,411 INFO : Completed test dromaeo_css (00:18:31) 07:21:43 INFO - 2015-11-23 07:21:43,411 INFO : Starting test kraken 07:21:43 INFO - 2015-11-23 07:21:43,411 DEBUG : operating with platform_type : linux_ 07:21:43 INFO - 2015-11-23 07:21:43,412 INFO : Initialising browser for kraken test... 07:21:43 INFO - 2015-11-23 07:21:43,418 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsGz1FO/profile http://localhost:35695/getInfo.html 07:21:48 INFO - 2015-11-23 07:21:48,063 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:21:48 INFO - 2015-11-23 07:21:48,064 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:21:48 INFO - 2015-11-23 07:21:48,064 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:21:48 INFO - 2015-11-23 07:21:48,064 DEBUG : BROWSER_OUTPUT: __metrics 07:21:49 INFO - 2015-11-23 07:21:49,127 INFO : Browser initialized. 07:21:49 INFO - 2015-11-23 07:21:49,127 INFO : Running cycle 1/1 for kraken test... 07:21:49 INFO - 2015-11-23 07:21:49,128 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsGz1FO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:22:00 INFO - 2015-11-23 07:22:00,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 142008320 07:22:00 INFO - 2015-11-23 07:22:00,962 DEBUG : BROWSER_OUTPUT: 07:22:03 INFO - 2015-11-23 07:22:03,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35695/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:04 INFO - 2015-11-23 07:22:04,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 142430208 07:22:04 INFO - 2015-11-23 07:22:04,053 DEBUG : BROWSER_OUTPUT: 07:22:06 INFO - 2015-11-23 07:22:06,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35695/tests/kraken/driver.html?testName=audio-dft) 07:22:07 INFO - 2015-11-23 07:22:07,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 142581760 07:22:07 INFO - 2015-11-23 07:22:07,296 DEBUG : BROWSER_OUTPUT: 07:22:10 INFO - 2015-11-23 07:22:10,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35695/tests/kraken/driver.html?testName=audio-fft) 07:22:10 INFO - 2015-11-23 07:22:10,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 137592832 07:22:10 INFO - 2015-11-23 07:22:10,740 DEBUG : BROWSER_OUTPUT: 07:22:12 INFO - 2015-11-23 07:22:12,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35695/tests/kraken/driver.html?testName=audio-oscillator) 07:22:13 INFO - 2015-11-23 07:22:13,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 138043392 07:22:13 INFO - 2015-11-23 07:22:13,286 DEBUG : BROWSER_OUTPUT: 07:22:15 INFO - 2015-11-23 07:22:15,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35695/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:22:16 INFO - 2015-11-23 07:22:16,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 138117120 07:22:16 INFO - 2015-11-23 07:22:16,040 DEBUG : BROWSER_OUTPUT: 07:22:19 INFO - 2015-11-23 07:22:19,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35695/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:19 INFO - 2015-11-23 07:22:19,673 DEBUG : BROWSER_OUTPUT: RSS: Main: 138502144 07:22:19 INFO - 2015-11-23 07:22:19,673 DEBUG : BROWSER_OUTPUT: 07:22:23 INFO - 2015-11-23 07:22:23,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35695/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:23 INFO - 2015-11-23 07:22:23,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 139935744 07:22:23 INFO - 2015-11-23 07:22:23,677 DEBUG : BROWSER_OUTPUT: 07:22:26 INFO - 2015-11-23 07:22:26,517 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35695/tests/kraken/driver.html?testName=json-parse-financial) 07:22:27 INFO - 2015-11-23 07:22:27,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 139886592 07:22:27 INFO - 2015-11-23 07:22:27,103 DEBUG : BROWSER_OUTPUT: 07:22:28 INFO - 2015-11-23 07:22:28,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35695/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:29 INFO - 2015-11-23 07:22:29,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 139427840 07:22:29 INFO - 2015-11-23 07:22:29,266 DEBUG : BROWSER_OUTPUT: 07:22:31 INFO - 2015-11-23 07:22:31,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:31 INFO - 2015-11-23 07:22:31,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 140173312 07:22:31 INFO - 2015-11-23 07:22:31,744 DEBUG : BROWSER_OUTPUT: 07:22:33 INFO - 2015-11-23 07:22:33,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:34 INFO - 2015-11-23 07:22:34,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 140193792 07:22:34 INFO - 2015-11-23 07:22:34,413 DEBUG : BROWSER_OUTPUT: 07:22:36 INFO - 2015-11-23 07:22:36,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:37 INFO - 2015-11-23 07:22:37,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 140455936 07:22:37 INFO - 2015-11-23 07:22:37,453 DEBUG : BROWSER_OUTPUT: 07:22:40 INFO - 2015-11-23 07:22:40,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:40 INFO - 2015-11-23 07:22:40,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 07:22:40 INFO - 2015-11-23 07:22:40,626 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35695/tests/kraken/driver.html?testName=ai-astar) 07:22:42 INFO - 2015-11-23 07:22:42,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 139890688 07:22:42 INFO - 2015-11-23 07:22:42,565 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,566 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:22:42 INFO - 2015-11-23 07:22:42,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:22:42 INFO - 2015-11-23 07:22:42,566 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:22:42 INFO - 2015-11-23 07:22:42,567 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:22:42 INFO - 2015-11-23 07:22:42,567 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;110;111;112;124;110;116;112;111 07:22:42 INFO - 2015-11-23 07:22:42,567 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;134;151;164;126;149;152;130;162;133 07:22:42 INFO - 2015-11-23 07:22:42,567 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;160;161;162;162;172;165;163 07:22:42 INFO - 2015-11-23 07:22:42,568 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;72;71;72;131;72;72;72;76 07:22:42 INFO - 2015-11-23 07:22:42,568 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;90;134;93;90;91;136;89;91;132 07:22:42 INFO - 2015-11-23 07:22:42,568 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;109;109;110;109;110;110;109 07:22:42 INFO - 2015-11-23 07:22:42,568 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;147;147;145;145;147;146 07:22:42 INFO - 2015-11-23 07:22:42,569 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;98;96;97;99;96;96;96;96 07:22:42 INFO - 2015-11-23 07:22:42,569 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;62;62;61;62;61;62;61;61;61 07:22:42 INFO - 2015-11-23 07:22:42,569 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;70;69;70;69;72;69;69 07:22:42 INFO - 2015-11-23 07:22:42,569 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;86;84;84;85;85;84;84;85 07:22:42 INFO - 2015-11-23 07:22:42,570 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;126;119;124;123;126;127;119;120;123 07:22:42 INFO - 2015-11-23 07:22:42,570 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;153;156;155;146;151;152;152;153;143 07:22:42 INFO - 2015-11-23 07:22:42,570 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;77;70;69;69;67;67;66;68;68;66 07:22:42 INFO - 2015-11-23 07:22:42,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:22:42 INFO - 2015-11-23 07:22:42,571 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:22:42 INFO - 2015-11-23 07:22:42,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,698 07:22:42 INFO - 2015-11-23 07:22:42,571 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:22:42 INFO - 2015-11-23 07:22:42,572 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292162564__endTimestamp 07:22:42 INFO - 2015-11-23 07:22:42,572 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,573 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:22:42 INFO - 2015-11-23 07:22:42,574 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:22:42 INFO - 2015-11-23 07:22:42,574 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,574 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.77 (4.3%) stddev-sans-first:5.05 07:22:42 INFO - 2015-11-23 07:22:42,574 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 110.0 111.0 112.0 124.0 110.0 116.0 112.0 111.0 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.60 Median:151.50 stddev:13.74 (9.1%) stddev-sans-first:14.14 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: Values: 155.0 134.0 151.0 164.0 126.0 149.0 152.0 130.0 162.0 133.0 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:3.48 (2.1%) stddev-sans-first:3.62 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 160.0 161.0 162.0 162.0 172.0 165.0 163.0 07:22:42 INFO - 2015-11-23 07:22:42,575 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.30 Median:72.00 stddev:18.57 (25.8%) stddev-sans-first:19.59 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 72.0 71.0 72.0 131.0 72.0 72.0 72.0 76.0 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:90.50 stddev:20.72 (22.9%) stddev-sans-first:21.72 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: Values: 95.0 90.0 134.0 93.0 90.0 91.0 136.0 89.0 91.0 132.0 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 147.0 147.0 145.0 145.0 147.0 146.0 07:22:42 INFO - 2015-11-23 07:22:42,576 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:1.06 (1.1%) stddev-sans-first:1.12 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 98.0 96.0 97.0 99.0 96.0 96.0 96.0 96.0 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:1.83 (2.9%) stddev-sans-first:0.53 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: Values: 67.0 62.0 62.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 69.0 70.0 69.0 72.0 69.0 69.0 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:0.97 (1.1%) stddev-sans-first:0.83 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 86.0 84.0 84.0 85.0 85.0 84.0 84.0 85.0 07:22:42 INFO - 2015-11-23 07:22:42,577 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:3.65 (3.0%) stddev-sans-first:3.08 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: Values: 116.0 126.0 119.0 124.0 123.0 126.0 127.0 119.0 120.0 123.0 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:152.50 stddev:4.55 (3.0%) stddev-sans-first:4.18 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: Values: 144.0 153.0 156.0 155.0 146.0 151.0 152.0 152.0 153.0 143.0 07:22:42 INFO - 2015-11-23 07:22:42,578 DEBUG : BROWSER_OUTPUT: 07:22:42 INFO - 2015-11-23 07:22:42,579 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:3.20 (4.7%) stddev-sans-first:1.39 07:22:42 INFO - 2015-11-23 07:22:42,579 DEBUG : BROWSER_OUTPUT: Values: 77.0 70.0 69.0 69.0 67.0 67.0 66.0 68.0 68.0 66.0 07:22:42 INFO - 2015-11-23 07:22:42,579 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:22:42 INFO - 2015-11-23 07:22:42,579 DEBUG : BROWSER_OUTPUT: 07:22:43 INFO - 2015-11-23 07:22:43,435 INFO : Browser exited with error code: 0 07:22:43 INFO - 2015-11-23 07:22:43,488 INFO : Completed test kraken (00:01:00) 07:22:43 INFO - 2015-11-23 07:22:43,488 INFO : Starting test v8_7 07:22:43 INFO - 2015-11-23 07:22:43,488 DEBUG : operating with platform_type : linux_ 07:22:43 INFO - 2015-11-23 07:22:43,488 INFO : Initialising browser for v8_7 test... 07:22:43 INFO - 2015-11-23 07:22:43,494 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAiFvp1/profile http://localhost:35695/getInfo.html 07:22:48 INFO - 2015-11-23 07:22:48,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:22:48 INFO - 2015-11-23 07:22:48,102 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:22:48 INFO - 2015-11-23 07:22:48,102 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:22:48 INFO - 2015-11-23 07:22:48,102 DEBUG : BROWSER_OUTPUT: __metrics 07:22:49 INFO - 2015-11-23 07:22:49,171 INFO : Browser initialized. 07:22:49 INFO - 2015-11-23 07:22:49,171 INFO : Running cycle 1/1 for v8_7 test... 07:22:49 INFO - 2015-11-23 07:22:49,172 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAiFvp1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:23:00 INFO - 2015-11-23 07:23:00,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 07:23:00 INFO - 2015-11-23 07:23:00,911 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35695/tests/v8_7/run.html (next: http://localhost:35695/tests/v8_7/run.html) 07:23:22 INFO - 2015-11-23 07:23:22,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 138850304 07:23:22 INFO - 2015-11-23 07:23:22,564 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,564 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:23:22 INFO - 2015-11-23 07:23:22,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:23:22 INFO - 2015-11-23 07:23:22,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:23:22 INFO - 2015-11-23 07:23:22,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:23:22 INFO - 2015-11-23 07:23:22,565 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5322976287817 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.1598770176787 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.8776443682104 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5060.606060606061 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1051.5247108307046 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |5;Earley;690.6077348066299 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 07:23:22 INFO - 2015-11-23 07:23:22,566 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 07:23:22 INFO - 2015-11-23 07:23:22,567 DEBUG : BROWSER_OUTPUT: |8;Splay;630.119722747322 07:23:22 INFO - 2015-11-23 07:23:22,567 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 07:23:22 INFO - 2015-11-23 07:23:22,567 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: __startTimestamp1448292202563__endTimestamp 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.53 Median:163.53 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,569 DEBUG : BROWSER_OUTPUT: Values: 163.5 07:23:22 INFO - 2015-11-23 07:23:22,569 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,569 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.16 Median:192.16 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,569 DEBUG : BROWSER_OUTPUT: Values: 192.2 07:23:22 INFO - 2015-11-23 07:23:22,570 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,570 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.88 Median:285.88 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,570 DEBUG : BROWSER_OUTPUT: Values: 285.9 07:23:22 INFO - 2015-11-23 07:23:22,570 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5060.61 Median:5060.61 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: Values: 5060.6 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1051.52 Median:1051.52 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: Values: 1051.5 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:690.61 Median:690.61 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: Values: 690.6 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: Values: 11964.3 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,572 DEBUG : BROWSER_OUTPUT: Values: 25425.0 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:630.12 Median:630.12 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: Values: 630.1 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: Values: 4826.9 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:23:22 INFO - 2015-11-23 07:23:22,573 DEBUG : BROWSER_OUTPUT: 07:23:23 INFO - 2015-11-23 07:23:23,435 INFO : Browser exited with error code: 0 07:23:23 INFO - 2015-11-23 07:23:23,449 INFO : Completed test v8_7 (00:00:39) 07:23:23 INFO - 2015-11-23 07:23:23,583 INFO : Completed test suite (00:20:11) 07:23:23 INFO - 2015-11-23 07:23:23,584 DEBUG : Working with test: dromaeo_css 07:23:23 INFO - 2015-11-23 07:23:23,584 DEBUG : Generating results file: dromaeo_css 07:23:23 INFO - 2015-11-23 07:23:23,585 DEBUG : Working with test: kraken 07:23:23 INFO - 2015-11-23 07:23:23,585 DEBUG : Generating results file: kraken 07:23:23 INFO - 2015-11-23 07:23:23,585 INFO : javascript benchmark 07:23:23 INFO - 2015-11-23 07:23:23,585 DEBUG : Working with test: v8_7 07:23:23 INFO - 2015-11-23 07:23:23,585 DEBUG : Generating results file: v8_7 07:23:23 INFO - 2015-11-23 07:23:23,586 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:23:23 INFO - 2015-11-23 07:23:23,648 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 07:23:23 INFO - 2015-11-23 07:23:23,648 DEBUG : process_Request line: dromaeo_css 6963.92 graph.html#tests=[[72,64,43]] 07:23:23 INFO - 2015-11-23 07:23:23,648 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:23:23 INFO - 2015-11-23 07:23:23,691 DEBUG : process_Request line: kraken 1513.40 graph.html#tests=[[232,64,43]] 07:23:23 INFO - 2015-11-23 07:23:23,691 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:23:23 INFO - 2015-11-23 07:23:23,725 DEBUG : process_Request line: v8_7 21426.73 graph.html#tests=[[230,64,43]] 07:23:23 INFO - 2015-11-23 07:23:23,726 INFO : javascript benchmark 07:23:23 INFO - 2015-11-23 07:23:23,730 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3186.474231751761, 3237.870485180593, 3250.9349813003755, 3274.5743053403053, 3283.5731354923873, 5285.550728188099, 5346.224797404374, 5356.946430535699, 5368.624196306255, 5393.919091213635, 5258.237555554442, 5387.272718183054, 5406.513413792758, 5414.945850541493, 5440.755166017529, 4885.242787367954, 4975.378077740283, 5079.4412614612365, 5102.821401250957, 5198.636095473318, 4947.802087916479, 5091.109055915219, 5093.414257360414, 5140.203268493371, 5175.767090480918, 4815.975920120412, 4821.54195351441, 4921.311016457699, 4950.529699678525, 5037.798488060474, 4945.876353091166, 4957.925631115536, 4958.727270000149, 4973.378327709036, 5008.29883816266, 4914.385701787277, 4923.704577725348, 4933.654644174909, 4949.8020079196785, 4966.279889416014, 5063.392392912837, 5074.5432911037815, 5121.487851214886, 5142.665726727751, 5172.534471897509, 5783.190353350492, 5832.416758324176, 5840.15317778924, 5842.357340692521, 5843.2695913010875, 5746.597738158331, 5868.2664666916635, 5870.412958704138, 5882.088276317178, 5883.882322353529, 5487.012337779198, 5513.393526712059, 5528.5577153828, 5532.972335138339, 5536.307961504812, 5920.2007728956905, 5991.340952495222, 6005.3394126646035, 6020.217371741734, 6056.273247210363, 5751.683657398883, 5790.131480277992, 5796.188533605298, 5806.506446952057, 5821.563382746311, 5688.033034384164, 5818.21454103699, 5898.469137777621, 5939.554533410012, 5943.940560594425, 5843.415658434123, 5960.0, 5972.193753843262, 5981.222441082718, 5992.580519363602, 5740.397258287903, 5745.425457454305, 5762.74067666956, 5769.048107062372, 5770.221020162225, 4386.978065109654, 4404.405405270311, 4443.4445694288215, 4474.530174331713, 4491.214037543416, 4022.6178513041214, 4032.737872038308, 4041.555428902818, 4056.229316429869, 4072.7963601819793, 5547.25112109868, 5551.333839939233, 5561.026820306431, 5564.4991950724625, 5601.131824567198, 5760.855978600569, 5908.615939963888, 5910.379410161957, 5918.112283157561, 5922.052471604608, 5510.862228444321, 5554.333479982347, 5555.972220138873, 5572.442755724395, 5581.525570326487, 4877.902441951142, 4946.332245146859, 4951.752412379366, 4966.081274964144, 4986.127427700138, 6098.054801505774, 6117.571769976059, 6118.938810611926, 6140.508759299245, 6143.938560614337, 5913.881722365614, 5926.762929482772, 5928.4960778334325, 5930.466258036711, 5944.167816505779, 5831.096180092092, 5950.2264705587995, 5983.431574000463, 6011.549133815069, 6069.635821850703, 5834.474897259267, 5839.0, 5859.707014649336, 5862.237909071793, 5871.03127983895, 5720.856978575569, 5928.555358348055, 5931.347551769388, 5937.732802023833, 5952.732127054206, 5644.435556444487, 5725.08398656213, 5729.828105156852, 5730.426957304237, 5796.0436527972415, 5754.827355179351, 5786.566007549535, 5787.508061814625, 5788.27646544182, 5794.449527294901, 5556.583256255716, 5661.235733175969, 5680.488756011979, 5706.771729130955, 5712.143178523254, 5739.942600574108, 5824.126381042708, 5826.621269617462, 5828.6502809831545, 5835.649861008353, 5556.055470569932, 5568.470995255444, 5575.916361254665, 5611.915821262766, 5614.24207731951], "unit": "ms", "name": "dojo.html", "value": 5394.605952378731}, {"lowerIsBetter": false, "replicates": [557.4314199516493, 589.787676436483, 602.7438338706049, 612.4212619074974, 652.7780554611434, 31703.36593268136, 32531.186720332003, 37387.756734595874, 38007.0, 38082.42876356857, 42054.57945420545, 42472.57527424725, 42699.359509607304, 42767.0, 42902.141957160835, 8736.388452808305, 8809.119088091204, 8885.95557022214, 8912.24245939096, 8914.375993680445, 8586.27016703581, 8627.396082274243, 8672.13278672131, 8681.869771953427, 8686.3495935772, 8739.038705742363, 8774.780630484225, 8813.1186881312, 8844.778880528007, 8877.911220887805, 8669.089745576719, 8698.695545655903, 8756.299496040334, 8814.691485797966, 8822.161894620001, 8675.436096653697, 8787.209151176361, 8789.868151977726, 8809.867851982226, 8814.647414103429, 40507.39238911419, 40528.392074118914, 40533.59466405357, 40552.797236013925, 40793.79603101995, 3057.2662560985204, 3158.322432314601, 3261.4129456697783, 3296.571445712066, 3334.899953001414, 29230.269243268875, 29740.70259297401, 29755.948840719542, 29876.55185172224, 30333.24166895823, 3425.811580363079, 3446.724262059054, 3531.0819187011307, 3541.1678255609913, 3576.445650924085, 275723.0, 275875.68870179093, 276728.0, 277571.0, 279594.99999999796, 40608.73608271148, 41518.58481415208, 57253.713731431075, 57526.7123664379, 57684.711576442685, 44850.32724509135, 44892.77553612211, 45035.54964450314, 45099.54900451019, 45168.77415612901, 13677.794833077513, 13819.792703109462, 13842.723145537033, 13878.097923635134, 13891.861081389057, 10664.41345725977, 10769.24615276923, 10795.0, 10796.838047429295, 10803.13574914005, 14346.0, 14409.06341087826, 14456.13263204211, 14512.782308265385, 14547.636309092357, 5943.0, 5978.222831031938, 6031.577789554689, 6052.6065805723365, 6082.908756368658, 969.8448248280241, 996.8106059848606, 1062.1555863088863, 1066.3814987307344, 1066.626680661762, 28391.148265552067, 28456.288592785346, 28691.139265821643, 28711.0, 28734.568981465294, 999.8750156230471, 1012.0587853296505, 1027.814993301213, 1030.4538594544904, 1133.8696049954196, 14836.62908427298, 14853.0, 15092.471763488446, 15291.24150722681, 15295.15876626774, 311091.0, 313985.0, 316319.0, 316405.0, 316591.0, 52025.0, 52622.0, 52851.0, 52860.47139528555, 52917.7354113227, 1247.133242396544, 1255.152771878978, 1261.9684507887375, 1274.4519856461625, 1277.6550331410467, 27385.0, 28360.85819570889, 28435.289117771394, 28471.572926405704, 28514.85940562354, 47134.528654714384, 47175.76412117918, 47406.0, 47582.28626570535, 47689.76155119341, 293004.0, 294260.0, 294769.0, 295343.0, 295796.0, 33111.83444082861, 42437.363439547815, 43093.784531077144, 43545.56454435415, 43939.0, 43333.78333108314, 44173.55826441823, 44187.77906110577, 44502.662300326956, 44975.32537011882, 37260.627393725714, 37845.0, 38836.0, 39257.607423926536, 39300.2139957205, 37478.812605937885, 38820.94419918064, 38827.0, 39042.80478597589, 39305.803470982464, 37376.252474950896, 40867.386989194594, 41764.0, 41883.0, 41905.0, 30942.69057309398, 34434.65565344415, 34919.301613968084, 35152.82423587866, 37373.62626373702, 25775.03895170013, 26130.346741331618, 26134.738652613232, 26285.605715913895, 26533.41798857207], "unit": "ms", "name": "ext.html", "value": 18138.841658940095}, {"lowerIsBetter": false, "replicates": [335.8018768926333, 337.07641063486057, 337.56117047837813, 341.2747910689784, 348.1591955427642, 16356.1004144772, 16482.340706371746, 17372.47882563522, 17604.735928961076, 18208.271669133217, 10303.948480257588, 10363.22275829314, 10509.684709458728, 10583.84124238137, 10629.627963021296, 4783.139034973695, 4885.755712214375, 4892.0, 4897.608191344684, 5104.157813960692, 5383.246345511631, 5403.945960540404, 5412.9458705412835, 5418.512333889949, 5420.078586640261, 4879.438864530571, 5064.797408103672, 5456.836294911139, 5491.643043202179, 5495.890082198353, 4881.243407271879, 4908.165611845995, 4936.185529387647, 4943.826966056189, 4952.727599981999, 4702.388689470347, 5324.961632481668, 5362.91955620666, 5366.141417373241, 5384.246205531229, 11517.712057198552, 11631.836816318386, 11761.235519691192, 12169.269843809312, 12246.81629775554, 2049.5388537579074, 2069.596428696405, 2075.7716651168357, 2082.9479263018547, 2198.5163264081875, 8916.0, 8985.23625491834, 9011.188992990663, 9042.954785226098, 9072.36493445459, 1730.2386949742074, 1768.3722278591172, 1786.7230579260236, 1862.8230318119756, 1865.4963159946874, 59975.40024599785, 62633.686831566, 63402.36597634011, 64539.67730161366, 65020.67489662521, 9853.211743060538, 9916.355436896723, 10222.926592707807, 10284.485775711335, 10326.48367581618, 13486.730265394637, 13531.59405217845, 13539.39072741729, 13546.932265338808, 13549.119307244997, 6969.337912898267, 7057.258987806309, 7137.714491420285, 7243.311885370881, 7338.156112047183, 6785.201921490809, 6804.0, 6838.692258848364, 6862.553933994274, 6864.107666003388, 4369.60673539383, 4420.823167073346, 4426.690131690815, 4429.601335879786, 4439.4228750262255, 1753.0270699761754, 1811.7101263797729, 1818.2906272753632, 1827.9817201827811, 1844.5665268661853, 372.51758972130614, 383.8157684311546, 386.6925793993782, 400.98195581198917, 879.9428037177563, 9661.758456038515, 9939.80120397588, 9942.701718948443, 10046.0, 16415.91792041032, 816.5386556595505, 919.1635611593418, 928.1414691410554, 954.6801821389773, 993.2749093162032, 9293.860592091123, 9345.299102567335, 9438.0, 9478.38390504615, 9626.711198664052, 550609.0, 554034.0, 554755.0, 563933.0, 565572.0, 73519.63240183765, 79952.0, 80161.59919200366, 81114.18885811184, 81816.0, 1110.6890070780194, 1112.5327362507605, 1139.2196345503357, 1171.3381939204492, 1185.9051275897907, 15843.287052082453, 15850.207489625242, 15991.120488373252, 16132.919335403249, 16358.263878125275, 34843.0, 34997.0, 35058.298834022666, 36055.0, 36358.8182059088, 43676.0, 43727.78136109299, 43947.72627284746, 46243.537564623926, 47378.0, 9361.157495825408, 9530.0, 9621.230301575997, 9623.855642165514, 9778.315517913677, 18010.279588816302, 18050.548736281173, 18144.818551814315, 18375.632487350445, 18382.908085459487, 14082.929585352007, 14104.647383815487, 14467.710645786814, 14592.489262875748, 14846.925765371105, 14040.78938815898, 14171.929140354232, 14193.148411095368, 14201.928990354982, 14537.41850325975, 14294.213818240096, 14411.135331880121, 14575.85424145745, 14698.853011469748, 14919.403223871357, 8708.60811263482, 9029.819403612022, 9149.405288656217, 9190.724278271662, 9206.849143857018, 9608.375455595364, 11027.83458248111, 14082.084664496775, 14252.429902803771, 14820.03669761462], "unit": "ms", "name": "jquery.html", "value": 8280.034429991267}, {"lowerIsBetter": false, "replicates": [1499.9100053996754, 1712.4092188195073, 1734.4623166818287, 1736.2620886123395, 1772.2910835665732, 7221.675024623892, 7524.84950300995, 7592.77221683349, 7663.770086897395, 7712.074551053867, 7620.237976202377, 7695.192004839495, 7720.691172353099, 7725.111612164589, 7730.149683534821, 2175.0973346061364, 2202.130158587357, 2203.911843526257, 2205.9448513787124, 2209.381373215494, 2239.2162743039967, 2266.05958527211, 2310.376198426424, 2311.503026849227, 2311.56080344734, 2193.265256139195, 2227.8329125315586, 2251.9437014074615, 2258.796708296253, 2261.852979556332, 2216.4126506475795, 2254.075828910139, 2289.1530133850415, 2290.8510946788488, 2296.5292115116363, 2249.550089981994, 2266.9886650566805, 2279.4529312964933, 2279.589673858705, 2290.0, 7440.776776696708, 7511.0986681598015, 7533.4349923755935, 7537.095548534211, 7555.16893141754, 4485.349624304457, 4579.129965306581, 4590.586847183736, 4591.977040114778, 4607.124646317223, 2949.837758923258, 2985.1790757541635, 3058.709422604849, 3067.340521787826, 3092.6443459002276, 956.712986104166, 965.165132160683, 973.7030205787232, 978.6036655154674, 990.8067926754286, 10097.08155450462, 10114.494275286279, 10230.283880128394, 10242.9487852561, 10251.6411925583, 3940.3695408734466, 3971.841126354971, 3978.42312864633, 4001.6998725095737, 4007.979960100181, 8329.625166867505, 8345.624446899905, 8354.916450835535, 8368.58157092143, 8370.79073023167, 4398.626116780046, 4404.4494438195225, 4414.84548040817, 4449.310356894686, 4459.9331010034875, 4022.235775202702, 4027.275090483741, 4036.5156181258435, 4038.434619153321, 4045.858394956221, 3415.6584341565645, 3419.145213696576, 3432.1762776933856, 3436.639152888961, 3457.9827100864836, 1025.9025392587691, 1048.4705223861902, 1058.1534772182224, 1061.7292590389402, 1070.9518071686794, 1012.9797404052025, 1024.8513965474965, 1086.1093902999623, 1166.9066474682006, 1311.1543054729646, 6780.830479238059, 6791.219009813836, 6846.760363387357, 6920.238773734885, 6927.0, 1140.0822338017808, 1141.931484110956, 1153.0775379696377, 1158.0619698044611, 1183.5206741269799, 5564.137558678412, 5573.331200255995, 5613.129964855454, 5646.57650676201, 5648.293963254593, 8711.303095752452, 8833.425827321333, 9121.45271283725, 9127.0, 9172.220361269234, 8962.058983806606, 9008.459492430475, 9019.684311049083, 9030.729078127666, 9054.81890362189, 6875.5530890491955, 6909.792706218822, 7049.718011279491, 7128.536645118051, 7145.82135446618, 6908.827279317856, 6923.861522769617, 6934.341237582422, 6947.930520694728, 6951.617661028692, 7656.0, 7890.210978902293, 7935.722249721232, 7971.083325417651, 8014.799630009064, 7931.087924888711, 8016.0, 8136.83726325482, 8162.265396114378, 8198.754037378889, 6745.3591908768585, 6785.762498312535, 6793.592384456949, 6847.0, 6893.75871844483, 7371.41028717712, 7398.223186565333, 7408.03695519579, 7412.592307423143, 7440.181580026301, 6716.597004179569, 6728.966355168192, 6735.595864248161, 6788.626625535643, 6803.625800581016, 6330.461910737455, 6387.137736405526, 6635.8009259722285, 6824.4199243064895, 6946.270641582763, 6923.0, 6937.549059311129, 6946.37482626566, 6953.895691564529, 6953.965230173817, 6144.354842741448, 6247.718852651551, 6250.937490625218, 6323.0, 6329.0, 6485.837854053686, 6489.415952564292, 6521.087047813215, 6522.184726909137, 6525.934740652722], "unit": "ms", "name": "mootools.html", "value": 4355.7351772862885}, {"lowerIsBetter": false, "replicates": [301.89282804604363, 309.0234857849196, 314.6145971185297, 321.82299735145665, 326.1422458933006, 6231.50147988161, 6293.779717709881, 6410.358964103593, 6410.551261411703, 6441.259255185655, 6151.753929842812, 6325.46233570146, 6330.4935605151595, 6340.778072767454, 6359.173307470022, 4775.188218002939, 4802.159622066142, 4811.735354555498, 4814.422269327685, 4815.975920120394, 4804.759762011886, 4807.35100761398, 4807.735574543399, 4816.759162041902, 4817.132916075105, 4666.883327916796, 4704.0356726870905, 4739.81040758371, 4749.548792864673, 4760.952390476103, 4736.076465089309, 4740.549647783455, 4748.097861406339, 4748.833790817339, 4749.62003039756, 4090.8363665453644, 4124.05146816234, 4126.071633882352, 4132.152908653718, 4138.193052354792, 5965.910511342333, 5968.37332080134, 5975.043992961106, 5998.640081595118, 6000.399960004008, 5429.511343979061, 5514.393416724157, 5546.195801608785, 5548.639338442988, 5560.026995275811, 6666.699998500079, 6674.098996635441, 6705.765298214588, 6711.060451536789, 6727.091842601235, 4569.0, 4573.679842411033, 4575.1993401155, 4581.931271030904, 4584.174848527264, 6830.863382732367, 6962.477814163958, 6982.860342793167, 7005.369516743517, 7016.543924644881, 4638.118757436144, 4644.790984405642, 4649.209634362167, 4658.34783130362, 4666.136764698542, 4693.178693728584, 4715.646326525456, 4716.740579268105, 4727.57451829337, 4739.502352252964, 5483.725813709299, 5506.476884695948, 5515.751791169407, 5516.558675305966, 5533.418991005967, 6670.5664131832245, 6786.423154031864, 6788.59268443895, 6805.523613347117, 6807.400260938675, 1594.4738236381966, 1633.616100216448, 1637.0, 1637.1405012368602, 1654.1811803157514, 1055.1927775251938, 1062.8193207154802, 1067.9092277156374, 1074.7689246811817, 1078.5901357484106, 6412.166418365583, 6421.903671444932, 6425.1968503937005, 6431.5529005973285, 6449.967750161313, 6863.073485079451, 6865.210500792373, 6879.759208427681, 6880.277570854988, 6903.240643529208, 6383.0, 6384.265809431882, 6394.808155755335, 6404.903926441107, 6404.935950640434, 3815.618438156162, 3823.5411750590106, 3826.253880493277, 3840.577536470986, 3851.672607828366, 7348.70605175787, 7375.225601311892, 7392.1499027611435, 7402.629868506553, 7403.629818509053, 7060.8940865886025, 7250.021247131675, 7313.707451701873, 7322.304381083789, 7335.669894854745, 7351.852962940711, 7355.705771769176, 7355.889661655079, 7357.043584334002, 7375.299346562068, 7067.646617668993, 7069.22238553769, 7072.3634872861685, 7075.858482830417, 7081.327273909176, 6835.69239384219, 6959.721611135498, 6988.79033628992, 6992.545484543489, 7002.684879180551, 7301.452391070585, 7314.743983960536, 7315.48791584584, 7319.780406587811, 7320.96339518299, 4551.271796512542, 4560.452745670541, 4603.171429142786, 4609.1703493371515, 4617.58441740245, 6929.856573665289, 6949.270326615632, 7057.153141623038, 7059.71761129549, 7067.081279433641, 6869.450443964371, 6872.381485666314, 6876.587404755731, 6878.55289406187, 6891.3797758202, 6798.116244888331, 6852.0, 6852.931470685229, 6857.622830744357, 6874.243833178446, 6601.867962640624, 6646.2356828965285, 6688.732450702112, 6723.697433615597, 6767.323267673193, 6845.349691779273, 6857.27998560164, 6900.689468973807, 6905.274946130785, 6922.411595014481, 6730.966345168243, 6745.730170793114, 6745.763898263537, 6748.628825414649, 6750.5274630775375], "unit": "ms", "name": "prototype.html", "value": 5041.757303254143}, {"lowerIsBetter": false, "replicates": [736.885782703681, 823.7611092783093, 824.3034635732804, 832.3590835057006, 861.5735211070524, 13895.166290022593, 14287.642808929782, 14332.211728354936, 14345.928270358634, 14395.568132956016, 13251.138675986054, 13354.93322533386, 13358.933205333984, 13364.131331463472, 13388.59834204973, 817.7751118442417, 831.4387788242942, 836.4855613797502, 836.7322456813822, 836.9707060252862, 814.7922279818638, 815.5636734347125, 815.7878951472601, 819.713100414853, 821.6590115102225, 857.2584714222185, 859.7635650196183, 862.5859587398053, 862.6980556805131, 866.4974314897376, 853.7012045783957, 855.1320409784074, 855.4952577978992, 857.5626430520417, 857.7984173719171, 623.2832242920678, 625.4902254662436, 626.4174317884366, 626.680392999569, 628.8459327464755, 14363.640908977255, 14459.060161089601, 14460.276986150755, 14490.275486225752, 14503.70992580153, 12677.683057923534, 12738.235705857585, 13012.349382530836, 13074.346282685829, 13246.801297980537, 9871.309008369417, 10236.641717539926, 10404.947975260151, 10579.57681692739, 10948.0, 3595.7482976191677, 3768.7550309229814, 3772.4718539404507, 3775.735698501106, 3784.375578029622, 46739.766301168616, 47179.0, 47329.29006064912, 47448.5255147451, 47461.0, 9822.950885245527, 10390.740231494274, 10406.11548018427, 10500.422476763852, 10729.731756705989, 19166.616667666567, 19606.90196549008, 19641.705374419395, 19650.115744791517, 19672.90163549173, 7299.5620262784405, 7347.338739513362, 7378.40972722181, 7528.1719010908755, 7566.394688424913, 4177.937330940038, 4185.560516145761, 4230.661547076226, 4256.765877876746, 4270.188664153801, 3107.145534977854, 3140.7016333448287, 3151.5902932618615, 3156.447621666199, 3161.936761264762, 513.4403500184817, 520.10541867987, 520.9661372010808, 522.639378828607, 531.7607076815449, 496.92546118081856, 664.867026594683, 667.432682220109, 690.5442408010689, 696.1506961506954, 7697.923020769833, 8765.298776097898, 8838.646454141763, 8948.149925757043, 9094.181523662903, 585.1865906390121, 677.4174210179242, 679.1646275081678, 680.904673345732, 683.0, 3992.181602771425, 4034.455348527911, 4093.3041382964966, 4114.19773144234, 4161.313383291784, 61297.38702613006, 61316.38683613107, 61378.38621613727, 61412.0, 61944.0, 46644.0, 51197.0, 54259.72870135624, 54804.0, 55203.0, 48102.518974809806, 48322.516774832504, 48679.0, 48893.51106488961, 49497.50502495001, 7854.6858125674335, 8030.678772849021, 8113.59432028408, 8497.0, 8791.560421979004, 35583.82208088943, 36263.456048159824, 36451.27097458089, 36983.41116121846, 37257.441138382404, 46195.3070703933, 46316.0, 46388.768056159504, 46478.07043859171, 46787.29819052785, 10519.316244444086, 10849.945750271198, 11014.173936954921, 11133.051715949838, 11187.440627968732, 11863.288202707865, 12114.636560903187, 12259.203151795105, 12919.22484650924, 13258.668533286746, 10273.04328879987, 10479.0, 10484.895151048391, 10573.4713264338, 10912.727181820517, 11853.229540079867, 11953.282803031845, 12030.879691203327, 12123.272603643809, 12547.058970577425, 11111.444427778417, 11254.480645113132, 11327.773444531229, 11395.943020284845, 11679.299242045505, 9799.755006124904, 9803.754906127404, 10094.444805535766, 10307.330023548446, 10507.369557826554, 9491.335606507755, 9491.572879220314, 9542.809143816947, 9568.808623827344, 9620.75948101275], "unit": "ms", "name": "yui.html", "value": 6409.727601466336}], "name": "dromaeo_css", "value": 6963.914829735745}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 110.0, 111.0, 112.0, 124.0, 110.0, 116.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 151.0, 164.0, 126.0, 149.0, 152.0, 130.0, 162.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 161.0, 162.0, 162.0, 172.0, 165.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 72.0, 71.0, 72.0, 131.0, 72.0, 72.0, 72.0, 76.0], "unit": "ms", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [95.0, 90.0, 134.0, 93.0, 90.0, 91.0, 136.0, 89.0, 91.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 145.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 98.0, 96.0, 97.0, 99.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [67.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 62.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 69.0, 70.0, 69.0, 72.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 86.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [116.0, 126.0, 119.0, 124.0, 123.0, 126.0, 127.0, 119.0, 120.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [144.0, 153.0, 156.0, 155.0, 146.0, 151.0, 152.0, 152.0, 153.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [77.0, 70.0, 69.0, 69.0, 67.0, 67.0, 66.0, 68.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1513.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.5322976287817], "unit": "score", "name": "Richards", "value": 215.87172999999993}, {"lowerIsBetter": false, "replicates": [192.1598770176787], "unit": "score", "name": "DeltaBlue", "value": 344.07807199999985}, {"lowerIsBetter": false, "replicates": [285.8776443682104], "unit": "score", "name": "Encrypt", "value": 931.1011380000001}, {"lowerIsBetter": false, "replicates": [5060.606060606061], "unit": "score", "name": "Decrypt", "value": 52.59864071856286}, {"lowerIsBetter": false, "replicates": [1051.5247108307046], "unit": "score", "name": "RayTrace", "value": 703.7295389999999}, {"lowerIsBetter": false, "replicates": [690.6077348066299], "unit": "score", "name": "Earley", "value": 965.0384240000001}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [630.119722747322], "unit": "score", "name": "Splay", "value": 129.326217}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21426.732961114736}]} 07:23:23 INFO - RETURN: dromaeo_css: 6963.92 07:23:23 INFO - RETURN: kraken: 1513.40 07:23:23 INFO - RETURN: v8_7: 21426.73 07:23:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21426.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6963.92"}}} 07:23:23 INFO - Return code: 0 07:23:23 INFO - # TBPL SUCCESS # 07:23:23 INFO - Running post-action listener: _resource_record_post_action 07:23:23 INFO - Running post-run listener: _resource_record_post_run 07:23:24 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513232896; Read time: 208; Write time: 370316 07:23:24 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 82677760; Read time: 0; Write time: 32584 07:23:24 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320987136; Read time: 208; Write time: 234744 07:23:24 INFO - Running post-run listener: _upload_blobber_files 07:23:24 INFO - Blob upload gear active. 07:23:24 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:23:24 INFO - Copying logs to upload dir... 07:23:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.503981 ========= master_lag: 0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-23 07:23:23.897782) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:23:23.901603) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010048 build_url: 'https://queue.taskcluster.net/v1/task/h0Ib4C-QT7mZNAWKBEb4EA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 07:23:23.952511) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:23:23.952868) ========= 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=e10134013339c31d8d0c4708000001d6-1448290937.839059-459417734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 07:23:24.002158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:23:24.002507) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 07:23:24.002810) ========= ========= Total master_lag: 0.39 =========