builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1448026535.26 results: success (0) buildid: 20151120030227 builduid: 5a10f9ad2c234d3696596db9ce2d60d8 revision: 3835b568092ae3b71adc931d24928670ad7141a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.259760) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.260194) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.260473) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006450 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.297262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.297612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.320798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.321113) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004759 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.369540) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.369804) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.373163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.373479) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 05:35:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 219M=0s 2015-11-20 05:35:35 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.560005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.560319) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017422 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:35.614132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 05:35:35.614500) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3835b568092ae3b71adc931d24928670ad7141a7 --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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 05:35:35,810 truncating revision to first 12 chars 2015-11-20 05:35:35,810 Setting DEBUG logging. 2015-11-20 05:35:35,811 attempt 1/10 2015-11-20 05:35:35,811 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3835b568092a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 05:35:36,446 unpacking tar archive at: mozilla-central-3835b568092a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.994671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 05:35:36.621549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.621898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.629208) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.629496) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:35:36.629858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-20 05:35:36.630167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:35:36 INFO - MultiFileLogger online at 20151120 05:35:36 in /builds/slave/test-pgo 05:35:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:35:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:35:36 INFO - {'append_to_log': False, 05:35:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:35:36 INFO - 'blob_upload_branch': 'Firefox', 05:35:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:35:36 INFO - 'branch': 'Firefox', 05:35:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:36 INFO - 'config_files': ('talos/linux_config.py',), 05:35:36 INFO - 'default_actions': ('clobber', 05:35:36 INFO - 'read-buildbot-config', 05:35:36 INFO - 'download-and-extract', 05:35:36 INFO - 'populate-webroot', 05:35:36 INFO - 'create-virtualenv', 05:35:36 INFO - 'install', 05:35:36 INFO - 'run-tests'), 05:35:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:36 INFO - 'download_minidump_stackwalk': True, 05:35:36 INFO - 'download_symbols': 'ondemand', 05:35:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:36 INFO - 'installer_path': 'installer.exe', 05:35:36 INFO - 'log_level': 'info', 05:35:36 INFO - 'log_name': 'talos', 05:35:36 INFO - 'log_to_console': True, 05:35:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:35:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:35:36 INFO - 'opt_config_files': (), 05:35:36 INFO - 'pip_index': False, 05:35:36 INFO - 'sps_profile': False, 05:35:36 INFO - 'sps_profile_interval': 0, 05:35:36 INFO - 'suite': 'dromaeojs-e10s', 05:35:36 INFO - 'system_bits': '64', 05:35:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:36 INFO - 'title': 'talos-linux64-ix-011', 05:35:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:36 INFO - 'use_talos_json': True, 05:35:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:35:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:36 INFO - 'work_dir': 'build'} 05:35:36 INFO - ##### 05:35:36 INFO - ##### Running clobber step. 05:35:36 INFO - ##### 05:35:36 INFO - Running pre-action listener: _resource_record_pre_action 05:35:36 INFO - Running main action method: clobber 05:35:36 INFO - rmtree: /builds/slave/test-pgo/build 05:35:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running read-buildbot-config step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: read_buildbot_config 05:35:37 INFO - Using buildbot properties: 05:35:37 INFO - { 05:35:37 INFO - "properties": { 05:35:37 INFO - "buildnumber": 551, 05:35:37 INFO - "product": "firefox", 05:35:37 INFO - "script_repo_revision": "production", 05:35:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:35:37 INFO - "repository": "", 05:35:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:35:37 INFO - "buildid": "20151120030227", 05:35:37 INFO - "slavename": "talos-linux64-ix-011", 05:35:37 INFO - "stage_platform": "linux64-pgo", 05:35:37 INFO - "basedir": "/builds/slave/test-pgo", 05:35:37 INFO - "nightly_build": "True", 05:35:37 INFO - "project": "", 05:35:37 INFO - "platform": "ubuntu64_hw", 05:35:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:35:37 INFO - "slavebuilddir": "test", 05:35:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "branch": "mozilla-central", 05:35:37 INFO - "repo_path": "mozilla-central", 05:35:37 INFO - "pgo_build": "True", 05:35:37 INFO - "builduid": "5a10f9ad2c234d3696596db9ce2d60d8", 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - }, 05:35:37 INFO - "sourcestamp": { 05:35:37 INFO - "repository": "", 05:35:37 INFO - "hasPatch": false, 05:35:37 INFO - "project": "", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "changes": [ 05:35:37 INFO - { 05:35:37 INFO - "category": null, 05:35:37 INFO - "files": [ 05:35:37 INFO - { 05:35:37 INFO - "url": null, 05:35:37 INFO - "name": "https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "repository": "", 05:35:37 INFO - "rev": "3835b568092ae3b71adc931d24928670ad7141a7", 05:35:37 INFO - "who": "sendchange", 05:35:37 INFO - "when": 1448026465, 05:35:37 INFO - "number": 6688414, 05:35:37 INFO - "comments": "", 05:35:37 INFO - "project": "", 05:35:37 INFO - "at": "Fri 20 Nov 2015 05:34:25", 05:35:37 INFO - "branch": "mozilla-central-linux64-pgo-talos", 05:35:37 INFO - "revlink": "", 05:35:37 INFO - "properties": [ 05:35:37 INFO - [ 05:35:37 INFO - "buildid", 05:35:37 INFO - "20151120030227", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "builduid", 05:35:37 INFO - "5a10f9ad2c234d3696596db9ce2d60d8", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "nightly_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ], 05:35:37 INFO - [ 05:35:37 INFO - "pgo_build", 05:35:37 INFO - "True", 05:35:37 INFO - "Change" 05:35:37 INFO - ] 05:35:37 INFO - ], 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - } 05:35:37 INFO - ], 05:35:37 INFO - "revision": "3835b568092ae3b71adc931d24928670ad7141a7" 05:35:37 INFO - } 05:35:37 INFO - } 05:35:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running download-and-extract step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: download_and_extract 05:35:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:35:37 INFO - Downloaded 1302 bytes. 05:35:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:35:37 INFO - Using the following test package requirements: 05:35:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:35:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'jsshell-linux-x86_64.zip'], 05:35:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:35:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:35:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:35:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:35:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:35:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:35:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:35:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:37 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:39 INFO - Downloaded 22520846 bytes. 05:35:39 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 05:35:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:39 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 05:35:40 INFO - Return code: 0 05:35:40 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 05:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:40 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:35:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:47 INFO - Downloaded 22520846 bytes. 05:35:47 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 05:35:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:35:47 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 05:35:48 INFO - Return code: 0 05:35:48 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')]} 05:35:48 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:50 INFO - Downloaded 11130997 bytes. 05:35:50 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 05:35:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:35:50 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 05:35:50 INFO - Return code: 0 05:35: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')]} 05:35:50 INFO - https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:35:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ob-EmXfDQjWAye0_l10YvQ/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 05:35:52 INFO - Downloaded 57346532 bytes. 05:35:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:52 INFO - mkdir: /builds/slave/test-pgo/properties 05:35:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:35:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:35:52 INFO - Contents: 05:35:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:35:52 INFO - Running post-action listener: _resource_record_post_action 05:35:52 INFO - Running post-action listener: set_extra_try_arguments 05:35:52 INFO - ##### 05:35:52 INFO - ##### Running populate-webroot step. 05:35:52 INFO - ##### 05:35:52 INFO - Running pre-action listener: _resource_record_pre_action 05:35:52 INFO - Running main action method: populate_webroot 05:35:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:35:52 INFO - '../fennec_ids.txt'], 05:35:52 INFO - 'tests': ['tcheck2']}, 05:35:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:52 INFO - '--tppagecycles', 05:35:52 INFO - '7'], 05:35:52 INFO - 'tests': ['tsvgm']}}, 05:35:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:35:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'tests': ['damp', 'tps']}, 05:35:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['damp', 'tps']}, 05:35:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:52 INFO - 'other': {'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'other_l64': {'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:52 INFO - 'ts_paint', 05:35:52 INFO - 'tpaint', 05:35:52 INFO - 'sessionrestore', 05:35:52 INFO - 'sessionrestore_no_auto_restore']}, 05:35:52 INFO - 'svgr': {'tests': ['tsvgx', 05:35:52 INFO - 'tsvgr_opacity', 05:35:52 INFO - 'tart', 05:35:52 INFO - 'tscrollx', 05:35:52 INFO - 'cart']}, 05:35:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['tsvgx', 05:35:52 INFO - 'tsvgr_opacity', 05:35:52 INFO - 'tart', 05:35:52 INFO - 'tscrollx', 05:35:52 INFO - 'cart']}, 05:35:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'tests': ['tp5o']}, 05:35:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'talos_options': ['--e10s'], 05:35:52 INFO - 'tests': ['tp5o']}, 05:35:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'talos_options': ['--xperf_path', 05:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:52 INFO - 'tests': ['tp5n']}, 05:35:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:52 INFO - 'talos_options': ['--e10s', 05:35:52 INFO - '--xperf_path', 05:35:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:52 INFO - 'tests': ['tp5n']}}, 05:35:52 INFO - 'talos.zip': {'path': '', 05:35:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:52 INFO - Running post-action listener: _resource_record_post_action 05:35:52 INFO - ##### 05:35:52 INFO - ##### Running create-virtualenv step. 05:35:52 INFO - ##### 05:35:52 INFO - Running pre-action listener: _resource_record_pre_action 05:35:52 INFO - Running main action method: create_virtualenv 05:35:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:35:52 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 05:35:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:35:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:53 INFO - Using real prefix '/usr' 05:35:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:35:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:55 INFO - Installing pip.................done. 05:35:55 INFO - Return code: 0 05:35:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:35:55 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')]} 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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')]} 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:35:55 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 05:35:55 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 05:35:55 INFO - Using env: {'DISPLAY': ':0', 05:35:55 INFO - 'HOME': '/home/cltbld', 05:35:55 INFO - 'LANG': 'en_US.UTF-8', 05:35:55 INFO - 'LANGUAGE': 'en_US:en', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MAIL': '/var/mail/cltbld', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SHLVL': '1', 05:35:55 INFO - 'TERM': 'linux', 05:35:55 INFO - 'TMOUT': '86400', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 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 05:35:55 INFO - Cleaning up... 05:35:55 INFO - Return code: 0 05:35:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:35:55 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')]} 05:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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')]} 05:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:55 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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:35:55 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 05:35:55 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 05:35:55 INFO - Using env: {'DISPLAY': ':0', 05:35:55 INFO - 'HOME': '/home/cltbld', 05:35:55 INFO - 'LANG': 'en_US.UTF-8', 05:35:55 INFO - 'LANGUAGE': 'en_US:en', 05:35:55 INFO - 'LOGNAME': 'cltbld', 05:35:55 INFO - 'MAIL': '/var/mail/cltbld', 05:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:55 INFO - 'MOZ_NO_REMOTE': '1', 05:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:55 INFO - 'NO_EM_RESTART': '1', 05:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:55 INFO - 'SHELL': '/bin/bash', 05:35:55 INFO - 'SHLVL': '1', 05:35:55 INFO - 'TERM': 'linux', 05:35:55 INFO - 'TMOUT': '86400', 05:35:55 INFO - 'USER': 'cltbld', 05:35:55 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:55 INFO - '_': '/tools/buildbot/bin/python'} 05:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:55 INFO - Downloading/unpacking psutil>=0.7.1 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:55 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 05:35:57 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:35:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:35:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:57 INFO - Installing collected packages: psutil 05:35:57 INFO - Running setup.py install for psutil 05:35:57 INFO - building 'psutil._psutil_linux' extension 05:35:57 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 05:35:57 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 05:35:57 INFO - building 'psutil._psutil_posix' extension 05:35:57 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 05:35:58 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 05:35:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:58 INFO - Successfully installed psutil 05:35:58 INFO - Cleaning up... 05:35:58 INFO - Return code: 0 05:35:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:58 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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:35:58 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 05:35:58 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 05:35:58 INFO - Using env: {'DISPLAY': ':0', 05:35:58 INFO - 'HOME': '/home/cltbld', 05:35:58 INFO - 'LANG': 'en_US.UTF-8', 05:35:58 INFO - 'LANGUAGE': 'en_US:en', 05:35:58 INFO - 'LOGNAME': 'cltbld', 05:35:58 INFO - 'MAIL': '/var/mail/cltbld', 05:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:58 INFO - 'MOZ_NO_REMOTE': '1', 05:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:58 INFO - 'NO_EM_RESTART': '1', 05:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:35:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:35:58 INFO - 'SHELL': '/bin/bash', 05:35:58 INFO - 'SHLVL': '1', 05:35:58 INFO - 'TERM': 'linux', 05:35:58 INFO - 'TMOUT': '86400', 05:35:58 INFO - 'USER': 'cltbld', 05:35:58 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:58 INFO - '_': '/tools/buildbot/bin/python'} 05:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:35:58 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 05:35:58 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 05:35:58 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 05:35:58 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 05:35:58 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 05:35:58 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 05:36:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:36:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:36:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:36:00 INFO - Installing collected packages: mozsystemmonitor 05:36:00 INFO - Running setup.py install for mozsystemmonitor 05:36:00 INFO - Successfully installed mozsystemmonitor 05:36:00 INFO - Cleaning up... 05:36:00 INFO - Return code: 0 05:36:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:00 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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:36:00 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 05:36:00 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 05:36:00 INFO - Using env: {'DISPLAY': ':0', 05:36:00 INFO - 'HOME': '/home/cltbld', 05:36:00 INFO - 'LANG': 'en_US.UTF-8', 05:36:00 INFO - 'LANGUAGE': 'en_US:en', 05:36:00 INFO - 'LOGNAME': 'cltbld', 05:36:00 INFO - 'MAIL': '/var/mail/cltbld', 05:36:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:00 INFO - 'MOZ_NO_REMOTE': '1', 05:36:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:00 INFO - 'NO_EM_RESTART': '1', 05:36:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:00 INFO - 'SHELL': '/bin/bash', 05:36:00 INFO - 'SHLVL': '1', 05:36:00 INFO - 'TERM': 'linux', 05:36:00 INFO - 'TMOUT': '86400', 05:36:00 INFO - 'USER': 'cltbld', 05:36:00 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:36:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:00 INFO - '_': '/tools/buildbot/bin/python'} 05:36:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:36:00 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 05:36:00 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 05:36:00 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 05:36:00 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 05:36:00 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 05:36:00 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 05:36:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:36:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36: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 05:36:02 INFO - Downloading docopt-0.6.1.tar.gz 05:36:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:36:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:36:02 INFO - Running setup.py install for blobuploader 05:36:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:36:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:36:02 INFO - Running setup.py install for requests 05:36:03 INFO - Running setup.py install for docopt 05:36:03 INFO - Successfully installed blobuploader requests docopt 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:36:03 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 05:36:03 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 05:36:03 INFO - Using env: {'DISPLAY': ':0', 05:36:03 INFO - 'HOME': '/home/cltbld', 05:36:03 INFO - 'LANG': 'en_US.UTF-8', 05:36:03 INFO - 'LANGUAGE': 'en_US:en', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MAIL': '/var/mail/cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SHLVL': '1', 05:36:03 INFO - 'TERM': 'linux', 05:36:03 INFO - 'TMOUT': '86400', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - '_': '/tools/buildbot/bin/python'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:03 INFO - Running setup.py (path:/tmp/pip-c8wU1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:03 INFO - Running setup.py (path:/tmp/pip-09iL80-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:03 INFO - Running setup.py (path:/tmp/pip-7qLOVR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:03 INFO - Running setup.py (path:/tmp/pip-ioWt2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:03 INFO - Running setup.py (path:/tmp/pip-_2Wmra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:04 INFO - Running setup.py (path:/tmp/pip-Q4pd71-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:04 INFO - Running setup.py (path:/tmp/pip-G6_Y1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:04 INFO - Running setup.py (path:/tmp/pip-Y7pXC6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:04 INFO - Running setup.py (path:/tmp/pip-FNGxrw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:04 INFO - Running setup.py (path:/tmp/pip-6PZicJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:04 INFO - Running setup.py (path:/tmp/pip-CvkZGX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:04 INFO - Running setup.py (path:/tmp/pip-u1Kwpi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:04 INFO - Running setup.py (path:/tmp/pip-CWJFWZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:04 INFO - Running setup.py (path:/tmp/pip-mJ4Kkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:04 INFO - Running setup.py (path:/tmp/pip-qmg7QJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:04 INFO - Running setup.py (path:/tmp/pip-Atoqik-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:04 INFO - Running setup.py (path:/tmp/pip-tpXTOy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:36:04 INFO - Running setup.py install for manifestparser 05:36:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:36:04 INFO - Running setup.py install for mozcrash 05:36:05 INFO - Running setup.py install for mozdebug 05:36:05 INFO - Running setup.py install for mozdevice 05:36:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Running setup.py install for mozfile 05:36:05 INFO - Running setup.py install for mozhttpd 05:36:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Running setup.py install for mozinfo 05:36:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Running setup.py install for mozInstall 05:36:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Running setup.py install for mozleak 05:36:05 INFO - Running setup.py install for mozlog 05:36:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:36:05 INFO - Running setup.py install for moznetwork 05:36:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Running setup.py install for mozprocess 05:36:06 INFO - Running setup.py install for mozprofile 05:36:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Running setup.py install for mozrunner 05:36:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Running setup.py install for mozscreenshot 05:36:06 INFO - Running setup.py install for moztest 05:36:06 INFO - Running setup.py install for mozversion 05:36:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:36:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:36:06 INFO - Cleaning up... 05:36:06 INFO - Return code: 0 05:36:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:36:06 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 05:36:06 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 05:36:06 INFO - Using env: {'DISPLAY': ':0', 05:36:06 INFO - 'HOME': '/home/cltbld', 05:36:06 INFO - 'LANG': 'en_US.UTF-8', 05:36:06 INFO - 'LANGUAGE': 'en_US:en', 05:36:06 INFO - 'LOGNAME': 'cltbld', 05:36:06 INFO - 'MAIL': '/var/mail/cltbld', 05:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:06 INFO - 'MOZ_NO_REMOTE': '1', 05:36:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:06 INFO - 'NO_EM_RESTART': '1', 05:36:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:06 INFO - 'SHELL': '/bin/bash', 05:36:06 INFO - 'SHLVL': '1', 05:36:06 INFO - 'TERM': 'linux', 05:36:06 INFO - 'TMOUT': '86400', 05:36:06 INFO - 'USER': 'cltbld', 05:36:06 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:06 INFO - '_': '/tools/buildbot/bin/python'} 05:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:06 INFO - Running setup.py (path:/tmp/pip-HWQ_Ph-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:36:06 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)) 05:36:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:06 INFO - Running setup.py (path:/tmp/pip-tmc0Kc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:07 INFO - Running setup.py (path:/tmp/pip-gglzKC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:07 INFO - Running setup.py (path:/tmp/pip-mF2wVV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:07 INFO - Running setup.py (path:/tmp/pip-CoBg9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:07 INFO - Running setup.py (path:/tmp/pip-DjjUfs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:07 INFO - Running setup.py (path:/tmp/pip-n7HhZk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:07 INFO - Running setup.py (path:/tmp/pip-3fyjFh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:07 INFO - Running setup.py (path:/tmp/pip-4RP1lD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:07 INFO - Running setup.py (path:/tmp/pip-h37TSE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:07 INFO - Running setup.py (path:/tmp/pip-iR4mQh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:07 INFO - Running setup.py (path:/tmp/pip-bRdYRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:07 INFO - Running setup.py (path:/tmp/pip-uEY_VG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:07 INFO - Running setup.py (path:/tmp/pip-ERXQKO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:07 INFO - Running setup.py (path:/tmp/pip-5Etkqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:36:07 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)) 05:36:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:07 INFO - Running setup.py (path:/tmp/pip-MoTR47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:36:08 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)) 05:36:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:08 INFO - Running setup.py (path:/tmp/pip-qJYKAq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:36:08 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)) 05:36:08 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)) 05:36:08 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)) 05:36:08 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)) 05:36:08 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)) 05:36:08 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)) 05:36:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:08 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 05:36:10 INFO - Downloading blessings-1.5.1.tar.gz 05:36:10 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 05:36:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:10 INFO - Installing collected packages: blessings 05:36:10 INFO - Running setup.py install for blessings 05:36:10 INFO - Successfully installed blessings 05:36:10 INFO - Cleaning up... 05:36:10 INFO - Return code: 0 05:36:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:36:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Current package versions: 05:36:11 INFO - argparse == 1.2.1 05:36:11 INFO - blessings == 1.5.1 05:36:11 INFO - blobuploader == 1.2.4 05:36:11 INFO - docopt == 0.6.1 05:36:11 INFO - manifestparser == 1.1 05:36:11 INFO - mozInstall == 1.12 05:36:11 INFO - mozcrash == 0.16 05:36:11 INFO - mozdebug == 0.1 05:36:11 INFO - mozdevice == 0.47 05:36:11 INFO - mozfile == 1.2 05:36:11 INFO - mozhttpd == 0.7 05:36:11 INFO - mozinfo == 0.9 05:36:11 INFO - mozleak == 0.1 05:36:11 INFO - mozlog == 3.0 05:36:11 INFO - moznetwork == 0.27 05:36:11 INFO - mozprocess == 0.22 05:36:11 INFO - mozprofile == 0.27 05:36:11 INFO - mozrunner == 6.11 05:36:11 INFO - mozscreenshot == 0.1 05:36:11 INFO - mozsystemmonitor == 0.0 05:36:11 INFO - moztest == 0.7 05:36:11 INFO - mozversion == 1.4 05:36:11 INFO - psutil == 3.1.1 05:36:11 INFO - requests == 1.2.3 05:36:11 INFO - wsgiref == 0.1.2 05:36:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f09a8e01c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ddd7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, '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': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', '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 05:36:11 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 05:36:11 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 05:36:11 INFO - Using env: {'DISPLAY': ':0', 05:36:11 INFO - 'HOME': '/home/cltbld', 05:36:11 INFO - 'LANG': 'en_US.UTF-8', 05:36:11 INFO - 'LANGUAGE': 'en_US:en', 05:36:11 INFO - 'LOGNAME': 'cltbld', 05:36:11 INFO - 'MAIL': '/var/mail/cltbld', 05:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:11 INFO - 'MOZ_NO_REMOTE': '1', 05:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:11 INFO - 'NO_EM_RESTART': '1', 05:36:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:11 INFO - 'SHELL': '/bin/bash', 05:36:11 INFO - 'SHLVL': '1', 05:36:11 INFO - 'TERM': 'linux', 05:36:11 INFO - 'TMOUT': '86400', 05:36:11 INFO - 'USER': 'cltbld', 05:36:11 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:11 INFO - '_': '/tools/buildbot/bin/python'} 05:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 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)) 05:36:11 INFO - Cleaning up... 05:36:11 INFO - Return code: 0 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - Running post-action listener: _start_resource_monitoring 05:36:11 INFO - Starting resource monitoring. 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running install step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: install 05:36:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:36:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:36:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Output received: 05:36:11 INFO - Usage: mozinstall [options] installer 05:36:11 INFO - Options: 05:36:11 INFO - -h, --help show this help message and exit 05:36:11 INFO - -d DEST, --destination=DEST 05:36:11 INFO - Directory to install application into. [default: 05:36:11 INFO - "/builds/slave/test-pgo"] 05:36:11 INFO - --app=APP Application being installed. [default: firefox] 05:36:11 INFO - mkdir: /builds/slave/test-pgo/build/application 05:36:11 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'] 05:36:11 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 05:36:26 INFO - Reading from file tmpfile_stdout 05:36:26 INFO - Output received: 05:36:26 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:36:26 INFO - Running post-action listener: _resource_record_post_action 05:36:26 INFO - ##### 05:36:26 INFO - ##### Running run-tests step. 05:36:26 INFO - ##### 05:36:26 INFO - Running pre-action listener: _resource_record_pre_action 05:36:26 INFO - Running main action method: run_tests 05:36:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:36:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:36:26 INFO - Python 2.7.3 05:36:26 INFO - Return code: 0 05:36:26 INFO - grabbing minidump binary from tooltool 05:36:26 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')]} 05:36:26 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 0x1e21d70>, '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 0x1e22b20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e22fb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:36:26 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 05:36:26 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 05:36:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:26 INFO - Return code: 0 05:36:26 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:36:26 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:36:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:36:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:36:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:36:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost 05:36:26 INFO - Using env: {'DISPLAY': ':0', 05:36:26 INFO - 'HOME': '/home/cltbld', 05:36:26 INFO - 'LANG': 'en_US.UTF-8', 05:36:26 INFO - 'LANGUAGE': 'en_US:en', 05:36:26 INFO - 'LOGNAME': 'cltbld', 05:36:26 INFO - 'MAIL': '/var/mail/cltbld', 05:36:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:26 INFO - 'MOZ_NO_REMOTE': '1', 05:36:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:36:26 INFO - 'NO_EM_RESTART': '1', 05:36:26 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:36:26 INFO - 'PWD': '/builds/slave/test-pgo', 05:36:26 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:36:26 INFO - 'SHELL': '/bin/bash', 05:36:26 INFO - 'SHLVL': '1', 05:36:26 INFO - 'TERM': 'linux', 05:36:26 INFO - 'TMOUT': '86400', 05:36:26 INFO - 'USER': 'cltbld', 05:36:26 INFO - 'XDG_SESSION_COOKIE': '76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021', 05:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:26 INFO - '_': '/tools/buildbot/bin/python'} 05:36:26 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost'] with output_timeout 3600 05:36:26 INFO - mozversion INFO | application_buildid: 20151120030227 05:36:26 INFO - mozversion INFO | application_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:36:26 INFO - mozversion INFO | application_display_name: Nightly 05:36:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:26 INFO - mozversion INFO | application_name: Firefox 05:36:26 INFO - mozversion INFO | application_remotingname: firefox 05:36:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:36:26 INFO - mozversion INFO | application_vendor: Mozilla 05:36:26 INFO - mozversion INFO | application_version: 45.0a1 05:36:26 INFO - mozversion INFO | platform_buildid: 20151120030227 05:36:26 INFO - mozversion INFO | platform_changeset: 3835b568092ae3b71adc931d24928670ad7141a7 05:36:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:36:26 INFO - mozversion INFO | platform_version: 45.0a1 05:36:26 INFO - 2015-11-20 05:36:26,436 DEBUG : using testdate: 1448026586 05:36:26 INFO - 2015-11-20 05:36:26,436 DEBUG : actual date: 1448026586 05:36:26 INFO - 2015-11-20 05:36:26,511 INFO : starting webserver on 'localhost:48819' 05:36:26 INFO - 2015-11-20 05:36:26,512 INFO : Starting test suite talos-linux64-ix-011.e 05:36:26 INFO - 2015-11-20 05:36:26,512 INFO : Starting test dromaeo_css 05:36:26 INFO - 2015-11-20 05:36:26,512 DEBUG : operating with platform_type : linux_ 05:36:26 INFO - 2015-11-20 05:36:26,513 INFO : Initialising browser for dromaeo_css test... 05:36:26 INFO - 2015-11-20 05:36:26,527 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8CIt8E/profile http://localhost:48819/getInfo.html 05:36:31 INFO - 2015-11-20 05:36:31,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:36:31 INFO - 2015-11-20 05:36:31,712 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:36:31 INFO - 2015-11-20 05:36:31,712 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:36:31 INFO - 2015-11-20 05:36:31,712 DEBUG : BROWSER_OUTPUT: __metrics 05:36:32 INFO - 2015-11-20 05:36:32,941 INFO : Browser initialized. 05:36:32 INFO - 2015-11-20 05:36:32,942 INFO : Running cycle 1/1 for dromaeo_css test... 05:36:32 INFO - 2015-11-20 05:36:32,942 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8CIt8E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:36:44 INFO - 2015-11-20 05:36:44,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 141582336 05:36:44 INFO - 2015-11-20 05:36:44,657 DEBUG : BROWSER_OUTPUT: 05:37:34 INFO - 2015-11-20 05:37:34,281 DEBUG : BROWSER_OUTPUT: 1448026654277 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] 05:39:43 INFO - 2015-11-20 05:39:43,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48819/tests/dromaeo/cssquery-ext.html) 05:39:45 INFO - 2015-11-20 05:39:45,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 148275200 05:39:45 INFO - 2015-11-20 05:39:45,069 DEBUG : BROWSER_OUTPUT: 05:42:47 INFO - 2015-11-20 05:42:47,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-ext.html (next: http://localhost:48819/tests/dromaeo/cssquery-jquery.html) 05:42:47 INFO - 2015-11-20 05:42:47,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 141500416 05:42:47 INFO - 2015-11-20 05:42:47,627 DEBUG : BROWSER_OUTPUT: 05:45:49 INFO - 2015-11-20 05:45:49,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48819/tests/dromaeo/cssquery-mootools.html) 05:45:49 INFO - 2015-11-20 05:45:49,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 142573568 05:45:49 INFO - 2015-11-20 05:45:49,827 DEBUG : BROWSER_OUTPUT: 05:48:51 INFO - 2015-11-20 05:48:51,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48819/tests/dromaeo/cssquery-prototype.html) 05:48:52 INFO - 2015-11-20 05:48:52,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 141107200 05:48:52 INFO - 2015-11-20 05:48:52,049 DEBUG : BROWSER_OUTPUT: 05:51:54 INFO - 2015-11-20 05:51:54,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48819/tests/dromaeo/cssquery-yui.html) 05:51:55 INFO - 2015-11-20 05:51:55,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 141750272 05:51:55 INFO - 2015-11-20 05:51:55,031 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/dromaeo/cssquery-yui.html (next: http://localhost:48819/tests/dromaeo/cssquery-dojo.html) 05:54:57 INFO - 2015-11-20 05:54:57,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 143671296 05:54:57 INFO - 2015-11-20 05:54:57,701 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,703 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:54:57 INFO - 2015-11-20 05:54:57,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:54:57 INFO - 2015-11-20 05:54:57,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:54:57 INFO - 2015-11-20 05:54:57,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:54:57 INFO - 2015-11-20 05:54:57,704 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3254.3165935153615;3292.489664102065;3327.168207948013;3344.4648856183007;3345.448001079822;5324.494173053564;5473.890522189554;5488.094464413372;5494.120940649497;5502.064649009668;5427.3215848019;5432.70120143392;5487.341519017714;5521.4478552144765;5591.049521581331;4966.354373931384;5061.949380506203;5096.362954630671;5143.43422223557;5145.253938178962;4985.825496107637;5062.417821950467;5102.234664800272;5132.40977287613;5196.92204616931;4864.659473836833;4991.176455884774;5108.795648174088;5128.35895513059;5129.384473863123;5030.346055012825;5045.596352291845;5065.8733531662;5077.035363281002;5079.466656001104;4993.425756038029;4998.075356059105;4999.8250061248045;5013.874653133665;5058.696478211319;5156.845294641167;5242.973785131088;5271.051210782058;5283.181106928432;5293.04725149473;5913.172155898178;5921.644701317891;6000.699965001776;6003.27960644721;6056.5457590680435;5993.130996005555;6015.368386319417;6016.909746353808;6020.307664618537;6023.066424704134;5475.780968761205;5582.218489411485;5692.686902220335;5696.77212911483;5701.230333904911;6075.088736689532;6173.043178307369;6175.59858609189;6177.382261773787;6186.979148440547;5796.510152600008;5862.736176872051;5866.882662346729;5875.236219291465;5910;5805.274340707411;5844.298684157843;5906.852328691817;5937.970310148422;5957.880842383128;5939.792107276225;5955.642661440327;5963.731632076567;5964.373740757158;5979.1629171915965;5975.701214939236;5982.611130276518;5984.760609575568;5988.790392336247;6016.2479690038745;4462.41988541494;4549.795259213343;4567.748773817472;4588.26587745959;4637.3275874997935;4121.237571049365;4129.752214867058;4129.855455059119;4136.276151673445;4165.354370072643;5728.570357223225;5735.139729040678;5758.222639943638;5768.5728310830345;5812.534997200214;5787.421257874179;5816.796412125555;5871.383504731942;5876.08920617305;5949.8215053548465;5665.263515742927;5701.629394089371;5720.456556627114;5742.397048309867;5750.654960702372;5250.107481728115;5252.185911183773;5255.894882102337;5256.999999999924;5299.655522391032;5920.171176035358;6096;6119.07606531266;6224.066390041439;6255.40573645503;5971.462568368867;6054.7275372607455;6062.42406971337;6071.635701857903;6101.633901965896;6012.518998480024;6196.194494715658;6215.720292586754;6241.469475094668;6247.96876015617;5805.477507024388;5842.444967728059;5881;5906.940930590639;5943.851403714942;5896.439838215363;5919.733611987557;5920.200772895604;5970.104484327386;5981.102834574848;5598.412166722435;5837.416258374298;5842.737076831468;5844.211031510692;5847.649141051551;5706.058500347563;5774.913376299275;5827.4172582741385;5828.0966450200285;5879.353271140257;5758.740856661544;5779.162021506942;5783.652980821164;5811.76752929895;5829.271341082364;5727.140928860705;5852.239208902815;5897.587168898136;5915.70421478933;5932.970335148297;5644.181593668977;5709.371969083314;5741.081426971665;5744.109663002241;5793.797217097382 05:54:57 INFO - 2015-11-20 05:54:57,706 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.5667310387339;599.3556926304224;601.7502736364409;604.811545313459;605.5488660947593;40004.79997600012;40589.39115913256;40684.59315406845;40843;40928.38607420891;42432.36351454731;42619;42731.572684273226;42753;42962.14075718484;8716.607752651114;8884.733457996239;8925.41984770991;8954.955225223865;8972.371933964592;8675.349348798834;8739.60671769772;8777.29781617469;8787.428817126898;8813.206811386974;8760.780980475507;8790.120987901222;8790.16493433126;8812.691555795549;8817.647294108228;8732.650693972266;8768.386212965095;8807.339449541278;8810.647574097029;8863.734087977371;8660.350473714496;8709.869351959725;8799.384043116985;8810.515421651806;8831.602577883947;40585.391219131736;40904.590954090374;41007.38488922668;41101.38347924784;41128.177436451406;3382.391169589473;3482.547268855058;3638.126849556114;3671.375866102769;3846.442265871461;30072.699273007427;30661.846690766626;30755.692443075506;30771.384572308427;30828.53757193644;3884.378499440076;3885.4754608128105;4022.0950286185666;4114.465119534471;4139.379093136024;273010;274283;274525;274902.999999998;275472;60587;60799.392006080256;60825.39174608286;60951;60968.695156524824;63468.682656586425;64121.679391602745;64728.35271647223;73136.63431682914;74050.25949740433;15253.23733813327;15458.690826183414;15489.605935465863;15519.379224831106;15641.765373519407;11625.941870290764;11783.646490605295;11802.291862488279;11817.290962542274;11842.111841611913;20703.482412939797;21081.472963176042;21161.470963226042;21164.682529762067;21179;8081.595920203967;8217;8267.462614930011;8323.708670196515;8398.496090234605;965.7344230336713;972.5963725054023;993.0020329568737;1005.3163848583034;1023.0485648347109;28153;28974;29121.56317655237;29810.55284170739;30383.10299973572;972.5137431284357;1002.0981116994617;1013.2653825976108;1016.3038318751679;1033.266380869576;15212.771808422662;15412.383504659689;15418.383264669512;15449.613759656098;15490.9225453872;403220;407676;408178;408336;408872;53005.7349713249;53040.469595303555;53503.73248133734;53614;53625.463745362824;1329.84706758724;1354.1671871798774;1363.1412210307442;1365.0512893539094;1469;27886;28693.569596456487;28747;28916.855415722788;29066.27334316659;46162.307565385876;46507;46698.29952550783;46725.299120512536;46777.76611116923;298777;299765;302204;302215;302283;29571.408571828873;30104.54843177398;31595.368092638477;31745.365092698477;32385;40416.59583404246;41631.37552936769;41781;42579.14841703087;42733.7179884604;35503;35865.46201806923;36699.53201871895;36931;37388;36778.448323274635;37913.81043094767;41246;42111.7894410526;42341.576584233764;35143.47284790679;36237.818810905774;36726;36890.81554592317;36938;31682.524762128127;34806.65193348034;34824.303513930085;35056.29887402289;35530.46704299489;25191;25206.62190067187;25390;25447.872760636077;25548.23355299344 05:54:57 INFO - 2015-11-20 05:54:57,709 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.9590647075587;357.6048466444579;358.678982310832;359.30474531781005;364.63718599993;14745.557633270992;15123.546293611196;16647.25087371068;18625.44123676292;19546.902265488687;11192.272502287346;13578.864211357883;15682.215889205523;16725.498235052968;16865.83134168661;4904.901901961958;5028.321176641161;5031.84904452867;5033.597312215014;5035.269885866565;4942.827001054964;4949.356583644121;4981.825636102737;4982.750862456863;4998.950010499903;4856.854294371175;4973.676711013791;4997.625178111638;5006.54941055305;5129.204973229155;5116.948830511722;5118.692878427288;5120.462351453081;5140.1004824156;5180.922286165711;4927.088488629579;5257.579393648499;5265.183896496049;5284.656497327662;5288.2596436498925;12226;12279.508819647204;12480.063995200306;12781.297028663419;12799.5520156795;1994.5113447205383;2017.7175195472646;2068.1520576563535;2131.914723411062;2168.349495151464;9310;9336.206422454099;9403.059694030611;10910.290831095954;12635.87364126356;1736.8436840684399;1758.446089481822;1771.5482551949299;1781.385422029398;1827.232562323827;60131.39868601302;62655.37344626541;63045.369546304406;63085.68457157731;64337.67831160814;10014.39913605186;10175.185985121321;10317.329373590692;10372.948135259427;10403.323783954018;13613;13647.317634118255;13652.795208071886;13657.658558536115;13663.795043074362;7512.286332798375;7540.17058123606;7582.658780354897;7606.315431611071;7702.460827742004;7095.751648692271;7110.3600675939415;7123.216446190915;7171.211166771651;7175.964120179366;4406.2949928012;4417.580329868657;4422.933655995163;4458.866234012985;4516.345129956138;1767.1164417791103;1767.142935676196;1810.7646006019133;1847.3164928976364;1855.1002763659615;399.75015615240477;407.3889166250624;415.77963679250047;425.987220383389;900.9459432434074;10230.23273254509;10415.375077495222;10487.632932847466;10588.10001149911;10654.73363165927;427.9293916503742;436.92572262715413;450.90305584299534;455.43071161048687;460.9262517997104;4867.3915760529935;5808.912866307009;5824.475797178275;5841.094630332305;5876.706164691834;534536;542525;543108;548138;557572;78474.6076269615;81478.59260703778;82881;83973;85719;472.85577898740524;473.4933621025539;476.4663576793944;476.5091955286061;478.2014036558955;9851.802963940825;9946.602135914773;14583.489577865148;15057.247137643293;16251;34551.82724086363;34887.476687849194;34953.65046349504;35901.82049089738;36216.81891590525;45101;47127;47452.7627361861;48076.75961620169;48875.26687099625;9621.90378096238;9756.560954756911;9773.169280610944;9807.509624518889;9959.302848800804;17689.115544222994;17811.198496067966;18014.36949706754;18142;18153.727694084337;13708.45166193381;14383.496577619733;14477.348519316445;14562.053466525065;14622.561323160322;14569.615886490767;14795.926020369829;14796.926015370285;15408.306626202071;15417.383304667688;13830.101043432145;14022.509212177525;14107.506237281646;14407.207603581903;14441.422343106158;9355.578998944928;9475.389183838626;9650.276229282692;9715.514224288898;9789;13670.93164534171;14196.29018549089;14571.761400281095;14652.853471465576;14856.257187140816 05:54:57 INFO - 2015-11-20 05:54:57,709 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1459.5840185547117;1524.6493306539498;1595.7765912772222;1621.481126039667;1716.0390181498362;7522.849543009143;7667.23327667233;7748.070231572212;7775.261350171739;7930.92069079309;7884.724034658788;7924.366050715943;7976.122626511079;7979.361651067915;7986.081600615931;2274.715660542428;2313.884305784704;2316.4672125411166;2317.44381348476;2319.617263151578;2238.955220895581;2289.1186893046215;2296.552172326397;2299.4366380236866;2345.906163753448;2235.3629215673536;2244.708187935566;2261.604219261631;2279.350385140235;2292.197730794217;2257.582347265761;2265.988670056639;2309.8960546775434;2313.0400883633356;2314.89582968766;2313.664518644804;2329.5690297295055;2337.614293641547;2339.017612602694;2345.108858633708;7617.619119044026;7683.615819209017;7729.227077292226;7765.30112289891;7791.259830316111;4643.8374656886845;4689.742064186468;4700.224462963641;4727.243641017455;4758;3196.488561830096;3229.273413481971;3237.3687131009465;3263.461528847737;3309.470484722433;1107.545906178463;1119.764849381631;1128.6049882541126;1137.590467431724;1143.2054721968236;10451.320664156805;10495.527701253386;10503.264771466;10550.62841830557;10554;4067.5525692173837;4074.0425999890003;4079.816408261576;4159.646430053419;4178.080822219107;8646.092160323202;8658.48049117055;8668.696595619123;8693.91306086931;8724.563771811385;4574.473935497461;4601.723896566216;4610.561996610317;4611.5619016193405;4631.258998560214;4215.473065866767;4226.028013556837;4253.04306531028;4280.571942805695;4285.100128972888;3463.255400088993;3490.5636795400574;3494.056604716712;3498.1954150545007;3508.754387192872;1057.3285963413134;1059.9788004239872;1064.2231171245035;1065.760203954104;1068.5405275731355;1068.957241710323;1072.694282129605;1106.0156460749938;1230.477047254913;1345.8115863779078;7181.928180718231;7237.746678866214;7239.20368759436;7295.306945840137;7403.074615673041;1131.4569006876745;1135.7501349703052;1138.4535422996842;1145.4421986098898;1162.1922763679163;5719.942800572025;5730.885382292331;5739.426057394227;5741.799037033684;5789.681567513743;8906.421082629739;9043.502607356528;9362.391444556082;9424.104710052534;9449.90550094504;9184.540772961325;9236.630534778667;9240.630374785067;9250.352475326663;9348.01845806194;7108.253633368422;7176.282371762886;7219.494635375473;7222.855542889113;7307.3423391894985;6947.826304342432;6995.580265184105;6998.020277161303;7005.54463959841;7013.473989450709;8003.91996080055;8125.3905957052275;8159.26566609008;8285.627146778288;8325.25072743456;8402.369822263478;8505.106963768716;8578.227959483676;8613.526256055977;8696.17386348296;6584;6661;6906.102206713095;6942.930570694229;6958.582485050913;7531.096268447822;7563.546187228784;7579.355754760907;7586.658600363107;7590.506617070094;6638.269790322964;6761.391474767294;6945.270746571739;6955.652217389009;6974.860502790018;6675.132232809704;6876.965615171892;6917.308269173042;6958.965205174144;6997.020417141706;6990.580565166107;7043.859122817413;7046.365827075588;7048.647567621701;7051.294870512907;6383.170187875547;6493.642849643126;6494.0258961156205;6502.0246962955935;6507.577007494498;6445.323241059621;6465.418112369909;6487.578307410004;6500.122483464861;6521.641309727821 05:54:57 INFO - 2015-11-20 05:54:57,713 DEBUG : BROWSER_OUTPUT: |4;prototype.html;329.42022041207474;332.29553346904567;336.34245050925443;339.96430374810643;342.3512443918774;6284.465820405259;6306.779262725806;6346.4288214060725;6379.266384365799;6395.808125756229;6157.38426157384;6335.398137176972;6342.0803983422375;6343.080253363271;6350.206224221973;4824.107540105074;4838.879028024292;4846.369971903648;4847.12751704693;4870.293807397925;4855.053264613402;4860.465348811628;4869.756512174377;4876.2198048312275;4882.2432522959;4733.621310295168;4810.831620893269;4812.566868981791;4813.181759100944;4831.903361932759;4792.137415265251;4799.976000119995;4805.975970120162;4809.78355973982;4831.758412079382;4207.305794543897;4215.409842622035;4220.978895105505;4234.06850492891;4240.851570195059;5939.584229103964;5985.850353741148;6014.96992515039;6020.8494787630225;6024.939750602482;5567.387587365427;5626.156076588503;5639.887202255973;5654.575906807006;5654.886902261973;6686.297938716413;6701.3968742812895;6701.821907879958;6704.7988560343265;6706.865862682719;4695.131400690883;4700.177468942956;4701.341812146302;4706.835260765857;4710.458297295821;6819.624920629363;6889.448844092461;6973.302669733037;6976.441884649266;6988.336108069776;4784.569388754959;4794.5924596408995;4803.639727020418;4804.231322988305;4805.831795887128;4852.636052296092;4859.1010663027455;4863.975680121577;4866.1727506323305;4871.098846713369;5621.325440947031;5628.099504079328;5631.7184140793615;5641.576881733887;5643.1535269709875;6489.351064893567;6645.800625981228;6668.733250670016;6706.899396509057;6710.429613482908;1661.3188592676945;1695.1693670101808;1722.4670043661151;1731.97402038967;1737.409280844519;1151.7581307925261;1162.0645380468634;1170.0639488409408;1176.2707121584672;1176.7117056321256;6442.098106265126;6448.419642232127;6467.482601391877;6468.3855033771715;6496.642684652389;6842.897356539655;6876.931230687729;6902.896456553156;6905.274946130584;6908.171019477695;6325.082862984841;6428.389303016206;6451.774187903401;6459.709313080923;6465.612063276219;3794.1842503861803;3799.2211596622624;3814.504114465102;3828.8277027533272;3829.100161462054;7300.853982920312;7313.414926805843;7346.5592064476305;7357.705691772269;7363.631818409058;7025.999999999898;7233.819154521179;7237.276272372721;7256.528325658815;7262.055932728817;7282.159957616534;7295.854082918312;7329.157146928065;7335.8532829344185;7341.926580734231;6932.792016239521;7002.124734408199;7015.789526314219;7015.894761578683;7019.824504387227;6719.193696756421;6909.7581584644295;6922.446204303745;6963.9651801740665;6968.581885086911;7195.568265904062;7315.597642129734;7331.41348692114;7356.337929586363;7371.262873712586;4609.51600082;4609.838655647036;4618.607418369476;4623.352730617784;4634.930476042795;6796.35434633709;6819.181698196248;6936.514443988873;6957.199922009034;6968.128983877015;6722.529422940347;6741.2921643226755;6745.494087943522;6746.055552222595;6760.290169532128;6671.966640166962;6677.165354330708;6680.198376194888;6730.394264516217;6815.182178138655;6524.086627872007;6593.80218593443;6620.404163625297;6641.302663220292;6641.302663220486;6732.495062870402;6740.427063699444;6786.287439818748;6789.932100679128;6800.863982720417;6583.604983700993;6610.305917878553;6613.305602911817;6622.63575503352;6634.237062737847 05:54:57 INFO - 2015-11-20 05:54:57,714 DEBUG : BROWSER_OUTPUT: |5;yui.html;816.7713040348702;822.5023860564359;843.1315744782872;847.6355167278072;883.6818745251712;12256.938715306422;12374.19567728097;12376.319302438362;12552.05859560532;12562.497500099997;13099.73800523989;13231.933840330785;13248.07263491556;13267.800982985264;13268;663.0716996205327;677.8745932002571;805.3154818404367;821.4003777242586;821.8685010398337;803.3533005930224;813.8372325534887;814.9918500815005;815.8857759913587;818.5661599352353;855.9101294364095;857.4426622695236;859.3168431097292;862.5773371048173;862.6980556805131;845.970391036317;849.0575461238021;850.685246458808;852.0286872964825;852.654674856684;635.0284065379976;635.2186810223404;635.2218532297898;635.5138319185827;640.1390130274773;13493.122947008413;13601.183928964196;13641.931790341085;13648.976326775532;13659.658508537266;12206.267623942593;12440.75118497625;12517.374131293398;12688.429020694091;12718.10973231874;10403.427811470367;10490.685279441628;10532.210084243636;10561.894381056169;10646.520906559223;3578.481120237577;3654.3239500692457;3660.432632941898;3706.7405281630295;3741.4387841823673;48054.519454805704;48420.51579484231;48461;48545.27182092272;48569.51430485685;10088;10187.388756674623;10199.18406527476;10379.273450858367;10514.3691378516;18999;19094.71357929632;19114.71327930082;19133.33033343826;19178.616427671368;7484.663190156347;7631.54210747357;7765.339946104531;7992.880106798402;8207.138250483613;4094.8566800161852;4163;4193.832246710159;4222.725522841006;4348.434703488526;3120.797148185406;3164.730997865161;3166.762492813002;3173.6829215875614;3180.220845892771;622.1569772957668;634.8571571396491;639.1180171363488;644.3234603666132;655.4788942790493;666.2870728320747;700.6426722371525;702.3819039245432;707.2114592229627;715.8031541326177;8668.306535477273;8902.332325075646;8938.955305223431;8992.89903059806;9154.725358239264;653.6306986552582;658.8122385120217;663.9634820084942;691.2499937567695;699.8985147153634;4225.514065882401;4282.443282373334;4311.698181127291;4403.823847046082;4463.843765468193;50682.23976640353;50715;50962.74518627457;51899.48100519022;55186;45732.542674572825;49059;53595;53734.19398709023;53966.73016634892;46115.769421152676;49761.75119124381;50010;50163.49836501661;50176.498235017185;8316.251537361666;8593.484390936565;8885.244754195708;8892.199702026848;9026;32204.83897580497;34076.14809629779;34351;37240.441393378576;37789.244215116094;46334;46908;47050;47448.762756186;47637.5236247647;11206.43967801623;11212.215144939775;11469;11554.133439991867;11632.302061876315;11207.551697932318;11509.482073306554;11519.383148578589;11762.470688818852;11784.941075294568;11058.391788451712;11082.113430925669;11407.37259450705;11714.297142171497;12086.758264834478;10673.786524269315;10684.679459616224;10804.783904321712;10841.566337346418;11052.778944421227;10298.536565854405;11044.668659940215;11253.381064041556;11342.432878356214;11764.939054603044;9077.636894524145;9107.453552786854;9207;9309.301802364715;9390;9189.310801689766;9861.260405469475;10341.172706183337;10348.896511034793;10364 05:54:57 INFO - 2015-11-20 05:54:57,714 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:54:57 INFO - 2015-11-20 05:54:57,714 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:54:57 INFO - 2015-11-20 05:54:57,715 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297 05:54:57 INFO - 2015-11-20 05:54:57,715 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:54:57 INFO - 2015-11-20 05:54:57,715 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027697701__endTimestamp 05:54:57 INFO - 2015-11-20 05:54:57,715 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5537.57 Median:5774.91 stddev:618.47 (10.7%) stddev-sans-first:593.86 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: Values: 3254.3 3292.5 3327.2 3344.5 3345.4 5324.5 5473.9 5488.1 5494.1 5502.1 5427.3 5432.7 5487.3 5521.4 5591.0 4966.4 5061.9 5096.4 5143.4 5145.3 4985.8 5062.4 5102.2 5132.4 5196.9 4864.7 4991.2 5108.8 5128.4 5129.4 5030.3 5045.6 5065.9 5077.0 5079.5 4993.4 4998.1 4999.8 5013.9 5058.7 5156.8 5243.0 5271.1 5283.2 5293.0 5913.2 5921.6 6000.7 6003.3 6056.5 5993.1 6015.4 6016.9 6020.3 6023.1 5475.8 5582.2 5692.7 5696.8 5701.2 6075.1 6173.0 6175.6 6177.4 6187.0 5796.5 5862.7 5866.9 5875.2 5910.0 5805.3 5844.3 5906.9 5938.0 5957.9 5939.8 5955.6 5963.7 5964.4 5979.2 5975.7 5982.6 5984.8 5988.8 6016.2 4462.4 4549.8 4567.7 4588.3 4637.3 4121.2 4129.8 4129.9 4136.3 4165.4 5728.6 5735.1 5758.2 5768.6 5812.5 5787.4 5816.8 5871.4 5876.1 5949.8 5665.3 5701.6 5720.5 5742.4 5750.7 5250.1 5252.2 5255.9 5257.0 5299.7 5920.2 6096.0 6119.1 6224.1 6255.4 5971.5 6054.7 6062.4 6071.6 6101.6 6012.5 6196.2 6215.7 6241.5 6248.0 5805.5 5842.4 5881.0 5906.9 5943.9 5896.4 5919.7 5920.2 5970.1 5981.1 5598.4 5837.4 5842.7 5844.2 5847.6 5706.1 5774.9 5827.4 5828.1 5879.4 5758.7 5779.2 5783.7 5811.8 5829.3 5727.1 5852.2 5897.6 5915.7 5933.0 5644.2 5709.4 5741.1 5744.1 5793.8 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,716 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49926.68 Median:22013.45 stddev:87413.11 (397.1%) stddev-sans-first:87579.75 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: Values: 560.6 599.4 601.8 604.8 605.5 40004.8 40589.4 40684.6 40843.0 40928.4 42432.4 42619.0 42731.6 42753.0 42962.1 8716.6 8884.7 8925.4 8955.0 8972.4 8675.3 8739.6 8777.3 8787.4 8813.2 8760.8 8790.1 8790.2 8812.7 8817.6 8732.7 8768.4 8807.3 8810.6 8863.7 8660.4 8709.9 8799.4 8810.5 8831.6 40585.4 40904.6 41007.4 41101.4 41128.2 3382.4 3482.5 3638.1 3671.4 3846.4 30072.7 30661.8 30755.7 30771.4 30828.5 3884.4 3885.5 4022.1 4114.5 4139.4 273010.0 274283.0 274525.0 274903.0 275472.0 60587.0 60799.4 60825.4 60951.0 60968.7 63468.7 64121.7 64728.4 73136.6 74050.3 15253.2 15458.7 15489.6 15519.4 15641.8 11625.9 11783.6 11802.3 11817.3 11842.1 20703.5 21081.5 21161.5 21164.7 21179.0 8081.6 8217.0 8267.5 8323.7 8398.5 965.7 972.6 993.0 1005.3 1023.0 28153.0 28974.0 29121.6 29810.6 30383.1 972.5 1002.1 1013.3 1016.3 1033.3 15212.8 15412.4 15418.4 15449.6 15490.9 403220.0 407676.0 408178.0 408336.0 408872.0 53005.7 53040.5 53503.7 53614.0 53625.5 1329.8 1354.2 1363.1 1365.1 1469.0 27886.0 28693.6 28747.0 28916.9 29066.3 46162.3 46507.0 46698.3 46725.3 46777.8 298777.0 299765.0 302204.0 302215.0 302283.0 29571.4 30104.5 31595.4 31745.4 32385.0 40416.6 41631.4 41781.0 42579.1 42733.7 35503.0 35865.5 36699.5 36931.0 37388.0 36778.4 37913.8 41246.0 42111.8 42341.6 35143.5 36237.8 36726.0 36890.8 36938.0 31682.5 34806.7 34824.3 35056.3 35530.5 25191.0 25206.6 25390.0 25447.9 25548.2 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28552.06 Median:2421.61 stddev:89249.55 (3685.5%) stddev-sans-first:89474.80 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: Values: 356.0 357.6 358.7 359.3 364.6 14745.6 15123.5 16647.3 18625.4 19546.9 11192.3 13578.9 15682.2 16725.5 16865.8 4904.9 5028.3 5031.8 5033.6 5035.3 4942.8 4949.4 4981.8 4982.8 4999.0 4856.9 4973.7 4997.6 5006.5 5129.2 5116.9 5118.7 5120.5 5140.1 5180.9 4927.1 5257.6 5265.2 5284.7 5288.3 12226.0 12279.5 12480.1 12781.3 12799.6 1994.5 2017.7 2068.2 2131.9 2168.3 9310.0 9336.2 9403.1 10910.3 12635.9 1736.8 1758.4 1771.5 1781.4 1827.2 60131.4 62655.4 63045.4 63085.7 64337.7 10014.4 10175.2 10317.3 10372.9 10403.3 13613.0 13647.3 13652.8 13657.7 13663.8 7512.3 7540.2 7582.7 7606.3 7702.5 7095.8 7110.4 7123.2 7171.2 7176.0 4406.3 4417.6 4422.9 4458.9 4516.3 1767.1 1767.1 1810.8 1847.3 1855.1 399.8 407.4 415.8 426.0 900.9 10230.2 10415.4 10487.6 10588.1 10654.7 427.9 436.9 450.9 455.4 460.9 4867.4 5808.9 5824.5 5841.1 5876.7 534536.0 542525.0 543108.0 548138.0 557572.0 78474.6 81478.6 82881.0 83973.0 85719.0 472.9 473.5 476.5 476.5 478.2 9851.8 9946.6 14583.5 15057.2 16251.0 34551.8 34887.5 34953.7 35901.8 36216.8 45101.0 47127.0 47452.8 48076.8 48875.3 9621.9 9756.6 9773.2 9807.5 9959.3 17689.1 17811.2 18014.4 18142.0 18153.7 13708.5 14383.5 14477.3 14562.1 14622.6 14569.6 14795.9 14796.9 15408.3 15417.4 13830.1 14022.5 14107.5 14407.2 14441.4 9355.6 9475.4 9650.3 9715.5 9789.0 13670.9 14196.3 14571.8 14652.9 14856.3 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,717 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5420.26 Median:6414.25 stddev:2772.81 (43.2%) stddev-sans-first:2764.61 05:54:57 INFO - 2015-11-20 05:54:57,718 DEBUG : BROWSER_OUTPUT: Values: 1459.6 1524.6 1595.8 1621.5 1716.0 7522.8 7667.2 7748.1 7775.3 7930.9 7884.7 7924.4 7976.1 7979.4 7986.1 2274.7 2313.9 2316.5 2317.4 2319.6 2239.0 2289.1 2296.6 2299.4 2345.9 2235.4 2244.7 2261.6 2279.4 2292.2 2257.6 2266.0 2309.9 2313.0 2314.9 2313.7 2329.6 2337.6 2339.0 2345.1 7617.6 7683.6 7729.2 7765.3 7791.3 4643.8 4689.7 4700.2 4727.2 4758.0 3196.5 3229.3 3237.4 3263.5 3309.5 1107.5 1119.8 1128.6 1137.6 1143.2 10451.3 10495.5 10503.3 10550.6 10554.0 4067.6 4074.0 4079.8 4159.6 4178.1 8646.1 8658.5 8668.7 8693.9 8724.6 4574.5 4601.7 4610.6 4611.6 4631.3 4215.5 4226.0 4253.0 4280.6 4285.1 3463.3 3490.6 3494.1 3498.2 3508.8 1057.3 1060.0 1064.2 1065.8 1068.5 1069.0 1072.7 1106.0 1230.5 1345.8 7181.9 7237.7 7239.2 7295.3 7403.1 1131.5 1135.8 1138.5 1145.4 1162.2 5719.9 5730.9 5739.4 5741.8 5789.7 8906.4 9043.5 9362.4 9424.1 9449.9 9184.5 9236.6 9240.6 9250.4 9348.0 7108.3 7176.3 7219.5 7222.9 7307.3 6947.8 6995.6 6998.0 7005.5 7013.5 8003.9 8125.4 8159.3 8285.6 8325.3 8402.4 8505.1 8578.2 8613.5 8696.2 6584.0 6661.0 6906.1 6942.9 6958.6 7531.1 7563.5 7579.4 7586.7 7590.5 6638.3 6761.4 6945.3 6955.7 6974.9 6675.1 6877.0 6917.3 6959.0 6997.0 6990.6 7043.9 7046.4 7048.6 7051.3 6383.2 6493.6 6494.0 6502.0 6507.6 6445.3 6465.4 6487.6 6500.1 6521.6 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5636.67 Median:6412.10 stddev:1704.55 (26.6%) stddev-sans-first:1662.13 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: Values: 329.4 332.3 336.3 340.0 342.4 6284.5 6306.8 6346.4 6379.3 6395.8 6157.4 6335.4 6342.1 6343.1 6350.2 4824.1 4838.9 4846.4 4847.1 4870.3 4855.1 4860.5 4869.8 4876.2 4882.2 4733.6 4810.8 4812.6 4813.2 4831.9 4792.1 4800.0 4806.0 4809.8 4831.8 4207.3 4215.4 4221.0 4234.1 4240.9 5939.6 5985.9 6015.0 6020.8 6024.9 5567.4 5626.2 5639.9 5654.6 5654.9 6686.3 6701.4 6701.8 6704.8 6706.9 4695.1 4700.2 4701.3 4706.8 4710.5 6819.6 6889.4 6973.3 6976.4 6988.3 4784.6 4794.6 4803.6 4804.2 4805.8 4852.6 4859.1 4864.0 4866.2 4871.1 5621.3 5628.1 5631.7 5641.6 5643.2 6489.4 6645.8 6668.7 6706.9 6710.4 1661.3 1695.2 1722.5 1732.0 1737.4 1151.8 1162.1 1170.1 1176.3 1176.7 6442.1 6448.4 6467.5 6468.4 6496.6 6842.9 6876.9 6902.9 6905.3 6908.2 6325.1 6428.4 6451.8 6459.7 6465.6 3794.2 3799.2 3814.5 3828.8 3829.1 7300.9 7313.4 7346.6 7357.7 7363.6 7026.0 7233.8 7237.3 7256.5 7262.1 7282.2 7295.9 7329.2 7335.9 7341.9 6932.8 7002.1 7015.8 7015.9 7019.8 6719.2 6909.8 6922.4 6964.0 6968.6 7195.6 7315.6 7331.4 7356.3 7371.3 4609.5 4609.8 4618.6 4623.4 4634.9 6796.4 6819.2 6936.5 6957.2 6968.1 6722.5 6741.3 6745.5 6746.1 6760.3 6672.0 6677.2 6680.2 6730.4 6815.2 6524.1 6593.8 6620.4 6641.3 6641.3 6732.5 6740.4 6786.3 6789.9 6800.9 6583.6 6610.3 6613.3 6622.6 6634.2 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13830.87 Median:46621.00 stddev:15878.91 (34.1%) stddev-sans-first:15893.38 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: Values: 816.8 822.5 843.1 847.6 883.7 12256.9 12374.2 12376.3 12552.1 12562.5 13099.7 13231.9 13248.1 13267.8 13268.0 663.1 677.9 805.3 821.4 821.9 803.4 813.8 815.0 815.9 818.6 855.9 857.4 859.3 862.6 862.7 846.0 849.1 850.7 852.0 852.7 635.0 635.2 635.2 635.5 640.1 13493.1 13601.2 13641.9 13649.0 13659.7 12206.3 12440.8 12517.4 12688.4 12718.1 10403.4 10490.7 10532.2 10561.9 10646.5 3578.5 3654.3 3660.4 3706.7 3741.4 48054.5 48420.5 48461.0 48545.3 48569.5 10088.0 10187.4 10199.2 10379.3 10514.4 18999.0 19094.7 19114.7 19133.3 19178.6 7484.7 7631.5 7765.3 7992.9 8207.1 4094.9 4163.0 4193.8 4222.7 4348.4 3120.8 3164.7 3166.8 3173.7 3180.2 622.2 634.9 639.1 644.3 655.5 666.3 700.6 702.4 707.2 715.8 8668.3 8902.3 8939.0 8992.9 9154.7 653.6 658.8 664.0 691.2 699.9 4225.5 4282.4 4311.7 4403.8 4463.8 50682.2 50715.0 50962.7 51899.5 55186.0 45732.5 49059.0 53595.0 53734.2 53966.7 46115.8 49761.8 50010.0 50163.5 50176.5 8316.3 8593.5 8885.2 8892.2 9026.0 32204.8 34076.1 34351.0 37240.4 37789.2 46334.0 46908.0 47050.0 47448.8 47637.5 11206.4 11212.2 11469.0 11554.1 11632.3 11207.6 11509.5 11519.4 11762.5 11784.9 11058.4 11082.1 11407.4 11714.3 12086.8 10673.8 10684.7 10804.8 10841.6 11052.8 10298.5 11044.7 11253.4 11342.4 11764.9 9077.6 9107.5 9207.0 9309.3 9390.0 9189.3 9861.3 10341.2 10348.9 10364.0 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:54:57 INFO - 2015-11-20 05:54:57,719 DEBUG : BROWSER_OUTPUT: 05:54:58 INFO - 2015-11-20 05:54:58,365 INFO : Browser exited with error code: 0 05:54:58 INFO - 2015-11-20 05:54:58,381 INFO : Completed test dromaeo_css (00:18:31) 05:54:58 INFO - 2015-11-20 05:54:58,382 INFO : Starting test kraken 05:54:58 INFO - 2015-11-20 05:54:58,382 DEBUG : operating with platform_type : linux_ 05:54:58 INFO - 2015-11-20 05:54:58,382 INFO : Initialising browser for kraken test... 05:54:58 INFO - 2015-11-20 05:54:58,388 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcLTDx5/profile http://localhost:48819/getInfo.html 05:55:03 INFO - 2015-11-20 05:55:03,456 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:55:03 INFO - 2015-11-20 05:55:03,456 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:55:03 INFO - 2015-11-20 05:55:03,457 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:55:03 INFO - 2015-11-20 05:55:03,457 DEBUG : BROWSER_OUTPUT: __metrics 05:55:04 INFO - 2015-11-20 05:55:04,609 INFO : Browser initialized. 05:55:04 INFO - 2015-11-20 05:55:04,610 INFO : Running cycle 1/1 for kraken test... 05:55:04 INFO - 2015-11-20 05:55:04,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcLTDx5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:55:16 INFO - 2015-11-20 05:55:16,417 DEBUG : BROWSER_OUTPUT: RSS: Main: 141864960 05:55:16 INFO - 2015-11-20 05:55:16,417 DEBUG : BROWSER_OUTPUT: 05:55:18 INFO - 2015-11-20 05:55:18,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:19 INFO - 2015-11-20 05:55:19,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 141819904 05:55:19 INFO - 2015-11-20 05:55:19,469 DEBUG : BROWSER_OUTPUT: 05:55:22 INFO - 2015-11-20 05:55:22,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-dft) 05:55:22 INFO - 2015-11-20 05:55:22,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 141979648 05:55:22 INFO - 2015-11-20 05:55:22,688 DEBUG : BROWSER_OUTPUT: 05:55:25 INFO - 2015-11-20 05:55:25,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-fft) 05:55:26 INFO - 2015-11-20 05:55:26,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 137388032 05:55:26 INFO - 2015-11-20 05:55:26,120 DEBUG : BROWSER_OUTPUT: 05:55:28 INFO - 2015-11-20 05:55:28,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48819/tests/kraken/driver.html?testName=audio-oscillator) 05:55:28 INFO - 2015-11-20 05:55:28,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 135671808 05:55:28 INFO - 2015-11-20 05:55:28,682 DEBUG : BROWSER_OUTPUT: 05:55:30 INFO - 2015-11-20 05:55:30,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:31 INFO - 2015-11-20 05:55:31,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 138326016 05:55:31 INFO - 2015-11-20 05:55:31,447 DEBUG : BROWSER_OUTPUT: 05:55:34 INFO - 2015-11-20 05:55:34,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:35 INFO - 2015-11-20 05:55:35,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 137424896 05:55:35 INFO - 2015-11-20 05:55:35,016 DEBUG : BROWSER_OUTPUT: 05:55:38 INFO - 2015-11-20 05:55:38,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48819/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:39 INFO - 2015-11-20 05:55:39,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 138575872 05:55:39 INFO - 2015-11-20 05:55:39,043 DEBUG : BROWSER_OUTPUT: 05:55:41 INFO - 2015-11-20 05:55:41,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48819/tests/kraken/driver.html?testName=json-parse-financial) 05:55:42 INFO - 2015-11-20 05:55:42,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 138596352 05:55:42 INFO - 2015-11-20 05:55:42,458 DEBUG : BROWSER_OUTPUT: 05:55:44 INFO - 2015-11-20 05:55:44,065 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:44 INFO - 2015-11-20 05:55:44,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 138907648 05:55:44 INFO - 2015-11-20 05:55:44,632 DEBUG : BROWSER_OUTPUT: 05:55:46 INFO - 2015-11-20 05:55:46,462 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:47 INFO - 2015-11-20 05:55:47,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 139165696 05:55:47 INFO - 2015-11-20 05:55:47,069 DEBUG : BROWSER_OUTPUT: 05:55:49 INFO - 2015-11-20 05:55:49,146 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:49 INFO - 2015-11-20 05:55:49,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 139329536 05:55:49 INFO - 2015-11-20 05:55:49,748 DEBUG : BROWSER_OUTPUT: 05:55:52 INFO - 2015-11-20 05:55:52,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:52 INFO - 2015-11-20 05:55:52,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 139587584 05:55:52 INFO - 2015-11-20 05:55:52,826 DEBUG : BROWSER_OUTPUT: 05:55:55 INFO - 2015-11-20 05:55:55,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:56 INFO - 2015-11-20 05:55:56,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 139612160 05:55:56 INFO - 2015-11-20 05:55:56,028 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48819/tests/kraken/driver.html?testName=ai-astar) 05:55:57 INFO - 2015-11-20 05:55:57,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 139325440 05:55:57 INFO - 2015-11-20 05:55:57,943 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,947 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:55:57 INFO - 2015-11-20 05:55:57,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:55:57 INFO - 2015-11-20 05:55:57,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:55:57 INFO - 2015-11-20 05:55:57,947 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:55:57 INFO - 2015-11-20 05:55:57,948 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;103;113;110;109;122;110;108;109;109 05:55:57 INFO - 2015-11-20 05:55:57,948 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;124;155;164;125;161;162;125;165;124 05:55:57 INFO - 2015-11-20 05:55:57,948 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;163;161;163;163;164;166;173;162 05:55:57 INFO - 2015-11-20 05:55:57,948 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;72;74;73;72;76;72;128;72 05:55:57 INFO - 2015-11-20 05:55:57,948 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;129;90;90;93;135;90;91;133 05:55:57 INFO - 2015-11-20 05:55:57,949 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;110;111;109;109;109 05:55:57 INFO - 2015-11-20 05:55:57,949 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;145;146;146;178;146 05:55:57 INFO - 2015-11-20 05:55:57,949 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;97;96;97;96;96;96;96 05:55:57 INFO - 2015-11-20 05:55:57,949 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;68;68;65;65;65;68;65;65;62 05:55:57 INFO - 2015-11-20 05:55:57,950 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;72;68;69;69;69;69;73;69;70 05:55:57 INFO - 2015-11-20 05:55:57,950 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;93;86;92;86;86;85;86 05:55:57 INFO - 2015-11-20 05:55:57,950 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;117;125;121;129;133;120;127;126;119 05:55:57 INFO - 2015-11-20 05:55:57,950 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;154;151;158;151;153;152;148;151;138 05:55:57 INFO - 2015-11-20 05:55:57,950 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;68;66;67;67;67;66;69;66;65 05:55:57 INFO - 2015-11-20 05:55:57,951 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:55:57 INFO - 2015-11-20 05:55:57,951 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:55:57 INFO - 2015-11-20 05:55:57,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,703 05:55:57 INFO - 2015-11-20 05:55:57,951 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:55:57 INFO - 2015-11-20 05:55:57,952 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027757945__endTimestamp 05:55:57 INFO - 2015-11-20 05:55:57,952 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,955 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:55:57 INFO - 2015-11-20 05:55:57,955 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:109.50 stddev:4.83 (4.4%) stddev-sans-first:5.10 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: Values: 109.0 103.0 113.0 110.0 109.0 122.0 110.0 108.0 109.0 109.0 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.10 Median:158.50 stddev:18.85 (11.9%) stddev-sans-first:19.65 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: Values: 156.0 124.0 155.0 164.0 125.0 161.0 162.0 125.0 165.0 124.0 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:3.43 (2.1%) stddev-sans-first:3.56 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 163.0 161.0 163.0 163.0 164.0 166.0 173.0 162.0 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.20 Median:72.00 stddev:17.55 (24.4%) stddev-sans-first:18.43 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 74.0 73.0 72.0 76.0 72.0 128.0 72.0 05:55:57 INFO - 2015-11-20 05:55:57,956 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.30 Median:90.50 stddev:20.11 (22.2%) stddev-sans-first:20.83 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 129.0 90.0 90.0 93.0 135.0 90.0 91.0 133.0 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 110.0 111.0 109.0 109.0 109.0 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:149.30 Median:146.00 stddev:10.10 (6.9%) stddev-sans-first:10.68 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 145.0 146.0 146.0 178.0 146.0 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,957 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 97.0 96.0 97.0 96.0 96.0 96.0 96.0 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:2.07 (3.2%) stddev-sans-first:2.00 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: Values: 63.0 68.0 68.0 65.0 65.0 65.0 68.0 65.0 65.0 62.0 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:1.65 (2.4%) stddev-sans-first:1.64 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: Values: 68.0 72.0 68.0 69.0 69.0 69.0 69.0 73.0 69.0 70.0 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,958 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.00 stddev:3.08 (3.6%) stddev-sans-first:3.10 05:55:57 INFO - 2015-11-20 05:55:57,959 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 93.0 86.0 92.0 86.0 86.0 85.0 86.0 05:55:57 INFO - 2015-11-20 05:55:57,959 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,959 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.50 stddev:5.27 (4.2%) stddev-sans-first:5.23 05:55:57 INFO - 2015-11-20 05:55:57,959 DEBUG : BROWSER_OUTPUT: Values: 130.0 117.0 125.0 121.0 129.0 133.0 120.0 127.0 126.0 119.0 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.50 Median:151.50 stddev:6.35 (4.2%) stddev-sans-first:5.48 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: Values: 139.0 154.0 151.0 158.0 151.0 153.0 152.0 148.0 151.0 138.0 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.00 (3.0%) stddev-sans-first:1.20 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: Values: 72.0 68.0 66.0 67.0 67.0 67.0 66.0 69.0 66.0 65.0 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:55:57 INFO - 2015-11-20 05:55:57,960 DEBUG : BROWSER_OUTPUT: 05:55:58 INFO - 2015-11-20 05:55:58,741 INFO : Browser exited with error code: 0 05:55:58 INFO - 2015-11-20 05:55:58,796 INFO : Completed test kraken (00:01:00) 05:55:58 INFO - 2015-11-20 05:55:58,796 INFO : Starting test v8_7 05:55:58 INFO - 2015-11-20 05:55:58,796 DEBUG : operating with platform_type : linux_ 05:55:58 INFO - 2015-11-20 05:55:58,796 INFO : Initialising browser for v8_7 test... 05:55:58 INFO - 2015-11-20 05:55:58,802 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL7EA5d/profile http://localhost:48819/getInfo.html 05:56:03 INFO - 2015-11-20 05:56:03,543 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:56:03 INFO - 2015-11-20 05:56:03,543 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:56:03 INFO - 2015-11-20 05:56:03,543 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/668 05:56:03 INFO - 2015-11-20 05:56:03,543 DEBUG : BROWSER_OUTPUT: __metrics 05:56:04 INFO - 2015-11-20 05:56:04,637 INFO : Browser initialized. 05:56:04 INFO - 2015-11-20 05:56:04,638 INFO : Running cycle 1/1 for v8_7 test... 05:56:04 INFO - 2015-11-20 05:56:04,638 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpL7EA5d/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:56:16 INFO - 2015-11-20 05:56:16,499 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 05:56:16 INFO - 2015-11-20 05:56:16,500 DEBUG : BROWSER_OUTPUT: 05:56:37 INFO - 2015-11-20 05:56:37,877 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48819/tests/v8_7/run.html (next: http://localhost:48819/tests/v8_7/run.html) 05:56:38 INFO - 2015-11-20 05:56:38,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 138739712 05:56:38 INFO - 2015-11-20 05:56:38,128 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,128 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:56:38 INFO - 2015-11-20 05:56:38,129 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:56:38 INFO - 2015-11-20 05:56:38,129 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:56:38 INFO - 2015-11-20 05:56:38,129 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:56:38 INFO - 2015-11-20 05:56:38,130 DEBUG : BROWSER_OUTPUT: |0;Richards;165.72754391779912 05:56:38 INFO - 2015-11-20 05:56:38,130 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.34468166955185 05:56:38 INFO - 2015-11-20 05:56:38,130 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 05:56:38 INFO - 2015-11-20 05:56:38,131 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5055.555555555556 05:56:38 INFO - 2015-11-20 05:56:38,131 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1055.9662090813094 05:56:38 INFO - 2015-11-20 05:56:38,131 DEBUG : BROWSER_OUTPUT: |5;Earley;752.4454477050414 05:56:38 INFO - 2015-11-20 05:56:38,131 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 05:56:38 INFO - 2015-11-20 05:56:38,131 DEBUG : BROWSER_OUTPUT: |7;RegExp;25375 05:56:38 INFO - 2015-11-20 05:56:38,133 DEBUG : BROWSER_OUTPUT: |8;Splay;670.0133868808567 05:56:38 INFO - 2015-11-20 05:56:38,133 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4854.368932038835 05:56:38 INFO - 2015-11-20 05:56:38,133 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:56:38 INFO - 2015-11-20 05:56:38,134 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027798127__endTimestamp 05:56:38 INFO - 2015-11-20 05:56:38,134 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,134 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:56:38 INFO - 2015-11-20 05:56:38,134 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:56:38 INFO - 2015-11-20 05:56:38,134 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,135 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,135 DEBUG : BROWSER_OUTPUT: Values: 165.7 05:56:38 INFO - 2015-11-20 05:56:38,135 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,135 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.34 Median:192.34 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,136 DEBUG : BROWSER_OUTPUT: Values: 192.3 05:56:38 INFO - 2015-11-20 05:56:38,136 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,136 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,136 DEBUG : BROWSER_OUTPUT: Values: 282.1 05:56:38 INFO - 2015-11-20 05:56:38,136 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5055.56 Median:5055.56 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: Values: 5055.6 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: Values: 1056.0 05:56:38 INFO - 2015-11-20 05:56:38,137 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,138 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:752.45 Median:752.45 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,138 DEBUG : BROWSER_OUTPUT: Values: 752.4 05:56:38 INFO - 2015-11-20 05:56:38,138 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,138 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,139 DEBUG : BROWSER_OUTPUT: Values: 11964.3 05:56:38 INFO - 2015-11-20 05:56:38,139 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,139 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,139 DEBUG : BROWSER_OUTPUT: Values: 25375.0 05:56:38 INFO - 2015-11-20 05:56:38,140 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,140 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:670.01 Median:670.01 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,140 DEBUG : BROWSER_OUTPUT: Values: 670.0 05:56:38 INFO - 2015-11-20 05:56:38,140 DEBUG : BROWSER_OUTPUT: 05:56:38 INFO - 2015-11-20 05:56:38,141 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:56:38 INFO - 2015-11-20 05:56:38,141 DEBUG : BROWSER_OUTPUT: Values: 4854.4 05:56:38 INFO - 2015-11-20 05:56:38,141 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:56:38 INFO - 2015-11-20 05:56:38,141 DEBUG : BROWSER_OUTPUT: 05:56:39 INFO - 2015-11-20 05:56:39,049 INFO : Browser exited with error code: 0 05:56:39 INFO - 2015-11-20 05:56:39,066 INFO : Completed test v8_7 (00:00:40) 05:56:39 INFO - 2015-11-20 05:56:39,161 INFO : Completed test suite (00:20:12) 05:56:39 INFO - 2015-11-20 05:56:39,162 DEBUG : Working with test: dromaeo_css 05:56:39 INFO - 2015-11-20 05:56:39,162 DEBUG : Generating results file: dromaeo_css 05:56:39 INFO - 2015-11-20 05:56:39,163 DEBUG : Working with test: kraken 05:56:39 INFO - 2015-11-20 05:56:39,163 DEBUG : Generating results file: kraken 05:56:39 INFO - 2015-11-20 05:56:39,163 INFO : javascript benchmark 05:56:39 INFO - 2015-11-20 05:56:39,163 DEBUG : Working with test: v8_7 05:56:39 INFO - 2015-11-20 05:56:39,164 DEBUG : Generating results file: v8_7 05:56:39 INFO - 2015-11-20 05:56:39,164 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:39 INFO - 2015-11-20 05:56:39,221 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 05:56:39 INFO - 2015-11-20 05:56:39,221 DEBUG : process_Request line: dromaeo_css 7030.10 graph.html#tests=[[72,1,43]] 05:56:39 INFO - 2015-11-20 05:56:39,221 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:39 INFO - 2015-11-20 05:56:39,250 DEBUG : process_Request line: kraken 1520.00 graph.html#tests=[[232,1,43]] 05:56:39 INFO - 2015-11-20 05:56:39,250 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:56:39 INFO - 2015-11-20 05:56:39,281 DEBUG : process_Request line: v8_7 21096.85 graph.html#tests=[[230,1,43]] 05:56:39 INFO - 2015-11-20 05:56:39,282 INFO : javascript benchmark 05:56:39 INFO - 2015-11-20 05:56:39,286 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3254.3165935153615, 3292.489664102065, 3327.168207948013, 3344.4648856183007, 3345.448001079822, 5324.494173053564, 5473.890522189554, 5488.094464413372, 5494.120940649497, 5502.064649009668, 5427.3215848019, 5432.70120143392, 5487.341519017714, 5521.4478552144765, 5591.049521581331, 4966.354373931384, 5061.949380506203, 5096.362954630671, 5143.43422223557, 5145.253938178962, 4985.825496107637, 5062.417821950467, 5102.234664800272, 5132.40977287613, 5196.92204616931, 4864.659473836833, 4991.176455884774, 5108.795648174088, 5128.35895513059, 5129.384473863123, 5030.346055012825, 5045.596352291845, 5065.8733531662, 5077.035363281002, 5079.466656001104, 4993.425756038029, 4998.075356059105, 4999.8250061248045, 5013.874653133665, 5058.696478211319, 5156.845294641167, 5242.973785131088, 5271.051210782058, 5283.181106928432, 5293.04725149473, 5913.172155898178, 5921.644701317891, 6000.699965001776, 6003.27960644721, 6056.5457590680435, 5993.130996005555, 6015.368386319417, 6016.909746353808, 6020.307664618537, 6023.066424704134, 5475.780968761205, 5582.218489411485, 5692.686902220335, 5696.77212911483, 5701.230333904911, 6075.088736689532, 6173.043178307369, 6175.59858609189, 6177.382261773787, 6186.979148440547, 5796.510152600008, 5862.736176872051, 5866.882662346729, 5875.236219291465, 5910.0, 5805.274340707411, 5844.298684157843, 5906.852328691817, 5937.970310148422, 5957.880842383128, 5939.792107276225, 5955.642661440327, 5963.731632076567, 5964.373740757158, 5979.1629171915965, 5975.701214939236, 5982.611130276518, 5984.760609575568, 5988.790392336247, 6016.2479690038745, 4462.41988541494, 4549.795259213343, 4567.748773817472, 4588.26587745959, 4637.3275874997935, 4121.237571049365, 4129.752214867058, 4129.855455059119, 4136.276151673445, 4165.354370072643, 5728.570357223225, 5735.139729040678, 5758.222639943638, 5768.5728310830345, 5812.534997200214, 5787.421257874179, 5816.796412125555, 5871.383504731942, 5876.08920617305, 5949.8215053548465, 5665.263515742927, 5701.629394089371, 5720.456556627114, 5742.397048309867, 5750.654960702372, 5250.107481728115, 5252.185911183773, 5255.894882102337, 5256.999999999924, 5299.655522391032, 5920.171176035358, 6096.0, 6119.07606531266, 6224.066390041439, 6255.40573645503, 5971.462568368867, 6054.7275372607455, 6062.42406971337, 6071.635701857903, 6101.633901965896, 6012.518998480024, 6196.194494715658, 6215.720292586754, 6241.469475094668, 6247.96876015617, 5805.477507024388, 5842.444967728059, 5881.0, 5906.940930590639, 5943.851403714942, 5896.439838215363, 5919.733611987557, 5920.200772895604, 5970.104484327386, 5981.102834574848, 5598.412166722435, 5837.416258374298, 5842.737076831468, 5844.211031510692, 5847.649141051551, 5706.058500347563, 5774.913376299275, 5827.4172582741385, 5828.0966450200285, 5879.353271140257, 5758.740856661544, 5779.162021506942, 5783.652980821164, 5811.76752929895, 5829.271341082364, 5727.140928860705, 5852.239208902815, 5897.587168898136, 5915.70421478933, 5932.970335148297, 5644.181593668977, 5709.371969083314, 5741.081426971665, 5744.109663002241, 5793.797217097382], "unit": "ms", "name": "dojo.html", "value": 5497.228152433306}, {"lowerIsBetter": false, "replicates": [560.5667310387339, 599.3556926304224, 601.7502736364409, 604.811545313459, 605.5488660947593, 40004.79997600012, 40589.39115913256, 40684.59315406845, 40843.0, 40928.38607420891, 42432.36351454731, 42619.0, 42731.572684273226, 42753.0, 42962.14075718484, 8716.607752651114, 8884.733457996239, 8925.41984770991, 8954.955225223865, 8972.371933964592, 8675.349348798834, 8739.60671769772, 8777.29781617469, 8787.428817126898, 8813.206811386974, 8760.780980475507, 8790.120987901222, 8790.16493433126, 8812.691555795549, 8817.647294108228, 8732.650693972266, 8768.386212965095, 8807.339449541278, 8810.647574097029, 8863.734087977371, 8660.350473714496, 8709.869351959725, 8799.384043116985, 8810.515421651806, 8831.602577883947, 40585.391219131736, 40904.590954090374, 41007.38488922668, 41101.38347924784, 41128.177436451406, 3382.391169589473, 3482.547268855058, 3638.126849556114, 3671.375866102769, 3846.442265871461, 30072.699273007427, 30661.846690766626, 30755.692443075506, 30771.384572308427, 30828.53757193644, 3884.378499440076, 3885.4754608128105, 4022.0950286185666, 4114.465119534471, 4139.379093136024, 273010.0, 274283.0, 274525.0, 274902.999999998, 275472.0, 60587.0, 60799.392006080256, 60825.39174608286, 60951.0, 60968.695156524824, 63468.682656586425, 64121.679391602745, 64728.35271647223, 73136.63431682914, 74050.25949740433, 15253.23733813327, 15458.690826183414, 15489.605935465863, 15519.379224831106, 15641.765373519407, 11625.941870290764, 11783.646490605295, 11802.291862488279, 11817.290962542274, 11842.111841611913, 20703.482412939797, 21081.472963176042, 21161.470963226042, 21164.682529762067, 21179.0, 8081.595920203967, 8217.0, 8267.462614930011, 8323.708670196515, 8398.496090234605, 965.7344230336713, 972.5963725054023, 993.0020329568737, 1005.3163848583034, 1023.0485648347109, 28153.0, 28974.0, 29121.56317655237, 29810.55284170739, 30383.10299973572, 972.5137431284357, 1002.0981116994617, 1013.2653825976108, 1016.3038318751679, 1033.266380869576, 15212.771808422662, 15412.383504659689, 15418.383264669512, 15449.613759656098, 15490.9225453872, 403220.0, 407676.0, 408178.0, 408336.0, 408872.0, 53005.7349713249, 53040.469595303555, 53503.73248133734, 53614.0, 53625.463745362824, 1329.84706758724, 1354.1671871798774, 1363.1412210307442, 1365.0512893539094, 1469.0, 27886.0, 28693.569596456487, 28747.0, 28916.855415722788, 29066.27334316659, 46162.307565385876, 46507.0, 46698.29952550783, 46725.299120512536, 46777.76611116923, 298777.0, 299765.0, 302204.0, 302215.0, 302283.0, 29571.408571828873, 30104.54843177398, 31595.368092638477, 31745.365092698477, 32385.0, 40416.59583404246, 41631.37552936769, 41781.0, 42579.14841703087, 42733.7179884604, 35503.0, 35865.46201806923, 36699.53201871895, 36931.0, 37388.0, 36778.448323274635, 37913.81043094767, 41246.0, 42111.7894410526, 42341.576584233764, 35143.47284790679, 36237.818810905774, 36726.0, 36890.81554592317, 36938.0, 31682.524762128127, 34806.65193348034, 34824.303513930085, 35056.29887402289, 35530.46704299489, 25191.0, 25206.62190067187, 25390.0, 25447.872760636077, 25548.23355299344], "unit": "ms", "name": "ext.html", "value": 19036.02783288805}, {"lowerIsBetter": false, "replicates": [355.9590647075587, 357.6048466444579, 358.678982310832, 359.30474531781005, 364.63718599993, 14745.557633270992, 15123.546293611196, 16647.25087371068, 18625.44123676292, 19546.902265488687, 11192.272502287346, 13578.864211357883, 15682.215889205523, 16725.498235052968, 16865.83134168661, 4904.901901961958, 5028.321176641161, 5031.84904452867, 5033.597312215014, 5035.269885866565, 4942.827001054964, 4949.356583644121, 4981.825636102737, 4982.750862456863, 4998.950010499903, 4856.854294371175, 4973.676711013791, 4997.625178111638, 5006.54941055305, 5129.204973229155, 5116.948830511722, 5118.692878427288, 5120.462351453081, 5140.1004824156, 5180.922286165711, 4927.088488629579, 5257.579393648499, 5265.183896496049, 5284.656497327662, 5288.2596436498925, 12226.0, 12279.508819647204, 12480.063995200306, 12781.297028663419, 12799.5520156795, 1994.5113447205383, 2017.7175195472646, 2068.1520576563535, 2131.914723411062, 2168.349495151464, 9310.0, 9336.206422454099, 9403.059694030611, 10910.290831095954, 12635.87364126356, 1736.8436840684399, 1758.446089481822, 1771.5482551949299, 1781.385422029398, 1827.232562323827, 60131.39868601302, 62655.37344626541, 63045.369546304406, 63085.68457157731, 64337.67831160814, 10014.39913605186, 10175.185985121321, 10317.329373590692, 10372.948135259427, 10403.323783954018, 13613.0, 13647.317634118255, 13652.795208071886, 13657.658558536115, 13663.795043074362, 7512.286332798375, 7540.17058123606, 7582.658780354897, 7606.315431611071, 7702.460827742004, 7095.751648692271, 7110.3600675939415, 7123.216446190915, 7171.211166771651, 7175.964120179366, 4406.2949928012, 4417.580329868657, 4422.933655995163, 4458.866234012985, 4516.345129956138, 1767.1164417791103, 1767.142935676196, 1810.7646006019133, 1847.3164928976364, 1855.1002763659615, 399.75015615240477, 407.3889166250624, 415.77963679250047, 425.987220383389, 900.9459432434074, 10230.23273254509, 10415.375077495222, 10487.632932847466, 10588.10001149911, 10654.73363165927, 427.9293916503742, 436.92572262715413, 450.90305584299534, 455.43071161048687, 460.9262517997104, 4867.3915760529935, 5808.912866307009, 5824.475797178275, 5841.094630332305, 5876.706164691834, 534536.0, 542525.0, 543108.0, 548138.0, 557572.0, 78474.6076269615, 81478.59260703778, 82881.0, 83973.0, 85719.0, 472.85577898740524, 473.4933621025539, 476.4663576793944, 476.5091955286061, 478.2014036558955, 9851.802963940825, 9946.602135914773, 14583.489577865148, 15057.247137643293, 16251.0, 34551.82724086363, 34887.476687849194, 34953.65046349504, 35901.82049089738, 36216.81891590525, 45101.0, 47127.0, 47452.7627361861, 48076.75961620169, 48875.26687099625, 9621.90378096238, 9756.560954756911, 9773.169280610944, 9807.509624518889, 9959.302848800804, 17689.115544222994, 17811.198496067966, 18014.36949706754, 18142.0, 18153.727694084337, 13708.45166193381, 14383.496577619733, 14477.348519316445, 14562.053466525065, 14622.561323160322, 14569.615886490767, 14795.926020369829, 14796.926015370285, 15408.306626202071, 15417.383304667688, 13830.101043432145, 14022.509212177525, 14107.506237281646, 14407.207603581903, 14441.422343106158, 9355.578998944928, 9475.389183838626, 9650.276229282692, 9715.514224288898, 9789.0, 13670.93164534171, 14196.29018549089, 14571.761400281095, 14652.853471465576, 14856.257187140816], "unit": "ms", "name": "jquery.html", "value": 7947.91935135671}, {"lowerIsBetter": false, "replicates": [1459.5840185547117, 1524.6493306539498, 1595.7765912772222, 1621.481126039667, 1716.0390181498362, 7522.849543009143, 7667.23327667233, 7748.070231572212, 7775.261350171739, 7930.92069079309, 7884.724034658788, 7924.366050715943, 7976.122626511079, 7979.361651067915, 7986.081600615931, 2274.715660542428, 2313.884305784704, 2316.4672125411166, 2317.44381348476, 2319.617263151578, 2238.955220895581, 2289.1186893046215, 2296.552172326397, 2299.4366380236866, 2345.906163753448, 2235.3629215673536, 2244.708187935566, 2261.604219261631, 2279.350385140235, 2292.197730794217, 2257.582347265761, 2265.988670056639, 2309.8960546775434, 2313.0400883633356, 2314.89582968766, 2313.664518644804, 2329.5690297295055, 2337.614293641547, 2339.017612602694, 2345.108858633708, 7617.619119044026, 7683.615819209017, 7729.227077292226, 7765.30112289891, 7791.259830316111, 4643.8374656886845, 4689.742064186468, 4700.224462963641, 4727.243641017455, 4758.0, 3196.488561830096, 3229.273413481971, 3237.3687131009465, 3263.461528847737, 3309.470484722433, 1107.545906178463, 1119.764849381631, 1128.6049882541126, 1137.590467431724, 1143.2054721968236, 10451.320664156805, 10495.527701253386, 10503.264771466, 10550.62841830557, 10554.0, 4067.5525692173837, 4074.0425999890003, 4079.816408261576, 4159.646430053419, 4178.080822219107, 8646.092160323202, 8658.48049117055, 8668.696595619123, 8693.91306086931, 8724.563771811385, 4574.473935497461, 4601.723896566216, 4610.561996610317, 4611.5619016193405, 4631.258998560214, 4215.473065866767, 4226.028013556837, 4253.04306531028, 4280.571942805695, 4285.100128972888, 3463.255400088993, 3490.5636795400574, 3494.056604716712, 3498.1954150545007, 3508.754387192872, 1057.3285963413134, 1059.9788004239872, 1064.2231171245035, 1065.760203954104, 1068.5405275731355, 1068.957241710323, 1072.694282129605, 1106.0156460749938, 1230.477047254913, 1345.8115863779078, 7181.928180718231, 7237.746678866214, 7239.20368759436, 7295.306945840137, 7403.074615673041, 1131.4569006876745, 1135.7501349703052, 1138.4535422996842, 1145.4421986098898, 1162.1922763679163, 5719.942800572025, 5730.885382292331, 5739.426057394227, 5741.799037033684, 5789.681567513743, 8906.421082629739, 9043.502607356528, 9362.391444556082, 9424.104710052534, 9449.90550094504, 9184.540772961325, 9236.630534778667, 9240.630374785067, 9250.352475326663, 9348.01845806194, 7108.253633368422, 7176.282371762886, 7219.494635375473, 7222.855542889113, 7307.3423391894985, 6947.826304342432, 6995.580265184105, 6998.020277161303, 7005.54463959841, 7013.473989450709, 8003.91996080055, 8125.3905957052275, 8159.26566609008, 8285.627146778288, 8325.25072743456, 8402.369822263478, 8505.106963768716, 8578.227959483676, 8613.526256055977, 8696.17386348296, 6584.0, 6661.0, 6906.102206713095, 6942.930570694229, 6958.582485050913, 7531.096268447822, 7563.546187228784, 7579.355754760907, 7586.658600363107, 7590.506617070094, 6638.269790322964, 6761.391474767294, 6945.270746571739, 6955.652217389009, 6974.860502790018, 6675.132232809704, 6876.965615171892, 6917.308269173042, 6958.965205174144, 6997.020417141706, 6990.580565166107, 7043.859122817413, 7046.365827075588, 7048.647567621701, 7051.294870512907, 6383.170187875547, 6493.642849643126, 6494.0258961156205, 6502.0246962955935, 6507.577007494498, 6445.323241059621, 6465.418112369909, 6487.578307410004, 6500.122483464861, 6521.641309727821], "unit": "ms", "name": "mootools.html", "value": 4477.1325355962335}, {"lowerIsBetter": false, "replicates": [329.42022041207474, 332.29553346904567, 336.34245050925443, 339.96430374810643, 342.3512443918774, 6284.465820405259, 6306.779262725806, 6346.4288214060725, 6379.266384365799, 6395.808125756229, 6157.38426157384, 6335.398137176972, 6342.0803983422375, 6343.080253363271, 6350.206224221973, 4824.107540105074, 4838.879028024292, 4846.369971903648, 4847.12751704693, 4870.293807397925, 4855.053264613402, 4860.465348811628, 4869.756512174377, 4876.2198048312275, 4882.2432522959, 4733.621310295168, 4810.831620893269, 4812.566868981791, 4813.181759100944, 4831.903361932759, 4792.137415265251, 4799.976000119995, 4805.975970120162, 4809.78355973982, 4831.758412079382, 4207.305794543897, 4215.409842622035, 4220.978895105505, 4234.06850492891, 4240.851570195059, 5939.584229103964, 5985.850353741148, 6014.96992515039, 6020.8494787630225, 6024.939750602482, 5567.387587365427, 5626.156076588503, 5639.887202255973, 5654.575906807006, 5654.886902261973, 6686.297938716413, 6701.3968742812895, 6701.821907879958, 6704.7988560343265, 6706.865862682719, 4695.131400690883, 4700.177468942956, 4701.341812146302, 4706.835260765857, 4710.458297295821, 6819.624920629363, 6889.448844092461, 6973.302669733037, 6976.441884649266, 6988.336108069776, 4784.569388754959, 4794.5924596408995, 4803.639727020418, 4804.231322988305, 4805.831795887128, 4852.636052296092, 4859.1010663027455, 4863.975680121577, 4866.1727506323305, 4871.098846713369, 5621.325440947031, 5628.099504079328, 5631.7184140793615, 5641.576881733887, 5643.1535269709875, 6489.351064893567, 6645.800625981228, 6668.733250670016, 6706.899396509057, 6710.429613482908, 1661.3188592676945, 1695.1693670101808, 1722.4670043661151, 1731.97402038967, 1737.409280844519, 1151.7581307925261, 1162.0645380468634, 1170.0639488409408, 1176.2707121584672, 1176.7117056321256, 6442.098106265126, 6448.419642232127, 6467.482601391877, 6468.3855033771715, 6496.642684652389, 6842.897356539655, 6876.931230687729, 6902.896456553156, 6905.274946130584, 6908.171019477695, 6325.082862984841, 6428.389303016206, 6451.774187903401, 6459.709313080923, 6465.612063276219, 3794.1842503861803, 3799.2211596622624, 3814.504114465102, 3828.8277027533272, 3829.100161462054, 7300.853982920312, 7313.414926805843, 7346.5592064476305, 7357.705691772269, 7363.631818409058, 7025.999999999898, 7233.819154521179, 7237.276272372721, 7256.528325658815, 7262.055932728817, 7282.159957616534, 7295.854082918312, 7329.157146928065, 7335.8532829344185, 7341.926580734231, 6932.792016239521, 7002.124734408199, 7015.789526314219, 7015.894761578683, 7019.824504387227, 6719.193696756421, 6909.7581584644295, 6922.446204303745, 6963.9651801740665, 6968.581885086911, 7195.568265904062, 7315.597642129734, 7331.41348692114, 7356.337929586363, 7371.262873712586, 4609.51600082, 4609.838655647036, 4618.607418369476, 4623.352730617784, 4634.930476042795, 6796.35434633709, 6819.181698196248, 6936.514443988873, 6957.199922009034, 6968.128983877015, 6722.529422940347, 6741.2921643226755, 6745.494087943522, 6746.055552222595, 6760.290169532128, 6671.966640166962, 6677.165354330708, 6680.198376194888, 6730.394264516217, 6815.182178138655, 6524.086627872007, 6593.80218593443, 6620.404163625297, 6641.302663220292, 6641.302663220486, 6732.495062870402, 6740.427063699444, 6786.287439818748, 6789.932100679128, 6800.863982720417, 6583.604983700993, 6610.305917878553, 6613.305602911817, 6622.63575503352, 6634.237062737847], "unit": "ms", "name": "prototype.html", "value": 5077.342602091202}, {"lowerIsBetter": false, "replicates": [816.7713040348702, 822.5023860564359, 843.1315744782872, 847.6355167278072, 883.6818745251712, 12256.938715306422, 12374.19567728097, 12376.319302438362, 12552.05859560532, 12562.497500099997, 13099.73800523989, 13231.933840330785, 13248.07263491556, 13267.800982985264, 13268.0, 663.0716996205327, 677.8745932002571, 805.3154818404367, 821.4003777242586, 821.8685010398337, 803.3533005930224, 813.8372325534887, 814.9918500815005, 815.8857759913587, 818.5661599352353, 855.9101294364095, 857.4426622695236, 859.3168431097292, 862.5773371048173, 862.6980556805131, 845.970391036317, 849.0575461238021, 850.685246458808, 852.0286872964825, 852.654674856684, 635.0284065379976, 635.2186810223404, 635.2218532297898, 635.5138319185827, 640.1390130274773, 13493.122947008413, 13601.183928964196, 13641.931790341085, 13648.976326775532, 13659.658508537266, 12206.267623942593, 12440.75118497625, 12517.374131293398, 12688.429020694091, 12718.10973231874, 10403.427811470367, 10490.685279441628, 10532.210084243636, 10561.894381056169, 10646.520906559223, 3578.481120237577, 3654.3239500692457, 3660.432632941898, 3706.7405281630295, 3741.4387841823673, 48054.519454805704, 48420.51579484231, 48461.0, 48545.27182092272, 48569.51430485685, 10088.0, 10187.388756674623, 10199.18406527476, 10379.273450858367, 10514.3691378516, 18999.0, 19094.71357929632, 19114.71327930082, 19133.33033343826, 19178.616427671368, 7484.663190156347, 7631.54210747357, 7765.339946104531, 7992.880106798402, 8207.138250483613, 4094.8566800161852, 4163.0, 4193.832246710159, 4222.725522841006, 4348.434703488526, 3120.797148185406, 3164.730997865161, 3166.762492813002, 3173.6829215875614, 3180.220845892771, 622.1569772957668, 634.8571571396491, 639.1180171363488, 644.3234603666132, 655.4788942790493, 666.2870728320747, 700.6426722371525, 702.3819039245432, 707.2114592229627, 715.8031541326177, 8668.306535477273, 8902.332325075646, 8938.955305223431, 8992.89903059806, 9154.725358239264, 653.6306986552582, 658.8122385120217, 663.9634820084942, 691.2499937567695, 699.8985147153634, 4225.514065882401, 4282.443282373334, 4311.698181127291, 4403.823847046082, 4463.843765468193, 50682.23976640353, 50715.0, 50962.74518627457, 51899.48100519022, 55186.0, 45732.542674572825, 49059.0, 53595.0, 53734.19398709023, 53966.73016634892, 46115.769421152676, 49761.75119124381, 50010.0, 50163.49836501661, 50176.498235017185, 8316.251537361666, 8593.484390936565, 8885.244754195708, 8892.199702026848, 9026.0, 32204.83897580497, 34076.14809629779, 34351.0, 37240.441393378576, 37789.244215116094, 46334.0, 46908.0, 47050.0, 47448.762756186, 47637.5236247647, 11206.43967801623, 11212.215144939775, 11469.0, 11554.133439991867, 11632.302061876315, 11207.551697932318, 11509.482073306554, 11519.383148578589, 11762.470688818852, 11784.941075294568, 11058.391788451712, 11082.113430925669, 11407.37259450705, 11714.297142171497, 12086.758264834478, 10673.786524269315, 10684.679459616224, 10804.783904321712, 10841.566337346418, 11052.778944421227, 10298.536565854405, 11044.668659940215, 11253.381064041556, 11342.432878356214, 11764.939054603044, 9077.636894524145, 9107.453552786854, 9207.0, 9309.301802364715, 9390.0, 9189.310801689766, 9861.260405469475, 10341.172706183337, 10348.896511034793, 10364.0], "unit": "ms", "name": "yui.html", "value": 6384.4387523927735}], "name": "dromaeo_css", "value": 7030.100073671554}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 103.0, 113.0, 110.0, 109.0, 122.0, 110.0, 108.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 155.0, 164.0, 125.0, 161.0, 162.0, 125.0, 165.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 163.0, 164.0, 166.0, 173.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 74.0, 73.0, 72.0, 76.0, 72.0, 128.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.2}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 129.0, 90.0, 90.0, 93.0, 135.0, 90.0, 91.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 111.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 178.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 149.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 68.0, 65.0, 65.0, 65.0, 68.0, 65.0, 65.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 65.4}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 68.0, 69.0, 69.0, 69.0, 69.0, 73.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.6}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 93.0, 86.0, 92.0, 86.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [130.0, 117.0, 125.0, 121.0, 129.0, 133.0, 120.0, 127.0, 126.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [139.0, 154.0, 151.0, 158.0, 151.0, 153.0, 152.0, 148.0, 151.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.5}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 69.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.3}], "name": "kraken", "value": 1519.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "Richards", "value": 213.01226799999995}, {"lowerIsBetter": false, "replicates": [192.34468166955185], "unit": "score", "name": "DeltaBlue", "value": 343.7474820000001}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [5055.555555555556], "unit": "score", "name": "Decrypt", "value": 52.65118681318681}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [752.4454477050414], "unit": "score", "name": "Earley", "value": 885.7293270000002}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [25375.0], "unit": "score", "name": "RegExp", "value": 35.90088669950742}, {"lowerIsBetter": false, "replicates": [670.0133868808567], "unit": "score", "name": "Splay", "value": 121.62592807192812}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 21096.84916306049}]} 05:56:39 INFO - RETURN: dromaeo_css: 7030.10 05:56:39 INFO - RETURN: kraken: 1520.00 05:56:39 INFO - RETURN: v8_7: 21096.85 05:56:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,43]]", "result": "21096.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1520.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7030.10"}}} 05:56:39 INFO - Return code: 0 05:56:39 INFO - # TBPL SUCCESS # 05:56:39 INFO - Running post-action listener: _resource_record_post_action 05:56:39 INFO - Running post-run listener: _resource_record_post_run 05:56:40 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 24576; Write bytes: 517910528; Read time: 40; Write time: 794652 05:56:40 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 241913856; Read time: 0; Write time: 532980 05:56:40 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 24576; Write bytes: 275992576; Read time: 40; Write time: 259888 05:56:40 INFO - Running post-run listener: _upload_blobber_files 05:56:40 INFO - Blob upload gear active. 05:56:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:56:40 INFO - Copying logs to upload dir... 05:56:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1263.719907 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-20 05:56:40.363258) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:40.366457) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009923 build_url: 'https://queue.taskcluster.net/v1/task/ob-EmXfDQjWAye0_l10YvQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:40.419019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:40.419413) ========= 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=76a4ffbc7ba64825c1a171dc000001de-1448026129.747515-2081040021 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:56:40.468807) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:56:40.469123) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:56:40.469405) ========= ========= Total master_lag: 0.24 =========