builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo
slave: talos-linux64-ix-056
starttime: 1459241777.28
results: success (0)
buildid: 20160328232154
builduid: 50328f6ee2984308b6b8550c1c66ed0d
revision: 72c2846e2d16
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.279391) =========
master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.279912) =========
========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.280429) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
/builds/slave/test-pgo
program finished with exit code 0
elapsedTime=0.006481
basedir: '/builds/slave/test-pgo'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.304975) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.305354) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.324976) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.325446) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004659
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.379001) =========
========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.379325) =========
script_repo_url: https://hg.mozilla.org/build/mozharness
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.379749) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.380059) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-03-29 01:56:19-- 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% 45.6M=0s
2016-03-29 01:56:19 (45.6 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.444025
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.837173) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.837569) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.015072
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.887003) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:17.887374) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72c2846e2d16 --destination scripts --debug'
in dir /builds/slave/test-pgo/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 72c2846e2d16 --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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-03-29 01:56:19,927 Setting DEBUG logging.
2016-03-29 01:56:19,927 attempt 1/10
2016-03-29 01:56:19,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/72c2846e2d16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-03-29 01:56:20,191 unpacking tar archive at: mozilla-inbound-72c2846e2d16/testing/mozharness/
program finished with exit code 0
elapsedTime=0.559779
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:18.461111) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:18.461555) =========
echo 72c2846e2d16
in dir /builds/slave/test-pgo/. (timeout 1200 secs)
watching logfiles {}
argv: ['echo', u'72c2846e2d16']
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
72c2846e2d16
program finished with exit code 0
elapsedTime=0.004462
script_repo_revision: '72c2846e2d16'
========= master_lag: 0.05 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:18.513019) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:18.513407) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 01:56:18.524322) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-29 01:56:18.524658) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json
PWD=/builds/slave/test-pgo
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
01:56:20 INFO - MultiFileLogger online at 20160329 01:56:20 in /builds/slave/test-pgo
01:56:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
01:56:20 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json.
01:56:20 INFO - {'append_to_log': False,
01:56:20 INFO - 'base_work_dir': '/builds/slave/test-pgo',
01:56:20 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
01:56:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt',
01:56:20 INFO - 'branch': 'Mozilla-Inbound',
01:56:20 INFO - 'buildbot_json_path': 'buildprops.json',
01:56:20 INFO - 'config_files': ('talos/linux_config.py',),
01:56:20 INFO - 'default_actions': ('clobber',
01:56:20 INFO - 'read-buildbot-config',
01:56:20 INFO - 'download-and-extract',
01:56:20 INFO - 'populate-webroot',
01:56:20 INFO - 'create-virtualenv',
01:56:20 INFO - 'install',
01:56:20 INFO - 'run-tests'),
01:56:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
01:56:20 INFO - 'download_minidump_stackwalk': True,
01:56:20 INFO - 'download_symbols': 'ondemand',
01:56:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
01:56:20 INFO - 'tooltool.py': '/tools/tooltool.py',
01:56:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
01:56:20 INFO - '/tools/misc-python/virtualenv.py')},
01:56:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
01:56:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
01:56:20 INFO - 'installer_path': 'installer.exe',
01:56:20 INFO - 'log_level': 'info',
01:56:20 INFO - 'log_name': 'talos',
01:56:20 INFO - 'log_to_console': True,
01:56:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
01:56:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
01:56:20 INFO - 'opt_config_files': (),
01:56:20 INFO - 'pip_index': False,
01:56:20 INFO - 'sps_profile': False,
01:56:20 INFO - 'sps_profile_interval': 0,
01:56:20 INFO - 'suite': 'dromaeojs',
01:56:20 INFO - 'system_bits': '32',
01:56:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
01:56:20 INFO - 'title': 'talos-linux64-ix-056',
01:56:20 INFO - 'tooltool_cache': '/builds/tooltool_cache',
01:56:20 INFO - 'use_talos_json': True,
01:56:20 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv',
01:56:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
01:56:20 INFO - 'work_dir': 'build'}
01:56:20 INFO - #####
01:56:20 INFO - ##### Running clobber step.
01:56:20 INFO - #####
01:56:20 INFO - Running pre-action listener: _resource_record_pre_action
01:56:20 INFO - Running main action method: clobber
01:56:20 INFO - rmtree: /builds/slave/test-pgo/build
01:56:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1
01:56:21 INFO - Running post-action listener: _resource_record_post_action
01:56:21 INFO - #####
01:56:21 INFO - ##### Running read-buildbot-config step.
01:56:21 INFO - #####
01:56:21 INFO - Running pre-action listener: _resource_record_pre_action
01:56:21 INFO - Running main action method: read_buildbot_config
01:56:21 INFO - Using buildbot properties:
01:56:21 INFO - {
01:56:21 INFO - "project": "",
01:56:21 INFO - "product": "firefox",
01:56:21 INFO - "script_repo_revision": "production",
01:56:21 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs",
01:56:21 INFO - "repository": "",
01:56:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs",
01:56:21 INFO - "buildid": "20160328232154",
01:56:21 INFO - "pgo_build": "True",
01:56:21 INFO - "basedir": "/builds/slave/test-pgo",
01:56:21 INFO - "buildnumber": 813,
01:56:21 INFO - "slavename": "talos-linux64-ix-056",
01:56:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/",
01:56:21 INFO - "platform": "ubuntu64_hw",
01:56:21 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos",
01:56:21 INFO - "branch": "mozilla-inbound",
01:56:21 INFO - "repo_path": "integration/mozilla-inbound",
01:56:21 INFO - "revision": "72c2846e2d16",
01:56:21 INFO - "stage_platform": "linux64-pgo",
01:56:21 INFO - "builduid": "50328f6ee2984308b6b8550c1c66ed0d",
01:56:21 INFO - "slavebuilddir": "test"
01:56:21 INFO - }
01:56:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2.
01:56:21 INFO - Running post-action listener: _resource_record_post_action
01:56:21 INFO - #####
01:56:21 INFO - ##### Running download-and-extract step.
01:56:21 INFO - #####
01:56:21 INFO - Running pre-action listener: _resource_record_pre_action
01:56:21 INFO - Running main action method: download_and_extract
01:56:21 INFO - mkdir: /builds/slave/test-pgo/build/tests
01:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:21 INFO - https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net
01:56:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json
01:56:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json
01:56:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json
01:56:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1
01:56:22 INFO - Downloaded 1361 bytes.
01:56:22 INFO - Reading from file /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json
01:56:22 INFO - Using the following test package requirements:
01:56:22 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'],
01:56:22 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
01:56:22 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'],
01:56:22 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'jsshell-linux-x86_64.zip'],
01:56:22 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
01:56:22 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'],
01:56:22 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'],
01:56:22 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'],
01:56:22 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
01:56:22 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip',
01:56:22 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
01:56:22 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
01:56: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')]}
01:56:22 INFO - https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
01:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
01:56:23 INFO - Downloaded 23673502 bytes.
01:56:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
01:56:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests
01:56:25 INFO - Return code: 0
01:56:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
01:56:25 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')]}
01:56:25 INFO - https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
01:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip
01:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
01:56:30 INFO - Downloaded 23673502 bytes.
01:56:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
01:56:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests
01:56:32 INFO - Return code: 0
01:56:32 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')]}
01:56:32 INFO - https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
01:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip
01:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip
01:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip
01:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
01:56:33 INFO - Downloaded 10847531 bytes.
01:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests']
01:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests
01:56:33 INFO - Return code: 0
01:56:33 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')]}
01:56:33 INFO - https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
01:56:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
01:56:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
01:56:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
01:56:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
01:56:38 INFO - Downloaded 57734263 bytes.
01:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
01:56:38 INFO - mkdir: /builds/slave/test-pgo/properties
01:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url
01:56:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url
01:56:38 INFO - Contents:
01:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
01:56:38 INFO - Running post-action listener: _resource_record_post_action
01:56:38 INFO - Running post-action listener: set_extra_try_arguments
01:56:38 INFO - #####
01:56:38 INFO - ##### Running populate-webroot step.
01:56:38 INFO - #####
01:56:38 INFO - Running pre-action listener: _resource_record_pre_action
01:56:38 INFO - Running main action method: populate_webroot
01:56:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
01:56:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
01:56:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
01:56:38 INFO - '--tppagecycles',
01:56:38 INFO - '7'],
01:56:38 INFO - 'tests': ['tsvgm']}},
01:56:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']},
01:56:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'],
01:56:38 INFO - 'tests': ['tresize', 'tcanvasmark']},
01:56:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']},
01:56:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['dromaeo_css', 'kraken']},
01:56:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
01:56:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
01:56:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'tests': ['damp', 'tps']},
01:56:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['damp', 'tps']},
01:56:39 INFO - 'g3': {'tests': ['dromaeo_dom']},
01:56:39 INFO - 'g3-e10s': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['dromaeo_dom']},
01:56:39 INFO - 'other': {'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'other-e10s': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'other_l64': {'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'other_nol64': {'tests': ['a11yr',
01:56:39 INFO - 'ts_paint',
01:56:39 INFO - 'tpaint',
01:56:39 INFO - 'sessionrestore',
01:56:39 INFO - 'sessionrestore_no_auto_restore',
01:56:39 INFO - 'tabpaint']},
01:56:39 INFO - 'svgr': {'tests': ['tsvgx',
01:56:39 INFO - 'tsvgr_opacity',
01:56:39 INFO - 'tart',
01:56:39 INFO - 'tscrollx',
01:56:39 INFO - 'cart']},
01:56:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['tsvgx',
01:56:39 INFO - 'tsvgr_opacity',
01:56:39 INFO - 'tart',
01:56:39 INFO - 'tscrollx',
01:56:39 INFO - 'cart']},
01:56:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'tests': ['tp5o']},
01:56:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'talos_options': ['--e10s'],
01:56:39 INFO - 'tests': ['tp5o']},
01:56:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'talos_options': ['--xperf_path',
01:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
01:56:39 INFO - 'tests': ['tp5n']},
01:56:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
01:56:39 INFO - 'talos_options': ['--e10s',
01:56:39 INFO - '--xperf_path',
01:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
01:56:39 INFO - 'tests': ['tp5n']}},
01:56:39 INFO - 'talos.zip': {'path': '',
01:56:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
01:56:39 INFO - Running post-action listener: _resource_record_post_action
01:56:39 INFO - #####
01:56:39 INFO - ##### Running create-virtualenv step.
01:56:39 INFO - #####
01:56:39 INFO - Running pre-action listener: _resource_record_pre_action
01:56:39 INFO - Running main action method: create_virtualenv
01:56:39 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv
01:56:39 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
01:56:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv
01:56:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
01:56:39 INFO - Using real prefix '/usr'
01:56:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python
01:56:39 INFO - Installing distribute.............................................................................................................................................................................................done.
01:56:41 INFO - Installing pip.................done.
01:56:41 INFO - Return code: 0
01:56:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv
01:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:41 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:41 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
01:56:41 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
01:56:41 INFO - Using env: {'DISPLAY': ':0',
01:56:41 INFO - 'HOME': '/home/cltbld',
01:56:41 INFO - 'LANG': 'en_US.UTF-8',
01:56:41 INFO - 'LANGUAGE': 'en_US:en',
01:56:41 INFO - 'LOGNAME': 'cltbld',
01:56:41 INFO - 'MAIL': '/var/mail/cltbld',
01:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:41 INFO - 'MOZ_NO_REMOTE': '1',
01:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:41 INFO - 'NO_EM_RESTART': '1',
01:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:41 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:41 INFO - 'SHELL': '/bin/bash',
01:56:41 INFO - 'SHLVL': '1',
01:56:41 INFO - 'TERM': 'linux',
01:56:41 INFO - 'TMOUT': '86400',
01:56:41 INFO - 'USER': 'cltbld',
01:56:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:41 INFO - '_': '/tools/buildbot/bin/python'}
01:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:41 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
01:56:41 INFO - Cleaning up...
01:56:41 INFO - Return code: 0
01:56:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv
01:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:41 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:41 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
01:56:41 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
01:56:41 INFO - Using env: {'DISPLAY': ':0',
01:56:41 INFO - 'HOME': '/home/cltbld',
01:56:41 INFO - 'LANG': 'en_US.UTF-8',
01:56:41 INFO - 'LANGUAGE': 'en_US:en',
01:56:41 INFO - 'LOGNAME': 'cltbld',
01:56:41 INFO - 'MAIL': '/var/mail/cltbld',
01:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:41 INFO - 'MOZ_NO_REMOTE': '1',
01:56:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:41 INFO - 'NO_EM_RESTART': '1',
01:56:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:41 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:41 INFO - 'SHELL': '/bin/bash',
01:56:41 INFO - 'SHLVL': '1',
01:56:41 INFO - 'TERM': 'linux',
01:56:41 INFO - 'TMOUT': '86400',
01:56:41 INFO - 'USER': 'cltbld',
01:56:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:41 INFO - '_': '/tools/buildbot/bin/python'}
01:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:42 INFO - Downloading/unpacking psutil>=0.7.1
01:56:42 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
01:56:42 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
01:56:42 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
01:56:42 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
01:56:42 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
01:56:42 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
01:56:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil
01:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
01:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
01:56:44 INFO - Installing collected packages: psutil
01:56:44 INFO - Running setup.py install for psutil
01:56:44 INFO - building 'psutil._psutil_linux' extension
01:56:44 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
01:56:44 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
01:56:44 INFO - building 'psutil._psutil_posix' extension
01:56:44 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
01:56:44 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
01:56:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
01:56:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
01:56:44 INFO - Successfully installed psutil
01:56:44 INFO - Cleaning up...
01:56:44 INFO - Return code: 0
01:56:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv
01:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
01:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:44 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:44 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
01:56:44 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
01:56:44 INFO - Using env: {'DISPLAY': ':0',
01:56:44 INFO - 'HOME': '/home/cltbld',
01:56:44 INFO - 'LANG': 'en_US.UTF-8',
01:56:44 INFO - 'LANGUAGE': 'en_US:en',
01:56:44 INFO - 'LOGNAME': 'cltbld',
01:56:44 INFO - 'MAIL': '/var/mail/cltbld',
01:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:44 INFO - 'MOZ_NO_REMOTE': '1',
01:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:44 INFO - 'NO_EM_RESTART': '1',
01:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:44 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:44 INFO - 'SHELL': '/bin/bash',
01:56:44 INFO - 'SHLVL': '1',
01:56:44 INFO - 'TERM': 'linux',
01:56:44 INFO - 'TMOUT': '86400',
01:56:44 INFO - 'USER': 'cltbld',
01:56:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:44 INFO - '_': '/tools/buildbot/bin/python'}
01:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
01:56:44 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
01:56:44 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
01:56:44 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
01:56:44 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
01:56:44 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
01:56:44 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
01:56:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz
01:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
01:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0)
01:56:46 INFO - Installing collected packages: mozsystemmonitor
01:56:46 INFO - Running setup.py install for mozsystemmonitor
01:56:46 INFO - Successfully installed mozsystemmonitor
01:56:46 INFO - Cleaning up...
01:56:47 INFO - Return code: 0
01:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv
01:56:47 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')]}
01:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:47 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')]}
01:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:47 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:47 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
01:56:47 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
01:56:47 INFO - Using env: {'DISPLAY': ':0',
01:56:47 INFO - 'HOME': '/home/cltbld',
01:56:47 INFO - 'LANG': 'en_US.UTF-8',
01:56:47 INFO - 'LANGUAGE': 'en_US:en',
01:56:47 INFO - 'LOGNAME': 'cltbld',
01:56:47 INFO - 'MAIL': '/var/mail/cltbld',
01:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:47 INFO - 'MOZ_NO_REMOTE': '1',
01:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:47 INFO - 'NO_EM_RESTART': '1',
01:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:47 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:47 INFO - 'SHELL': '/bin/bash',
01:56:47 INFO - 'SHLVL': '1',
01:56:47 INFO - 'TERM': 'linux',
01:56:47 INFO - 'TMOUT': '86400',
01:56:47 INFO - 'USER': 'cltbld',
01:56:47 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:47 INFO - '_': '/tools/buildbot/bin/python'}
01:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:47 INFO - Downloading/unpacking blobuploader==1.2.4
01:56:47 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
01:56:47 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
01:56:47 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
01:56:47 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
01:56:47 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
01:56:47 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
01:56:49 INFO - Downloading blobuploader-1.2.4.tar.gz
01:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
01:56:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests
01:56:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 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
01:56:49 INFO - Downloading docopt-0.6.1.tar.gz
01:56:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt
01:56:49 INFO - Installing collected packages: blobuploader, requests, docopt
01:56:49 INFO - Running setup.py install for blobuploader
01:56:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
01:56:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775
01:56:49 INFO - Running setup.py install for requests
01:56:50 INFO - Running setup.py install for docopt
01:56:50 INFO - Successfully installed blobuploader requests docopt
01:56:50 INFO - Cleaning up...
01:56:50 INFO - Return code: 0
01:56:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
01:56: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')]}
01:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56: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')]}
01:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:50 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:50 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
01:56:50 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
01:56:50 INFO - Using env: {'DISPLAY': ':0',
01:56:50 INFO - 'HOME': '/home/cltbld',
01:56:50 INFO - 'LANG': 'en_US.UTF-8',
01:56:50 INFO - 'LANGUAGE': 'en_US:en',
01:56:50 INFO - 'LOGNAME': 'cltbld',
01:56:50 INFO - 'MAIL': '/var/mail/cltbld',
01:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:50 INFO - 'MOZ_NO_REMOTE': '1',
01:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:50 INFO - 'NO_EM_RESTART': '1',
01:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:50 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:50 INFO - 'SHELL': '/bin/bash',
01:56:50 INFO - 'SHLVL': '1',
01:56:50 INFO - 'TERM': 'linux',
01:56:50 INFO - 'TMOUT': '86400',
01:56:50 INFO - 'USER': 'cltbld',
01:56:50 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:50 INFO - '_': '/tools/buildbot/bin/python'}
01:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
01:56:50 INFO - Running setup.py (path:/tmp/pip-xSBe2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
01:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
01:56:50 INFO - Running setup.py (path:/tmp/pip-OzyRJY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
01:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
01:56:50 INFO - Running setup.py (path:/tmp/pip-8Thlrk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
01:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
01:56:50 INFO - Running setup.py (path:/tmp/pip-KphDT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
01:56:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
01:56:50 INFO - Running setup.py (path:/tmp/pip-ugEXvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
01:56:51 INFO - Running setup.py (path:/tmp/pip-2FtXgS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
01:56:51 INFO - Running setup.py (path:/tmp/pip-IOH2Rq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
01:56:51 INFO - Running setup.py (path:/tmp/pip-xFSY1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
01:56:51 INFO - Running setup.py (path:/tmp/pip-Q6HpLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
01:56:51 INFO - Running setup.py (path:/tmp/pip-bxyiLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
01:56:51 INFO - Running setup.py (path:/tmp/pip-q3Kij3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
01:56:51 INFO - Running setup.py (path:/tmp/pip-b7H8Qa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
01:56:51 INFO - Running setup.py (path:/tmp/pip-mZIvZv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
01:56:51 INFO - Running setup.py (path:/tmp/pip-n5eux7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:56:51 INFO - Running setup.py (path:/tmp/pip-5aJ6Zy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
01:56:51 INFO - Running setup.py (path:/tmp/pip-CBwVxx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
01:56:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
01:56:51 INFO - Running setup.py (path:/tmp/pip-tVDIi7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
01:56:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
01:56:51 INFO - Running setup.py install for manifestparser
01:56:52 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for mozcrash
01:56:52 INFO - Running setup.py install for mozdebug
01:56:52 INFO - Running setup.py install for mozdevice
01:56:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for mozfile
01:56:52 INFO - Running setup.py install for mozhttpd
01:56:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for mozinfo
01:56:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for mozInstall
01:56:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for mozleak
01:56:52 INFO - Running setup.py install for mozlog
01:56:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin
01:56:52 INFO - Running setup.py install for moznetwork
01:56:53 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Running setup.py install for mozprocess
01:56:53 INFO - Running setup.py install for mozprofile
01:56:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Running setup.py install for mozrunner
01:56:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Running setup.py install for mozscreenshot
01:56:53 INFO - Running setup.py install for moztest
01:56:53 INFO - Running setup.py install for mozversion
01:56:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin
01:56:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
01:56:53 INFO - Cleaning up...
01:56:53 INFO - Return code: 0
01:56:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
01:56: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')]}
01:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56: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')]}
01:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:53 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:53 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
01:56:53 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
01:56:53 INFO - Using env: {'DISPLAY': ':0',
01:56:53 INFO - 'HOME': '/home/cltbld',
01:56:53 INFO - 'LANG': 'en_US.UTF-8',
01:56:53 INFO - 'LANGUAGE': 'en_US:en',
01:56:53 INFO - 'LOGNAME': 'cltbld',
01:56:53 INFO - 'MAIL': '/var/mail/cltbld',
01:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:53 INFO - 'MOZ_NO_REMOTE': '1',
01:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:53 INFO - 'NO_EM_RESTART': '1',
01:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:53 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:53 INFO - 'SHELL': '/bin/bash',
01:56:53 INFO - 'SHLVL': '1',
01:56:53 INFO - 'TERM': 'linux',
01:56:53 INFO - 'TMOUT': '86400',
01:56:53 INFO - 'USER': 'cltbld',
01:56:53 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:53 INFO - '_': '/tools/buildbot/bin/python'}
01:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser
01:56:53 INFO - Running setup.py (path:/tmp/pip-SfOS3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash
01:56:54 INFO - Running setup.py (path:/tmp/pip-6O4ltQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash
01:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug
01:56:54 INFO - Running setup.py (path:/tmp/pip-OF4oI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice
01:56:54 INFO - Running setup.py (path:/tmp/pip-I679Et-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile
01:56:54 INFO - Running setup.py (path:/tmp/pip-muUdz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd
01:56:54 INFO - Running setup.py (path:/tmp/pip-hkuIEd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo
01:56:54 INFO - Running setup.py (path:/tmp/pip-KsYI4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall
01:56:54 INFO - Running setup.py (path:/tmp/pip-XfVfdQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak
01:56:54 INFO - Running setup.py (path:/tmp/pip-EaFziI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog
01:56:54 INFO - Running setup.py (path:/tmp/pip-UbGeuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork
01:56:54 INFO - Running setup.py (path:/tmp/pip-utwAAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess
01:56:54 INFO - Running setup.py (path:/tmp/pip-VnfJ7G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile
01:56:54 INFO - Running setup.py (path:/tmp/pip-WckNp4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner
01:56:54 INFO - Running setup.py (path:/tmp/pip-F2DSby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner
01:56:54 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))
01:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:56:54 INFO - Running setup.py (path:/tmp/pip-5pis_I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot
01:56:55 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))
01:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest
01:56:55 INFO - Running setup.py (path:/tmp/pip-4cXt9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest
01:56:55 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))
01:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion
01:56:55 INFO - Running setup.py (path:/tmp/pip-noYHEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion
01:56:55 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))
01:56:55 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2))
01:56:55 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2))
01:56:55 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))
01:56:55 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))
01:56:55 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))
01:56:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10))
01:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:56:57 INFO - Downloading blessings-1.6.tar.gz
01:56:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings
01:56:57 INFO - Installing collected packages: blessings
01:56:57 INFO - Running setup.py install for blessings
01:56:57 INFO - Successfully installed blessings
01:56:57 INFO - Cleaning up...
01:56:57 INFO - Return code: 0
01:56:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv.
01:56:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
01:56:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
01:56:57 INFO - Reading from file tmpfile_stdout
01:56:57 INFO - Current package versions:
01:56:57 INFO - argparse == 1.2.1
01:56:57 INFO - blessings == 1.6
01:56:57 INFO - blobuploader == 1.2.4
01:56:57 INFO - docopt == 0.6.1
01:56:57 INFO - manifestparser == 1.1
01:56:57 INFO - mozInstall == 1.12
01:56:57 INFO - mozcrash == 0.17
01:56:57 INFO - mozdebug == 0.1
01:56:57 INFO - mozdevice == 0.48
01:56:57 INFO - mozfile == 1.2
01:56:57 INFO - mozhttpd == 0.7
01:56:57 INFO - mozinfo == 0.9
01:56:57 INFO - mozleak == 0.1
01:56:57 INFO - mozlog == 3.1
01:56:57 INFO - moznetwork == 0.27
01:56:57 INFO - mozprocess == 0.22
01:56:57 INFO - mozprofile == 0.28
01:56:57 INFO - mozrunner == 6.11
01:56:57 INFO - mozscreenshot == 0.1
01:56:57 INFO - mozsystemmonitor == 0.0
01:56:57 INFO - moztest == 0.7
01:56:57 INFO - mozversion == 1.4
01:56:57 INFO - psutil == 3.1.1
01:56:57 INFO - requests == 1.2.3
01:56:57 INFO - wsgiref == 0.1.2
01:56:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv
01:56: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')]}
01:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56: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')]}
01:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56: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/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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:57 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
01:56:57 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
01:56:57 INFO - Using env: {'DISPLAY': ':0',
01:56:57 INFO - 'HOME': '/home/cltbld',
01:56:57 INFO - 'LANG': 'en_US.UTF-8',
01:56:57 INFO - 'LANGUAGE': 'en_US:en',
01:56:57 INFO - 'LOGNAME': 'cltbld',
01:56:57 INFO - 'MAIL': '/var/mail/cltbld',
01:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:57 INFO - 'MOZ_NO_REMOTE': '1',
01:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:57 INFO - 'NO_EM_RESTART': '1',
01:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:57 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:57 INFO - 'SHELL': '/bin/bash',
01:56:57 INFO - 'SHLVL': '1',
01:56:57 INFO - 'TERM': 'linux',
01:56:57 INFO - 'TMOUT': '86400',
01:56:57 INFO - 'USER': 'cltbld',
01:56:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:57 INFO - '_': '/tools/buildbot/bin/python'}
01:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 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))
01:56:57 INFO - Cleaning up...
01:56:57 INFO - Return code: 0
01:56:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv
01:56: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')]}
01:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56: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')]}
01:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:56:57 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:56:57 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
01:56:57 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
01:56:57 INFO - Using env: {'DISPLAY': ':0',
01:56:57 INFO - 'HOME': '/home/cltbld',
01:56:57 INFO - 'LANG': 'en_US.UTF-8',
01:56:57 INFO - 'LANGUAGE': 'en_US:en',
01:56:57 INFO - 'LOGNAME': 'cltbld',
01:56:57 INFO - 'MAIL': '/var/mail/cltbld',
01:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:56:57 INFO - 'MOZ_NO_REMOTE': '1',
01:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:56:57 INFO - 'NO_EM_RESTART': '1',
01:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:56:57 INFO - 'PWD': '/builds/slave/test-pgo',
01:56:57 INFO - 'SHELL': '/bin/bash',
01:56:57 INFO - 'SHLVL': '1',
01:56:57 INFO - 'TERM': 'linux',
01:56:57 INFO - 'TMOUT': '86400',
01:56:57 INFO - 'USER': 'cltbld',
01:56:57 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:56:57 INFO - '_': '/tools/buildbot/bin/python'}
01:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:56:57 INFO - Downloading/unpacking jsonschema
01:56:57 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
01:56:57 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
01:56:57 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
01:56:57 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
01:56:57 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
01:56:57 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
01:56:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
01:56:59 INFO - Downloading/unpacking functools32 (from jsonschema)
01:56:59 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
01:56:59 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
01:56:59 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
01:56:59 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
01:56:59 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
01:56:59 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
01:57:00 INFO - Downloading functools32-3.2.3-2.tar.gz
01:57:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32
01:57:00 INFO - warning: no files found matching '*.txt'
01:57:00 INFO - no previously-included directories found matching 'build'
01:57:00 INFO - no previously-included directories found matching 'dist'
01:57:00 INFO - no previously-included directories found matching '.git*'
01:57:00 INFO - Installing collected packages: jsonschema, functools32
01:57:00 INFO - Running setup.py install for functools32
01:57:00 INFO - warning: no files found matching '*.txt'
01:57:00 INFO - no previously-included directories found matching 'build'
01:57:00 INFO - no previously-included directories found matching 'dist'
01:57:00 INFO - no previously-included directories found matching '.git*'
01:57:00 INFO - Successfully installed jsonschema functools32
01:57:00 INFO - Cleaning up...
01:57:00 INFO - Return code: 0
01:57:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv
01:57: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')]}
01:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
01:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:57: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')]}
01:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
01:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
01:57:00 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 0x7f72a1e35f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11498d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, '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': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778', '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
01:57:00 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
01:57:00 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
01:57:00 INFO - Using env: {'DISPLAY': ':0',
01:57:00 INFO - 'HOME': '/home/cltbld',
01:57:00 INFO - 'LANG': 'en_US.UTF-8',
01:57:00 INFO - 'LANGUAGE': 'en_US:en',
01:57:00 INFO - 'LOGNAME': 'cltbld',
01:57:00 INFO - 'MAIL': '/var/mail/cltbld',
01:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:57:00 INFO - 'MOZ_NO_REMOTE': '1',
01:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:57:00 INFO - 'NO_EM_RESTART': '1',
01:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:57:00 INFO - 'PWD': '/builds/slave/test-pgo',
01:57:00 INFO - 'SHELL': '/bin/bash',
01:57:00 INFO - 'SHLVL': '1',
01:57:00 INFO - 'TERM': 'linux',
01:57:00 INFO - 'TMOUT': '86400',
01:57:00 INFO - 'USER': 'cltbld',
01:57:00 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:57:00 INFO - '_': '/tools/buildbot/bin/python'}
01:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/
01:57:00 INFO - Downloading/unpacking flake8
01:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
01:57:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
01:57:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
01:57:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8
01:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
01:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
01:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
01:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
01:57:03 INFO - no previously-included directories found matching 'docs/_build'
01:57:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
01:57:03 INFO - Running setup.py install for pep8
01:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
01:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
01:57:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
01:57:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
01:57:03 INFO - no previously-included directories found matching 'docs/_build'
01:57:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin
01:57:03 INFO - Successfully installed flake8 mccabe pyflakes pep8
01:57:03 INFO - Cleaning up...
01:57:03 INFO - Return code: 0
01:57:03 INFO - Running post-action listener: _resource_record_post_action
01:57:03 INFO - Running post-action listener: _start_resource_monitoring
01:57:03 INFO - Starting resource monitoring.
01:57:03 INFO - #####
01:57:03 INFO - ##### Running install step.
01:57:03 INFO - #####
01:57:03 INFO - Running pre-action listener: _resource_record_pre_action
01:57:03 INFO - Running main action method: install
01:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze']
01:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze
01:57:03 INFO - Reading from file tmpfile_stdout
01:57:03 INFO - Detecting whether we're running mozinstall >=1.0...
01:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h']
01:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h
01:57:03 INFO - Reading from file tmpfile_stdout
01:57:03 INFO - Output received:
01:57:03 INFO - Usage: mozinstall [options] installer
01:57:03 INFO - Options:
01:57:03 INFO - -h, --help show this help message and exit
01:57:03 INFO - -d DEST, --destination=DEST
01:57:03 INFO - Directory to install application into. [default:
01:57:03 INFO - "/builds/slave/test-pgo"]
01:57:03 INFO - --app=APP Application being installed. [default: firefox]
01:57:03 INFO - mkdir: /builds/slave/test-pgo/build/application
01:57:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application']
01:57:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application
01:57:20 INFO - Reading from file tmpfile_stdout
01:57:20 INFO - Output received:
01:57:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox
01:57:20 INFO - Running post-action listener: _resource_record_post_action
01:57:20 INFO - #####
01:57:20 INFO - ##### Running run-tests step.
01:57:20 INFO - #####
01:57:20 INFO - Running pre-action listener: _resource_record_pre_action
01:57:20 INFO - Running main action method: run_tests
01:57:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version']
01:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version
01:57:20 INFO - Python 2.7.3
01:57:20 INFO - Return code: 0
01:57:20 INFO - grabbing minidump binary from tooltool
01:57:20 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')]}
01:57:20 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 0x11d88b0>, '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 0x11d97b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11d9c60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1
01:57:20 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
01:57:20 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
01:57:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
01:57:20 INFO - Return code: 0
01:57:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755
01:57:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir
01:57:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir
01:57:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk
01:57:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir
01:57:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos']
01:57:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos
01:57:21 INFO - Return code: 0
01:57:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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
01:57:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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
01:57:21 INFO - Using env: {'DISPLAY': ':0',
01:57:21 INFO - 'HOME': '/home/cltbld',
01:57:21 INFO - 'LANG': 'en_US.UTF-8',
01:57:21 INFO - 'LANGUAGE': 'en_US:en',
01:57:21 INFO - 'LOGNAME': 'cltbld',
01:57:21 INFO - 'MAIL': '/var/mail/cltbld',
01:57:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir',
01:57:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk',
01:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
01:57:21 INFO - 'MOZ_NO_REMOTE': '1',
01:57:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir',
01:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
01:57:21 INFO - 'NO_EM_RESTART': '1',
01:57:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
01:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json',
01:57:21 INFO - 'PWD': '/builds/slave/test-pgo',
01:57:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos',
01:57:21 INFO - 'SHELL': '/bin/bash',
01:57:21 INFO - 'SHLVL': '1',
01:57:21 INFO - 'TERM': 'linux',
01:57:21 INFO - 'TMOUT': '86400',
01:57:21 INFO - 'USER': 'cltbld',
01:57:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778',
01:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
01:57:21 INFO - '_': '/tools/buildbot/bin/python'}
01:57:21 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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
01:57:21 INFO - mozversion application_buildid: 20160328232154
01:57:21 INFO - mozversion application_changeset: 72c2846e2d161e3c73f04c679e52717ccde38f7b
01:57:21 INFO - mozversion application_display_name: Nightly
01:57:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
01:57:21 INFO - mozversion application_name: Firefox
01:57:21 INFO - mozversion application_remotingname: firefox
01:57:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
01:57:21 INFO - mozversion application_vendor: Mozilla
01:57:21 INFO - mozversion application_version: 48.0a1
01:57:21 INFO - mozversion platform_buildid: 20160328232154
01:57:21 INFO - mozversion platform_changeset: 72c2846e2d161e3c73f04c679e52717ccde38f7b
01:57:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
01:57:21 INFO - mozversion platform_version: 48.0a1
01:57:21 INFO - using testdate: 1459241841
01:57:21 INFO - actual date: 1459241841
01:57:21 INFO - starting webserver on 'localhost:54727'
01:57:21 INFO - SUITE-START | Running 2 tests
01:57:21 INFO - TEST-START | dromaeo_css
01:57:21 INFO - operating with platform_type : linux_
01:57:21 INFO - Initialising browser for dromaeo_css test...
01:57:21 INFO - TEST-INFO | started process 10853 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAG3qCW/profile http://localhost:54727/getInfo.html)
01:57:25 INFO - PROCESS | 10853 | __metrics Screen width/height:1600/1200
01:57:25 INFO - PROCESS | 10853 | colorDepth:24
01:57:25 INFO - PROCESS | 10853 | Browser inner width/height: 1024/697
01:57:25 INFO - PROCESS | 10853 | __metrics
01:57:26 ERROR - PROCESS | 10853 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
01:57:26 INFO - PROCESS | 10853 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code.
01:57:27 INFO - TEST-INFO | 10853: exit 0
01:57:27 INFO - Browser initialized.
01:57:27 INFO - Running cycle 1/1 for dromaeo_css test...
01:57:27 INFO - TEST-INFO | started process 10948 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAG3qCW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
01:57:39 INFO - PROCESS | 10948 | RSS: Main: 153055232
01:57:39 INFO - PROCESS | 10948 |
01:58:30 INFO - PROCESS | 10948 | 1459241910164 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]
02:00:37 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54727/tests/dromaeo/cssquery-ext.html)
02:00:39 INFO - PROCESS | 10948 | RSS: Main: 320532480
02:00:39 INFO - PROCESS | 10948 |
02:03:41 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-ext.html (next: http://localhost:54727/tests/dromaeo/cssquery-jquery.html)
02:03:42 INFO - PROCESS | 10948 | RSS: Main: 237182976
02:03:42 INFO - PROCESS | 10948 |
02:06:43 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54727/tests/dromaeo/cssquery-mootools.html)
02:06:44 INFO - PROCESS | 10948 | RSS: Main: 235671552
02:06:44 INFO - PROCESS | 10948 |
02:09:46 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54727/tests/dromaeo/cssquery-prototype.html)
02:09:46 INFO - PROCESS | 10948 | RSS: Main: 211828736
02:09:46 INFO - PROCESS | 10948 |
02:12:49 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54727/tests/dromaeo/cssquery-yui.html)
02:12:50 INFO - PROCESS | 10948 | RSS: Main: 217497600
02:12:50 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | Cycle 1(1): loaded http://localhost:54727/tests/dromaeo/cssquery-yui.html (next: http://localhost:54727/tests/dromaeo/cssquery-dojo.html)
02:15:52 INFO - PROCESS | 10948 | RSS: Main: 270348288
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | __start_tp_report
02:15:52 INFO - PROCESS | 10948 | _x_x_mozilla_page_load
02:15:52 INFO - PROCESS | 10948 | _x_x_mozilla_page_load_details
02:15:52 INFO - PROCESS | 10948 | |i|pagename|runs|
02:15:52 INFO - PROCESS | 10948 | |0;dojo.html;3048.8323142227177;3068.8312142832137;3103.0380582019575;3107.7979931304462;3134.7335476484504;5124.615653825968;5174.870628234296;5184.403793563736;5187.247849061884;5207.557357624606;5199.064168449687;5229.424763276046;5239.449857764937;5249.86875328117;5262.710550919698;4718.150732868074;4748.192807222763;4757.310190022445;4774.952250477486;4864.124457597631;4813.326134341195;4821.493743156971;4822.397200349957;4825.420949486067;4860.7326597037145;4632.837850675227;4718.551737584924;4742.027884283713;4770.61835053195;4829.203181475053;4774.976125119387;4786.904261914777;4791.065742180276;4794.640401969831;4794.9520504794855;4717;4752.287156926454;4761.0715910397485;4761.166795810719;4765.046990601893;5081.79672813087;5085.669431486978;5092.210707340369;5116.053530096944;5148.871278218037;5485.177223416479;5504.4770746778995;5508.091164957777;5518.365387980393;5559.972200139014;5446.591505637093;5519.475649813261;5523.558115350762;5524.116141417354;5612.887742245132;5213.2701421800975;5259.684418934838;5262.184361423985;5262.210668399733;5266.315379000705;5660.858478537987;5669.886602268014;5703.258576385043;5709.371969083398;5711.6858572778065;5370.758315875795;5425.647332923348;5442.836714898559;5501.697406642593;5506.146547285177;5463.426340234298;5467.699276539749;5479.287692599936;5479.808206712746;5491.039068163135;5449.727513624303;5452.700101494376;5454.854480559127;5472.370677372153;5509.807156749494;5381.139017757218;5573.693446860461;5591.10542313228;5661.971690141605;5670.489655930986;4278.44380230568;4288.48538175421;4293.549177336397;4299.914001719948;4330.523642399334;3738.7009039277336;3848;3853.8073096345634;3874.9031274217805;3895.3377925752125;5205.427402985669;5223.843284701465;5226.503482169188;5258.07983602868;5263.6315457918345;5564.33228012641;5599.636023658449;5609.382967873531;5612.579056570774;5620.63465874725;5155.407128180233;5235.554977826851;5291.7354132294;5303.204519322133;5309.3894202166475;4792.904141917142;4804.447488538793;4805.038992201574;4832.782524786393;4853.878653033702;5701.087825947829;5705.914411283834;5723.170140329712;5726.924916308027;5772.740226689809;5429.077056900257;5522.088855338824;5543.196236545759;5544.584156188302;5573.7213139343685;5726.828195154152;5731.914021289767;5745.425457454221;5756.740946657326;5781.94218057814;5432.239486471976;5476.17857321405;5481.177823326373;5481.671099734029;5486.917696234639;5479.342478902558;5563.916541251803;5564.360098588714;5570.136628822539;5579.972100139474;5445.40100588927;5461.890762184655;5462.6995515247045;5467.20725494809;5467.343918729778;5412.539934105645;5415.83752487426;5422.61723260566;5423.078076726887;5450;5363.758630861698;5389.892202156013;5416.431274716098;5447.264619276347;5453.400125986218;5443.59173062014;5473.972630136824;5502.862428439321;5514.338279406497;5526.06056970308;5273.52538271542;5306.734663266899;5334.013207556614;5362.785488580413;5375.838724838261
02:15:52 INFO - PROCESS | 10948 | |1;ext.html;541.9132938729804;549.8131679778935;567.1011446856731;576.5589324167013;594.6877889108217;39434.80282598587;39442.40836387453;39530.20939581214;39627.20745585087;39692.60307396925;41097.383539246934;41789.164216715646;41864.162716745646;41898;41955.16089678204;8631.093735157812;8729.519876406826;8777.561121943909;8827.514486703229;8832.867506987368;8563.186497282748;8680.218780309771;8690.174433428814;8699.217070463657;8701.869471957925;8896.199342059213;8953.776155596097;8965.417247878868;8968.148025937526;8976.281897448222;8836.823263534725;8898.199162075412;8901;8907.376483646147;8912.420692655021;8788.209061184523;8868.645254189825;8905.73282801517;8909.509976951265;8916.554172291424;41406.79296603498;42122.578774212176;42156.57843421588;42190.78904605488;42262.57737422648;3663.8900832974787;3700.7409481336317;3761.4169803680475;3856.730028897978;4172.520160181588;31333.686663133303;31800.84099579487;31814.363712725848;31979.680203197902;33181.17047073819;4366.56334366564;4395;4439.245328294198;4471.8434854779925;4615.515370886076;219681;221141;221441;221491;221601;53732;54874;54884.451155488736;54988.45011549913;55011.17483237755;61914;62080.689596551725;62139.689301553204;62162.0675689865;62224.37775622276;15110;15144.54566363011;15171.317290721943;15190.240487975558;15196.848031519765;11901.345426001653;11917.582884598998;11926;11940.283582985048;11947.522099116111;17877.29411047379;19428.855474089723;19439.319623813382;19545.706814397796;19730.70403943942;5484.314460692413;7588.696452141963;7761.379089672812;7764.922350776533;7812.960935195288;1020.1787561013456;1094.6223552874246;1114.554178328675;1122.315387613555;1129.8531190945125;30483.39033219323;30615.2346191347;31006.22484437907;32096;32245.193870152965;1088.8149014667526;1105.5135740274254;1115.2137742891243;1174.9823752643717;1220.7741567809983;16230.431934882223;16464.685333906302;16653.91673041627;16703.916480417764;16857.241424135944;416206;420155;421059;422747;423282;55642.16536751952;57041.71479142578;57046.42953570494;57144;57233;1125.7579620381657;1352.1481466675932;1387.1676993803637;1413.5971248194421;1415.3913817058558;28713.85643071771;29913;30043.098707038826;31813.840930796123;32150.35699286048;45862.77068614635;46539.76730116328;46540.7672961633;46550.53449465462;46566.767166163954;255165;260626;262905;263177;263381;30032.84983575068;35508.289834203686;35909.64090359167;36082;36519.81740091283;41862.581374185866;42345.576544234165;42491.36262955996;42740.145197096506;42894.78552607217;35571.57713691423;35750.642493575775;36346.27307453889;36738.63261367352;39597.80201098976;37778.43332350072;38410;38468;38618.42072368973;39557.40663890102;39440.60559394484;39758.80120599378;40610.39084413795;40767.59232407757;40808.18383632251;31547.684523154476;33160;35558;35730;36261.81869090637;27238.72761272441;27614.447711045264;27693;27829.133112034084;27872.860635696692
02:15:52 INFO - PROCESS | 10948 | |2;jquery.html;373.2125215794674;373.65623626263834;378.34923930838966;379.4497977931998;382.14209100569224;18550.536236594075;19129.330473433416;19442.708359374603;19543.609127817435;19574.510637234078;17629.382971596;17640.558986025324;18125.728114078265;18128.093595320246;18154.636907261847;5169.48305169482;5311.203319502067;5335.413104558495;5350.946490535103;5366.838994830161;3750.9812450937843;5257.23770053342;5599.132134519135;5808.4481974212595;5818.505427038707;5797.507211886995;5807.912881306784;5834.416558344153;5836.795712150076;5843.970780146094;5393.325834270716;5599.440055994409;5602;5608.523275521586;5779.335376431701;3626.274745050974;5354.785808567653;5431.646942948696;5551.861203469905;5570.053090974544;13264.602061938062;13352.465901363934;13375.933120334434;14862.777058344134;22005.779942200534;2121.4378189779723;2242.136777340719;2437.585610446228;2713.348796288896;3005.6242969628797;10208.846867296996;10514.842277365846;10523.210759193014;10623.946880265627;11191.552337906474;1906.1327096171208;1946.6496030714466;1966.1840336260434;2014.3755435814944;2044.580860923507;69657;73970;74742.25257747408;78915.21084789194;82425.9999999994;10109.797804043877;10355.17158627308;10443.477826108665;10648.14814814813;10839.187060970458;14583.635409114644;14668.853311466748;14671.926640366943;14689.632759180893;14692.559223223321;7716.459847810712;7943.920560794318;7953.443258971816;8193.549354785544;8195.180481951757;7719.614019299012;7841.607919603997;7861.921380786233;7925.603719813987;7945.086315073725;4572.314152877095;4587.9541204588195;4600.815967361335;4624.3294722265755;4640.512746161672;1736.7394890766486;1850.851931845476;1925.422373288008;2960.4671159191553;3090.7836451448634;880.4585180114311;992.0872797026608;1009.8182327181031;1098.0995583621514;1098.3300186885992;17708.203130859143;18435.170417331254;18441.446756597325;18535.258589656263;19113.33103341404;485.461138136668;499.98000079996393;501.24812780828756;501.7541404711665;503;6220.502359811204;6351.491880649537;6436.903446448307;6651.966740166365;6685.966570167118;474004;481697;496635;499232;516205;54987.72506137444;84445.57777211074;87587.56206218927;88819;90247.54876225708;514.0746656019151;516.042740715974;519.9116150254466;522.6002108387087;522.6863881670967;11019.338839669645;11174.217804753915;11193.720156995814;11195.944020279847;11213.15901307389;37963.620363796006;38057.238855223295;38062;38218.42672359861;39076.6092339073;53578.464215357344;53632.46367536275;53673;53889.191662125886;54589.45410546003;8337.874931875906;8479.830403392021;8661.566921653766;8703.47779133254;8764.737057888273;9440.433573985583;10413.791724165625;12663.683407914876;13061.477540898257;13403.597892063253;10932.617358392417;11302.773944520899;11895.464704088165;11898.405079745806;11911.106666999836;11466.541338346706;11468.139889508153;11570.652880413601;11644.184907056424;11768.235064720766;11635.76728465409;11927.701807454883;12108.697282567653;12112.152149349813;12113.515459381879;8060.758177254692;8114;8156.877646835421;8361.205685459872;8507.234348908629;11184;11410.771784564096;11417.086633069168;11449.313041217554;11657.183997120459
02:15:52 INFO - PROCESS | 10948 | |3;mootools.html;1093.092733031584;1427.486105002199;1428.9071210371326;1583.3824808324748;1751.0981844350163;7150.284971502847;7303.342699157075;7311.305425984537;7323;7325.633718314083;7015.228324884271;7158.964205178967;7161.5345002574795;7162.283771622835;7172.96413517933;1890.5084677983687;1932.5748335366268;2194.615942210115;2242.6523888797224;2274.6701728249395;2202.2512345802425;2219.556088782242;2219.5671843990426;2220.245116660335;2222.055626358799;2113.947151321214;2138.5829763196184;2148.795864392888;2222.866628002317;2224.7552769195377;2207.834412419059;2222.055626358799;2230.721159855018;2234.8100411464966;2235.329401179648;2235.3294011796397;2254.1546919905036;2263.4115130066302;2264.230161745015;2266.3427605994243;7318.3047610476915;7399.297066778701;7405.370543503808;7422.331990120861;7437.3306402423505;4686.601638860701;4753.382060332135;4759.738214398207;4810.062037902575;4811.855644330676;3131.906042818719;3161.6996385343587;3343.1976325681903;3365.512000759876;3370.174307294704;1046.0428707732415;1049.595905576351;1083.3554035348955;1109.3787479011698;1123.6966019174859;9856.211503079736;9968.750781230454;10016.54925528353;10025.498725063791;10037.69886903394;4167.229062623424;4286.185624731291;4317.84887528935;4345.348197770297;4382.2112019836095;8585.098564650747;8627.309815214769;8629.568521573896;8635;8711.128887111237;4815.566599006106;4819.807207711722;4833.202521583899;4835.419749630067;4838.395200599925;3778.0932576182067;4284.335927931175;4357.237483440385;4373.6282415994365;4458.621017213508;3504.9649503505148;3560.483729859156;3581.606023337431;3586.4620306954166;3587.7847329160336;1232.186756740547;1246.1401632873287;1250.6248125562477;1252.5303011370736;1253.4986005597834;1087.8912108789216;1101.1631160318057;1108.9057430118369;1297.9675508112184;1378.7242551489742;6910.44716422685;7044.330788575077;7069.151701795715;7078.186008608973;7114.253003434668;485.87610159409127;493.2453346380044;493.6371766751435;493.6815753838754;497.6367251906129;5530.806421775219;5550.7779688812;5551.9722401387735;5565.610407271533;5586.91619625706;8614.18165274298;8679.17547832955;8873.689420870238;8980.371374003887;9104.13510716481;8820.162084601952;8852.114788521225;8920.509371984603;8920.776980575538;8923.41997770143;6490.4807615390655;6606.339366063356;6616.900746488806;7040.295970402919;7043.68303426347;6909.412699920362;6958.478114141561;6994.2306346302885;7009.894851577333;7034.788956331114;7670.386369090348;7907.367410607023;7990.800229994296;7991.28078472917;8060.193980601893;7891.684332626631;8218.589070546568;8229.95885020571;8237.958810205912;8241.587920603826;6135.907961380493;6801.18385793708;6986.510944233854;7149.785506434815;7272.563646181246;7108.822279443055;7154.320339567733;7168.283171682999;7182.317679820409;7204.927950720636;6396.744130234739;6405.775797847053;6420.06908998202;6581.703823328057;6587.209534855848;6523.706433210422;6556.770513032021;6611.371919667624;6624.701888415129;6634.502412318999;6854.383105520527;6868.313168683291;6880.65596720152;6892.517523773287;6922.861542769016;6283.874322513616;6465.353464653497;6480.643564603992;6484.157059582224;6492.967535162294;6492.188476440445;6498.3826536478955;6512.706928188148;6530.934690653033;6535.117759102651
02:15:52 INFO - PROCESS | 10948 | |4;prototype.html;317.46824069683277;321.1617677860784;344.9275652113056;346.18818869750436;346.6983724159981;5970.373110823361;5978.8804223915495;5980.521558275338;6034.4568988791;6061.696915154241;5926.674032928187;5943.3462319144855;5947.4052594740615;5954.612950158236;5957.553183511243;4318.913621727564;4443.200223959702;4524.276115821469;4527.705699129554;4571.817127314904;4549.886252843672;4552.157850797596;4554.544545545452;4558.566936141061;4563.703359281636;4520.68355215135;4522.3216517522305;4524.11779702958;4528.230200865844;4532.592066713995;4320.092780516095;4425.468943726757;4509.1883460977015;4512.729236245836;4553.066621342617;4034.253663072341;4049.8582549610915;4050.4936882889638;4060;4065.1666408386504;5761.164631128463;5761.711914404305;5763.5101016413655;5778.653280803165;5783.334916484616;5292.444293349181;5305.973470132624;5308.734563271821;5310.336207974004;5313.7608807603365;6224.502039836848;6230.532710046719;6233.750649973996;6237.812865614039;6238.251409830849;4396.599228528703;4451.666125040635;4454.30958201476;4478.0596074824325;4485.529019452943;6479.1901012373455;6513.055606936968;6513.250976137758;6515.837104072436;6516.696660667838;4590.701604395704;4592.471865735416;4593.954060459419;4599.6090332321455;4602.263637817933;4637.350770892078;4645.628349732014;4647.256438969748;4652.883677908079;4654.2785868190485;5295.391030031518;5296.947030529723;5300.3639563252655;5307.363116426053;5311.309529761106;6125.418085281891;6280.874382512416;6308.400701933309;6309.842253943688;6316.242050953915;1579.33667859497;1631.0947424179694;1641.253229780447;1644.5559698881234;1648.7197176480026;983.1201075037801;1041.2971244409994;1087.6138970665459;1117.4301106435776;1120.2718233148519;5782.508486778587;5802.390748971382;5812.738426770806;5917.52659787216;5931.110333450017;6377.266614339411;6382.4255816975765;6383.680815959184;6390.7443702251385;6402.48780097591;5843.649381037151;5889.646621202742;5902.61632993854;5904.202932604129;5906.763729450774;3401.5067815166663;3423.17843717511;3428.5885693716914;3432.5194472773833;3439.9828000860334;6422.4862011039;6528.510361722795;6586.637734924625;6598.37315455031;6602.60384376939;6459.09572659828;6494.383033611799;6501.414872661483;6507.479401647857;6511.381418765304;6573.835654108686;6589.308122647149;6592.472602191813;6597.934020659828;6598;6351.491880649629;6351.68241587928;6366;6369.9681501592195;6370.522210834113;6133.815985520441;6281.874362512633;6296.024116261987;6296.968515157395;6310.368963103653;6552.8361790955605;6581.177352830896;6583.078369028244;6597.27429982692;6599.373059559334;4486.955130448654;4495.617872480745;4497.662675299301;4512.435945506812;4527.185106680829;6328.272248691275;6339.936600633934;6376.139221205078;6420.165378500765;6446.8388290293115;6147.047207682816;6175.228096487939;6186.4122908325435;6198.597091189058;6229.190205273286;6010.849728756816;6147.262328520427;6149.631022138686;6151.169592105009;6163.322034576104;6026.186464827192;6027.57806953509;6042.607230530001;6053.122297266959;6053.485453736305;6182.690865456799;6183.598066125687;6194.318624951342;6197.287311959182;6197.4422301991235;5883.823485295276;5997.430244126801;6015.639061656315;6017.247844019497;6027.397260273938
02:15:52 INFO - PROCESS | 10948 | |5;yui.html;729.7664747280869;752.8870669399589;754.3964828137489;792.9405294602899;804.987925181122;14203.857961420383;14390.352434140463;14449.63875903103;14490.5652830415;14527.709445811091;15541.766873496907;15561.299741511632;15672.294746736396;15760.605984850385;15776.368945242206;566.3119310038303;843.2326582809629;851.5401683091123;853.0744142605281;856.400519636254;870.6996086350199;874.1957399192758;877.1228771228771;880.0627331891548;882.8057827277988;896.7399454158286;901.9549022548879;902.1024081039375;902.2285945516587;902.6795487601905;597.1490625858156;882.3999680217449;894.7226359828474;895.3642913531401;896.551724137931;645.7287939065603;647.3009150117908;647.974081036758;649.191756263455;657.7204688007625;14253;14327.283635818167;14349;14359.282035898163;14360.138391696531;13469.528566500223;13685.110467819659;13861.722765544733;13896.305184740824;14004.47695567014;11482.425878706032;11666.533338666528;11693.649190524298;11703.648890533297;11797.17419780607;3669.486271921933;3708.87018954338;3730.7388482806214;3733.8693145739767;3767.2088861339153;57545.69817207307;58210.79840608765;58740.412595874346;58891.41108588902;59602.40397596012;10921.235513513977;10997.54904392863;11034.062104721188;11072.557097716;11148.888511114785;19440.611187776165;19577;19602.70595941062;19617.509562261057;19651.508712282022;8123.268905798388;8138.104808471064;8173.713920012771;8306;8678.739637810875;4862.992251221411;4877.609791216694;4909.803607855646;4914.99596641665;4986.576141027981;3378.1554611347165;3398.966010339865;3414.0611331883433;3418.1967237699123;3422.0418282880833;533.2561077297149;577.6043410263983;595.5265563876728;596.3380647481292;608.4888693497395;646.9902951455732;655.6918248423328;728.2717282717283;769.0617446714999;796.1083586383172;9350.766230844147;9846.310758246997;9904.306698531178;9973.601055957826;10057.69826905194;734.7795661301695;736.8968344431784;755.1881727143233;756.640595717041;792.136571137463;4418.33724941255;4603.700759450625;4618.053299073682;4647.233206520954;4681.695689780221;58383;58798.11802822961;58802;59275.70362148248;59464.40535594675;59562;60590.091148632804;60756.392436075956;61081.389186108456;61567;52415.21377179345;52581.737091315066;53053;53452;54493.727531362885;9100.635974560944;9276.211522020703;9310.44137351734;9395;9438;38900.80549597347;39128.41307380335;39196.41205381865;40950.385744213265;41113;48123;52103.47896520986;52763.944721106134;53116.46883531115;53675;11249.943750281196;11374.20380573352;11481.540738370706;11548.307101573933;11555.246284606457;12447.502099916264;12807.807882881578;12849.164804287691;12950.870491295344;13516.594502164951;11617.767644647229;11648.94175529117;11750.059995200534;11807.940960295144;12118.752289218843;12135.575254866037;12266.386680665753;12266.4480098394;12386.938065309616;12465;11079.72300692489;11080.778384432428;11210.27133236337;11331.943340283246;11386.430678465878;9906.900930990598;10349.896501034893;10359.119474844421;10483.633072842415;10618.946905265424;10135.594576217163;10300.536475858455;10375.066244038073;10406.791864162524;10425.218108642033
02:15:52 INFO - PROCESS | 10948 | __end_tp_report
02:15:52 INFO - PROCESS | 10948 | __start_cc_report
02:15:52 INFO - PROCESS | 10948 | _x_x_mozilla_cycle_collect,1160
02:15:52 INFO - PROCESS | 10948 | __end_cc_report
02:15:52 INFO - PROCESS | 10948 | __startTimestamp1459242952497__endTimestamp
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | ------- Summary: start -------
02:15:52 INFO - PROCESS | 10948 | Number of tests: 6
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#0] dojo.html Cycles:165 Average:5170.89 Median:5381.14 stddev:560.06 (10.4%) stddev-sans-first:536.47
02:15:52 INFO - PROCESS | 10948 | Values: 3048.8 3068.8 3103.0 3107.8 3134.7 5124.6 5174.9 5184.4 5187.2 5207.6 5199.1 5229.4 5239.4 5249.9 5262.7 4718.2 4748.2 4757.3 4775.0 4864.1 4813.3 4821.5 4822.4 4825.4 4860.7 4632.8 4718.6 4742.0 4770.6 4829.2 4775.0 4786.9 4791.1 4794.6 4795.0 4717.0 4752.3 4761.1 4761.2 4765.0 5081.8 5085.7 5092.2 5116.1 5148.9 5485.2 5504.5 5508.1 5518.4 5560.0 5446.6 5519.5 5523.6 5524.1 5612.9 5213.3 5259.7 5262.2 5262.2 5266.3 5660.9 5669.9 5703.3 5709.4 5711.7 5370.8 5425.6 5442.8 5501.7 5506.1 5463.4 5467.7 5479.3 5479.8 5491.0 5449.7 5452.7 5454.9 5472.4 5509.8 5381.1 5573.7 5591.1 5662.0 5670.5 4278.4 4288.5 4293.5 4299.9 4330.5 3738.7 3848.0 3853.8 3874.9 3895.3 5205.4 5223.8 5226.5 5258.1 5263.6 5564.3 5599.6 5609.4 5612.6 5620.6 5155.4 5235.6 5291.7 5303.2 5309.4 4792.9 4804.4 4805.0 4832.8 4853.9 5701.1 5705.9 5723.2 5726.9 5772.7 5429.1 5522.1 5543.2 5544.6 5573.7 5726.8 5731.9 5745.4 5756.7 5781.9 5432.2 5476.2 5481.2 5481.7 5486.9 5479.3 5563.9 5564.4 5570.1 5580.0 5445.4 5461.9 5462.7 5467.2 5467.3 5412.5 5415.8 5422.6 5423.1 5450.0 5363.8 5389.9 5416.4 5447.3 5453.4 5443.6 5474.0 5502.9 5514.3 5526.1 5273.5 5306.7 5334.0 5362.8 5375.8
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#1] ext.html Cycles:180 Average:47826.08 Median:39543.81 stddev:82363.19 (208.3%) stddev-sans-first:82517.72
02:15:52 INFO - PROCESS | 10948 | Values: 541.9 549.8 567.1 576.6 594.7 39434.8 39442.4 39530.2 39627.2 39692.6 41097.4 41789.2 41864.2 41898.0 41955.2 8631.1 8729.5 8777.6 8827.5 8832.9 8563.2 8680.2 8690.2 8699.2 8701.9 8896.2 8953.8 8965.4 8968.1 8976.3 8836.8 8898.2 8901.0 8907.4 8912.4 8788.2 8868.6 8905.7 8909.5 8916.6 41406.8 42122.6 42156.6 42190.8 42262.6 3663.9 3700.7 3761.4 3856.7 4172.5 31333.7 31800.8 31814.4 31979.7 33181.2 4366.6 4395.0 4439.2 4471.8 4615.5 219681.0 221141.0 221441.0 221491.0 221601.0 53732.0 54874.0 54884.5 54988.5 55011.2 61914.0 62080.7 62139.7 62162.1 62224.4 15110.0 15144.5 15171.3 15190.2 15196.8 11901.3 11917.6 11926.0 11940.3 11947.5 17877.3 19428.9 19439.3 19545.7 19730.7 5484.3 7588.7 7761.4 7764.9 7813.0 1020.2 1094.6 1114.6 1122.3 1129.9 30483.4 30615.2 31006.2 32096.0 32245.2 1088.8 1105.5 1115.2 1175.0 1220.8 16230.4 16464.7 16653.9 16703.9 16857.2 416206.0 420155.0 421059.0 422747.0 423282.0 55642.2 57041.7 57046.4 57144.0 57233.0 1125.8 1352.1 1387.2 1413.6 1415.4 28713.9 29913.0 30043.1 31813.8 32150.4 45862.8 46539.8 46540.8 46550.5 46566.8 255165.0 260626.0 262905.0 263177.0 263381.0 30032.8 35508.3 35909.6 36082.0 36519.8 41862.6 42345.6 42491.4 42740.1 42894.8 35571.6 35750.6 36346.3 36738.6 39597.8 37778.4 38410.0 38468.0 38618.4 39557.4 39440.6 39758.8 40610.4 40767.6 40808.2 31547.7 33160.0 35558.0 35730.0 36261.8 27238.7 27614.4 27693.0 27829.1 27872.9
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#2] jquery.html Cycles:180 Average:27755.45 Median:19222.07 stddev:81197.02 (422.4%) stddev-sans-first:81398.77
02:15:52 INFO - PROCESS | 10948 | Values: 373.2 373.7 378.3 379.4 382.1 18550.5 19129.3 19442.7 19543.6 19574.5 17629.4 17640.6 18125.7 18128.1 18154.6 5169.5 5311.2 5335.4 5350.9 5366.8 3751.0 5257.2 5599.1 5808.4 5818.5 5797.5 5807.9 5834.4 5836.8 5844.0 5393.3 5599.4 5602.0 5608.5 5779.3 3626.3 5354.8 5431.6 5551.9 5570.1 13264.6 13352.5 13375.9 14862.8 22005.8 2121.4 2242.1 2437.6 2713.3 3005.6 10208.8 10514.8 10523.2 10623.9 11191.6 1906.1 1946.6 1966.2 2014.4 2044.6 69657.0 73970.0 74742.3 78915.2 82426.0 10109.8 10355.2 10443.5 10648.1 10839.2 14583.6 14668.9 14671.9 14689.6 14692.6 7716.5 7943.9 7953.4 8193.5 8195.2 7719.6 7841.6 7861.9 7925.6 7945.1 4572.3 4588.0 4600.8 4624.3 4640.5 1736.7 1850.9 1925.4 2960.5 3090.8 880.5 992.1 1009.8 1098.1 1098.3 17708.2 18435.2 18441.4 18535.3 19113.3 485.5 500.0 501.2 501.8 503.0 6220.5 6351.5 6436.9 6652.0 6686.0 474004.0 481697.0 496635.0 499232.0 516205.0 54987.7 84445.6 87587.6 88819.0 90247.5 514.1 516.0 519.9 522.6 522.7 11019.3 11174.2 11193.7 11195.9 11213.2 37963.6 38057.2 38062.0 38218.4 39076.6 53578.5 53632.5 53673.0 53889.2 54589.5 8337.9 8479.8 8661.6 8703.5 8764.7 9440.4 10413.8 12663.7 13061.5 13403.6 10932.6 11302.8 11895.5 11898.4 11911.1 11466.5 11468.1 11570.7 11644.2 11768.2 11635.8 11927.7 12108.7 12112.2 12113.5 8060.8 8114.0 8156.9 8361.2 8507.2 11184.0 11410.8 11417.1 11449.3 11657.2
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#3] mootools.html Cycles:180 Average:5249.21 Median:6401.26 stddev:2668.49 (41.7%) stddev-sans-first:2657.68
02:15:52 INFO - PROCESS | 10948 | Values: 1093.1 1427.5 1428.9 1583.4 1751.1 7150.3 7303.3 7311.3 7323.0 7325.6 7015.2 7159.0 7161.5 7162.3 7173.0 1890.5 1932.6 2194.6 2242.7 2274.7 2202.3 2219.6 2219.6 2220.2 2222.1 2113.9 2138.6 2148.8 2222.9 2224.8 2207.8 2222.1 2230.7 2234.8 2235.3 2235.3 2254.2 2263.4 2264.2 2266.3 7318.3 7399.3 7405.4 7422.3 7437.3 4686.6 4753.4 4759.7 4810.1 4811.9 3131.9 3161.7 3343.2 3365.5 3370.2 1046.0 1049.6 1083.4 1109.4 1123.7 9856.2 9968.8 10016.5 10025.5 10037.7 4167.2 4286.2 4317.8 4345.3 4382.2 8585.1 8627.3 8629.6 8635.0 8711.1 4815.6 4819.8 4833.2 4835.4 4838.4 3778.1 4284.3 4357.2 4373.6 4458.6 3505.0 3560.5 3581.6 3586.5 3587.8 1232.2 1246.1 1250.6 1252.5 1253.5 1087.9 1101.2 1108.9 1298.0 1378.7 6910.4 7044.3 7069.2 7078.2 7114.3 485.9 493.2 493.6 493.7 497.6 5530.8 5550.8 5552.0 5565.6 5586.9 8614.2 8679.2 8873.7 8980.4 9104.1 8820.2 8852.1 8920.5 8920.8 8923.4 6490.5 6606.3 6616.9 7040.3 7043.7 6909.4 6958.5 6994.2 7009.9 7034.8 7670.4 7907.4 7990.8 7991.3 8060.2 7891.7 8218.6 8230.0 8238.0 8241.6 6135.9 6801.2 6986.5 7149.8 7272.6 7108.8 7154.3 7168.3 7182.3 7204.9 6396.7 6405.8 6420.1 6581.7 6587.2 6523.7 6556.8 6611.4 6624.7 6634.5 6854.4 6868.3 6880.7 6892.5 6922.9 6283.9 6465.4 6480.6 6484.2 6493.0 6492.2 6498.4 6512.7 6530.9 6535.1
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#4] prototype.html Cycles:180 Average:5220.94 Median:5937.23 stddev:1538.66 (25.9%) stddev-sans-first:1498.32
02:15:52 INFO - PROCESS | 10948 | Values: 317.5 321.2 344.9 346.2 346.7 5970.4 5978.9 5980.5 6034.5 6061.7 5926.7 5943.3 5947.4 5954.6 5957.6 4318.9 4443.2 4524.3 4527.7 4571.8 4549.9 4552.2 4554.5 4558.6 4563.7 4520.7 4522.3 4524.1 4528.2 4532.6 4320.1 4425.5 4509.2 4512.7 4553.1 4034.3 4049.9 4050.5 4060.0 4065.2 5761.2 5761.7 5763.5 5778.7 5783.3 5292.4 5306.0 5308.7 5310.3 5313.8 6224.5 6230.5 6233.8 6237.8 6238.3 4396.6 4451.7 4454.3 4478.1 4485.5 6479.2 6513.1 6513.3 6515.8 6516.7 4590.7 4592.5 4594.0 4599.6 4602.3 4637.4 4645.6 4647.3 4652.9 4654.3 5295.4 5296.9 5300.4 5307.4 5311.3 6125.4 6280.9 6308.4 6309.8 6316.2 1579.3 1631.1 1641.3 1644.6 1648.7 983.1 1041.3 1087.6 1117.4 1120.3 5782.5 5802.4 5812.7 5917.5 5931.1 6377.3 6382.4 6383.7 6390.7 6402.5 5843.6 5889.6 5902.6 5904.2 5906.8 3401.5 3423.2 3428.6 3432.5 3440.0 6422.5 6528.5 6586.6 6598.4 6602.6 6459.1 6494.4 6501.4 6507.5 6511.4 6573.8 6589.3 6592.5 6597.9 6598.0 6351.5 6351.7 6366.0 6370.0 6370.5 6133.8 6281.9 6296.0 6297.0 6310.4 6552.8 6581.2 6583.1 6597.3 6599.4 4487.0 4495.6 4497.7 4512.4 4527.2 6328.3 6339.9 6376.1 6420.2 6446.8 6147.0 6175.2 6186.4 6198.6 6229.2 6010.8 6147.3 6149.6 6151.2 6163.3 6026.2 6027.6 6042.6 6053.1 6053.5 6182.7 6183.6 6194.3 6197.3 6197.4 5883.8 5997.4 6015.6 6017.2 6027.4
02:15:52 INFO - PROCESS | 10948 |
02:15:52 INFO - PROCESS | 10948 | [#5] yui.html Cycles:180 Average:15416.72 Median:26493.00 stddev:18237.98 (68.8%) stddev-sans-first:18255.79
02:15:52 INFO - PROCESS | 10948 | Values: 729.8 752.9 754.4 792.9 805.0 14203.9 14390.4 14449.6 14490.6 14527.7 15541.8 15561.3 15672.3 15760.6 15776.4 566.3 843.2 851.5 853.1 856.4 870.7 874.2 877.1 880.1 882.8 896.7 902.0 902.1 902.2 902.7 597.1 882.4 894.7 895.4 896.6 645.7 647.3 648.0 649.2 657.7 14253.0 14327.3 14349.0 14359.3 14360.1 13469.5 13685.1 13861.7 13896.3 14004.5 11482.4 11666.5 11693.6 11703.6 11797.2 3669.5 3708.9 3730.7 3733.9 3767.2 57545.7 58210.8 58740.4 58891.4 59602.4 10921.2 10997.5 11034.1 11072.6 11148.9 19440.6 19577.0 19602.7 19617.5 19651.5 8123.3 8138.1 8173.7 8306.0 8678.7 4863.0 4877.6 4909.8 4915.0 4986.6 3378.2 3399.0 3414.1 3418.2 3422.0 533.3 577.6 595.5 596.3 608.5 647.0 655.7 728.3 769.1 796.1 9350.8 9846.3 9904.3 9973.6 10057.7 734.8 736.9 755.2 756.6 792.1 4418.3 4603.7 4618.1 4647.2 4681.7 58383.0 58798.1 58802.0 59275.7 59464.4 59562.0 60590.1 60756.4 61081.4 61567.0 52415.2 52581.7 53053.0 53452.0 54493.7 9100.6 9276.2 9310.4 9395.0 9438.0 38900.8 39128.4 39196.4 40950.4 41113.0 48123.0 52103.5 52763.9 53116.5 53675.0 11249.9 11374.2 11481.5 11548.3 11555.2 12447.5 12807.8 12849.2 12950.9 13516.6 11617.8 11648.9 11750.1 11807.9 12118.8 12135.6 12266.4 12266.4 12386.9 12465.0 11079.7 11080.8 11210.3 11331.9 11386.4 9906.9 10349.9 10359.1 10483.6 10618.9 10135.6 10300.5 10375.1 10406.8 10425.2
02:15:52 INFO - PROCESS | 10948 | -------- Summary: end --------
02:15:52 INFO - PROCESS | 10948 |
02:15:53 INFO - TEST-INFO | 10948: exit 0
02:15:53 INFO - TEST-OK | dromaeo_css | took 1111925ms
02:15:53 INFO - TEST-START | kraken
02:15:53 INFO - operating with platform_type : linux_
02:15:53 INFO - Initialising browser for kraken test...
02:15:53 INFO - TEST-INFO | started process 11132 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYUcyiv/profile http://localhost:54727/getInfo.html)
02:15:57 INFO - PROCESS | 11132 | __metrics Screen width/height:1600/1200
02:15:57 INFO - PROCESS | 11132 | colorDepth:24
02:15:57 INFO - PROCESS | 11132 | Browser inner width/height: 1024/697
02:15:57 INFO - PROCESS | 11132 | __metrics
02:15:58 ERROR - PROCESS | 11132 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
02:15:58 INFO - PROCESS | 11132 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code.
02:15:59 INFO - TEST-INFO | 11132: exit 0
02:15:59 INFO - Browser initialized.
02:15:59 INFO - Running cycle 1/1 for kraken test...
02:15:59 INFO - TEST-INFO | started process 11221 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYUcyiv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
02:16:11 INFO - PROCESS | 11221 | RSS: Main: 153968640
02:16:11 INFO - PROCESS | 11221 |
02:16:14 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54727/tests/kraken/driver.html?testName=audio-beat-detection)
02:16:14 INFO - PROCESS | 11221 | RSS: Main: 194682880
02:16:14 INFO - PROCESS | 11221 |
02:16:17 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54727/tests/kraken/driver.html?testName=audio-dft)
02:16:17 INFO - PROCESS | 11221 | RSS: Main: 184143872
02:16:17 INFO - PROCESS | 11221 |
02:16:20 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54727/tests/kraken/driver.html?testName=audio-fft)
02:16:21 INFO - PROCESS | 11221 | RSS: Main: 168730624
02:16:21 INFO - PROCESS | 11221 |
02:16:23 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54727/tests/kraken/driver.html?testName=audio-oscillator)
02:16:24 INFO - PROCESS | 11221 | RSS: Main: 171474944
02:16:24 INFO - PROCESS | 11221 |
02:16:26 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54727/tests/kraken/driver.html?testName=imaging-gaussian-blur)
02:16:26 INFO - PROCESS | 11221 | RSS: Main: 172773376
02:16:26 INFO - PROCESS | 11221 |
02:16:29 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54727/tests/kraken/driver.html?testName=imaging-darkroom)
02:16:30 INFO - PROCESS | 11221 | RSS: Main: 173846528
02:16:30 INFO - PROCESS | 11221 |
02:16:33 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54727/tests/kraken/driver.html?testName=imaging-desaturate)
02:16:34 INFO - PROCESS | 11221 | RSS: Main: 174395392
02:16:34 INFO - PROCESS | 11221 |
02:16:37 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54727/tests/kraken/driver.html?testName=json-parse-financial)
02:16:37 INFO - PROCESS | 11221 | RSS: Main: 174505984
02:16:37 INFO - PROCESS | 11221 |
02:16:39 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54727/tests/kraken/driver.html?testName=json-stringify-tinderbox)
02:16:39 INFO - PROCESS | 11221 | RSS: Main: 184627200
02:16:39 INFO - PROCESS | 11221 |
02:16:41 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-aes)
02:16:42 INFO - PROCESS | 11221 | RSS: Main: 182865920
02:16:42 INFO - PROCESS | 11221 |
02:16:44 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-ccm)
02:16:44 INFO - PROCESS | 11221 | RSS: Main: 194965504
02:16:44 INFO - PROCESS | 11221 |
02:16:47 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
02:16:47 INFO - PROCESS | 11221 | RSS: Main: 200790016
02:16:47 INFO - PROCESS | 11221 |
02:16:50 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
02:16:50 INFO - PROCESS | 11221 | RSS: Main: 198955008
02:16:50 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | Cycle 1(1): loaded http://localhost:54727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54727/tests/kraken/driver.html?testName=ai-astar)
02:16:52 INFO - PROCESS | 11221 | RSS: Main: 262295552
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | __start_tp_report
02:16:52 INFO - PROCESS | 11221 | _x_x_mozilla_page_load
02:16:52 INFO - PROCESS | 11221 | _x_x_mozilla_page_load_details
02:16:52 INFO - PROCESS | 11221 | |i|pagename|runs|
02:16:52 INFO - PROCESS | 11221 | |0;ai-astar;108;109;105;110;110;112;99;110;109;110
02:16:52 INFO - PROCESS | 11221 | |1;audio-beat-detection;156;131;159;178;124;153;154;128;174;136
02:16:52 INFO - PROCESS | 11221 | |2;audio-dft;163;162;162;160;161;161;162;165;162;163
02:16:52 INFO - PROCESS | 11221 | |3;audio-fft;73;76;110;97;76;78;73;120;98;73
02:16:52 INFO - PROCESS | 11221 | |4;audio-oscillator;92;94;146;93;94;94;149;94;93;149
02:16:52 INFO - PROCESS | 11221 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;118;118
02:16:52 INFO - PROCESS | 11221 | |6;imaging-darkroom;146;147;145;146;146;147;146;146;146;167
02:16:52 INFO - PROCESS | 11221 | |7;imaging-desaturate;96;95;96;96;96;96;95;96;96;95
02:16:52 INFO - PROCESS | 11221 | |8;json-parse-financial;59;58;58;56;58;56;59;65;57;56
02:16:52 INFO - PROCESS | 11221 | |9;json-stringify-tinderbox;60;72;61;60;62;61;61;60;61;61
02:16:52 INFO - PROCESS | 11221 | |10;stanford-crypto-aes;78;79;81;80;79;79;87;79;80;78
02:16:52 INFO - PROCESS | 11221 | |11;stanford-crypto-ccm;119;112;116;110;117;125;119;109;111;121
02:16:52 INFO - PROCESS | 11221 | |12;stanford-crypto-pbkdf2;142;144;150;142;145;131;140;145;142;140
02:16:52 INFO - PROCESS | 11221 | |13;stanford-crypto-sha256-iterative;70;65;65;63;63;63;63;64;68;62
02:16:52 INFO - PROCESS | 11221 | __end_tp_report
02:16:52 INFO - PROCESS | 11221 | __start_cc_report
02:16:52 INFO - PROCESS | 11221 | _x_x_mozilla_cycle_collect,1100
02:16:52 INFO - PROCESS | 11221 | __end_cc_report
02:16:52 INFO - PROCESS | 11221 | __startTimestamp1459243012835__endTimestamp
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | ------- Summary: start -------
02:16:52 INFO - PROCESS | 11221 | Number of tests: 14
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:3.71 (3.4%) stddev-sans-first:3.93
02:16:52 INFO - PROCESS | 11221 | Values: 108.0 109.0 105.0 110.0 110.0 112.0 99.0 110.0 109.0 110.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:155.00 stddev:18.90 (12.2%) stddev-sans-first:19.89
02:16:52 INFO - PROCESS | 11221 | Values: 156.0 131.0 159.0 178.0 124.0 153.0 154.0 128.0 174.0 136.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41
02:16:52 INFO - PROCESS | 11221 | Values: 163.0 162.0 162.0 160.0 161.0 161.0 162.0 165.0 162.0 163.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#3] audio-fft Cycles:10 Average:87.40 Median:76.00 stddev:17.48 (23.0%) stddev-sans-first:17.74
02:16:52 INFO - PROCESS | 11221 | Values: 73.0 76.0 110.0 97.0 76.0 78.0 73.0 120.0 98.0 73.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:93.50 stddev:26.38 (28.2%) stddev-sans-first:27.18
02:16:52 INFO - PROCESS | 11221 | Values: 92.0 94.0 146.0 93.0 94.0 94.0 149.0 94.0 93.0 149.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71
02:16:52 INFO - PROCESS | 11221 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:146.00 stddev:6.63 (4.5%) stddev-sans-first:6.98
02:16:52 INFO - PROCESS | 11221 | Values: 146.0 147.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 167.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50
02:16:52 INFO - PROCESS | 11221 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.66 (4.6%) stddev-sans-first:2.80
02:16:52 INFO - PROCESS | 11221 | Values: 59.0 58.0 58.0 56.0 58.0 56.0 59.0 65.0 57.0 56.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:61.00 stddev:3.60 (5.9%) stddev-sans-first:3.76
02:16:52 INFO - PROCESS | 11221 | Values: 60.0 72.0 61.0 60.0 62.0 61.0 61.0 60.0 61.0 61.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.50 stddev:2.62 (3.3%) stddev-sans-first:2.68
02:16:52 INFO - PROCESS | 11221 | Values: 78.0 79.0 81.0 80.0 79.0 79.0 87.0 79.0 80.0 78.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:118.00 stddev:5.28 (4.5%) stddev-sans-first:5.48
02:16:52 INFO - PROCESS | 11221 | Values: 119.0 112.0 116.0 110.0 117.0 125.0 119.0 109.0 111.0 121.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:143.00 stddev:4.89 (3.4%) stddev-sans-first:5.18
02:16:52 INFO - PROCESS | 11221 | Values: 142.0 144.0 150.0 142.0 145.0 131.0 140.0 145.0 142.0 140.0
02:16:52 INFO - PROCESS | 11221 |
02:16:52 INFO - PROCESS | 11221 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:2.55 (3.9%) stddev-sans-first:1.80
02:16:52 INFO - PROCESS | 11221 | Values: 70.0 65.0 65.0 63.0 63.0 63.0 63.0 64.0 68.0 62.0
02:16:52 INFO - PROCESS | 11221 | -------- Summary: end --------
02:16:52 INFO - PROCESS | 11221 |
02:16:53 INFO - TEST-INFO | 11221: exit 0
02:16:53 INFO - TEST-OK | kraken | took 60455ms
02:16:53 INFO - SUITE-END | took 1172s
02:16:54 INFO - Completed test suite (00:19:32)
02:16:54 INFO - javascript benchmark
02:16:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3048.8323142227177, 3068.8312142832137, 3103.0380582019575, 3107.7979931304462, 3134.7335476484504, 5124.615653825968, 5174.870628234296, 5184.403793563736, 5187.247849061884, 5207.557357624606, 5199.064168449687, 5229.424763276046, 5239.449857764937, 5249.86875328117, 5262.710550919698, 4718.150732868074, 4748.192807222763, 4757.310190022445, 4774.952250477486, 4864.124457597631, 4813.326134341195, 4821.493743156971, 4822.397200349957, 4825.420949486067, 4860.7326597037145, 4632.837850675227, 4718.551737584924, 4742.027884283713, 4770.61835053195, 4829.203181475053, 4774.976125119387, 4786.904261914777, 4791.065742180276, 4794.640401969831, 4794.9520504794855, 4717.0, 4752.287156926454, 4761.0715910397485, 4761.166795810719, 4765.046990601893, 5081.79672813087, 5085.669431486978, 5092.210707340369, 5116.053530096944, 5148.871278218037, 5485.177223416479, 5504.4770746778995, 5508.091164957777, 5518.365387980393, 5559.972200139014, 5446.591505637093, 5519.475649813261, 5523.558115350762, 5524.116141417354, 5612.887742245132, 5213.2701421800975, 5259.684418934838, 5262.184361423985, 5262.210668399733, 5266.315379000705, 5660.858478537987, 5669.886602268014, 5703.258576385043, 5709.371969083398, 5711.6858572778065, 5370.758315875795, 5425.647332923348, 5442.836714898559, 5501.697406642593, 5506.146547285177, 5463.426340234298, 5467.699276539749, 5479.287692599936, 5479.808206712746, 5491.039068163135, 5449.727513624303, 5452.700101494376, 5454.854480559127, 5472.370677372153, 5509.807156749494, 5381.139017757218, 5573.693446860461, 5591.10542313228, 5661.971690141605, 5670.489655930986, 4278.44380230568, 4288.48538175421, 4293.549177336397, 4299.914001719948, 4330.523642399334, 3738.7009039277336, 3848.0, 3853.8073096345634, 3874.9031274217805, 3895.3377925752125, 5205.427402985669, 5223.843284701465, 5226.503482169188, 5258.07983602868, 5263.6315457918345, 5564.33228012641, 5599.636023658449, 5609.382967873531, 5612.579056570774, 5620.63465874725, 5155.407128180233, 5235.554977826851, 5291.7354132294, 5303.204519322133, 5309.3894202166475, 4792.904141917142, 4804.447488538793, 4805.038992201574, 4832.782524786393, 4853.878653033702, 5701.087825947829, 5705.914411283834, 5723.170140329712, 5726.924916308027, 5772.740226689809, 5429.077056900257, 5522.088855338824, 5543.196236545759, 5544.584156188302, 5573.7213139343685, 5726.828195154152, 5731.914021289767, 5745.425457454221, 5756.740946657326, 5781.94218057814, 5432.239486471976, 5476.17857321405, 5481.177823326373, 5481.671099734029, 5486.917696234639, 5479.342478902558, 5563.916541251803, 5564.360098588714, 5570.136628822539, 5579.972100139474, 5445.40100588927, 5461.890762184655, 5462.6995515247045, 5467.20725494809, 5467.343918729778, 5412.539934105645, 5415.83752487426, 5422.61723260566, 5423.078076726887, 5450.0, 5363.758630861698, 5389.892202156013, 5416.431274716098, 5447.264619276347, 5453.400125986218, 5443.59173062014, 5473.972630136824, 5502.862428439321, 5514.338279406497, 5526.06056970308, 5273.52538271542, 5306.734663266899, 5334.013207556614, 5362.785488580413, 5375.838724838261], "unit": "score", "name": "dojo.html", "value": 5134.936580355119}, {"lowerIsBetter": false, "replicates": [541.9132938729804, 549.8131679778935, 567.1011446856731, 576.5589324167013, 594.6877889108217, 39434.80282598587, 39442.40836387453, 39530.20939581214, 39627.20745585087, 39692.60307396925, 41097.383539246934, 41789.164216715646, 41864.162716745646, 41898.0, 41955.16089678204, 8631.093735157812, 8729.519876406826, 8777.561121943909, 8827.514486703229, 8832.867506987368, 8563.186497282748, 8680.218780309771, 8690.174433428814, 8699.217070463657, 8701.869471957925, 8896.199342059213, 8953.776155596097, 8965.417247878868, 8968.148025937526, 8976.281897448222, 8836.823263534725, 8898.199162075412, 8901.0, 8907.376483646147, 8912.420692655021, 8788.209061184523, 8868.645254189825, 8905.73282801517, 8909.509976951265, 8916.554172291424, 41406.79296603498, 42122.578774212176, 42156.57843421588, 42190.78904605488, 42262.57737422648, 3663.8900832974787, 3700.7409481336317, 3761.4169803680475, 3856.730028897978, 4172.520160181588, 31333.686663133303, 31800.84099579487, 31814.363712725848, 31979.680203197902, 33181.17047073819, 4366.56334366564, 4395.0, 4439.245328294198, 4471.8434854779925, 4615.515370886076, 219681.0, 221141.0, 221441.0, 221491.0, 221601.0, 53732.0, 54874.0, 54884.451155488736, 54988.45011549913, 55011.17483237755, 61914.0, 62080.689596551725, 62139.689301553204, 62162.0675689865, 62224.37775622276, 15110.0, 15144.54566363011, 15171.317290721943, 15190.240487975558, 15196.848031519765, 11901.345426001653, 11917.582884598998, 11926.0, 11940.283582985048, 11947.522099116111, 17877.29411047379, 19428.855474089723, 19439.319623813382, 19545.706814397796, 19730.70403943942, 5484.314460692413, 7588.696452141963, 7761.379089672812, 7764.922350776533, 7812.960935195288, 1020.1787561013456, 1094.6223552874246, 1114.554178328675, 1122.315387613555, 1129.8531190945125, 30483.39033219323, 30615.2346191347, 31006.22484437907, 32096.0, 32245.193870152965, 1088.8149014667526, 1105.5135740274254, 1115.2137742891243, 1174.9823752643717, 1220.7741567809983, 16230.431934882223, 16464.685333906302, 16653.91673041627, 16703.916480417764, 16857.241424135944, 416206.0, 420155.0, 421059.0, 422747.0, 423282.0, 55642.16536751952, 57041.71479142578, 57046.42953570494, 57144.0, 57233.0, 1125.7579620381657, 1352.1481466675932, 1387.1676993803637, 1413.5971248194421, 1415.3913817058558, 28713.85643071771, 29913.0, 30043.098707038826, 31813.840930796123, 32150.35699286048, 45862.77068614635, 46539.76730116328, 46540.7672961633, 46550.53449465462, 46566.767166163954, 255165.0, 260626.0, 262905.0, 263177.0, 263381.0, 30032.84983575068, 35508.289834203686, 35909.64090359167, 36082.0, 36519.81740091283, 41862.581374185866, 42345.576544234165, 42491.36262955996, 42740.145197096506, 42894.78552607217, 35571.57713691423, 35750.642493575775, 36346.27307453889, 36738.63261367352, 39597.80201098976, 37778.43332350072, 38410.0, 38468.0, 38618.42072368973, 39557.40663890102, 39440.60559394484, 39758.80120599378, 40610.39084413795, 40767.59232407757, 40808.18383632251, 31547.684523154476, 33160.0, 35558.0, 35730.0, 36261.81869090637, 27238.72761272441, 27614.447711045264, 27693.0, 27829.133112034084, 27872.860635696692], "unit": "score", "name": "ext.html", "value": 19119.279049658173}, {"lowerIsBetter": false, "replicates": [373.2125215794674, 373.65623626263834, 378.34923930838966, 379.4497977931998, 382.14209100569224, 18550.536236594075, 19129.330473433416, 19442.708359374603, 19543.609127817435, 19574.510637234078, 17629.382971596, 17640.558986025324, 18125.728114078265, 18128.093595320246, 18154.636907261847, 5169.48305169482, 5311.203319502067, 5335.413104558495, 5350.946490535103, 5366.838994830161, 3750.9812450937843, 5257.23770053342, 5599.132134519135, 5808.4481974212595, 5818.505427038707, 5797.507211886995, 5807.912881306784, 5834.416558344153, 5836.795712150076, 5843.970780146094, 5393.325834270716, 5599.440055994409, 5602.0, 5608.523275521586, 5779.335376431701, 3626.274745050974, 5354.785808567653, 5431.646942948696, 5551.861203469905, 5570.053090974544, 13264.602061938062, 13352.465901363934, 13375.933120334434, 14862.777058344134, 22005.779942200534, 2121.4378189779723, 2242.136777340719, 2437.585610446228, 2713.348796288896, 3005.6242969628797, 10208.846867296996, 10514.842277365846, 10523.210759193014, 10623.946880265627, 11191.552337906474, 1906.1327096171208, 1946.6496030714466, 1966.1840336260434, 2014.3755435814944, 2044.580860923507, 69657.0, 73970.0, 74742.25257747408, 78915.21084789194, 82425.9999999994, 10109.797804043877, 10355.17158627308, 10443.477826108665, 10648.14814814813, 10839.187060970458, 14583.635409114644, 14668.853311466748, 14671.926640366943, 14689.632759180893, 14692.559223223321, 7716.459847810712, 7943.920560794318, 7953.443258971816, 8193.549354785544, 8195.180481951757, 7719.614019299012, 7841.607919603997, 7861.921380786233, 7925.603719813987, 7945.086315073725, 4572.314152877095, 4587.9541204588195, 4600.815967361335, 4624.3294722265755, 4640.512746161672, 1736.7394890766486, 1850.851931845476, 1925.422373288008, 2960.4671159191553, 3090.7836451448634, 880.4585180114311, 992.0872797026608, 1009.8182327181031, 1098.0995583621514, 1098.3300186885992, 17708.203130859143, 18435.170417331254, 18441.446756597325, 18535.258589656263, 19113.33103341404, 485.461138136668, 499.98000079996393, 501.24812780828756, 501.7541404711665, 503.0, 6220.502359811204, 6351.491880649537, 6436.903446448307, 6651.966740166365, 6685.966570167118, 474004.0, 481697.0, 496635.0, 499232.0, 516205.0, 54987.72506137444, 84445.57777211074, 87587.56206218927, 88819.0, 90247.54876225708, 514.0746656019151, 516.042740715974, 519.9116150254466, 522.6002108387087, 522.6863881670967, 11019.338839669645, 11174.217804753915, 11193.720156995814, 11195.944020279847, 11213.15901307389, 37963.620363796006, 38057.238855223295, 38062.0, 38218.42672359861, 39076.6092339073, 53578.464215357344, 53632.46367536275, 53673.0, 53889.191662125886, 54589.45410546003, 8337.874931875906, 8479.830403392021, 8661.566921653766, 8703.47779133254, 8764.737057888273, 9440.433573985583, 10413.791724165625, 12663.683407914876, 13061.477540898257, 13403.597892063253, 10932.617358392417, 11302.773944520899, 11895.464704088165, 11898.405079745806, 11911.106666999836, 11466.541338346706, 11468.139889508153, 11570.652880413601, 11644.184907056424, 11768.235064720766, 11635.76728465409, 11927.701807454883, 12108.697282567653, 12112.152149349813, 12113.515459381879, 8060.758177254692, 8114.0, 8156.877646835421, 8361.205685459872, 8507.234348908629, 11184.0, 11410.771784564096, 11417.086633069168, 11449.313041217554, 11657.183997120459], "unit": "score", "name": "jquery.html", "value": 8376.802393089854}, {"lowerIsBetter": false, "replicates": [1093.092733031584, 1427.486105002199, 1428.9071210371326, 1583.3824808324748, 1751.0981844350163, 7150.284971502847, 7303.342699157075, 7311.305425984537, 7323.0, 7325.633718314083, 7015.228324884271, 7158.964205178967, 7161.5345002574795, 7162.283771622835, 7172.96413517933, 1890.5084677983687, 1932.5748335366268, 2194.615942210115, 2242.6523888797224, 2274.6701728249395, 2202.2512345802425, 2219.556088782242, 2219.5671843990426, 2220.245116660335, 2222.055626358799, 2113.947151321214, 2138.5829763196184, 2148.795864392888, 2222.866628002317, 2224.7552769195377, 2207.834412419059, 2222.055626358799, 2230.721159855018, 2234.8100411464966, 2235.329401179648, 2235.3294011796397, 2254.1546919905036, 2263.4115130066302, 2264.230161745015, 2266.3427605994243, 7318.3047610476915, 7399.297066778701, 7405.370543503808, 7422.331990120861, 7437.3306402423505, 4686.601638860701, 4753.382060332135, 4759.738214398207, 4810.062037902575, 4811.855644330676, 3131.906042818719, 3161.6996385343587, 3343.1976325681903, 3365.512000759876, 3370.174307294704, 1046.0428707732415, 1049.595905576351, 1083.3554035348955, 1109.3787479011698, 1123.6966019174859, 9856.211503079736, 9968.750781230454, 10016.54925528353, 10025.498725063791, 10037.69886903394, 4167.229062623424, 4286.185624731291, 4317.84887528935, 4345.348197770297, 4382.2112019836095, 8585.098564650747, 8627.309815214769, 8629.568521573896, 8635.0, 8711.128887111237, 4815.566599006106, 4819.807207711722, 4833.202521583899, 4835.419749630067, 4838.395200599925, 3778.0932576182067, 4284.335927931175, 4357.237483440385, 4373.6282415994365, 4458.621017213508, 3504.9649503505148, 3560.483729859156, 3581.606023337431, 3586.4620306954166, 3587.7847329160336, 1232.186756740547, 1246.1401632873287, 1250.6248125562477, 1252.5303011370736, 1253.4986005597834, 1087.8912108789216, 1101.1631160318057, 1108.9057430118369, 1297.9675508112184, 1378.7242551489742, 6910.44716422685, 7044.330788575077, 7069.151701795715, 7078.186008608973, 7114.253003434668, 485.87610159409127, 493.2453346380044, 493.6371766751435, 493.6815753838754, 497.6367251906129, 5530.806421775219, 5550.7779688812, 5551.9722401387735, 5565.610407271533, 5586.91619625706, 8614.18165274298, 8679.17547832955, 8873.689420870238, 8980.371374003887, 9104.13510716481, 8820.162084601952, 8852.114788521225, 8920.509371984603, 8920.776980575538, 8923.41997770143, 6490.4807615390655, 6606.339366063356, 6616.900746488806, 7040.295970402919, 7043.68303426347, 6909.412699920362, 6958.478114141561, 6994.2306346302885, 7009.894851577333, 7034.788956331114, 7670.386369090348, 7907.367410607023, 7990.800229994296, 7991.28078472917, 8060.193980601893, 7891.684332626631, 8218.589070546568, 8229.95885020571, 8237.958810205912, 8241.587920603826, 6135.907961380493, 6801.18385793708, 6986.510944233854, 7149.785506434815, 7272.563646181246, 7108.822279443055, 7154.320339567733, 7168.283171682999, 7182.317679820409, 7204.927950720636, 6396.744130234739, 6405.775797847053, 6420.06908998202, 6581.703823328057, 6587.209534855848, 6523.706433210422, 6556.770513032021, 6611.371919667624, 6624.701888415129, 6634.502412318999, 6854.383105520527, 6868.313168683291, 6880.65596720152, 6892.517523773287, 6922.861542769016, 6283.874322513616, 6465.353464653497, 6480.643564603992, 6484.157059582224, 6492.967535162294, 6492.188476440445, 6498.3826536478955, 6512.706928188148, 6530.934690653033, 6535.117759102651], "unit": "score", "name": "mootools.html", "value": 4281.956746087086}, {"lowerIsBetter": false, "replicates": [317.46824069683277, 321.1617677860784, 344.9275652113056, 346.18818869750436, 346.6983724159981, 5970.373110823361, 5978.8804223915495, 5980.521558275338, 6034.4568988791, 6061.696915154241, 5926.674032928187, 5943.3462319144855, 5947.4052594740615, 5954.612950158236, 5957.553183511243, 4318.913621727564, 4443.200223959702, 4524.276115821469, 4527.705699129554, 4571.817127314904, 4549.886252843672, 4552.157850797596, 4554.544545545452, 4558.566936141061, 4563.703359281636, 4520.68355215135, 4522.3216517522305, 4524.11779702958, 4528.230200865844, 4532.592066713995, 4320.092780516095, 4425.468943726757, 4509.1883460977015, 4512.729236245836, 4553.066621342617, 4034.253663072341, 4049.8582549610915, 4050.4936882889638, 4060.0, 4065.1666408386504, 5761.164631128463, 5761.711914404305, 5763.5101016413655, 5778.653280803165, 5783.334916484616, 5292.444293349181, 5305.973470132624, 5308.734563271821, 5310.336207974004, 5313.7608807603365, 6224.502039836848, 6230.532710046719, 6233.750649973996, 6237.812865614039, 6238.251409830849, 4396.599228528703, 4451.666125040635, 4454.30958201476, 4478.0596074824325, 4485.529019452943, 6479.1901012373455, 6513.055606936968, 6513.250976137758, 6515.837104072436, 6516.696660667838, 4590.701604395704, 4592.471865735416, 4593.954060459419, 4599.6090332321455, 4602.263637817933, 4637.350770892078, 4645.628349732014, 4647.256438969748, 4652.883677908079, 4654.2785868190485, 5295.391030031518, 5296.947030529723, 5300.3639563252655, 5307.363116426053, 5311.309529761106, 6125.418085281891, 6280.874382512416, 6308.400701933309, 6309.842253943688, 6316.242050953915, 1579.33667859497, 1631.0947424179694, 1641.253229780447, 1644.5559698881234, 1648.7197176480026, 983.1201075037801, 1041.2971244409994, 1087.6138970665459, 1117.4301106435776, 1120.2718233148519, 5782.508486778587, 5802.390748971382, 5812.738426770806, 5917.52659787216, 5931.110333450017, 6377.266614339411, 6382.4255816975765, 6383.680815959184, 6390.7443702251385, 6402.48780097591, 5843.649381037151, 5889.646621202742, 5902.61632993854, 5904.202932604129, 5906.763729450774, 3401.5067815166663, 3423.17843717511, 3428.5885693716914, 3432.5194472773833, 3439.9828000860334, 6422.4862011039, 6528.510361722795, 6586.637734924625, 6598.37315455031, 6602.60384376939, 6459.09572659828, 6494.383033611799, 6501.414872661483, 6507.479401647857, 6511.381418765304, 6573.835654108686, 6589.308122647149, 6592.472602191813, 6597.934020659828, 6598.0, 6351.491880649629, 6351.68241587928, 6366.0, 6369.9681501592195, 6370.522210834113, 6133.815985520441, 6281.874362512633, 6296.024116261987, 6296.968515157395, 6310.368963103653, 6552.8361790955605, 6581.177352830896, 6583.078369028244, 6597.27429982692, 6599.373059559334, 4486.955130448654, 4495.617872480745, 4497.662675299301, 4512.435945506812, 4527.185106680829, 6328.272248691275, 6339.936600633934, 6376.139221205078, 6420.165378500765, 6446.8388290293115, 6147.047207682816, 6175.228096487939, 6186.4122908325435, 6198.597091189058, 6229.190205273286, 6010.849728756816, 6147.262328520427, 6149.631022138686, 6151.169592105009, 6163.322034576104, 6026.186464827192, 6027.57806953509, 6042.607230530001, 6053.122297266959, 6053.485453736305, 6182.690865456799, 6183.598066125687, 6194.318624951342, 6197.287311959182, 6197.4422301991235, 5883.823485295276, 5997.430244126801, 6015.639061656315, 6017.247844019497, 6027.397260273938], "unit": "score", "name": "prototype.html", "value": 4721.879649689156}, {"lowerIsBetter": false, "replicates": [729.7664747280869, 752.8870669399589, 754.3964828137489, 792.9405294602899, 804.987925181122, 14203.857961420383, 14390.352434140463, 14449.63875903103, 14490.5652830415, 14527.709445811091, 15541.766873496907, 15561.299741511632, 15672.294746736396, 15760.605984850385, 15776.368945242206, 566.3119310038303, 843.2326582809629, 851.5401683091123, 853.0744142605281, 856.400519636254, 870.6996086350199, 874.1957399192758, 877.1228771228771, 880.0627331891548, 882.8057827277988, 896.7399454158286, 901.9549022548879, 902.1024081039375, 902.2285945516587, 902.6795487601905, 597.1490625858156, 882.3999680217449, 894.7226359828474, 895.3642913531401, 896.551724137931, 645.7287939065603, 647.3009150117908, 647.974081036758, 649.191756263455, 657.7204688007625, 14253.0, 14327.283635818167, 14349.0, 14359.282035898163, 14360.138391696531, 13469.528566500223, 13685.110467819659, 13861.722765544733, 13896.305184740824, 14004.47695567014, 11482.425878706032, 11666.533338666528, 11693.649190524298, 11703.648890533297, 11797.17419780607, 3669.486271921933, 3708.87018954338, 3730.7388482806214, 3733.8693145739767, 3767.2088861339153, 57545.69817207307, 58210.79840608765, 58740.412595874346, 58891.41108588902, 59602.40397596012, 10921.235513513977, 10997.54904392863, 11034.062104721188, 11072.557097716, 11148.888511114785, 19440.611187776165, 19577.0, 19602.70595941062, 19617.509562261057, 19651.508712282022, 8123.268905798388, 8138.104808471064, 8173.713920012771, 8306.0, 8678.739637810875, 4862.992251221411, 4877.609791216694, 4909.803607855646, 4914.99596641665, 4986.576141027981, 3378.1554611347165, 3398.966010339865, 3414.0611331883433, 3418.1967237699123, 3422.0418282880833, 533.2561077297149, 577.6043410263983, 595.5265563876728, 596.3380647481292, 608.4888693497395, 646.9902951455732, 655.6918248423328, 728.2717282717283, 769.0617446714999, 796.1083586383172, 9350.766230844147, 9846.310758246997, 9904.306698531178, 9973.601055957826, 10057.69826905194, 734.7795661301695, 736.8968344431784, 755.1881727143233, 756.640595717041, 792.136571137463, 4418.33724941255, 4603.700759450625, 4618.053299073682, 4647.233206520954, 4681.695689780221, 58383.0, 58798.11802822961, 58802.0, 59275.70362148248, 59464.40535594675, 59562.0, 60590.091148632804, 60756.392436075956, 61081.389186108456, 61567.0, 52415.21377179345, 52581.737091315066, 53053.0, 53452.0, 54493.727531362885, 9100.635974560944, 9276.211522020703, 9310.44137351734, 9395.0, 9438.0, 38900.80549597347, 39128.41307380335, 39196.41205381865, 40950.385744213265, 41113.0, 48123.0, 52103.47896520986, 52763.944721106134, 53116.46883531115, 53675.0, 11249.943750281196, 11374.20380573352, 11481.540738370706, 11548.307101573933, 11555.246284606457, 12447.502099916264, 12807.807882881578, 12849.164804287691, 12950.870491295344, 13516.594502164951, 11617.767644647229, 11648.94175529117, 11750.059995200534, 11807.940960295144, 12118.752289218843, 12135.575254866037, 12266.386680665753, 12266.4480098394, 12386.938065309616, 12465.0, 11079.72300692489, 11080.778384432428, 11210.27133236337, 11331.943340283246, 11386.430678465878, 9906.900930990598, 10349.896501034893, 10359.119474844421, 10483.633072842415, 10618.946905265424, 10135.594576217163, 10300.536475858455, 10375.066244038073, 10406.791864162524, 10425.218108642033], "unit": "score", "name": "yui.html", "value": 6847.716496209007}], "name": "dromaeo_css", "value": 6962.067809317834}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 105.0, 110.0, 110.0, 112.0, 99.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 108.2}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 159.0, 178.0, 124.0, 153.0, 154.0, 128.0, 174.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 110.0, 97.0, 76.0, 78.0, 73.0, 120.0, 98.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.4}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 146.0, 93.0, 94.0, 94.0, 149.0, 94.0, 93.0, 149.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 167.0], "unit": "score", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 56.0, 58.0, 56.0, 59.0, 65.0, 57.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [60.0, 72.0, 61.0, 60.0, 62.0, 61.0, 61.0, 60.0, 61.0, 61.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 61.9}, {"lowerIsBetter": true, "replicates": [78.0, 79.0, 81.0, 80.0, 79.0, 79.0, 87.0, 79.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.0}, {"lowerIsBetter": true, "replicates": [119.0, 112.0, 116.0, 110.0, 117.0, 125.0, 119.0, 109.0, 111.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [142.0, 144.0, 150.0, 142.0, 145.0, 131.0, 140.0, 145.0, 142.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [70.0, 65.0, 65.0, 63.0, 63.0, 63.0, 63.0, 64.0, 68.0, 62.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.6}], "name": "kraken", "value": 1500.4}]}
02:16:54 INFO - Return code: 0
02:16:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json
02:16:54 ERROR - # TBPL SUCCESS #
02:16:54 INFO - Running post-action listener: _resource_record_post_action
02:16:54 INFO - Running post-run listener: _resource_record_post_run
02:16:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535408640; Read time: 288; Write time: 705732
02:16:55 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 243019776; Read time: 0; Write time: 378768
02:16:55 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292388864; Read time: 288; Write time: 326964
02:16:55 INFO - Running post-run listener: _upload_blobber_files
02:16:55 INFO - Blob upload gear active.
02:16:55 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir.
02:16:55 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
02:16:55 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json']
02:16:55 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json
02:16:55 INFO - (blobuploader) - INFO - Open directory for files ...
02:16:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ...
02:16:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
02:16:55 INFO - (blobuploader) - INFO - Uploading, attempt #1.
02:16:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
02:16:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
02:16:56 INFO - (blobuploader) - INFO - Done attempting.
02:16:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
02:16:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
02:16:56 INFO - (blobuploader) - INFO - Uploading, attempt #1.
02:16:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
02:16:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
02:16:57 INFO - (blobuploader) - INFO - Done attempting.
02:16:57 INFO - (blobuploader) - INFO - Iteration through files over.
02:16:57 INFO - Return code: 0
02:16:57 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json
02:16:57 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1
02:16:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d066ef063ca54d2b79ec98dc8acb6e51e392b2fb288d557ddbfd9fa9feab99631bfcffbb35477a411bc2a28d42c9a5356c5be56ddaec34314a4a770ea4ee46c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8dd4505b3cac78e432a2d2db1003b23d82c11fba158c2ef001ee1b29bbf0e0911fed5a1c9cc37b82e1e4d5fe21cf4be8f866a44b09215788ab796643e9b2b04"}
02:16:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files
02:16:57 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files
02:16:57 INFO - Contents:
02:16:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d066ef063ca54d2b79ec98dc8acb6e51e392b2fb288d557ddbfd9fa9feab99631bfcffbb35477a411bc2a28d42c9a5356c5be56ddaec34314a4a770ea4ee46c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8dd4505b3cac78e432a2d2db1003b23d82c11fba158c2ef001ee1b29bbf0e0911fed5a1c9cc37b82e1e4d5fe21cf4be8f866a44b09215788ab796643e9b2b04"}
02:16:57 INFO - Running post-run listener: copy_logs_to_upload_dir
02:16:57 INFO - Copying logs to upload dir...
02:16:57 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs
02:16:57 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1236.882418
========= master_lag: 0.66 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-03-29 02:16:56.064165) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 02:16:56.067832) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d066ef063ca54d2b79ec98dc8acb6e51e392b2fb288d557ddbfd9fa9feab99631bfcffbb35477a411bc2a28d42c9a5356c5be56ddaec34314a4a770ea4ee46c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8dd4505b3cac78e432a2d2db1003b23d82c11fba158c2ef001ee1b29bbf0e0911fed5a1c9cc37b82e1e4d5fe21cf4be8f866a44b09215788ab796643e9b2b04"}
build_url:https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011338
build_url: 'https://queue.taskcluster.net/v1/task/aT68NWPhQ4aGRCCZLPjS-w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d066ef063ca54d2b79ec98dc8acb6e51e392b2fb288d557ddbfd9fa9feab99631bfcffbb35477a411bc2a28d42c9a5356c5be56ddaec34314a4a770ea4ee46c2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c8dd4505b3cac78e432a2d2db1003b23d82c11fba158c2ef001ee1b29bbf0e0911fed5a1c9cc37b82e1e4d5fe21cf4be8f866a44b09215788ab796643e9b2b04"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-29 02:16:56.096015) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 02:16:56.096437) =========
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=52faae308a556c440401f8e5000001e8-1459238442.500881-1890953778
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004419
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 02:16:56.149325) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 02:16:56.149704) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 02:16:56.150043) =========
========= Total master_lag: 0.90 =========