builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1448080895.75 results: success (0) buildid: 20151120193127 builduid: 85d8a643dd9f469992c2a7ef8f482c9e revision: eaa63e3f270780d6f7474f3e3153f896d6b49516 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.748893) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.749512) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.749800) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006476 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.814916) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.815223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.878959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.879229) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.938247) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.938525) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.938856) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:35.939162) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 20:41:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 139M=0s 2015-11-20 20:41:36 (139 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.144177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.144485) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.193805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.194565) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eaa63e3f270780d6f7474f3e3153f896d6b49516 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eaa63e3f270780d6f7474f3e3153f896d6b49516 --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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 20:41:36,747 truncating revision to first 12 chars 2015-11-20 20:41:36,747 Setting DEBUG logging. 2015-11-20 20:41:36,747 attempt 1/10 2015-11-20 20:41:36,747 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/eaa63e3f2707?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 20:41:37,009 unpacking tar archive at: mozilla-inbound-eaa63e3f2707/testing/mozharness/ program finished with exit code 0 elapsedTime=0.565493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.776003) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.776283) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.786452) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.786696) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 20:41:36.787035) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-20 20:41:36.787325) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:41:37 INFO - MultiFileLogger online at 20151120 20:41:37 in /builds/slave/test-pgo 20:41:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 20:41:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:41:37 INFO - {'append_to_log': False, 20:41:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:41:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 20:41:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:41:37 INFO - 'branch': 'Mozilla-Inbound', 20:41:37 INFO - 'buildbot_json_path': 'buildprops.json', 20:41:37 INFO - 'config_files': ('talos/linux_config.py',), 20:41:37 INFO - 'default_actions': ('clobber', 20:41:37 INFO - 'read-buildbot-config', 20:41:37 INFO - 'download-and-extract', 20:41:37 INFO - 'populate-webroot', 20:41:37 INFO - 'create-virtualenv', 20:41:37 INFO - 'install', 20:41:37 INFO - 'run-tests'), 20:41:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:41:37 INFO - 'download_minidump_stackwalk': True, 20:41:37 INFO - 'download_symbols': 'ondemand', 20:41:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:41:37 INFO - 'tooltool.py': '/tools/tooltool.py', 20:41:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:41:37 INFO - '/tools/misc-python/virtualenv.py')}, 20:41:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:41:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:41:37 INFO - 'installer_path': 'installer.exe', 20:41:37 INFO - 'log_level': 'info', 20:41:37 INFO - 'log_name': 'talos', 20:41:37 INFO - 'log_to_console': True, 20:41:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:41:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:41:37 INFO - 'opt_config_files': (), 20:41:37 INFO - 'pip_index': False, 20:41:37 INFO - 'sps_profile': False, 20:41:37 INFO - 'sps_profile_interval': 0, 20:41:37 INFO - 'suite': 'dromaeojs-e10s', 20:41:37 INFO - 'system_bits': '64', 20:41:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:41:37 INFO - 'title': 'talos-linux64-ix-067', 20:41:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:41:37 INFO - 'use_talos_json': True, 20:41:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:41:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:41:37 INFO - 'work_dir': 'build'} 20:41:37 INFO - ##### 20:41:37 INFO - ##### Running clobber step. 20:41:37 INFO - ##### 20:41:37 INFO - Running pre-action listener: _resource_record_pre_action 20:41:37 INFO - Running main action method: clobber 20:41:37 INFO - rmtree: /builds/slave/test-pgo/build 20:41:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:41:38 INFO - Running post-action listener: _resource_record_post_action 20:41:38 INFO - ##### 20:41:38 INFO - ##### Running read-buildbot-config step. 20:41:38 INFO - ##### 20:41:38 INFO - Running pre-action listener: _resource_record_pre_action 20:41:38 INFO - Running main action method: read_buildbot_config 20:41:38 INFO - Using buildbot properties: 20:41:38 INFO - { 20:41:38 INFO - "properties": { 20:41:38 INFO - "buildnumber": 454, 20:41:38 INFO - "product": "firefox", 20:41:38 INFO - "script_repo_revision": "production", 20:41:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 20:41:38 INFO - "repository": "", 20:41:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 20:41:38 INFO - "buildid": "20151120193127", 20:41:38 INFO - "slavename": "talos-linux64-ix-067", 20:41:38 INFO - "pgo_build": "True", 20:41:38 INFO - "basedir": "/builds/slave/test-pgo", 20:41:38 INFO - "project": "", 20:41:38 INFO - "platform": "ubuntu64_hw", 20:41:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:41:38 INFO - "slavebuilddir": "test", 20:41:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 20:41:38 INFO - "branch": "mozilla-inbound", 20:41:38 INFO - "repo_path": "integration/mozilla-inbound", 20:41:38 INFO - "stage_platform": "linux64-pgo", 20:41:38 INFO - "builduid": "85d8a643dd9f469992c2a7ef8f482c9e", 20:41:38 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:38 INFO - }, 20:41:38 INFO - "sourcestamp": { 20:41:38 INFO - "repository": "", 20:41:38 INFO - "hasPatch": false, 20:41:38 INFO - "project": "", 20:41:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 20:41:38 INFO - "changes": [ 20:41:38 INFO - { 20:41:38 INFO - "category": null, 20:41:38 INFO - "files": [ 20:41:38 INFO - { 20:41:38 INFO - "url": null, 20:41:38 INFO - "name": "https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 20:41:38 INFO - } 20:41:38 INFO - ], 20:41:38 INFO - "repository": "", 20:41:38 INFO - "rev": "eaa63e3f270780d6f7474f3e3153f896d6b49516", 20:41:38 INFO - "who": "sendchange", 20:41:38 INFO - "when": 1448080847, 20:41:38 INFO - "number": 6691870, 20:41:38 INFO - "comments": "", 20:41:38 INFO - "project": "", 20:41:38 INFO - "at": "Fri 20 Nov 2015 20:40:47", 20:41:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 20:41:38 INFO - "revlink": "", 20:41:38 INFO - "properties": [ 20:41:38 INFO - [ 20:41:38 INFO - "buildid", 20:41:38 INFO - "20151120193127", 20:41:38 INFO - "Change" 20:41:38 INFO - ], 20:41:38 INFO - [ 20:41:38 INFO - "builduid", 20:41:38 INFO - "85d8a643dd9f469992c2a7ef8f482c9e", 20:41:38 INFO - "Change" 20:41:38 INFO - ], 20:41:38 INFO - [ 20:41:38 INFO - "pgo_build", 20:41:38 INFO - "True", 20:41:38 INFO - "Change" 20:41:38 INFO - ] 20:41:38 INFO - ], 20:41:38 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:38 INFO - } 20:41:38 INFO - ], 20:41:38 INFO - "revision": "eaa63e3f270780d6f7474f3e3153f896d6b49516" 20:41:38 INFO - } 20:41:38 INFO - } 20:41:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 20:41:38 INFO - Running post-action listener: _resource_record_post_action 20:41:38 INFO - ##### 20:41:38 INFO - ##### Running download-and-extract step. 20:41:38 INFO - ##### 20:41:38 INFO - Running pre-action listener: _resource_record_pre_action 20:41:38 INFO - Running main action method: download_and_extract 20:41:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:38 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json 20:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json 20:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:41:46 INFO - Downloaded 1302 bytes. 20:41:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:41:46 INFO - Using the following test package requirements: 20:41:46 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:46 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:41:46 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'jsshell-linux-x86_64.zip'], 20:41:46 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:41:46 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:46 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:41:46 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:41:46 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:41:46 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 20:41:46 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 20:41:46 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:41:46 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:41: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')]} 20:41:46 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:49 INFO - Downloaded 22523516 bytes. 20:41:49 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 20:41:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:49 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 20:41:50 INFO - Return code: 0 20:41:50 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 20:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:41:50 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:41:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:41:59 INFO - Downloaded 22523516 bytes. 20:41:59 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 20:41:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 20:41:59 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 20:42:00 INFO - Return code: 0 20:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:00 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:42:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:42:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:42:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:42:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:42:01 INFO - Downloaded 11130997 bytes. 20:42:01 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 20:42:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 20:42:01 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 20:42:01 INFO - Return code: 0 20:42:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:01 INFO - https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:42:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:42:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tIFvKsfHQI2u7khxDab7MA/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 20:42:03 INFO - Downloaded 57475353 bytes. 20:42:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:03 INFO - mkdir: /builds/slave/test-pgo/properties 20:42:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:42:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:42:03 INFO - Contents: 20:42:03 INFO - build_url:https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 20:42:03 INFO - Running post-action listener: _resource_record_post_action 20:42:03 INFO - Running post-action listener: set_extra_try_arguments 20:42:03 INFO - ##### 20:42:03 INFO - ##### Running populate-webroot step. 20:42:03 INFO - ##### 20:42:03 INFO - Running pre-action listener: _resource_record_pre_action 20:42:03 INFO - Running main action method: populate_webroot 20:42:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:42:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:42:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 20:42:03 INFO - '../fennec_ids.txt'], 20:42:03 INFO - 'tests': ['tcheck2']}, 20:42:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:42:03 INFO - '--tppagecycles', 20:42:03 INFO - '7'], 20:42:03 INFO - 'tests': ['tsvgm']}}, 20:42:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:42:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:42:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:42:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:42:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:42:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'tests': ['damp', 'tps']}, 20:42:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['damp', 'tps']}, 20:42:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:42:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:42:03 INFO - 'other': {'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'other_l64': {'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'other_nol64': {'tests': ['a11yr', 20:42:03 INFO - 'ts_paint', 20:42:03 INFO - 'tpaint', 20:42:03 INFO - 'sessionrestore', 20:42:03 INFO - 'sessionrestore_no_auto_restore']}, 20:42:03 INFO - 'svgr': {'tests': ['tsvgx', 20:42:03 INFO - 'tsvgr_opacity', 20:42:03 INFO - 'tart', 20:42:03 INFO - 'tscrollx', 20:42:03 INFO - 'cart']}, 20:42:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['tsvgx', 20:42:03 INFO - 'tsvgr_opacity', 20:42:03 INFO - 'tart', 20:42:03 INFO - 'tscrollx', 20:42:03 INFO - 'cart']}, 20:42:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'tests': ['tp5o']}, 20:42:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'talos_options': ['--e10s'], 20:42:03 INFO - 'tests': ['tp5o']}, 20:42:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'talos_options': ['--xperf_path', 20:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:03 INFO - 'tests': ['tp5n']}, 20:42:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:42:03 INFO - 'talos_options': ['--e10s', 20:42:03 INFO - '--xperf_path', 20:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:42:03 INFO - 'tests': ['tp5n']}}, 20:42:03 INFO - 'talos.zip': {'path': '', 20:42:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:42:03 INFO - Running post-action listener: _resource_record_post_action 20:42:03 INFO - ##### 20:42:03 INFO - ##### Running create-virtualenv step. 20:42:03 INFO - ##### 20:42:03 INFO - Running pre-action listener: _resource_record_pre_action 20:42:03 INFO - Running main action method: create_virtualenv 20:42:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:42:03 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 20:42:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:42:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:42:03 INFO - Using real prefix '/usr' 20:42:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:42:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:42:06 INFO - Installing pip.................done. 20:42:06 INFO - Return code: 0 20:42:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:42:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:42:06 INFO - Using env: {'DISPLAY': ':0', 20:42:06 INFO - 'HOME': '/home/cltbld', 20:42:06 INFO - 'LANG': 'en_US.UTF-8', 20:42:06 INFO - 'LANGUAGE': 'en_US:en', 20:42:06 INFO - 'LOGNAME': 'cltbld', 20:42:06 INFO - 'MAIL': '/var/mail/cltbld', 20:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:06 INFO - 'MOZ_NO_REMOTE': '1', 20:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:06 INFO - 'NO_EM_RESTART': '1', 20:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:06 INFO - 'SHELL': '/bin/bash', 20:42:06 INFO - 'SHLVL': '1', 20:42:06 INFO - 'TERM': 'linux', 20:42:06 INFO - 'TMOUT': '86400', 20:42:06 INFO - 'USER': 'cltbld', 20:42:06 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:06 INFO - '_': '/tools/buildbot/bin/python'} 20:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:06 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 20:42:06 INFO - Cleaning up... 20:42:06 INFO - Return code: 0 20:42:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:42:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:42:06 INFO - Using env: {'DISPLAY': ':0', 20:42:06 INFO - 'HOME': '/home/cltbld', 20:42:06 INFO - 'LANG': 'en_US.UTF-8', 20:42:06 INFO - 'LANGUAGE': 'en_US:en', 20:42:06 INFO - 'LOGNAME': 'cltbld', 20:42:06 INFO - 'MAIL': '/var/mail/cltbld', 20:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:06 INFO - 'MOZ_NO_REMOTE': '1', 20:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:06 INFO - 'NO_EM_RESTART': '1', 20:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:06 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:06 INFO - 'SHELL': '/bin/bash', 20:42:06 INFO - 'SHLVL': '1', 20:42:06 INFO - 'TERM': 'linux', 20:42:06 INFO - 'TMOUT': '86400', 20:42:06 INFO - 'USER': 'cltbld', 20:42:06 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:06 INFO - '_': '/tools/buildbot/bin/python'} 20:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:06 INFO - Downloading/unpacking psutil>=0.7.1 20:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:42:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:42:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:08 INFO - Installing collected packages: psutil 20:42:08 INFO - Running setup.py install for psutil 20:42:08 INFO - building 'psutil._psutil_linux' extension 20:42:08 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 20:42:08 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 20:42:08 INFO - building 'psutil._psutil_posix' extension 20:42:08 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 20:42:08 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 20:42:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:42:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:42:09 INFO - Successfully installed psutil 20:42:09 INFO - Cleaning up... 20:42:09 INFO - Return code: 0 20:42:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:42:09 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')]} 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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')]} 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:09 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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:09 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 20:42:09 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 20:42:09 INFO - Using env: {'DISPLAY': ':0', 20:42:09 INFO - 'HOME': '/home/cltbld', 20:42:09 INFO - 'LANG': 'en_US.UTF-8', 20:42:09 INFO - 'LANGUAGE': 'en_US:en', 20:42:09 INFO - 'LOGNAME': 'cltbld', 20:42:09 INFO - 'MAIL': '/var/mail/cltbld', 20:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:09 INFO - 'MOZ_NO_REMOTE': '1', 20:42:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:09 INFO - 'NO_EM_RESTART': '1', 20:42:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:09 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:09 INFO - 'SHELL': '/bin/bash', 20:42:09 INFO - 'SHLVL': '1', 20:42:09 INFO - 'TERM': 'linux', 20:42:09 INFO - 'TMOUT': '86400', 20:42:09 INFO - 'USER': 'cltbld', 20:42:09 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:09 INFO - '_': '/tools/buildbot/bin/python'} 20:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:42:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:42:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:42:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:42:11 INFO - Installing collected packages: mozsystemmonitor 20:42:11 INFO - Running setup.py install for mozsystemmonitor 20:42:11 INFO - Successfully installed mozsystemmonitor 20:42:11 INFO - Cleaning up... 20:42:11 INFO - Return code: 0 20:42:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:42: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')]} 20:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42: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')]} 20:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:11 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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:11 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 20:42:11 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 20:42:11 INFO - Using env: {'DISPLAY': ':0', 20:42:11 INFO - 'HOME': '/home/cltbld', 20:42:11 INFO - 'LANG': 'en_US.UTF-8', 20:42:11 INFO - 'LANGUAGE': 'en_US:en', 20:42:11 INFO - 'LOGNAME': 'cltbld', 20:42:11 INFO - 'MAIL': '/var/mail/cltbld', 20:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:11 INFO - 'MOZ_NO_REMOTE': '1', 20:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:11 INFO - 'NO_EM_RESTART': '1', 20:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:11 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:11 INFO - 'SHELL': '/bin/bash', 20:42:11 INFO - 'SHLVL': '1', 20:42:11 INFO - 'TERM': 'linux', 20:42:11 INFO - 'TMOUT': '86400', 20:42:11 INFO - 'USER': 'cltbld', 20:42:11 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:11 INFO - '_': '/tools/buildbot/bin/python'} 20:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:11 INFO - Downloading/unpacking blobuploader==1.2.4 20:42:11 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 20:42:11 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 20:42:11 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 20:42:11 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 20:42:11 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 20:42:11 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 20:42:13 INFO - Downloading blobuploader-1.2.4.tar.gz 20:42:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:42:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:42:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:42:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:42:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 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 20:42:13 INFO - Downloading docopt-0.6.1.tar.gz 20:42:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:42:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:42:13 INFO - Installing collected packages: blobuploader, requests, docopt 20:42:13 INFO - Running setup.py install for blobuploader 20:42:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:42:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:42:13 INFO - Running setup.py install for requests 20:42:14 INFO - Running setup.py install for docopt 20:42:14 INFO - Successfully installed blobuploader requests docopt 20:42:14 INFO - Cleaning up... 20:42:14 INFO - Return code: 0 20:42:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:14 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')]} 20:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:14 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')]} 20:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:14 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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:14 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 20:42:14 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 20:42:14 INFO - Using env: {'DISPLAY': ':0', 20:42:14 INFO - 'HOME': '/home/cltbld', 20:42:14 INFO - 'LANG': 'en_US.UTF-8', 20:42:14 INFO - 'LANGUAGE': 'en_US:en', 20:42:14 INFO - 'LOGNAME': 'cltbld', 20:42:14 INFO - 'MAIL': '/var/mail/cltbld', 20:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:14 INFO - 'MOZ_NO_REMOTE': '1', 20:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:14 INFO - 'NO_EM_RESTART': '1', 20:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:14 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:14 INFO - 'SHELL': '/bin/bash', 20:42:14 INFO - 'SHLVL': '1', 20:42:14 INFO - 'TERM': 'linux', 20:42:14 INFO - 'TMOUT': '86400', 20:42:14 INFO - 'USER': 'cltbld', 20:42:14 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:14 INFO - '_': '/tools/buildbot/bin/python'} 20:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:14 INFO - Running setup.py (path:/tmp/pip-SfDOzh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:14 INFO - Running setup.py (path:/tmp/pip-H6NOQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:14 INFO - Running setup.py (path:/tmp/pip-XgqdNN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:14 INFO - Running setup.py (path:/tmp/pip-OyC_ua-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:14 INFO - Running setup.py (path:/tmp/pip-Eveg3P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:14 INFO - Running setup.py (path:/tmp/pip-Qh0VrE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:15 INFO - Running setup.py (path:/tmp/pip-Y1fW6x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:15 INFO - Running setup.py (path:/tmp/pip-mtaaGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:15 INFO - Running setup.py (path:/tmp/pip-lcb6Em-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:15 INFO - Running setup.py (path:/tmp/pip-9V1GTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:15 INFO - Running setup.py (path:/tmp/pip-1Hi7if-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:15 INFO - Running setup.py (path:/tmp/pip-cveTso-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:15 INFO - Running setup.py (path:/tmp/pip-82lLKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:15 INFO - Running setup.py (path:/tmp/pip-74sed5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:15 INFO - Running setup.py (path:/tmp/pip-tYFXIY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:15 INFO - Running setup.py (path:/tmp/pip-i43UFk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:15 INFO - Running setup.py (path:/tmp/pip-rLhUhg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:42:15 INFO - Running setup.py install for manifestparser 20:42:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:42:15 INFO - Running setup.py install for mozcrash 20:42:15 INFO - Running setup.py install for mozdebug 20:42:16 INFO - Running setup.py install for mozdevice 20:42:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for mozfile 20:42:16 INFO - Running setup.py install for mozhttpd 20:42:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for mozinfo 20:42:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for mozInstall 20:42:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for mozleak 20:42:16 INFO - Running setup.py install for mozlog 20:42:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for moznetwork 20:42:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:42:16 INFO - Running setup.py install for mozprocess 20:42:17 INFO - Running setup.py install for mozprofile 20:42:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:42:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:42:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:42:17 INFO - Running setup.py install for mozrunner 20:42:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:42:17 INFO - Running setup.py install for mozscreenshot 20:42:17 INFO - Running setup.py install for moztest 20:42:17 INFO - Running setup.py install for mozversion 20:42:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:42:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:42:17 INFO - Cleaning up... 20:42:17 INFO - Return code: 0 20:42:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 20:42:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 20:42:17 INFO - Using env: {'DISPLAY': ':0', 20:42:17 INFO - 'HOME': '/home/cltbld', 20:42:17 INFO - 'LANG': 'en_US.UTF-8', 20:42:17 INFO - 'LANGUAGE': 'en_US:en', 20:42:17 INFO - 'LOGNAME': 'cltbld', 20:42:17 INFO - 'MAIL': '/var/mail/cltbld', 20:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:17 INFO - 'MOZ_NO_REMOTE': '1', 20:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:17 INFO - 'NO_EM_RESTART': '1', 20:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:17 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:17 INFO - 'SHELL': '/bin/bash', 20:42:17 INFO - 'SHLVL': '1', 20:42:17 INFO - 'TERM': 'linux', 20:42:17 INFO - 'TMOUT': '86400', 20:42:17 INFO - 'USER': 'cltbld', 20:42:17 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:17 INFO - '_': '/tools/buildbot/bin/python'} 20:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:17 INFO - Running setup.py (path:/tmp/pip-Lue_vy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:42:17 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)) 20:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:17 INFO - Running setup.py (path:/tmp/pip-3JKxaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:42:17 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)) 20:42:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:17 INFO - Running setup.py (path:/tmp/pip-W3edbt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:18 INFO - Running setup.py (path:/tmp/pip-2HS2io-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:18 INFO - Running setup.py (path:/tmp/pip-er0Xbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:18 INFO - Running setup.py (path:/tmp/pip-qaWlbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:18 INFO - Running setup.py (path:/tmp/pip-tO80c2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:18 INFO - Running setup.py (path:/tmp/pip-AHmERe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:18 INFO - Running setup.py (path:/tmp/pip-hZ9kyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:18 INFO - Running setup.py (path:/tmp/pip-1kdmoD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:18 INFO - Running setup.py (path:/tmp/pip-miz8Y5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:18 INFO - Running setup.py (path:/tmp/pip-9uMUyA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:18 INFO - Running setup.py (path:/tmp/pip-JPFUEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:18 INFO - Running setup.py (path:/tmp/pip-G9bUGy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:18 INFO - Running setup.py (path:/tmp/pip-DwvCRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:18 INFO - Running setup.py (path:/tmp/pip-AwSNNm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:42:18 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)) 20:42:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:18 INFO - Running setup.py (path:/tmp/pip-7RGjQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 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)) 20:42:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:42:19 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 20:42:19 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 20:42:19 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 20:42:19 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 20:42:19 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 20:42:19 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 20:42:20 INFO - Downloading blessings-1.5.1.tar.gz 20:42:20 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 20:42:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:42:20 INFO - Installing collected packages: blessings 20:42:20 INFO - Running setup.py install for blessings 20:42:20 INFO - Successfully installed blessings 20:42:20 INFO - Cleaning up... 20:42:20 INFO - Return code: 0 20:42:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:42:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:21 INFO - Reading from file tmpfile_stdout 20:42:21 INFO - Current package versions: 20:42:21 INFO - argparse == 1.2.1 20:42:21 INFO - blessings == 1.5.1 20:42:21 INFO - blobuploader == 1.2.4 20:42:21 INFO - docopt == 0.6.1 20:42:21 INFO - manifestparser == 1.1 20:42:21 INFO - mozInstall == 1.12 20:42:21 INFO - mozcrash == 0.16 20:42:21 INFO - mozdebug == 0.1 20:42:21 INFO - mozdevice == 0.47 20:42:21 INFO - mozfile == 1.2 20:42:21 INFO - mozhttpd == 0.7 20:42:21 INFO - mozinfo == 0.9 20:42:21 INFO - mozleak == 0.1 20:42:21 INFO - mozlog == 3.1 20:42:21 INFO - moznetwork == 0.27 20:42:21 INFO - mozprocess == 0.22 20:42:21 INFO - mozprofile == 0.27 20:42:21 INFO - mozrunner == 6.11 20:42:21 INFO - mozscreenshot == 0.1 20:42:21 INFO - mozsystemmonitor == 0.0 20:42:21 INFO - moztest == 0.7 20:42:21 INFO - mozversion == 1.4 20:42:21 INFO - psutil == 3.1.1 20:42:21 INFO - requests == 1.2.3 20:42:21 INFO - wsgiref == 0.1.2 20:42:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:42:21 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')]} 20:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:21 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')]} 20:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:42:21 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 0x7fe081c77c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2af76c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba97c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, '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': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', '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 20:42:21 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 20:42:21 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 20:42:21 INFO - Using env: {'DISPLAY': ':0', 20:42:21 INFO - 'HOME': '/home/cltbld', 20:42:21 INFO - 'LANG': 'en_US.UTF-8', 20:42:21 INFO - 'LANGUAGE': 'en_US:en', 20:42:21 INFO - 'LOGNAME': 'cltbld', 20:42:21 INFO - 'MAIL': '/var/mail/cltbld', 20:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:21 INFO - 'MOZ_NO_REMOTE': '1', 20:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:21 INFO - 'NO_EM_RESTART': '1', 20:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:21 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:21 INFO - 'SHELL': '/bin/bash', 20:42:21 INFO - 'SHLVL': '1', 20:42:21 INFO - 'TERM': 'linux', 20:42:21 INFO - 'TMOUT': '86400', 20:42:21 INFO - 'USER': 'cltbld', 20:42:21 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:21 INFO - '_': '/tools/buildbot/bin/python'} 20:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 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)) 20:42:21 INFO - Cleaning up... 20:42:21 INFO - Return code: 0 20:42:21 INFO - Running post-action listener: _resource_record_post_action 20:42:21 INFO - Running post-action listener: _start_resource_monitoring 20:42:21 INFO - Starting resource monitoring. 20:42:21 INFO - ##### 20:42:21 INFO - ##### Running install step. 20:42:21 INFO - ##### 20:42:21 INFO - Running pre-action listener: _resource_record_pre_action 20:42:21 INFO - Running main action method: install 20:42:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:42:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:42:21 INFO - Reading from file tmpfile_stdout 20:42:21 INFO - Detecting whether we're running mozinstall >=1.0... 20:42:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:42:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:42:21 INFO - Reading from file tmpfile_stdout 20:42:21 INFO - Output received: 20:42:21 INFO - Usage: mozinstall [options] installer 20:42:21 INFO - Options: 20:42:21 INFO - -h, --help show this help message and exit 20:42:21 INFO - -d DEST, --destination=DEST 20:42:21 INFO - Directory to install application into. [default: 20:42:21 INFO - "/builds/slave/test-pgo"] 20:42:21 INFO - --app=APP Application being installed. [default: firefox] 20:42:21 INFO - mkdir: /builds/slave/test-pgo/build/application 20:42:21 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'] 20:42:21 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 20:42:36 INFO - Reading from file tmpfile_stdout 20:42:36 INFO - Output received: 20:42:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:42:36 INFO - Running post-action listener: _resource_record_post_action 20:42:36 INFO - ##### 20:42:36 INFO - ##### Running run-tests step. 20:42:36 INFO - ##### 20:42:36 INFO - Running pre-action listener: _resource_record_pre_action 20:42:36 INFO - Running main action method: run_tests 20:42:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:42:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:42:36 INFO - Python 2.7.3 20:42:36 INFO - Return code: 0 20:42:36 INFO - grabbing minidump binary from tooltool 20:42: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')]} 20:42:36 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 0x2bedd70>, '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 0x2beeb20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2beefb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:42:36 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 20:42:36 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 20:42:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:42:36 INFO - Return code: 0 20:42:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:42:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:42:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:42:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:42:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 20:42:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost 20:42:36 INFO - Using env: {'DISPLAY': ':0', 20:42:36 INFO - 'HOME': '/home/cltbld', 20:42:36 INFO - 'LANG': 'en_US.UTF-8', 20:42:36 INFO - 'LANGUAGE': 'en_US:en', 20:42:36 INFO - 'LOGNAME': 'cltbld', 20:42:36 INFO - 'MAIL': '/var/mail/cltbld', 20:42:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:42:36 INFO - 'MOZ_NO_REMOTE': '1', 20:42:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:42:36 INFO - 'NO_EM_RESTART': '1', 20:42:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:42:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:42:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:42:36 INFO - 'SHELL': '/bin/bash', 20:42:36 INFO - 'SHLVL': '1', 20:42:36 INFO - 'TERM': 'linux', 20:42:36 INFO - 'TMOUT': '86400', 20:42:36 INFO - 'USER': 'cltbld', 20:42:36 INFO - 'XDG_SESSION_COOKIE': '3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450', 20:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:42:36 INFO - '_': '/tools/buildbot/bin/python'} 20:42:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost'] with output_timeout 3600 20:42:36 INFO - mozversion INFO | application_buildid: 20151120193127 20:42:36 INFO - mozversion INFO | application_changeset: eaa63e3f270780d6f7474f3e3153f896d6b49516 20:42:36 INFO - mozversion INFO | application_display_name: Nightly 20:42:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:42:36 INFO - mozversion INFO | application_name: Firefox 20:42:36 INFO - mozversion INFO | application_remotingname: firefox 20:42:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:36 INFO - mozversion INFO | application_vendor: Mozilla 20:42:36 INFO - mozversion INFO | application_version: 45.0a1 20:42:36 INFO - mozversion INFO | platform_buildid: 20151120193127 20:42:36 INFO - mozversion INFO | platform_changeset: eaa63e3f270780d6f7474f3e3153f896d6b49516 20:42:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:42:36 INFO - mozversion INFO | platform_version: 45.0a1 20:42:36 INFO - 2015-11-20 20:42:36,375 DEBUG : using testdate: 1448080956 20:42:36 INFO - 2015-11-20 20:42:36,375 DEBUG : actual date: 1448080956 20:42:36 INFO - 2015-11-20 20:42:36,453 INFO : starting webserver on 'localhost:34910' 20:42:36 INFO - 2015-11-20 20:42:36,454 INFO : Starting test suite talos-linux64-ix-067.e 20:42:36 INFO - 2015-11-20 20:42:36,455 INFO : Starting test dromaeo_css 20:42:36 INFO - 2015-11-20 20:42:36,455 DEBUG : operating with platform_type : linux_ 20:42:36 INFO - 2015-11-20 20:42:36,455 INFO : Initialising browser for dromaeo_css test... 20:42:36 INFO - 2015-11-20 20:42:36,471 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz6dFz9/profile http://localhost:34910/getInfo.html 20:42:41 INFO - 2015-11-20 20:42:41,759 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:42:41 INFO - 2015-11-20 20:42:41,760 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:42:41 INFO - 2015-11-20 20:42:41,760 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:42:41 INFO - 2015-11-20 20:42:41,760 DEBUG : BROWSER_OUTPUT: __metrics 20:42:42 INFO - 2015-11-20 20:42:42,747 INFO : Browser initialized. 20:42:42 INFO - 2015-11-20 20:42:42,747 INFO : Running cycle 1/1 for dromaeo_css test... 20:42:42 INFO - 2015-11-20 20:42:42,748 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpz6dFz9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:42:54 INFO - 2015-11-20 20:42:54,502 DEBUG : BROWSER_OUTPUT: RSS: Main: 140079104 20:42:54 INFO - 2015-11-20 20:42:54,502 DEBUG : BROWSER_OUTPUT: 20:43:44 INFO - 2015-11-20 20:43:44,125 DEBUG : BROWSER_OUTPUT: 1448081024122 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] 20:45:53 INFO - 2015-11-20 20:45:53,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34910/tests/dromaeo/cssquery-ext.html) 20:45:54 INFO - 2015-11-20 20:45:54,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 147410944 20:45:54 INFO - 2015-11-20 20:45:54,584 DEBUG : BROWSER_OUTPUT: 20:48:56 INFO - 2015-11-20 20:48:56,630 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-ext.html (next: http://localhost:34910/tests/dromaeo/cssquery-jquery.html) 20:48:57 INFO - 2015-11-20 20:48:57,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 142708736 20:48:57 INFO - 2015-11-20 20:48:57,212 DEBUG : BROWSER_OUTPUT: 20:51:58 INFO - 2015-11-20 20:51:58,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34910/tests/dromaeo/cssquery-mootools.html) 20:51:59 INFO - 2015-11-20 20:51:59,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 142733312 20:51:59 INFO - 2015-11-20 20:51:59,487 DEBUG : BROWSER_OUTPUT: 20:55:01 INFO - 2015-11-20 20:55:01,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34910/tests/dromaeo/cssquery-prototype.html) 20:55:01 INFO - 2015-11-20 20:55:01,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 141156352 20:55:01 INFO - 2015-11-20 20:55:01,763 DEBUG : BROWSER_OUTPUT: 20:58:04 INFO - 2015-11-20 20:58:04,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34910/tests/dromaeo/cssquery-yui.html) 20:58:04 INFO - 2015-11-20 20:58:04,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 141082624 20:58:04 INFO - 2015-11-20 20:58:04,647 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,037 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/dromaeo/cssquery-yui.html (next: http://localhost:34910/tests/dromaeo/cssquery-dojo.html) 21:01:07 INFO - 2015-11-20 21:01:07,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 144080896 21:01:07 INFO - 2015-11-20 21:01:07,287 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,288 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:01:07 INFO - 2015-11-20 21:01:07,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:01:07 INFO - 2015-11-20 21:01:07,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:01:07 INFO - 2015-11-20 21:01:07,289 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:01:07 INFO - 2015-11-20 21:01:07,289 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3248.366568519139;3290.9999999999986;3333.083402064432;3346.84939177737;3351.463765797472;5344.412114667383;5545.916811247829;5566.471185237401;5596.748146333414;5608.9439105608935;5432.782688692448;5434.755436005379;5474.562035037197;5502.724863756816;5512.200730894018;4969.602431805447;5011.27336536203;5034.345535080434;5216.530512253897;5237.8952420951555;5159.916417552318;5177.275181474596;5195.922061169085;5217.973910130444;5237.973810130963;4856.077345304381;4921;4987.576056035241;5079.593632509391;5091.8981620367385;5050.267711181895;5052.292679024939;5083.364579427572;5092.185250359925;5131.4868513148385;4918.508149185089;5020.748962551895;5079.263506791532;5096.3884333879805;5101.948980510185;5274.947250527484;5313.628046036741;5315.946840531584;5320.813771517978;5355.036093503168;5961.463468287831;5997.490213331828;6005.789797357115;6012.518998480155;6017.247844019497;6022.8494287642725;6028.276606807167;6029.668368239745;6035.849103772397;6048.939510604881;5292.153255479105;5465.316835395575;5481.068218402881;5541.0580201365865;5603.075492543766;6069.271687397452;6074.301455332693;6117.694115294306;6120.60216085953;6126.479249263773;5793.536517078624;5849.824505264849;5858.56060795442;5893.587448878623;5914.6746928918465;5913.142594323799;5928.051511758098;5973.104034394789;6008;6075.787347442818;5976.163337132805;6060.757569697163;6083.087536869505;6086.695665216722;6093.025115981422;5756.510696590837;5908.881822363529;6082.148499210114;6087.726052327655;6095.207623008981;4487.753173575485;4528.252838281713;4540.500544940054;4558.156741002925;4597.172508948354;4073.368627862686;4098.221337945781;4106.691998100095;4115.835366585363;4137.110521237948;5582.972085139549;5678.119891416837;5748.19525266463;5766.654000759884;5766.971165144148;5849.415058494116;5944.85137871548;5945.227120474311;5951.196588460502;6018.037114061729;5741.598088133791;5780.364159942403;5780.508656764222;5792;5793.8841223175305;5115.488451154854;5170.431252562215;5176.948230517722;5233.371995360581;5272.868178295574;6101.755929762849;6125.816225513242;6128.111423843607;6141.385861413913;6220.875582488416;5935.436133567304;5936.436038576328;5947.9405205949115;5950.077737950624;5960.433758792908;5971.91042134377;6070;6103.389661033861;6157.507399407947;6300.306966233619;5943.465088142088;5976.656025538568;5991.730372133177;6009.128676341993;6038.456538911519;6058.84852878664;6060.6969651516365;6082.878342433215;6094;6095.786647467317;5753.626014309057;5831.7667293307795;5844.181814546052;5869;5960.970195148997;5730.5129064030025;5852.736626851717;5859.853503662443;5866.882662346644;5900.468957793819;5639.2668953035845;5683.403242659461;5789.45000224978;5789.652620842763;5800.970995144998;5824.5340372770925;5851.531877449879;5927.644341339534;5930.377310382521;5982.581219314607;5709.314882214161;5847.561432892465;5876.853078673067;5881.617694849992;5884.764609415746 21:01:07 INFO - 2015-11-20 21:01:07,290 DEBUG : BROWSER_OUTPUT: |1;ext.html;597.0417479944689;602.8191542537238;607.5109536822857;612.3386742318294;649.7913880182862;39672.40491392628;40211.19577608446;40398.79800601;40470.59529404705;40629.187416251654;41272.38091428631;42336.57663423365;42420.78789606048;42439.78780106095;42530.574694253046;8693;8903.554822258893;8928.508932008737;8940.552972351388;8946.731598052069;8472.49165050099;8609.913900861005;8644.092370301121;8677.132286771335;8682.6092825823;8620.439671421338;8661.090585488528;8748.212660860521;8773.341999350043;8774.298056155525;8577.528235947051;8710.608022638997;8740.03859575443;8743.256823170039;8745.73762787111;8475.660973561051;8535.54895667738;8565.914340856574;8607.354448416394;8626.698065567674;38875;39317;39545.20909581821;39555.40666889999;39619.8019009906;3217.678232176787;3272.034749748806;3304.339132173575;3727.310447567209;3891.4941057662604;29525.557116643267;30031;30319;30576.54135187974;30610;3699.5560532735976;3833.21419109082;3906.2187562487334;3914.2171565686976;4004.959950400517;267753;270384;271470.64264678746;271711;272467;53673.731631341594;54961.450385496435;62110.37889621136;62326.68836655878;62353.37646623476;57646.54120752768;57932.71033644805;58142;58284.41715582875;58406.707966460745;14607.707845843237;14717.411303547738;14751.40994360235;14783.852161478462;14826.777598336033;10892.782144357227;10928;10948.34309941406;11052.834207486894;11061.281016733887;20709.171633134505;20781.272655456985;20991.895040524698;21167.8941605291;21172.15311387558;8129.715459958873;8348;8378.958105209435;8528.550146475114;8602.913970860336;859.9398042137116;892.7678803511004;1047.4186826311318;1056.27645063132;1065.9946700266448;28073.578896316572;28212.71787282142;28489.57265641017;28761.56857647137;29119.41761164765;1013.1287093099928;1029.6756521695643;1042.6611351310855;1056.75166335911;1057.1225882517492;14723.11661300304;14896;14938.402463901322;15041.924790375979;15097.39610415593;318840;319580;320158;320382;320769;51306.23040654393;51718.48281517137;51835.74082129641;51934.48065519372;51982.22026669603;1331.8135461035463;1334.5862782537445;1336.2984433172467;1337.0840973932886;1347.7439286535528;27367.178984630493;28059;28490.24964297644;28560.85719571389;28639.42721145607;45362;45849.31226031679;45849.77075114603;46035.30947035864;46189.30716039329;293535;293548;294058;294823;295583;32142;44965.550344496136;45708.542914570426;45970.77014614906;46868.53131468778;43249.56750432456;43645.56354436415;43654;44082.33876491791;44384.77807610941;36722.8163859179;36839.44740828943;40461.79769101136;40663.39004914988;41863.953401165214;36938.261234775695;37425;40104.79947600243;41236.79381603073;41911.58088419077;36307.27385452329;36611;36783.08042298964;40426.59573404346;41364.1727165449;31488.527672085394;32926.83536582302;33150.34797216169;33534.329313414084;33606;25206.747932521175;25287.74712252854;25411.110611128523;25570.872145639154;25604 21:01:07 INFO - 2015-11-20 21:01:07,291 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.8832185378825;360.8340163524779;360.92420591675744;361.35498135827555;365.77322060322604;16356.263968121433;17114.05872677004;17488.38790642328;17800.55498612534;18017.729734053966;10860.239783215158;11791.410429478534;16499.340026398928;16558.917205413956;16565.337386504554;4695.788689508963;5062.620303477254;5081.263216833557;5102.030614183312;5102.591792656597;5078.060558796616;5107.284980102789;5110.747866772627;5112.514311140436;5114.28400023997;5080.288759573663;5095;5236.188390799432;5274.419813820496;5439.782408703647;5202.609804264657;5203.713795741232;5208.635395522315;5212.061828870802;5237.319148510688;5007.5993920486635;5034.370703662043;5035.647504674675;5305.973470132624;5329.786808527654;12314.26114433128;12350;12406.81389779154;15178.696426071418;20782;2110.7467103947624;2122.628540005493;2133.9253126140666;2181.3783071824455;2182.90176942038;9368.812623747555;9579.042095790435;9773.12041916231;10558.313709608929;13435.26106064166;1783.554111472132;1799.1813724755204;1808.8191180881938;1838.6046999895086;1848.574827789616;55805;56598.71700641471;56937.71531142359;58444.99999999958;58667;10179.643712470028;10183.33808302458;10207.336523125972;10261.435621040766;10301.639442619473;13071.477140914258;13095.672608184872;13156.276404797827;13177.47290108404;13179.60461186166;7520.09758828944;7547.962260188774;7552.8867066994035;7644.0827100748265;7660.080790305199;7386.704531818775;7404.74083407089;7455.329020388191;7481.962590187123;7485.401167906554;4382.23310920594;4392.890177745518;4392.912141757147;4434.490033646172;4440.134173836071;1817.9545511362057;1873.456697557693;1881.1064744246646;1888.518427800902;1893.252165394689;430.56943056943055;440.29552715655336;832.7252006837729;889.8620713789373;952.3143336797494;9830.75423114428;10058;10258.692239232834;10272.613197218428;10335.37987720724;419.4945091165139;422.05670326819535;437.374554387223;439.40680081889195;449.77736020669977;5624.634398764149;5641.294838145232;5653.491185793298;5656.547476201894;9497.810043799085;488299;519267;523096;539626;543312;71927;76601.6169919158;77416.2258377409;78633.60683196662;79576;1158.9362585057734;1159.2522822779429;1204.50615247748;1225.2893321873291;1246.4702501436852;14879.628009299855;15015.924920375328;15103;15440;15542.9222853885;32255;32887.67112328846;34364.65635343615;34805.47791783176;36052.09869753277;45774;45861;46750.53249467598;47546;48589;8763.25512331459;9161.404508706913;9227.492487913229;9251;9386.296027797805;10693.57225710994;10784.89215107839;13844.377003034686;16899.577510562336;17523.21145548479;14526.782098268746;14566.41734330615;14678.339474723449;15097.169655668604;15196.544103676908;12024.879751202727;13131.474741010252;13264.336783160996;14742.336594853472;15051.623709407353;9516.666916657883;9638.566264518253;9697.175740061892;9708.805823883624;14571.34428950721;14314.928425357806;14393.496227631982;14517.709645807236;14657.120572765669;14840.18378989166;9452.291078169028;9823.705288841345;9851.655192068243;15551.455699050479;15680.843191568394 21:01:07 INFO - 2015-11-20 21:01:07,293 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1526.114853385037;1702.285040283081;1767.637634284971;1779.5195297269734;1788.4902802701233;7385.963070184648;7493.812654683636;7539;7571.621418929052;7598.278163574465;7931;7934.52392856429;7995.4403191776455;8037.075736290329;8052.194780521945;2180.68380084888;2235.0724449353497;2235.7987781099696;2239.585676649817;2241.3388050525054;2191.2659259148204;2220.3006053093304;2313.687652166953;2314.1206341590173;2314.479242170515;2216.357256395643;2216.8448208625405;2226.7773222677683;2247.0674670011927;2262.5474905019064;2215.8338124640636;2235.083615717548;2235.3740952533317;2236.7315922089374;2246.3710161154904;2219.3674802681157;2223.655333423322;2234.8323875709225;2240.764719704424;2243.887805609729;7801.336886364666;7846.8430631387055;7863.174366691473;7884.763457096296;7909.327707144842;4565.863024109282;4630.837920672794;4641.0949864776385;4645.651576131803;4672;2876.6404199475064;2927.0926012936056;2996.9700302997126;3016.457037733207;3020.6979302069617;928.7817362919776;939.4363381970832;948.7533241357228;951.46242373059;957.5164541906362;10707.839382409193;10717.410542420243;10735;10768.24622276441;10817.567297308176;3989.222101690201;4095.651869591118;4225.915481690349;4248.63886569645;4260.936085958651;8664.91335086641;8668.78328041804;8695.869561956575;8696.826063478822;8703.521306328086;4625.468071171791;4633.2818413146015;4653.23221668421;4654.650901182425;4655.2784318430695;4225.936610950838;4254.957450425456;4258.382534532476;4277.807498662568;4278.058827058042;3264.4450443424676;3309.4043072247227;3354.0608629583758;3356.5133055706788;3358.3451227010987;1045.947702614866;1071.346478648024;1074.8763892152347;1075.4622688655672;1076.6016573867562;978.1099199728213;978.848278516831;1105.4086063955745;1107.734143805497;1317.571789168505;7228.204897461275;7400.481966262418;7400.666969986363;7411.6664750086375;7413.2957369049855;1096.7916095941746;1139;1140.749035212252;1145.931244125355;1161.1233518693332;5751.1085781703905;5786.247787787561;5808.30300363959;5814.069748840166;5814.738336774771;8280.378971577156;8397.244248017707;8447.662093516314;8483.278921291636;9055.320850936207;9189.356745027784;9308.255339572817;9408.764780880532;9423.481708506099;9423.717288481357;7101.360877521048;7120.252373500812;7169.139703235541;7195.92804071963;7199.424046076301;7184.1738200105565;7222.494425390172;7236.855262894818;7276.4542659299705;7291.270872912666;7693.730719424793;8025.478343907627;8028.237317454832;8112.75661730149;8213.219744124299;8299.170082991652;8302.916970830214;8307.584620769057;8329.625166867627;8441.11368306319;6584.144061272004;6790.354916283143;6831.897521537082;6832.692528836114;6894.758683446055;7464.440166987606;7501.2123727007875;7513.474056816189;7521.135069467081;7526.887096693445;6916.515843890879;7049.519600883872;7145.7498987537265;7155.177154627285;7236.529625574321;6818.659067046528;6836.042953986346;6952.312030544378;6987.580745155307;7131.42948564124;6988.895166572607;7004.754833580801;7010.614416207158;7032.050673159058;7050.15398152225;6245.281792593728;6286.685665716787;6306.590071645328;6313.652749098844;6329.873402531832;6555.4427873629365;6581.111549940888;6607;6610.9669451652435;6625.900611490928 21:01:07 INFO - 2015-11-20 21:01:07,296 DEBUG : BROWSER_OUTPUT: |4;prototype.html;332.3469382663067;340.26672520717864;340.53176881787545;343.94752058700374;344.60026369411486;6328.7468501259955;6390.105385246064;6402.327755585667;6450.8387290317705;6466.321036291192;6212.44088032077;6262.874742505147;6284.43440090393;6287.6107079309795;6291.4652254558305;4743.644226682995;4769.18923782956;4778.665493415462;4780.30685550595;4781.880452988668;4795.736234507101;4797.0645724083815;4798.280257961299;4812.975935120319;4817.951820481803;4642.07158568286;4731.739754313511;4734.5265473452555;4740.834070807522;4757.714537127784;4717.882052948669;4735.526447355272;4745.21703918853;4752.07334569759;4762.952370476303;4144.212599606065;4146.751194928314;4150.294449943517;4159.396887451333;4160.292750232467;5944.702764861783;5947.762089516415;5951.49412299955;5952.494038006775;5961.493273071751;5412.972935135338;5555.083411237181;5573.749181286811;5574.219609254707;5578.776848926038;6633.2040155181685;6649.268580456146;6652.767153149616;6654.401103900624;6665.566738162004;4605.125026245003;4610.331501932201;4611.5619016193405;4615.930761038587;4618.145643056046;6793.728250869959;6865.382115609569;6934.930650693479;6961.895571566431;6967.407770339527;4750.216214324667;4791.161546729309;4793.592544633675;4797.832075877328;4810.254410566367;4828.927566086511;4833.975830120827;4837.467878533358;4838.346823178826;4841.05599408112;5564.27664403633;5590;5594.916076258859;5604.803831865946;5619.129034999582;6606.1172565818515;6662.233843108008;6740.191177058784;6740.29226931175;6745.932540674628;1670.3652612007359;1690.932362705478;1698.7621732957396;1706.5136436115647;1707.9914600426919;1095.1457862866976;1173.9413029348498;1174.629991552658;1180.2446434282067;1185.9940700296615;6415.26224484181;6427.742890284337;6430.839229019219;6441.806745797539;6481.09264702942;6793.320667933167;6845.383915447634;6850.9314906850295;6851.691673874688;6859.862802743917;6319.431251187415;6400.551961362753;6431.549791514549;6439.645819479973;6443.742250310029;3694.907627309285;3726.925461490809;3730.4963829883163;3739.9252014960093;3744.3821769408287;7103.751368702174;7103.969924360938;7104.609246491493;7110.680019399139;7116.146062472433;6922.307769223138;7022.894656580155;7041.507094503336;7042.6830792614455;7050;7135.678894449762;7139.071920650386;7139.214686384494;7142.678579463936;7154.678039488235;6797.28628494001;6806.55757375769;6831.931680683129;6837.760678376432;6864.6910889011115;6616.669166541557;6695.397414232742;6745.156855393076;6770.729170833111;6785.5250132490255;7070.505064645426;7080.468964827762;7116.608586527584;7124.323189297009;7125;4728.810847566059;4741.075490279362;4746.881327966828;4757.595604373529;4758;6645.006076539558;6729.528932974645;6734.292899245509;6793.932060679527;6799.456043516606;6579.934200657932;6599.637019963948;6602.0096985452565;6604.570702904296;6608.975608780646;6552.148220731275;6586.077949087227;6615.900761488485;6618.900716489353;6622.701978410887;6366.872662546631;6478.967605161944;6479.157709497924;6554.213494380705;6559.770408035696;6737.629430381376;6815.148106486689;6816.352446517573;6823.283555226828;6829.214640316229;6589.604623722592;6617.8014659560295;6627.5360724750735;6652.101966234496;6654.467642588678 21:01:07 INFO - 2015-11-20 21:01:07,298 DEBUG : BROWSER_OUTPUT: |5;yui.html;700.0269625220941;721.3255606008379;798.7923139983607;805.2913436176166;847.0005393635512;13354.065215434912;13755.931220343884;13761.862381376182;13768.655783605414;13812.102213356126;12759.744805103892;12838.422270997804;12893.355332233397;12925.74148517029;12928.09503334767;791.7783020754198;796.9840603187932;803.5660743198665;804.6057431858405;815.4617952151581;801.0187520287659;801.4790386248956;802.9277365037145;805.0862271322034;805.697863301262;853.1681610429844;863.87905693203;869.9826003479926;870.4820631724145;872.7294538692994;851.9190676885717;856.4090777363631;858.845407826591;860.1312674199041;860.6944534690158;633.885900537903;636.2174525333819;637.4326849104301;637.4454224824386;638.0939066525499;12397.504099835996;12505.312207828565;12602.621921342374;12614.180078294881;12642.304673242968;11824.645260642195;12174.269543827399;12573.182743121668;12652.873471265353;12690.492380304777;10391.79216415675;10399.636012739518;10526.684199474028;11305.378204198765;11385.14611404148;3629.1652919828325;3631.455281707739;3656.1590834108306;3672.192117734094;3772.1512659651357;45155.77422112868;45812.770936145105;45834;46077.30884036742;46367.30449043267;9905.356151850106;10048.14590759779;10092.192624590016;10145.9492702536;10164.949175254076;17102.743458848126;18139.365122220923;18327.908360458114;18336.449906502825;18398.17208225633;7646.235376462309;7798.415118866108;7812.804679883048;7829.412794040356;7887.250711182429;4359.38968544404;4414.4702635683925;4421.513633500313;4459.420275364182;4483.080968401535;2970.495015847311;3007.2331555453657;3022.002739096093;3022.788404811642;3023.9244018899262;513.6738171261202;525.9953488836304;531.8696919254808;532.8188415938599;533.2214966149465;445.49881383443625;538.4803664463811;551.9420460851633;560.9775608975677;565.1550931357565;8040.557769322743;8273.420860539705;8280.213379728915;8406.83186336282;8475.27960123384;460.7673125071817;463.7565278228889;521.1453216724575;562.7552014873543;570.1533223163599;3819.3698039823676;3826.789526576065;3884.028992751812;3889.552701439314;3899.6880249579967;58778.70610647005;59533.702331488064;59619;59682.10476842851;60064;52071.21893171605;53186;54016.45983540114;54121.45878541164;54304.185437218475;46990.765046175235;48118.5188148121;49151.508484914695;49475.752621236665;49503.25745113754;7851.921480785348;7998.640061197144;8031.518108913484;8032.196780321921;8069.556174410463;35067.47398789071;35423;35715.28569428649;36178.63821361752;36275.27449451049;42632;42783.572164279205;46000.539994600964;46750.766246168554;47785.28322075102;9313;9405.106514881076;9434.386764860263;9553.379030363005;9722.611095556098;10236;10250.948745256226;10385.584576616851;10405.739856503345;10480.423576703355;9471.857922131036;9626.855597165908;9669.661561845583;9948.054934781185;10002.949690282707;9569.978100736556;9573.377730447499;10145.03622155894;10431;10446.63436779709;9329.393589416666;9717.02829717051;9806.313558050868;9836.06557377048;10236.18110551169;8974.596143173703;9041.819163616823;9325.626974920928;9374.5781439834;9430.57562409707;8425.368097392597;8448.577571121543;8530.70142545008;8954.373193876627;9125.589348479467 21:01:07 INFO - 2015-11-20 21:01:07,298 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:01:07 INFO - 2015-11-20 21:01:07,298 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:01:07 INFO - 2015-11-20 21:01:07,298 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,303 21:01:07 INFO - 2015-11-20 21:01:07,298 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082067288__endTimestamp 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,299 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5553.49 Median:5793.54 stddev:628.91 (10.9%) stddev-sans-first:604.29 21:01:07 INFO - 2015-11-20 21:01:07,300 DEBUG : BROWSER_OUTPUT: Values: 3248.4 3291.0 3333.1 3346.8 3351.5 5344.4 5545.9 5566.5 5596.7 5608.9 5432.8 5434.8 5474.6 5502.7 5512.2 4969.6 5011.3 5034.3 5216.5 5237.9 5159.9 5177.3 5195.9 5218.0 5238.0 4856.1 4921.0 4987.6 5079.6 5091.9 5050.3 5052.3 5083.4 5092.2 5131.5 4918.5 5020.7 5079.3 5096.4 5101.9 5274.9 5313.6 5315.9 5320.8 5355.0 5961.5 5997.5 6005.8 6012.5 6017.2 6022.8 6028.3 6029.7 6035.8 6048.9 5292.2 5465.3 5481.1 5541.1 5603.1 6069.3 6074.3 6117.7 6120.6 6126.5 5793.5 5849.8 5858.6 5893.6 5914.7 5913.1 5928.1 5973.1 6008.0 6075.8 5976.2 6060.8 6083.1 6086.7 6093.0 5756.5 5908.9 6082.1 6087.7 6095.2 4487.8 4528.3 4540.5 4558.2 4597.2 4073.4 4098.2 4106.7 4115.8 4137.1 5583.0 5678.1 5748.2 5766.7 5767.0 5849.4 5944.9 5945.2 5951.2 6018.0 5741.6 5780.4 5780.5 5792.0 5793.9 5115.5 5170.4 5176.9 5233.4 5272.9 6101.8 6125.8 6128.1 6141.4 6220.9 5935.4 5936.4 5947.9 5950.1 5960.4 5971.9 6070.0 6103.4 6157.5 6300.3 5943.5 5976.7 5991.7 6009.1 6038.5 6058.8 6060.7 6082.9 6094.0 6095.8 5753.6 5831.8 5844.2 5869.0 5961.0 5730.5 5852.7 5859.9 5866.9 5900.5 5639.3 5683.4 5789.5 5789.7 5801.0 5824.5 5851.5 5927.6 5930.4 5982.6 5709.3 5847.6 5876.9 5881.6 5884.8 21:01:07 INFO - 2015-11-20 21:01:07,301 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,301 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:47107.46 Median:21615.61 stddev:77163.00 (357.0%) stddev-sans-first:77300.44 21:01:07 INFO - 2015-11-20 21:01:07,301 DEBUG : BROWSER_OUTPUT: Values: 597.0 602.8 607.5 612.3 649.8 39672.4 40211.2 40398.8 40470.6 40629.2 41272.4 42336.6 42420.8 42439.8 42530.6 8693.0 8903.6 8928.5 8940.6 8946.7 8472.5 8609.9 8644.1 8677.1 8682.6 8620.4 8661.1 8748.2 8773.3 8774.3 8577.5 8710.6 8740.0 8743.3 8745.7 8475.7 8535.5 8565.9 8607.4 8626.7 38875.0 39317.0 39545.2 39555.4 39619.8 3217.7 3272.0 3304.3 3727.3 3891.5 29525.6 30031.0 30319.0 30576.5 30610.0 3699.6 3833.2 3906.2 3914.2 4005.0 267753.0 270384.0 271470.6 271711.0 272467.0 53673.7 54961.5 62110.4 62326.7 62353.4 57646.5 57932.7 58142.0 58284.4 58406.7 14607.7 14717.4 14751.4 14783.9 14826.8 10892.8 10928.0 10948.3 11052.8 11061.3 20709.2 20781.3 20991.9 21167.9 21172.2 8129.7 8348.0 8379.0 8528.6 8602.9 859.9 892.8 1047.4 1056.3 1066.0 28073.6 28212.7 28489.6 28761.6 29119.4 1013.1 1029.7 1042.7 1056.8 1057.1 14723.1 14896.0 14938.4 15041.9 15097.4 318840.0 319580.0 320158.0 320382.0 320769.0 51306.2 51718.5 51835.7 51934.5 51982.2 1331.8 1334.6 1336.3 1337.1 1347.7 27367.2 28059.0 28490.2 28560.9 28639.4 45362.0 45849.3 45849.8 46035.3 46189.3 293535.0 293548.0 294058.0 294823.0 295583.0 32142.0 44965.6 45708.5 45970.8 46868.5 43249.6 43645.6 43654.0 44082.3 44384.8 36722.8 36839.4 40461.8 40663.4 41864.0 36938.3 37425.0 40104.8 41236.8 41911.6 36307.3 36611.0 36783.1 40426.6 41364.2 31488.5 32926.8 33150.3 33534.3 33606.0 25206.7 25287.7 25411.1 25570.9 25604.0 21:01:07 INFO - 2015-11-20 21:01:07,301 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,301 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27565.98 Median:426.31 stddev:85512.43 (20058.6%) stddev-sans-first:85727.90 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: Values: 353.9 360.8 360.9 361.4 365.8 16356.3 17114.1 17488.4 17800.6 18017.7 10860.2 11791.4 16499.3 16558.9 16565.3 4695.8 5062.6 5081.3 5102.0 5102.6 5078.1 5107.3 5110.7 5112.5 5114.3 5080.3 5095.0 5236.2 5274.4 5439.8 5202.6 5203.7 5208.6 5212.1 5237.3 5007.6 5034.4 5035.6 5306.0 5329.8 12314.3 12350.0 12406.8 15178.7 20782.0 2110.7 2122.6 2133.9 2181.4 2182.9 9368.8 9579.0 9773.1 10558.3 13435.3 1783.6 1799.2 1808.8 1838.6 1848.6 55805.0 56598.7 56937.7 58445.0 58667.0 10179.6 10183.3 10207.3 10261.4 10301.6 13071.5 13095.7 13156.3 13177.5 13179.6 7520.1 7548.0 7552.9 7644.1 7660.1 7386.7 7404.7 7455.3 7482.0 7485.4 4382.2 4392.9 4392.9 4434.5 4440.1 1818.0 1873.5 1881.1 1888.5 1893.3 430.6 440.3 832.7 889.9 952.3 9830.8 10058.0 10258.7 10272.6 10335.4 419.5 422.1 437.4 439.4 449.8 5624.6 5641.3 5653.5 5656.5 9497.8 488299.0 519267.0 523096.0 539626.0 543312.0 71927.0 76601.6 77416.2 78633.6 79576.0 1158.9 1159.3 1204.5 1225.3 1246.5 14879.6 15015.9 15103.0 15440.0 15542.9 32255.0 32887.7 34364.7 34805.5 36052.1 45774.0 45861.0 46750.5 47546.0 48589.0 8763.3 9161.4 9227.5 9251.0 9386.3 10693.6 10784.9 13844.4 16899.6 17523.2 14526.8 14566.4 14678.3 15097.2 15196.5 12024.9 13131.5 13264.3 14742.3 15051.6 9516.7 9638.6 9697.2 9708.8 14571.3 14314.9 14393.5 14517.7 14657.1 14840.2 9452.3 9823.7 9851.7 15551.5 15680.8 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5389.02 Median:6595.57 stddev:2785.61 (42.2%) stddev-sans-first:2778.30 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: Values: 1526.1 1702.3 1767.6 1779.5 1788.5 7386.0 7493.8 7539.0 7571.6 7598.3 7931.0 7934.5 7995.4 8037.1 8052.2 2180.7 2235.1 2235.8 2239.6 2241.3 2191.3 2220.3 2313.7 2314.1 2314.5 2216.4 2216.8 2226.8 2247.1 2262.5 2215.8 2235.1 2235.4 2236.7 2246.4 2219.4 2223.7 2234.8 2240.8 2243.9 7801.3 7846.8 7863.2 7884.8 7909.3 4565.9 4630.8 4641.1 4645.7 4672.0 2876.6 2927.1 2997.0 3016.5 3020.7 928.8 939.4 948.8 951.5 957.5 10707.8 10717.4 10735.0 10768.2 10817.6 3989.2 4095.7 4225.9 4248.6 4260.9 8664.9 8668.8 8695.9 8696.8 8703.5 4625.5 4633.3 4653.2 4654.7 4655.3 4225.9 4255.0 4258.4 4277.8 4278.1 3264.4 3309.4 3354.1 3356.5 3358.3 1045.9 1071.3 1074.9 1075.5 1076.6 978.1 978.8 1105.4 1107.7 1317.6 7228.2 7400.5 7400.7 7411.7 7413.3 1096.8 1139.0 1140.7 1145.9 1161.1 5751.1 5786.2 5808.3 5814.1 5814.7 8280.4 8397.2 8447.7 8483.3 9055.3 9189.4 9308.3 9408.8 9423.5 9423.7 7101.4 7120.3 7169.1 7195.9 7199.4 7184.2 7222.5 7236.9 7276.5 7291.3 7693.7 8025.5 8028.2 8112.8 8213.2 8299.2 8302.9 8307.6 8329.6 8441.1 6584.1 6790.4 6831.9 6832.7 6894.8 7464.4 7501.2 7513.5 7521.1 7526.9 6916.5 7049.5 7145.7 7155.2 7236.5 6818.7 6836.0 6952.3 6987.6 7131.4 6988.9 7004.8 7010.6 7032.1 7050.2 6245.3 6286.7 6306.6 6313.7 6329.9 6555.4 6581.1 6607.0 6611.0 6625.9 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,303 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5571.66 Median:6408.80 stddev:1674.74 (26.1%) stddev-sans-first:1632.61 21:01:07 INFO - 2015-11-20 21:01:07,304 DEBUG : BROWSER_OUTPUT: Values: 332.3 340.3 340.5 343.9 344.6 6328.7 6390.1 6402.3 6450.8 6466.3 6212.4 6262.9 6284.4 6287.6 6291.5 4743.6 4769.2 4778.7 4780.3 4781.9 4795.7 4797.1 4798.3 4813.0 4818.0 4642.1 4731.7 4734.5 4740.8 4757.7 4717.9 4735.5 4745.2 4752.1 4763.0 4144.2 4146.8 4150.3 4159.4 4160.3 5944.7 5947.8 5951.5 5952.5 5961.5 5413.0 5555.1 5573.7 5574.2 5578.8 6633.2 6649.3 6652.8 6654.4 6665.6 4605.1 4610.3 4611.6 4615.9 4618.1 6793.7 6865.4 6934.9 6961.9 6967.4 4750.2 4791.2 4793.6 4797.8 4810.3 4828.9 4834.0 4837.5 4838.3 4841.1 5564.3 5590.0 5594.9 5604.8 5619.1 6606.1 6662.2 6740.2 6740.3 6745.9 1670.4 1690.9 1698.8 1706.5 1708.0 1095.1 1173.9 1174.6 1180.2 1186.0 6415.3 6427.7 6430.8 6441.8 6481.1 6793.3 6845.4 6850.9 6851.7 6859.9 6319.4 6400.6 6431.5 6439.6 6443.7 3694.9 3726.9 3730.5 3739.9 3744.4 7103.8 7104.0 7104.6 7110.7 7116.1 6922.3 7022.9 7041.5 7042.7 7050.0 7135.7 7139.1 7139.2 7142.7 7154.7 6797.3 6806.6 6831.9 6837.8 6864.7 6616.7 6695.4 6745.2 6770.7 6785.5 7070.5 7080.5 7116.6 7124.3 7125.0 4728.8 4741.1 4746.9 4757.6 4758.0 6645.0 6729.5 6734.3 6793.9 6799.5 6579.9 6599.6 6602.0 6604.6 6609.0 6552.1 6586.1 6615.9 6618.9 6622.7 6366.9 6479.0 6479.2 6554.2 6559.8 6737.6 6815.1 6816.4 6823.3 6829.2 6589.6 6617.8 6627.5 6652.1 6654.5 21:01:07 INFO - 2015-11-20 21:01:07,304 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,304 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13656.28 Median:528.93 stddev:16380.08 (3096.8%) stddev-sans-first:16397.13 21:01:07 INFO - 2015-11-20 21:01:07,305 DEBUG : BROWSER_OUTPUT: Values: 700.0 721.3 798.8 805.3 847.0 13354.1 13755.9 13761.9 13768.7 13812.1 12759.7 12838.4 12893.4 12925.7 12928.1 791.8 797.0 803.6 804.6 815.5 801.0 801.5 802.9 805.1 805.7 853.2 863.9 870.0 870.5 872.7 851.9 856.4 858.8 860.1 860.7 633.9 636.2 637.4 637.4 638.1 12397.5 12505.3 12602.6 12614.2 12642.3 11824.6 12174.3 12573.2 12652.9 12690.5 10391.8 10399.6 10526.7 11305.4 11385.1 3629.2 3631.5 3656.2 3672.2 3772.2 45155.8 45812.8 45834.0 46077.3 46367.3 9905.4 10048.1 10092.2 10145.9 10164.9 17102.7 18139.4 18327.9 18336.4 18398.2 7646.2 7798.4 7812.8 7829.4 7887.3 4359.4 4414.5 4421.5 4459.4 4483.1 2970.5 3007.2 3022.0 3022.8 3023.9 513.7 526.0 531.9 532.8 533.2 445.5 538.5 551.9 561.0 565.2 8040.6 8273.4 8280.2 8406.8 8475.3 460.8 463.8 521.1 562.8 570.2 3819.4 3826.8 3884.0 3889.6 3899.7 58778.7 59533.7 59619.0 59682.1 60064.0 52071.2 53186.0 54016.5 54121.5 54304.2 46990.8 48118.5 49151.5 49475.8 49503.3 7851.9 7998.6 8031.5 8032.2 8069.6 35067.5 35423.0 35715.3 36178.6 36275.3 42632.0 42783.6 46000.5 46750.8 47785.3 9313.0 9405.1 9434.4 9553.4 9722.6 10236.0 10250.9 10385.6 10405.7 10480.4 9471.9 9626.9 9669.7 9948.1 10002.9 9570.0 9573.4 10145.0 10431.0 10446.6 9329.4 9717.0 9806.3 9836.1 10236.2 8974.6 9041.8 9325.6 9374.6 9430.6 8425.4 8448.6 8530.7 8954.4 9125.6 21:01:07 INFO - 2015-11-20 21:01:07,305 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:01:07 INFO - 2015-11-20 21:01:07,305 DEBUG : BROWSER_OUTPUT: 21:01:07 INFO - 2015-11-20 21:01:07,943 INFO : Browser exited with error code: 0 21:01:07 INFO - 2015-11-20 21:01:07,964 INFO : Completed test dromaeo_css (00:18:31) 21:01:07 INFO - 2015-11-20 21:01:07,964 INFO : Starting test kraken 21:01:07 INFO - 2015-11-20 21:01:07,964 DEBUG : operating with platform_type : linux_ 21:01:07 INFO - 2015-11-20 21:01:07,965 INFO : Initialising browser for kraken test... 21:01:07 INFO - 2015-11-20 21:01:07,971 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqK2meN/profile http://localhost:34910/getInfo.html 21:01:12 INFO - 2015-11-20 21:01:12,393 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:01:12 INFO - 2015-11-20 21:01:12,393 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:01:12 INFO - 2015-11-20 21:01:12,393 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:01:12 INFO - 2015-11-20 21:01:12,393 DEBUG : BROWSER_OUTPUT: __metrics 21:01:13 INFO - 2015-11-20 21:01:13,295 INFO : Browser initialized. 21:01:13 INFO - 2015-11-20 21:01:13,295 INFO : Running cycle 1/1 for kraken test... 21:01:13 INFO - 2015-11-20 21:01:13,296 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqK2meN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:01:25 INFO - 2015-11-20 21:01:25,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 142045184 21:01:25 INFO - 2015-11-20 21:01:25,112 DEBUG : BROWSER_OUTPUT: 21:01:27 INFO - 2015-11-20 21:01:27,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34910/tests/kraken/driver.html?testName=audio-beat-detection) 21:01:28 INFO - 2015-11-20 21:01:28,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 21:01:28 INFO - 2015-11-20 21:01:28,201 DEBUG : BROWSER_OUTPUT: 21:01:30 INFO - 2015-11-20 21:01:30,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34910/tests/kraken/driver.html?testName=audio-dft) 21:01:31 INFO - 2015-11-20 21:01:31,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 142442496 21:01:31 INFO - 2015-11-20 21:01:31,453 DEBUG : BROWSER_OUTPUT: 21:01:34 INFO - 2015-11-20 21:01:34,311 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34910/tests/kraken/driver.html?testName=audio-fft) 21:01:34 INFO - 2015-11-20 21:01:34,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 136433664 21:01:34 INFO - 2015-11-20 21:01:34,893 DEBUG : BROWSER_OUTPUT: 21:01:36 INFO - 2015-11-20 21:01:36,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34910/tests/kraken/driver.html?testName=audio-oscillator) 21:01:37 INFO - 2015-11-20 21:01:37,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 137965568 21:01:37 INFO - 2015-11-20 21:01:37,480 DEBUG : BROWSER_OUTPUT: 21:01:39 INFO - 2015-11-20 21:01:39,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34910/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:01:40 INFO - 2015-11-20 21:01:40,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 137420800 21:01:40 INFO - 2015-11-20 21:01:40,264 DEBUG : BROWSER_OUTPUT: 21:01:43 INFO - 2015-11-20 21:01:43,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34910/tests/kraken/driver.html?testName=imaging-darkroom) 21:01:43 INFO - 2015-11-20 21:01:43,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 137949184 21:01:43 INFO - 2015-11-20 21:01:43,825 DEBUG : BROWSER_OUTPUT: 21:01:47 INFO - 2015-11-20 21:01:47,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34910/tests/kraken/driver.html?testName=imaging-desaturate) 21:01:47 INFO - 2015-11-20 21:01:47,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 139268096 21:01:47 INFO - 2015-11-20 21:01:47,819 DEBUG : BROWSER_OUTPUT: 21:01:50 INFO - 2015-11-20 21:01:50,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34910/tests/kraken/driver.html?testName=json-parse-financial) 21:01:51 INFO - 2015-11-20 21:01:51,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 139698176 21:01:51 INFO - 2015-11-20 21:01:51,228 DEBUG : BROWSER_OUTPUT: 21:01:52 INFO - 2015-11-20 21:01:52,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34910/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:01:53 INFO - 2015-11-20 21:01:53,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 140206080 21:01:53 INFO - 2015-11-20 21:01:53,392 DEBUG : BROWSER_OUTPUT: 21:01:55 INFO - 2015-11-20 21:01:55,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:01:55 INFO - 2015-11-20 21:01:55,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 140185600 21:01:55 INFO - 2015-11-20 21:01:55,829 DEBUG : BROWSER_OUTPUT: 21:01:57 INFO - 2015-11-20 21:01:57,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:01:58 INFO - 2015-11-20 21:01:58,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 140656640 21:01:58 INFO - 2015-11-20 21:01:58,567 DEBUG : BROWSER_OUTPUT: 21:02:01 INFO - 2015-11-20 21:02:01,002 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:02:01 INFO - 2015-11-20 21:02:01,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 140054528 21:02:01 INFO - 2015-11-20 21:02:01,589 DEBUG : BROWSER_OUTPUT: 21:02:04 INFO - 2015-11-20 21:02:04,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:02:04 INFO - 2015-11-20 21:02:04,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 139403264 21:02:04 INFO - 2015-11-20 21:02:04,732 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34910/tests/kraken/driver.html?testName=ai-astar) 21:02:06 INFO - 2015-11-20 21:02:06,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 139747328 21:02:06 INFO - 2015-11-20 21:02:06,639 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,640 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:02:06 INFO - 2015-11-20 21:02:06,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:02:06 INFO - 2015-11-20 21:02:06,641 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:02:06 INFO - 2015-11-20 21:02:06,641 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:02:06 INFO - 2015-11-20 21:02:06,641 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;105;111;110;112;123;111;111;110;111 21:02:06 INFO - 2015-11-20 21:02:06,641 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;132;164;170;127;158;151;129;174;126 21:02:06 INFO - 2015-11-20 21:02:06,642 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;161;161;162;159;162;168;170;166 21:02:06 INFO - 2015-11-20 21:02:06,642 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;73;72;72;145;72;71;72;81 21:02:06 INFO - 2015-11-20 21:02:06,642 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;90;136;90;89;90;143;90;90;137 21:02:06 INFO - 2015-11-20 21:02:06,642 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;110;110;109;111 21:02:06 INFO - 2015-11-20 21:02:06,643 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;148;148;148;147;146 21:02:06 INFO - 2015-11-20 21:02:06,643 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;96;96;96;97;96;96;96;95 21:02:06 INFO - 2015-11-20 21:02:06,643 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;61;60;60;61;60;60;64;58 21:02:06 INFO - 2015-11-20 21:02:06,643 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;70;68;70;69;69;69 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;93;91;95;86;86;94;91;85;85 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;126;123;122;117;123;117;117;125;117 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;146;149;141;141;148;147;148;152 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;65;68;69;68;68;69;66;66;65 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:02:06 INFO - 2015-11-20 21:02:06,645 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,712 21:02:06 INFO - 2015-11-20 21:02:06,646 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:02:06 INFO - 2015-11-20 21:02:06,646 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082126640__endTimestamp 21:02:06 INFO - 2015-11-20 21:02:06,646 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,649 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:4.48 (4.0%) stddev-sans-first:4.75 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: Values: 112.0 105.0 111.0 110.0 112.0 123.0 111.0 111.0 110.0 111.0 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,650 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:156.50 stddev:18.60 (11.9%) stddev-sans-first:19.58 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: Values: 155.0 132.0 164.0 170.0 127.0 158.0 151.0 129.0 174.0 126.0 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.47 (2.1%) stddev-sans-first:3.64 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 161.0 161.0 162.0 159.0 162.0 168.0 170.0 166.0 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:72.50 stddev:22.87 (31.5%) stddev-sans-first:24.10 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 72.0 72.0 145.0 72.0 71.0 72.0 81.0 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.60 Median:90.00 stddev:23.58 (26.2%) stddev-sans-first:24.49 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: Values: 91.0 90.0 136.0 90.0 89.0 90.0 143.0 90.0 90.0 137.0 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 111.0 21:02:06 INFO - 2015-11-20 21:02:06,651 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 148.0 148.0 148.0 147.0 146.0 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.50 Median:60.50 stddev:1.51 (2.5%) stddev-sans-first:1.59 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 61.0 60.0 60.0 61.0 60.0 60.0 64.0 58.0 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 70.0 68.0 70.0 69.0 69.0 69.0 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:91.00 stddev:4.09 (4.5%) stddev-sans-first:4.07 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: Values: 85.0 93.0 91.0 95.0 86.0 86.0 94.0 91.0 85.0 85.0 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,652 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:123.00 stddev:3.62 (2.9%) stddev-sans-first:3.77 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: Values: 123.0 126.0 123.0 122.0 117.0 123.0 117.0 117.0 125.0 117.0 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:148.00 stddev:4.57 (3.1%) stddev-sans-first:4.01 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 146.0 149.0 141.0 141.0 148.0 147.0 148.0 152.0 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.64 (2.4%) stddev-sans-first:1.62 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: Values: 69.0 65.0 68.0 69.0 68.0 68.0 69.0 66.0 66.0 65.0 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:02:06 INFO - 2015-11-20 21:02:06,653 DEBUG : BROWSER_OUTPUT: 21:02:07 INFO - 2015-11-20 21:02:07,519 INFO : Browser exited with error code: 0 21:02:07 INFO - 2015-11-20 21:02:07,567 INFO : Completed test kraken (00:00:59) 21:02:07 INFO - 2015-11-20 21:02:07,567 INFO : Starting test v8_7 21:02:07 INFO - 2015-11-20 21:02:07,567 DEBUG : operating with platform_type : linux_ 21:02:07 INFO - 2015-11-20 21:02:07,567 INFO : Initialising browser for v8_7 test... 21:02:07 INFO - 2015-11-20 21:02:07,573 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkXNNkf/profile http://localhost:34910/getInfo.html 21:02:12 INFO - 2015-11-20 21:02:12,170 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:02:12 INFO - 2015-11-20 21:02:12,171 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:02:12 INFO - 2015-11-20 21:02:12,171 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 21:02:12 INFO - 2015-11-20 21:02:12,171 DEBUG : BROWSER_OUTPUT: __metrics 21:02:13 INFO - 2015-11-20 21:02:13,243 INFO : Browser initialized. 21:02:13 INFO - 2015-11-20 21:02:13,243 INFO : Running cycle 1/1 for v8_7 test... 21:02:13 INFO - 2015-11-20 21:02:13,243 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkXNNkf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:02:25 INFO - 2015-11-20 21:02:25,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 21:02:25 INFO - 2015-11-20 21:02:25,081 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34910/tests/v8_7/run.html (next: http://localhost:34910/tests/v8_7/run.html) 21:02:46 INFO - 2015-11-20 21:02:46,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 21:02:46 INFO - 2015-11-20 21:02:46,775 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,776 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:02:46 INFO - 2015-11-20 21:02:46,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:02:46 INFO - 2015-11-20 21:02:46,776 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:02:46 INFO - 2015-11-20 21:02:46,776 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:02:46 INFO - 2015-11-20 21:02:46,776 DEBUG : BROWSER_OUTPUT: |0;Richards;166.44474034620507 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.28793471925394 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |2;Encrypt;286.5329512893983 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5050.50505050505 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1060.4453870625662 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |5;Earley;713.2667617689016 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |6;Boyer;12216.867469879518 21:02:46 INFO - 2015-11-20 21:02:46,777 DEBUG : BROWSER_OUTPUT: |7;RegExp;25550 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: |8;Splay;582.4111822947001 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: __startTimestamp1448082166775__endTimestamp 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: Values: 166.4 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.29 Median:194.29 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: Values: 194.3 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:286.53 Median:286.53 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: Values: 286.5 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,779 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5050.51 Median:5050.51 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,780 DEBUG : BROWSER_OUTPUT: Values: 5050.5 21:02:46 INFO - 2015-11-20 21:02:46,780 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,780 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1060.45 Median:1060.45 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,780 DEBUG : BROWSER_OUTPUT: Values: 1060.4 21:02:46 INFO - 2015-11-20 21:02:46,780 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,781 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.27 Median:713.27 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,781 DEBUG : BROWSER_OUTPUT: Values: 713.3 21:02:46 INFO - 2015-11-20 21:02:46,781 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,781 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12216.87 Median:12216.87 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,781 DEBUG : BROWSER_OUTPUT: Values: 12216.9 21:02:46 INFO - 2015-11-20 21:02:46,782 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,783 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,783 DEBUG : BROWSER_OUTPUT: Values: 25550.0 21:02:46 INFO - 2015-11-20 21:02:46,783 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,783 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:582.41 Median:582.41 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,783 DEBUG : BROWSER_OUTPUT: Values: 582.4 21:02:46 INFO - 2015-11-20 21:02:46,784 DEBUG : BROWSER_OUTPUT: 21:02:46 INFO - 2015-11-20 21:02:46,784 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 21:02:46 INFO - 2015-11-20 21:02:46,784 DEBUG : BROWSER_OUTPUT: Values: 4830.9 21:02:46 INFO - 2015-11-20 21:02:46,784 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:02:46 INFO - 2015-11-20 21:02:46,784 DEBUG : BROWSER_OUTPUT: 21:02:47 INFO - 2015-11-20 21:02:47,707 INFO : Browser exited with error code: 0 21:02:47 INFO - 2015-11-20 21:02:47,726 INFO : Completed test v8_7 (00:00:40) 21:02:47 INFO - 2015-11-20 21:02:47,806 INFO : Completed test suite (00:20:11) 21:02:47 INFO - 2015-11-20 21:02:47,807 DEBUG : Working with test: dromaeo_css 21:02:47 INFO - 2015-11-20 21:02:47,807 DEBUG : Generating results file: dromaeo_css 21:02:47 INFO - 2015-11-20 21:02:47,808 DEBUG : Working with test: kraken 21:02:47 INFO - 2015-11-20 21:02:47,808 DEBUG : Generating results file: kraken 21:02:47 INFO - 2015-11-20 21:02:47,808 INFO : javascript benchmark 21:02:47 INFO - 2015-11-20 21:02:47,808 DEBUG : Working with test: v8_7 21:02:47 INFO - 2015-11-20 21:02:47,808 DEBUG : Generating results file: v8_7 21:02:47 INFO - 2015-11-20 21:02:47,809 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:47 INFO - 2015-11-20 21:02:47,948 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 21:02:47 INFO - 2015-11-20 21:02:47,948 DEBUG : process_Request line: dromaeo_css 6970.91 graph.html#tests=[[72,63,43]] 21:02:47 INFO - 2015-11-20 21:02:47,948 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:48 INFO - 2015-11-20 21:02:48,051 DEBUG : process_Request line: kraken 1514.80 graph.html#tests=[[232,63,43]] 21:02:48 INFO - 2015-11-20 21:02:48,052 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:02:48 INFO - 2015-11-20 21:02:48,088 DEBUG : process_Request line: v8_7 21389.04 graph.html#tests=[[230,63,43]] 21:02:48 INFO - 2015-11-20 21:02:48,089 INFO : javascript benchmark 21:02:48 INFO - 2015-11-20 21:02:48,093 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3248.366568519139, 3290.9999999999986, 3333.083402064432, 3346.84939177737, 3351.463765797472, 5344.412114667383, 5545.916811247829, 5566.471185237401, 5596.748146333414, 5608.9439105608935, 5432.782688692448, 5434.755436005379, 5474.562035037197, 5502.724863756816, 5512.200730894018, 4969.602431805447, 5011.27336536203, 5034.345535080434, 5216.530512253897, 5237.8952420951555, 5159.916417552318, 5177.275181474596, 5195.922061169085, 5217.973910130444, 5237.973810130963, 4856.077345304381, 4921.0, 4987.576056035241, 5079.593632509391, 5091.8981620367385, 5050.267711181895, 5052.292679024939, 5083.364579427572, 5092.185250359925, 5131.4868513148385, 4918.508149185089, 5020.748962551895, 5079.263506791532, 5096.3884333879805, 5101.948980510185, 5274.947250527484, 5313.628046036741, 5315.946840531584, 5320.813771517978, 5355.036093503168, 5961.463468287831, 5997.490213331828, 6005.789797357115, 6012.518998480155, 6017.247844019497, 6022.8494287642725, 6028.276606807167, 6029.668368239745, 6035.849103772397, 6048.939510604881, 5292.153255479105, 5465.316835395575, 5481.068218402881, 5541.0580201365865, 5603.075492543766, 6069.271687397452, 6074.301455332693, 6117.694115294306, 6120.60216085953, 6126.479249263773, 5793.536517078624, 5849.824505264849, 5858.56060795442, 5893.587448878623, 5914.6746928918465, 5913.142594323799, 5928.051511758098, 5973.104034394789, 6008.0, 6075.787347442818, 5976.163337132805, 6060.757569697163, 6083.087536869505, 6086.695665216722, 6093.025115981422, 5756.510696590837, 5908.881822363529, 6082.148499210114, 6087.726052327655, 6095.207623008981, 4487.753173575485, 4528.252838281713, 4540.500544940054, 4558.156741002925, 4597.172508948354, 4073.368627862686, 4098.221337945781, 4106.691998100095, 4115.835366585363, 4137.110521237948, 5582.972085139549, 5678.119891416837, 5748.19525266463, 5766.654000759884, 5766.971165144148, 5849.415058494116, 5944.85137871548, 5945.227120474311, 5951.196588460502, 6018.037114061729, 5741.598088133791, 5780.364159942403, 5780.508656764222, 5792.0, 5793.8841223175305, 5115.488451154854, 5170.431252562215, 5176.948230517722, 5233.371995360581, 5272.868178295574, 6101.755929762849, 6125.816225513242, 6128.111423843607, 6141.385861413913, 6220.875582488416, 5935.436133567304, 5936.436038576328, 5947.9405205949115, 5950.077737950624, 5960.433758792908, 5971.91042134377, 6070.0, 6103.389661033861, 6157.507399407947, 6300.306966233619, 5943.465088142088, 5976.656025538568, 5991.730372133177, 6009.128676341993, 6038.456538911519, 6058.84852878664, 6060.6969651516365, 6082.878342433215, 6094.0, 6095.786647467317, 5753.626014309057, 5831.7667293307795, 5844.181814546052, 5869.0, 5960.970195148997, 5730.5129064030025, 5852.736626851717, 5859.853503662443, 5866.882662346644, 5900.468957793819, 5639.2668953035845, 5683.403242659461, 5789.45000224978, 5789.652620842763, 5800.970995144998, 5824.5340372770925, 5851.531877449879, 5927.644341339534, 5930.377310382521, 5982.581219314607, 5709.314882214161, 5847.561432892465, 5876.853078673067, 5881.617694849992, 5884.764609415746], "unit": "ms", "name": "dojo.html", "value": 5511.896637384678}, {"lowerIsBetter": false, "replicates": [597.0417479944689, 602.8191542537238, 607.5109536822857, 612.3386742318294, 649.7913880182862, 39672.40491392628, 40211.19577608446, 40398.79800601, 40470.59529404705, 40629.187416251654, 41272.38091428631, 42336.57663423365, 42420.78789606048, 42439.78780106095, 42530.574694253046, 8693.0, 8903.554822258893, 8928.508932008737, 8940.552972351388, 8946.731598052069, 8472.49165050099, 8609.913900861005, 8644.092370301121, 8677.132286771335, 8682.6092825823, 8620.439671421338, 8661.090585488528, 8748.212660860521, 8773.341999350043, 8774.298056155525, 8577.528235947051, 8710.608022638997, 8740.03859575443, 8743.256823170039, 8745.73762787111, 8475.660973561051, 8535.54895667738, 8565.914340856574, 8607.354448416394, 8626.698065567674, 38875.0, 39317.0, 39545.20909581821, 39555.40666889999, 39619.8019009906, 3217.678232176787, 3272.034749748806, 3304.339132173575, 3727.310447567209, 3891.4941057662604, 29525.557116643267, 30031.0, 30319.0, 30576.54135187974, 30610.0, 3699.5560532735976, 3833.21419109082, 3906.2187562487334, 3914.2171565686976, 4004.959950400517, 267753.0, 270384.0, 271470.64264678746, 271711.0, 272467.0, 53673.731631341594, 54961.450385496435, 62110.37889621136, 62326.68836655878, 62353.37646623476, 57646.54120752768, 57932.71033644805, 58142.0, 58284.41715582875, 58406.707966460745, 14607.707845843237, 14717.411303547738, 14751.40994360235, 14783.852161478462, 14826.777598336033, 10892.782144357227, 10928.0, 10948.34309941406, 11052.834207486894, 11061.281016733887, 20709.171633134505, 20781.272655456985, 20991.895040524698, 21167.8941605291, 21172.15311387558, 8129.715459958873, 8348.0, 8378.958105209435, 8528.550146475114, 8602.913970860336, 859.9398042137116, 892.7678803511004, 1047.4186826311318, 1056.27645063132, 1065.9946700266448, 28073.578896316572, 28212.71787282142, 28489.57265641017, 28761.56857647137, 29119.41761164765, 1013.1287093099928, 1029.6756521695643, 1042.6611351310855, 1056.75166335911, 1057.1225882517492, 14723.11661300304, 14896.0, 14938.402463901322, 15041.924790375979, 15097.39610415593, 318840.0, 319580.0, 320158.0, 320382.0, 320769.0, 51306.23040654393, 51718.48281517137, 51835.74082129641, 51934.48065519372, 51982.22026669603, 1331.8135461035463, 1334.5862782537445, 1336.2984433172467, 1337.0840973932886, 1347.7439286535528, 27367.178984630493, 28059.0, 28490.24964297644, 28560.85719571389, 28639.42721145607, 45362.0, 45849.31226031679, 45849.77075114603, 46035.30947035864, 46189.30716039329, 293535.0, 293548.0, 294058.0, 294823.0, 295583.0, 32142.0, 44965.550344496136, 45708.542914570426, 45970.77014614906, 46868.53131468778, 43249.56750432456, 43645.56354436415, 43654.0, 44082.33876491791, 44384.77807610941, 36722.8163859179, 36839.44740828943, 40461.79769101136, 40663.39004914988, 41863.953401165214, 36938.261234775695, 37425.0, 40104.79947600243, 41236.79381603073, 41911.58088419077, 36307.27385452329, 36611.0, 36783.08042298964, 40426.59573404346, 41364.1727165449, 31488.527672085394, 32926.83536582302, 33150.34797216169, 33534.329313414084, 33606.0, 25206.747932521175, 25287.74712252854, 25411.110611128523, 25570.872145639154, 25604.0], "unit": "ms", "name": "ext.html", "value": 18817.750304414898}, {"lowerIsBetter": false, "replicates": [353.8832185378825, 360.8340163524779, 360.92420591675744, 361.35498135827555, 365.77322060322604, 16356.263968121433, 17114.05872677004, 17488.38790642328, 17800.55498612534, 18017.729734053966, 10860.239783215158, 11791.410429478534, 16499.340026398928, 16558.917205413956, 16565.337386504554, 4695.788689508963, 5062.620303477254, 5081.263216833557, 5102.030614183312, 5102.591792656597, 5078.060558796616, 5107.284980102789, 5110.747866772627, 5112.514311140436, 5114.28400023997, 5080.288759573663, 5095.0, 5236.188390799432, 5274.419813820496, 5439.782408703647, 5202.609804264657, 5203.713795741232, 5208.635395522315, 5212.061828870802, 5237.319148510688, 5007.5993920486635, 5034.370703662043, 5035.647504674675, 5305.973470132624, 5329.786808527654, 12314.26114433128, 12350.0, 12406.81389779154, 15178.696426071418, 20782.0, 2110.7467103947624, 2122.628540005493, 2133.9253126140666, 2181.3783071824455, 2182.90176942038, 9368.812623747555, 9579.042095790435, 9773.12041916231, 10558.313709608929, 13435.26106064166, 1783.554111472132, 1799.1813724755204, 1808.8191180881938, 1838.6046999895086, 1848.574827789616, 55805.0, 56598.71700641471, 56937.71531142359, 58444.99999999958, 58667.0, 10179.643712470028, 10183.33808302458, 10207.336523125972, 10261.435621040766, 10301.639442619473, 13071.477140914258, 13095.672608184872, 13156.276404797827, 13177.47290108404, 13179.60461186166, 7520.09758828944, 7547.962260188774, 7552.8867066994035, 7644.0827100748265, 7660.080790305199, 7386.704531818775, 7404.74083407089, 7455.329020388191, 7481.962590187123, 7485.401167906554, 4382.23310920594, 4392.890177745518, 4392.912141757147, 4434.490033646172, 4440.134173836071, 1817.9545511362057, 1873.456697557693, 1881.1064744246646, 1888.518427800902, 1893.252165394689, 430.56943056943055, 440.29552715655336, 832.7252006837729, 889.8620713789373, 952.3143336797494, 9830.75423114428, 10058.0, 10258.692239232834, 10272.613197218428, 10335.37987720724, 419.4945091165139, 422.05670326819535, 437.374554387223, 439.40680081889195, 449.77736020669977, 5624.634398764149, 5641.294838145232, 5653.491185793298, 5656.547476201894, 9497.810043799085, 488299.0, 519267.0, 523096.0, 539626.0, 543312.0, 71927.0, 76601.6169919158, 77416.2258377409, 78633.60683196662, 79576.0, 1158.9362585057734, 1159.2522822779429, 1204.50615247748, 1225.2893321873291, 1246.4702501436852, 14879.628009299855, 15015.924920375328, 15103.0, 15440.0, 15542.9222853885, 32255.0, 32887.67112328846, 34364.65635343615, 34805.47791783176, 36052.09869753277, 45774.0, 45861.0, 46750.53249467598, 47546.0, 48589.0, 8763.25512331459, 9161.404508706913, 9227.492487913229, 9251.0, 9386.296027797805, 10693.57225710994, 10784.89215107839, 13844.377003034686, 16899.577510562336, 17523.21145548479, 14526.782098268746, 14566.41734330615, 14678.339474723449, 15097.169655668604, 15196.544103676908, 12024.879751202727, 13131.474741010252, 13264.336783160996, 14742.336594853472, 15051.623709407353, 9516.666916657883, 9638.566264518253, 9697.175740061892, 9708.805823883624, 14571.34428950721, 14314.928425357806, 14393.496227631982, 14517.709645807236, 14657.120572765669, 14840.18378989166, 9452.291078169028, 9823.705288841345, 9851.655192068243, 15551.455699050479, 15680.843191568394], "unit": "ms", "name": "jquery.html", "value": 8200.636754392288}, {"lowerIsBetter": false, "replicates": [1526.114853385037, 1702.285040283081, 1767.637634284971, 1779.5195297269734, 1788.4902802701233, 7385.963070184648, 7493.812654683636, 7539.0, 7571.621418929052, 7598.278163574465, 7931.0, 7934.52392856429, 7995.4403191776455, 8037.075736290329, 8052.194780521945, 2180.68380084888, 2235.0724449353497, 2235.7987781099696, 2239.585676649817, 2241.3388050525054, 2191.2659259148204, 2220.3006053093304, 2313.687652166953, 2314.1206341590173, 2314.479242170515, 2216.357256395643, 2216.8448208625405, 2226.7773222677683, 2247.0674670011927, 2262.5474905019064, 2215.8338124640636, 2235.083615717548, 2235.3740952533317, 2236.7315922089374, 2246.3710161154904, 2219.3674802681157, 2223.655333423322, 2234.8323875709225, 2240.764719704424, 2243.887805609729, 7801.336886364666, 7846.8430631387055, 7863.174366691473, 7884.763457096296, 7909.327707144842, 4565.863024109282, 4630.837920672794, 4641.0949864776385, 4645.651576131803, 4672.0, 2876.6404199475064, 2927.0926012936056, 2996.9700302997126, 3016.457037733207, 3020.6979302069617, 928.7817362919776, 939.4363381970832, 948.7533241357228, 951.46242373059, 957.5164541906362, 10707.839382409193, 10717.410542420243, 10735.0, 10768.24622276441, 10817.567297308176, 3989.222101690201, 4095.651869591118, 4225.915481690349, 4248.63886569645, 4260.936085958651, 8664.91335086641, 8668.78328041804, 8695.869561956575, 8696.826063478822, 8703.521306328086, 4625.468071171791, 4633.2818413146015, 4653.23221668421, 4654.650901182425, 4655.2784318430695, 4225.936610950838, 4254.957450425456, 4258.382534532476, 4277.807498662568, 4278.058827058042, 3264.4450443424676, 3309.4043072247227, 3354.0608629583758, 3356.5133055706788, 3358.3451227010987, 1045.947702614866, 1071.346478648024, 1074.8763892152347, 1075.4622688655672, 1076.6016573867562, 978.1099199728213, 978.848278516831, 1105.4086063955745, 1107.734143805497, 1317.571789168505, 7228.204897461275, 7400.481966262418, 7400.666969986363, 7411.6664750086375, 7413.2957369049855, 1096.7916095941746, 1139.0, 1140.749035212252, 1145.931244125355, 1161.1233518693332, 5751.1085781703905, 5786.247787787561, 5808.30300363959, 5814.069748840166, 5814.738336774771, 8280.378971577156, 8397.244248017707, 8447.662093516314, 8483.278921291636, 9055.320850936207, 9189.356745027784, 9308.255339572817, 9408.764780880532, 9423.481708506099, 9423.717288481357, 7101.360877521048, 7120.252373500812, 7169.139703235541, 7195.92804071963, 7199.424046076301, 7184.1738200105565, 7222.494425390172, 7236.855262894818, 7276.4542659299705, 7291.270872912666, 7693.730719424793, 8025.478343907627, 8028.237317454832, 8112.75661730149, 8213.219744124299, 8299.170082991652, 8302.916970830214, 8307.584620769057, 8329.625166867627, 8441.11368306319, 6584.144061272004, 6790.354916283143, 6831.897521537082, 6832.692528836114, 6894.758683446055, 7464.440166987606, 7501.2123727007875, 7513.474056816189, 7521.135069467081, 7526.887096693445, 6916.515843890879, 7049.519600883872, 7145.7498987537265, 7155.177154627285, 7236.529625574321, 6818.659067046528, 6836.042953986346, 6952.312030544378, 6987.580745155307, 7131.42948564124, 6988.895166572607, 7004.754833580801, 7010.614416207158, 7032.050673159058, 7050.15398152225, 6245.281792593728, 6286.685665716787, 6306.590071645328, 6313.652749098844, 6329.873402531832, 6555.4427873629365, 6581.111549940888, 6607.0, 6610.9669451652435, 6625.900611490928], "unit": "ms", "name": "mootools.html", "value": 4422.216211782462}, {"lowerIsBetter": false, "replicates": [332.3469382663067, 340.26672520717864, 340.53176881787545, 343.94752058700374, 344.60026369411486, 6328.7468501259955, 6390.105385246064, 6402.327755585667, 6450.8387290317705, 6466.321036291192, 6212.44088032077, 6262.874742505147, 6284.43440090393, 6287.6107079309795, 6291.4652254558305, 4743.644226682995, 4769.18923782956, 4778.665493415462, 4780.30685550595, 4781.880452988668, 4795.736234507101, 4797.0645724083815, 4798.280257961299, 4812.975935120319, 4817.951820481803, 4642.07158568286, 4731.739754313511, 4734.5265473452555, 4740.834070807522, 4757.714537127784, 4717.882052948669, 4735.526447355272, 4745.21703918853, 4752.07334569759, 4762.952370476303, 4144.212599606065, 4146.751194928314, 4150.294449943517, 4159.396887451333, 4160.292750232467, 5944.702764861783, 5947.762089516415, 5951.49412299955, 5952.494038006775, 5961.493273071751, 5412.972935135338, 5555.083411237181, 5573.749181286811, 5574.219609254707, 5578.776848926038, 6633.2040155181685, 6649.268580456146, 6652.767153149616, 6654.401103900624, 6665.566738162004, 4605.125026245003, 4610.331501932201, 4611.5619016193405, 4615.930761038587, 4618.145643056046, 6793.728250869959, 6865.382115609569, 6934.930650693479, 6961.895571566431, 6967.407770339527, 4750.216214324667, 4791.161546729309, 4793.592544633675, 4797.832075877328, 4810.254410566367, 4828.927566086511, 4833.975830120827, 4837.467878533358, 4838.346823178826, 4841.05599408112, 5564.27664403633, 5590.0, 5594.916076258859, 5604.803831865946, 5619.129034999582, 6606.1172565818515, 6662.233843108008, 6740.191177058784, 6740.29226931175, 6745.932540674628, 1670.3652612007359, 1690.932362705478, 1698.7621732957396, 1706.5136436115647, 1707.9914600426919, 1095.1457862866976, 1173.9413029348498, 1174.629991552658, 1180.2446434282067, 1185.9940700296615, 6415.26224484181, 6427.742890284337, 6430.839229019219, 6441.806745797539, 6481.09264702942, 6793.320667933167, 6845.383915447634, 6850.9314906850295, 6851.691673874688, 6859.862802743917, 6319.431251187415, 6400.551961362753, 6431.549791514549, 6439.645819479973, 6443.742250310029, 3694.907627309285, 3726.925461490809, 3730.4963829883163, 3739.9252014960093, 3744.3821769408287, 7103.751368702174, 7103.969924360938, 7104.609246491493, 7110.680019399139, 7116.146062472433, 6922.307769223138, 7022.894656580155, 7041.507094503336, 7042.6830792614455, 7050.0, 7135.678894449762, 7139.071920650386, 7139.214686384494, 7142.678579463936, 7154.678039488235, 6797.28628494001, 6806.55757375769, 6831.931680683129, 6837.760678376432, 6864.6910889011115, 6616.669166541557, 6695.397414232742, 6745.156855393076, 6770.729170833111, 6785.5250132490255, 7070.505064645426, 7080.468964827762, 7116.608586527584, 7124.323189297009, 7125.0, 4728.810847566059, 4741.075490279362, 4746.881327966828, 4757.595604373529, 4758.0, 6645.006076539558, 6729.528932974645, 6734.292899245509, 6793.932060679527, 6799.456043516606, 6579.934200657932, 6599.637019963948, 6602.0096985452565, 6604.570702904296, 6608.975608780646, 6552.148220731275, 6586.077949087227, 6615.900761488485, 6618.900716489353, 6622.701978410887, 6366.872662546631, 6478.967605161944, 6479.157709497924, 6554.213494380705, 6559.770408035696, 6737.629430381376, 6815.148106486689, 6816.352446517573, 6823.283555226828, 6829.214640316229, 6589.604623722592, 6617.8014659560295, 6627.5360724750735, 6652.101966234496, 6654.467642588678], "unit": "ms", "name": "prototype.html", "value": 5024.590844393988}, {"lowerIsBetter": false, "replicates": [700.0269625220941, 721.3255606008379, 798.7923139983607, 805.2913436176166, 847.0005393635512, 13354.065215434912, 13755.931220343884, 13761.862381376182, 13768.655783605414, 13812.102213356126, 12759.744805103892, 12838.422270997804, 12893.355332233397, 12925.74148517029, 12928.09503334767, 791.7783020754198, 796.9840603187932, 803.5660743198665, 804.6057431858405, 815.4617952151581, 801.0187520287659, 801.4790386248956, 802.9277365037145, 805.0862271322034, 805.697863301262, 853.1681610429844, 863.87905693203, 869.9826003479926, 870.4820631724145, 872.7294538692994, 851.9190676885717, 856.4090777363631, 858.845407826591, 860.1312674199041, 860.6944534690158, 633.885900537903, 636.2174525333819, 637.4326849104301, 637.4454224824386, 638.0939066525499, 12397.504099835996, 12505.312207828565, 12602.621921342374, 12614.180078294881, 12642.304673242968, 11824.645260642195, 12174.269543827399, 12573.182743121668, 12652.873471265353, 12690.492380304777, 10391.79216415675, 10399.636012739518, 10526.684199474028, 11305.378204198765, 11385.14611404148, 3629.1652919828325, 3631.455281707739, 3656.1590834108306, 3672.192117734094, 3772.1512659651357, 45155.77422112868, 45812.770936145105, 45834.0, 46077.30884036742, 46367.30449043267, 9905.356151850106, 10048.14590759779, 10092.192624590016, 10145.9492702536, 10164.949175254076, 17102.743458848126, 18139.365122220923, 18327.908360458114, 18336.449906502825, 18398.17208225633, 7646.235376462309, 7798.415118866108, 7812.804679883048, 7829.412794040356, 7887.250711182429, 4359.38968544404, 4414.4702635683925, 4421.513633500313, 4459.420275364182, 4483.080968401535, 2970.495015847311, 3007.2331555453657, 3022.002739096093, 3022.788404811642, 3023.9244018899262, 513.6738171261202, 525.9953488836304, 531.8696919254808, 532.8188415938599, 533.2214966149465, 445.49881383443625, 538.4803664463811, 551.9420460851633, 560.9775608975677, 565.1550931357565, 8040.557769322743, 8273.420860539705, 8280.213379728915, 8406.83186336282, 8475.27960123384, 460.7673125071817, 463.7565278228889, 521.1453216724575, 562.7552014873543, 570.1533223163599, 3819.3698039823676, 3826.789526576065, 3884.028992751812, 3889.552701439314, 3899.6880249579967, 58778.70610647005, 59533.702331488064, 59619.0, 59682.10476842851, 60064.0, 52071.21893171605, 53186.0, 54016.45983540114, 54121.45878541164, 54304.185437218475, 46990.765046175235, 48118.5188148121, 49151.508484914695, 49475.752621236665, 49503.25745113754, 7851.921480785348, 7998.640061197144, 8031.518108913484, 8032.196780321921, 8069.556174410463, 35067.47398789071, 35423.0, 35715.28569428649, 36178.63821361752, 36275.27449451049, 42632.0, 42783.572164279205, 46000.539994600964, 46750.766246168554, 47785.28322075102, 9313.0, 9405.106514881076, 9434.386764860263, 9553.379030363005, 9722.611095556098, 10236.0, 10250.948745256226, 10385.584576616851, 10405.739856503345, 10480.423576703355, 9471.857922131036, 9626.855597165908, 9669.661561845583, 9948.054934781185, 10002.949690282707, 9569.978100736556, 9573.377730447499, 10145.03622155894, 10431.0, 10446.63436779709, 9329.393589416666, 9717.02829717051, 9806.313558050868, 9836.06557377048, 10236.18110551169, 8974.596143173703, 9041.819163616823, 9325.626974920928, 9374.5781439834, 9430.57562409707, 8425.368097392597, 8448.577571121543, 8530.70142545008, 8954.373193876627, 9125.589348479467], "unit": "ms", "name": "yui.html", "value": 6070.725715797645}], "name": "dromaeo_css", "value": 6970.904564295754}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 105.0, 111.0, 110.0, 112.0, 123.0, 111.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [155.0, 132.0, 164.0, 170.0, 127.0, 158.0, 151.0, 129.0, 174.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 161.0, 162.0, 159.0, 162.0, 168.0, 170.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 72.0, 145.0, 72.0, 71.0, 72.0, 81.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [91.0, 90.0, 136.0, 90.0, 89.0, 90.0, 143.0, 90.0, 90.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 104.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 64.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 70.0, 68.0, 70.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 91.0, 95.0, 86.0, 86.0, 94.0, 91.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 89.1}, {"lowerIsBetter": true, "replicates": [123.0, 126.0, 123.0, 122.0, 117.0, 123.0, 117.0, 117.0, 125.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 146.0, 149.0, 141.0, 141.0, 148.0, 147.0, 148.0, 152.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [69.0, 65.0, 68.0, 69.0, 68.0, 68.0, 69.0, 66.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1514.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [194.28793471925394], "unit": "score", "name": "DeltaBlue", "value": 340.309346}, {"lowerIsBetter": false, "replicates": [286.5329512893983], "unit": "score", "name": "Encrypt", "value": 928.97169}, {"lowerIsBetter": false, "replicates": [5050.50505050505], "unit": "score", "name": "Decrypt", "value": 52.70383799999996}, {"lowerIsBetter": false, "replicates": [1060.4453870625662], "unit": "score", "name": "RayTrace", "value": 697.809627}, {"lowerIsBetter": false, "replicates": [713.2667617689016], "unit": "score", "name": "Earley", "value": 934.3811260000003}, {"lowerIsBetter": false, "replicates": [12216.867469879518], "unit": "score", "name": "Boyer", "value": 54.55269132149902}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [582.4111822947001], "unit": "score", "name": "Splay", "value": 139.92004699999995}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21389.03681725717}]} 21:02:48 INFO - RETURN: dromaeo_css: 6970.91 21:02:48 INFO - RETURN: kraken: 1514.80 21:02:48 INFO - RETURN: v8_7: 21389.04 21:02:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21389.04"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1514.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6970.91"}}} 21:02:48 INFO - Return code: 0 21:02:48 INFO - # TBPL SUCCESS # 21:02:48 INFO - Running post-action listener: _resource_record_post_action 21:02:48 INFO - Running post-run listener: _resource_record_post_run 21:02:49 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 12288; Write bytes: 509251584; Read time: 136; Write time: 364892 21:02:49 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 164257792; Read time: 12; Write time: 143956 21:02:49 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 8192; Write bytes: 344993792; Read time: 124; Write time: 220936 21:02:49 INFO - Running post-run listener: _upload_blobber_files 21:02:49 INFO - Blob upload gear active. 21:02:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:02:49 INFO - Copying logs to upload dir... 21:02:49 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.997104 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-11-20 21:02:48.783340) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 21:02:48.786479) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009844 build_url: 'https://queue.taskcluster.net/v1/task/tIFvKsfHQI2u7khxDab7MA/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-20 21:02:48.837247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:02:48.837589) ========= 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=3e14eba40af1795cf0357910000001c3-1448079111.76891-1448690450 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 21:02:48.886965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:02:48.887282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 21:02:48.887586) ========= ========= Total master_lag: 0.27 =========