builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1447887095.39 results: success (0) buildid: 20151118133104 builduid: 10cb8191a16a4e988a66fdb7719d1890 revision: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.391379) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.392248) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.392549) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006679 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.447289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.447575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.510257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.510527) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.712106) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.712385) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.712748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.713015) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-18 14:51:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 223M=0s 2015-11-18 14:51:36 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167823 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.920283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.920569) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018207 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.971702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:35.972054) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-18 14:51:36,759 truncating revision to first 12 chars 2015-11-18 14:51:36,759 Setting DEBUG logging. 2015-11-18 14:51:36,759 attempt 1/10 2015-11-18 14:51:36,759 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a2ccdf48529b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 14:51:37,024 unpacking tar archive at: mozilla-inbound-a2ccdf48529b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571204 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.556439) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.556797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.565166) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.565470) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 14:51:36.565905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-18 14:51:36.566251) ========= /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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:51:37 INFO - MultiFileLogger online at 20151118 14:51:37 in /builds/slave/test-pgo 14:51: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 14:51:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:51:37 INFO - {'append_to_log': False, 14:51:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:51:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 14:51:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:51:37 INFO - 'branch': 'Mozilla-Inbound', 14:51:37 INFO - 'buildbot_json_path': 'buildprops.json', 14:51:37 INFO - 'config_files': ('talos/linux_config.py',), 14:51:37 INFO - 'default_actions': ('clobber', 14:51:37 INFO - 'read-buildbot-config', 14:51:37 INFO - 'download-and-extract', 14:51:37 INFO - 'populate-webroot', 14:51:37 INFO - 'create-virtualenv', 14:51:37 INFO - 'install', 14:51:37 INFO - 'run-tests'), 14:51:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:51:37 INFO - 'download_minidump_stackwalk': True, 14:51:37 INFO - 'download_symbols': 'ondemand', 14:51:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:51:37 INFO - 'tooltool.py': '/tools/tooltool.py', 14:51:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:51:37 INFO - '/tools/misc-python/virtualenv.py')}, 14:51:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:51:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:51:37 INFO - 'installer_path': 'installer.exe', 14:51:37 INFO - 'log_level': 'info', 14:51:37 INFO - 'log_name': 'talos', 14:51:37 INFO - 'log_to_console': True, 14:51:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:51:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:51:37 INFO - 'opt_config_files': (), 14:51:37 INFO - 'pip_index': False, 14:51:37 INFO - 'sps_profile': False, 14:51:37 INFO - 'sps_profile_interval': 0, 14:51:37 INFO - 'suite': 'dromaeojs-e10s', 14:51:37 INFO - 'system_bits': '64', 14:51:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:51:37 INFO - 'title': 'talos-linux64-ix-027', 14:51:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:51:37 INFO - 'use_talos_json': True, 14:51:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:51:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:51:37 INFO - 'work_dir': 'build'} 14:51:37 INFO - ##### 14:51:37 INFO - ##### Running clobber step. 14:51:37 INFO - ##### 14:51:37 INFO - Running pre-action listener: _resource_record_pre_action 14:51:37 INFO - Running main action method: clobber 14:51:37 INFO - rmtree: /builds/slave/test-pgo/build 14:51:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:51:38 INFO - Running post-action listener: _resource_record_post_action 14:51:38 INFO - ##### 14:51:38 INFO - ##### Running read-buildbot-config step. 14:51:38 INFO - ##### 14:51:38 INFO - Running pre-action listener: _resource_record_pre_action 14:51:38 INFO - Running main action method: read_buildbot_config 14:51:38 INFO - Using buildbot properties: 14:51:38 INFO - { 14:51:38 INFO - "properties": { 14:51:38 INFO - "buildnumber": 446, 14:51:38 INFO - "product": "firefox", 14:51:38 INFO - "script_repo_revision": "production", 14:51:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 14:51:38 INFO - "repository": "", 14:51:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 14:51:38 INFO - "buildid": "20151118133104", 14:51:38 INFO - "slavename": "talos-linux64-ix-027", 14:51:38 INFO - "pgo_build": "True", 14:51:38 INFO - "basedir": "/builds/slave/test-pgo", 14:51:38 INFO - "project": "", 14:51:38 INFO - "platform": "ubuntu64_hw", 14:51:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:51:38 INFO - "slavebuilddir": "test", 14:51:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 14:51:38 INFO - "branch": "mozilla-inbound", 14:51:38 INFO - "repo_path": "integration/mozilla-inbound", 14:51:38 INFO - "stage_platform": "linux64-pgo", 14:51:38 INFO - "builduid": "10cb8191a16a4e988a66fdb7719d1890", 14:51:38 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:38 INFO - }, 14:51:38 INFO - "sourcestamp": { 14:51:38 INFO - "repository": "", 14:51:38 INFO - "hasPatch": false, 14:51:38 INFO - "project": "", 14:51:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 14:51:38 INFO - "changes": [ 14:51:38 INFO - { 14:51:38 INFO - "category": null, 14:51:38 INFO - "files": [ 14:51:38 INFO - { 14:51:38 INFO - "url": null, 14:51:38 INFO - "name": "https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:51:38 INFO - } 14:51:38 INFO - ], 14:51:38 INFO - "repository": "", 14:51:38 INFO - "rev": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0", 14:51:38 INFO - "who": "sendchange", 14:51:38 INFO - "when": 1447887055, 14:51:38 INFO - "number": 6679155, 14:51:38 INFO - "comments": "", 14:51:38 INFO - "project": "", 14:51:38 INFO - "at": "Wed 18 Nov 2015 14:50:55", 14:51:38 INFO - "branch": "mozilla-inbound-linux64-pgo-talos", 14:51:38 INFO - "revlink": "", 14:51:38 INFO - "properties": [ 14:51:38 INFO - [ 14:51:38 INFO - "buildid", 14:51:38 INFO - "20151118133104", 14:51:38 INFO - "Change" 14:51:38 INFO - ], 14:51:38 INFO - [ 14:51:38 INFO - "builduid", 14:51:38 INFO - "10cb8191a16a4e988a66fdb7719d1890", 14:51:38 INFO - "Change" 14:51:38 INFO - ], 14:51:38 INFO - [ 14:51:38 INFO - "pgo_build", 14:51:38 INFO - "True", 14:51:38 INFO - "Change" 14:51:38 INFO - ] 14:51:38 INFO - ], 14:51:38 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:38 INFO - } 14:51:38 INFO - ], 14:51:38 INFO - "revision": "a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0" 14:51:38 INFO - } 14:51:38 INFO - } 14:51:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:51:38 INFO - Running post-action listener: _resource_record_post_action 14:51:38 INFO - ##### 14:51:38 INFO - ##### Running download-and-extract step. 14:51:38 INFO - ##### 14:51:38 INFO - Running pre-action listener: _resource_record_pre_action 14:51:38 INFO - Running main action method: download_and_extract 14:51:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:51: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')]} 14:51:38 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:51:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json 14:51:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json 14:51:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:51:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:51:38 INFO - Downloaded 1302 bytes. 14:51:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:51:38 INFO - Using the following test package requirements: 14:51:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:51:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'jsshell-linux-x86_64.zip'], 14:51:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:51:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:51:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:51:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:51:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:51:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:51:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:51:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:39 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:51:40 INFO - Downloaded 22506947 bytes. 14:51:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:51:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:51:41 INFO - Return code: 0 14:51:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:41 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:51:42 INFO - Downloaded 22506947 bytes. 14:51:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:51:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:51:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:51:44 INFO - Return code: 0 14:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:44 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:51:45 INFO - Downloaded 11130997 bytes. 14:51:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:51:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:51:45 INFO - Return code: 0 14:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:45 INFO - https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:51:47 INFO - Downloaded 57319325 bytes. 14:51:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:47 INFO - mkdir: /builds/slave/test-pgo/properties 14:51:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:51:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:51:47 INFO - Contents: 14:51:47 INFO - build_url:https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:51:47 INFO - Running post-action listener: _resource_record_post_action 14:51:47 INFO - Running post-action listener: set_extra_try_arguments 14:51:47 INFO - ##### 14:51:47 INFO - ##### Running populate-webroot step. 14:51:47 INFO - ##### 14:51:47 INFO - Running pre-action listener: _resource_record_pre_action 14:51:47 INFO - Running main action method: populate_webroot 14:51:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:51:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:51:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:51:47 INFO - '../fennec_ids.txt'], 14:51:47 INFO - 'tests': ['tcheck2']}, 14:51:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:51:47 INFO - '--tppagecycles', 14:51:47 INFO - '7'], 14:51:47 INFO - 'tests': ['tsvgm']}}, 14:51:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:51:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:51:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:51:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:51:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:51:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'tests': ['damp', 'tps']}, 14:51:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['damp', 'tps']}, 14:51:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:51:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:51:47 INFO - 'other': {'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'other_l64': {'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'other_nol64': {'tests': ['a11yr', 14:51:47 INFO - 'ts_paint', 14:51:47 INFO - 'tpaint', 14:51:47 INFO - 'sessionrestore', 14:51:47 INFO - 'sessionrestore_no_auto_restore']}, 14:51:47 INFO - 'svgr': {'tests': ['tsvgx', 14:51:47 INFO - 'tsvgr_opacity', 14:51:47 INFO - 'tart', 14:51:47 INFO - 'tscrollx', 14:51:47 INFO - 'cart']}, 14:51:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['tsvgx', 14:51:47 INFO - 'tsvgr_opacity', 14:51:47 INFO - 'tart', 14:51:47 INFO - 'tscrollx', 14:51:47 INFO - 'cart']}, 14:51:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'tests': ['tp5o']}, 14:51:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'talos_options': ['--e10s'], 14:51:47 INFO - 'tests': ['tp5o']}, 14:51:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'talos_options': ['--xperf_path', 14:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:47 INFO - 'tests': ['tp5n']}, 14:51:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:51:47 INFO - 'talos_options': ['--e10s', 14:51:47 INFO - '--xperf_path', 14:51:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:51:47 INFO - 'tests': ['tp5n']}}, 14:51:47 INFO - 'talos.zip': {'path': '', 14:51:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:51:47 INFO - Running post-action listener: _resource_record_post_action 14:51:47 INFO - ##### 14:51:47 INFO - ##### Running create-virtualenv step. 14:51:47 INFO - ##### 14:51:47 INFO - Running pre-action listener: _resource_record_pre_action 14:51:47 INFO - Running main action method: create_virtualenv 14:51:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:51:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 14:51:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:51:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:51:47 INFO - Using real prefix '/usr' 14:51:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 14:51:49 INFO - Installing pip.................done. 14:51:49 INFO - Return code: 0 14:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:49 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:51:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 14:51:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:51:49 INFO - Using env: {'DISPLAY': ':0', 14:51:49 INFO - 'HOME': '/home/cltbld', 14:51:49 INFO - 'LANG': 'en_US.UTF-8', 14:51:49 INFO - 'LANGUAGE': 'en_US:en', 14:51:49 INFO - 'LOGNAME': 'cltbld', 14:51:49 INFO - 'MAIL': '/var/mail/cltbld', 14:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:49 INFO - 'MOZ_NO_REMOTE': '1', 14:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:49 INFO - 'NO_EM_RESTART': '1', 14:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:49 INFO - 'SHELL': '/bin/bash', 14:51:49 INFO - 'SHLVL': '1', 14:51:49 INFO - 'TERM': 'linux', 14:51:49 INFO - 'TMOUT': '86400', 14:51:49 INFO - 'USER': 'cltbld', 14:51:49 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:49 INFO - '_': '/tools/buildbot/bin/python'} 14:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:51:50 INFO - Cleaning up... 14:51:50 INFO - Return code: 0 14:51:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:50 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:51:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 14:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:51:50 INFO - Using env: {'DISPLAY': ':0', 14:51:50 INFO - 'HOME': '/home/cltbld', 14:51:50 INFO - 'LANG': 'en_US.UTF-8', 14:51:50 INFO - 'LANGUAGE': 'en_US:en', 14:51:50 INFO - 'LOGNAME': 'cltbld', 14:51:50 INFO - 'MAIL': '/var/mail/cltbld', 14:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:50 INFO - 'MOZ_NO_REMOTE': '1', 14:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:50 INFO - 'NO_EM_RESTART': '1', 14:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:50 INFO - 'SHELL': '/bin/bash', 14:51:50 INFO - 'SHLVL': '1', 14:51:50 INFO - 'TERM': 'linux', 14:51:50 INFO - 'TMOUT': '86400', 14:51:50 INFO - 'USER': 'cltbld', 14:51:50 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:50 INFO - '_': '/tools/buildbot/bin/python'} 14:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:50 INFO - Downloading/unpacking psutil>=0.7.1 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:51:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:51:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:52 INFO - Installing collected packages: psutil 14:51:52 INFO - Running setup.py install for psutil 14:51:52 INFO - building 'psutil._psutil_linux' extension 14:51:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:51:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:51:52 INFO - building 'psutil._psutil_posix' extension 14:51:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:51:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:51:52 INFO - Successfully installed psutil 14:51:52 INFO - Cleaning up... 14:51:52 INFO - Return code: 0 14:51:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:52 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:51:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 14:51:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:51:52 INFO - Using env: {'DISPLAY': ':0', 14:51:52 INFO - 'HOME': '/home/cltbld', 14:51:52 INFO - 'LANG': 'en_US.UTF-8', 14:51:52 INFO - 'LANGUAGE': 'en_US:en', 14:51:52 INFO - 'LOGNAME': 'cltbld', 14:51:52 INFO - 'MAIL': '/var/mail/cltbld', 14:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:52 INFO - 'MOZ_NO_REMOTE': '1', 14:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:52 INFO - 'NO_EM_RESTART': '1', 14:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:52 INFO - 'SHELL': '/bin/bash', 14:51:52 INFO - 'SHLVL': '1', 14:51:52 INFO - 'TERM': 'linux', 14:51:52 INFO - 'TMOUT': '86400', 14:51:52 INFO - 'USER': 'cltbld', 14:51:52 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:52 INFO - '_': '/tools/buildbot/bin/python'} 14:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:51:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:51:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:51:54 INFO - Installing collected packages: mozsystemmonitor 14:51:54 INFO - Running setup.py install for mozsystemmonitor 14:51:54 INFO - Successfully installed mozsystemmonitor 14:51:54 INFO - Cleaning up... 14:51:54 INFO - Return code: 0 14:51:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:54 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:51:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:51:54 INFO - Using env: {'DISPLAY': ':0', 14:51:54 INFO - 'HOME': '/home/cltbld', 14:51:54 INFO - 'LANG': 'en_US.UTF-8', 14:51:54 INFO - 'LANGUAGE': 'en_US:en', 14:51:54 INFO - 'LOGNAME': 'cltbld', 14:51:54 INFO - 'MAIL': '/var/mail/cltbld', 14:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:54 INFO - 'MOZ_NO_REMOTE': '1', 14:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:54 INFO - 'NO_EM_RESTART': '1', 14:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:54 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:54 INFO - 'SHELL': '/bin/bash', 14:51:54 INFO - 'SHLVL': '1', 14:51:54 INFO - 'TERM': 'linux', 14:51:54 INFO - 'TMOUT': '86400', 14:51:54 INFO - 'USER': 'cltbld', 14:51:54 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:54 INFO - '_': '/tools/buildbot/bin/python'} 14:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:51:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:51:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:51:57 INFO - Downloading docopt-0.6.1.tar.gz 14:51:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:51:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:51:57 INFO - Running setup.py install for blobuploader 14:51:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:51:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:51:57 INFO - Running setup.py install for requests 14:51:57 INFO - Running setup.py install for docopt 14:51:57 INFO - Successfully installed blobuploader requests docopt 14:51:57 INFO - Cleaning up... 14:51:57 INFO - Return code: 0 14:51:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:51:57 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:51:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:51:57 INFO - Using env: {'DISPLAY': ':0', 14:51:57 INFO - 'HOME': '/home/cltbld', 14:51:57 INFO - 'LANG': 'en_US.UTF-8', 14:51:57 INFO - 'LANGUAGE': 'en_US:en', 14:51:57 INFO - 'LOGNAME': 'cltbld', 14:51:57 INFO - 'MAIL': '/var/mail/cltbld', 14:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:57 INFO - 'MOZ_NO_REMOTE': '1', 14:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:57 INFO - 'NO_EM_RESTART': '1', 14:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 14:51:57 INFO - 'SHELL': '/bin/bash', 14:51:57 INFO - 'SHLVL': '1', 14:51:57 INFO - 'TERM': 'linux', 14:51:57 INFO - 'TMOUT': '86400', 14:51:57 INFO - 'USER': 'cltbld', 14:51:57 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:57 INFO - '_': '/tools/buildbot/bin/python'} 14:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:51:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:58 INFO - Running setup.py (path:/tmp/pip-YWLjSg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:58 INFO - Running setup.py (path:/tmp/pip-JwXt3o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:58 INFO - Running setup.py (path:/tmp/pip-0LXP0c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:58 INFO - Running setup.py (path:/tmp/pip-GZ6bVj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:58 INFO - Running setup.py (path:/tmp/pip-zxb_KO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:58 INFO - Running setup.py (path:/tmp/pip-ulFW1I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:58 INFO - Running setup.py (path:/tmp/pip-EgnSqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:58 INFO - Running setup.py (path:/tmp/pip-MjWxoW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:58 INFO - Running setup.py (path:/tmp/pip-TjvAd4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:58 INFO - Running setup.py (path:/tmp/pip-L_lf0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:58 INFO - Running setup.py (path:/tmp/pip-sTt8sq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:58 INFO - Running setup.py (path:/tmp/pip-wWwYI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:58 INFO - Running setup.py (path:/tmp/pip-3pkZL7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:51:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:58 INFO - Running setup.py (path:/tmp/pip-vNlB2F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:59 INFO - Running setup.py (path:/tmp/pip-u4UL0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:59 INFO - Running setup.py (path:/tmp/pip-9FMcwl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:51:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:59 INFO - Running setup.py (path:/tmp/pip-sjv9Fa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:51:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:51:59 INFO - Running setup.py install for manifestparser 14:51:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:51:59 INFO - Running setup.py install for mozcrash 14:51:59 INFO - Running setup.py install for mozdebug 14:51:59 INFO - Running setup.py install for mozdevice 14:51:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:51:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:51:59 INFO - Running setup.py install for mozfile 14:51:59 INFO - Running setup.py install for mozhttpd 14:51:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:51:59 INFO - Running setup.py install for mozinfo 14:51:59 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:51:59 INFO - Running setup.py install for mozInstall 14:52:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Running setup.py install for mozleak 14:52:00 INFO - Running setup.py install for mozlog 14:52:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Running setup.py install for moznetwork 14:52:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Running setup.py install for mozprocess 14:52:00 INFO - Running setup.py install for mozprofile 14:52:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Running setup.py install for mozrunner 14:52:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:52:00 INFO - Running setup.py install for mozscreenshot 14:52:00 INFO - Running setup.py install for moztest 14:52:00 INFO - Running setup.py install for mozversion 14:52:00 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:52:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:01 INFO - Cleaning up... 14:52:01 INFO - Return code: 0 14:52:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52: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')]} 14:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:01 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 14:52:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:01 INFO - Using env: {'DISPLAY': ':0', 14:52:01 INFO - 'HOME': '/home/cltbld', 14:52:01 INFO - 'LANG': 'en_US.UTF-8', 14:52:01 INFO - 'LANGUAGE': 'en_US:en', 14:52:01 INFO - 'LOGNAME': 'cltbld', 14:52:01 INFO - 'MAIL': '/var/mail/cltbld', 14:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:01 INFO - 'MOZ_NO_REMOTE': '1', 14:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:01 INFO - 'NO_EM_RESTART': '1', 14:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:01 INFO - 'SHELL': '/bin/bash', 14:52:01 INFO - 'SHLVL': '1', 14:52:01 INFO - 'TERM': 'linux', 14:52:01 INFO - 'TMOUT': '86400', 14:52:01 INFO - 'USER': 'cltbld', 14:52:01 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:01 INFO - '_': '/tools/buildbot/bin/python'} 14:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:01 INFO - Running setup.py (path:/tmp/pip-a9gkqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:01 INFO - Running setup.py (path:/tmp/pip-yZOoHd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:01 INFO - Running setup.py (path:/tmp/pip-m7wvfM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:01 INFO - Running setup.py (path:/tmp/pip-xKWkWa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:01 INFO - Running setup.py (path:/tmp/pip-st8ROq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:01 INFO - Running setup.py (path:/tmp/pip-FVVvwD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:01 INFO - Running setup.py (path:/tmp/pip-kViPAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:01 INFO - Running setup.py (path:/tmp/pip-ocmm6J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:01 INFO - Running setup.py (path:/tmp/pip-5LVFxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:01 INFO - Running setup.py (path:/tmp/pip-eah50_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:01 INFO - Running setup.py (path:/tmp/pip-cqtrKU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:02 INFO - Running setup.py (path:/tmp/pip-DmDBHF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:02 INFO - Running setup.py (path:/tmp/pip-Nxk_7U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:02 INFO - Running setup.py (path:/tmp/pip-xwlQJP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:02 INFO - Running setup.py (path:/tmp/pip-Pw_jCL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:02 INFO - Running setup.py (path:/tmp/pip-OQ5kgH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 14:52:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:02 INFO - Running setup.py (path:/tmp/pip-mkiiZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:04 INFO - Downloading blessings-1.5.1.tar.gz 14:52:04 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 14:52:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:04 INFO - Installing collected packages: blessings 14:52:04 INFO - Running setup.py install for blessings 14:52:04 INFO - Successfully installed blessings 14:52:04 INFO - Cleaning up... 14:52:04 INFO - Return code: 0 14:52:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:52:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:52:04 INFO - Reading from file tmpfile_stdout 14:52:04 INFO - Current package versions: 14:52:04 INFO - argparse == 1.2.1 14:52:04 INFO - blessings == 1.5.1 14:52:04 INFO - blobuploader == 1.2.4 14:52:04 INFO - docopt == 0.6.1 14:52:04 INFO - manifestparser == 1.1 14:52:04 INFO - mozInstall == 1.12 14:52:04 INFO - mozcrash == 0.16 14:52:04 INFO - mozdebug == 0.1 14:52:04 INFO - mozdevice == 0.47 14:52:04 INFO - mozfile == 1.2 14:52:04 INFO - mozhttpd == 0.7 14:52:04 INFO - mozinfo == 0.9 14:52:04 INFO - mozleak == 0.1 14:52:04 INFO - mozlog == 3.0 14:52:04 INFO - moznetwork == 0.27 14:52:04 INFO - mozprocess == 0.22 14:52:04 INFO - mozprofile == 0.27 14:52:04 INFO - mozrunner == 6.11 14:52:04 INFO - mozscreenshot == 0.1 14:52:04 INFO - mozsystemmonitor == 0.0 14:52:04 INFO - moztest == 0.7 14:52:04 INFO - mozversion == 1.4 14:52:04 INFO - psutil == 3.1.1 14:52:04 INFO - requests == 1.2.3 14:52:04 INFO - wsgiref == 0.1.2 14:52:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:04 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 0x7f8eeef0ac70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19896e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, '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': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 14:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:04 INFO - Using env: {'DISPLAY': ':0', 14:52:04 INFO - 'HOME': '/home/cltbld', 14:52:04 INFO - 'LANG': 'en_US.UTF-8', 14:52:04 INFO - 'LANGUAGE': 'en_US:en', 14:52:04 INFO - 'LOGNAME': 'cltbld', 14:52:04 INFO - 'MAIL': '/var/mail/cltbld', 14:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:04 INFO - 'MOZ_NO_REMOTE': '1', 14:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:04 INFO - 'NO_EM_RESTART': '1', 14:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:04 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:04 INFO - 'SHELL': '/bin/bash', 14:52:04 INFO - 'SHLVL': '1', 14:52:04 INFO - 'TERM': 'linux', 14:52:04 INFO - 'TMOUT': '86400', 14:52:04 INFO - 'USER': 'cltbld', 14:52:04 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:04 INFO - '_': '/tools/buildbot/bin/python'} 14:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 14:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:52:04 INFO - Cleaning up... 14:52:04 INFO - Return code: 0 14:52:04 INFO - Running post-action listener: _resource_record_post_action 14:52:04 INFO - Running post-action listener: _start_resource_monitoring 14:52:04 INFO - Starting resource monitoring. 14:52:04 INFO - ##### 14:52:04 INFO - ##### Running install step. 14:52:04 INFO - ##### 14:52:04 INFO - Running pre-action listener: _resource_record_pre_action 14:52:04 INFO - Running main action method: install 14:52:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:52:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:52:05 INFO - Reading from file tmpfile_stdout 14:52:05 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:52:05 INFO - Reading from file tmpfile_stdout 14:52:05 INFO - Output received: 14:52:05 INFO - Usage: mozinstall [options] installer 14:52:05 INFO - Options: 14:52:05 INFO - -h, --help show this help message and exit 14:52:05 INFO - -d DEST, --destination=DEST 14:52:05 INFO - Directory to install application into. [default: 14:52:05 INFO - "/builds/slave/test-pgo"] 14:52:05 INFO - --app=APP Application being installed. [default: firefox] 14:52:05 INFO - mkdir: /builds/slave/test-pgo/build/application 14:52:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:52:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:52:19 INFO - Reading from file tmpfile_stdout 14:52:19 INFO - Output received: 14:52:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:52:19 INFO - Running post-action listener: _resource_record_post_action 14:52:19 INFO - ##### 14:52:19 INFO - ##### Running run-tests step. 14:52:19 INFO - ##### 14:52:19 INFO - Running pre-action listener: _resource_record_pre_action 14:52:19 INFO - Running main action method: run_tests 14:52:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:52:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:52:19 INFO - Python 2.7.3 14:52:19 INFO - Return code: 0 14:52:19 INFO - grabbing minidump binary from tooltool 14:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:19 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 0x19bfa90>, '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 0x1a11f70>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a122e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:52:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 14:52:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:52:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:19 INFO - Return code: 0 14:52:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:52:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:52:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:52:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:52:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:52:19 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:52:19 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 14:52:19 INFO - Using env: {'DISPLAY': ':0', 14:52:19 INFO - 'HOME': '/home/cltbld', 14:52:19 INFO - 'LANG': 'en_US.UTF-8', 14:52:19 INFO - 'LANGUAGE': 'en_US:en', 14:52:19 INFO - 'LOGNAME': 'cltbld', 14:52:19 INFO - 'MAIL': '/var/mail/cltbld', 14:52:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:52:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:19 INFO - 'MOZ_NO_REMOTE': '1', 14:52:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:19 INFO - 'NO_EM_RESTART': '1', 14:52:19 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:52:19 INFO - 'PWD': '/builds/slave/test-pgo', 14:52:19 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:52:19 INFO - 'SHELL': '/bin/bash', 14:52:19 INFO - 'SHLVL': '1', 14:52:19 INFO - 'TERM': 'linux', 14:52:19 INFO - 'TMOUT': '86400', 14:52:19 INFO - 'USER': 'cltbld', 14:52:19 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392', 14:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:19 INFO - '_': '/tools/buildbot/bin/python'} 14:52:19 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/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 14:52:19 INFO - mozversion INFO | application_buildid: 20151118133104 14:52:19 INFO - mozversion INFO | application_changeset: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 14:52:19 INFO - mozversion INFO | application_display_name: Nightly 14:52:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:19 INFO - mozversion INFO | application_name: Firefox 14:52:19 INFO - mozversion INFO | application_remotingname: firefox 14:52:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:52:19 INFO - mozversion INFO | application_vendor: Mozilla 14:52:19 INFO - mozversion INFO | application_version: 45.0a1 14:52:19 INFO - mozversion INFO | platform_buildid: 20151118133104 14:52:19 INFO - mozversion INFO | platform_changeset: a2ccdf48529ba5b597e1f77c9b1d2e8d70c32eb0 14:52:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 14:52:19 INFO - mozversion INFO | platform_version: 45.0a1 14:52:19 INFO - 2015-11-18 14:52:19,798 DEBUG : using testdate: 1447887139 14:52:19 INFO - 2015-11-18 14:52:19,798 DEBUG : actual date: 1447887139 14:52:19 INFO - 2015-11-18 14:52:19,846 INFO : starting webserver on 'localhost:44927' 14:52:19 INFO - 2015-11-18 14:52:19,847 INFO : Starting test suite talos-linux64-ix-027.e 14:52:19 INFO - 2015-11-18 14:52:19,847 INFO : Starting test dromaeo_css 14:52:19 INFO - 2015-11-18 14:52:19,848 DEBUG : operating with platform_type : linux_ 14:52:19 INFO - 2015-11-18 14:52:19,848 INFO : Initialising browser for dromaeo_css test... 14:52:19 INFO - 2015-11-18 14:52:19,865 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTr0Zb5/profile http://localhost:44927/getInfo.html 14:52:24 INFO - 2015-11-18 14:52:24,570 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:52:24 INFO - 2015-11-18 14:52:24,570 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:52:24 INFO - 2015-11-18 14:52:24,570 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:52:24 INFO - 2015-11-18 14:52:24,570 DEBUG : BROWSER_OUTPUT: __metrics 14:52:25 INFO - 2015-11-18 14:52:25,623 INFO : Browser initialized. 14:52:25 INFO - 2015-11-18 14:52:25,623 INFO : Running cycle 1/1 for dromaeo_css test... 14:52:25 INFO - 2015-11-18 14:52:25,623 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpTr0Zb5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:52:37 INFO - 2015-11-18 14:52:37,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 141324288 14:52:37 INFO - 2015-11-18 14:52:37,429 DEBUG : BROWSER_OUTPUT: 14:53:27 INFO - 2015-11-18 14:53:27,066 DEBUG : BROWSER_OUTPUT: 1447887207064 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:55:35 INFO - 2015-11-18 14:55:35,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44927/tests/dromaeo/cssquery-ext.html) 14:55:36 INFO - 2015-11-18 14:55:36,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 145453056 14:55:36 INFO - 2015-11-18 14:55:36,840 DEBUG : BROWSER_OUTPUT: 14:58:38 INFO - 2015-11-18 14:58:38,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-ext.html (next: http://localhost:44927/tests/dromaeo/cssquery-jquery.html) 14:58:39 INFO - 2015-11-18 14:58:39,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 142295040 14:58:39 INFO - 2015-11-18 14:58:39,472 DEBUG : BROWSER_OUTPUT: 15:01:41 INFO - 2015-11-18 15:01:41,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44927/tests/dromaeo/cssquery-mootools.html) 15:01:41 INFO - 2015-11-18 15:01:41,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 141959168 15:01:41 INFO - 2015-11-18 15:01:41,664 DEBUG : BROWSER_OUTPUT: 15:04:43 INFO - 2015-11-18 15:04:43,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44927/tests/dromaeo/cssquery-prototype.html) 15:04:43 INFO - 2015-11-18 15:04:43,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 141037568 15:04:43 INFO - 2015-11-18 15:04:43,920 DEBUG : BROWSER_OUTPUT: 15:07:46 INFO - 2015-11-18 15:07:46,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44927/tests/dromaeo/cssquery-yui.html) 15:07:46 INFO - 2015-11-18 15:07:46,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 142204928 15:07:46 INFO - 2015-11-18 15:07:46,817 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/dromaeo/cssquery-yui.html (next: http://localhost:44927/tests/dromaeo/cssquery-dojo.html) 15:10:49 INFO - 2015-11-18 15:10:49,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 144392192 15:10:49 INFO - 2015-11-18 15:10:49,468 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,469 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:10:49 INFO - 2015-11-18 15:10:49,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:10:49 INFO - 2015-11-18 15:10:49,470 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:10:49 INFO - 2015-11-18 15:10:49,470 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:10:49 INFO - 2015-11-18 15:10:49,473 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3206.743460523158;3245.415825151473;3267.9836600816993;3283.3925723741104;3298.290867463495;5210.843674689765;5344.652597581155;5350.598705097119;5373.489518495741;5385.35375754909;5300.681959082458;5301.1783173608055;5313.521783039526;5425.782968681248;5439.129739241722;4900.264960255954;4944.975275123637;4969.62727795415;5007.14878470659;5043.268726034741;4887.218045112782;4960.305557221992;4971.229459433794;5011.799528018893;5038.319826823387;4716.339712440261;4768.189407800683;4868.196747536652;4923.58149557288;4947.455779864212;4969.304297398367;4976.651634385595;4997;5000.324956130912;5043.218301163289;4954.43024052235;4977.875553111165;4992.450830408652;4994.725290109042;5022.321986531808;5004.674696144775;5087.236914462823;5135.768890399941;5143.125668636303;5149.794008239666;5829.970850145764;5844.26946631671;5858.297004359461;5859.384764599698;5869.589128760988;5662.065759149777;5896.262967129109;5917.171595976523;5917.615355001911;5925.259342582177;5349.438308977501;5360.303160589098;5363.999999999961;5366.275552800361;5377.838664840022;5794.478496935296;5876.882462350729;5878.382769809194;5880.2943646761805;5925.081612350093;5684.090545512699;5687.857803554944;5701.600887937804;5718.599698021098;5727.341355744059;5506.284183056177;5627.184058311522;5646.491815736521;5797.420257974253;5807.912881306784;5701.515371193412;5738.454846789548;5762.711864406763;5781.046127389018;5783.074708046693;5714.714264286769;5737.110747834093;5753.108268218432;5754.74103665336;5762.596618236767;4304.677149213821;4413.16149931512;4414.27164517851;4485.372047913294;4516.8193272268745;3983.42240375144;3994.460747799068;4015.6185162409524;4019.7990100495444;4029.1146289077733;5551.666899986014;5568.805091821767;5580.330360356783;5584.385717571064;5609.4390560943575;5634.661920284796;5662.405447428043;5692.060809966392;5736.741846616912;5776.133579963039;5502.669839809624;5562.833115006556;5596.3284405871555;5609.186667933209;5626.774929002876;4974.825881094144;5081.8475445736685;5093.465186155475;5095.617828662865;5126.000429916131;5875.265591801025;5892.823215303548;5906;5923.940760592425;6027.276726792726;5724.771009159587;5752.539796816328;5767.769289228551;5773.884522309614;5787.797427090031;5983.162357270073;5999.070144127667;6005.429484198994;6008.639481631116;6009.819705408845;5459.945400545944;5551.084071128219;5635.380108188178;5708.714564271853;5711.714414279352;5862.530997520103;5862.706864656665;5862.970685146547;5867.647941123546;5888.146218798336;5668.603197776281;5705.087186050212;5713.428657134254;5714.399988001366;5717.971410142923;5568.387477377566;5585.636933599303;5673.574481913791;5695.971520142372;5712;5513.228148059355;5563.77596928675;5592.412796656456;5624.943750562442;5652.180433836988;5700.885982280414;5706.828795136153;5727.971360143172;5737.942620573908;5754.856128596819;5345.118055520796;5451.8364449065;5479.4520547944885;5556.944430555643;5589.748461319169 15:10:49 INFO - 2015-11-18 15:10:49,474 DEBUG : BROWSER_OUTPUT: |1;ext.html;585.1924344404721;586.8591538030873;595.6842873277163;602.3765402808094;606.6572386601567;39193.824185274454;40083.79958100205;40150.59849401505;40202.798986005066;40325.39511907324;43071.35392969108;43909.56090439095;43996.780016099954;44050;44062;8722.433041852275;8816.162464565889;8829.293656507463;8852.291816654651;8869.645214191456;8567.571621418903;8648.827023459527;8657.913420865774;8665.740027799176;8688.391812573122;8599.527026013568;8705.260052895512;8713.215810577047;8730.51982140982;8739.951205855306;8671.176238257387;8748.650053997833;8764.824703505927;8780.209781119665;8795.340349473783;8543.487390756512;8621.137886211329;8647.783805404852;8649.048604653482;8661.350398720122;38911.41632875509;39121.021974450865;39354.21291574181;39367;39384.409233861516;3209.737160061012;3244.821534815584;3277.705006549422;3315.154635567939;3362.9159271018175;30407.847960760275;30963.22591935197;31367.529487057713;31557.52663710046;32579.51130733041;3551.94672079919;3623.800690961996;3645.143391303042;3714.4879989629285;3750.624937506255;268633;269486;271318;272483.999999998;272499;51670;60898;61299.6935015331;61489.69255153696;61537.69231153816;54706.45293547093;65760;67445.66277168583;67586.98619520711;67972.660136699;12881.742365152644;12961.41673624689;13030.80453793194;13039.934800325938;13054.34728263602;9131.908680913239;9230.446173229628;9241.815163696689;9252;9263.629454821867;20117.899410502854;20734.481637959172;20774;20810.375688729364;20839.8958005209;7835.216478352233;7930.365570754326;8114.837703245902;8184.959075204586;8199.098099209083;973.4840534516718;982.1749730226644;989.4854675568664;1008.5763979128784;1034.813733527957;28788.568171477444;29150.708492915222;29592.852035740114;32946.3410731784;33005.17487062795;1032.2980373346047;1063.9946800266105;1105.8009558279587;1105.9170562207867;1113.7939481196004;15059.698806023818;15133.470328538448;15340.539783806504;15523.379064837505;15647.452339168301;388119;388748;389854;390050;390168;56063.878722425325;56065.439345606836;56259.71870140623;56323.71838140865;56353.71823140858;1305.8041293805816;1326.1247576599399;1329.2024785128845;1341.9194848309132;1342.02703040295;28425.43149137047;28979;29437.705622943497;29455.410891782474;29658.851705741334;47610.285845713035;47753.522464776295;47761;48147.5185248143;48165.75917120392;307655;308833;309370;310806;311459;32949.83525082455;45686.28921384827;45721.77139114283;46698;46827;44817.327740083274;44861.551384487044;45043.77478112588;45304.37564994858;45376.09247815091;36985.630143699294;37157.442638359906;41386.58613413827;41558.79220603878;42389.576104238564;37331;37732.24535509219;38058.809705951295;38698.4195237066;39020;37130.25739485141;37344.066398340256;37574.06064848401;37766.811165944;37835.62164378321;33809.66190338164;36366.818165909004;38864.80567597144;39064.41403379008;39286.60713392829;26002.739972600033;26385.868070659522;26525;26572.202833915013;26732.599011014463 15:10:49 INFO - 2015-11-18 15:10:49,477 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.79890462436424;354.26666799724563;357.07695606856277;360.310006337863;361.5137639874369;12581.748365032694;13040.152390094661;16475.67048659026;16788.244528996194;17416;11656.067514598833;11684.649460516199;11734;12013.219140755844;12155.999999999978;4404.581564751352;4519.435070616173;4521;4528.43394575678;4540.500544940054;4368.497622773374;4476.149531589004;4494.640428765691;4499;4505.594496495315;4525.818967241306;4528.456585209779;4685.36747539083;4793.376861008064;4796.83211087612;4831.806727730886;4842.322074909515;4871.147549178897;4877.122118018738;4893.8287159949405;4126.793660316972;4170.061736109351;4191.077962848169;4200;4205.285101532716;13605.455781768718;13638.386272617756;13732.038757286993;13861.376238069312;13890.23603701796;1984.9206031758713;2008.939731808048;2028.4928767808049;2057.300517823947;2101.0860275780083;10015.89984100157;10079.395236285847;10169.186465082776;10296.073353398155;10303.948480257626;1659.659769747211;1669.3906724045758;1670.6742185273877;1679.512941247037;1692.0609061970601;58280.70859645717;59625.105623415686;59734;59866;59869.401305986816;6800.149981252343;6933.68798404073;7031.613261270679;7083.5041547091205;7117.75087871922;8456.830863382698;8512.957435212784;8516.233538981522;8532.402731808837;8534.402591818513;5193;5266.868328291824;5379.273798037293;5400.054990376747;5417.241586177938;5252.921206181911;5266.657667251617;5299.3905700844125;5312.9734351328;5331.786728530816;3273.214428537134;3317.668233176663;3337.8331083445732;3340.265141668829;3353.094664440587;1157.5543415784985;1160.825876118572;1161.35544772652;1166.6033548593518;1220.8657047724744;390.31304903369704;403.2600178672111;408.4282005192754;411.79410294852573;428.05827180203676;9830.459324737209;10219.386836789668;10465;10789.56841726338;11182.32906025641;413.1241767453019;414.7014149812191;443.5032763305119;443.63400194839386;480.29156993434407;5909;5964.493018093423;5993.820185394445;6036.215292012098;6126.571140020156;459890;459964;468585;468719;469458;74995;77260.61369693115;77401.6129919358;78961.65710885957;80469;464.85821824343225;470.4848191230597;470.5858844217067;471.8112754898;472.46611329198475;10229;10257.640982565574;10357.689269321932;10429.426381549089;11023.338599684044;32941.67058329386;33158.66841331556;33370.33259334848;33743.66256337504;33770;41078;42118.789406052776;42534.57465425306;43469.56530434655;43721.34417983669;6778;6810.489213308922;6870.519063665495;6878.071460352989;6890.827729306808;11902.583409580624;12642.051846111763;12846.164999275017;12868.742625147257;12903.225806451643;10753;10800.567977280822;10862.891371086187;10871.728206794893;11061.5022323994;10597.62908298206;10727.892721072689;11033;11040.779184416428;11052.447377630926;10964.945175274073;11252;11318;11333.886661133283;11440.427978601203;6918.481113916577;6920.861582768417;6995.650217489004;7005.439564834699;7019.754308599175;10658.413787241467;10829.079528240189;10900.836487452852;10962.671119866416;11043.337399756041 15:10:49 INFO - 2015-11-18 15:10:49,478 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1505.4881340344282;1692.1285537947958;1746.0833062642112;1772.7961284452292;1787.8301561351668;7070.15158181019;7085.1497820261575;7207.675654595542;7238.891416628741;7264.382527485163;7276.272372762721;7296.489245752799;7318.707251709939;7372;7399.667014984325;2270.94322641934;2300.7469178390365;2307.7576854430295;2310.9653355199684;2311.167979527369;2279.9658005129936;2301.1830800065986;2323.2217207235512;2324.7094113235844;2329.4875127472014;2216.6342553478657;2232.2968264996557;2258.3789457899043;2270.591293567157;2273.124846933934;2251.3583628665915;2280.4982903761147;2310.0297874892503;2315.1086831569796;2317.4669825940127;2241.0923575951765;2312.3294244669028;2315.4674424882373;2317.4901521665206;2319.826013049011;7344.449166312548;7370.631468426557;7416.629168541605;7417;7429.8885516716755;4584.6561507887045;4643.535646435364;4654.650901182391;4669.743164125972;4679.508651591602;3089.1504836170006;3119.23578723212;3223.113643747988;3229.4832826747843;3239.1092449576317;1116.5198964445285;1125.3810404277615;1129.5368898751556;1137.5212224108625;1212.1514939542267;9992.750181245454;10083.142932850717;10086.394816311045;10088;10098.343607665478;4031.3952907064177;4130.607592278729;4135.152293779768;4152.1072969311745;4224.619784219435;8156.143604921516;8157.75526734199;8204.138565450661;8209.302209312156;8218.21926916942;4558.475775285819;4562.726236425825;4587.541245875385;4588.678792484561;4609.055143695535;4082.1427500225286;4098.180363927227;4113.91772164555;4115.58844115592;4119.526254480713;3354.647761985005;3412.675795799395;3413.573303337083;3425.1950791563963;3434.9313013739584;1053.694428615693;1054.778496515725;1056.5668076088766;1060.0830281806336;1064.2177999170603;988.19462138357;1044.796264728386;1048.6906362623045;1055.0662663542666;1083.1930211992117;7045.471589630798;7058.258882817333;7065.50541462103;7076.32774886385;7080.539764915264;710.573655806512;725.0791494801573;725.3942957630333;733.5818583407513;836.3727204596553;5342;5439.5920305976415;5447.53695935842;5457.863553411196;5474.343078830566;8597.5701214939;9009.774755631031;9012.684556040507;9030.096990300917;9134.269258459308;8806.471611703319;8906.821863562693;8950.239229665422;8968.372213945091;8969.955150224338;6795.116634837538;6804.455643548603;6818.659067046628;6845.691943862538;6851.9657401712675;6634.734610615521;6643.767468138785;6667.266600674019;6670.799876003728;6695.296993815579;7707.691692332244;7969.561674107979;8029.076656184614;8044.718434854752;8070.435069545076;7944.285014348737;7946.483478574106;7947.125816160334;7954.482958607672;7984.081830589556;6193.752249909953;6227.875442491216;6289.685515724287;6380.3619638035825;6385.201849768779;7034.648267586703;7065.046218760402;7087.574745515286;7091.751788687371;7101.325374089453;6572.671366431564;6735.62954037513;6821.1814582250445;6838.521303508706;6891.620960847202;5687;6363.713632886439;6673.399394054559;6721.495887808336;6742.022406751092;6584.341565843377;6723.125993620798;6760.830979225559;6826.419754320938;6851.45188384918;5952.76188952437;6102.420270074336;6110.358412366638;6118.449339559283;6133.693315334126;6154.076888466766;6425.935740642533;6426.29310775805;6447.226332839901;6454.870902582016 15:10:49 INFO - 2015-11-18 15:10:49,480 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.5889035930984;344.1018940565126;344.1430837215333;344.85171376308193;348.82384395880075;6161.845953851145;6187.5668703190795;6266.592671476356;6289.811305660832;6405.455536279422;6204.689765511729;6245.063240513914;6278.372162783719;6280.214973128359;6287.497000239981;4730.124926888528;4776.617870570346;4780.880477988061;4792.856214313576;4795.304680821278;4780.259059845712;4782.78477468513;4785.353977213083;4793.7842797074045;4804.183288840905;4643.303504474322;4738.265568836819;4750.76246187691;4757;4759.762011899391;4724.480307166209;4728.763561821896;4730.97634511827;4738.573528382445;4766.332713420124;4084.5915408459214;4093.6520395766397;4094.508658960914;4108;4113.1568028554375;5919.674417907014;5939.020061689816;5942.078977758454;5951.761929522814;5959.642421454727;5388.838334849961;5487.98472282629;5532.806351777709;5535.280413546254;5546.084895992157;6610.669466526702;6661.76683816069;6676.666166691694;6685.799426017179;6689.397954184098;4554.8861278467975;4569.657275704336;4577.931331030038;4582.083583283324;4587.79354929029;6747.831304217434;6864.1762988441205;6898.758543451006;6915.51591388608;6940.063091482636;4618.67669263155;4623.237165867661;4638.721676699409;4638.744869032168;4661.091087238024;4707.199776038082;4719.4100737407825;4720.787564559603;4726.527347265314;4728.71627702339;5474.7810087596845;5482.945170548243;5487.945120548823;5514.338279406497;5515.944840551623;6600.402780484647;6630.668466576652;6689.933100669028;6741.426978706865;6743.494237932175;1632.2246932707108;1656.989236565694;1675.7151284281701;1676.9496915092566;1678.261564911435;1083.6911480228098;1093.9343639381502;1105.5909313554037;1126.9969726943027;1136.7158210447387;6378.266499352541;6410.878096333123;6428.292887782341;6432.2281326241155;6441.227052753606;6823.078884350648;6836.487263455261;6842.384185423236;6843.178818541707;6844.760433384808;6394.328595497499;6424.903626445607;6439.098526206335;6439.9356006440275;6452.032195170762;3770.71719621024;3803.972927309611;3804.524434445694;3806.695464362844;3810.8285127169343;7260.41916646667;7269.927300726925;7313.634318284065;7333.88999165013;7337.0828646419195;6933.0986971693355;7119.679614417364;7124.679389427488;7173.641317934187;7183.676734546958;7240.09498812659;7247.710091596277;7287.6356182190675;7288.234735352712;7320;6942.444604431735;6967.96516017437;6970.093887794555;6984.057152284579;6988.440924726111;6692.263850976291;6868.7252509901045;6880.58716477013;6882.208546017272;6899.827504312432;7238.27617238272;7261.491695581259;7270.563766174047;7270.89093663606;7295;4648.34923110758;4678.8362407316945;4684.765761711969;4702.083093796677;4703.459102203154;6770.52606317553;6806.591604503746;6931.826704332432;6988.266232045766;6996.895046574407;6720.563163394364;6728.629925354153;6752.5948443093575;6753.932460675331;6766.255711871591;6706.6981985811735;6723.562968407038;6724.462043036643;6725.159355080615;6725.461963042847;6497.805065848032;6561.671916404256;6595.538312318092;6597.80206593803;6617.874961256502;6717.529772916045;6721.663916804043;6727.730890764315;6734.966325168343;6762.222344430454;6542.247641521286;6573.506986976092;6577.638229897401;6581.868362632625;6631.535792494479 15:10:49 INFO - 2015-11-18 15:10:49,483 DEBUG : BROWSER_OUTPUT: |5;yui.html;746.6416120262274;776.9922300776998;788.3889985261421;801.3989507869098;855.7176131876481;13634.659133521667;13938.790918136236;13973.580792576213;14141.15153090814;14184.432622695093;13058.934705326485;13075.476980920776;13104.541341053065;13157.868421315785;13159.60521184366;788.6845261895259;798.2137594469443;804.2962407893093;816.0533780814256;817.6729308276707;799.8800179973022;801.6633014134078;806.379088102161;806.5160903457937;809.0574480729942;838.2497664590188;840.5881118252073;841.7264389073545;842.4313588327885;848.1391387741417;831.5509624802569;834.5743670727911;835.2691395029349;838.3712215838121;840.3613253926999;612.7732738886596;614.3150387318108;617.0312609203552;617.527591392585;618.35073173168;12920.612381628565;13051.804222936664;13130.540431084866;13145.474181032747;13156.276404797733;9784.804303913881;9915;10240.590376384936;10496.52765625541;10824.025837674568;9933.850992235122;9954.9502252489;10026.49867506629;10308.79382412355;10569.365838049665;3238.8218647974354;3280.1963518938014;3303.223742420529;3305.3058857639926;3364.9831750841336;45087.77456112731;45312.3203151953;45475.54524454746;45526.040807347745;45723;7337.853242935218;7368.852622947618;7473.738419155304;7595.164531901486;7597.658105385271;12379.504819807287;12390.31853248062;12392.070594705252;12404.19372740769;12430;6407.038944158414;6500.967495162588;6535.869282614416;6576.572522786004;6591.307912669101;4094.754314741125;4123.175364927027;4127.855525056609;4163.458750362433;4166.0834616384345;2727.7135900730536;2753.4630747004144;2754.325190328342;2761.1578468566877;2770.4320614274025;430.1654789707957;437.65862627150875;443.8158164361754;446.6471487524819;448.24470766758117;623.4607064888838;682.6825526130274;685.7428464325877;706.3113464372196;720.8558288342352;7581.50720203185;7992.200779921961;8180.345572354197;8287.778357041829;8449.281811046007;568.2640979930999;664.0868805392586;665.8834703926793;685.9519833611699;720.1502227371751;3840.347140986039;3905.414187871842;4037.9192416151513;4077.918441631151;4103.862194739155;57287.713561432756;57631.71184144053;58814.41185588089;59426.405735942084;59610.40389596135;51999.74000129975;52005.7399712999;52082;52376.73811630918;52550.737246313525;46779;47123.764381177876;47147.29279060817;47391.763041184575;48158.03683926302;8171.959140204499;8185.590720463834;8374.246317831425;8600.78498037554;8735.868961965449;35267.82366088153;35590.466143008394;35993.28013439664;36524.26951460903;36909.81545092257;45757;47026.52973470358;47125;47382.52617473781;47395;7878.527288362717;7957.442978991647;8108.554029528433;8196.344292456708;8310.958445207736;11255.66233013011;11598.18812683138;11607.941960290145;11614.941925290319;11660.12549058807;10867.510962006887;10952.452377381258;11363.943180284046;11787.528498859949;11911.463984120563;10903.890961090605;11447.484863181344;11735.589254376056;11764.470598822902;11776.411179441166;10839;11260.7747845041;11335.206535542433;11709.76580468403;11753.353565553976;8864.955675221841;9126.361154719107;9151.084891510796;9333.57998890038;9477.620895164391;8832.293416526534;8888.911110888808;8901.33240006989;9476.620935162791;9602.08780165883 15:10:49 INFO - 2015-11-18 15:10:49,483 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:10:49 INFO - 2015-11-18 15:10:49,483 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:10:49 INFO - 2015-11-18 15:10:49,483 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,278 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888249469__endTimestamp 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: Number of tests: 6 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5374.22 Median:5589.75 stddev:586.47 (10.5%) stddev-sans-first:563.08 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: Values: 3206.7 3245.4 3268.0 3283.4 3298.3 5210.8 5344.7 5350.6 5373.5 5385.4 5300.7 5301.2 5313.5 5425.8 5439.1 4900.3 4945.0 4969.6 5007.1 5043.3 4887.2 4960.3 4971.2 5011.8 5038.3 4716.3 4768.2 4868.2 4923.6 4947.5 4969.3 4976.7 4997.0 5000.3 5043.2 4954.4 4977.9 4992.5 4994.7 5022.3 5004.7 5087.2 5135.8 5143.1 5149.8 5830.0 5844.3 5858.3 5859.4 5869.6 5662.1 5896.3 5917.2 5917.6 5925.3 5349.4 5360.3 5364.0 5366.3 5377.8 5794.5 5876.9 5878.4 5880.3 5925.1 5684.1 5687.9 5701.6 5718.6 5727.3 5506.3 5627.2 5646.5 5797.4 5807.9 5701.5 5738.5 5762.7 5781.0 5783.1 5714.7 5737.1 5753.1 5754.7 5762.6 4304.7 4413.2 4414.3 4485.4 4516.8 3983.4 3994.5 4015.6 4019.8 4029.1 5551.7 5568.8 5580.3 5584.4 5609.4 5634.7 5662.4 5692.1 5736.7 5776.1 5502.7 5562.8 5596.3 5609.2 5626.8 4974.8 5081.8 5093.5 5095.6 5126.0 5875.3 5892.8 5906.0 5923.9 6027.3 5724.8 5752.5 5767.8 5773.9 5787.8 5983.2 5999.1 6005.4 6008.6 6009.8 5459.9 5551.1 5635.4 5708.7 5711.7 5862.5 5862.7 5863.0 5867.6 5888.1 5668.6 5705.1 5713.4 5714.4 5718.0 5568.4 5585.6 5673.6 5696.0 5712.0 5513.2 5563.8 5592.4 5624.9 5652.2 5700.9 5706.8 5728.0 5737.9 5754.9 5345.1 5451.8 5479.5 5556.9 5589.7 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50035.95 Median:39157.42 stddev:85826.55 (219.2%) stddev-sans-first:85987.00 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: Values: 585.2 586.9 595.7 602.4 606.7 39193.8 40083.8 40150.6 40202.8 40325.4 43071.4 43909.6 43996.8 44050.0 44062.0 8722.4 8816.2 8829.3 8852.3 8869.6 8567.6 8648.8 8657.9 8665.7 8688.4 8599.5 8705.3 8713.2 8730.5 8740.0 8671.2 8748.7 8764.8 8780.2 8795.3 8543.5 8621.1 8647.8 8649.0 8661.4 38911.4 39121.0 39354.2 39367.0 39384.4 3209.7 3244.8 3277.7 3315.2 3362.9 30407.8 30963.2 31367.5 31557.5 32579.5 3551.9 3623.8 3645.1 3714.5 3750.6 268633.0 269486.0 271318.0 272484.0 272499.0 51670.0 60898.0 61299.7 61489.7 61537.7 54706.5 65760.0 67445.7 67587.0 67972.7 12881.7 12961.4 13030.8 13039.9 13054.3 9131.9 9230.4 9241.8 9252.0 9263.6 20117.9 20734.5 20774.0 20810.4 20839.9 7835.2 7930.4 8114.8 8185.0 8199.1 973.5 982.2 989.5 1008.6 1034.8 28788.6 29150.7 29592.9 32946.3 33005.2 1032.3 1064.0 1105.8 1105.9 1113.8 15059.7 15133.5 15340.5 15523.4 15647.5 388119.0 388748.0 389854.0 390050.0 390168.0 56063.9 56065.4 56259.7 56323.7 56353.7 1305.8 1326.1 1329.2 1341.9 1342.0 28425.4 28979.0 29437.7 29455.4 29658.9 47610.3 47753.5 47761.0 48147.5 48165.8 307655.0 308833.0 309370.0 310806.0 311459.0 32949.8 45686.3 45721.8 46698.0 46827.0 44817.3 44861.6 45043.8 45304.4 45376.1 36985.6 37157.4 41386.6 41558.8 42389.6 37331.0 37732.2 38058.8 38698.4 39020.0 37130.3 37344.1 37574.1 37766.8 37835.6 33809.7 36366.8 38864.8 39064.4 39286.6 26002.7 26385.9 26525.0 26572.2 26732.6 15:10:49 INFO - 2015-11-18 15:10:49,484 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,485 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24600.80 Median:413.91 stddev:76452.14 (18470.6%) stddev-sans-first:76644.93 15:10:49 INFO - 2015-11-18 15:10:49,486 DEBUG : BROWSER_OUTPUT: Values: 352.8 354.3 357.1 360.3 361.5 12581.7 13040.2 16475.7 16788.2 17416.0 11656.1 11684.6 11734.0 12013.2 12156.0 4404.6 4519.4 4521.0 4528.4 4540.5 4368.5 4476.1 4494.6 4499.0 4505.6 4525.8 4528.5 4685.4 4793.4 4796.8 4831.8 4842.3 4871.1 4877.1 4893.8 4126.8 4170.1 4191.1 4200.0 4205.3 13605.5 13638.4 13732.0 13861.4 13890.2 1984.9 2008.9 2028.5 2057.3 2101.1 10015.9 10079.4 10169.2 10296.1 10303.9 1659.7 1669.4 1670.7 1679.5 1692.1 58280.7 59625.1 59734.0 59866.0 59869.4 6800.1 6933.7 7031.6 7083.5 7117.8 8456.8 8513.0 8516.2 8532.4 8534.4 5193.0 5266.9 5379.3 5400.1 5417.2 5252.9 5266.7 5299.4 5313.0 5331.8 3273.2 3317.7 3337.8 3340.3 3353.1 1157.6 1160.8 1161.4 1166.6 1220.9 390.3 403.3 408.4 411.8 428.1 9830.5 10219.4 10465.0 10789.6 11182.3 413.1 414.7 443.5 443.6 480.3 5909.0 5964.5 5993.8 6036.2 6126.6 459890.0 459964.0 468585.0 468719.0 469458.0 74995.0 77260.6 77401.6 78961.7 80469.0 464.9 470.5 470.6 471.8 472.5 10229.0 10257.6 10357.7 10429.4 11023.3 32941.7 33158.7 33370.3 33743.7 33770.0 41078.0 42118.8 42534.6 43469.6 43721.3 6778.0 6810.5 6870.5 6878.1 6890.8 11902.6 12642.1 12846.2 12868.7 12903.2 10753.0 10800.6 10862.9 10871.7 11061.5 10597.6 10727.9 11033.0 11040.8 11052.4 10964.9 11252.0 11318.0 11333.9 11440.4 6918.5 6920.9 6995.7 7005.4 7019.8 10658.4 10829.1 10900.8 10962.7 11043.3 15:10:49 INFO - 2015-11-18 15:10:49,486 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,486 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5192.88 Median:6210.81 stddev:2624.41 (42.3%) stddev-sans-first:2617.13 15:10:49 INFO - 2015-11-18 15:10:49,487 DEBUG : BROWSER_OUTPUT: Values: 1505.5 1692.1 1746.1 1772.8 1787.8 7070.2 7085.1 7207.7 7238.9 7264.4 7276.3 7296.5 7318.7 7372.0 7399.7 2270.9 2300.7 2307.8 2311.0 2311.2 2280.0 2301.2 2323.2 2324.7 2329.5 2216.6 2232.3 2258.4 2270.6 2273.1 2251.4 2280.5 2310.0 2315.1 2317.5 2241.1 2312.3 2315.5 2317.5 2319.8 7344.4 7370.6 7416.6 7417.0 7429.9 4584.7 4643.5 4654.7 4669.7 4679.5 3089.2 3119.2 3223.1 3229.5 3239.1 1116.5 1125.4 1129.5 1137.5 1212.2 9992.8 10083.1 10086.4 10088.0 10098.3 4031.4 4130.6 4135.2 4152.1 4224.6 8156.1 8157.8 8204.1 8209.3 8218.2 4558.5 4562.7 4587.5 4588.7 4609.1 4082.1 4098.2 4113.9 4115.6 4119.5 3354.6 3412.7 3413.6 3425.2 3434.9 1053.7 1054.8 1056.6 1060.1 1064.2 988.2 1044.8 1048.7 1055.1 1083.2 7045.5 7058.3 7065.5 7076.3 7080.5 710.6 725.1 725.4 733.6 836.4 5342.0 5439.6 5447.5 5457.9 5474.3 8597.6 9009.8 9012.7 9030.1 9134.3 8806.5 8906.8 8950.2 8968.4 8970.0 6795.1 6804.5 6818.7 6845.7 6852.0 6634.7 6643.8 6667.3 6670.8 6695.3 7707.7 7969.6 8029.1 8044.7 8070.4 7944.3 7946.5 7947.1 7954.5 7984.1 6193.8 6227.9 6289.7 6380.4 6385.2 7034.6 7065.0 7087.6 7091.8 7101.3 6572.7 6735.6 6821.2 6838.5 6891.6 5687.0 6363.7 6673.4 6721.5 6742.0 6584.3 6723.1 6760.8 6826.4 6851.5 5952.8 6102.4 6110.4 6118.4 6133.7 6154.1 6425.9 6426.3 6447.2 6454.9 15:10:49 INFO - 2015-11-18 15:10:49,488 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,488 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5584.62 Median:6399.89 stddev:1710.38 (26.7%) stddev-sans-first:1669.18 15:10:49 INFO - 2015-11-18 15:10:49,488 DEBUG : BROWSER_OUTPUT: Values: 335.6 344.1 344.1 344.9 348.8 6161.8 6187.6 6266.6 6289.8 6405.5 6204.7 6245.1 6278.4 6280.2 6287.5 4730.1 4776.6 4780.9 4792.9 4795.3 4780.3 4782.8 4785.4 4793.8 4804.2 4643.3 4738.3 4750.8 4757.0 4759.8 4724.5 4728.8 4731.0 4738.6 4766.3 4084.6 4093.7 4094.5 4108.0 4113.2 5919.7 5939.0 5942.1 5951.8 5959.6 5388.8 5488.0 5532.8 5535.3 5546.1 6610.7 6661.8 6676.7 6685.8 6689.4 4554.9 4569.7 4577.9 4582.1 4587.8 6747.8 6864.2 6898.8 6915.5 6940.1 4618.7 4623.2 4638.7 4638.7 4661.1 4707.2 4719.4 4720.8 4726.5 4728.7 5474.8 5482.9 5487.9 5514.3 5515.9 6600.4 6630.7 6689.9 6741.4 6743.5 1632.2 1657.0 1675.7 1676.9 1678.3 1083.7 1093.9 1105.6 1127.0 1136.7 6378.3 6410.9 6428.3 6432.2 6441.2 6823.1 6836.5 6842.4 6843.2 6844.8 6394.3 6424.9 6439.1 6439.9 6452.0 3770.7 3804.0 3804.5 3806.7 3810.8 7260.4 7269.9 7313.6 7333.9 7337.1 6933.1 7119.7 7124.7 7173.6 7183.7 7240.1 7247.7 7287.6 7288.2 7320.0 6942.4 6968.0 6970.1 6984.1 6988.4 6692.3 6868.7 6880.6 6882.2 6899.8 7238.3 7261.5 7270.6 7270.9 7295.0 4648.3 4678.8 4684.8 4702.1 4703.5 6770.5 6806.6 6931.8 6988.3 6996.9 6720.6 6728.6 6752.6 6753.9 6766.3 6706.7 6723.6 6724.5 6725.2 6725.5 6497.8 6561.7 6595.5 6597.8 6617.9 6717.5 6721.7 6727.7 6735.0 6762.2 6542.2 6573.5 6577.6 6581.9 6631.5 15:10:49 INFO - 2015-11-18 15:10:49,488 DEBUG : BROWSER_OUTPUT: 15:10:49 INFO - 2015-11-18 15:10:49,488 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13413.79 Median:50078.89 stddev:16234.19 (32.4%) stddev-sans-first:16251.86 15:10:49 INFO - 2015-11-18 15:10:49,490 DEBUG : BROWSER_OUTPUT: Values: 746.6 777.0 788.4 801.4 855.7 13634.7 13938.8 13973.6 14141.2 14184.4 13058.9 13075.5 13104.5 13157.9 13159.6 788.7 798.2 804.3 816.1 817.7 799.9 801.7 806.4 806.5 809.1 838.2 840.6 841.7 842.4 848.1 831.6 834.6 835.3 838.4 840.4 612.8 614.3 617.0 617.5 618.4 12920.6 13051.8 13130.5 13145.5 13156.3 9784.8 9915.0 10240.6 10496.5 10824.0 9933.9 9955.0 10026.5 10308.8 10569.4 3238.8 3280.2 3303.2 3305.3 3365.0 45087.8 45312.3 45475.5 45526.0 45723.0 7337.9 7368.9 7473.7 7595.2 7597.7 12379.5 12390.3 12392.1 12404.2 12430.0 6407.0 6501.0 6535.9 6576.6 6591.3 4094.8 4123.2 4127.9 4163.5 4166.1 2727.7 2753.5 2754.3 2761.2 2770.4 430.2 437.7 443.8 446.6 448.2 623.5 682.7 685.7 706.3 720.9 7581.5 7992.2 8180.3 8287.8 8449.3 568.3 664.1 665.9 686.0 720.2 3840.3 3905.4 4037.9 4077.9 4103.9 57287.7 57631.7 58814.4 59426.4 59610.4 51999.7 52005.7 52082.0 52376.7 52550.7 46779.0 47123.8 47147.3 47391.8 48158.0 8172.0 8185.6 8374.2 8600.8 8735.9 35267.8 35590.5 35993.3 36524.3 36909.8 45757.0 47026.5 47125.0 47382.5 47395.0 7878.5 7957.4 8108.6 8196.3 8311.0 11255.7 11598.2 11607.9 11614.9 11660.1 10867.5 10952.5 11363.9 11787.5 11911.5 10903.9 11447.5 11735.6 11764.5 11776.4 10839.0 11260.8 11335.2 11709.8 11753.4 8865.0 9126.4 9151.1 9333.6 9477.6 8832.3 8888.9 8901.3 9476.6 9602.1 15:10:49 INFO - 2015-11-18 15:10:49,490 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:10:49 INFO - 2015-11-18 15:10:49,490 DEBUG : BROWSER_OUTPUT: 15:10:50 INFO - 2015-11-18 15:10:50,037 INFO : Browser exited with error code: 0 15:10:50 INFO - 2015-11-18 15:10:50,054 INFO : Completed test dromaeo_css (00:18:30) 15:10:50 INFO - 2015-11-18 15:10:50,054 INFO : Starting test kraken 15:10:50 INFO - 2015-11-18 15:10:50,055 DEBUG : operating with platform_type : linux_ 15:10:50 INFO - 2015-11-18 15:10:50,055 INFO : Initialising browser for kraken test... 15:10:50 INFO - 2015-11-18 15:10:50,061 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNck9HM/profile http://localhost:44927/getInfo.html 15:10:54 INFO - 2015-11-18 15:10:54,622 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:10:54 INFO - 2015-11-18 15:10:54,622 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:10:54 INFO - 2015-11-18 15:10:54,622 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:10:54 INFO - 2015-11-18 15:10:54,622 DEBUG : BROWSER_OUTPUT: __metrics 15:10:55 INFO - 2015-11-18 15:10:55,619 INFO : Browser initialized. 15:10:55 INFO - 2015-11-18 15:10:55,619 INFO : Running cycle 1/1 for kraken test... 15:10:55 INFO - 2015-11-18 15:10:55,619 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNck9HM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:11:07 INFO - 2015-11-18 15:11:07,406 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 15:11:07 INFO - 2015-11-18 15:11:07,406 DEBUG : BROWSER_OUTPUT: 15:11:09 INFO - 2015-11-18 15:11:09,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:10 INFO - 2015-11-18 15:11:10,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 141529088 15:11:10 INFO - 2015-11-18 15:11:10,516 DEBUG : BROWSER_OUTPUT: 15:11:13 INFO - 2015-11-18 15:11:13,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-dft) 15:11:13 INFO - 2015-11-18 15:11:13,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 141918208 15:11:13 INFO - 2015-11-18 15:11:13,779 DEBUG : BROWSER_OUTPUT: 15:11:16 INFO - 2015-11-18 15:11:16,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-fft) 15:11:17 INFO - 2015-11-18 15:11:17,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 135815168 15:11:17 INFO - 2015-11-18 15:11:17,226 DEBUG : BROWSER_OUTPUT: 15:11:19 INFO - 2015-11-18 15:11:19,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44927/tests/kraken/driver.html?testName=audio-oscillator) 15:11:20 INFO - 2015-11-18 15:11:20,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 136556544 15:11:20 INFO - 2015-11-18 15:11:20,135 DEBUG : BROWSER_OUTPUT: 15:11:22 INFO - 2015-11-18 15:11:22,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:11:22 INFO - 2015-11-18 15:11:22,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 137949184 15:11:22 INFO - 2015-11-18 15:11:22,879 DEBUG : BROWSER_OUTPUT: 15:11:25 INFO - 2015-11-18 15:11:25,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-darkroom) 15:11:26 INFO - 2015-11-18 15:11:26,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 138289152 15:11:26 INFO - 2015-11-18 15:11:26,430 DEBUG : BROWSER_OUTPUT: 15:11:29 INFO - 2015-11-18 15:11:29,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44927/tests/kraken/driver.html?testName=imaging-desaturate) 15:11:30 INFO - 2015-11-18 15:11:30,410 DEBUG : BROWSER_OUTPUT: RSS: Main: 138498048 15:11:30 INFO - 2015-11-18 15:11:30,410 DEBUG : BROWSER_OUTPUT: 15:11:33 INFO - 2015-11-18 15:11:33,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44927/tests/kraken/driver.html?testName=json-parse-financial) 15:11:33 INFO - 2015-11-18 15:11:33,886 DEBUG : BROWSER_OUTPUT: RSS: Main: 139161600 15:11:33 INFO - 2015-11-18 15:11:33,886 DEBUG : BROWSER_OUTPUT: 15:11:35 INFO - 2015-11-18 15:11:35,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:11:36 INFO - 2015-11-18 15:11:36,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 15:11:36 INFO - 2015-11-18 15:11:36,061 DEBUG : BROWSER_OUTPUT: 15:11:37 INFO - 2015-11-18 15:11:37,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:11:38 INFO - 2015-11-18 15:11:38,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 139194368 15:11:38 INFO - 2015-11-18 15:11:38,500 DEBUG : BROWSER_OUTPUT: 15:11:40 INFO - 2015-11-18 15:11:40,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:11:41 INFO - 2015-11-18 15:11:41,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 139743232 15:11:41 INFO - 2015-11-18 15:11:41,179 DEBUG : BROWSER_OUTPUT: 15:11:43 INFO - 2015-11-18 15:11:43,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:11:44 INFO - 2015-11-18 15:11:44,247 DEBUG : BROWSER_OUTPUT: RSS: Main: 140140544 15:11:44 INFO - 2015-11-18 15:11:44,248 DEBUG : BROWSER_OUTPUT: 15:11:46 INFO - 2015-11-18 15:11:46,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:11:47 INFO - 2015-11-18 15:11:47,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 15:11:47 INFO - 2015-11-18 15:11:47,423 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44927/tests/kraken/driver.html?testName=ai-astar) 15:11:49 INFO - 2015-11-18 15:11:49,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 139526144 15:11:49 INFO - 2015-11-18 15:11:49,347 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;114;112;113;124;113;112;115;113 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;125;159;165;125;160;164;131;169;128 15:11:49 INFO - 2015-11-18 15:11:49,348 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;163;163;162;163;162;166;168;163 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;74;75;72;73;73;157;72;73 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;132;90;91;91;142;92;91;132 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;109;110;109;110;109;110;110;110 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;146;146;145;147;146;147;146;146 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;95;96;96;96 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;64;64;62;63;62;63;60;66 15:11:49 INFO - 2015-11-18 15:11:49,349 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;68;69;69;69;68;69;69 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;93;84;86;88;87;88;94;87;86;88 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;120;131;126;119;119;121;120;123;117 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;161;154;138;150;149;154;149;153;150 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;69;66;67;67;67;68;66;68 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: __start_cc_report 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,725 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: __end_cc_report 15:11:49 INFO - 2015-11-18 15:11:49,350 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888309345__endTimestamp 15:11:49 INFO - 2015-11-18 15:11:49,351 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: Number of tests: 14 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.90 (3.4%) stddev-sans-first:4.14 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 114.0 112.0 113.0 124.0 113.0 112.0 115.0 113.0 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:159.50 stddev:18.33 (11.5%) stddev-sans-first:19.35 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: Values: 153.0 125.0 159.0 165.0 125.0 160.0 164.0 131.0 169.0 128.0 15:11:49 INFO - 2015-11-18 15:11:49,352 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:1.89 (1.2%) stddev-sans-first:1.99 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 163.0 163.0 162.0 163.0 162.0 166.0 168.0 163.0 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:73.00 stddev:26.54 (36.4%) stddev-sans-first:27.97 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 74.0 75.0 72.0 73.0 73.0 157.0 72.0 73.0 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,353 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:91.00 stddev:21.53 (23.7%) stddev-sans-first:22.36 15:11:49 INFO - 2015-11-18 15:11:49,354 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 132.0 90.0 91.0 91.0 142.0 92.0 91.0 132.0 15:11:49 INFO - 2015-11-18 15:11:49,354 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,354 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 15:11:49 INFO - 2015-11-18 15:11:49,354 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 110.0 110.0 15:11:49 INFO - 2015-11-18 15:11:49,355 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,355 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:1.08 (0.7%) stddev-sans-first:0.67 15:11:49 INFO - 2015-11-18 15:11:49,355 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 146.0 146.0 145.0 147.0 146.0 147.0 146.0 146.0 15:11:49 INFO - 2015-11-18 15:11:49,355 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,356 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:11:49 INFO - 2015-11-18 15:11:49,356 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 15:11:49 INFO - 2015-11-18 15:11:49,356 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.56 (2.5%) stddev-sans-first:1.66 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 64.0 64.0 62.0 63.0 62.0 63.0 60.0 66.0 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 69.0 69.0 69.0 68.0 69.0 69.0 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:3.11 (3.5%) stddev-sans-first:2.74 15:11:49 INFO - 2015-11-18 15:11:49,357 DEBUG : BROWSER_OUTPUT: Values: 93.0 84.0 86.0 88.0 87.0 88.0 94.0 87.0 86.0 88.0 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.00 stddev:4.09 (3.4%) stddev-sans-first:4.32 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: Values: 123.0 120.0 131.0 126.0 119.0 119.0 121.0 120.0 123.0 117.0 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:151.50 stddev:6.43 (4.2%) stddev-sans-first:6.13 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: Values: 142.0 161.0 154.0 138.0 150.0 149.0 154.0 149.0 153.0 150.0 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 66.0 67.0 67.0 67.0 68.0 66.0 68.0 15:11:49 INFO - 2015-11-18 15:11:49,358 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:11:49 INFO - 2015-11-18 15:11:49,359 DEBUG : BROWSER_OUTPUT: 15:11:50 INFO - 2015-11-18 15:11:50,223 INFO : Browser exited with error code: 0 15:11:50 INFO - 2015-11-18 15:11:50,277 INFO : Completed test kraken (00:01:00) 15:11:50 INFO - 2015-11-18 15:11:50,277 INFO : Starting test v8_7 15:11:50 INFO - 2015-11-18 15:11:50,277 DEBUG : operating with platform_type : linux_ 15:11:50 INFO - 2015-11-18 15:11:50,277 INFO : Initialising browser for v8_7 test... 15:11:50 INFO - 2015-11-18 15:11:50,283 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprCy4EQ/profile http://localhost:44927/getInfo.html 15:11:55 INFO - 2015-11-18 15:11:55,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:11:55 INFO - 2015-11-18 15:11:55,189 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:11:55 INFO - 2015-11-18 15:11:55,189 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:11:55 INFO - 2015-11-18 15:11:55,189 DEBUG : BROWSER_OUTPUT: __metrics 15:11:56 INFO - 2015-11-18 15:11:56,327 INFO : Browser initialized. 15:11:56 INFO - 2015-11-18 15:11:56,327 INFO : Running cycle 1/1 for v8_7 test... 15:11:56 INFO - 2015-11-18 15:11:56,327 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprCy4EQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:12:08 INFO - 2015-11-18 15:12:08,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 15:12:08 INFO - 2015-11-18 15:12:08,167 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44927/tests/v8_7/run.html (next: http://localhost:44927/tests/v8_7/run.html) 15:12:29 INFO - 2015-11-18 15:12:29,896 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 15:12:29 INFO - 2015-11-18 15:12:29,897 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,898 DEBUG : BROWSER_OUTPUT: __start_tp_report 15:12:29 INFO - 2015-11-18 15:12:29,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 15:12:29 INFO - 2015-11-18 15:12:29,898 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 15:12:29 INFO - 2015-11-18 15:12:29,898 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 15:12:29 INFO - 2015-11-18 15:12:29,898 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.34880123743233 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.84899233607723 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1068.3760683760684 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |5;Earley;703.7297677691766 15:12:29 INFO - 2015-11-18 15:12:29,899 DEBUG : BROWSER_OUTPUT: |6;Boyer;12011.904761904761 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: |8;Splay;611.7216117216117 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: __end_tp_report 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: __startTimestamp1447888349897__endTimestamp 15:12:29 INFO - 2015-11-18 15:12:29,900 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,901 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 15:12:29 INFO - 2015-11-18 15:12:29,901 DEBUG : BROWSER_OUTPUT: Number of tests: 10 15:12:29 INFO - 2015-11-18 15:12:29,901 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,901 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,901 DEBUG : BROWSER_OUTPUT: Values: 166.0 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.35 Median:193.35 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: Values: 193.3 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.85 Median:283.85 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,902 DEBUG : BROWSER_OUTPUT: Values: 283.8 15:12:29 INFO - 2015-11-18 15:12:29,903 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,903 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,903 DEBUG : BROWSER_OUTPUT: Values: 5065.7 15:12:29 INFO - 2015-11-18 15:12:29,903 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,903 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,904 DEBUG : BROWSER_OUTPUT: Values: 1068.4 15:12:29 INFO - 2015-11-18 15:12:29,904 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,905 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,905 DEBUG : BROWSER_OUTPUT: Values: 703.7 15:12:29 INFO - 2015-11-18 15:12:29,905 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,905 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12011.90 Median:12011.90 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: Values: 12011.9 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: Values: 25100.0 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.72 Median:611.72 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: Values: 611.7 15:12:29 INFO - 2015-11-18 15:12:29,906 DEBUG : BROWSER_OUTPUT: 15:12:29 INFO - 2015-11-18 15:12:29,907 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 15:12:29 INFO - 2015-11-18 15:12:29,907 DEBUG : BROWSER_OUTPUT: Values: 4830.9 15:12:29 INFO - 2015-11-18 15:12:29,907 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 15:12:29 INFO - 2015-11-18 15:12:29,907 DEBUG : BROWSER_OUTPUT: 15:12:30 INFO - 2015-11-18 15:12:30,779 INFO : Browser exited with error code: 0 15:12:30 INFO - 2015-11-18 15:12:30,791 INFO : Completed test v8_7 (00:00:40) 15:12:30 INFO - 2015-11-18 15:12:30,887 INFO : Completed test suite (00:20:11) 15:12:30 INFO - 2015-11-18 15:12:30,887 DEBUG : Working with test: dromaeo_css 15:12:30 INFO - 2015-11-18 15:12:30,887 DEBUG : Generating results file: dromaeo_css 15:12:30 INFO - 2015-11-18 15:12:30,888 DEBUG : Working with test: kraken 15:12:30 INFO - 2015-11-18 15:12:30,889 DEBUG : Generating results file: kraken 15:12:30 INFO - 2015-11-18 15:12:30,889 INFO : javascript benchmark 15:12:30 INFO - 2015-11-18 15:12:30,889 DEBUG : Working with test: v8_7 15:12:30 INFO - 2015-11-18 15:12:30,889 DEBUG : Generating results file: v8_7 15:12:30 INFO - 2015-11-18 15:12:30,889 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:30 INFO - 2015-11-18 15:12:30,934 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 15:12:30 INFO - 2015-11-18 15:12:30,934 DEBUG : process_Request line: dromaeo_css 6666.12 graph.html#tests=[[72,63,43]] 15:12:30 INFO - 2015-11-18 15:12:30,934 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:30 INFO - 2015-11-18 15:12:30,961 DEBUG : process_Request line: kraken 1522.60 graph.html#tests=[[232,63,43]] 15:12:30 INFO - 2015-11-18 15:12:30,961 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:12:30 INFO - 2015-11-18 15:12:30,988 DEBUG : process_Request line: v8_7 21399.66 graph.html#tests=[[230,63,43]] 15:12:30 INFO - 2015-11-18 15:12:30,990 INFO : javascript benchmark 15:12:31 INFO - 2015-11-18 15:12:30,993 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3206.743460523158, 3245.415825151473, 3267.9836600816993, 3283.3925723741104, 3298.290867463495, 5210.843674689765, 5344.652597581155, 5350.598705097119, 5373.489518495741, 5385.35375754909, 5300.681959082458, 5301.1783173608055, 5313.521783039526, 5425.782968681248, 5439.129739241722, 4900.264960255954, 4944.975275123637, 4969.62727795415, 5007.14878470659, 5043.268726034741, 4887.218045112782, 4960.305557221992, 4971.229459433794, 5011.799528018893, 5038.319826823387, 4716.339712440261, 4768.189407800683, 4868.196747536652, 4923.58149557288, 4947.455779864212, 4969.304297398367, 4976.651634385595, 4997.0, 5000.324956130912, 5043.218301163289, 4954.43024052235, 4977.875553111165, 4992.450830408652, 4994.725290109042, 5022.321986531808, 5004.674696144775, 5087.236914462823, 5135.768890399941, 5143.125668636303, 5149.794008239666, 5829.970850145764, 5844.26946631671, 5858.297004359461, 5859.384764599698, 5869.589128760988, 5662.065759149777, 5896.262967129109, 5917.171595976523, 5917.615355001911, 5925.259342582177, 5349.438308977501, 5360.303160589098, 5363.999999999961, 5366.275552800361, 5377.838664840022, 5794.478496935296, 5876.882462350729, 5878.382769809194, 5880.2943646761805, 5925.081612350093, 5684.090545512699, 5687.857803554944, 5701.600887937804, 5718.599698021098, 5727.341355744059, 5506.284183056177, 5627.184058311522, 5646.491815736521, 5797.420257974253, 5807.912881306784, 5701.515371193412, 5738.454846789548, 5762.711864406763, 5781.046127389018, 5783.074708046693, 5714.714264286769, 5737.110747834093, 5753.108268218432, 5754.74103665336, 5762.596618236767, 4304.677149213821, 4413.16149931512, 4414.27164517851, 4485.372047913294, 4516.8193272268745, 3983.42240375144, 3994.460747799068, 4015.6185162409524, 4019.7990100495444, 4029.1146289077733, 5551.666899986014, 5568.805091821767, 5580.330360356783, 5584.385717571064, 5609.4390560943575, 5634.661920284796, 5662.405447428043, 5692.060809966392, 5736.741846616912, 5776.133579963039, 5502.669839809624, 5562.833115006556, 5596.3284405871555, 5609.186667933209, 5626.774929002876, 4974.825881094144, 5081.8475445736685, 5093.465186155475, 5095.617828662865, 5126.000429916131, 5875.265591801025, 5892.823215303548, 5906.0, 5923.940760592425, 6027.276726792726, 5724.771009159587, 5752.539796816328, 5767.769289228551, 5773.884522309614, 5787.797427090031, 5983.162357270073, 5999.070144127667, 6005.429484198994, 6008.639481631116, 6009.819705408845, 5459.945400545944, 5551.084071128219, 5635.380108188178, 5708.714564271853, 5711.714414279352, 5862.530997520103, 5862.706864656665, 5862.970685146547, 5867.647941123546, 5888.146218798336, 5668.603197776281, 5705.087186050212, 5713.428657134254, 5714.399988001366, 5717.971410142923, 5568.387477377566, 5585.636933599303, 5673.574481913791, 5695.971520142372, 5712.0, 5513.228148059355, 5563.77596928675, 5592.412796656456, 5624.943750562442, 5652.180433836988, 5700.885982280414, 5706.828795136153, 5727.971360143172, 5737.942620573908, 5754.856128596819, 5345.118055520796, 5451.8364449065, 5479.4520547944885, 5556.944430555643, 5589.748461319169], "unit": "ms", "name": "dojo.html", "value": 5336.886775407199}, {"lowerIsBetter": false, "replicates": [585.1924344404721, 586.8591538030873, 595.6842873277163, 602.3765402808094, 606.6572386601567, 39193.824185274454, 40083.79958100205, 40150.59849401505, 40202.798986005066, 40325.39511907324, 43071.35392969108, 43909.56090439095, 43996.780016099954, 44050.0, 44062.0, 8722.433041852275, 8816.162464565889, 8829.293656507463, 8852.291816654651, 8869.645214191456, 8567.571621418903, 8648.827023459527, 8657.913420865774, 8665.740027799176, 8688.391812573122, 8599.527026013568, 8705.260052895512, 8713.215810577047, 8730.51982140982, 8739.951205855306, 8671.176238257387, 8748.650053997833, 8764.824703505927, 8780.209781119665, 8795.340349473783, 8543.487390756512, 8621.137886211329, 8647.783805404852, 8649.048604653482, 8661.350398720122, 38911.41632875509, 39121.021974450865, 39354.21291574181, 39367.0, 39384.409233861516, 3209.737160061012, 3244.821534815584, 3277.705006549422, 3315.154635567939, 3362.9159271018175, 30407.847960760275, 30963.22591935197, 31367.529487057713, 31557.52663710046, 32579.51130733041, 3551.94672079919, 3623.800690961996, 3645.143391303042, 3714.4879989629285, 3750.624937506255, 268633.0, 269486.0, 271318.0, 272483.999999998, 272499.0, 51670.0, 60898.0, 61299.6935015331, 61489.69255153696, 61537.69231153816, 54706.45293547093, 65760.0, 67445.66277168583, 67586.98619520711, 67972.660136699, 12881.742365152644, 12961.41673624689, 13030.80453793194, 13039.934800325938, 13054.34728263602, 9131.908680913239, 9230.446173229628, 9241.815163696689, 9252.0, 9263.629454821867, 20117.899410502854, 20734.481637959172, 20774.0, 20810.375688729364, 20839.8958005209, 7835.216478352233, 7930.365570754326, 8114.837703245902, 8184.959075204586, 8199.098099209083, 973.4840534516718, 982.1749730226644, 989.4854675568664, 1008.5763979128784, 1034.813733527957, 28788.568171477444, 29150.708492915222, 29592.852035740114, 32946.3410731784, 33005.17487062795, 1032.2980373346047, 1063.9946800266105, 1105.8009558279587, 1105.9170562207867, 1113.7939481196004, 15059.698806023818, 15133.470328538448, 15340.539783806504, 15523.379064837505, 15647.452339168301, 388119.0, 388748.0, 389854.0, 390050.0, 390168.0, 56063.878722425325, 56065.439345606836, 56259.71870140623, 56323.71838140865, 56353.71823140858, 1305.8041293805816, 1326.1247576599399, 1329.2024785128845, 1341.9194848309132, 1342.02703040295, 28425.43149137047, 28979.0, 29437.705622943497, 29455.410891782474, 29658.851705741334, 47610.285845713035, 47753.522464776295, 47761.0, 48147.5185248143, 48165.75917120392, 307655.0, 308833.0, 309370.0, 310806.0, 311459.0, 32949.83525082455, 45686.28921384827, 45721.77139114283, 46698.0, 46827.0, 44817.327740083274, 44861.551384487044, 45043.77478112588, 45304.37564994858, 45376.09247815091, 36985.630143699294, 37157.442638359906, 41386.58613413827, 41558.79220603878, 42389.576104238564, 37331.0, 37732.24535509219, 38058.809705951295, 38698.4195237066, 39020.0, 37130.25739485141, 37344.066398340256, 37574.06064848401, 37766.811165944, 37835.62164378321, 33809.66190338164, 36366.818165909004, 38864.80567597144, 39064.41403379008, 39286.60713392829, 26002.739972600033, 26385.868070659522, 26525.0, 26572.202833915013, 26732.599011014463], "unit": "ms", "name": "ext.html", "value": 19029.859224457785}, {"lowerIsBetter": false, "replicates": [352.79890462436424, 354.26666799724563, 357.07695606856277, 360.310006337863, 361.5137639874369, 12581.748365032694, 13040.152390094661, 16475.67048659026, 16788.244528996194, 17416.0, 11656.067514598833, 11684.649460516199, 11734.0, 12013.219140755844, 12155.999999999978, 4404.581564751352, 4519.435070616173, 4521.0, 4528.43394575678, 4540.500544940054, 4368.497622773374, 4476.149531589004, 4494.640428765691, 4499.0, 4505.594496495315, 4525.818967241306, 4528.456585209779, 4685.36747539083, 4793.376861008064, 4796.83211087612, 4831.806727730886, 4842.322074909515, 4871.147549178897, 4877.122118018738, 4893.8287159949405, 4126.793660316972, 4170.061736109351, 4191.077962848169, 4200.0, 4205.285101532716, 13605.455781768718, 13638.386272617756, 13732.038757286993, 13861.376238069312, 13890.23603701796, 1984.9206031758713, 2008.939731808048, 2028.4928767808049, 2057.300517823947, 2101.0860275780083, 10015.89984100157, 10079.395236285847, 10169.186465082776, 10296.073353398155, 10303.948480257626, 1659.659769747211, 1669.3906724045758, 1670.6742185273877, 1679.512941247037, 1692.0609061970601, 58280.70859645717, 59625.105623415686, 59734.0, 59866.0, 59869.401305986816, 6800.149981252343, 6933.68798404073, 7031.613261270679, 7083.5041547091205, 7117.75087871922, 8456.830863382698, 8512.957435212784, 8516.233538981522, 8532.402731808837, 8534.402591818513, 5193.0, 5266.868328291824, 5379.273798037293, 5400.054990376747, 5417.241586177938, 5252.921206181911, 5266.657667251617, 5299.3905700844125, 5312.9734351328, 5331.786728530816, 3273.214428537134, 3317.668233176663, 3337.8331083445732, 3340.265141668829, 3353.094664440587, 1157.5543415784985, 1160.825876118572, 1161.35544772652, 1166.6033548593518, 1220.8657047724744, 390.31304903369704, 403.2600178672111, 408.4282005192754, 411.79410294852573, 428.05827180203676, 9830.459324737209, 10219.386836789668, 10465.0, 10789.56841726338, 11182.32906025641, 413.1241767453019, 414.7014149812191, 443.5032763305119, 443.63400194839386, 480.29156993434407, 5909.0, 5964.493018093423, 5993.820185394445, 6036.215292012098, 6126.571140020156, 459890.0, 459964.0, 468585.0, 468719.0, 469458.0, 74995.0, 77260.61369693115, 77401.6129919358, 78961.65710885957, 80469.0, 464.85821824343225, 470.4848191230597, 470.5858844217067, 471.8112754898, 472.46611329198475, 10229.0, 10257.640982565574, 10357.689269321932, 10429.426381549089, 11023.338599684044, 32941.67058329386, 33158.66841331556, 33370.33259334848, 33743.66256337504, 33770.0, 41078.0, 42118.789406052776, 42534.57465425306, 43469.56530434655, 43721.34417983669, 6778.0, 6810.489213308922, 6870.519063665495, 6878.071460352989, 6890.827729306808, 11902.583409580624, 12642.051846111763, 12846.164999275017, 12868.742625147257, 12903.225806451643, 10753.0, 10800.567977280822, 10862.891371086187, 10871.728206794893, 11061.5022323994, 10597.62908298206, 10727.892721072689, 11033.0, 11040.779184416428, 11052.447377630926, 10964.945175274073, 11252.0, 11318.0, 11333.886661133283, 11440.427978601203, 6918.481113916577, 6920.861582768417, 6995.650217489004, 7005.439564834699, 7019.754308599175, 10658.413787241467, 10829.079528240189, 10900.836487452852, 10962.671119866416, 11043.337399756041], "unit": "ms", "name": "jquery.html", "value": 6710.1028131755365}, {"lowerIsBetter": false, "replicates": [1505.4881340344282, 1692.1285537947958, 1746.0833062642112, 1772.7961284452292, 1787.8301561351668, 7070.15158181019, 7085.1497820261575, 7207.675654595542, 7238.891416628741, 7264.382527485163, 7276.272372762721, 7296.489245752799, 7318.707251709939, 7372.0, 7399.667014984325, 2270.94322641934, 2300.7469178390365, 2307.7576854430295, 2310.9653355199684, 2311.167979527369, 2279.9658005129936, 2301.1830800065986, 2323.2217207235512, 2324.7094113235844, 2329.4875127472014, 2216.6342553478657, 2232.2968264996557, 2258.3789457899043, 2270.591293567157, 2273.124846933934, 2251.3583628665915, 2280.4982903761147, 2310.0297874892503, 2315.1086831569796, 2317.4669825940127, 2241.0923575951765, 2312.3294244669028, 2315.4674424882373, 2317.4901521665206, 2319.826013049011, 7344.449166312548, 7370.631468426557, 7416.629168541605, 7417.0, 7429.8885516716755, 4584.6561507887045, 4643.535646435364, 4654.650901182391, 4669.743164125972, 4679.508651591602, 3089.1504836170006, 3119.23578723212, 3223.113643747988, 3229.4832826747843, 3239.1092449576317, 1116.5198964445285, 1125.3810404277615, 1129.5368898751556, 1137.5212224108625, 1212.1514939542267, 9992.750181245454, 10083.142932850717, 10086.394816311045, 10088.0, 10098.343607665478, 4031.3952907064177, 4130.607592278729, 4135.152293779768, 4152.1072969311745, 4224.619784219435, 8156.143604921516, 8157.75526734199, 8204.138565450661, 8209.302209312156, 8218.21926916942, 4558.475775285819, 4562.726236425825, 4587.541245875385, 4588.678792484561, 4609.055143695535, 4082.1427500225286, 4098.180363927227, 4113.91772164555, 4115.58844115592, 4119.526254480713, 3354.647761985005, 3412.675795799395, 3413.573303337083, 3425.1950791563963, 3434.9313013739584, 1053.694428615693, 1054.778496515725, 1056.5668076088766, 1060.0830281806336, 1064.2177999170603, 988.19462138357, 1044.796264728386, 1048.6906362623045, 1055.0662663542666, 1083.1930211992117, 7045.471589630798, 7058.258882817333, 7065.50541462103, 7076.32774886385, 7080.539764915264, 710.573655806512, 725.0791494801573, 725.3942957630333, 733.5818583407513, 836.3727204596553, 5342.0, 5439.5920305976415, 5447.53695935842, 5457.863553411196, 5474.343078830566, 8597.5701214939, 9009.774755631031, 9012.684556040507, 9030.096990300917, 9134.269258459308, 8806.471611703319, 8906.821863562693, 8950.239229665422, 8968.372213945091, 8969.955150224338, 6795.116634837538, 6804.455643548603, 6818.659067046628, 6845.691943862538, 6851.9657401712675, 6634.734610615521, 6643.767468138785, 6667.266600674019, 6670.799876003728, 6695.296993815579, 7707.691692332244, 7969.561674107979, 8029.076656184614, 8044.718434854752, 8070.435069545076, 7944.285014348737, 7946.483478574106, 7947.125816160334, 7954.482958607672, 7984.081830589556, 6193.752249909953, 6227.875442491216, 6289.685515724287, 6380.3619638035825, 6385.201849768779, 7034.648267586703, 7065.046218760402, 7087.574745515286, 7091.751788687371, 7101.325374089453, 6572.671366431564, 6735.62954037513, 6821.1814582250445, 6838.521303508706, 6891.620960847202, 5687.0, 6363.713632886439, 6673.399394054559, 6721.495887808336, 6742.022406751092, 6584.341565843377, 6723.125993620798, 6760.830979225559, 6826.419754320938, 6851.45188384918, 5952.76188952437, 6102.420270074336, 6110.358412366638, 6118.449339559283, 6133.693315334126, 6154.076888466766, 6425.935740642533, 6426.29310775805, 6447.226332839901, 6454.870902582016], "unit": "ms", "name": "mootools.html", "value": 4287.360588917298}, {"lowerIsBetter": false, "replicates": [335.5889035930984, 344.1018940565126, 344.1430837215333, 344.85171376308193, 348.82384395880075, 6161.845953851145, 6187.5668703190795, 6266.592671476356, 6289.811305660832, 6405.455536279422, 6204.689765511729, 6245.063240513914, 6278.372162783719, 6280.214973128359, 6287.497000239981, 4730.124926888528, 4776.617870570346, 4780.880477988061, 4792.856214313576, 4795.304680821278, 4780.259059845712, 4782.78477468513, 4785.353977213083, 4793.7842797074045, 4804.183288840905, 4643.303504474322, 4738.265568836819, 4750.76246187691, 4757.0, 4759.762011899391, 4724.480307166209, 4728.763561821896, 4730.97634511827, 4738.573528382445, 4766.332713420124, 4084.5915408459214, 4093.6520395766397, 4094.508658960914, 4108.0, 4113.1568028554375, 5919.674417907014, 5939.020061689816, 5942.078977758454, 5951.761929522814, 5959.642421454727, 5388.838334849961, 5487.98472282629, 5532.806351777709, 5535.280413546254, 5546.084895992157, 6610.669466526702, 6661.76683816069, 6676.666166691694, 6685.799426017179, 6689.397954184098, 4554.8861278467975, 4569.657275704336, 4577.931331030038, 4582.083583283324, 4587.79354929029, 6747.831304217434, 6864.1762988441205, 6898.758543451006, 6915.51591388608, 6940.063091482636, 4618.67669263155, 4623.237165867661, 4638.721676699409, 4638.744869032168, 4661.091087238024, 4707.199776038082, 4719.4100737407825, 4720.787564559603, 4726.527347265314, 4728.71627702339, 5474.7810087596845, 5482.945170548243, 5487.945120548823, 5514.338279406497, 5515.944840551623, 6600.402780484647, 6630.668466576652, 6689.933100669028, 6741.426978706865, 6743.494237932175, 1632.2246932707108, 1656.989236565694, 1675.7151284281701, 1676.9496915092566, 1678.261564911435, 1083.6911480228098, 1093.9343639381502, 1105.5909313554037, 1126.9969726943027, 1136.7158210447387, 6378.266499352541, 6410.878096333123, 6428.292887782341, 6432.2281326241155, 6441.227052753606, 6823.078884350648, 6836.487263455261, 6842.384185423236, 6843.178818541707, 6844.760433384808, 6394.328595497499, 6424.903626445607, 6439.098526206335, 6439.9356006440275, 6452.032195170762, 3770.71719621024, 3803.972927309611, 3804.524434445694, 3806.695464362844, 3810.8285127169343, 7260.41916646667, 7269.927300726925, 7313.634318284065, 7333.88999165013, 7337.0828646419195, 6933.0986971693355, 7119.679614417364, 7124.679389427488, 7173.641317934187, 7183.676734546958, 7240.09498812659, 7247.710091596277, 7287.6356182190675, 7288.234735352712, 7320.0, 6942.444604431735, 6967.96516017437, 6970.093887794555, 6984.057152284579, 6988.440924726111, 6692.263850976291, 6868.7252509901045, 6880.58716477013, 6882.208546017272, 6899.827504312432, 7238.27617238272, 7261.491695581259, 7270.563766174047, 7270.89093663606, 7295.0, 4648.34923110758, 4678.8362407316945, 4684.765761711969, 4702.083093796677, 4703.459102203154, 6770.52606317553, 6806.591604503746, 6931.826704332432, 6988.266232045766, 6996.895046574407, 6720.563163394364, 6728.629925354153, 6752.5948443093575, 6753.932460675331, 6766.255711871591, 6706.6981985811735, 6723.562968407038, 6724.462043036643, 6725.159355080615, 6725.461963042847, 6497.805065848032, 6561.671916404256, 6595.538312318092, 6597.80206593803, 6617.874961256502, 6717.529772916045, 6721.663916804043, 6727.730890764315, 6734.966325168343, 6762.222344430454, 6542.247641521286, 6573.506986976092, 6577.638229897401, 6581.868362632625, 6631.535792494479], "unit": "ms", "name": "prototype.html", "value": 5023.73132430904}, {"lowerIsBetter": false, "replicates": [746.6416120262274, 776.9922300776998, 788.3889985261421, 801.3989507869098, 855.7176131876481, 13634.659133521667, 13938.790918136236, 13973.580792576213, 14141.15153090814, 14184.432622695093, 13058.934705326485, 13075.476980920776, 13104.541341053065, 13157.868421315785, 13159.60521184366, 788.6845261895259, 798.2137594469443, 804.2962407893093, 816.0533780814256, 817.6729308276707, 799.8800179973022, 801.6633014134078, 806.379088102161, 806.5160903457937, 809.0574480729942, 838.2497664590188, 840.5881118252073, 841.7264389073545, 842.4313588327885, 848.1391387741417, 831.5509624802569, 834.5743670727911, 835.2691395029349, 838.3712215838121, 840.3613253926999, 612.7732738886596, 614.3150387318108, 617.0312609203552, 617.527591392585, 618.35073173168, 12920.612381628565, 13051.804222936664, 13130.540431084866, 13145.474181032747, 13156.276404797733, 9784.804303913881, 9915.0, 10240.590376384936, 10496.52765625541, 10824.025837674568, 9933.850992235122, 9954.9502252489, 10026.49867506629, 10308.79382412355, 10569.365838049665, 3238.8218647974354, 3280.1963518938014, 3303.223742420529, 3305.3058857639926, 3364.9831750841336, 45087.77456112731, 45312.3203151953, 45475.54524454746, 45526.040807347745, 45723.0, 7337.853242935218, 7368.852622947618, 7473.738419155304, 7595.164531901486, 7597.658105385271, 12379.504819807287, 12390.31853248062, 12392.070594705252, 12404.19372740769, 12430.0, 6407.038944158414, 6500.967495162588, 6535.869282614416, 6576.572522786004, 6591.307912669101, 4094.754314741125, 4123.175364927027, 4127.855525056609, 4163.458750362433, 4166.0834616384345, 2727.7135900730536, 2753.4630747004144, 2754.325190328342, 2761.1578468566877, 2770.4320614274025, 430.1654789707957, 437.65862627150875, 443.8158164361754, 446.6471487524819, 448.24470766758117, 623.4607064888838, 682.6825526130274, 685.7428464325877, 706.3113464372196, 720.8558288342352, 7581.50720203185, 7992.200779921961, 8180.345572354197, 8287.778357041829, 8449.281811046007, 568.2640979930999, 664.0868805392586, 665.8834703926793, 685.9519833611699, 720.1502227371751, 3840.347140986039, 3905.414187871842, 4037.9192416151513, 4077.918441631151, 4103.862194739155, 57287.713561432756, 57631.71184144053, 58814.41185588089, 59426.405735942084, 59610.40389596135, 51999.74000129975, 52005.7399712999, 52082.0, 52376.73811630918, 52550.737246313525, 46779.0, 47123.764381177876, 47147.29279060817, 47391.763041184575, 48158.03683926302, 8171.959140204499, 8185.590720463834, 8374.246317831425, 8600.78498037554, 8735.868961965449, 35267.82366088153, 35590.466143008394, 35993.28013439664, 36524.26951460903, 36909.81545092257, 45757.0, 47026.52973470358, 47125.0, 47382.52617473781, 47395.0, 7878.527288362717, 7957.442978991647, 8108.554029528433, 8196.344292456708, 8310.958445207736, 11255.66233013011, 11598.18812683138, 11607.941960290145, 11614.941925290319, 11660.12549058807, 10867.510962006887, 10952.452377381258, 11363.943180284046, 11787.528498859949, 11911.463984120563, 10903.890961090605, 11447.484863181344, 11735.589254376056, 11764.470598822902, 11776.411179441166, 10839.0, 11260.7747845041, 11335.206535542433, 11709.76580468403, 11753.353565553976, 8864.955675221841, 9126.361154719107, 9151.084891510796, 9333.57998890038, 9477.620895164391, 8832.293416526534, 8888.911110888808, 8901.33240006989, 9476.620935162791, 9602.08780165883], "unit": "ms", "name": "yui.html", "value": 5977.68153592511}], "name": "dromaeo_css", "value": 6666.124032476761}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 112.0, 113.0, 124.0, 113.0, 112.0, 115.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [153.0, 125.0, 159.0, 165.0, 125.0, 160.0, 164.0, 131.0, 169.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 163.0, 162.0, 163.0, 162.0, 166.0, 168.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 74.0, 75.0, 72.0, 73.0, 73.0, 157.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 132.0, 90.0, 91.0, 91.0, 142.0, 92.0, 91.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 62.0, 63.0, 62.0, 63.0, 60.0, 66.0], "unit": "ms", "name": "json-parse-financial", "value": 63.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [93.0, 84.0, 86.0, 88.0, 87.0, 88.0, 94.0, 87.0, 86.0, 88.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.1}, {"lowerIsBetter": true, "replicates": [123.0, 120.0, 131.0, 126.0, 119.0, 119.0, 121.0, 120.0, 123.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.9}, {"lowerIsBetter": true, "replicates": [142.0, 161.0, 154.0, 138.0, 150.0, 149.0, 154.0, 149.0, 153.0, 150.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 66.0, 67.0, 67.0, 67.0, 68.0, 66.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1522.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [193.34880123743233], "unit": "score", "name": "DeltaBlue", "value": 341.96229600000015}, {"lowerIsBetter": false, "replicates": [283.84899233607723], "unit": "score", "name": "Encrypt", "value": 937.7556629999997}, {"lowerIsBetter": false, "replicates": [5065.656565656565], "unit": "score", "name": "Decrypt", "value": 52.54619940179463}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12011.904761904761], "unit": "score", "name": "Boyer", "value": 55.483540138751295}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [611.7216117216117], "unit": "score", "name": "Splay", "value": 133.2158263473054}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21399.663372830913}]} 15:12:31 INFO - RETURN: dromaeo_css: 6666.12 15:12:31 INFO - RETURN: kraken: 1522.60 15:12:31 INFO - RETURN: v8_7: 21399.66 15:12:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21399.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1522.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6666.12"}}} 15:12:31 INFO - Return code: 0 15:12:31 INFO - # TBPL SUCCESS # 15:12:31 INFO - Running post-action listener: _resource_record_post_action 15:12:31 INFO - Running post-run listener: _resource_record_post_run 15:12:32 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529604608; Read time: 12; Write time: 618328 15:12:32 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248500224; Read time: 0; Write time: 347392 15:12:32 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 281104384; Read time: 12; Write time: 270936 15:12:32 INFO - Running post-run listener: _upload_blobber_files 15:12:32 INFO - Blob upload gear active. 15:12:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 15:12:32 INFO - Copying logs to upload dir... 15:12:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1254.906985 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2015-11-18 15:12:31.490093) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:31.493489) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010125 build_url: 'https://queue.taskcluster.net/v1/task/O6SV_rCEToydgoshA8n6RA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:31.544521) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:31.544895) ========= 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=447a3abc0420b6a47dd38cba000001bf-1447886846.192651-311154392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004657 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 15:12:31.596022) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:12:31.596485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 15:12:31.596920) ========= ========= Total master_lag: 0.43 =========