builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo
slave: talos-linux64-ix-039
starttime: 1451520209.17
results: success (0)
buildid: 20151230133836
builduid: 3ce91322b7e4426eb46210a66e3b973f
revision: 839dd566125d53b477bcd3838c33ac824d06dced
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.171393) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.171867) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.172170) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
/builds/slave/test-pgo
program finished with exit code 0
elapsedTime=0.006335
basedir: '/builds/slave/test-pgo'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.201287) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.201631) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.269205) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.269635) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.025303
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.319061) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.319374) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.319730) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.320014) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2015-12-30 16:03:29-- 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% 222M=0s
2015-12-30 16:03:29 (222 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.336337
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.672924) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.673271) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.088814
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.774315) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:29.774925) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 839dd566125d53b477bcd3838c33ac824d06dced --destination scripts --debug'
in dir /builds/slave/test-pgo/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 839dd566125d53b477bcd3838c33ac824d06dced --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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2015-12-30 16:03:29,867 truncating revision to first 12 chars
2015-12-30 16:03:29,867 Setting DEBUG logging.
2015-12-30 16:03:29,867 attempt 1/10
2015-12-30 16:03:29,867 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/839dd566125d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2015-12-30 16:03:30,121 unpacking tar archive at: mozilla-aurora-839dd566125d/testing/mozharness/
program finished with exit code 0
elapsedTime=0.535920
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:30.327206) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:30.327718) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:30.339628) =========
========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:30.340198) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 16:03:30.340912) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-30 16:03:30.341418) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora
in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora']
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
16:03:30 INFO - MultiFileLogger online at 20151230 16:03:30 in /builds/slave/test-pgo
16:03:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora
16:03:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json.
16:03:30 INFO - {'append_to_log': False,
16:03:30 INFO - 'base_work_dir': '/builds/slave/test-pgo',
16:03:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora',
16:03:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt',
16:03:30 INFO - 'branch': 'Mozilla-Aurora',
16:03:30 INFO - 'buildbot_json_path': 'buildprops.json',
16:03:30 INFO - 'config_files': ('talos/linux_config.py',),
16:03:30 INFO - 'default_actions': ('clobber',
16:03:30 INFO - 'read-buildbot-config',
16:03:30 INFO - 'download-and-extract',
16:03:30 INFO - 'populate-webroot',
16:03:30 INFO - 'create-virtualenv',
16:03:30 INFO - 'install',
16:03:30 INFO - 'run-tests'),
16:03:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
16:03:30 INFO - 'download_minidump_stackwalk': True,
16:03:30 INFO - 'download_symbols': 'ondemand',
16:03:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
16:03:30 INFO - 'tooltool.py': '/tools/tooltool.py',
16:03:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
16:03:30 INFO - '/tools/misc-python/virtualenv.py')},
16:03:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
16:03:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
16:03:30 INFO - 'installer_path': 'installer.exe',
16:03:30 INFO - 'log_level': 'info',
16:03:30 INFO - 'log_name': 'talos',
16:03:30 INFO - 'log_to_console': True,
16:03:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
16:03:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
16:03:30 INFO - 'opt_config_files': (),
16:03:30 INFO - 'pip_index': False,
16:03:30 INFO - 'sps_profile': False,
16:03:30 INFO - 'sps_profile_interval': 0,
16:03:30 INFO - 'suite': 'dromaeojs-e10s',
16:03:30 INFO - 'system_bits': '32',
16:03:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
16:03:30 INFO - 'title': 'talos-linux64-ix-039',
16:03:30 INFO - 'tooltool_cache': '/builds/tooltool_cache',
16:03:30 INFO - 'use_talos_json': True,
16:03:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv',
16:03:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
16:03:30 INFO - 'work_dir': 'build'}
16:03:30 INFO - #####
16:03:30 INFO - ##### Running clobber step.
16:03:30 INFO - #####
16:03:30 INFO - Running pre-action listener: _resource_record_pre_action
16:03:30 INFO - Running main action method: clobber
16:03:30 INFO - rmtree: /builds/slave/test-pgo/build
16:03:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1
16:03:34 INFO - Running post-action listener: _resource_record_post_action
16:03:34 INFO - #####
16:03:34 INFO - ##### Running read-buildbot-config step.
16:03:34 INFO - #####
16:03:34 INFO - Running pre-action listener: _resource_record_pre_action
16:03:34 INFO - Running main action method: read_buildbot_config
16:03:34 INFO - Using buildbot properties:
16:03:34 INFO - {
16:03:34 INFO - "properties": {
16:03:34 INFO - "buildnumber": 31,
16:03:34 INFO - "product": "firefox",
16:03:34 INFO - "script_repo_revision": "production",
16:03:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s",
16:03:34 INFO - "repository": "",
16:03:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s",
16:03:34 INFO - "buildid": "20151230133836",
16:03:34 INFO - "slavename": "talos-linux64-ix-039",
16:03:34 INFO - "pgo_build": "True",
16:03:34 INFO - "basedir": "/builds/slave/test-pgo",
16:03:34 INFO - "project": "",
16:03:34 INFO - "platform": "ubuntu64_hw",
16:03:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
16:03:34 INFO - "slavebuilddir": "test",
16:03:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos",
16:03:34 INFO - "branch": "mozilla-aurora",
16:03:34 INFO - "repo_path": "releases/mozilla-aurora",
16:03:34 INFO - "stage_platform": "linux64-pgo",
16:03:34 INFO - "builduid": "3ce91322b7e4426eb46210a66e3b973f",
16:03:34 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced"
16:03:34 INFO - },
16:03:34 INFO - "sourcestamp": {
16:03:34 INFO - "repository": "",
16:03:34 INFO - "hasPatch": false,
16:03:34 INFO - "project": "",
16:03:34 INFO - "branch": "mozilla-aurora-linux64-pgo-talos",
16:03:34 INFO - "changes": [
16:03:34 INFO - {
16:03:34 INFO - "category": null,
16:03:34 INFO - "files": [
16:03:34 INFO - {
16:03:34 INFO - "url": null,
16:03:34 INFO - "name": "https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2"
16:03:34 INFO - }
16:03:34 INFO - ],
16:03:34 INFO - "repository": "",
16:03:34 INFO - "rev": "839dd566125d53b477bcd3838c33ac824d06dced",
16:03:34 INFO - "who": "dholbert@mozilla.com",
16:03:34 INFO - "when": 1451520185,
16:03:34 INFO - "number": 7404801,
16:03:34 INFO - "comments": "Bug 1204897: Attempt to work around randomorange in test_bug332655-1.html by using an unthemed widget. r=jfkthame a=testonly",
16:03:34 INFO - "project": "",
16:03:34 INFO - "at": "Wed 30 Dec 2015 16:03:05",
16:03:34 INFO - "branch": "mozilla-aurora-linux64-pgo-talos",
16:03:34 INFO - "revlink": "",
16:03:34 INFO - "properties": [
16:03:34 INFO - [
16:03:34 INFO - "buildid",
16:03:34 INFO - "20151230133836",
16:03:34 INFO - "Change"
16:03:34 INFO - ],
16:03:34 INFO - [
16:03:34 INFO - "builduid",
16:03:34 INFO - "3ce91322b7e4426eb46210a66e3b973f",
16:03:34 INFO - "Change"
16:03:34 INFO - ],
16:03:34 INFO - [
16:03:34 INFO - "pgo_build",
16:03:34 INFO - "True",
16:03:34 INFO - "Change"
16:03:34 INFO - ]
16:03:34 INFO - ],
16:03:34 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced"
16:03:34 INFO - }
16:03:34 INFO - ],
16:03:34 INFO - "revision": "839dd566125d53b477bcd3838c33ac824d06dced"
16:03:34 INFO - }
16:03:34 INFO - }
16:03:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2.
16:03:34 INFO - Running post-action listener: _resource_record_post_action
16:03:34 INFO - #####
16:03:34 INFO - ##### Running download-and-extract step.
16:03:34 INFO - #####
16:03:34 INFO - Running pre-action listener: _resource_record_pre_action
16:03:34 INFO - Running main action method: download_and_extract
16:03:34 INFO - mkdir: /builds/slave/test-pgo/build/tests
16:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:34 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
16:03:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json
16:03:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json
16:03:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json
16:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1
16:03:35 INFO - Downloaded 1302 bytes.
16:03:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json
16:03:35 INFO - Using the following test package requirements:
16:03:35 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'],
16:03:35 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'],
16:03:35 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'jsshell-linux-x86_64.zip'],
16:03:35 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'],
16:03:35 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'],
16:03:35 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'],
16:03:35 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'],
16:03:35 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'],
16:03:35 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'],
16:03:35 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip',
16:03:35 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']}
16:03:35 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
16:03:35 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')]}
16:03:35 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
16:03:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1
16:03:36 INFO - Downloaded 23023515 bytes.
16:03:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests
16:03:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760
16:03:37 INFO - Return code: 0
16:03:37 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
16:03: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')]}
16:03:37 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
16:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1
16:03:39 INFO - Downloaded 23023515 bytes.
16:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests
16:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip
16:03:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760
16:03:41 INFO - Return code: 0
16:03:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:41 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
16:03:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip
16:03:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip
16:03:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip
16:03:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
16:03:42 INFO - Downloaded 11132038 bytes.
16:03:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests
16:03:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip
16:03:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760
16:03:42 INFO - Return code: 0
16:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:42 INFO - https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
16:03:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
16:03:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
16:03:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
16:03:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1
16:03:45 INFO - Downloaded 58079339 bytes.
16:03:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
16:03:45 INFO - mkdir: /builds/slave/test-pgo/properties
16:03:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url
16:03:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url
16:03:45 INFO - Contents:
16:03:45 INFO - build_url:https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
16:03:45 INFO - Running post-action listener: _resource_record_post_action
16:03:45 INFO - Running post-action listener: set_extra_try_arguments
16:03:45 INFO - #####
16:03:45 INFO - ##### Running populate-webroot step.
16:03:45 INFO - #####
16:03:45 INFO - Running pre-action listener: _resource_record_pre_action
16:03:45 INFO - Running main action method: populate_webroot
16:03:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
16:03:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
16:03:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
16:03:45 INFO - '--tppagecycles',
16:03:45 INFO - '7'],
16:03:45 INFO - 'tests': ['tsvgm']}},
16:03:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']},
16:03:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['tresize', 'tcanvasmark']},
16:03:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']},
16:03:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']},
16:03:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
16:03:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
16:03:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'tests': ['damp', 'tps']},
16:03:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['damp', 'tps']},
16:03:45 INFO - 'g3': {'tests': ['dromaeo_dom']},
16:03:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
16:03:45 INFO - 'other': {'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'other-e10s': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'other_l64': {'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'other_nol64': {'tests': ['a11yr',
16:03:45 INFO - 'ts_paint',
16:03:45 INFO - 'tpaint',
16:03:45 INFO - 'sessionrestore',
16:03:45 INFO - 'sessionrestore_no_auto_restore']},
16:03:45 INFO - 'svgr': {'tests': ['tsvgx',
16:03:45 INFO - 'tsvgr_opacity',
16:03:45 INFO - 'tart',
16:03:45 INFO - 'tscrollx',
16:03:45 INFO - 'cart']},
16:03:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['tsvgx',
16:03:45 INFO - 'tsvgr_opacity',
16:03:45 INFO - 'tart',
16:03:45 INFO - 'tscrollx',
16:03:45 INFO - 'cart']},
16:03:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'tests': ['tp5o']},
16:03:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'talos_options': ['--e10s'],
16:03:45 INFO - 'tests': ['tp5o']},
16:03:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'talos_options': ['--xperf_path',
16:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
16:03:45 INFO - 'tests': ['tp5n']},
16:03:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
16:03:45 INFO - 'talos_options': ['--e10s',
16:03:45 INFO - '--xperf_path',
16:03:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
16:03:45 INFO - 'tests': ['tp5n']}},
16:03:45 INFO - 'talos.zip': {'path': '',
16:03:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
16:03:45 INFO - Running post-action listener: _resource_record_post_action
16:03:45 INFO - #####
16:03:45 INFO - ##### Running create-virtualenv step.
16:03:45 INFO - #####
16:03:45 INFO - Running pre-action listener: _resource_record_pre_action
16:03:45 INFO - Running main action method: create_virtualenv
16:03:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv
16:03:45 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
16:03:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv
16:03:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
16:03:45 INFO - Using real prefix '/usr'
16:03:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python
16:03:46 INFO - Installing distribute.............................................................................................................................................................................................done.
16:03:48 INFO - Installing pip.................done.
16:03:48 INFO - Return code: 0
16:03:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv
16:03: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')]}
16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03: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')]}
16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:48 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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:48 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
16:03:48 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
16:03:48 INFO - Using env: {'DISPLAY': ':0',
16:03:48 INFO - 'HOME': '/home/cltbld',
16:03:48 INFO - 'LANG': 'en_US.UTF-8',
16:03:48 INFO - 'LANGUAGE': 'en_US:en',
16:03:48 INFO - 'LOGNAME': 'cltbld',
16:03:48 INFO - 'MAIL': '/var/mail/cltbld',
16:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:48 INFO - 'MOZ_NO_REMOTE': '1',
16:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:48 INFO - 'NO_EM_RESTART': '1',
16:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:48 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:48 INFO - 'SHELL': '/bin/bash',
16:03:48 INFO - 'SHLVL': '1',
16:03:48 INFO - 'TERM': 'linux',
16:03:48 INFO - 'TMOUT': '86400',
16:03:48 INFO - 'USER': 'cltbld',
16:03:48 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:48 INFO - '_': '/tools/buildbot/bin/python'}
16:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:48 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
16:03:48 INFO - Cleaning up...
16:03:48 INFO - Return code: 0
16:03:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv
16:03: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')]}
16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03: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')]}
16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:48 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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:48 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
16:03:48 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
16:03:48 INFO - Using env: {'DISPLAY': ':0',
16:03:48 INFO - 'HOME': '/home/cltbld',
16:03:48 INFO - 'LANG': 'en_US.UTF-8',
16:03:48 INFO - 'LANGUAGE': 'en_US:en',
16:03:48 INFO - 'LOGNAME': 'cltbld',
16:03:48 INFO - 'MAIL': '/var/mail/cltbld',
16:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:48 INFO - 'MOZ_NO_REMOTE': '1',
16:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:48 INFO - 'NO_EM_RESTART': '1',
16:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:48 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:48 INFO - 'SHELL': '/bin/bash',
16:03:48 INFO - 'SHLVL': '1',
16:03:48 INFO - 'TERM': 'linux',
16:03:48 INFO - 'TMOUT': '86400',
16:03:48 INFO - 'USER': 'cltbld',
16:03:48 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:48 INFO - '_': '/tools/buildbot/bin/python'}
16:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:48 INFO - Downloading/unpacking psutil>=0.7.1
16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
16:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
16:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
16:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
16:03:50 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache
16:03:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz
16:03:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil
16:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
16:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
16:03:50 INFO - Installing collected packages: psutil
16:03:50 INFO - Running setup.py install for psutil
16:03:50 INFO - building 'psutil._psutil_linux' extension
16:03:50 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
16:03:50 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
16:03:50 INFO - building 'psutil._psutil_posix' extension
16:03:50 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
16:03:50 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
16:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
16:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
16:03:50 INFO - Successfully installed psutil
16:03:50 INFO - Cleaning up...
16:03:50 INFO - Return code: 0
16:03:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv
16:03: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')]}
16:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03: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')]}
16:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build
16:03:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0
16:03:50 INFO - Using env: {'DISPLAY': ':0',
16:03:50 INFO - 'HOME': '/home/cltbld',
16:03:50 INFO - 'LANG': 'en_US.UTF-8',
16:03:50 INFO - 'LANGUAGE': 'en_US:en',
16:03:50 INFO - 'LOGNAME': 'cltbld',
16:03:50 INFO - 'MAIL': '/var/mail/cltbld',
16:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:50 INFO - 'MOZ_NO_REMOTE': '1',
16:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:50 INFO - 'NO_EM_RESTART': '1',
16:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:50 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:50 INFO - 'SHELL': '/bin/bash',
16:03:50 INFO - 'SHLVL': '1',
16:03:50 INFO - 'TERM': 'linux',
16:03:50 INFO - 'TMOUT': '86400',
16:03:50 INFO - 'USER': 'cltbld',
16:03:50 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:50 INFO - '_': '/tools/buildbot/bin/python'}
16:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
16:03:51 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
16:03:51 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
16:03:51 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
16:03:51 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
16:03:51 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
16:03:51 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
16:03:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz
16:03:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz
16:03:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
16:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0)
16:03:52 INFO - Installing collected packages: mozsystemmonitor
16:03:52 INFO - Running setup.py install for mozsystemmonitor
16:03:52 INFO - Successfully installed mozsystemmonitor
16:03:52 INFO - Cleaning up...
16:03:52 INFO - Return code: 0
16:03:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv
16:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build
16:03:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
16:03:52 INFO - Using env: {'DISPLAY': ':0',
16:03:52 INFO - 'HOME': '/home/cltbld',
16:03:52 INFO - 'LANG': 'en_US.UTF-8',
16:03:52 INFO - 'LANGUAGE': 'en_US:en',
16:03:52 INFO - 'LOGNAME': 'cltbld',
16:03:52 INFO - 'MAIL': '/var/mail/cltbld',
16:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:52 INFO - 'MOZ_NO_REMOTE': '1',
16:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:52 INFO - 'NO_EM_RESTART': '1',
16:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:52 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:52 INFO - 'SHELL': '/bin/bash',
16:03:52 INFO - 'SHLVL': '1',
16:03:52 INFO - 'TERM': 'linux',
16:03:52 INFO - 'TMOUT': '86400',
16:03:52 INFO - 'USER': 'cltbld',
16:03:52 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:52 INFO - '_': '/tools/buildbot/bin/python'}
16:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:53 INFO - Downloading/unpacking blobuploader==1.2.4
16:03:53 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
16:03:53 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
16:03:53 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
16:03:53 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
16:03:53 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
16:03:53 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
16:03:54 INFO - Downloading blobuploader-1.2.4.tar.gz
16:03:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz
16:03:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
16:03:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
16:03: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
16:03: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
16:03: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
16:03: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
16:03: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
16:03: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
16:03:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz
16:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests
16:03:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
16:03: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
16:03: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
16:03: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
16:03: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
16:03: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
16:03: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
16:03:55 INFO - Downloading docopt-0.6.1.tar.gz
16:03:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz
16:03:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt
16:03:55 INFO - Installing collected packages: blobuploader, requests, docopt
16:03:55 INFO - Running setup.py install for blobuploader
16:03:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
16:03:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775
16:03:55 INFO - Running setup.py install for requests
16:03:56 INFO - Running setup.py install for docopt
16:03:56 INFO - Successfully installed blobuploader requests docopt
16:03:56 INFO - Cleaning up...
16:03:56 INFO - Return code: 0
16:03:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
16:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
16:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:56 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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:56 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
16:03:56 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
16:03:56 INFO - Using env: {'DISPLAY': ':0',
16:03:56 INFO - 'HOME': '/home/cltbld',
16:03:56 INFO - 'LANG': 'en_US.UTF-8',
16:03:56 INFO - 'LANGUAGE': 'en_US:en',
16:03:56 INFO - 'LOGNAME': 'cltbld',
16:03:56 INFO - 'MAIL': '/var/mail/cltbld',
16:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:56 INFO - 'MOZ_NO_REMOTE': '1',
16:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:56 INFO - 'NO_EM_RESTART': '1',
16:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:56 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:56 INFO - 'SHELL': '/bin/bash',
16:03:56 INFO - 'SHLVL': '1',
16:03:56 INFO - 'TERM': 'linux',
16:03:56 INFO - 'TMOUT': '86400',
16:03:56 INFO - 'USER': 'cltbld',
16:03:56 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:56 INFO - '_': '/tools/buildbot/bin/python'}
16:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
16:03:56 INFO - Running setup.py (path:/tmp/pip-VvEQmU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
16:03:56 INFO - Running setup.py (path:/tmp/pip-7wUaa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
16:03:56 INFO - Running setup.py (path:/tmp/pip-H7eqZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
16:03:56 INFO - Running setup.py (path:/tmp/pip-3bijMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
16:03:56 INFO - Running setup.py (path:/tmp/pip-JGSz9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
16:03:56 INFO - Running setup.py (path:/tmp/pip-C10cUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
16:03:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
16:03:56 INFO - Running setup.py (path:/tmp/pip-fHOoEh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
16:03:57 INFO - Running setup.py (path:/tmp/pip-voxe5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
16:03:57 INFO - Running setup.py (path:/tmp/pip-GbCdZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
16:03:57 INFO - Running setup.py (path:/tmp/pip-xKnhap-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
16:03:57 INFO - Running setup.py (path:/tmp/pip-tlrdHh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
16:03:57 INFO - Running setup.py (path:/tmp/pip-1xg5Xq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
16:03:57 INFO - Running setup.py (path:/tmp/pip-uaLoGc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
16:03:57 INFO - Running setup.py (path:/tmp/pip-mAXf2h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:03:57 INFO - Running setup.py (path:/tmp/pip-CoCYhH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
16:03:57 INFO - Running setup.py (path:/tmp/pip-JvXviO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
16:03:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
16:03:57 INFO - Running setup.py (path:/tmp/pip-ytzzwd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
16:03:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
16:03:57 INFO - Running setup.py install for manifestparser
16:03:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin
16:03:57 INFO - Running setup.py install for mozcrash
16:03:57 INFO - Running setup.py install for mozdebug
16:03:58 INFO - Running setup.py install for mozdevice
16:03:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for mozfile
16:03:58 INFO - Running setup.py install for mozhttpd
16:03:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for mozinfo
16:03:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for mozInstall
16:03:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for mozleak
16:03:58 INFO - Running setup.py install for mozlog
16:03:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for moznetwork
16:03:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin
16:03:58 INFO - Running setup.py install for mozprocess
16:03:58 INFO - Running setup.py install for mozprofile
16:03:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin
16:03:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin
16:03:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin
16:03:59 INFO - Running setup.py install for mozrunner
16:03:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin
16:03:59 INFO - Running setup.py install for mozscreenshot
16:03:59 INFO - Running setup.py install for moztest
16:03:59 INFO - Running setup.py install for mozversion
16:03:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin
16:03:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
16:03:59 INFO - Cleaning up...
16:03:59 INFO - Return code: 0
16:03:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
16:03:59 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')]}
16:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:59 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')]}
16:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:03:59 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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:03:59 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
16:03:59 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
16:03:59 INFO - Using env: {'DISPLAY': ':0',
16:03:59 INFO - 'HOME': '/home/cltbld',
16:03:59 INFO - 'LANG': 'en_US.UTF-8',
16:03:59 INFO - 'LANGUAGE': 'en_US:en',
16:03:59 INFO - 'LOGNAME': 'cltbld',
16:03:59 INFO - 'MAIL': '/var/mail/cltbld',
16:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:03:59 INFO - 'MOZ_NO_REMOTE': '1',
16:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:03:59 INFO - 'NO_EM_RESTART': '1',
16:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:03:59 INFO - 'PWD': '/builds/slave/test-pgo',
16:03:59 INFO - 'SHELL': '/bin/bash',
16:03:59 INFO - 'SHLVL': '1',
16:03:59 INFO - 'TERM': 'linux',
16:03:59 INFO - 'TMOUT': '86400',
16:03:59 INFO - 'USER': 'cltbld',
16:03:59 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:03:59 INFO - '_': '/tools/buildbot/bin/python'}
16:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
16:03:59 INFO - Running setup.py (path:/tmp/pip-i89lCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
16:03:59 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))
16:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
16:03:59 INFO - Running setup.py (path:/tmp/pip-Y91rhd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
16:03:59 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))
16:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
16:03:59 INFO - Running setup.py (path:/tmp/pip-mU9rvg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
16:03:59 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))
16:03:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
16:03:59 INFO - Running setup.py (path:/tmp/pip-Iq8J57-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
16:04:00 INFO - Running setup.py (path:/tmp/pip-vQj8hK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
16:04:00 INFO - Running setup.py (path:/tmp/pip-m7fyYR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
16:04:00 INFO - Running setup.py (path:/tmp/pip-2YCwcb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
16:04:00 INFO - Running setup.py (path:/tmp/pip-ga5uWj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
16:04:00 INFO - Running setup.py (path:/tmp/pip-Cqd3Vh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
16:04:00 INFO - Running setup.py (path:/tmp/pip-75lHAW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
16:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
16:04:00 INFO - Running setup.py (path:/tmp/pip-q2Q1h1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
16:04:00 INFO - Running setup.py (path:/tmp/pip-7hHQtw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
16:04:00 INFO - Running setup.py (path:/tmp/pip-xbVE44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
16:04:00 INFO - Running setup.py (path:/tmp/pip-Oh7Xr3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:04:00 INFO - Running setup.py (path:/tmp/pip-sN40an-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
16:04:00 INFO - Running setup.py (path:/tmp/pip-ANjWeH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
16:04:00 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))
16:04:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
16:04:00 INFO - Running setup.py (path:/tmp/pip-blha0l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
16:04:00 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))
16:04:00 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))
16:04:00 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))
16:04:00 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))
16:04:00 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))
16:04:00 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))
16:04:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10))
16:04: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
16:04: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
16:04: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
16:04: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
16:04: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
16:04: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
16:04:02 INFO - Downloading blessings-1.5.1.tar.gz
16:04:02 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
16:04:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings
16:04:02 INFO - Installing collected packages: blessings
16:04:02 INFO - Running setup.py install for blessings
16:04:02 INFO - Successfully installed blessings
16:04:02 INFO - Cleaning up...
16:04:02 INFO - Return code: 0
16:04:02 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv.
16:04:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
16:04:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
16:04:03 INFO - Reading from file tmpfile_stdout
16:04:03 INFO - Current package versions:
16:04:03 INFO - argparse == 1.2.1
16:04:03 INFO - blessings == 1.5.1
16:04:03 INFO - blobuploader == 1.2.4
16:04:03 INFO - docopt == 0.6.1
16:04:03 INFO - manifestparser == 1.1
16:04:03 INFO - mozInstall == 1.12
16:04:03 INFO - mozcrash == 0.16
16:04:03 INFO - mozdebug == 0.1
16:04:03 INFO - mozdevice == 0.47
16:04:03 INFO - mozfile == 1.2
16:04:03 INFO - mozhttpd == 0.7
16:04:03 INFO - mozinfo == 0.9
16:04:03 INFO - mozleak == 0.1
16:04:03 INFO - mozlog == 3.1
16:04:03 INFO - moznetwork == 0.27
16:04:03 INFO - mozprocess == 0.22
16:04:03 INFO - mozprofile == 0.27
16:04:03 INFO - mozrunner == 6.11
16:04:03 INFO - mozscreenshot == 0.1
16:04:03 INFO - mozsystemmonitor == 0.0
16:04:03 INFO - moztest == 0.7
16:04:03 INFO - mozversion == 1.4
16:04:03 INFO - psutil == 3.1.1
16:04:03 INFO - requests == 1.2.3
16:04:03 INFO - wsgiref == 0.1.2
16:04:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
16:04: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')]}
16:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04: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')]}
16:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04:03 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 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:04:03 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
16:04:03 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
16:04:03 INFO - Using env: {'DISPLAY': ':0',
16:04:03 INFO - 'HOME': '/home/cltbld',
16:04:03 INFO - 'LANG': 'en_US.UTF-8',
16:04:03 INFO - 'LANGUAGE': 'en_US:en',
16:04:03 INFO - 'LOGNAME': 'cltbld',
16:04:03 INFO - 'MAIL': '/var/mail/cltbld',
16:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:04:03 INFO - 'MOZ_NO_REMOTE': '1',
16:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:04:03 INFO - 'NO_EM_RESTART': '1',
16:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:04:03 INFO - 'PWD': '/builds/slave/test-pgo',
16:04:03 INFO - 'SHELL': '/bin/bash',
16:04:03 INFO - 'SHLVL': '1',
16:04:03 INFO - 'TERM': 'linux',
16:04:03 INFO - 'TMOUT': '86400',
16:04:03 INFO - 'USER': 'cltbld',
16:04:03 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:04:03 INFO - '_': '/tools/buildbot/bin/python'}
16:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 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))
16:04:03 INFO - Cleaning up...
16:04:03 INFO - Return code: 0
16:04:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv
16:04: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')]}
16:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04: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')]}
16:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04:03 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:04:03 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', 'jsonschema'] in /builds/slave/test-pgo/build
16:04:03 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 jsonschema
16:04:03 INFO - Using env: {'DISPLAY': ':0',
16:04:03 INFO - 'HOME': '/home/cltbld',
16:04:03 INFO - 'LANG': 'en_US.UTF-8',
16:04:03 INFO - 'LANGUAGE': 'en_US:en',
16:04:03 INFO - 'LOGNAME': 'cltbld',
16:04:03 INFO - 'MAIL': '/var/mail/cltbld',
16:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:04:03 INFO - 'MOZ_NO_REMOTE': '1',
16:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:04:03 INFO - 'NO_EM_RESTART': '1',
16:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:04:03 INFO - 'PWD': '/builds/slave/test-pgo',
16:04:03 INFO - 'SHELL': '/bin/bash',
16:04:03 INFO - 'SHLVL': '1',
16:04:03 INFO - 'TERM': 'linux',
16:04:03 INFO - 'TMOUT': '86400',
16:04:03 INFO - 'USER': 'cltbld',
16:04:03 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:04:03 INFO - '_': '/tools/buildbot/bin/python'}
16:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:04:03 INFO - Downloading/unpacking jsonschema
16:04:03 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
16:04:03 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
16:04:03 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
16:04:03 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
16:04:03 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
16:04:03 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
16:04:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
16:04:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl
16:04:05 INFO - Downloading/unpacking functools32 (from jsonschema)
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 INFO - Downloading functools32-3.2.3-2.tar.gz
16:04:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz
16:04:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32
16:04:05 INFO - warning: no files found matching '*.txt'
16:04:05 INFO - no previously-included directories found matching 'build'
16:04:05 INFO - no previously-included directories found matching 'dist'
16:04:05 INFO - no previously-included directories found matching '.git*'
16:04:05 INFO - Installing collected packages: jsonschema, functools32
16:04:05 INFO - Running setup.py install for functools32
16:04:05 INFO - warning: no files found matching '*.txt'
16:04:05 INFO - no previously-included directories found matching 'build'
16:04:05 INFO - no previously-included directories found matching 'dist'
16:04:05 INFO - no previously-included directories found matching '.git*'
16:04:05 INFO - Successfully installed jsonschema functools32
16:04:05 INFO - Cleaning up...
16:04:05 INFO - Return code: 0
16:04:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv
16:04:05 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')]}
16:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
16:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04:05 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')]}
16:04:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
16:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
16:04:05 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae60b90f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c54450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, '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': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911', '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
16:04:05 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', 'flake8'] in /builds/slave/test-pgo/build
16:04:05 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 flake8
16:04:05 INFO - Using env: {'DISPLAY': ':0',
16:04:05 INFO - 'HOME': '/home/cltbld',
16:04:05 INFO - 'LANG': 'en_US.UTF-8',
16:04:05 INFO - 'LANGUAGE': 'en_US:en',
16:04:05 INFO - 'LOGNAME': 'cltbld',
16:04:05 INFO - 'MAIL': '/var/mail/cltbld',
16:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:04:05 INFO - 'MOZ_NO_REMOTE': '1',
16:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:04:05 INFO - 'NO_EM_RESTART': '1',
16:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:04:05 INFO - 'PWD': '/builds/slave/test-pgo',
16:04:05 INFO - 'SHELL': '/bin/bash',
16:04:05 INFO - 'SHLVL': '1',
16:04:05 INFO - 'TERM': 'linux',
16:04:05 INFO - 'TMOUT': '86400',
16:04:05 INFO - 'USER': 'cltbld',
16:04:05 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:04:05 INFO - '_': '/tools/buildbot/bin/python'}
16:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/
16:04:05 INFO - Downloading/unpacking flake8
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:05 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
16:04:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
16:04:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl
16:04:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
16:04:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl
16:04:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:07 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
16:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl
16:04:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
16:04: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
16:04: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
16:04: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
16:04: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
16:04: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
16:04: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
16:04:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz
16:04:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8
16:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
16:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
16:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
16:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
16:04:08 INFO - no previously-included directories found matching 'docs/_build'
16:04:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
16:04:08 INFO - Running setup.py install for pep8
16:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
16:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
16:04:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
16:04:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
16:04:08 INFO - no previously-included directories found matching 'docs/_build'
16:04:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin
16:04:08 INFO - Successfully installed flake8 mccabe pyflakes pep8
16:04:08 INFO - Cleaning up...
16:04:08 INFO - Return code: 0
16:04:08 INFO - Running post-action listener: _resource_record_post_action
16:04:08 INFO - Running post-action listener: _start_resource_monitoring
16:04:08 INFO - Starting resource monitoring.
16:04:08 INFO - #####
16:04:08 INFO - ##### Running install step.
16:04:08 INFO - #####
16:04:08 INFO - Running pre-action listener: _resource_record_pre_action
16:04:08 INFO - Running main action method: install
16:04:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
16:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
16:04:08 INFO - Reading from file tmpfile_stdout
16:04:08 INFO - Detecting whether we're running mozinstall >=1.0...
16:04:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h']
16:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h
16:04:08 INFO - Reading from file tmpfile_stdout
16:04:08 INFO - Output received:
16:04:08 INFO - Usage: mozinstall [options] installer
16:04:08 INFO - Options:
16:04:08 INFO - -h, --help show this help message and exit
16:04:08 INFO - -d DEST, --destination=DEST
16:04:08 INFO - Directory to install application into. [default:
16:04:08 INFO - "/builds/slave/test-pgo"]
16:04:08 INFO - --app=APP Application being installed. [default: firefox]
16:04:08 INFO - mkdir: /builds/slave/test-pgo/build/application
16:04:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application']
16:04:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application
16:04:23 INFO - Reading from file tmpfile_stdout
16:04:23 INFO - Output received:
16:04:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox
16:04:23 INFO - Running post-action listener: _resource_record_post_action
16:04:23 INFO - #####
16:04:23 INFO - ##### Running run-tests step.
16:04:23 INFO - #####
16:04:23 INFO - Running pre-action listener: _resource_record_pre_action
16:04:23 INFO - Running main action method: run_tests
16:04:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version']
16:04:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version
16:04:23 INFO - Python 2.7.3
16:04:23 INFO - Return code: 0
16:04:23 INFO - grabbing minidump binary from tooltool
16:04:23 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')]}
16:04:23 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 0x2ce6a50>, '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 0x2c52550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c529e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1
16:04:23 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
16:04:23 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
16:04:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
16:04:23 INFO - Return code: 0
16:04:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755
16:04:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir
16:04:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir
16:04:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk
16:04:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir
16:04:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos']
16:04:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos
16:04:24 INFO - Return code: 0
16:04:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test-pgo/build
16:04:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost
16:04:24 INFO - Using env: {'DISPLAY': ':0',
16:04:24 INFO - 'HOME': '/home/cltbld',
16:04:24 INFO - 'LANG': 'en_US.UTF-8',
16:04:24 INFO - 'LANGUAGE': 'en_US:en',
16:04:24 INFO - 'LOGNAME': 'cltbld',
16:04:24 INFO - 'MAIL': '/var/mail/cltbld',
16:04:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir',
16:04:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk',
16:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
16:04:24 INFO - 'MOZ_NO_REMOTE': '1',
16:04:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir',
16:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
16:04:24 INFO - 'NO_EM_RESTART': '1',
16:04:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
16:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
16:04:24 INFO - 'PWD': '/builds/slave/test-pgo',
16:04:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos',
16:04:24 INFO - 'SHELL': '/bin/bash',
16:04:24 INFO - 'SHLVL': '1',
16:04:24 INFO - 'TERM': 'linux',
16:04:24 INFO - 'TMOUT': '86400',
16:04:24 INFO - 'USER': 'cltbld',
16:04:24 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1451520134.258142-467326911',
16:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
16:04:24 INFO - '_': '/tools/buildbot/bin/python'}
16:04:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600
16:04:24 INFO - mozversion INFO | application_buildid: 20151230133836
16:04:24 INFO - mozversion INFO | application_changeset: 839dd566125d53b477bcd3838c33ac824d06dced
16:04:24 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition
16:04:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
16:04:24 INFO - mozversion INFO | application_name: Firefox
16:04:24 INFO - mozversion INFO | application_remotingname: firefox-dev
16:04:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora
16:04:24 INFO - mozversion INFO | application_vendor: Mozilla
16:04:24 INFO - mozversion INFO | application_version: 45.0a2
16:04:24 INFO - mozversion INFO | platform_buildid: 20151230133836
16:04:24 INFO - mozversion INFO | platform_changeset: 839dd566125d53b477bcd3838c33ac824d06dced
16:04:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora
16:04:24 INFO - mozversion INFO | platform_version: 45.0a2
16:04:24 INFO - 2015-12-30 16:04:24,599 DEBUG : using testdate: 1451520264
16:04:24 INFO - 2015-12-30 16:04:24,599 DEBUG : actual date: 1451520264
16:04:24 INFO - 2015-12-30 16:04:24,609 INFO : starting webserver on 'localhost:49649'
16:04:24 INFO - 2015-12-30 16:04:24,610 INFO : Starting test suite talos-linux64-ix-039.e
16:04:24 INFO - 2015-12-30 16:04:24,610 INFO : Starting test dromaeo_css
16:04:24 INFO - 2015-12-30 16:04:24,610 DEBUG : operating with platform_type : linux_
16:04:24 INFO - 2015-12-30 16:04:24,611 INFO : Initialising browser for dromaeo_css test...
16:04:24 INFO - 2015-12-30 16:04:24,627 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpypJTNx/profile http://localhost:49649/getInfo.html
16:04:29 INFO - 2015-12-30 16:04:29,381 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
16:04:29 INFO - 2015-12-30 16:04:29,382 DEBUG : BROWSER_OUTPUT: colorDepth:24
16:04:29 INFO - 2015-12-30 16:04:29,382 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697
16:04:29 INFO - 2015-12-30 16:04:29,382 DEBUG : BROWSER_OUTPUT: __metrics
16:04:30 INFO - 2015-12-30 16:04:30,394 INFO : Browser initialized.
16:04:30 INFO - 2015-12-30 16:04:30,394 INFO : Running cycle 1/1 for dromaeo_css test...
16:04:30 INFO - 2015-12-30 16:04:30,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpypJTNx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
16:04:42 INFO - 2015-12-30 16:04:42,205 DEBUG : BROWSER_OUTPUT: RSS: Main: 137547776
16:04:42 INFO - 2015-12-30 16:04:42,205 DEBUG : BROWSER_OUTPUT:
16:05:31 INFO - 2015-12-30 16:05:31,822 DEBUG : BROWSER_OUTPUT: 1451520331818 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]
16:07:39 INFO - 2015-12-30 16:07:39,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49649/tests/dromaeo/cssquery-ext.html)
16:07:40 INFO - 2015-12-30 16:07:40,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 141205504
16:07:40 INFO - 2015-12-30 16:07:40,856 DEBUG : BROWSER_OUTPUT:
16:10:42 INFO - 2015-12-30 16:10:42,682 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-ext.html (next: http://localhost:49649/tests/dromaeo/cssquery-jquery.html)
16:10:43 INFO - 2015-12-30 16:10:43,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424
16:10:43 INFO - 2015-12-30 16:10:43,266 DEBUG : BROWSER_OUTPUT:
16:13:44 INFO - 2015-12-30 16:13:44,895 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49649/tests/dromaeo/cssquery-mootools.html)
16:13:45 INFO - 2015-12-30 16:13:45,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 141127680
16:13:45 INFO - 2015-12-30 16:13:45,477 DEBUG : BROWSER_OUTPUT:
16:16:47 INFO - 2015-12-30 16:16:47,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49649/tests/dromaeo/cssquery-prototype.html)
16:16:47 INFO - 2015-12-30 16:16:47,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 139730944
16:16:47 INFO - 2015-12-30 16:16:47,653 DEBUG : BROWSER_OUTPUT:
16:19:49 INFO - 2015-12-30 16:19:49,862 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49649/tests/dromaeo/cssquery-yui.html)
16:19:50 INFO - 2015-12-30 16:19:50,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 140210176
16:19:50 INFO - 2015-12-30 16:19:50,465 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/dromaeo/cssquery-yui.html (next: http://localhost:49649/tests/dromaeo/cssquery-dojo.html)
16:22:52 INFO - 2015-12-30 16:22:52,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 141811712
16:22:52 INFO - 2015-12-30 16:22:52,806 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,808 DEBUG : BROWSER_OUTPUT: __start_tp_report
16:22:52 INFO - 2015-12-30 16:22:52,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
16:22:52 INFO - 2015-12-30 16:22:52,808 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
16:22:52 INFO - 2015-12-30 16:22:52,808 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
16:22:52 INFO - 2015-12-30 16:22:52,810 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3332.9500057499135;3356.4461863792476;3380.7464440166964;3390.542276792632;3397.048826328628;5501.642393244446;5542.279503664523;5542.528885044776;5550.7224638768;5559.861003474915;5528.530074943635;5574.136008918614;5581.162825576165;5581.748821303041;5602.887942241153;5055.5702765265;5073.315102461157;5124.820631277906;5125.513076257749;5182.4299327073995;4797.808087676489;4937.975310123445;4950.009998000396;5141.1517099678695;5265.842024739245;5022.070916880389;5087.643864929457;5090.567301779353;5092.312537807404;5201.2458193561915;5162.793488260465;5170.689758614476;5188.22176673502;5189.974050129726;5231.006108839328;4917.483664215278;4955.380577427822;5010.223415370623;5101.0308041472;5120.897582048376;5284.920726189111;5338.652987555796;5356.223347614613;5375.354957405098;5413.377461591928;5966.67183304918;6081.878362432726;6138.815835524897;6149.754009839601;6156.87686246277;5948.196993405878;5959.255093113361;6089.573729838913;6169.598976066586;6176.289726681444;5569.693666848281;5571.247881536022;5579.414161513023;5586.972065139689;5588.692621905793;6006.729697163551;6074.331823499411;6079.483243924316;6083.66539840313;6094.786682466092;5735.283089613798;5808.041673123887;5844.1233814927255;5874.324452687995;5962.55280853929;5917.46742793142;6042.12389203563;6085.300190478063;6092.177556029879;6099.9390006099375;5980.611260268156;6031.487323577458;6036.6679832609625;6051.0923361496125;6057.757689692451;5772.3938986406665;5799.94200057994;5896.587238893237;5928.407159284037;6025.578209525379;4410.426644536254;4431.158079964796;4432.955670443319;4458.509563947963;4477.440319960005;4015.678745700337;4018.1561872007205;4038.3336749436603;4054.0878302382316;4056.6957478189256;5626.212330273765;5661.433856614388;5698.572607054404;5722.599418040781;5759.366469688331;5914.645121292736;6067.180930574316;6081.27024757032;6108.816735497942;6121.265448146251;5578.163275508625;5775.884482310415;5783.768649254067;5790.739416726257;5808.215890854765;4967.850964471072;4976;5045.016221836707;5055.797768089235;5103.336566246364;6112.816615501542;6131.601445906091;6146.815595532141;6154.446099851035;6159.753609855556;5953.702314884238;5975.462208401264;5981.3420523743225;5987.31145918225;6008.669523176267;5959.67221802805;5999.880002400015;6069.635821850703;6098.908516372169;6122.816315510542;5823.82528524145;5858.5898987070495;5863.355030946678;5863.442972917566;5930.258717660293;5885.73514191871;5909.970450147722;5966.820995370146;5968.641881487125;5977.940220597912;5671.659700417823;5738.885222295614;5756.712164391847;5761.683107429131;5796.014677504919;5830.387809280134;5836.153757705194;5843.357230704534;5850.151727999501;5858.150568167506;5626.352969408406;5703.030484817674;5759.481646651654;5766.250387449605;5778.566607504538;5893.5874488785375;5913.379095195115;5915.497182739343;5916.3492015877355;5982.521398288213;5661;5693.857653558694;5722.084466485342;5723.914141287801;5743.0811070228565
16:22:52 INFO - 2015-12-30 16:22:52,811 DEBUG : BROWSER_OUTPUT: |1;ext.html;578.0952808854146;611.8653896142848;614.9108379285007;635.3582881289896;673.6766352150968;32303.51544726828;41163.38254926175;41193.3820992685;41355.17289654205;41615;46748.766256168754;47706;47762;47891;47902.76048619761;8972.371933964609;9162.908370916306;9188.8621670675;9195.95402022989;9213.95393023034;8845.4250473719;8996.325275604324;9046.954765226197;9057.094290570923;9059.456432614064;9001.954990225073;9061.818763624724;9089.091090890892;9112.407693499934;9117.0427105154;9024.18782309592;9089.590968406437;9092.499912504809;9102.271818254523;9103;8950.86573701395;9048.909510904872;9067.229285510739;9098.818023639491;9102.681406150752;42529.57470425287;42985.78507107476;43224;43246;43394.34908476375;3747.831347589365;3963.009247688078;3981.1838573092737;4298.075913678543;4299.892502687427;32726.6727332726;32807;32911.6708832911;33327;34842.82578587116;3968.146848427602;3989.920201595981;3992.7005474589523;4127.215828992512;4138.544760076389;282752;285008;285890;286443;287027;45532.77233613811;45703.31445028327;45821.54178458173;46076.3088553672;66516;43513.56486435158;43611.78194109009;43807;43813.56186438158;43819.78090109593;16349.509514714578;16542.42101526441;16543.420980265633;16544.75182872258;16550.172491375382;13030.869691302965;13242.602721918358;13309.40107695156;13350.132241404277;13450.327483625779;15282.465113720966;15356.385744570316;15390.07659540431;15420.537383878502;15503.922480387526;5988.28140623128;6215.595986260879;6243.500519958392;6249.625022498664;6288.402601752826;1067.3382502848283;1078.5577913055765;1089.1613457637575;1105.6738262212666;1146.140394703972;29823.552646710315;30099.849500752793;30311.848440757654;30354;34649.48025779615;1111.1999360460457;1138.317009794117;1162.314234601589;1209.2744353387898;1244.9946841807086;15644.765328520081;15758.606034848992;15773.842261577467;15946.823959159814;16264.67470650604;575258;576715;584023;837012;848024;60891;61331.08003379953;61496.38503614996;61529.69235153795;61720.38279617146;1504.0674781635237;1517.3627076627843;1525.130675514968;1528.6102043978938;1530.7474266746085;31290.374192516476;31922.52116218305;31950.20124496813;31981.36037279288;32204.516932245566;49846.501534984185;50104;50348.748256258485;50463.24305135499;50554.24168637547;319708.40874773794;320371;321304;322429;323145;35065;35401.468977965866;35457.468137977434;35822.10444738902;36110;46746.76626616845;47065.2940205904;47296.290555641004;47382;47871;40112.59887401089;40506.594934050285;46244.76877615591;49910.25134622911;51810.74094629503;41179.58820411757;41363.379549307385;42898;44994.3250851244;45469.54530454653;43017.569824302605;43041.354379683704;43563.12873742571;43876.34185487156;43943.121137577706;42870.35694464523;43224.56775432205;43727.34408983932;43839.78080109579;44426.55573444224;29625.40749184961;29648.703512964596;29750.553741694326;29864.850675746482;29975
16:22:52 INFO - 2015-12-30 16:22:52,814 DEBUG : BROWSER_OUTPUT: |2;jquery.html;388.5551044054556;393.4039929506797;394.7414443539479;394.8341696487475;395.2431094454121;16303.940243884139;17442.651146977052;17475.912620436895;18867.245310187594;18905.432837014876;11106.777864442707;11335.829962550568;11467.254628449145;11484.310941343525;11585.594504192355;4875.536824001714;4965.702057876539;4978.103941290567;4979.278004689318;4994.076095922248;3680.834362453683;3795.905102372449;4972.428170760355;5397.811076612319;5488.670679759207;5452.809151679692;5459.535939445152;5467.781288748445;5488.204210389511;5496.065668836288;5409.837704868841;6063.818085457443;6093.268807743055;6095.664738439384;6114.052321890114;5471.835844924619;5485.040117979377;5487.506124448819;5489.862753431156;5514.944850551524;19787.40637780869;21593.67609485859;21817.127314907386;22592.322230333117;22750.203742868922;2232.073689418889;2266.2634643740685;2362.078789272185;2375.619900815861;2426.648136020267;9661;9907.603695852158;14344.067635603757;14443.277836108153;14574.489892853806;1970.6846904495212;2003.6794112942005;2008.3372487079375;2021.4845214470215;2043.83649308055;59889;60693.69653151706;61420.38579614191;62456.68771656113;64522.677386613235;10762.892371076345;11160.944195278971;11263.887361126448;11349.773004540028;11409.744928057908;15080.472183473526;15082.472113476195;15086.321115549827;15099.169545674873;15119.697606047817;8639.784005399915;8661.263792577702;8667.17661822126;8703.390762646553;8735.694250701195;8627.266682331947;8686.91313086861;8690.565471726388;8695.695650652196;8724.389292749574;4898.9712160446;4924.8030078797165;5009.499050094962;5012.097822392005;5016.322796422509;1865.5149661088215;1960.6470835249506;1961.1861077652613;2015.3349394699715;2019.2528764357282;962;966.6713317472094;991.5587563534158;1055.3404122423485;1066.4561073852392;17642;17926.820731792777;18390.356337528123;18429.723554146698;18624.97562634068;950.296780382512;998.6854140945579;1010.3988127064385;1034.7102811212872;1066.983995240072;10435.739106522245;10578.471076446147;10613.73465663349;10688;10694.679159625224;549882;558574;568312;600463;646904;86400.56799715961;87832.56083719668;89204;89938;91033.54483227541;1160.808466603001;1163.1218430085232;1202.8797120287902;1206.6138835572533;1228.6436933289424;16464.34142634329;16618.75071873947;16640.417585384454;16721.414750483676;16845.2419641114;35716;36100.81949590235;39086.804565976985;39120;39477.605223947394;51149.488505114474;54116.72941635267;54611;56313;59044;9802.36284641496;10053.748656283651;10162.288639795439;10526.421046842497;10798.514066866852;14704.926475367554;17130.314787408362;18611.90694046521;18864;19256.807431925503;15380.846191538389;15663.216839157769;15673.608159796097;15863.52409427719;15906.9204653976;15253.161076140475;15378.461753838563;15971.44099956496;16252.918735406247;16477.0113793168;16499.58751031234;16785;16920.492385228463;16996.235169417654;17112.743308850626;9835.655752048644;9933.801323973625;10019.448930308903;10047.899521004696;10120.949395252977;15996.68006639884;16297.67404651924;16435.58911027234;16529.66940661204;16634.50096497107
16:22:52 INFO - 2015-12-30 16:22:52,815 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1472.4699108321004;1525.549962760985;1660.3358656537375;1718.9742153867687;1859.4421673497957;7487.812804679879;7680.385569154469;7878.212178782119;7945.205479452059;7995.720149794758;7726.768196954086;7757.1079325877545;7757.456978011542;7760.185180556045;7820.92179078209;2328.348062542487;2363.83453158279;2368.2895131460577;2370.383700237942;2375.323032935614;2357.0571771291447;2383.988080059606;2386.176769014687;2391.9162829300976;2398.2205783120467;2251.718535183102;2287.5882341178663;2300.8619482831;2323.3262353917344;2326.3835083702834;2257.2776711452343;2299.827512936528;2329.7670232976734;2334.4280651240383;2338.9649155262687;2344.4490544721975;2367.9052837886466;2370.7392186859433;2372.9644055339186;2379.845310054841;7795.33739632132;7843.764687059397;7884.093329267151;7893.05283365994;7905.209479052049;4737.857864264043;4794.113089078532;4801.591864691471;4810.63920205986;4840.467548569654;3060.617422822147;3136.0121561708215;3167.683231676814;3176.7140957313723;3181.8886338978023;1015.2537884654773;1036.3004971644186;1038.3873514626332;1039.9688009359731;1065.1372388365448;10682.412467314294;10702.839457408145;10733.677989660322;10749.301295415773;10791.406472644001;4125.195586860594;4156.376543518436;4166.270902592095;4171.707980441401;4238.766867822238;8831.514266715263;8841.513716745641;8856.557172141367;8875.423097498642;8882.822343553222;4768.3085952536685;4779.06808172403;4800.615950723934;4801.615870730333;4809.278608208797;4382.758948257812;4420.270655341897;4429.180601588717;4429.822807087745;4431.158079964796;3453;3529.6117427083;3539.1682954505673;3547.308274886424;3565.982170089133;1011.2769369900557;1022.0545994954638;1035.9741006474899;1036.9118624916966;1132.5130194016651;1098.340995402752;1149.741308205647;1163.6567212672282;1175.2713317743055;1200.8438902942562;7438.962805185939;7447.106347238366;7532.811679707942;7540.359069479046;7626.694932202649;1209.625016244967;1210.267787988272;1212.5271144253747;1218.0803493362632;1258.5846670598864;5988;6015.157877897098;6049.395060494004;6067;6085.208922840091;9071.59177836999;9091.727248182566;9132.086791320815;9267.212286955684;9270.258379329638;9044.366894317334;9153.084691530927;9183.265338772882;9208.309376796633;9210.95394523023;7268.382187514015;7434.107907051189;7455.2172021938;7455.701771929171;7485.0643669541305;7428.888566671396;7469.775906722807;7489.176190619137;7494.400447964259;7542.4720269582795;8360.874586881324;8466.915330846612;8484.915150848412;8519.574021299035;8549.529775862387;8503.532305723245;8516.659333626585;8589.699360522352;8611.268042216481;8666.869996950178;6967.303269673195;7066.434685225273;7067.328603782633;7078.079849619517;7084.610346430995;7494.662740176815;7544.547327160388;7606.315431611181;7610.505317154367;7649.885251721117;7192.640367981476;7213.458990575623;7245.855082898207;7253.1296244448895;7264.382527485011;6823.1812182538415;7039.190493093155;7078.8938165928585;7121.679524421517;7265.9273407265255;6870.381665650116;6902.171739391305;6927.826804329932;6931.93068069333;6949.270326615835;6625.4037136657935;6666.300038496082;6666.433353165035;6675.098861653614;6678.365555272241;6729.327067293231;6750.594964302158;6777.186737591323;6787;6800.047993280846
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.2186237241462;344.65706621911204;347.4996005751716;347.59157989362507;355.34084273672335;6387.36126387361;6413.134226879376;6425.775097871576;6486.837829054276;6511.316311787259;6299.496040316775;6314.589551679138;6367.299597044333;6371.235451745785;6451.29035806061;4819.614430845532;4833.299171620113;4835.758212089381;4840.903181936377;4844.200706883377;4842.927356089662;4847.5394837490385;4849.005953779467;4851.684640498374;4854.2718592211095;4698.506656801038;4725.078609671115;4771.18889788735;4803.039392121572;4803.375561177042;4750.738709370983;4771.308160316752;4780.163471392492;4788.04239152171;4794.544518270759;4191.832326706928;4200.600942910419;4201.600847919473;4201.747895126272;4207.978960105211;6053.848653783647;6056.970315046453;6061.060535616986;6067.059605761114;6067.24159480065;5552.639078459887;5596.776128954837;5637.857614106654;5637.8590535236535;5659.773609055633;6751.662416879137;6753.3246675332075;6768;6776.864462710768;6813.0121132435515;4628.976855115737;4641.489436162019;4644.210484217658;4662.044280922402;4662.533746625344;7005;7041.753538626174;7107.715691372339;7110.928890711079;7129.714811407537;4757.690750101232;4761.47623761386;4763.095011947719;4767.856964291077;4772.236442169236;4749.810007599726;4766.261229509431;4772.331873537708;4815.061063092733;4826.975865120652;5569.916451253234;5628.577856660767;5629.211910332557;5632.098864181793;5635.8591035224445;6743.055972163803;6790.388865002074;6863.622500762406;6865.038894554767;6870.141232345957;1677.3542186258135;1703.4463799265288;1703.49746824687;1704.795424549062;1706.8890522116023;1125.8367536707296;1127.560251501915;1132.0999805154922;1134.7276653603076;1147.0937959012288;6595.670216489157;6607.768728094494;6625.204975402982;6630.701618427182;6631.403173714389;7078.327558881898;7079.92920070803;7080.539764915264;7081.575105493687;7083.0437890885105;6544.312847151075;6569.67151642416;6604.240512341143;6671.932490801449;6722.29415911332;3859.112404147062;3867.8646247381207;3873.922521549553;3881.4177873319227;3890.8638197662945;7331.706731730777;7334.156571994182;7367;7380.741674041383;7392.55644661322;7235.167955685059;7346.485745997836;7384.667689953965;7389.66746496409;7405.33351998312;7348.669309880961;7361.963190184015;7367.410607151415;7374.078240219973;7385.0399448072485;7069.22238553769;7108.466864985044;7116.964415177891;7173.426125910019;7188.065551478275;7041.507094503336;7049.048378468841;7062.540934839424;7063.117110361205;7071.045408869737;7316.158641756053;7340;7352.264773522605;7354.816129596803;7388.298111679382;4666.859994200179;4678.976605117089;4700.200965835747;4710.92933606003;4711.316859055486;7157.391621712213;7157.534760240567;7160.069191005136;7163.713451461883;7168.749093781693;6957.373836354753;6964.442844572321;6973.12835895513;6978.930210697828;6978.965105174441;6837.453003759787;6914.688839002157;6944.340287672663;6961.199462061928;6964.79105626832;6816.147981502312;6825.590464572141;6827.112475378169;6835.077264569419;6838.897416538656;6954.721811127701;6966.9303306966285;6983.0921980144285;6993.545419547713;7001.61491117973;6604.63674497888;6759.695813688298;6781.0845535854005;6788.660566971533;6788.694508747217
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: |5;yui.html;807.6204184033502;812.1959260332269;820.8850760893472;881.1628952495129;941.1999800169855;14211.360488778004;14490;14513.709725805478;14519.927400363009;14529.27353632318;13751.312434378266;13853.376598053086;13857.307134643277;13860.584182474542;13896.791548126786;902.0483390023522;927.4064598656865;929.4098247612781;932.6409332407038;934.0939288889766;908.8773015642903;917.3761841947473;925.2644147902433;925.4401087342162;926.3700683535193;962.93259471837;979.6228452045978;980.7499087732618;981.7790997025684;981.9361741486781;963.9566219520138;967.2938754709031;972.4457059476066;973.3575839945672;974.5565767575736;714.7677004973352;716.8172116110359;718.0127324928224;718.6119495472439;719.6006216549813;14909.179995100265;14963.850361496463;14995.32521036556;15030.248487575578;15031.323590438456;12949.741005179938;13084.803727943994;13149.737005259842;13285.3357332133;13371;10700.518476668569;11032.889671103347;11214.943925280402;11231.157663175294;11282.605108821233;3823.2926908522013;3847.8845634631007;3894.571597124314;3922.1371298314325;3939.763614183158;51661.7416912913;51738.7413062936;52239.216411753856;52455.213171802454;52847.20729189065;10633.46832658364;10650.201234907257;10750.838737418944;10867.021968022758;10895.891041089488;19272.32546860853;19338.709919351222;19360;19391.80608193928;19432.4170274892;8005.199480051948;8011.1588283230585;8018.879716804253;8085.151059138823;8225.054118776297;4637.234856248749;4652.067446998438;4652.092841895797;4733.431988161443;4842.297866809293;3229.9677003230136;3278.5737854079293;3283.228441316289;3286.063471910542;3287.6219234787827;603.7162533609196;622.4056026494777;624.123107034608;633.297040285283;637.327619361578;567.6906086182958;598.9401059893976;603.966781826995;608.0817964872986;740.8851627997669;9181.546949729376;9260.629574817067;9406;9435.339526233098;9436.669716559887;683.5761827666779;697.5326531224092;716.4912911832657;736.2490259934837;742.6620887496284;4276.208901353198;4285.1643929434085;4376.759278239664;4493.213687604656;4543.159515489645;59399;60085.699571501864;60208.39791602115;60684.696576516835;60932.39067609356;53489.732551336994;54059.72970135124;54273.72863135659;54325;54577.72711136419;51145.7442712784;51697.48302517002;51990;52084.218736718976;52867.73566132145;9200.171984521425;9263.212626926786;9494.098060684224;9561.330706850455;9659.227261818896;38266.851994440214;38417.23165536729;39398.80300598593;40094.398584021845;40616;48176;48380.75809620929;48715.269270960256;49108.508914910395;49131.754341228065;11823.231489953125;11968.880311197125;12026.218295810744;12079.396030198279;12207.511699531919;12809;13353.39909704085;13452.192868427926;13846.515371961934;14412;12583.245005299712;12799.680007999874;12875.227486350848;12945.741085178055;13179.077464577387;12263.38683065861;12711.682207944876;12722.363881805688;12916.612501624966;12993.935030324788;11690.70773230676;12137.21108127969;12157.392130393622;12218.083643726934;13079.149855259378;10929.726756831144;11275.605353812578;11320.830187547028;11627.302361858316;11921;10421.68734937953;10950.890491094988;11071;11082.279651822928;11217.49521271561
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: __end_tp_report
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: __start_cc_report
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,297
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: __end_cc_report
16:22:52 INFO - 2015-12-30 16:22:52,816 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521372806__endTimestamp
16:22:52 INFO - 2015-12-30 16:22:52,817 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,817 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
16:22:52 INFO - 2015-12-30 16:22:52,817 DEBUG : BROWSER_OUTPUT: Number of tests: 6
16:22:52 INFO - 2015-12-30 16:22:52,817 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,817 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5540.57 Median:5759.48 stddev:628.71 (10.9%) stddev-sans-first:606.32
16:22:52 INFO - 2015-12-30 16:22:52,818 DEBUG : BROWSER_OUTPUT: Values: 3333.0 3356.4 3380.7 3390.5 3397.0 5501.6 5542.3 5542.5 5550.7 5559.9 5528.5 5574.1 5581.2 5581.7 5602.9 5055.6 5073.3 5124.8 5125.5 5182.4 4797.8 4938.0 4950.0 5141.2 5265.8 5022.1 5087.6 5090.6 5092.3 5201.2 5162.8 5170.7 5188.2 5190.0 5231.0 4917.5 4955.4 5010.2 5101.0 5120.9 5284.9 5338.7 5356.2 5375.4 5413.4 5966.7 6081.9 6138.8 6149.8 6156.9 5948.2 5959.3 6089.6 6169.6 6176.3 5569.7 5571.2 5579.4 5587.0 5588.7 6006.7 6074.3 6079.5 6083.7 6094.8 5735.3 5808.0 5844.1 5874.3 5962.6 5917.5 6042.1 6085.3 6092.2 6099.9 5980.6 6031.5 6036.7 6051.1 6057.8 5772.4 5799.9 5896.6 5928.4 6025.6 4410.4 4431.2 4433.0 4458.5 4477.4 4015.7 4018.2 4038.3 4054.1 4056.7 5626.2 5661.4 5698.6 5722.6 5759.4 5914.6 6067.2 6081.3 6108.8 6121.3 5578.2 5775.9 5783.8 5790.7 5808.2 4967.9 4976.0 5045.0 5055.8 5103.3 6112.8 6131.6 6146.8 6154.4 6159.8 5953.7 5975.5 5981.3 5987.3 6008.7 5959.7 5999.9 6069.6 6098.9 6122.8 5823.8 5858.6 5863.4 5863.4 5930.3 5885.7 5910.0 5966.8 5968.6 5977.9 5671.7 5738.9 5756.7 5761.7 5796.0 5830.4 5836.2 5843.4 5850.2 5858.2 5626.4 5703.0 5759.5 5766.3 5778.6 5893.6 5913.4 5915.5 5916.3 5982.5 5661.0 5693.9 5722.1 5723.9 5743.1
16:22:52 INFO - 2015-12-30 16:22:52,818 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,819 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59347.54 Median:23641.93 stddev:126841.86 (536.5%) stddev-sans-first:127120.94
16:22:52 INFO - 2015-12-30 16:22:52,819 DEBUG : BROWSER_OUTPUT: Values: 578.1 611.9 614.9 635.4 673.7 32303.5 41163.4 41193.4 41355.2 41615.0 46748.8 47706.0 47762.0 47891.0 47902.8 8972.4 9162.9 9188.9 9196.0 9214.0 8845.4 8996.3 9047.0 9057.1 9059.5 9002.0 9061.8 9089.1 9112.4 9117.0 9024.2 9089.6 9092.5 9102.3 9103.0 8950.9 9048.9 9067.2 9098.8 9102.7 42529.6 42985.8 43224.0 43246.0 43394.3 3747.8 3963.0 3981.2 4298.1 4299.9 32726.7 32807.0 32911.7 33327.0 34842.8 3968.1 3989.9 3992.7 4127.2 4138.5 282752.0 285008.0 285890.0 286443.0 287027.0 45532.8 45703.3 45821.5 46076.3 66516.0 43513.6 43611.8 43807.0 43813.6 43819.8 16349.5 16542.4 16543.4 16544.8 16550.2 13030.9 13242.6 13309.4 13350.1 13450.3 15282.5 15356.4 15390.1 15420.5 15503.9 5988.3 6215.6 6243.5 6249.6 6288.4 1067.3 1078.6 1089.2 1105.7 1146.1 29823.6 30099.8 30311.8 30354.0 34649.5 1111.2 1138.3 1162.3 1209.3 1245.0 15644.8 15758.6 15773.8 15946.8 16264.7 575258.0 576715.0 584023.0 837012.0 848024.0 60891.0 61331.1 61496.4 61529.7 61720.4 1504.1 1517.4 1525.1 1528.6 1530.7 31290.4 31922.5 31950.2 31981.4 32204.5 49846.5 50104.0 50348.7 50463.2 50554.2 319708.4 320371.0 321304.0 322429.0 323145.0 35065.0 35401.5 35457.5 35822.1 36110.0 46746.8 47065.3 47296.3 47382.0 47871.0 40112.6 40506.6 46244.8 49910.3 51810.7 41179.6 41363.4 42898.0 44994.3 45469.5 43017.6 43041.4 43563.1 43876.3 43943.1 42870.4 43224.6 43727.3 43839.8 44426.6 29625.4 29648.7 29750.6 29864.9 29975.0
16:22:52 INFO - 2015-12-30 16:22:52,819 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,819 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31257.29 Median:11818.76 stddev:95772.74 (810.3%) stddev-sans-first:96013.36
16:22:52 INFO - 2015-12-30 16:22:52,820 DEBUG : BROWSER_OUTPUT: Values: 388.6 393.4 394.7 394.8 395.2 16303.9 17442.7 17475.9 18867.2 18905.4 11106.8 11335.8 11467.3 11484.3 11585.6 4875.5 4965.7 4978.1 4979.3 4994.1 3680.8 3795.9 4972.4 5397.8 5488.7 5452.8 5459.5 5467.8 5488.2 5496.1 5409.8 6063.8 6093.3 6095.7 6114.1 5471.8 5485.0 5487.5 5489.9 5514.9 19787.4 21593.7 21817.1 22592.3 22750.2 2232.1 2266.3 2362.1 2375.6 2426.6 9661.0 9907.6 14344.1 14443.3 14574.5 1970.7 2003.7 2008.3 2021.5 2043.8 59889.0 60693.7 61420.4 62456.7 64522.7 10762.9 11160.9 11263.9 11349.8 11409.7 15080.5 15082.5 15086.3 15099.2 15119.7 8639.8 8661.3 8667.2 8703.4 8735.7 8627.3 8686.9 8690.6 8695.7 8724.4 4899.0 4924.8 5009.5 5012.1 5016.3 1865.5 1960.6 1961.2 2015.3 2019.3 962.0 966.7 991.6 1055.3 1066.5 17642.0 17926.8 18390.4 18429.7 18625.0 950.3 998.7 1010.4 1034.7 1067.0 10435.7 10578.5 10613.7 10688.0 10694.7 549882.0 558574.0 568312.0 600463.0 646904.0 86400.6 87832.6 89204.0 89938.0 91033.5 1160.8 1163.1 1202.9 1206.6 1228.6 16464.3 16618.8 16640.4 16721.4 16845.2 35716.0 36100.8 39086.8 39120.0 39477.6 51149.5 54116.7 54611.0 56313.0 59044.0 9802.4 10053.7 10162.3 10526.4 10798.5 14704.9 17130.3 18611.9 18864.0 19256.8 15380.8 15663.2 15673.6 15863.5 15906.9 15253.2 15378.5 15971.4 16252.9 16477.0 16499.6 16785.0 16920.5 16996.2 17112.7 9835.7 9933.8 10019.4 10047.9 10120.9 15996.7 16297.7 16435.6 16529.7 16634.5
16:22:52 INFO - 2015-12-30 16:22:52,820 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,820 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5522.95 Median:6645.85 stddev:2816.40 (42.4%) stddev-sans-first:2807.85
16:22:52 INFO - 2015-12-30 16:22:52,820 DEBUG : BROWSER_OUTPUT: Values: 1472.5 1525.5 1660.3 1719.0 1859.4 7487.8 7680.4 7878.2 7945.2 7995.7 7726.8 7757.1 7757.5 7760.2 7820.9 2328.3 2363.8 2368.3 2370.4 2375.3 2357.1 2384.0 2386.2 2391.9 2398.2 2251.7 2287.6 2300.9 2323.3 2326.4 2257.3 2299.8 2329.8 2334.4 2339.0 2344.4 2367.9 2370.7 2373.0 2379.8 7795.3 7843.8 7884.1 7893.1 7905.2 4737.9 4794.1 4801.6 4810.6 4840.5 3060.6 3136.0 3167.7 3176.7 3181.9 1015.3 1036.3 1038.4 1040.0 1065.1 10682.4 10702.8 10733.7 10749.3 10791.4 4125.2 4156.4 4166.3 4171.7 4238.8 8831.5 8841.5 8856.6 8875.4 8882.8 4768.3 4779.1 4800.6 4801.6 4809.3 4382.8 4420.3 4429.2 4429.8 4431.2 3453.0 3529.6 3539.2 3547.3 3566.0 1011.3 1022.1 1036.0 1036.9 1132.5 1098.3 1149.7 1163.7 1175.3 1200.8 7439.0 7447.1 7532.8 7540.4 7626.7 1209.6 1210.3 1212.5 1218.1 1258.6 5988.0 6015.2 6049.4 6067.0 6085.2 9071.6 9091.7 9132.1 9267.2 9270.3 9044.4 9153.1 9183.3 9208.3 9211.0 7268.4 7434.1 7455.2 7455.7 7485.1 7428.9 7469.8 7489.2 7494.4 7542.5 8360.9 8466.9 8484.9 8519.6 8549.5 8503.5 8516.7 8589.7 8611.3 8666.9 6967.3 7066.4 7067.3 7078.1 7084.6 7494.7 7544.5 7606.3 7610.5 7649.9 7192.6 7213.5 7245.9 7253.1 7264.4 6823.2 7039.2 7078.9 7121.7 7265.9 6870.4 6902.2 6927.8 6931.9 6949.3 6625.4 6666.3 6666.4 6675.1 6678.4 6729.3 6750.6 6777.2 6787.0 6800.0
16:22:52 INFO - 2015-12-30 16:22:52,820 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,821 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5713.92 Median:6556.99 stddev:1763.58 (26.9%) stddev-sans-first:1721.86
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT: Values: 344.2 344.7 347.5 347.6 355.3 6387.4 6413.1 6425.8 6486.8 6511.3 6299.5 6314.6 6367.3 6371.2 6451.3 4819.6 4833.3 4835.8 4840.9 4844.2 4842.9 4847.5 4849.0 4851.7 4854.3 4698.5 4725.1 4771.2 4803.0 4803.4 4750.7 4771.3 4780.2 4788.0 4794.5 4191.8 4200.6 4201.6 4201.7 4208.0 6053.8 6057.0 6061.1 6067.1 6067.2 5552.6 5596.8 5637.9 5637.9 5659.8 6751.7 6753.3 6768.0 6776.9 6813.0 4629.0 4641.5 4644.2 4662.0 4662.5 7005.0 7041.8 7107.7 7110.9 7129.7 4757.7 4761.5 4763.1 4767.9 4772.2 4749.8 4766.3 4772.3 4815.1 4827.0 5569.9 5628.6 5629.2 5632.1 5635.9 6743.1 6790.4 6863.6 6865.0 6870.1 1677.4 1703.4 1703.5 1704.8 1706.9 1125.8 1127.6 1132.1 1134.7 1147.1 6595.7 6607.8 6625.2 6630.7 6631.4 7078.3 7079.9 7080.5 7081.6 7083.0 6544.3 6569.7 6604.2 6671.9 6722.3 3859.1 3867.9 3873.9 3881.4 3890.9 7331.7 7334.2 7367.0 7380.7 7392.6 7235.2 7346.5 7384.7 7389.7 7405.3 7348.7 7362.0 7367.4 7374.1 7385.0 7069.2 7108.5 7117.0 7173.4 7188.1 7041.5 7049.0 7062.5 7063.1 7071.0 7316.2 7340.0 7352.3 7354.8 7388.3 4666.9 4679.0 4700.2 4710.9 4711.3 7157.4 7157.5 7160.1 7163.7 7168.7 6957.4 6964.4 6973.1 6978.9 6979.0 6837.5 6914.7 6944.3 6961.2 6964.8 6816.1 6825.6 6827.1 6835.1 6838.9 6954.7 6966.9 6983.1 6993.5 7001.6 6604.6 6759.7 6781.1 6788.7 6788.7
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT:
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15014.51 Median:4644.65 stddev:17189.68 (370.1%) stddev-sans-first:17204.80
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT: Values: 807.6 812.2 820.9 881.2 941.2 14211.4 14490.0 14513.7 14519.9 14529.3 13751.3 13853.4 13857.3 13860.6 13896.8 902.0 927.4 929.4 932.6 934.1 908.9 917.4 925.3 925.4 926.4 962.9 979.6 980.7 981.8 981.9 964.0 967.3 972.4 973.4 974.6 714.8 716.8 718.0 718.6 719.6 14909.2 14963.9 14995.3 15030.2 15031.3 12949.7 13084.8 13149.7 13285.3 13371.0 10700.5 11032.9 11214.9 11231.2 11282.6 3823.3 3847.9 3894.6 3922.1 3939.8 51661.7 51738.7 52239.2 52455.2 52847.2 10633.5 10650.2 10750.8 10867.0 10895.9 19272.3 19338.7 19360.0 19391.8 19432.4 8005.2 8011.2 8018.9 8085.2 8225.1 4637.2 4652.1 4652.1 4733.4 4842.3 3230.0 3278.6 3283.2 3286.1 3287.6 603.7 622.4 624.1 633.3 637.3 567.7 598.9 604.0 608.1 740.9 9181.5 9260.6 9406.0 9435.3 9436.7 683.6 697.5 716.5 736.2 742.7 4276.2 4285.2 4376.8 4493.2 4543.2 59399.0 60085.7 60208.4 60684.7 60932.4 53489.7 54059.7 54273.7 54325.0 54577.7 51145.7 51697.5 51990.0 52084.2 52867.7 9200.2 9263.2 9494.1 9561.3 9659.2 38266.9 38417.2 39398.8 40094.4 40616.0 48176.0 48380.8 48715.3 49108.5 49131.8 11823.2 11968.9 12026.2 12079.4 12207.5 12809.0 13353.4 13452.2 13846.5 14412.0 12583.2 12799.7 12875.2 12945.7 13179.1 12263.4 12711.7 12722.4 12916.6 12993.9 11690.7 12137.2 12157.4 12218.1 13079.1 10929.7 11275.6 11320.8 11627.3 11921.0 10421.7 10950.9 11071.0 11082.3 11217.5
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
16:22:52 INFO - 2015-12-30 16:22:52,822 DEBUG : BROWSER_OUTPUT:
16:22:53 INFO - 2015-12-30 16:22:53,490 INFO : Browser exited with error code: 0
16:22:53 INFO - 2015-12-30 16:22:53,513 INFO : Completed test dromaeo_css (00:18:28)
16:22:53 INFO - 2015-12-30 16:22:53,513 INFO : Starting test kraken
16:22:53 INFO - 2015-12-30 16:22:53,513 DEBUG : operating with platform_type : linux_
16:22:53 INFO - 2015-12-30 16:22:53,514 INFO : Initialising browser for kraken test...
16:22:53 INFO - 2015-12-30 16:22:53,520 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFz5ky/profile http://localhost:49649/getInfo.html
16:22:57 INFO - 2015-12-30 16:22:57,920 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
16:22:57 INFO - 2015-12-30 16:22:57,920 DEBUG : BROWSER_OUTPUT: colorDepth:24
16:22:57 INFO - 2015-12-30 16:22:57,920 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697
16:22:57 INFO - 2015-12-30 16:22:57,920 DEBUG : BROWSER_OUTPUT: __metrics
16:22:58 INFO - 2015-12-30 16:22:58,906 INFO : Browser initialized.
16:22:58 INFO - 2015-12-30 16:22:58,906 INFO : Running cycle 1/1 for kraken test...
16:22:58 INFO - 2015-12-30 16:22:58,906 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqFz5ky/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
16:23:10 INFO - 2015-12-30 16:23:10,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 136761344
16:23:10 INFO - 2015-12-30 16:23:10,737 DEBUG : BROWSER_OUTPUT:
16:23:13 INFO - 2015-12-30 16:23:13,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection)
16:23:13 INFO - 2015-12-30 16:23:13,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904
16:23:13 INFO - 2015-12-30 16:23:13,798 DEBUG : BROWSER_OUTPUT:
16:23:16 INFO - 2015-12-30 16:23:16,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-dft)
16:23:17 INFO - 2015-12-30 16:23:17,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 138559488
16:23:17 INFO - 2015-12-30 16:23:17,020 DEBUG : BROWSER_OUTPUT:
16:23:19 INFO - 2015-12-30 16:23:19,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-fft)
16:23:20 INFO - 2015-12-30 16:23:20,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 138211328
16:23:20 INFO - 2015-12-30 16:23:20,412 DEBUG : BROWSER_OUTPUT:
16:23:22 INFO - 2015-12-30 16:23:22,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator)
16:23:23 INFO - 2015-12-30 16:23:23,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 138211328
16:23:23 INFO - 2015-12-30 16:23:23,053 DEBUG : BROWSER_OUTPUT:
16:23:25 INFO - 2015-12-30 16:23:25,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur)
16:23:25 INFO - 2015-12-30 16:23:25,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 138280960
16:23:25 INFO - 2015-12-30 16:23:25,821 DEBUG : BROWSER_OUTPUT:
16:23:28 INFO - 2015-12-30 16:23:28,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom)
16:23:29 INFO - 2015-12-30 16:23:29,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 139210752
16:23:29 INFO - 2015-12-30 16:23:29,405 DEBUG : BROWSER_OUTPUT:
16:23:32 INFO - 2015-12-30 16:23:32,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate)
16:23:33 INFO - 2015-12-30 16:23:33,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 139345920
16:23:33 INFO - 2015-12-30 16:23:33,333 DEBUG : BROWSER_OUTPUT:
16:23:36 INFO - 2015-12-30 16:23:36,116 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial)
16:23:36 INFO - 2015-12-30 16:23:36,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424
16:23:36 INFO - 2015-12-30 16:23:36,703 DEBUG : BROWSER_OUTPUT:
16:23:38 INFO - 2015-12-30 16:23:38,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox)
16:23:38 INFO - 2015-12-30 16:23:38,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 139276288
16:23:38 INFO - 2015-12-30 16:23:38,874 DEBUG : BROWSER_OUTPUT:
16:23:40 INFO - 2015-12-30 16:23:40,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes)
16:23:41 INFO - 2015-12-30 16:23:41,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432
16:23:41 INFO - 2015-12-30 16:23:41,240 DEBUG : BROWSER_OUTPUT:
16:23:43 INFO - 2015-12-30 16:23:43,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm)
16:23:43 INFO - 2015-12-30 16:23:43,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 138059776
16:23:43 INFO - 2015-12-30 16:23:43,825 DEBUG : BROWSER_OUTPUT:
16:23:46 INFO - 2015-12-30 16:23:46,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
16:23:46 INFO - 2015-12-30 16:23:46,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 138805248
16:23:46 INFO - 2015-12-30 16:23:46,826 DEBUG : BROWSER_OUTPUT:
16:23:49 INFO - 2015-12-30 16:23:49,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
16:23:49 INFO - 2015-12-30 16:23:49,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 138477568
16:23:49 INFO - 2015-12-30 16:23:49,956 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49649/tests/kraken/driver.html?testName=ai-astar)
16:23:51 INFO - 2015-12-30 16:23:51,855 DEBUG : BROWSER_OUTPUT: RSS: Main: 139489280
16:23:51 INFO - 2015-12-30 16:23:51,855 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,856 DEBUG : BROWSER_OUTPUT: __start_tp_report
16:23:51 INFO - 2015-12-30 16:23:51,856 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;104;112;110;112;122;112;111;110;113
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;122;155;162;123;150;148;126;180;128
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;162;162;165;161;159;161;164;163
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |3;audio-fft;90;74;73;154;73;71;72;71;158;71
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;147;94;92;93;143;91;93;132
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;110;110;110;110;109;109
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;150;147;147;146;146;147;147;147
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;99;96;97;96;96;97;96;96;95
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;61;62;62;60;62;66;62;60;59
16:23:51 INFO - 2015-12-30 16:23:51,857 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;62;63;64;63;64;63;62;63
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;81;80;81;81;81;81;88;82;81
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;111;116;119;116;121;118;118;129;117;121
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;151;160;148;149;146;146;147;137;146
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;66;65;69;64;65;64;66;65
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: __end_tp_report
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: __start_cc_report
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,720
16:23:51 INFO - 2015-12-30 16:23:51,858 DEBUG : BROWSER_OUTPUT: __end_cc_report
16:23:51 INFO - 2015-12-30 16:23:51,859 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521431855__endTimestamp
16:23:51 INFO - 2015-12-30 16:23:51,859 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,862 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
16:23:51 INFO - 2015-12-30 16:23:51,862 DEBUG : BROWSER_OUTPUT: Number of tests: 14
16:23:51 INFO - 2015-12-30 16:23:51,863 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,863 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:4.39 (3.9%) stddev-sans-first:4.66
16:23:51 INFO - 2015-12-30 16:23:51,863 DEBUG : BROWSER_OUTPUT: Values: 112.0 104.0 112.0 110.0 112.0 122.0 112.0 111.0 110.0 113.0
16:23:51 INFO - 2015-12-30 16:23:51,864 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,864 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.00 stddev:19.14 (12.8%) stddev-sans-first:20.30
16:23:51 INFO - 2015-12-30 16:23:51,864 DEBUG : BROWSER_OUTPUT: Values: 144.0 122.0 155.0 162.0 123.0 150.0 148.0 126.0 180.0 128.0
16:23:51 INFO - 2015-12-30 16:23:51,864 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,864 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.77 (1.1%) stddev-sans-first:1.87
16:23:51 INFO - 2015-12-30 16:23:51,865 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 162.0 162.0 165.0 161.0 159.0 161.0 164.0 163.0
16:23:51 INFO - 2015-12-30 16:23:51,865 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,865 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.70 Median:72.50 stddev:34.89 (48.1%) stddev-sans-first:37.01
16:23:51 INFO - 2015-12-30 16:23:51,865 DEBUG : BROWSER_OUTPUT: Values: 90.0 74.0 73.0 154.0 73.0 71.0 72.0 71.0 158.0 71.0
16:23:51 INFO - 2015-12-30 16:23:51,866 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,866 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:92.00 stddev:23.60 (25.7%) stddev-sans-first:24.41
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 147.0 94.0 92.0 93.0 143.0 91.0 93.0 132.0
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.17
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 150.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.07 (1.1%) stddev-sans-first:1.13
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: Values: 96.0 99.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 95.0
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,867 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:62.00 stddev:2.20 (3.6%) stddev-sans-first:2.01
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: Values: 58.0 61.0 62.0 62.0 60.0 62.0 66.0 62.0 60.0 59.0
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 62.0 63.0 64.0 63.0 64.0 63.0 62.0 63.0
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:2.42 (3.0%) stddev-sans-first:2.39
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: Values: 79.0 81.0 80.0 81.0 81.0 81.0 81.0 88.0 82.0 81.0
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:118.50 stddev:4.65 (3.9%) stddev-sans-first:4.03
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: Values: 111.0 116.0 119.0 116.0 121.0 118.0 118.0 129.0 117.0 121.0
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:148.50 stddev:5.74 (3.9%) stddev-sans-first:6.00
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: Values: 151.0 151.0 160.0 148.0 149.0 146.0 146.0 147.0 137.0 146.0
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT:
16:23:51 INFO - 2015-12-30 16:23:51,868 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.50 stddev:1.43 (2.2%) stddev-sans-first:1.51
16:23:51 INFO - 2015-12-30 16:23:51,869 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 66.0 65.0 69.0 64.0 65.0 64.0 66.0 65.0
16:23:51 INFO - 2015-12-30 16:23:51,869 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
16:23:51 INFO - 2015-12-30 16:23:51,869 DEBUG : BROWSER_OUTPUT:
16:23:52 INFO - 2015-12-30 16:23:52,690 INFO : Browser exited with error code: 0
16:23:52 INFO - 2015-12-30 16:23:52,742 INFO : Completed test kraken (00:00:59)
16:23:52 INFO - 2015-12-30 16:23:52,742 INFO : Starting test v8_7
16:23:52 INFO - 2015-12-30 16:23:52,742 DEBUG : operating with platform_type : linux_
16:23:52 INFO - 2015-12-30 16:23:52,742 INFO : Initialising browser for v8_7 test...
16:23:52 INFO - 2015-12-30 16:23:52,748 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplpI2q3/profile http://localhost:49649/getInfo.html
16:23:57 INFO - 2015-12-30 16:23:57,400 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200
16:23:57 INFO - 2015-12-30 16:23:57,400 DEBUG : BROWSER_OUTPUT: colorDepth:24
16:23:57 INFO - 2015-12-30 16:23:57,400 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697
16:23:57 INFO - 2015-12-30 16:23:57,400 DEBUG : BROWSER_OUTPUT: __metrics
16:23:58 INFO - 2015-12-30 16:23:58,442 INFO : Browser initialized.
16:23:58 INFO - 2015-12-30 16:23:58,442 INFO : Running cycle 1/1 for v8_7 test...
16:23:58 INFO - 2015-12-30 16:23:58,442 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmplpI2q3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1
16:24:10 INFO - 2015-12-30 16:24:10,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 136826880
16:24:10 INFO - 2015-12-30 16:24:10,202 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49649/tests/v8_7/run.html (next: http://localhost:49649/tests/v8_7/run.html)
16:24:31 INFO - 2015-12-30 16:24:31,831 DEBUG : BROWSER_OUTPUT: RSS: Main: 136232960
16:24:31 INFO - 2015-12-30 16:24:31,831 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,832 DEBUG : BROWSER_OUTPUT: __start_tp_report
16:24:31 INFO - 2015-12-30 16:24:31,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load
16:24:31 INFO - 2015-12-30 16:24:31,832 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details
16:24:31 INFO - 2015-12-30 16:24:31,832 DEBUG : BROWSER_OUTPUT: |i|pagename|runs|
16:24:31 INFO - 2015-12-30 16:24:31,833 DEBUG : BROWSER_OUTPUT: |0;Richards;166.9727834362999
16:24:31 INFO - 2015-12-30 16:24:31,833 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.9449081803005
16:24:31 INFO - 2015-12-30 16:24:31,833 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087
16:24:31 INFO - 2015-12-30 16:24:31,834 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845
16:24:31 INFO - 2015-12-30 16:24:31,834 DEBUG : BROWSER_OUTPUT: |4;RayTrace;910.7468123861566
16:24:31 INFO - 2015-12-30 16:24:31,834 DEBUG : BROWSER_OUTPUT: |5;Earley;542.5935973955508
16:24:31 INFO - 2015-12-30 16:24:31,834 DEBUG : BROWSER_OUTPUT: |6;Boyer;10902.173913043478
16:24:31 INFO - 2015-12-30 16:24:31,835 DEBUG : BROWSER_OUTPUT: |7;RegExp;24190.47619047619
16:24:31 INFO - 2015-12-30 16:24:31,835 DEBUG : BROWSER_OUTPUT: |8;Splay;516.2622612287042
16:24:31 INFO - 2015-12-30 16:24:31,835 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531
16:24:31 INFO - 2015-12-30 16:24:31,835 DEBUG : BROWSER_OUTPUT: __end_tp_report
16:24:31 INFO - 2015-12-30 16:24:31,836 DEBUG : BROWSER_OUTPUT: __startTimestamp1451521471829__endTimestamp
16:24:31 INFO - 2015-12-30 16:24:31,836 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,836 DEBUG : BROWSER_OUTPUT: ------- Summary: start -------
16:24:31 INFO - 2015-12-30 16:24:31,837 DEBUG : BROWSER_OUTPUT: Number of tests: 10
16:24:31 INFO - 2015-12-30 16:24:31,837 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,837 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,837 DEBUG : BROWSER_OUTPUT: Values: 167.0
16:24:31 INFO - 2015-12-30 16:24:31,837 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.94 Median:166.94 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: Values: 166.9
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: Values: 278.7
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,838 DEBUG : BROWSER_OUTPUT: Values: 5196.9
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:910.75 Median:910.75 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT: Values: 910.7
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:542.59 Median:542.59 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT: Values: 542.6
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,839 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10902.17 Median:10902.17 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: Values: 10902.2
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24190.48 Median:24190.48 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: Values: 24190.5
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.26 Median:516.26 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: Values: 516.3
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT:
16:24:31 INFO - 2015-12-30 16:24:31,840 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%)
16:24:31 INFO - 2015-12-30 16:24:31,841 DEBUG : BROWSER_OUTPUT: Values: 4835.7
16:24:31 INFO - 2015-12-30 16:24:31,841 DEBUG : BROWSER_OUTPUT: -------- Summary: end --------
16:24:31 INFO - 2015-12-30 16:24:31,841 DEBUG : BROWSER_OUTPUT:
16:24:32 INFO - 2015-12-30 16:24:32,654 INFO : Browser exited with error code: 0
16:24:32 INFO - 2015-12-30 16:24:32,668 INFO : Completed test v8_7 (00:00:39)
16:24:32 INFO - 2015-12-30 16:24:32,892 INFO : Completed test suite (00:20:08)
16:24:32 INFO - 2015-12-30 16:24:32,892 DEBUG : Working with test: dromaeo_css
16:24:32 INFO - 2015-12-30 16:24:32,892 DEBUG : Generating results file: dromaeo_css
16:24:32 INFO - 2015-12-30 16:24:32,893 DEBUG : Working with test: kraken
16:24:32 INFO - 2015-12-30 16:24:32,893 DEBUG : Generating results file: kraken
16:24:32 INFO - 2015-12-30 16:24:32,894 INFO : javascript benchmark
16:24:32 INFO - 2015-12-30 16:24:32,894 DEBUG : Working with test: v8_7
16:24:32 INFO - 2015-12-30 16:24:32,894 DEBUG : Generating results file: v8_7
16:24:32 INFO - 2015-12-30 16:24:32,894 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
16:24:32 INFO - 2015-12-30 16:24:32,953 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]]
16:24:32 INFO - 2015-12-30 16:24:32,953 DEBUG : process_Request line: dromaeo_css 7445.20 graph.html#tests=[[72,52,43]]
16:24:32 INFO - 2015-12-30 16:24:32,953 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
16:24:32 INFO - 2015-12-30 16:24:32,987 DEBUG : process_Request line: kraken 1506.70 graph.html#tests=[[232,52,43]]
16:24:32 INFO - 2015-12-30 16:24:32,987 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
16:24:33 INFO - 2015-12-30 16:24:33,021 DEBUG : process_Request line: v8_7 23311.54 graph.html#tests=[[230,52,43]]
16:24:33 INFO - 2015-12-30 16:24:33,023 INFO : javascript benchmark
16:24:33 INFO - 2015-12-30 16:24:33,026 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3332.9500057499135, 3356.4461863792476, 3380.7464440166964, 3390.542276792632, 3397.048826328628, 5501.642393244446, 5542.279503664523, 5542.528885044776, 5550.7224638768, 5559.861003474915, 5528.530074943635, 5574.136008918614, 5581.162825576165, 5581.748821303041, 5602.887942241153, 5055.5702765265, 5073.315102461157, 5124.820631277906, 5125.513076257749, 5182.4299327073995, 4797.808087676489, 4937.975310123445, 4950.009998000396, 5141.1517099678695, 5265.842024739245, 5022.070916880389, 5087.643864929457, 5090.567301779353, 5092.312537807404, 5201.2458193561915, 5162.793488260465, 5170.689758614476, 5188.22176673502, 5189.974050129726, 5231.006108839328, 4917.483664215278, 4955.380577427822, 5010.223415370623, 5101.0308041472, 5120.897582048376, 5284.920726189111, 5338.652987555796, 5356.223347614613, 5375.354957405098, 5413.377461591928, 5966.67183304918, 6081.878362432726, 6138.815835524897, 6149.754009839601, 6156.87686246277, 5948.196993405878, 5959.255093113361, 6089.573729838913, 6169.598976066586, 6176.289726681444, 5569.693666848281, 5571.247881536022, 5579.414161513023, 5586.972065139689, 5588.692621905793, 6006.729697163551, 6074.331823499411, 6079.483243924316, 6083.66539840313, 6094.786682466092, 5735.283089613798, 5808.041673123887, 5844.1233814927255, 5874.324452687995, 5962.55280853929, 5917.46742793142, 6042.12389203563, 6085.300190478063, 6092.177556029879, 6099.9390006099375, 5980.611260268156, 6031.487323577458, 6036.6679832609625, 6051.0923361496125, 6057.757689692451, 5772.3938986406665, 5799.94200057994, 5896.587238893237, 5928.407159284037, 6025.578209525379, 4410.426644536254, 4431.158079964796, 4432.955670443319, 4458.509563947963, 4477.440319960005, 4015.678745700337, 4018.1561872007205, 4038.3336749436603, 4054.0878302382316, 4056.6957478189256, 5626.212330273765, 5661.433856614388, 5698.572607054404, 5722.599418040781, 5759.366469688331, 5914.645121292736, 6067.180930574316, 6081.27024757032, 6108.816735497942, 6121.265448146251, 5578.163275508625, 5775.884482310415, 5783.768649254067, 5790.739416726257, 5808.215890854765, 4967.850964471072, 4976.0, 5045.016221836707, 5055.797768089235, 5103.336566246364, 6112.816615501542, 6131.601445906091, 6146.815595532141, 6154.446099851035, 6159.753609855556, 5953.702314884238, 5975.462208401264, 5981.3420523743225, 5987.31145918225, 6008.669523176267, 5959.67221802805, 5999.880002400015, 6069.635821850703, 6098.908516372169, 6122.816315510542, 5823.82528524145, 5858.5898987070495, 5863.355030946678, 5863.442972917566, 5930.258717660293, 5885.73514191871, 5909.970450147722, 5966.820995370146, 5968.641881487125, 5977.940220597912, 5671.659700417823, 5738.885222295614, 5756.712164391847, 5761.683107429131, 5796.014677504919, 5830.387809280134, 5836.153757705194, 5843.357230704534, 5850.151727999501, 5858.150568167506, 5626.352969408406, 5703.030484817674, 5759.481646651654, 5766.250387449605, 5778.566607504538, 5893.5874488785375, 5913.379095195115, 5915.497182739343, 5916.3492015877355, 5982.521398288213, 5661.0, 5693.857653558694, 5722.084466485342, 5723.914141287801, 5743.0811070228565], "unit": "ms", "name": "dojo.html", "value": 5499.118458413217}, {"lowerIsBetter": false, "replicates": [578.0952808854146, 611.8653896142848, 614.9108379285007, 635.3582881289896, 673.6766352150968, 32303.51544726828, 41163.38254926175, 41193.3820992685, 41355.17289654205, 41615.0, 46748.766256168754, 47706.0, 47762.0, 47891.0, 47902.76048619761, 8972.371933964609, 9162.908370916306, 9188.8621670675, 9195.95402022989, 9213.95393023034, 8845.4250473719, 8996.325275604324, 9046.954765226197, 9057.094290570923, 9059.456432614064, 9001.954990225073, 9061.818763624724, 9089.091090890892, 9112.407693499934, 9117.0427105154, 9024.18782309592, 9089.590968406437, 9092.499912504809, 9102.271818254523, 9103.0, 8950.86573701395, 9048.909510904872, 9067.229285510739, 9098.818023639491, 9102.681406150752, 42529.57470425287, 42985.78507107476, 43224.0, 43246.0, 43394.34908476375, 3747.831347589365, 3963.009247688078, 3981.1838573092737, 4298.075913678543, 4299.892502687427, 32726.6727332726, 32807.0, 32911.6708832911, 33327.0, 34842.82578587116, 3968.146848427602, 3989.920201595981, 3992.7005474589523, 4127.215828992512, 4138.544760076389, 282752.0, 285008.0, 285890.0, 286443.0, 287027.0, 45532.77233613811, 45703.31445028327, 45821.54178458173, 46076.3088553672, 66516.0, 43513.56486435158, 43611.78194109009, 43807.0, 43813.56186438158, 43819.78090109593, 16349.509514714578, 16542.42101526441, 16543.420980265633, 16544.75182872258, 16550.172491375382, 13030.869691302965, 13242.602721918358, 13309.40107695156, 13350.132241404277, 13450.327483625779, 15282.465113720966, 15356.385744570316, 15390.07659540431, 15420.537383878502, 15503.922480387526, 5988.28140623128, 6215.595986260879, 6243.500519958392, 6249.625022498664, 6288.402601752826, 1067.3382502848283, 1078.5577913055765, 1089.1613457637575, 1105.6738262212666, 1146.140394703972, 29823.552646710315, 30099.849500752793, 30311.848440757654, 30354.0, 34649.48025779615, 1111.1999360460457, 1138.317009794117, 1162.314234601589, 1209.2744353387898, 1244.9946841807086, 15644.765328520081, 15758.606034848992, 15773.842261577467, 15946.823959159814, 16264.67470650604, 575258.0, 576715.0, 584023.0, 837012.0, 848024.0, 60891.0, 61331.08003379953, 61496.38503614996, 61529.69235153795, 61720.38279617146, 1504.0674781635237, 1517.3627076627843, 1525.130675514968, 1528.6102043978938, 1530.7474266746085, 31290.374192516476, 31922.52116218305, 31950.20124496813, 31981.36037279288, 32204.516932245566, 49846.501534984185, 50104.0, 50348.748256258485, 50463.24305135499, 50554.24168637547, 319708.40874773794, 320371.0, 321304.0, 322429.0, 323145.0, 35065.0, 35401.468977965866, 35457.468137977434, 35822.10444738902, 36110.0, 46746.76626616845, 47065.2940205904, 47296.290555641004, 47382.0, 47871.0, 40112.59887401089, 40506.594934050285, 46244.76877615591, 49910.25134622911, 51810.74094629503, 41179.58820411757, 41363.379549307385, 42898.0, 44994.3250851244, 45469.54530454653, 43017.569824302605, 43041.354379683704, 43563.12873742571, 43876.34185487156, 43943.121137577706, 42870.35694464523, 43224.56775432205, 43727.34408983932, 43839.78080109579, 44426.55573444224, 29625.40749184961, 29648.703512964596, 29750.553741694326, 29864.850675746482, 29975.0], "unit": "ms", "name": "ext.html", "value": 20130.098975952802}, {"lowerIsBetter": false, "replicates": [388.5551044054556, 393.4039929506797, 394.7414443539479, 394.8341696487475, 395.2431094454121, 16303.940243884139, 17442.651146977052, 17475.912620436895, 18867.245310187594, 18905.432837014876, 11106.777864442707, 11335.829962550568, 11467.254628449145, 11484.310941343525, 11585.594504192355, 4875.536824001714, 4965.702057876539, 4978.103941290567, 4979.278004689318, 4994.076095922248, 3680.834362453683, 3795.905102372449, 4972.428170760355, 5397.811076612319, 5488.670679759207, 5452.809151679692, 5459.535939445152, 5467.781288748445, 5488.204210389511, 5496.065668836288, 5409.837704868841, 6063.818085457443, 6093.268807743055, 6095.664738439384, 6114.052321890114, 5471.835844924619, 5485.040117979377, 5487.506124448819, 5489.862753431156, 5514.944850551524, 19787.40637780869, 21593.67609485859, 21817.127314907386, 22592.322230333117, 22750.203742868922, 2232.073689418889, 2266.2634643740685, 2362.078789272185, 2375.619900815861, 2426.648136020267, 9661.0, 9907.603695852158, 14344.067635603757, 14443.277836108153, 14574.489892853806, 1970.6846904495212, 2003.6794112942005, 2008.3372487079375, 2021.4845214470215, 2043.83649308055, 59889.0, 60693.69653151706, 61420.38579614191, 62456.68771656113, 64522.677386613235, 10762.892371076345, 11160.944195278971, 11263.887361126448, 11349.773004540028, 11409.744928057908, 15080.472183473526, 15082.472113476195, 15086.321115549827, 15099.169545674873, 15119.697606047817, 8639.784005399915, 8661.263792577702, 8667.17661822126, 8703.390762646553, 8735.694250701195, 8627.266682331947, 8686.91313086861, 8690.565471726388, 8695.695650652196, 8724.389292749574, 4898.9712160446, 4924.8030078797165, 5009.499050094962, 5012.097822392005, 5016.322796422509, 1865.5149661088215, 1960.6470835249506, 1961.1861077652613, 2015.3349394699715, 2019.2528764357282, 962.0, 966.6713317472094, 991.5587563534158, 1055.3404122423485, 1066.4561073852392, 17642.0, 17926.820731792777, 18390.356337528123, 18429.723554146698, 18624.97562634068, 950.296780382512, 998.6854140945579, 1010.3988127064385, 1034.7102811212872, 1066.983995240072, 10435.739106522245, 10578.471076446147, 10613.73465663349, 10688.0, 10694.679159625224, 549882.0, 558574.0, 568312.0, 600463.0, 646904.0, 86400.56799715961, 87832.56083719668, 89204.0, 89938.0, 91033.54483227541, 1160.808466603001, 1163.1218430085232, 1202.8797120287902, 1206.6138835572533, 1228.6436933289424, 16464.34142634329, 16618.75071873947, 16640.417585384454, 16721.414750483676, 16845.2419641114, 35716.0, 36100.81949590235, 39086.804565976985, 39120.0, 39477.605223947394, 51149.488505114474, 54116.72941635267, 54611.0, 56313.0, 59044.0, 9802.36284641496, 10053.748656283651, 10162.288639795439, 10526.421046842497, 10798.514066866852, 14704.926475367554, 17130.314787408362, 18611.90694046521, 18864.0, 19256.807431925503, 15380.846191538389, 15663.216839157769, 15673.608159796097, 15863.52409427719, 15906.9204653976, 15253.161076140475, 15378.461753838563, 15971.44099956496, 16252.918735406247, 16477.0113793168, 16499.58751031234, 16785.0, 16920.492385228463, 16996.235169417654, 17112.743308850626, 9835.655752048644, 9933.801323973625, 10019.448930308903, 10047.899521004696, 10120.949395252977, 15996.68006639884, 16297.67404651924, 16435.58911027234, 16529.66940661204, 16634.50096497107], "unit": "ms", "name": "jquery.html", "value": 9525.100570199662}, {"lowerIsBetter": false, "replicates": [1472.4699108321004, 1525.549962760985, 1660.3358656537375, 1718.9742153867687, 1859.4421673497957, 7487.812804679879, 7680.385569154469, 7878.212178782119, 7945.205479452059, 7995.720149794758, 7726.768196954086, 7757.1079325877545, 7757.456978011542, 7760.185180556045, 7820.92179078209, 2328.348062542487, 2363.83453158279, 2368.2895131460577, 2370.383700237942, 2375.323032935614, 2357.0571771291447, 2383.988080059606, 2386.176769014687, 2391.9162829300976, 2398.2205783120467, 2251.718535183102, 2287.5882341178663, 2300.8619482831, 2323.3262353917344, 2326.3835083702834, 2257.2776711452343, 2299.827512936528, 2329.7670232976734, 2334.4280651240383, 2338.9649155262687, 2344.4490544721975, 2367.9052837886466, 2370.7392186859433, 2372.9644055339186, 2379.845310054841, 7795.33739632132, 7843.764687059397, 7884.093329267151, 7893.05283365994, 7905.209479052049, 4737.857864264043, 4794.113089078532, 4801.591864691471, 4810.63920205986, 4840.467548569654, 3060.617422822147, 3136.0121561708215, 3167.683231676814, 3176.7140957313723, 3181.8886338978023, 1015.2537884654773, 1036.3004971644186, 1038.3873514626332, 1039.9688009359731, 1065.1372388365448, 10682.412467314294, 10702.839457408145, 10733.677989660322, 10749.301295415773, 10791.406472644001, 4125.195586860594, 4156.376543518436, 4166.270902592095, 4171.707980441401, 4238.766867822238, 8831.514266715263, 8841.513716745641, 8856.557172141367, 8875.423097498642, 8882.822343553222, 4768.3085952536685, 4779.06808172403, 4800.615950723934, 4801.615870730333, 4809.278608208797, 4382.758948257812, 4420.270655341897, 4429.180601588717, 4429.822807087745, 4431.158079964796, 3453.0, 3529.6117427083, 3539.1682954505673, 3547.308274886424, 3565.982170089133, 1011.2769369900557, 1022.0545994954638, 1035.9741006474899, 1036.9118624916966, 1132.5130194016651, 1098.340995402752, 1149.741308205647, 1163.6567212672282, 1175.2713317743055, 1200.8438902942562, 7438.962805185939, 7447.106347238366, 7532.811679707942, 7540.359069479046, 7626.694932202649, 1209.625016244967, 1210.267787988272, 1212.5271144253747, 1218.0803493362632, 1258.5846670598864, 5988.0, 6015.157877897098, 6049.395060494004, 6067.0, 6085.208922840091, 9071.59177836999, 9091.727248182566, 9132.086791320815, 9267.212286955684, 9270.258379329638, 9044.366894317334, 9153.084691530927, 9183.265338772882, 9208.309376796633, 9210.95394523023, 7268.382187514015, 7434.107907051189, 7455.2172021938, 7455.701771929171, 7485.0643669541305, 7428.888566671396, 7469.775906722807, 7489.176190619137, 7494.400447964259, 7542.4720269582795, 8360.874586881324, 8466.915330846612, 8484.915150848412, 8519.574021299035, 8549.529775862387, 8503.532305723245, 8516.659333626585, 8589.699360522352, 8611.268042216481, 8666.869996950178, 6967.303269673195, 7066.434685225273, 7067.328603782633, 7078.079849619517, 7084.610346430995, 7494.662740176815, 7544.547327160388, 7606.315431611181, 7610.505317154367, 7649.885251721117, 7192.640367981476, 7213.458990575623, 7245.855082898207, 7253.1296244448895, 7264.382527485011, 6823.1812182538415, 7039.190493093155, 7078.8938165928585, 7121.679524421517, 7265.9273407265255, 6870.381665650116, 6902.171739391305, 6927.826804329932, 6931.93068069333, 6949.270326615835, 6625.4037136657935, 6666.300038496082, 6666.433353165035, 6675.098861653614, 6678.365555272241, 6729.327067293231, 6750.594964302158, 6777.186737591323, 6787.0, 6800.047993280846], "unit": "ms", "name": "mootools.html", "value": 4553.676166338719}, {"lowerIsBetter": false, "replicates": [344.2186237241462, 344.65706621911204, 347.4996005751716, 347.59157989362507, 355.34084273672335, 6387.36126387361, 6413.134226879376, 6425.775097871576, 6486.837829054276, 6511.316311787259, 6299.496040316775, 6314.589551679138, 6367.299597044333, 6371.235451745785, 6451.29035806061, 4819.614430845532, 4833.299171620113, 4835.758212089381, 4840.903181936377, 4844.200706883377, 4842.927356089662, 4847.5394837490385, 4849.005953779467, 4851.684640498374, 4854.2718592211095, 4698.506656801038, 4725.078609671115, 4771.18889788735, 4803.039392121572, 4803.375561177042, 4750.738709370983, 4771.308160316752, 4780.163471392492, 4788.04239152171, 4794.544518270759, 4191.832326706928, 4200.600942910419, 4201.600847919473, 4201.747895126272, 4207.978960105211, 6053.848653783647, 6056.970315046453, 6061.060535616986, 6067.059605761114, 6067.24159480065, 5552.639078459887, 5596.776128954837, 5637.857614106654, 5637.8590535236535, 5659.773609055633, 6751.662416879137, 6753.3246675332075, 6768.0, 6776.864462710768, 6813.0121132435515, 4628.976855115737, 4641.489436162019, 4644.210484217658, 4662.044280922402, 4662.533746625344, 7005.0, 7041.753538626174, 7107.715691372339, 7110.928890711079, 7129.714811407537, 4757.690750101232, 4761.47623761386, 4763.095011947719, 4767.856964291077, 4772.236442169236, 4749.810007599726, 4766.261229509431, 4772.331873537708, 4815.061063092733, 4826.975865120652, 5569.916451253234, 5628.577856660767, 5629.211910332557, 5632.098864181793, 5635.8591035224445, 6743.055972163803, 6790.388865002074, 6863.622500762406, 6865.038894554767, 6870.141232345957, 1677.3542186258135, 1703.4463799265288, 1703.49746824687, 1704.795424549062, 1706.8890522116023, 1125.8367536707296, 1127.560251501915, 1132.0999805154922, 1134.7276653603076, 1147.0937959012288, 6595.670216489157, 6607.768728094494, 6625.204975402982, 6630.701618427182, 6631.403173714389, 7078.327558881898, 7079.92920070803, 7080.539764915264, 7081.575105493687, 7083.0437890885105, 6544.312847151075, 6569.67151642416, 6604.240512341143, 6671.932490801449, 6722.29415911332, 3859.112404147062, 3867.8646247381207, 3873.922521549553, 3881.4177873319227, 3890.8638197662945, 7331.706731730777, 7334.156571994182, 7367.0, 7380.741674041383, 7392.55644661322, 7235.167955685059, 7346.485745997836, 7384.667689953965, 7389.66746496409, 7405.33351998312, 7348.669309880961, 7361.963190184015, 7367.410607151415, 7374.078240219973, 7385.0399448072485, 7069.22238553769, 7108.466864985044, 7116.964415177891, 7173.426125910019, 7188.065551478275, 7041.507094503336, 7049.048378468841, 7062.540934839424, 7063.117110361205, 7071.045408869737, 7316.158641756053, 7340.0, 7352.264773522605, 7354.816129596803, 7388.298111679382, 4666.859994200179, 4678.976605117089, 4700.200965835747, 4710.92933606003, 4711.316859055486, 7157.391621712213, 7157.534760240567, 7160.069191005136, 7163.713451461883, 7168.749093781693, 6957.373836354753, 6964.442844572321, 6973.12835895513, 6978.930210697828, 6978.965105174441, 6837.453003759787, 6914.688839002157, 6944.340287672663, 6961.199462061928, 6964.79105626832, 6816.147981502312, 6825.590464572141, 6827.112475378169, 6835.077264569419, 6838.897416538656, 6954.721811127701, 6966.9303306966285, 6983.0921980144285, 6993.545419547713, 7001.61491117973, 6604.63674497888, 6759.695813688298, 6781.0845535854005, 6788.660566971533, 6788.694508747217], "unit": "ms", "name": "prototype.html", "value": 5134.610001586784}, {"lowerIsBetter": false, "replicates": [807.6204184033502, 812.1959260332269, 820.8850760893472, 881.1628952495129, 941.1999800169855, 14211.360488778004, 14490.0, 14513.709725805478, 14519.927400363009, 14529.27353632318, 13751.312434378266, 13853.376598053086, 13857.307134643277, 13860.584182474542, 13896.791548126786, 902.0483390023522, 927.4064598656865, 929.4098247612781, 932.6409332407038, 934.0939288889766, 908.8773015642903, 917.3761841947473, 925.2644147902433, 925.4401087342162, 926.3700683535193, 962.93259471837, 979.6228452045978, 980.7499087732618, 981.7790997025684, 981.9361741486781, 963.9566219520138, 967.2938754709031, 972.4457059476066, 973.3575839945672, 974.5565767575736, 714.7677004973352, 716.8172116110359, 718.0127324928224, 718.6119495472439, 719.6006216549813, 14909.179995100265, 14963.850361496463, 14995.32521036556, 15030.248487575578, 15031.323590438456, 12949.741005179938, 13084.803727943994, 13149.737005259842, 13285.3357332133, 13371.0, 10700.518476668569, 11032.889671103347, 11214.943925280402, 11231.157663175294, 11282.605108821233, 3823.2926908522013, 3847.8845634631007, 3894.571597124314, 3922.1371298314325, 3939.763614183158, 51661.7416912913, 51738.7413062936, 52239.216411753856, 52455.213171802454, 52847.20729189065, 10633.46832658364, 10650.201234907257, 10750.838737418944, 10867.021968022758, 10895.891041089488, 19272.32546860853, 19338.709919351222, 19360.0, 19391.80608193928, 19432.4170274892, 8005.199480051948, 8011.1588283230585, 8018.879716804253, 8085.151059138823, 8225.054118776297, 4637.234856248749, 4652.067446998438, 4652.092841895797, 4733.431988161443, 4842.297866809293, 3229.9677003230136, 3278.5737854079293, 3283.228441316289, 3286.063471910542, 3287.6219234787827, 603.7162533609196, 622.4056026494777, 624.123107034608, 633.297040285283, 637.327619361578, 567.6906086182958, 598.9401059893976, 603.966781826995, 608.0817964872986, 740.8851627997669, 9181.546949729376, 9260.629574817067, 9406.0, 9435.339526233098, 9436.669716559887, 683.5761827666779, 697.5326531224092, 716.4912911832657, 736.2490259934837, 742.6620887496284, 4276.208901353198, 4285.1643929434085, 4376.759278239664, 4493.213687604656, 4543.159515489645, 59399.0, 60085.699571501864, 60208.39791602115, 60684.696576516835, 60932.39067609356, 53489.732551336994, 54059.72970135124, 54273.72863135659, 54325.0, 54577.72711136419, 51145.7442712784, 51697.48302517002, 51990.0, 52084.218736718976, 52867.73566132145, 9200.171984521425, 9263.212626926786, 9494.098060684224, 9561.330706850455, 9659.227261818896, 38266.851994440214, 38417.23165536729, 39398.80300598593, 40094.398584021845, 40616.0, 48176.0, 48380.75809620929, 48715.269270960256, 49108.508914910395, 49131.754341228065, 11823.231489953125, 11968.880311197125, 12026.218295810744, 12079.396030198279, 12207.511699531919, 12809.0, 13353.39909704085, 13452.192868427926, 13846.515371961934, 14412.0, 12583.245005299712, 12799.680007999874, 12875.227486350848, 12945.741085178055, 13179.077464577387, 12263.38683065861, 12711.682207944876, 12722.363881805688, 12916.612501624966, 12993.935030324788, 11690.70773230676, 12137.21108127969, 12157.392130393622, 12218.083643726934, 13079.149855259378, 10929.726756831144, 11275.605353812578, 11320.830187547028, 11627.302361858316, 11921.0, 10421.68734937953, 10950.890491094988, 11071.0, 11082.279651822928, 11217.49521271561], "unit": "ms", "name": "yui.html", "value": 6907.811889624785}], "name": "dromaeo_css", "value": 7445.198332619227}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 104.0, 112.0, 110.0, 112.0, 122.0, 112.0, 111.0, 110.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [144.0, 122.0, 155.0, 162.0, 123.0, 150.0, 148.0, 126.0, 180.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 162.0, 162.0, 165.0, 161.0, 159.0, 161.0, 164.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [90.0, 74.0, 73.0, 154.0, 73.0, 71.0, 72.0, 71.0, 158.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 90.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 147.0, 94.0, 92.0, 93.0, 143.0, 91.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 150.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [58.0, 61.0, 62.0, 62.0, 60.0, 62.0, 66.0, 62.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 63.0, 64.0, 63.0, 62.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.0}, {"lowerIsBetter": true, "replicates": [79.0, 81.0, 80.0, 81.0, 81.0, 81.0, 81.0, 88.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [111.0, 116.0, 119.0, 116.0, 121.0, 118.0, 118.0, 129.0, 117.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [151.0, 151.0, 160.0, 148.0, 149.0, 146.0, 146.0, 147.0, 137.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 66.0, 65.0, 69.0, 64.0, 65.0, 64.0, 66.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.5}], "name": "kraken", "value": 1506.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [166.9449081803005], "unit": "score", "name": "DeltaBlue", "value": 396.0468199999999}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [910.7468123861566], "unit": "score", "name": "RayTrace", "value": 812.5079219999998}, {"lowerIsBetter": false, "replicates": [542.5935973955508], "unit": "score", "name": "Earley", "value": 1228.2913090000002}, {"lowerIsBetter": false, "replicates": [10902.173913043478], "unit": "score", "name": "Boyer", "value": 61.131202392821535}, {"lowerIsBetter": false, "replicates": [24190.47619047619], "unit": "score", "name": "RegExp", "value": 37.65882874015749}, {"lowerIsBetter": false, "replicates": [516.2622612287042], "unit": "score", "name": "Splay", "value": 157.84806699999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23311.538279541957}]}
16:24:33 INFO - RETURN: dromaeo_css: 7445.20
16:24:33 INFO - RETURN: kraken: 1506.70
16:24:33 INFO - RETURN: v8_7: 23311.54
16:24:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23311.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1506.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7445.20"}}}
16:24:33 INFO - Return code: 0
16:24:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json
16:24:33 INFO - # TBPL SUCCESS #
16:24:33 INFO - Running post-action listener: _resource_record_post_action
16:24:33 INFO - Running post-run listener: _resource_record_post_run
16:24:34 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 327680; Write bytes: 531357696; Read time: 132; Write time: 630332
16:24:34 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 237289472; Read time: 0; Write time: 378576
16:24:34 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 327680; Write bytes: 277491712; Read time: 132; Write time: 242660
16:24:34 INFO - Running post-run listener: _upload_blobber_files
16:24:34 INFO - Blob upload gear active.
16:24:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ...
16:24:34 INFO - Copying logs to upload dir...
16:24:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs
program finished with exit code 0
elapsedTime=1263.873637
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-12-30 16:24:34.232853) =========
========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:34.236849) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
build_url:https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.010124
build_url: 'https://queue.taskcluster.net/v1/task/gC2-0kDLS9amiPitq2hkvA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'
========= master_lag: 0.04 =========
========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:34.288529) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:34.288875) =========
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=6e558709db315bacd2260379000001b6-1451520134.258142-467326911
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004566
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 16:24:34.340181) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 16:24:34.340575) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 16:24:34.340997) =========
========= Total master_lag: 0.20 =========