builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo
slave: talos-linux64-ix-062
starttime: 1453989612.56
results: success (0)
buildid: 20160128030208
builduid: 39b27016497340c39510ceec0a698967
revision: 0ecd7d72f232304da046b352c457e039e35ceed7
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.564667) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.565137) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.565436) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
/builds/slave/test-pgo
program finished with exit code 0
elapsedTime=0.006369
basedir: '/builds/slave/test-pgo'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.588413) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.588726) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.612414) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.612702) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.023383
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.660756) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.661257) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.661876) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.662368) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-01-28 06:00:12-- 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% 217M=0s
2016-01-28 06:00:12 (217 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.103587
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.778381) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.778706) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.111139
========= master_lag: 0.01 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.901058) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:12.901399) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --destination scripts --debug'
in dir /builds/slave/test-pgo/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-01-28 06:00:12,969 truncating revision to first 12 chars
2016-01-28 06:00:12,969 Setting DEBUG logging.
2016-01-28 06:00:12,970 attempt 1/10
2016-01-28 06:00:12,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ecd7d72f232?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-01-28 06:00:13,210 unpacking tar archive at: mozilla-central-0ecd7d72f232/testing/mozharness/
program finished with exit code 0
elapsedTime=0.527490
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.442474) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.442828) =========
echo 0ecd7d72f232304da046b352c457e039e35ceed7
in dir /builds/slave/test-pgo/. (timeout 1200 secs)
watching logfiles {}
argv: ['echo', u'0ecd7d72f232304da046b352c457e039e35ceed7']
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
0ecd7d72f232304da046b352c457e039e35ceed7
program finished with exit code 0
elapsedTime=0.004835
script_repo_revision: '0ecd7d72f232304da046b352c457e039e35ceed7'
========= master_lag: 0.05 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.493432) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.493786) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 06:00:13.503977) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-28 06:00:13.504403) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json
PWD=/builds/slave/test-pgo
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
06:00:13 INFO - MultiFileLogger online at 20160128 06:00:13 in /builds/slave/test-pgo
06:00:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
06:00:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json.
06:00:13 INFO - {'append_to_log': False,
06:00:13 INFO - 'base_work_dir': '/builds/slave/test-pgo',
06:00:13 INFO - 'blob_upload_branch': 'Firefox',
06:00:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt',
06:00:13 INFO - 'branch': 'Firefox',
06:00:13 INFO - 'buildbot_json_path': 'buildprops.json',
06:00:13 INFO - 'config_files': ('talos/linux_config.py',),
06:00:13 INFO - 'default_actions': ('clobber',
06:00:13 INFO - 'read-buildbot-config',
06:00:13 INFO - 'download-and-extract',
06:00:13 INFO - 'populate-webroot',
06:00:13 INFO - 'create-virtualenv',
06:00:13 INFO - 'install',
06:00:13 INFO - 'run-tests'),
06:00:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
06:00:13 INFO - 'download_minidump_stackwalk': True,
06:00:13 INFO - 'download_symbols': 'ondemand',
06:00:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
06:00:13 INFO - 'tooltool.py': '/tools/tooltool.py',
06:00:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
06:00:13 INFO - '/tools/misc-python/virtualenv.py')},
06:00:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
06:00:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
06:00:13 INFO - 'installer_path': 'installer.exe',
06:00:13 INFO - 'log_level': 'info',
06:00:13 INFO - 'log_name': 'talos',
06:00:13 INFO - 'log_to_console': True,
06:00:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
06:00:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
06:00:13 INFO - 'opt_config_files': (),
06:00:13 INFO - 'pip_index': False,
06:00:13 INFO - 'sps_profile': False,
06:00:13 INFO - 'sps_profile_interval': 0,
06:00:13 INFO - 'suite': 'dromaeojs',
06:00:13 INFO - 'system_bits': '32',
06:00:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
06:00:13 INFO - 'title': 'talos-linux64-ix-062',
06:00:13 INFO - 'tooltool_cache': '/builds/tooltool_cache',
06:00:13 INFO - 'use_talos_json': True,
06:00:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv',
06:00:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
06:00:13 INFO - 'work_dir': 'build'}
06:00:13 INFO - #####
06:00:13 INFO - ##### Running clobber step.
06:00:13 INFO - #####
06:00:13 INFO - Running pre-action listener: _resource_record_pre_action
06:00:13 INFO - Running main action method: clobber
06:00:13 INFO - rmtree: /builds/slave/test-pgo/build
06:00:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1
06:00:14 INFO - Running post-action listener: _resource_record_post_action
06:00:14 INFO - #####
06:00:14 INFO - ##### Running read-buildbot-config step.
06:00:14 INFO - #####
06:00:14 INFO - Running pre-action listener: _resource_record_pre_action
06:00:14 INFO - Running main action method: read_buildbot_config
06:00:14 INFO - Using buildbot properties:
06:00:14 INFO - {
06:00:14 INFO - "project": "",
06:00:14 INFO - "product": "firefox",
06:00:14 INFO - "script_repo_revision": "production",
06:00:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs",
06:00:14 INFO - "repository": "",
06:00:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs",
06:00:14 INFO - "buildid": "20160128030208",
06:00:14 INFO - "stage_platform": "linux64-pgo",
06:00:14 INFO - "basedir": "/builds/slave/test-pgo",
06:00:14 INFO - "nightly_build": "True",
06:00:14 INFO - "buildnumber": 334,
06:00:14 INFO - "slavename": "talos-linux64-ix-062",
06:00:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
06:00:14 INFO - "platform": "ubuntu64_hw",
06:00:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos",
06:00:14 INFO - "branch": "mozilla-central",
06:00:14 INFO - "repo_path": "mozilla-central",
06:00:14 INFO - "revision": "0ecd7d72f232304da046b352c457e039e35ceed7",
06:00:14 INFO - "pgo_build": "True",
06:00:14 INFO - "builduid": "39b27016497340c39510ceec0a698967",
06:00:14 INFO - "slavebuilddir": "test"
06:00:14 INFO - }
06:00:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2.
06:00:14 INFO - Running post-action listener: _resource_record_post_action
06:00:14 INFO - #####
06:00:14 INFO - ##### Running download-and-extract step.
06:00:14 INFO - #####
06:00:14 INFO - Running pre-action listener: _resource_record_pre_action
06:00:14 INFO - Running main action method: download_and_extract
06:00:14 INFO - mkdir: /builds/slave/test-pgo/build/tests
06:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:14 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net
06:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json
06:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json
06:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json
06:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1
06:00:24 INFO - Downloaded 1448 bytes.
06:00:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json
06:00:24 INFO - Using the following test package requirements:
06:00:24 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'],
06:00:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
06:00:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'],
06:00:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'jsshell-linux-x86_64.zip'],
06:00:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
06:00:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'],
06:00:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'],
06:00:24 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'],
06:00:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
06:00:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'],
06:00:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip',
06:00:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
06:00:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
06:00:24 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')]}
06:00:24 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
06:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
06:00:25 INFO - Downloaded 22503314 bytes.
06:00:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
06:00:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests
06:00:26 INFO - Return code: 0
06:00:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
06:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:26 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
06:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip
06:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
06:00:33 INFO - Downloaded 22503314 bytes.
06:00:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
06:00:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests
06:00:34 INFO - Return code: 0
06:00: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')]}
06:00:34 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
06:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip
06:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip
06:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip
06:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
06:00:35 INFO - Downloaded 10706572 bytes.
06:00:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
06:00:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests
06:00:35 INFO - Return code: 0
06:00: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')]}
06:00:35 INFO - https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
06:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
06:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
06:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
06:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
06:00:41 INFO - Downloaded 55991278 bytes.
06:00:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
06:00:41 INFO - mkdir: /builds/slave/test-pgo/properties
06:00:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url
06:00:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url
06:00:41 INFO - Contents:
06:00:41 INFO - build_url:https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
06:00:41 INFO - Running post-action listener: _resource_record_post_action
06:00:41 INFO - Running post-action listener: set_extra_try_arguments
06:00:41 INFO - #####
06:00:41 INFO - ##### Running populate-webroot step.
06:00:41 INFO - #####
06:00:41 INFO - Running pre-action listener: _resource_record_pre_action
06:00:41 INFO - Running main action method: populate_webroot
06:00:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
06:00:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
06:00:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
06:00:41 INFO - '--tppagecycles',
06:00:41 INFO - '7'],
06:00:41 INFO - 'tests': ['tsvgm']}},
06:00:41 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']},
06:00:41 INFO - 'chromez-e10s': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['tresize', 'tcanvasmark']},
06:00:41 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']},
06:00:41 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']},
06:00:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
06:00:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
06:00:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'tests': ['damp', 'tps']},
06:00:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['damp', 'tps']},
06:00:41 INFO - 'g3': {'tests': ['dromaeo_dom']},
06:00:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
06:00:41 INFO - 'other': {'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'other-e10s': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'other_l64': {'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'other_nol64': {'tests': ['a11yr',
06:00:41 INFO - 'ts_paint',
06:00:41 INFO - 'tpaint',
06:00:41 INFO - 'sessionrestore',
06:00:41 INFO - 'sessionrestore_no_auto_restore']},
06:00:41 INFO - 'svgr': {'tests': ['tsvgx',
06:00:41 INFO - 'tsvgr_opacity',
06:00:41 INFO - 'tart',
06:00:41 INFO - 'tscrollx',
06:00:41 INFO - 'cart']},
06:00:41 INFO - 'svgr-e10s': {'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['tsvgx',
06:00:41 INFO - 'tsvgr_opacity',
06:00:41 INFO - 'tart',
06:00:41 INFO - 'tscrollx',
06:00:41 INFO - 'cart']},
06:00:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'tests': ['tp5o']},
06:00:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'talos_options': ['--e10s'],
06:00:41 INFO - 'tests': ['tp5o']},
06:00:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'talos_options': ['--xperf_path',
06:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
06:00:41 INFO - 'tests': ['tp5n']},
06:00:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:00:41 INFO - 'talos_options': ['--e10s',
06:00:41 INFO - '--xperf_path',
06:00:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
06:00:41 INFO - 'tests': ['tp5n']}},
06:00:41 INFO - 'talos.zip': {'path': '',
06:00:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
06:00:41 INFO - Running post-action listener: _resource_record_post_action
06:00:41 INFO - #####
06:00:41 INFO - ##### Running create-virtualenv step.
06:00:41 INFO - #####
06:00:41 INFO - Running pre-action listener: _resource_record_pre_action
06:00:41 INFO - Running main action method: create_virtualenv
06:00:41 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv
06:00:41 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
06:00:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv
06:00:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
06:00:41 INFO - Using real prefix '/usr'
06:00:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python
06:00:42 INFO - Installing distribute.............................................................................................................................................................................................done.
06:00:45 INFO - Installing pip.................done.
06:00:45 INFO - Return code: 0
06:00:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv
06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:00:45 INFO - Using env: {'DISPLAY': ':0',
06:00:45 INFO - 'HOME': '/home/cltbld',
06:00:45 INFO - 'LANG': 'en_US.UTF-8',
06:00:45 INFO - 'LANGUAGE': 'en_US:en',
06:00:45 INFO - 'LOGNAME': 'cltbld',
06:00:45 INFO - 'MAIL': '/var/mail/cltbld',
06:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:45 INFO - 'MOZ_NO_REMOTE': '1',
06:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:45 INFO - 'NO_EM_RESTART': '1',
06:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:45 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:45 INFO - 'SHELL': '/bin/bash',
06:00:45 INFO - 'SHLVL': '1',
06:00:45 INFO - 'TERM': 'linux',
06:00:45 INFO - 'TMOUT': '86400',
06:00:45 INFO - 'USER': 'cltbld',
06:00:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:45 INFO - '_': '/tools/buildbot/bin/python'}
06:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:45 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
06:00:45 INFO - Cleaning up...
06:00:45 INFO - Return code: 0
06:00:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv
06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:45 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:00:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:00:45 INFO - Using env: {'DISPLAY': ':0',
06:00:45 INFO - 'HOME': '/home/cltbld',
06:00:45 INFO - 'LANG': 'en_US.UTF-8',
06:00:45 INFO - 'LANGUAGE': 'en_US:en',
06:00:45 INFO - 'LOGNAME': 'cltbld',
06:00:45 INFO - 'MAIL': '/var/mail/cltbld',
06:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:45 INFO - 'MOZ_NO_REMOTE': '1',
06:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:45 INFO - 'NO_EM_RESTART': '1',
06:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:45 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:45 INFO - 'SHELL': '/bin/bash',
06:00:45 INFO - 'SHLVL': '1',
06:00:45 INFO - 'TERM': 'linux',
06:00:45 INFO - 'TMOUT': '86400',
06:00:45 INFO - 'USER': 'cltbld',
06:00:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:45 INFO - '_': '/tools/buildbot/bin/python'}
06:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:45 INFO - Downloading/unpacking psutil>=0.7.1
06:00:45 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
06:00:45 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
06:00:45 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
06:00:45 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
06:00:45 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
06:00:45 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
06:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil
06:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
06:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
06:00:47 INFO - Installing collected packages: psutil
06:00:47 INFO - Running setup.py install for psutil
06:00:47 INFO - building 'psutil._psutil_linux' extension
06:00:47 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
06:00:48 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
06:00:48 INFO - building 'psutil._psutil_posix' extension
06:00:48 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
06:00:48 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
06:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
06:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
06:00:48 INFO - Successfully installed psutil
06:00:48 INFO - Cleaning up...
06:00:48 INFO - Return code: 0
06:00:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv
06:00: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')]}
06:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00: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')]}
06:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:00:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:00:48 INFO - Using env: {'DISPLAY': ':0',
06:00:48 INFO - 'HOME': '/home/cltbld',
06:00:48 INFO - 'LANG': 'en_US.UTF-8',
06:00:48 INFO - 'LANGUAGE': 'en_US:en',
06:00:48 INFO - 'LOGNAME': 'cltbld',
06:00:48 INFO - 'MAIL': '/var/mail/cltbld',
06:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:48 INFO - 'MOZ_NO_REMOTE': '1',
06:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:48 INFO - 'NO_EM_RESTART': '1',
06:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:48 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:48 INFO - 'SHELL': '/bin/bash',
06:00:48 INFO - 'SHLVL': '1',
06:00:48 INFO - 'TERM': 'linux',
06:00:48 INFO - 'TMOUT': '86400',
06:00:48 INFO - 'USER': 'cltbld',
06:00:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:48 INFO - '_': '/tools/buildbot/bin/python'}
06:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
06:00: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
06:00: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
06:00: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
06:00: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
06:00: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
06:00: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
06:00:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz
06:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
06:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0)
06:00:50 INFO - Installing collected packages: mozsystemmonitor
06:00:50 INFO - Running setup.py install for mozsystemmonitor
06:00:50 INFO - Successfully installed mozsystemmonitor
06:00:50 INFO - Cleaning up...
06:00:50 INFO - Return code: 0
06:00:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv
06:00: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')]}
06:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00: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')]}
06:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:00:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:00:50 INFO - Using env: {'DISPLAY': ':0',
06:00:50 INFO - 'HOME': '/home/cltbld',
06:00:50 INFO - 'LANG': 'en_US.UTF-8',
06:00:50 INFO - 'LANGUAGE': 'en_US:en',
06:00:50 INFO - 'LOGNAME': 'cltbld',
06:00:50 INFO - 'MAIL': '/var/mail/cltbld',
06:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:50 INFO - 'MOZ_NO_REMOTE': '1',
06:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:50 INFO - 'NO_EM_RESTART': '1',
06:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:50 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:50 INFO - 'SHELL': '/bin/bash',
06:00:50 INFO - 'SHLVL': '1',
06:00:50 INFO - 'TERM': 'linux',
06:00:50 INFO - 'TMOUT': '86400',
06:00:50 INFO - 'USER': 'cltbld',
06:00:50 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:50 INFO - '_': '/tools/buildbot/bin/python'}
06:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:50 INFO - Downloading/unpacking blobuploader==1.2.4
06:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:00:52 INFO - Downloading blobuploader-1.2.4.tar.gz
06:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
06:00:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:00:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests
06:00:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
06:00: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
06:00: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
06:00: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
06:00: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
06:00: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
06:00: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
06:00:53 INFO - Downloading docopt-0.6.1.tar.gz
06:00:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt
06:00:53 INFO - Installing collected packages: blobuploader, requests, docopt
06:00:53 INFO - Running setup.py install for blobuploader
06:00:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
06:00:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775
06:00:53 INFO - Running setup.py install for requests
06:00:53 INFO - Running setup.py install for docopt
06:00:53 INFO - Successfully installed blobuploader requests docopt
06:00:53 INFO - Cleaning up...
06:00:53 INFO - Return code: 0
06:00:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
06:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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
06:00:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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
06:00:53 INFO - Using env: {'DISPLAY': ':0',
06:00:53 INFO - 'HOME': '/home/cltbld',
06:00:53 INFO - 'LANG': 'en_US.UTF-8',
06:00:53 INFO - 'LANGUAGE': 'en_US:en',
06:00:53 INFO - 'LOGNAME': 'cltbld',
06:00:53 INFO - 'MAIL': '/var/mail/cltbld',
06:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:53 INFO - 'MOZ_NO_REMOTE': '1',
06:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:53 INFO - 'NO_EM_RESTART': '1',
06:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:53 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:53 INFO - 'SHELL': '/bin/bash',
06:00:53 INFO - 'SHLVL': '1',
06:00:53 INFO - 'TERM': 'linux',
06:00:53 INFO - 'TMOUT': '86400',
06:00:53 INFO - 'USER': 'cltbld',
06:00:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:53 INFO - '_': '/tools/buildbot/bin/python'}
06:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
06:00:54 INFO - Running setup.py (path:/tmp/pip-57Yf93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
06:00:54 INFO - Running setup.py (path:/tmp/pip-70BJra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
06:00:54 INFO - Running setup.py (path:/tmp/pip-Jdpl2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
06:00:54 INFO - Running setup.py (path:/tmp/pip-KZiHhZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
06:00:54 INFO - Running setup.py (path:/tmp/pip-v_Pc6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
06:00:54 INFO - Running setup.py (path:/tmp/pip-ih5SYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
06:00:54 INFO - Running setup.py (path:/tmp/pip-ypsxCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
06:00:54 INFO - Running setup.py (path:/tmp/pip-gGmfAO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
06:00:54 INFO - Running setup.py (path:/tmp/pip-b7TSaH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
06:00:54 INFO - Running setup.py (path:/tmp/pip-iaDA7z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
06:00:54 INFO - Running setup.py (path:/tmp/pip-5dWRBo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
06:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
06:00:54 INFO - Running setup.py (path:/tmp/pip-OMSxEq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
06:00:55 INFO - Running setup.py (path:/tmp/pip-eUkwOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
06:00:55 INFO - Running setup.py (path:/tmp/pip-WbpGv8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
06:00:55 INFO - Running setup.py (path:/tmp/pip-0vJf3f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
06:00:55 INFO - Running setup.py (path:/tmp/pip-ZOSdn3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
06:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
06:00:55 INFO - Running setup.py (path:/tmp/pip-OqPBLa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
06:00:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
06:00:55 INFO - Running setup.py install for manifestparser
06:00:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin
06:00:55 INFO - Running setup.py install for mozcrash
06:00:55 INFO - Running setup.py install for mozdebug
06:00:55 INFO - Running setup.py install for mozdevice
06:00:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin
06:00:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin
06:00:55 INFO - Running setup.py install for mozfile
06:00:55 INFO - Running setup.py install for mozhttpd
06:00:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozinfo
06:00:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozInstall
06:00:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozleak
06:00:56 INFO - Running setup.py install for mozlog
06:00:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for moznetwork
06:00:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozprocess
06:00:56 INFO - Running setup.py install for mozprofile
06:00:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozrunner
06:00:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin
06:00:56 INFO - Running setup.py install for mozscreenshot
06:00:56 INFO - Running setup.py install for moztest
06:00:57 INFO - Running setup.py install for mozversion
06:00:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin
06:00:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
06:00:57 INFO - Cleaning up...
06:00:57 INFO - Return code: 0
06:00:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:00:57 INFO - Using env: {'DISPLAY': ':0',
06:00:57 INFO - 'HOME': '/home/cltbld',
06:00:57 INFO - 'LANG': 'en_US.UTF-8',
06:00:57 INFO - 'LANGUAGE': 'en_US:en',
06:00:57 INFO - 'LOGNAME': 'cltbld',
06:00:57 INFO - 'MAIL': '/var/mail/cltbld',
06:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:00:57 INFO - 'MOZ_NO_REMOTE': '1',
06:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:00:57 INFO - 'NO_EM_RESTART': '1',
06:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:00:57 INFO - 'PWD': '/builds/slave/test-pgo',
06:00:57 INFO - 'SHELL': '/bin/bash',
06:00:57 INFO - 'SHLVL': '1',
06:00:57 INFO - 'TERM': 'linux',
06:00:57 INFO - 'TMOUT': '86400',
06:00:57 INFO - 'USER': 'cltbld',
06:00:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:00:57 INFO - '_': '/tools/buildbot/bin/python'}
06:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
06:00:57 INFO - Running setup.py (path:/tmp/pip-Yidqdf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
06:00:57 INFO - Running setup.py (path:/tmp/pip-3oHpCO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
06:00:57 INFO - Running setup.py (path:/tmp/pip-qfOFAM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
06:00:57 INFO - Running setup.py (path:/tmp/pip-9fKoSj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
06:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
06:00:57 INFO - Running setup.py (path:/tmp/pip-AlXgkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
06:00:57 INFO - Running setup.py (path:/tmp/pip-RLdqnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
06:00:57 INFO - Running setup.py (path:/tmp/pip-R2KXwX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
06:00:57 INFO - Running setup.py (path:/tmp/pip-jltJd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
06:00:57 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))
06:00:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
06:00:57 INFO - Running setup.py (path:/tmp/pip-skCFzi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
06:00:58 INFO - Running setup.py (path:/tmp/pip-m3TKGT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
06:00:58 INFO - Running setup.py (path:/tmp/pip-4HOSS0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
06:00:58 INFO - Running setup.py (path:/tmp/pip-Q1hMda-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
06:00:58 INFO - Running setup.py (path:/tmp/pip-y2nTtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
06:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
06:00:58 INFO - Running setup.py (path:/tmp/pip-ouuybI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
06:00:58 INFO - Running setup.py (path:/tmp/pip-Ieh1uP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
06:00:58 INFO - Running setup.py (path:/tmp/pip-2zVeht-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
06:00:58 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))
06:00:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
06:00:58 INFO - Running setup.py (path:/tmp/pip-TZWzhm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
06:00:58 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))
06:00:58 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))
06:00:58 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))
06:00:58 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))
06:00:58 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4))
06:00:58 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4))
06:00:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10))
06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:01:00 INFO - Downloading blessings-1.6.tar.gz
06:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings
06:01:00 INFO - Installing collected packages: blessings
06:01:00 INFO - Running setup.py install for blessings
06:01:00 INFO - Successfully installed blessings
06:01:00 INFO - Cleaning up...
06:01:00 INFO - Return code: 0
06:01:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv.
06:01:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
06:01:00 INFO - Reading from file tmpfile_stdout
06:01:00 INFO - Current package versions:
06:01:00 INFO - argparse == 1.2.1
06:01:00 INFO - blessings == 1.6
06:01:00 INFO - blobuploader == 1.2.4
06:01:00 INFO - docopt == 0.6.1
06:01:00 INFO - manifestparser == 1.1
06:01:00 INFO - mozInstall == 1.12
06:01:00 INFO - mozcrash == 0.16
06:01:00 INFO - mozdebug == 0.1
06:01:00 INFO - mozdevice == 0.48
06:01:00 INFO - mozfile == 1.2
06:01:00 INFO - mozhttpd == 0.7
06:01:00 INFO - mozinfo == 0.9
06:01:00 INFO - mozleak == 0.1
06:01:00 INFO - mozlog == 3.1
06:01:00 INFO - moznetwork == 0.27
06:01:00 INFO - mozprocess == 0.22
06:01:00 INFO - mozprofile == 0.28
06:01:00 INFO - mozrunner == 6.11
06:01:00 INFO - mozscreenshot == 0.1
06:01:00 INFO - mozsystemmonitor == 0.0
06:01:00 INFO - moztest == 0.7
06:01:00 INFO - mozversion == 1.4
06:01:00 INFO - psutil == 3.1.1
06:01:00 INFO - requests == 1.2.3
06:01:00 INFO - wsgiref == 0.1.2
06:01:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:01:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:01:00 INFO - Using env: {'DISPLAY': ':0',
06:01:00 INFO - 'HOME': '/home/cltbld',
06:01:00 INFO - 'LANG': 'en_US.UTF-8',
06:01:00 INFO - 'LANGUAGE': 'en_US:en',
06:01:00 INFO - 'LOGNAME': 'cltbld',
06:01:00 INFO - 'MAIL': '/var/mail/cltbld',
06:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:01:00 INFO - 'MOZ_NO_REMOTE': '1',
06:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:01:00 INFO - 'NO_EM_RESTART': '1',
06:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:01:00 INFO - 'PWD': '/builds/slave/test-pgo',
06:01:00 INFO - 'SHELL': '/bin/bash',
06:01:00 INFO - 'SHLVL': '1',
06:01:00 INFO - 'TERM': 'linux',
06:01:00 INFO - 'TMOUT': '86400',
06:01:00 INFO - 'USER': 'cltbld',
06:01:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:01:00 INFO - '_': '/tools/buildbot/bin/python'}
06:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1))
06:01:01 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 2))
06:01:01 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 3))
06:01:01 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 4))
06:01:01 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 5))
06:01:01 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 6))
06:01:01 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 7))
06:01:01 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 8))
06:01:01 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 9))
06:01:01 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1))
06:01:01 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 4))
06:01:01 INFO - Cleaning up...
06:01:01 INFO - Return code: 0
06:01:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv
06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:01:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:01:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:01:01 INFO - Using env: {'DISPLAY': ':0',
06:01:01 INFO - 'HOME': '/home/cltbld',
06:01:01 INFO - 'LANG': 'en_US.UTF-8',
06:01:01 INFO - 'LANGUAGE': 'en_US:en',
06:01:01 INFO - 'LOGNAME': 'cltbld',
06:01:01 INFO - 'MAIL': '/var/mail/cltbld',
06:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:01:01 INFO - 'MOZ_NO_REMOTE': '1',
06:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:01:01 INFO - 'NO_EM_RESTART': '1',
06:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:01:01 INFO - 'PWD': '/builds/slave/test-pgo',
06:01:01 INFO - 'SHELL': '/bin/bash',
06:01:01 INFO - 'SHLVL': '1',
06:01:01 INFO - 'TERM': 'linux',
06:01:01 INFO - 'TMOUT': '86400',
06:01:01 INFO - 'USER': 'cltbld',
06:01:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:01:01 INFO - '_': '/tools/buildbot/bin/python'}
06:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:01:01 INFO - Downloading/unpacking jsonschema
06:01:01 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
06:01:01 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
06:01:01 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
06:01:01 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
06:01:01 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
06:01:01 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
06:01:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
06:01:03 INFO - Downloading/unpacking functools32 (from jsonschema)
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01:03 INFO - Downloading functools32-3.2.3-2.tar.gz
06:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32
06:01:03 INFO - warning: no files found matching '*.txt'
06:01:03 INFO - no previously-included directories found matching 'build'
06:01:03 INFO - no previously-included directories found matching 'dist'
06:01:03 INFO - no previously-included directories found matching '.git*'
06:01:03 INFO - Installing collected packages: jsonschema, functools32
06:01:03 INFO - Running setup.py install for functools32
06:01:03 INFO - warning: no files found matching '*.txt'
06:01:03 INFO - no previously-included directories found matching 'build'
06:01:03 INFO - no previously-included directories found matching 'dist'
06:01:03 INFO - no previously-included directories found matching '.git*'
06:01:03 INFO - Successfully installed jsonschema functools32
06:01:03 INFO - Cleaning up...
06:01:03 INFO - Return code: 0
06:01:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv
06:01: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')]}
06:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01: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')]}
06:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:01:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7ffbee797f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28788a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2948630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287', '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
06:01:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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
06:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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
06:01:03 INFO - Using env: {'DISPLAY': ':0',
06:01:03 INFO - 'HOME': '/home/cltbld',
06:01:03 INFO - 'LANG': 'en_US.UTF-8',
06:01:03 INFO - 'LANGUAGE': 'en_US:en',
06:01:03 INFO - 'LOGNAME': 'cltbld',
06:01:03 INFO - 'MAIL': '/var/mail/cltbld',
06:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:01:03 INFO - 'MOZ_NO_REMOTE': '1',
06:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:01:03 INFO - 'NO_EM_RESTART': '1',
06:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:01:03 INFO - 'PWD': '/builds/slave/test-pgo',
06:01:03 INFO - 'SHELL': '/bin/bash',
06:01:03 INFO - 'SHLVL': '1',
06:01:03 INFO - 'TERM': 'linux',
06:01:03 INFO - 'TMOUT': '86400',
06:01:03 INFO - 'USER': 'cltbld',
06:01:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:01:03 INFO - '_': '/tools/buildbot/bin/python'}
06:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:01:03 INFO - Downloading/unpacking flake8
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
06:01:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
06:01:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01: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
06:01:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8
06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
06:01:06 INFO - no previously-included directories found matching 'docs/_build'
06:01:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
06:01:06 INFO - Running setup.py install for pep8
06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
06:01:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
06:01:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
06:01:06 INFO - no previously-included directories found matching 'docs/_build'
06:01:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin
06:01:06 INFO - Successfully installed flake8 mccabe pyflakes pep8
06:01:06 INFO - Cleaning up...
06:01:06 INFO - Return code: 0
06:01:06 INFO - Running post-action listener: _resource_record_post_action
06:01:06 INFO - Running post-action listener: _start_resource_monitoring
06:01:06 INFO - Starting resource monitoring.
06:01:06 INFO - #####
06:01:06 INFO - ##### Running install step.
06:01:06 INFO - #####
06:01:06 INFO - Running pre-action listener: _resource_record_pre_action
06:01:06 INFO - Running main action method: install
06:01:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
06:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
06:01:06 INFO - Reading from file tmpfile_stdout
06:01:06 INFO - Detecting whether we're running mozinstall >=1.0...
06:01:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h']
06:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h
06:01:06 INFO - Reading from file tmpfile_stdout
06:01:06 INFO - Output received:
06:01:06 INFO - Usage: mozinstall [options] installer
06:01:06 INFO - Options:
06:01:06 INFO - -h, --help show this help message and exit
06:01:06 INFO - -d DEST, --destination=DEST
06:01:06 INFO - Directory to install application into. [default:
06:01:06 INFO - "/builds/slave/test-pgo"]
06:01:06 INFO - --app=APP Application being installed. [default: firefox]
06:01:06 INFO - mkdir: /builds/slave/test-pgo/build/application
06:01:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application']
06:01:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application
06:01:22 INFO - Reading from file tmpfile_stdout
06:01:22 INFO - Output received:
06:01:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox
06:01:22 INFO - Running post-action listener: _resource_record_post_action
06:01:22 INFO - #####
06:01:22 INFO - ##### Running run-tests step.
06:01:22 INFO - #####
06:01:22 INFO - Running pre-action listener: _resource_record_pre_action
06:01:22 INFO - Running main action method: run_tests
06:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version']
06:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version
06:01:22 INFO - Python 2.7.3
06:01:22 INFO - Return code: 0
06:01:22 INFO - grabbing minidump binary from tooltool
06:01:22 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')]}
06:01:22 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 0x29d9840>, '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 0x29466b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2946b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1
06:01:22 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
06:01:22 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
06:01:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
06:01:22 INFO - Return code: 0
06:01:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755
06:01:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir
06:01:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir
06:01:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk
06:01:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir
06:01:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos']
06:01:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos
06:01:23 INFO - Return code: 0
06:01:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build
06:01:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log
06:01:23 INFO - Using env: {'DISPLAY': ':0',
06:01:23 INFO - 'HOME': '/home/cltbld',
06:01:23 INFO - 'LANG': 'en_US.UTF-8',
06:01:23 INFO - 'LANGUAGE': 'en_US:en',
06:01:23 INFO - 'LOGNAME': 'cltbld',
06:01:23 INFO - 'MAIL': '/var/mail/cltbld',
06:01:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir',
06:01:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk',
06:01:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:01:23 INFO - 'MOZ_NO_REMOTE': '1',
06:01:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir',
06:01:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:01:23 INFO - 'NO_EM_RESTART': '1',
06:01:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:01:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
06:01:23 INFO - 'PWD': '/builds/slave/test-pgo',
06:01:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos',
06:01:23 INFO - 'SHELL': '/bin/bash',
06:01:23 INFO - 'SHLVL': '1',
06:01:23 INFO - 'TERM': 'linux',
06:01:23 INFO - 'TMOUT': '86400',
06:01:23 INFO - 'USER': 'cltbld',
06:01:23 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287',
06:01:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:01:23 INFO - '_': '/tools/buildbot/bin/python'}
06:01:23 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600
06:01:24 INFO - mozversion application_buildid: 20160128030208
06:01:24 INFO - mozversion application_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7
06:01:24 INFO - mozversion application_display_name: Nightly
06:01:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
06:01:24 INFO - mozversion application_name: Firefox
06:01:24 INFO - mozversion application_remotingname: firefox
06:01:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
06:01:24 INFO - mozversion application_vendor: Mozilla
06:01:24 INFO - mozversion application_version: 47.0a1
06:01:24 INFO - mozversion platform_buildid: 20160128030208
06:01:24 INFO - mozversion platform_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7
06:01:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
06:01:24 INFO - mozversion platform_version: 47.0a1
06:01:24 INFO - using testdate: 1453989684
06:01:24 INFO - actual date: 1453989684
06:01:24 INFO - starting webserver on 'localhost:43044'
06:01:24 INFO - SUITE-START | Running 3 tests
06:01:24 INFO - TEST-START | dromaeo_css
06:01:24 INFO - operating with platform_type : linux_
06:01:24 INFO - Initialising browser for dromaeo_css test...
06:01:24 INFO - TEST-INFO | started process 4430 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBrm4A/profile http://localhost:43044/getInfo.html)
06:01:27 INFO - PROCESS | 4430 | __metrics Screen width/height:1600/1200
06:01:27 INFO - PROCESS | 4430 | colorDepth:24
06:01:27 INFO - PROCESS | 4430 | Browser inner width/height: 1024/697
06:01:27 INFO - PROCESS | 4430 | __metrics
06:01:27 INFO - PROCESS | 4430 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
06:01:27 INFO - PROCESS | 4430 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
06:01:28 INFO - TEST-INFO | 4430: exit 0
06:01:28 INFO - Browser initialized.
06:01:28 INFO - Running cycle 1/1 for dromaeo_css test...
06:01:28 INFO - TEST-INFO | started process 4522 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBrm4A/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
06:01:40 INFO - PROCESS | 4522 | RSS: Main: 148447232
06:01:40 INFO - PROCESS | 4522 |
06:02:32 INFO - PROCESS | 4522 | 1453989752187 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]
06:04:39 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43044/tests/dromaeo/cssquery-ext.html)
06:04:41 INFO - PROCESS | 4522 | RSS: Main: 270000128
06:04:41 INFO - PROCESS | 4522 |
06:07:43 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-ext.html (next: http://localhost:43044/tests/dromaeo/cssquery-jquery.html)
06:07:44 INFO - PROCESS | 4522 | RSS: Main: 227651584
06:07:44 INFO - PROCESS | 4522 |
06:10:46 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43044/tests/dromaeo/cssquery-mootools.html)
06:10:46 INFO - PROCESS | 4522 | RSS: Main: 236146688
06:10:46 INFO - PROCESS | 4522 |
06:13:48 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43044/tests/dromaeo/cssquery-prototype.html)
06:13:49 INFO - PROCESS | 4522 | RSS: Main: 215670784
06:13:49 INFO - PROCESS | 4522 |
06:16:51 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43044/tests/dromaeo/cssquery-yui.html)
06:16:52 INFO - PROCESS | 4522 | RSS: Main: 218083328
06:16:52 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | Cycle 1(1): loaded http://localhost:43044/tests/dromaeo/cssquery-yui.html (next: http://localhost:43044/tests/dromaeo/cssquery-dojo.html)
06:19:55 INFO - PROCESS | 4522 | RSS: Main: 264237056
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | __start_tp_report
06:19:55 INFO - PROCESS | 4522 | _x_x_mozilla_page_load
06:19:55 INFO - PROCESS | 4522 | _x_x_mozilla_page_load_details
06:19:55 INFO - PROCESS | 4522 | |i|pagename|runs|
06:19:55 INFO - PROCESS | 4522 | |0;dojo.html;3036.316828713539;3078.769092318074;3124.312651216733;3124.437601231779;3147.3705258948216;4876.2929375240565;4909.263610458433;4988.850334489966;5008.899822003557;5046.293518907356;4904.975475122628;4959.479254678261;4993.176125939225;5006.699598024121;5019.899602007958;4548.8862778430475;4550.067236216568;4589.655775816827;4622.0293738314995;4632;4616.8614941551805;4653;4684.344191813149;4688.109259240733;4693.131770622445;4439.911201775946;4609.469910960249;4617.676762626617;4690.718556886581;4700.1539722849875;4511.120331535352;4564.7032942858605;4568.223402021665;4575.702579332366;4613.746243956581;4579.381783459224;4580.129775342674;4587.885302867422;4590.908181836345;4620.653450991189;4856.781444834991;4861.927071093936;4864.464908860023;4873.634477414173;4943.431505376891;5266.683998960037;5275.60432967529;5296.523312901819;5309.681419114865;5345.278387417727;5320.787168513255;5339.65292256006;5342.786288548454;5350.3312085989255;5351.732413379315;4916.287138364917;4924.482929292444;4985.925211121836;5025.447200807908;5054.570361519275;5433.0763770159165;5441.972790136024;5465.726713664301;5470.206820011076;5520.585956053312;5266.236395722599;5271.314729085195;5274.340707411574;5282.709450980233;5283.233931079972;5267.78928842842;5317.1226747586215;5332.386775520865;5337.706426146599;5452.618316717871;5186.92219616706;5192.1173400522;5197.376314842168;5199.948000520022;5222.477752224823;5210.76551555181;5221.164613661796;5224.007438586732;5232.9738351308;5277.261183434322;4085.22380747657;4143.523494798137;4165.271077561415;4170.562090980464;4232.830686772556;3718.3121122592406;3734.3091528067393;3736.9626303736613;3759.774413535197;3768.3028639701197;4904.754762261872;4905.607551395879;4935.358403407534;4936.75316234194;4986.800527978913;5124;5189.221616757441;5289.18017707256;5341;5390.730463476811;4956.826511072168;4958.8760280993265;4981.62637802159;5003.224500202475;5050.747462626928;4484.573965473275;4554.726716396961;4591.540845915449;4598.26427771555;4628.4445866496235;5485.232067510552;5562.332520097614;5578.800557880075;5608.719564021864;5660.886782264414;5333.386660534088;5350.304460420276;5356.437574054824;5357.491038351351;5360.276362691143;5396.9190462142315;5457.290552228185;5553.445794691482;5581.274434323512;5636.267285252891;5241.528262456397;5247.9766445542755;5274.261603375454;5277.155655095166;5318.335208098988;5335.199720042025;5364.865878353073;5374.811881584125;5387.353517577916;5413.56691464674;5088.007838471611;5130.179171332569;5152.793888244429;5251.947480525146;5252.474752524717;5283.841484755463;5288.947110528846;5299.6290259681455;5304.708241046779;5314.946850531445;5165.509276618715;5199.766010529611;5211.1922651989;5211.5049070338255;5254.7898084076205;5143.459936706741;5165.020044032055;5185.040767458032;5239.109351410193;5240.764165612481;5218.034663587248;5219.8434046978655;5227.085260079547;5232.11054120808;5233.712145832016
06:19:55 INFO - PROCESS | 4522 | |1;ext.html;515.5772266741271;522.4592546714151;536.8469986053974;554.5425024354909;558.4025093150328;26733.866330668345;28107.718922810767;35264.471032934496;35913.2817343653;36002.279954400896;38265;38493.88283644398;38747.80626096865;38898.416523752094;38922.416163757494;8391.076981532042;8566.057733649293;8583.785405364884;8588;8590.828183436328;8247.175282471764;8328.125546817588;8391.664333426656;8403.915960840375;8415.537145456998;8634.78413039676;8705.869411958794;8717.215450609443;8717.694880679177;8727.476351418934;8620.267277281439;8657.523836189008;8671.089535598734;8677.1756683115;8680.218780309739;8435.662573497053;8451.070382257947;8456.06983231844;8472.872906906401;8560.143985601453;38645.42031869524;38940.610593894264;39003.41494877579;39086.60913390858;39185.60814391877;2840.318323602341;2877.1656219696265;2911.446825103245;3143.874245030196;3272.525483804835;28597.857010715023;28984.710152898413;29459.70540294591;29515.262118447212;29627.70372296271;3855.2096820152083;3867.941980870289;3899.78551179685;3930;4034.9798251008556;255140;259501;260070.69964650244;260256;260462;50154.49845501571;50961.490385095676;54488.37162797211;54826.45173548293;56773.43226567681;51639.74180129075;51847;51867.740661297204;51918.22122668163;52125;13647.931760341135;13809.378577964017;13810.309484525733;13856.168629882239;13917.373718182705;9889.456079915673;10098.293119481712;10413.843792343121;10678.305910115818;10826.296290741077;17886.195121219578;18033.278668853098;18095.36666216676;18119;18119.547011324823;6849.280825513349;7110.146782386147;7153.928460715326;7185.245549217361;7193.856122877618;796.2555011064674;820.3806126374668;824.6083110522574;893.5800173918248;1010.5806090472519;23959.880200598884;26443.471130577665;26533.73466265351;26662.20013399601;26828;873.4366333714719;877.4472082588056;883.7746374674546;898.1602201941206;1035.7048241251357;12643.862052415327;12708.301043442514;12750.553730619384;12883.677908052374;13035.087543872027;240549;245293;247649;248083;248390;46037;46265.5373446268;46476.5352346479;46549.30176047362;51199.74400127975;1217.5008246618843;1220.725336799213;1249.1817859301989;1250.531050855929;1255.8555766087018;23205;24216.63675044911;28436.28909277202;28483;28790.712092878803;50824.72938176427;51201;51448;51586.74206628943;51720;173899;176987;188735;273177;275447;42491;42554.86870924414;42805.57194428016;43055.35416968811;43673.34489982589;44668.32997505105;44815.32777008413;45195.548044519135;45491.31763023491;46188.307175391725;37221.627783721815;37394.813025934694;37684.246315074095;38098.619013809504;39304.80347598244;31745.365092697553;36309.63690363168;37137;37350.25299494049;37351.25297494089;34069.48895766516;34446.65553344435;34681.13297167591;34839.47740783941;35057.298854022265;32136.678633214306;33600.3279934395;34053;34093.659063409046;34470;23710.525789484458;23740.406489837893;26413.943442262862;26609;27491
06:19:55 INFO - PROCESS | 4522 | |2;jquery.html;352.1864493021121;356.6255431796611;357.14642005606606;357.18739866803026;359.58288385472855;15471.92264038681;16293.429729959455;17190.22643981021;17565.297388104493;17731.822681773177;10483.161347092233;10846.783064338728;15779.526614201592;15940.760888586681;16026.679466410666;4733.550312720295;4863.902721945559;4869.780859861297;4872.853814385574;4875.268709693539;4859.635527335447;5321.095413779647;5325.3875804282425;5329.706866122362;5335.413104558495;3746.7189960752917;3789.962100379002;3856.5757766645647;5303.098473259555;5305.389880163772;5169.172932330828;5352.197170424429;5377.489138531833;5379.193121031837;5388.568914486851;4977.552020318152;5154.768035438415;5157.819476318348;5163.922541161885;5167.6641018333685;10374;10706.41114738689;12101.334426606532;17084.40204592846;17862.732059019127;1851.685213513706;1940.922363105488;1943.4461178564184;1987.831034362081;2074.730285062932;9770.658026969022;9916.851247231298;10523.52644131016;10636.574537018587;12966.416511257015;1653.4295667994522;1678.5887457572974;1694.5255328508038;1765.143905205974;1833.1384249402759;54571.727141364434;55316.44683553153;56860.431395685926;56873.43126568764;57675.13487297694;9693.22454203662;10069.244806639532;10119.443430611387;10179.134773544332;10242.897571024194;13352.866471335357;13532.25572593497;13533.323333833268;13556.186628802106;13565.728685426237;6915.066466027122;7025.156981162191;7073.92926070743;7184.317489838457;7265.564066156047;6505.837354066186;6656.866862662817;6770.086038384854;6826.488013398915;6827.6244806536115;4431.689781715249;4468.50846406895;4483.14820184164;4516.638668906479;4544.795629158276;1783.144090836406;1792.7400526923784;1793.175139435848;1806.2323512507132;1827.8263564961308;723.8190452386904;752.834376437183;795.8766391209372;859.7764581208805;900.8108297257518;13936.58190254294;14533.491327803687;14879.256037198096;14879.92560037193;15049.172295523633;792.6551949901811;804.5896592737629;823.1932705948204;886.0209468537303;925.5372313843078;7532.472726909064;8360.122187170382;8442.746717598482;9074.137956894085;9248.445093294424;475837;476318;494053;504001;512323;70043.64978175076;70447.64776176086;72603.63698181581;72766;73025.26974730291;997.7278969314037;1018.2922868606396;1026.1124127629546;1031.8761748590066;1034.6792494326633;13930.79103813464;14649.560513184622;14669.853301466848;15086.698266034398;15870.60323491922;32790.04889559856;33605.83197083999;34443.483347750305;34503.65496345004;36659.26681466409;40434.39348409717;44631;45227.32159017552;45754.77122614365;46506.53493465022;9475.24198064167;9804.509774511103;10069.19446444268;10200.132988696045;10470.790584188426;7442.888356674546;11315.20793544444;11657.18399712012;11841.703957401134;12060.155789094679;7033.542819716702;7306.817329566803;7320.9267907320245;7431;7444.143923448873;7576.469647124648;7777.961110194413;7947.245011723877;7965.641546130554;8052.235037671412;7552.093748750185;7592.696292148252;7595.506292090997;7624.428167887541;7794.337481314152;7274.599897005503;9904.207663386767;10130.8480372793;10187.439690817077;10556;9278.211352034883;9322.300827437834;9507.191888689538;9771.804563908825;9845.901540984498
06:19:55 INFO - PROCESS | 4522 | |3;mootools.html;1221.4442428694945;1387.9375428105736;1425.3229715884952;1513.3719506404843;1681.5207665815244;6755.6622168891545;7339.522931009487;7473.850522989537;7473.887891681629;7486.176520582739;7259;7418;7440.851182976337;7441.479096463249;7464.514806537585;1965.4889728670505;2019.121682068305;2201.306588424649;2202.8127609153203;2241.450844543081;2229.4203507088114;2230.230570453191;2234.486068204314;2235.3182279404773;2237.3064350051536;2105.6630939049755;2156.7411910570754;2157.985746699049;2158.881261530615;2161.708169397135;2195.835312351564;2229.788170123844;2234.296196698051;2237;2246.6068438023444;2118.0998075817715;2135;2136.647453170225;2138.4119367173994;2147.216266062876;7624.771256862303;7678.961605191994;7681.57751323677;7699.923000769976;7701.730439434649;4497.055618320157;4613.423322084739;4639.744814035227;4642.65180111493;4645.256758918556;2922.9269268268463;2977.7766667500023;2981.552767084933;3027.031349968011;3058.250728571514;903.602414937432;914.7987442762582;921.4839689773681;934.2432629570002;939.8214339275584;10466.372017678888;10513.737156571071;10518.158547316272;10526.526306316158;10537.894621053769;4027.2952233359047;4075.7146999709735;4112.115895082572;4118.299889018874;4118.9588104118575;8928.375013748975;8946.731598051938;8955.596998135099;8971.05803890595;8974.685885993958;4505.211587972158;4516.345129956138;4516.570925762047;4518.2319005769095;4523.570260825217;4114.938275925803;4126.030382860025;4135.875923722293;4138.8551400701435;4146.5024197096545;3343.297907439465;3396.575428071491;3532.4171511700797;3580.0870777951977;3595.083253770324;1116.9776604467866;1144.9752471537927;1145.9255148415327;1153.9844936455866;1155.4800339847102;1224.2960297828783;1225.6261840138666;1243.254047571468;1257.9747505782757;1264;6976.895346569806;7041.4718896082995;7066;7066.576005439587;7077.964610176916;1017.9287449878585;1018.4805749068029;1021.3106153346462;1030.05749738988;1044.550843137443;5387.057264978613;5453.863653408696;5494.972525137348;5503.147012213113;5508.394076651645;9061.41100828444;9080.545972701339;9292.256619470427;9360.719178424659;9377.249820014382;9230.953845230732;9258;9282.071792820663;9302.488363140092;9313.208377288007;6629.7348106075215;6941.930580694229;7086.00795888576;7189.317014883578;7257.963710181415;6808.829779255559;6862;6874.587524748531;6884.173899132136;6895.5173137879865;7871.724489642835;8136.308413784895;8182.509049457051;8293.129221431664;8306.750797476085;8306.961629796275;8528.616212270339;8558.957205213934;8600;8720.127987201482;6660.367265109807;6689;6703.463722902058;6704;6835.58986460814;6592.505562082959;6712.093867327848;7052.083229180379;7237.203907570058;7238.8914166286495;6453.1610890583925;6484.221893372637;6553.901691474536;6618.867622647424;6662.666866656745;6297.370262973849;6363.840903977252;6380.968095159495;6508.511861610304;6518.5111116667385;6291.119243306032;6328.272248691275;6328.746850126127;6351.714172862325;6353.650549219652;5963.254593175853;5969.224000879858;5983.192269043623;5984;5995.430434108753;5908.3500814911185;6158.353372895782;6183.412575805291;6186.907196391968;6197.845053873689
06:19:55 INFO - PROCESS | 4522 | |4;prototype.html;319.3023244211398;326.54610091972154;333.6746671994804;337.822643112366;340.5164666174031;5768.307803063633;5771.711414429283;5839.591228613998;5849.7367618457165;5853.5902486825935;5480.369757477892;5566.081596536576;5574.052411090114;5708.372079071299;5757.856053598662;4483.0809684014785;4483.910321793563;4501.954980450187;4509.075639493913;4520.412346394981;4303.505096913848;4504.436945381827;4505.166544189319;4512.458504979407;4518.751468669222;4319.33050377192;4364.847230346939;4387.23223435899;4405.625521830648;4406.4271644686305;4372.409724687174;4411.205982923073;4431.335299705038;4435.201663700533;4442.000549876284;3907.941380879289;3929.6266854649048;3930.3318435865685;3944.5069366329208;3949.1509325494867;5379.447599150487;5444.455554444564;5447.400785913546;5450.264214331094;5459.099248623972;5148.3564554430695;5154.896902061975;5184.326037615124;5196.92204616931;5204.323437953042;6042.305134909498;6048.758049678007;6052.546059045545;6052.878942421171;6054.455099041107;4399.6480281577715;4400.427944367212;4402.955970440286;4408.625266852321;4410.691251612388;6168.136460895478;6361.936380636181;6370.840728981766;6376.330485299023;6417.871642567169;4250.171216612731;4251.851185208503;4256.063665993476;4257.106007738348;4257.3613957905945;4286.7856607169515;4294.227039132924;4301.78491075445;4302.3546468030045;4304.78476076195;5033.496650335011;5036.697798132123;5047.318611987334;5047.4447810740785;5057.393112826411;6056.06131049688;6075.179850720185;6158.846028849314;6165.10605962133;6169.198004259418;1536.8770498360104;1572.2531797396373;1572.4182052640597;1575.7715131305897;1576.204016971422;1011.7318910488726;1051.8422236664408;1054.583439541377;1068.5992752717732;1071.121680222226;5817.243758311477;5818.2436283282905;5820.738066787005;5820.88358232833;5844.620099693507;6277.309495955441;6280.9685951569945;6284.560080794392;6297.716602752887;6301.6219026858535;5596.636218645775;5689.687067211343;5703.486686198262;5713.628614140068;5719.5138413235345;3374.915627109342;3429.4684323929832;3432.1762776933356;3432.4164891968426;3437.2438063625964;6678.666066696645;6699.732010719614;6700.765473208415;6712.966435167793;6714.060031595581;6378.585391949508;6556.18047744032;6575.934240657532;6581.2102547694585;6595.868082638416;6712.765053223114;6763.357481039294;6800;6803.897941530881;6820.31796820314;6381.3937675920715;6383.36166383358;6389.424951754364;6392.456641185366;6400.9039864403;6242.875142497034;6312.368763123651;6355.650439225702;6356.110144579855;6373.426391624776;6686.9331306688255;6693.933060669331;6718.428933540704;6725.562838415487;6729.0915726376315;4290.871273861789;4329.740215587075;4330.133973205308;4330.545292744342;4340;6253.155823963889;6404;6406.295307516262;6413.518986076157;6424.582402143846;6149.815505534841;6195.1636529068;6207.16203312547;6234.937650623617;6254.343293954069;6183.938160618336;6223.159873417212;6228.813135605939;6232.688365581794;6255.468285195628;5935.258092738408;6090.482309003784;6106.847328816815;6133.325334213322;6145.508359331154;6207.720652570735;6243.094751260951;6273.9372606273355;6276.246850377984;6281.371862813682;6052.818415447544;6098.695065246809;6110.236220472441;6119.84700382494;6125.081237814364
06:19:55 INFO - PROCESS | 4522 | |5;yui.html;622.4833388287722;694.1358009278453;696.8432102776876;706.4842664854659;735.8565079809435;10915.781684366308;11013.779724405516;11246.662600121988;11303.378314192736;11346.60286889959;10940.56237750491;11006.339619622808;11026.44867756613;11048.613298534552;11072.557097716102;635.9919527548841;648.5849056603778;745.2398553475465;749.8612756640039;758.3023618271176;746.2500187311745;749.2170681637701;752.6236881559221;754.1553460124668;755.7052749427728;786.5909726941986;794.3605397654885;795.5624406576388;798.1619299735283;800.5756948817136;655.7868692674876;670.9765158219464;783.7805414483954;794.66226853587;795.6300320351006;583.1602492410957;584.0742423259139;586.2408181405091;586.337438694277;586.5190543754123;11589.478473468629;11631.883681163165;11644.417779111096;11677.007454366389;11688.883111168865;10507.369557826554;11093.837695008891;11206.607768728138;11287.49206285719;11309.377984210865;9126.58930348136;9297.209737172348;9325.580348884248;9352.579133938989;9401.341906066578;3418.9145271368166;3426.0920855973186;3426.9033909149084;3522.84147213376;3552.342816578941;44831.55168448339;45103.774481127715;45263.54736452626;45297;46446.30330545045;8952.552372381355;9064.728058158265;9074.954625226832;9166.633334666538;9343.34596578233;15806.20968951548;16021;16214.837851621569;16220.837791622169;16255.918720406322;6717.9664101680155;6830.146231721035;6832.487563432763;6863.553868998499;6894.482913781487;4058.492688413948;4112.239235741397;4114.629683328515;4130;4155.542890282067;2874.4107457971068;2874.4682233786816;2884.120343295273;2884.480793457156;2890.985545072261;554.215784664695;556.4518948835394;561.1554610311537;567.0388691168512;572.4275724275724;498.36209651645953;510.2703134517601;558.7038869399225;564.2833601326292;572.2560671127518;6920.446364290845;6961.338672826073;7808.375329973588;7849.529028258208;7952.3638108951145;470.1842303603246;535.6625326044567;558.974846131925;560.907450270709;573.1116769008021;3326.3679900818765;3434.8797792077157;3714.7771133732062;3765.755225910307;3814.237152569497;52016.739916300176;53129.734351328;53148;53189.2021619676;55006;48339.75830120827;48403.27395089076;48500.757496212296;48671.513284867404;49423;42230.78884605557;43073.35389969153;43518;43667.12665746667;43717.344239835795;6827.93172068273;7090.361867431956;7226.277372262732;7380.151282602569;7404.96297518509;33542.32915341728;34042.82978585091;34108.82945585256;34683;34705;37873.62126378701;40284.59715402809;42351.1529769409;42591.57408426;42657;9370.67202647904;9416.387934784218;9628.71113866585;9673.322867399214;9810.558524866541;9827;10024.198064154703;10026.298159128792;10053.949730251303;10239.590416383262;9362.95318523403;9408.623655053994;9541.522923853918;9600.135987761136;9974.850377244493;9777.41335519871;9964.302498825013;10319.380837149494;10324.896751032393;10438.947805260925;8854.911450885409;8863.290936725176;8929.151730585583;8931.866022009544;9159.633614655339;7763.573003484863;7904.20957904205;7920.5247685139075;7973.641186146753;8386.790330241793;7961.840763184588;7986.640601172845;8007.359411247203;8041.793730940406;8480.10958849312
06:19:55 INFO - PROCESS | 4522 | __end_tp_report
06:19:55 INFO - PROCESS | 4522 | __start_cc_report
06:19:55 INFO - PROCESS | 4522 | _x_x_mozilla_cycle_collect,998
06:19:55 INFO - PROCESS | 4522 | __end_cc_report
06:19:55 INFO - PROCESS | 4522 | __startTimestamp1453990795350__endTimestamp
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | ------- Summary: start -------
06:19:55 INFO - PROCESS | 4522 | Number of tests: 6
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#0] dojo.html Cycles:165 Average:4968.47 Median:5185.04 stddev:520.67 (10.0%) stddev-sans-first:499.72
06:19:55 INFO - PROCESS | 4522 | Values: 3036.3 3078.8 3124.3 3124.4 3147.4 4876.3 4909.3 4988.9 5008.9 5046.3 4905.0 4959.5 4993.2 5006.7 5019.9 4548.9 4550.1 4589.7 4622.0 4632.0 4616.9 4653.0 4684.3 4688.1 4693.1 4439.9 4609.5 4617.7 4690.7 4700.2 4511.1 4564.7 4568.2 4575.7 4613.7 4579.4 4580.1 4587.9 4590.9 4620.7 4856.8 4861.9 4864.5 4873.6 4943.4 5266.7 5275.6 5296.5 5309.7 5345.3 5320.8 5339.7 5342.8 5350.3 5351.7 4916.3 4924.5 4985.9 5025.4 5054.6 5433.1 5442.0 5465.7 5470.2 5520.6 5266.2 5271.3 5274.3 5282.7 5283.2 5267.8 5317.1 5332.4 5337.7 5452.6 5186.9 5192.1 5197.4 5199.9 5222.5 5210.8 5221.2 5224.0 5233.0 5277.3 4085.2 4143.5 4165.3 4170.6 4232.8 3718.3 3734.3 3737.0 3759.8 3768.3 4904.8 4905.6 4935.4 4936.8 4986.8 5124.0 5189.2 5289.2 5341.0 5390.7 4956.8 4958.9 4981.6 5003.2 5050.7 4484.6 4554.7 4591.5 4598.3 4628.4 5485.2 5562.3 5578.8 5608.7 5660.9 5333.4 5350.3 5356.4 5357.5 5360.3 5396.9 5457.3 5553.4 5581.3 5636.3 5241.5 5248.0 5274.3 5277.2 5318.3 5335.2 5364.9 5374.8 5387.4 5413.6 5088.0 5130.2 5152.8 5251.9 5252.5 5283.8 5288.9 5299.6 5304.7 5314.9 5165.5 5199.8 5211.2 5211.5 5254.8 5143.5 5165.0 5185.0 5239.1 5240.8 5218.0 5219.8 5227.1 5232.1 5233.7
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#1] ext.html Cycles:180 Average:41390.49 Median:38379.44 stddev:63230.38 (164.8%) stddev-sans-first:63333.27
06:19:55 INFO - PROCESS | 4522 | Values: 515.6 522.5 536.8 554.5 558.4 26733.9 28107.7 35264.5 35913.3 36002.3 38265.0 38493.9 38747.8 38898.4 38922.4 8391.1 8566.1 8583.8 8588.0 8590.8 8247.2 8328.1 8391.7 8403.9 8415.5 8634.8 8705.9 8717.2 8717.7 8727.5 8620.3 8657.5 8671.1 8677.2 8680.2 8435.7 8451.1 8456.1 8472.9 8560.1 38645.4 38940.6 39003.4 39086.6 39185.6 2840.3 2877.2 2911.4 3143.9 3272.5 28597.9 28984.7 29459.7 29515.3 29627.7 3855.2 3867.9 3899.8 3930.0 4035.0 255140.0 259501.0 260070.7 260256.0 260462.0 50154.5 50961.5 54488.4 54826.5 56773.4 51639.7 51847.0 51867.7 51918.2 52125.0 13647.9 13809.4 13810.3 13856.2 13917.4 9889.5 10098.3 10413.8 10678.3 10826.3 17886.2 18033.3 18095.4 18119.0 18119.5 6849.3 7110.1 7153.9 7185.2 7193.9 796.3 820.4 824.6 893.6 1010.6 23959.9 26443.5 26533.7 26662.2 26828.0 873.4 877.4 883.8 898.2 1035.7 12643.9 12708.3 12750.6 12883.7 13035.1 240549.0 245293.0 247649.0 248083.0 248390.0 46037.0 46265.5 46476.5 46549.3 51199.7 1217.5 1220.7 1249.2 1250.5 1255.9 23205.0 24216.6 28436.3 28483.0 28790.7 50824.7 51201.0 51448.0 51586.7 51720.0 173899.0 176987.0 188735.0 273177.0 275447.0 42491.0 42554.9 42805.6 43055.4 43673.3 44668.3 44815.3 45195.5 45491.3 46188.3 37221.6 37394.8 37684.2 38098.6 39304.8 31745.4 36309.6 37137.0 37350.3 37351.3 34069.5 34446.7 34681.1 34839.5 35057.3 32136.7 33600.3 34053.0 34093.7 34470.0 23710.5 23740.4 26413.9 26609.0 27491.0
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#2] jquery.html Cycles:180 Average:25852.32 Median:476077.50 stddev:80610.04 (16.9%) stddev-sans-first:80813.43
06:19:55 INFO - PROCESS | 4522 | Values: 352.2 356.6 357.1 357.2 359.6 15471.9 16293.4 17190.2 17565.3 17731.8 10483.2 10846.8 15779.5 15940.8 16026.7 4733.6 4863.9 4869.8 4872.9 4875.3 4859.6 5321.1 5325.4 5329.7 5335.4 3746.7 3790.0 3856.6 5303.1 5305.4 5169.2 5352.2 5377.5 5379.2 5388.6 4977.6 5154.8 5157.8 5163.9 5167.7 10374.0 10706.4 12101.3 17084.4 17862.7 1851.7 1940.9 1943.4 1987.8 2074.7 9770.7 9916.9 10523.5 10636.6 12966.4 1653.4 1678.6 1694.5 1765.1 1833.1 54571.7 55316.4 56860.4 56873.4 57675.1 9693.2 10069.2 10119.4 10179.1 10242.9 13352.9 13532.3 13533.3 13556.2 13565.7 6915.1 7025.2 7073.9 7184.3 7265.6 6505.8 6656.9 6770.1 6826.5 6827.6 4431.7 4468.5 4483.1 4516.6 4544.8 1783.1 1792.7 1793.2 1806.2 1827.8 723.8 752.8 795.9 859.8 900.8 13936.6 14533.5 14879.3 14879.9 15049.2 792.7 804.6 823.2 886.0 925.5 7532.5 8360.1 8442.7 9074.1 9248.4 475837.0 476318.0 494053.0 504001.0 512323.0 70043.6 70447.6 72603.6 72766.0 73025.3 997.7 1018.3 1026.1 1031.9 1034.7 13930.8 14649.6 14669.9 15086.7 15870.6 32790.0 33605.8 34443.5 34503.7 36659.3 40434.4 44631.0 45227.3 45754.8 46506.5 9475.2 9804.5 10069.2 10200.1 10470.8 7442.9 11315.2 11657.2 11841.7 12060.2 7033.5 7306.8 7320.9 7431.0 7444.1 7576.5 7778.0 7947.2 7965.6 8052.2 7552.1 7592.7 7595.5 7624.4 7794.3 7274.6 9904.2 10130.8 10187.4 10556.0 9278.2 9322.3 9507.2 9771.8 9845.9
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#3] mootools.html Cycles:180 Average:5251.18 Median:6076.89 stddev:2749.23 (45.2%) stddev-sans-first:2740.25
06:19:55 INFO - PROCESS | 4522 | Values: 1221.4 1387.9 1425.3 1513.4 1681.5 6755.7 7339.5 7473.9 7473.9 7486.2 7259.0 7418.0 7440.9 7441.5 7464.5 1965.5 2019.1 2201.3 2202.8 2241.5 2229.4 2230.2 2234.5 2235.3 2237.3 2105.7 2156.7 2158.0 2158.9 2161.7 2195.8 2229.8 2234.3 2237.0 2246.6 2118.1 2135.0 2136.6 2138.4 2147.2 7624.8 7679.0 7681.6 7699.9 7701.7 4497.1 4613.4 4639.7 4642.7 4645.3 2922.9 2977.8 2981.6 3027.0 3058.3 903.6 914.8 921.5 934.2 939.8 10466.4 10513.7 10518.2 10526.5 10537.9 4027.3 4075.7 4112.1 4118.3 4119.0 8928.4 8946.7 8955.6 8971.1 8974.7 4505.2 4516.3 4516.6 4518.2 4523.6 4114.9 4126.0 4135.9 4138.9 4146.5 3343.3 3396.6 3532.4 3580.1 3595.1 1117.0 1145.0 1145.9 1154.0 1155.5 1224.3 1225.6 1243.3 1258.0 1264.0 6976.9 7041.5 7066.0 7066.6 7078.0 1017.9 1018.5 1021.3 1030.1 1044.6 5387.1 5453.9 5495.0 5503.1 5508.4 9061.4 9080.5 9292.3 9360.7 9377.2 9231.0 9258.0 9282.1 9302.5 9313.2 6629.7 6941.9 7086.0 7189.3 7258.0 6808.8 6862.0 6874.6 6884.2 6895.5 7871.7 8136.3 8182.5 8293.1 8306.8 8307.0 8528.6 8559.0 8600.0 8720.1 6660.4 6689.0 6703.5 6704.0 6835.6 6592.5 6712.1 7052.1 7237.2 7238.9 6453.2 6484.2 6553.9 6618.9 6662.7 6297.4 6363.8 6381.0 6508.5 6518.5 6291.1 6328.3 6328.7 6351.7 6353.7 5963.3 5969.2 5983.2 5984.0 5995.4 5908.4 6158.4 6183.4 6186.9 6197.8
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#4] prototype.html Cycles:180 Average:5151.47 Median:5770.01 stddev:1561.36 (27.1%) stddev-sans-first:1523.03
06:19:55 INFO - PROCESS | 4522 | Values: 319.3 326.5 333.7 337.8 340.5 5768.3 5771.7 5839.6 5849.7 5853.6 5480.4 5566.1 5574.1 5708.4 5757.9 4483.1 4483.9 4502.0 4509.1 4520.4 4303.5 4504.4 4505.2 4512.5 4518.8 4319.3 4364.8 4387.2 4405.6 4406.4 4372.4 4411.2 4431.3 4435.2 4442.0 3907.9 3929.6 3930.3 3944.5 3949.2 5379.4 5444.5 5447.4 5450.3 5459.1 5148.4 5154.9 5184.3 5196.9 5204.3 6042.3 6048.8 6052.5 6052.9 6054.5 4399.6 4400.4 4403.0 4408.6 4410.7 6168.1 6361.9 6370.8 6376.3 6417.9 4250.2 4251.9 4256.1 4257.1 4257.4 4286.8 4294.2 4301.8 4302.4 4304.8 5033.5 5036.7 5047.3 5047.4 5057.4 6056.1 6075.2 6158.8 6165.1 6169.2 1536.9 1572.3 1572.4 1575.8 1576.2 1011.7 1051.8 1054.6 1068.6 1071.1 5817.2 5818.2 5820.7 5820.9 5844.6 6277.3 6281.0 6284.6 6297.7 6301.6 5596.6 5689.7 5703.5 5713.6 5719.5 3374.9 3429.5 3432.2 3432.4 3437.2 6678.7 6699.7 6700.8 6713.0 6714.1 6378.6 6556.2 6575.9 6581.2 6595.9 6712.8 6763.4 6800.0 6803.9 6820.3 6381.4 6383.4 6389.4 6392.5 6400.9 6242.9 6312.4 6355.7 6356.1 6373.4 6686.9 6693.9 6718.4 6725.6 6729.1 4290.9 4329.7 4330.1 4330.5 4340.0 6253.2 6404.0 6406.3 6413.5 6424.6 6149.8 6195.2 6207.2 6234.9 6254.3 6183.9 6223.2 6228.8 6232.7 6255.5 5935.3 6090.5 6106.8 6133.3 6145.5 6207.7 6243.1 6273.9 6276.2 6281.4 6052.8 6098.7 6110.2 6119.8 6125.1
06:19:55 INFO - PROCESS | 4522 |
06:19:55 INFO - PROCESS | 4522 | [#5] yui.html Cycles:180 Average:12535.88 Median:561.03 stddev:15033.77 (2679.7%) stddev-sans-first:15049.33
06:19:55 INFO - PROCESS | 4522 | Values: 622.5 694.1 696.8 706.5 735.9 10915.8 11013.8 11246.7 11303.4 11346.6 10940.6 11006.3 11026.4 11048.6 11072.6 636.0 648.6 745.2 749.9 758.3 746.3 749.2 752.6 754.2 755.7 786.6 794.4 795.6 798.2 800.6 655.8 671.0 783.8 794.7 795.6 583.2 584.1 586.2 586.3 586.5 11589.5 11631.9 11644.4 11677.0 11688.9 10507.4 11093.8 11206.6 11287.5 11309.4 9126.6 9297.2 9325.6 9352.6 9401.3 3418.9 3426.1 3426.9 3522.8 3552.3 44831.6 45103.8 45263.5 45297.0 46446.3 8952.6 9064.7 9075.0 9166.6 9343.3 15806.2 16021.0 16214.8 16220.8 16255.9 6718.0 6830.1 6832.5 6863.6 6894.5 4058.5 4112.2 4114.6 4130.0 4155.5 2874.4 2874.5 2884.1 2884.5 2891.0 554.2 556.5 561.2 567.0 572.4 498.4 510.3 558.7 564.3 572.3 6920.4 6961.3 7808.4 7849.5 7952.4 470.2 535.7 559.0 560.9 573.1 3326.4 3434.9 3714.8 3765.8 3814.2 52016.7 53129.7 53148.0 53189.2 55006.0 48339.8 48403.3 48500.8 48671.5 49423.0 42230.8 43073.4 43518.0 43667.1 43717.3 6827.9 7090.4 7226.3 7380.2 7405.0 33542.3 34042.8 34108.8 34683.0 34705.0 37873.6 40284.6 42351.2 42591.6 42657.0 9370.7 9416.4 9628.7 9673.3 9810.6 9827.0 10024.2 10026.3 10053.9 10239.6 9363.0 9408.6 9541.5 9600.1 9974.9 9777.4 9964.3 10319.4 10324.9 10438.9 8854.9 8863.3 8929.2 8931.9 9159.6 7763.6 7904.2 7920.5 7973.6 8386.8 7961.8 7986.6 8007.4 8041.8 8480.1
06:19:55 INFO - PROCESS | 4522 | -------- Summary: end --------
06:19:55 INFO - PROCESS | 4522 |
06:19:56 INFO - TEST-INFO | 4522: exit 0
06:19:56 INFO - TEST-OK | dromaeo_css | took 1111774ms
06:19:56 INFO - TEST-START | kraken
06:19:56 INFO - operating with platform_type : linux_
06:19:56 INFO - Initialising browser for kraken test...
06:19:56 INFO - TEST-INFO | started process 4721 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVzqgcE/profile http://localhost:43044/getInfo.html)
06:19:59 INFO - PROCESS | 4721 | __metrics Screen width/height:1600/1200
06:19:59 INFO - PROCESS | 4721 | colorDepth:24
06:19:59 INFO - PROCESS | 4721 | Browser inner width/height: 1024/697
06:19:59 INFO - PROCESS | 4721 | __metrics
06:20:00 INFO - PROCESS | 4721 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
06:20:00 INFO - PROCESS | 4721 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
06:20:00 INFO - TEST-INFO | 4721: exit 0
06:20:00 INFO - Browser initialized.
06:20:00 INFO - Running cycle 1/1 for kraken test...
06:20:00 INFO - TEST-INFO | started process 4805 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVzqgcE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
06:20:12 INFO - PROCESS | 4805 | RSS: Main: 149262336
06:20:12 INFO - PROCESS | 4805 |
06:20:15 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43044/tests/kraken/driver.html?testName=audio-beat-detection)
06:20:15 INFO - PROCESS | 4805 | RSS: Main: 188518400
06:20:15 INFO - PROCESS | 4805 |
06:20:18 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43044/tests/kraken/driver.html?testName=audio-dft)
06:20:19 INFO - PROCESS | 4805 | RSS: Main: 178966528
06:20:19 INFO - PROCESS | 4805 |
06:20:21 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43044/tests/kraken/driver.html?testName=audio-fft)
06:20:22 INFO - PROCESS | 4805 | RSS: Main: 162119680
06:20:22 INFO - PROCESS | 4805 |
06:20:24 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43044/tests/kraken/driver.html?testName=audio-oscillator)
06:20:25 INFO - PROCESS | 4805 | RSS: Main: 165777408
06:20:25 INFO - PROCESS | 4805 |
06:20:27 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43044/tests/kraken/driver.html?testName=imaging-gaussian-blur)
06:20:27 INFO - PROCESS | 4805 | RSS: Main: 167550976
06:20:27 INFO - PROCESS | 4805 |
06:20:30 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43044/tests/kraken/driver.html?testName=imaging-darkroom)
06:20:31 INFO - PROCESS | 4805 | RSS: Main: 168747008
06:20:31 INFO - PROCESS | 4805 |
06:20:34 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43044/tests/kraken/driver.html?testName=imaging-desaturate)
06:20:35 INFO - PROCESS | 4805 | RSS: Main: 167784448
06:20:35 INFO - PROCESS | 4805 |
06:20:38 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43044/tests/kraken/driver.html?testName=json-parse-financial)
06:20:38 INFO - PROCESS | 4805 | RSS: Main: 168071168
06:20:38 INFO - PROCESS | 4805 |
06:20:40 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43044/tests/kraken/driver.html?testName=json-stringify-tinderbox)
06:20:41 INFO - PROCESS | 4805 | RSS: Main: 180207616
06:20:41 INFO - PROCESS | 4805 |
06:20:42 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-aes)
06:20:43 INFO - PROCESS | 4805 | RSS: Main: 178311168
06:20:43 INFO - PROCESS | 4805 |
06:20:45 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-ccm)
06:20:46 INFO - PROCESS | 4805 | RSS: Main: 188477440
06:20:46 INFO - PROCESS | 4805 |
06:20:48 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
06:20:49 INFO - PROCESS | 4805 | RSS: Main: 196759552
06:20:49 INFO - PROCESS | 4805 |
06:20:51 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
06:20:52 INFO - PROCESS | 4805 | RSS: Main: 196251648
06:20:52 INFO - PROCESS | 4805 |
06:20:53 INFO - PROCESS | 4805 | Cycle 1(1): loaded http://localhost:43044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43044/tests/kraken/driver.html?testName=ai-astar)
06:20:54 INFO - PROCESS | 4805 | RSS: Main: 257118208
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | __start_tp_report
06:20:54 INFO - PROCESS | 4805 | _x_x_mozilla_page_load
06:20:54 INFO - PROCESS | 4805 | _x_x_mozilla_page_load_details
06:20:54 INFO - PROCESS | 4805 | |i|pagename|runs|
06:20:54 INFO - PROCESS | 4805 | |0;ai-astar;114;113;105;112;113;112;111;112;104;112
06:20:54 INFO - PROCESS | 4805 | |1;audio-beat-detection;151;126;151;170;131;151;157;128;171;125
06:20:54 INFO - PROCESS | 4805 | |2;audio-dft;163;162;161;164;161;162;164;160;161;162
06:20:54 INFO - PROCESS | 4805 | |3;audio-fft;76;73;98;93;73;74;74;125;93;73
06:20:54 INFO - PROCESS | 4805 | |4;audio-oscillator;96;95;142;95;97;96;140;96;96;152
06:20:54 INFO - PROCESS | 4805 | |5;imaging-gaussian-blur;120;115;115;116;115;115;115;116;115;114
06:20:54 INFO - PROCESS | 4805 | |6;imaging-darkroom;146;145;146;145;147;146;148;146;146;145
06:20:54 INFO - PROCESS | 4805 | |7;imaging-desaturate;97;95;96;96;96;98;97;96;97;97
06:20:54 INFO - PROCESS | 4805 | |8;json-parse-financial;58;57;57;57;56;57;57;57;57;54
06:20:54 INFO - PROCESS | 4805 | |9;json-stringify-tinderbox;68;68;68;68;70;68;68;68;68;69
06:20:54 INFO - PROCESS | 4805 | |10;stanford-crypto-aes;83;83;84;83;84;83;86;85;85;84
06:20:54 INFO - PROCESS | 4805 | |11;stanford-crypto-ccm;114;114;117;111;127;123;129;124;114;117
06:20:54 INFO - PROCESS | 4805 | |12;stanford-crypto-pbkdf2;146;138;149;145;148;135;141;161;146;147
06:20:54 INFO - PROCESS | 4805 | |13;stanford-crypto-sha256-iterative;69;69;70;69;70;70;69;68;70;68
06:20:54 INFO - PROCESS | 4805 | __end_tp_report
06:20:54 INFO - PROCESS | 4805 | __start_cc_report
06:20:54 INFO - PROCESS | 4805 | _x_x_mozilla_cycle_collect,982
06:20:54 INFO - PROCESS | 4805 | __end_cc_report
06:20:54 INFO - PROCESS | 4805 | __startTimestamp1453990854191__endTimestamp
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | ------- Summary: start -------
06:20:54 INFO - PROCESS | 4805 | Number of tests: 14
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:3.43
06:20:54 INFO - PROCESS | 4805 | Values: 114.0 113.0 105.0 112.0 113.0 112.0 111.0 112.0 104.0 112.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.00 stddev:17.60 (11.7%) stddev-sans-first:18.57
06:20:54 INFO - PROCESS | 4805 | Values: 151.0 126.0 151.0 170.0 131.0 151.0 157.0 128.0 171.0 125.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.33 (0.8%) stddev-sans-first:1.36
06:20:54 INFO - PROCESS | 4805 | Values: 163.0 162.0 161.0 164.0 161.0 162.0 164.0 160.0 161.0 162.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.00 stddev:17.16 (22.9%) stddev-sans-first:17.88
06:20:54 INFO - PROCESS | 4805 | Values: 76.0 73.0 98.0 93.0 73.0 74.0 74.0 125.0 93.0 73.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.78 (24.8%) stddev-sans-first:24.63
06:20:54 INFO - PROCESS | 4805 | Values: 96.0 95.0 142.0 95.0 97.0 96.0 140.0 96.0 96.0 152.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.00 stddev:1.65 (1.4%) stddev-sans-first:0.60
06:20:54 INFO - PROCESS | 4805 | Values: 120.0 115.0 115.0 116.0 115.0 115.0 115.0 116.0 115.0 114.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.94 (0.6%) stddev-sans-first:1.00
06:20:54 INFO - PROCESS | 4805 | Values: 146.0 145.0 146.0 145.0 147.0 146.0 148.0 146.0 146.0 145.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.85 (0.9%) stddev-sans-first:0.88
06:20:54 INFO - PROCESS | 4805 | Values: 97.0 95.0 96.0 96.0 96.0 98.0 97.0 96.0 97.0 97.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.06 (1.9%) stddev-sans-first:1.01
06:20:54 INFO - PROCESS | 4805 | Values: 58.0 57.0 57.0 57.0 56.0 57.0 57.0 57.0 57.0 54.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71
06:20:54 INFO - PROCESS | 4805 | Values: 68.0 68.0 68.0 68.0 70.0 68.0 68.0 68.0 68.0 69.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.05 (1.3%) stddev-sans-first:1.05
06:20:54 INFO - PROCESS | 4805 | Values: 83.0 83.0 84.0 83.0 84.0 83.0 86.0 85.0 85.0 84.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:120.00 stddev:6.25 (5.2%) stddev-sans-first:6.37
06:20:54 INFO - PROCESS | 4805 | Values: 114.0 114.0 117.0 111.0 127.0 123.0 129.0 124.0 114.0 117.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.60 Median:146.50 stddev:7.06 (4.8%) stddev-sans-first:7.49
06:20:54 INFO - PROCESS | 4805 | Values: 146.0 138.0 149.0 145.0 148.0 135.0 141.0 161.0 146.0 147.0
06:20:54 INFO - PROCESS | 4805 |
06:20:54 INFO - PROCESS | 4805 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:0.79 (1.1%) stddev-sans-first:0.83
06:20:54 INFO - PROCESS | 4805 | Values: 69.0 69.0 70.0 69.0 70.0 70.0 69.0 68.0 70.0 68.0
06:20:54 INFO - PROCESS | 4805 | -------- Summary: end --------
06:20:54 INFO - PROCESS | 4805 |
06:20:55 INFO - TEST-INFO | 4805: exit 0
06:20:55 INFO - TEST-OK | kraken | took 59047ms
06:20:55 INFO - TEST-START | v8_7
06:20:55 INFO - operating with platform_type : linux_
06:20:55 INFO - Initialising browser for v8_7 test...
06:20:55 INFO - TEST-INFO | started process 5053 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYGcKLq/profile http://localhost:43044/getInfo.html)
06:20:58 INFO - PROCESS | 5053 | __metrics Screen width/height:1600/1200
06:20:58 INFO - PROCESS | 5053 | colorDepth:24
06:20:58 INFO - PROCESS | 5053 | Browser inner width/height: 1024/697
06:20:58 INFO - PROCESS | 5053 | __metrics
06:20:58 INFO - PROCESS | 5053 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank]
06:20:58 INFO - PROCESS | 5053 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
06:20:59 INFO - TEST-INFO | 5053: exit 0
06:20:59 INFO - Browser initialized.
06:20:59 INFO - Running cycle 1/1 for v8_7 test...
06:20:59 INFO - TEST-INFO | started process 5134 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYGcKLq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
06:21:11 INFO - PROCESS | 5134 | RSS: Main: 148631552
06:21:11 INFO - PROCESS | 5134 |
06:21:33 INFO - PROCESS | 5134 | Cycle 1(1): loaded http://localhost:43044/tests/v8_7/run.html (next: http://localhost:43044/tests/v8_7/run.html)
06:21:34 INFO - PROCESS | 5134 | RSS: Main: 509288448
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | __start_tp_report
06:21:34 INFO - PROCESS | 5134 | _x_x_mozilla_page_load
06:21:34 INFO - PROCESS | 5134 | _x_x_mozilla_page_load_details
06:21:34 INFO - PROCESS | 5134 | |i|pagename|runs|
06:21:34 INFO - PROCESS | 5134 | |0;Richards;168.23687752355318
06:21:34 INFO - PROCESS | 5134 | |1;DeltaBlue;189.465706707086
06:21:34 INFO - PROCESS | 5134 | |2;Encrypt;273.972602739726
06:21:34 INFO - PROCESS | 5134 | |3;Decrypt;5268.421052631579
06:21:34 INFO - PROCESS | 5134 | |4;RayTrace;2000
06:21:34 INFO - PROCESS | 5134 | |5;Earley;780.0312012480499
06:21:34 INFO - PROCESS | 5134 | |6;Boyer;12207.317073170732
06:21:34 INFO - PROCESS | 5134 | |7;RegExp;41918.36734693877
06:21:34 INFO - PROCESS | 5134 | |8;Splay;568.1818181818181
06:21:34 INFO - PROCESS | 5134 | |9;NavierStokes;4850.241545893719
06:21:34 INFO - PROCESS | 5134 | __end_tp_report
06:21:34 INFO - PROCESS | 5134 | __startTimestamp1453990894076__endTimestamp
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | ------- Summary: start -------
06:21:34 INFO - PROCESS | 5134 | Number of tests: 10
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#0] Richards Cycles:1 Average:168.24 Median:168.24 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 168.2
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#1] DeltaBlue Cycles:1 Average:189.47 Median:189.47 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 189.5
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#2] Encrypt Cycles:1 Average:273.97 Median:273.97 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 274.0
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 5268.4
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 2000.0
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#5] Earley Cycles:1 Average:780.03 Median:780.03 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 780.0
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 12207.3
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#7] RegExp Cycles:1 Average:41918.37 Median:41918.37 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 41918.4
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#8] Splay Cycles:1 Average:568.18 Median:568.18 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 568.2
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - PROCESS | 5134 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%)
06:21:34 INFO - PROCESS | 5134 | Values: 4850.2
06:21:34 INFO - PROCESS | 5134 | -------- Summary: end --------
06:21:34 INFO - PROCESS | 5134 |
06:21:34 INFO - TEST-INFO | 5134: exit 0
06:21:34 INFO - TEST-OK | v8_7 | took 39828ms
06:21:34 INFO - SUITE-END | took 1210s
06:21:35 INFO - Completed test suite (00:20:10)
06:21:35 INFO - Working with test: dromaeo_css
06:21:35 INFO - Generating results file: dromaeo_css
06:21:35 INFO - Working with test: kraken
06:21:35 INFO - Generating results file: kraken
06:21:35 INFO - javascript benchmark
06:21:35 INFO - Working with test: v8_7
06:21:35 INFO - Generating results file: v8_7
06:21:35 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
06:21:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]]
06:21:35 INFO - process_Request line: dromaeo_css 6497.78 graph.html#tests=[[72,1,35]]
06:21:35 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
06:21:35 INFO - process_Request line: kraken 1515.50 graph.html#tests=[[232,1,35]]
06:21:35 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0
06:21:35 INFO - process_Request line: v8_7 19033.09 graph.html#tests=[[230,1,35]]
06:21:35 INFO - RETURN: dromaeo_css: 6497.78
06:21:35 INFO - RETURN: kraken: 1515.50
06:21:35 INFO - RETURN: v8_7: 19033.09
06:21:35 INFO - javascript benchmark
06:21:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3036.316828713539, 3078.769092318074, 3124.312651216733, 3124.437601231779, 3147.3705258948216, 4876.2929375240565, 4909.263610458433, 4988.850334489966, 5008.899822003557, 5046.293518907356, 4904.975475122628, 4959.479254678261, 4993.176125939225, 5006.699598024121, 5019.899602007958, 4548.8862778430475, 4550.067236216568, 4589.655775816827, 4622.0293738314995, 4632.0, 4616.8614941551805, 4653.0, 4684.344191813149, 4688.109259240733, 4693.131770622445, 4439.911201775946, 4609.469910960249, 4617.676762626617, 4690.718556886581, 4700.1539722849875, 4511.120331535352, 4564.7032942858605, 4568.223402021665, 4575.702579332366, 4613.746243956581, 4579.381783459224, 4580.129775342674, 4587.885302867422, 4590.908181836345, 4620.653450991189, 4856.781444834991, 4861.927071093936, 4864.464908860023, 4873.634477414173, 4943.431505376891, 5266.683998960037, 5275.60432967529, 5296.523312901819, 5309.681419114865, 5345.278387417727, 5320.787168513255, 5339.65292256006, 5342.786288548454, 5350.3312085989255, 5351.732413379315, 4916.287138364917, 4924.482929292444, 4985.925211121836, 5025.447200807908, 5054.570361519275, 5433.0763770159165, 5441.972790136024, 5465.726713664301, 5470.206820011076, 5520.585956053312, 5266.236395722599, 5271.314729085195, 5274.340707411574, 5282.709450980233, 5283.233931079972, 5267.78928842842, 5317.1226747586215, 5332.386775520865, 5337.706426146599, 5452.618316717871, 5186.92219616706, 5192.1173400522, 5197.376314842168, 5199.948000520022, 5222.477752224823, 5210.76551555181, 5221.164613661796, 5224.007438586732, 5232.9738351308, 5277.261183434322, 4085.22380747657, 4143.523494798137, 4165.271077561415, 4170.562090980464, 4232.830686772556, 3718.3121122592406, 3734.3091528067393, 3736.9626303736613, 3759.774413535197, 3768.3028639701197, 4904.754762261872, 4905.607551395879, 4935.358403407534, 4936.75316234194, 4986.800527978913, 5124.0, 5189.221616757441, 5289.18017707256, 5341.0, 5390.730463476811, 4956.826511072168, 4958.8760280993265, 4981.62637802159, 5003.224500202475, 5050.747462626928, 4484.573965473275, 4554.726716396961, 4591.540845915449, 4598.26427771555, 4628.4445866496235, 5485.232067510552, 5562.332520097614, 5578.800557880075, 5608.719564021864, 5660.886782264414, 5333.386660534088, 5350.304460420276, 5356.437574054824, 5357.491038351351, 5360.276362691143, 5396.9190462142315, 5457.290552228185, 5553.445794691482, 5581.274434323512, 5636.267285252891, 5241.528262456397, 5247.9766445542755, 5274.261603375454, 5277.155655095166, 5318.335208098988, 5335.199720042025, 5364.865878353073, 5374.811881584125, 5387.353517577916, 5413.56691464674, 5088.007838471611, 5130.179171332569, 5152.793888244429, 5251.947480525146, 5252.474752524717, 5283.841484755463, 5288.947110528846, 5299.6290259681455, 5304.708241046779, 5314.946850531445, 5165.509276618715, 5199.766010529611, 5211.1922651989, 5211.5049070338255, 5254.7898084076205, 5143.459936706741, 5165.020044032055, 5185.040767458032, 5239.109351410193, 5240.764165612481, 5218.034663587248, 5219.8434046978655, 5227.085260079547, 5232.11054120808, 5233.712145832016], "unit": "score", "name": "dojo.html", "value": 4936.993511960628}, {"lowerIsBetter": false, "replicates": [515.5772266741271, 522.4592546714151, 536.8469986053974, 554.5425024354909, 558.4025093150328, 26733.866330668345, 28107.718922810767, 35264.471032934496, 35913.2817343653, 36002.279954400896, 38265.0, 38493.88283644398, 38747.80626096865, 38898.416523752094, 38922.416163757494, 8391.076981532042, 8566.057733649293, 8583.785405364884, 8588.0, 8590.828183436328, 8247.175282471764, 8328.125546817588, 8391.664333426656, 8403.915960840375, 8415.537145456998, 8634.78413039676, 8705.869411958794, 8717.215450609443, 8717.694880679177, 8727.476351418934, 8620.267277281439, 8657.523836189008, 8671.089535598734, 8677.1756683115, 8680.218780309739, 8435.662573497053, 8451.070382257947, 8456.06983231844, 8472.872906906401, 8560.143985601453, 38645.42031869524, 38940.610593894264, 39003.41494877579, 39086.60913390858, 39185.60814391877, 2840.318323602341, 2877.1656219696265, 2911.446825103245, 3143.874245030196, 3272.525483804835, 28597.857010715023, 28984.710152898413, 29459.70540294591, 29515.262118447212, 29627.70372296271, 3855.2096820152083, 3867.941980870289, 3899.78551179685, 3930.0, 4034.9798251008556, 255140.0, 259501.0, 260070.69964650244, 260256.0, 260462.0, 50154.49845501571, 50961.490385095676, 54488.37162797211, 54826.45173548293, 56773.43226567681, 51639.74180129075, 51847.0, 51867.740661297204, 51918.22122668163, 52125.0, 13647.931760341135, 13809.378577964017, 13810.309484525733, 13856.168629882239, 13917.373718182705, 9889.456079915673, 10098.293119481712, 10413.843792343121, 10678.305910115818, 10826.296290741077, 17886.195121219578, 18033.278668853098, 18095.36666216676, 18119.0, 18119.547011324823, 6849.280825513349, 7110.146782386147, 7153.928460715326, 7185.245549217361, 7193.856122877618, 796.2555011064674, 820.3806126374668, 824.6083110522574, 893.5800173918248, 1010.5806090472519, 23959.880200598884, 26443.471130577665, 26533.73466265351, 26662.20013399601, 26828.0, 873.4366333714719, 877.4472082588056, 883.7746374674546, 898.1602201941206, 1035.7048241251357, 12643.862052415327, 12708.301043442514, 12750.553730619384, 12883.677908052374, 13035.087543872027, 240549.0, 245293.0, 247649.0, 248083.0, 248390.0, 46037.0, 46265.5373446268, 46476.5352346479, 46549.30176047362, 51199.74400127975, 1217.5008246618843, 1220.725336799213, 1249.1817859301989, 1250.531050855929, 1255.8555766087018, 23205.0, 24216.63675044911, 28436.28909277202, 28483.0, 28790.712092878803, 50824.72938176427, 51201.0, 51448.0, 51586.74206628943, 51720.0, 173899.0, 176987.0, 188735.0, 273177.0, 275447.0, 42491.0, 42554.86870924414, 42805.57194428016, 43055.35416968811, 43673.34489982589, 44668.32997505105, 44815.32777008413, 45195.548044519135, 45491.31763023491, 46188.307175391725, 37221.627783721815, 37394.813025934694, 37684.246315074095, 38098.619013809504, 39304.80347598244, 31745.365092697553, 36309.63690363168, 37137.0, 37350.25299494049, 37351.25297494089, 34069.48895766516, 34446.65553344435, 34681.13297167591, 34839.47740783941, 35057.298854022265, 32136.678633214306, 33600.3279934395, 34053.0, 34093.659063409046, 34470.0, 23710.525789484458, 23740.406489837893, 26413.943442262862, 26609.0, 27491.0], "unit": "score", "name": "ext.html", "value": 17436.341712999194}, {"lowerIsBetter": false, "replicates": [352.1864493021121, 356.6255431796611, 357.14642005606606, 357.18739866803026, 359.58288385472855, 15471.92264038681, 16293.429729959455, 17190.22643981021, 17565.297388104493, 17731.822681773177, 10483.161347092233, 10846.783064338728, 15779.526614201592, 15940.760888586681, 16026.679466410666, 4733.550312720295, 4863.902721945559, 4869.780859861297, 4872.853814385574, 4875.268709693539, 4859.635527335447, 5321.095413779647, 5325.3875804282425, 5329.706866122362, 5335.413104558495, 3746.7189960752917, 3789.962100379002, 3856.5757766645647, 5303.098473259555, 5305.389880163772, 5169.172932330828, 5352.197170424429, 5377.489138531833, 5379.193121031837, 5388.568914486851, 4977.552020318152, 5154.768035438415, 5157.819476318348, 5163.922541161885, 5167.6641018333685, 10374.0, 10706.41114738689, 12101.334426606532, 17084.40204592846, 17862.732059019127, 1851.685213513706, 1940.922363105488, 1943.4461178564184, 1987.831034362081, 2074.730285062932, 9770.658026969022, 9916.851247231298, 10523.52644131016, 10636.574537018587, 12966.416511257015, 1653.4295667994522, 1678.5887457572974, 1694.5255328508038, 1765.143905205974, 1833.1384249402759, 54571.727141364434, 55316.44683553153, 56860.431395685926, 56873.43126568764, 57675.13487297694, 9693.22454203662, 10069.244806639532, 10119.443430611387, 10179.134773544332, 10242.897571024194, 13352.866471335357, 13532.25572593497, 13533.323333833268, 13556.186628802106, 13565.728685426237, 6915.066466027122, 7025.156981162191, 7073.92926070743, 7184.317489838457, 7265.564066156047, 6505.837354066186, 6656.866862662817, 6770.086038384854, 6826.488013398915, 6827.6244806536115, 4431.689781715249, 4468.50846406895, 4483.14820184164, 4516.638668906479, 4544.795629158276, 1783.144090836406, 1792.7400526923784, 1793.175139435848, 1806.2323512507132, 1827.8263564961308, 723.8190452386904, 752.834376437183, 795.8766391209372, 859.7764581208805, 900.8108297257518, 13936.58190254294, 14533.491327803687, 14879.256037198096, 14879.92560037193, 15049.172295523633, 792.6551949901811, 804.5896592737629, 823.1932705948204, 886.0209468537303, 925.5372313843078, 7532.472726909064, 8360.122187170382, 8442.746717598482, 9074.137956894085, 9248.445093294424, 475837.0, 476318.0, 494053.0, 504001.0, 512323.0, 70043.64978175076, 70447.64776176086, 72603.63698181581, 72766.0, 73025.26974730291, 997.7278969314037, 1018.2922868606396, 1026.1124127629546, 1031.8761748590066, 1034.6792494326633, 13930.79103813464, 14649.560513184622, 14669.853301466848, 15086.698266034398, 15870.60323491922, 32790.04889559856, 33605.83197083999, 34443.483347750305, 34503.65496345004, 36659.26681466409, 40434.39348409717, 44631.0, 45227.32159017552, 45754.77122614365, 46506.53493465022, 9475.24198064167, 9804.509774511103, 10069.19446444268, 10200.132988696045, 10470.790584188426, 7442.888356674546, 11315.20793544444, 11657.18399712012, 11841.703957401134, 12060.155789094679, 7033.542819716702, 7306.817329566803, 7320.9267907320245, 7431.0, 7444.143923448873, 7576.469647124648, 7777.961110194413, 7947.245011723877, 7965.641546130554, 8052.235037671412, 7552.093748750185, 7592.696292148252, 7595.506292090997, 7624.428167887541, 7794.337481314152, 7274.599897005503, 9904.207663386767, 10130.8480372793, 10187.439690817077, 10556.0, 9278.211352034883, 9322.300827437834, 9507.191888689538, 9771.804563908825, 9845.901540984498], "unit": "score", "name": "jquery.html", "value": 7770.633686990821}, {"lowerIsBetter": false, "replicates": [1221.4442428694945, 1387.9375428105736, 1425.3229715884952, 1513.3719506404843, 1681.5207665815244, 6755.6622168891545, 7339.522931009487, 7473.850522989537, 7473.887891681629, 7486.176520582739, 7259.0, 7418.0, 7440.851182976337, 7441.479096463249, 7464.514806537585, 1965.4889728670505, 2019.121682068305, 2201.306588424649, 2202.8127609153203, 2241.450844543081, 2229.4203507088114, 2230.230570453191, 2234.486068204314, 2235.3182279404773, 2237.3064350051536, 2105.6630939049755, 2156.7411910570754, 2157.985746699049, 2158.881261530615, 2161.708169397135, 2195.835312351564, 2229.788170123844, 2234.296196698051, 2237.0, 2246.6068438023444, 2118.0998075817715, 2135.0, 2136.647453170225, 2138.4119367173994, 2147.216266062876, 7624.771256862303, 7678.961605191994, 7681.57751323677, 7699.923000769976, 7701.730439434649, 4497.055618320157, 4613.423322084739, 4639.744814035227, 4642.65180111493, 4645.256758918556, 2922.9269268268463, 2977.7766667500023, 2981.552767084933, 3027.031349968011, 3058.250728571514, 903.602414937432, 914.7987442762582, 921.4839689773681, 934.2432629570002, 939.8214339275584, 10466.372017678888, 10513.737156571071, 10518.158547316272, 10526.526306316158, 10537.894621053769, 4027.2952233359047, 4075.7146999709735, 4112.115895082572, 4118.299889018874, 4118.9588104118575, 8928.375013748975, 8946.731598051938, 8955.596998135099, 8971.05803890595, 8974.685885993958, 4505.211587972158, 4516.345129956138, 4516.570925762047, 4518.2319005769095, 4523.570260825217, 4114.938275925803, 4126.030382860025, 4135.875923722293, 4138.8551400701435, 4146.5024197096545, 3343.297907439465, 3396.575428071491, 3532.4171511700797, 3580.0870777951977, 3595.083253770324, 1116.9776604467866, 1144.9752471537927, 1145.9255148415327, 1153.9844936455866, 1155.4800339847102, 1224.2960297828783, 1225.6261840138666, 1243.254047571468, 1257.9747505782757, 1264.0, 6976.895346569806, 7041.4718896082995, 7066.0, 7066.576005439587, 7077.964610176916, 1017.9287449878585, 1018.4805749068029, 1021.3106153346462, 1030.05749738988, 1044.550843137443, 5387.057264978613, 5453.863653408696, 5494.972525137348, 5503.147012213113, 5508.394076651645, 9061.41100828444, 9080.545972701339, 9292.256619470427, 9360.719178424659, 9377.249820014382, 9230.953845230732, 9258.0, 9282.071792820663, 9302.488363140092, 9313.208377288007, 6629.7348106075215, 6941.930580694229, 7086.00795888576, 7189.317014883578, 7257.963710181415, 6808.829779255559, 6862.0, 6874.587524748531, 6884.173899132136, 6895.5173137879865, 7871.724489642835, 8136.308413784895, 8182.509049457051, 8293.129221431664, 8306.750797476085, 8306.961629796275, 8528.616212270339, 8558.957205213934, 8600.0, 8720.127987201482, 6660.367265109807, 6689.0, 6703.463722902058, 6704.0, 6835.58986460814, 6592.505562082959, 6712.093867327848, 7052.083229180379, 7237.203907570058, 7238.8914166286495, 6453.1610890583925, 6484.221893372637, 6553.901691474536, 6618.867622647424, 6662.666866656745, 6297.370262973849, 6363.840903977252, 6380.968095159495, 6508.511861610304, 6518.5111116667385, 6291.119243306032, 6328.272248691275, 6328.746850126127, 6351.714172862325, 6353.650549219652, 5963.254593175853, 5969.224000879858, 5983.192269043623, 5984.0, 5995.430434108753, 5908.3500814911185, 6158.353372895782, 6183.412575805291, 6186.907196391968, 6197.845053873689], "unit": "score", "name": "mootools.html", "value": 4309.147798857842}, {"lowerIsBetter": false, "replicates": [319.3023244211398, 326.54610091972154, 333.6746671994804, 337.822643112366, 340.5164666174031, 5768.307803063633, 5771.711414429283, 5839.591228613998, 5849.7367618457165, 5853.5902486825935, 5480.369757477892, 5566.081596536576, 5574.052411090114, 5708.372079071299, 5757.856053598662, 4483.0809684014785, 4483.910321793563, 4501.954980450187, 4509.075639493913, 4520.412346394981, 4303.505096913848, 4504.436945381827, 4505.166544189319, 4512.458504979407, 4518.751468669222, 4319.33050377192, 4364.847230346939, 4387.23223435899, 4405.625521830648, 4406.4271644686305, 4372.409724687174, 4411.205982923073, 4431.335299705038, 4435.201663700533, 4442.000549876284, 3907.941380879289, 3929.6266854649048, 3930.3318435865685, 3944.5069366329208, 3949.1509325494867, 5379.447599150487, 5444.455554444564, 5447.400785913546, 5450.264214331094, 5459.099248623972, 5148.3564554430695, 5154.896902061975, 5184.326037615124, 5196.92204616931, 5204.323437953042, 6042.305134909498, 6048.758049678007, 6052.546059045545, 6052.878942421171, 6054.455099041107, 4399.6480281577715, 4400.427944367212, 4402.955970440286, 4408.625266852321, 4410.691251612388, 6168.136460895478, 6361.936380636181, 6370.840728981766, 6376.330485299023, 6417.871642567169, 4250.171216612731, 4251.851185208503, 4256.063665993476, 4257.106007738348, 4257.3613957905945, 4286.7856607169515, 4294.227039132924, 4301.78491075445, 4302.3546468030045, 4304.78476076195, 5033.496650335011, 5036.697798132123, 5047.318611987334, 5047.4447810740785, 5057.393112826411, 6056.06131049688, 6075.179850720185, 6158.846028849314, 6165.10605962133, 6169.198004259418, 1536.8770498360104, 1572.2531797396373, 1572.4182052640597, 1575.7715131305897, 1576.204016971422, 1011.7318910488726, 1051.8422236664408, 1054.583439541377, 1068.5992752717732, 1071.121680222226, 5817.243758311477, 5818.2436283282905, 5820.738066787005, 5820.88358232833, 5844.620099693507, 6277.309495955441, 6280.9685951569945, 6284.560080794392, 6297.716602752887, 6301.6219026858535, 5596.636218645775, 5689.687067211343, 5703.486686198262, 5713.628614140068, 5719.5138413235345, 3374.915627109342, 3429.4684323929832, 3432.1762776933356, 3432.4164891968426, 3437.2438063625964, 6678.666066696645, 6699.732010719614, 6700.765473208415, 6712.966435167793, 6714.060031595581, 6378.585391949508, 6556.18047744032, 6575.934240657532, 6581.2102547694585, 6595.868082638416, 6712.765053223114, 6763.357481039294, 6800.0, 6803.897941530881, 6820.31796820314, 6381.3937675920715, 6383.36166383358, 6389.424951754364, 6392.456641185366, 6400.9039864403, 6242.875142497034, 6312.368763123651, 6355.650439225702, 6356.110144579855, 6373.426391624776, 6686.9331306688255, 6693.933060669331, 6718.428933540704, 6725.562838415487, 6729.0915726376315, 4290.871273861789, 4329.740215587075, 4330.133973205308, 4330.545292744342, 4340.0, 6253.155823963889, 6404.0, 6406.295307516262, 6413.518986076157, 6424.582402143846, 6149.815505534841, 6195.1636529068, 6207.16203312547, 6234.937650623617, 6254.343293954069, 6183.938160618336, 6223.159873417212, 6228.813135605939, 6232.688365581794, 6255.468285195628, 5935.258092738408, 6090.482309003784, 6106.847328816815, 6133.325334213322, 6145.508359331154, 6207.720652570735, 6243.094751260951, 6273.9372606273355, 6276.246850377984, 6281.371862813682, 6052.818415447544, 6098.695065246809, 6110.236220472441, 6119.84700382494, 6125.081237814364], "unit": "score", "name": "prototype.html", "value": 4647.283364601115}, {"lowerIsBetter": false, "replicates": [622.4833388287722, 694.1358009278453, 696.8432102776876, 706.4842664854659, 735.8565079809435, 10915.781684366308, 11013.779724405516, 11246.662600121988, 11303.378314192736, 11346.60286889959, 10940.56237750491, 11006.339619622808, 11026.44867756613, 11048.613298534552, 11072.557097716102, 635.9919527548841, 648.5849056603778, 745.2398553475465, 749.8612756640039, 758.3023618271176, 746.2500187311745, 749.2170681637701, 752.6236881559221, 754.1553460124668, 755.7052749427728, 786.5909726941986, 794.3605397654885, 795.5624406576388, 798.1619299735283, 800.5756948817136, 655.7868692674876, 670.9765158219464, 783.7805414483954, 794.66226853587, 795.6300320351006, 583.1602492410957, 584.0742423259139, 586.2408181405091, 586.337438694277, 586.5190543754123, 11589.478473468629, 11631.883681163165, 11644.417779111096, 11677.007454366389, 11688.883111168865, 10507.369557826554, 11093.837695008891, 11206.607768728138, 11287.49206285719, 11309.377984210865, 9126.58930348136, 9297.209737172348, 9325.580348884248, 9352.579133938989, 9401.341906066578, 3418.9145271368166, 3426.0920855973186, 3426.9033909149084, 3522.84147213376, 3552.342816578941, 44831.55168448339, 45103.774481127715, 45263.54736452626, 45297.0, 46446.30330545045, 8952.552372381355, 9064.728058158265, 9074.954625226832, 9166.633334666538, 9343.34596578233, 15806.20968951548, 16021.0, 16214.837851621569, 16220.837791622169, 16255.918720406322, 6717.9664101680155, 6830.146231721035, 6832.487563432763, 6863.553868998499, 6894.482913781487, 4058.492688413948, 4112.239235741397, 4114.629683328515, 4130.0, 4155.542890282067, 2874.4107457971068, 2874.4682233786816, 2884.120343295273, 2884.480793457156, 2890.985545072261, 554.215784664695, 556.4518948835394, 561.1554610311537, 567.0388691168512, 572.4275724275724, 498.36209651645953, 510.2703134517601, 558.7038869399225, 564.2833601326292, 572.2560671127518, 6920.446364290845, 6961.338672826073, 7808.375329973588, 7849.529028258208, 7952.3638108951145, 470.1842303603246, 535.6625326044567, 558.974846131925, 560.907450270709, 573.1116769008021, 3326.3679900818765, 3434.8797792077157, 3714.7771133732062, 3765.755225910307, 3814.237152569497, 52016.739916300176, 53129.734351328, 53148.0, 53189.2021619676, 55006.0, 48339.75830120827, 48403.27395089076, 48500.757496212296, 48671.513284867404, 49423.0, 42230.78884605557, 43073.35389969153, 43518.0, 43667.12665746667, 43717.344239835795, 6827.93172068273, 7090.361867431956, 7226.277372262732, 7380.151282602569, 7404.96297518509, 33542.32915341728, 34042.82978585091, 34108.82945585256, 34683.0, 34705.0, 37873.62126378701, 40284.59715402809, 42351.1529769409, 42591.57408426, 42657.0, 9370.67202647904, 9416.387934784218, 9628.71113866585, 9673.322867399214, 9810.558524866541, 9827.0, 10024.198064154703, 10026.298159128792, 10053.949730251303, 10239.590416383262, 9362.95318523403, 9408.623655053994, 9541.522923853918, 9600.135987761136, 9974.850377244493, 9777.41335519871, 9964.302498825013, 10319.380837149494, 10324.896751032393, 10438.947805260925, 8854.911450885409, 8863.290936725176, 8929.151730585583, 8931.866022009544, 9159.633614655339, 7763.573003484863, 7904.20957904205, 7920.5247685139075, 7973.641186146753, 8386.790330241793, 7961.840763184588, 7986.640601172845, 8007.359411247203, 8041.793730940406, 8480.10958849312], "unit": "score", "name": "yui.html", "value": 5618.071465789628}], "name": "dromaeo_css", "value": 6497.783535444706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 113.0, 105.0, 112.0, 113.0, 112.0, 111.0, 112.0, 104.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 151.0, 170.0, 131.0, 151.0, 157.0, 128.0, 171.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 164.0, 161.0, 162.0, 164.0, 160.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 98.0, 93.0, 73.0, 74.0, 74.0, 125.0, 93.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 142.0, 95.0, 97.0, 96.0, 140.0, 96.0, 96.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 116.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.6}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 148.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 96.0, 96.0, 96.0, 98.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 68.0, 68.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 83.0, 84.0, 83.0, 86.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [114.0, 114.0, 117.0, 111.0, 127.0, 123.0, 129.0, 124.0, 114.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [146.0, 138.0, 149.0, 145.0, 148.0, 135.0, 141.0, 161.0, 146.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 70.0, 70.0, 69.0, 68.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1515.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.23687752355318], "unit": "score", "name": "Richards", "value": 209.83508800000004}, {"lowerIsBetter": false, "replicates": [189.465706707086], "unit": "score", "name": "DeltaBlue", "value": 348.97080399999993}, {"lowerIsBetter": false, "replicates": [273.972602739726], "unit": "score", "name": "Encrypt", "value": 971.56065}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [780.0312012480499], "unit": "score", "name": "Earley", "value": 854.4055660000001}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [41918.36734693877], "unit": "score", "name": "RegExp", "value": 21.732358812074008}, {"lowerIsBetter": false, "replicates": [568.1818181818181], "unit": "score", "name": "Splay", "value": 143.42415999999997}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19033.08503059553}]}
06:21:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,35]]", "result": "19033.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1515.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6497.78"}}}
06:21:35 INFO - Return code: 0
06:21:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json
06:21:35 INFO - # TBPL SUCCESS #
06:21:35 INFO - Running post-action listener: _resource_record_post_action
06:21:35 INFO - Running post-run listener: _resource_record_post_run
06:21:37 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 20480; Write bytes: 317734912; Read time: 60; Write time: 287544
06:21:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 19509248; Read time: 0; Write time: 11744
06:21:37 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 20480; Write bytes: 298225664; Read time: 60; Write time: 275800
06:21:37 INFO - Running post-run listener: _upload_blobber_files
06:21:37 INFO - Blob upload gear active.
06:21:37 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir.
06:21:37 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
06:21:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json']
06:21:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json
06:21:37 INFO - (blobuploader) - INFO - Open directory for files ...
06:21:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ...
06:21:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
06:21:37 INFO - (blobuploader) - INFO - Uploading, attempt #1.
06:21:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
06:21:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
06:21:39 INFO - (blobuploader) - INFO - Done attempting.
06:21:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
06:21:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
06:21:39 INFO - (blobuploader) - INFO - Uploading, attempt #1.
06:21:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
06:21:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
06:21:40 INFO - (blobuploader) - INFO - Done attempting.
06:21:40 INFO - (blobuploader) - INFO - Iteration through files over.
06:21:40 INFO - Return code: 0
06:21:40 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json
06:21:40 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1
06:21:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af15c67399a464c9a30c182b8cca749da93dc8795ed57414c74dca4808161779c9e0485bf592e4157ef97a1fb0ec8e00eb91ee2dc81557d1534beb441fea67eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39cfec342b41a92a8f3371115836fa36ca894108149513008f667cb0ad9ea81ded2caf04b8a6bc77bddc7188737ee35483efa0a1db71d5eb6ec30285a04bc4e7"}
06:21:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files
06:21:40 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files
06:21:40 INFO - Contents:
06:21:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af15c67399a464c9a30c182b8cca749da93dc8795ed57414c74dca4808161779c9e0485bf592e4157ef97a1fb0ec8e00eb91ee2dc81557d1534beb441fea67eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39cfec342b41a92a8f3371115836fa36ca894108149513008f667cb0ad9ea81ded2caf04b8a6bc77bddc7188737ee35483efa0a1db71d5eb6ec30285a04bc4e7"}
06:21:40 INFO - Running post-run listener: copy_logs_to_upload_dir
06:21:40 INFO - Copying logs to upload dir...
06:21:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs
06:21:40 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1286.544461
========= master_lag: 0.03 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-28 06:21:40.074915) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:40.079226) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af15c67399a464c9a30c182b8cca749da93dc8795ed57414c74dca4808161779c9e0485bf592e4157ef97a1fb0ec8e00eb91ee2dc81557d1534beb441fea67eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39cfec342b41a92a8f3371115836fa36ca894108149513008f667cb0ad9ea81ded2caf04b8a6bc77bddc7188737ee35483efa0a1db71d5eb6ec30285a04bc4e7"}
build_url:https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011287
build_url: 'https://queue.taskcluster.net/v1/task/BmVGspXMSXChKbhkQVsM2w/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af15c67399a464c9a30c182b8cca749da93dc8795ed57414c74dca4808161779c9e0485bf592e4157ef97a1fb0ec8e00eb91ee2dc81557d1534beb441fea67eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39cfec342b41a92a8f3371115836fa36ca894108149513008f667cb0ad9ea81ded2caf04b8a6bc77bddc7188737ee35483efa0a1db71d5eb6ec30285a04bc4e7"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:40.110011) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:40.110561) =========
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=a4ce256d2ec601f24a60a71e000001bc-1453986999.378237-1997686287
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004463
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 06:21:40.192899) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 06:21:40.193424) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 06:21:40.193949) =========
========= Total master_lag: 0.25 =========