builder: fx-team_ubuntu64_hw_test-dromaeojs
slave: talos-linux64-ix-039
starttime: 1461644373.16
results: success (0)
buildid: 20160425204203
builduid: f25ac29b8a8b41e4a2db418ddd501fc3
revision: f2b20c6eb71dbf7a2884a776251e760e73b8c69b
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.165473) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.166024) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.166356) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.217142) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.217409) =========
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/. (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
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-04-25 21:19:34-- 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% 46.7M=0s
2016-04-25 21:19:34 (46.7 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.154290
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.387807) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.388119) =========
rm -rf scripts properties
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts', '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
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.014287
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.438619) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.438924) =========
bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f2b20c6eb71dbf7a2884a776251e760e73b8c69b --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f2b20c6eb71dbf7a2884a776251e760e73b8c69b --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
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-04-25 21:19:34,372 truncating revision to first 12 chars
2016-04-25 21:19:34,372 Setting DEBUG logging.
2016-04-25 21:19:34,372 attempt 1/10
2016-04-25 21:19:34,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f2b20c6eb71d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-04-25 21:19:34,678 unpacking tar archive at: fx-team-f2b20c6eb71d/testing/mozharness/
program finished with exit code 0
elapsedTime=0.582287
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.035908) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036226) =========
script_repo_revision: f2b20c6eb71dbf7a2884a776251e760e73b8c69b
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036598) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036862) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.052752) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 21:19:34.053053) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO
in dir /builds/slave/test/. (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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO']
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/buildprops.json
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
21:19:35 INFO - MultiFileLogger online at 20160425 21:19:35 in /builds/slave/test
21:19:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO
21:19:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
21:19:35 INFO - {'append_to_log': False,
21:19:35 INFO - 'base_work_dir': '/builds/slave/test',
21:19:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO',
21:19:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
21:19:35 INFO - 'branch': 'Fx-Team-Non-PGO',
21:19:35 INFO - 'buildbot_json_path': 'buildprops.json',
21:19:35 INFO - 'config_files': ('talos/linux_config.py',),
21:19:35 INFO - 'default_actions': ('clobber',
21:19:35 INFO - 'read-buildbot-config',
21:19:35 INFO - 'download-and-extract',
21:19:35 INFO - 'populate-webroot',
21:19:35 INFO - 'create-virtualenv',
21:19:35 INFO - 'install',
21:19:35 INFO - 'run-tests'),
21:19:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
21:19:35 INFO - 'download_minidump_stackwalk': True,
21:19:35 INFO - 'download_symbols': 'ondemand',
21:19:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
21:19:35 INFO - 'tooltool.py': '/tools/tooltool.py',
21:19:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
21:19:35 INFO - '/tools/misc-python/virtualenv.py')},
21:19:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
21:19:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
21:19:35 INFO - 'installer_path': 'installer.exe',
21:19:35 INFO - 'log_level': 'info',
21:19:35 INFO - 'log_name': 'talos',
21:19:35 INFO - 'log_to_console': True,
21:19:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
21:19:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
21:19:35 INFO - 'opt_config_files': (),
21:19:35 INFO - 'pip_index': False,
21:19:35 INFO - 'sps_profile': False,
21:19:35 INFO - 'sps_profile_interval': 0,
21:19:35 INFO - 'suite': 'dromaeojs',
21:19:35 INFO - 'system_bits': '32',
21:19:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
21:19:35 INFO - 'title': 'talos-linux64-ix-039',
21:19:35 INFO - 'tooltool_cache': '/builds/tooltool_cache',
21:19:35 INFO - 'use_talos_json': True,
21:19:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
21:19:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:19:35 INFO - 'work_dir': 'build'}
21:19:35 INFO - #####
21:19:35 INFO - ##### Running clobber step.
21:19:35 INFO - #####
21:19:35 INFO - Running pre-action listener: _resource_record_pre_action
21:19:35 INFO - Running main action method: clobber
21:19:35 INFO - rmtree: /builds/slave/test/build
21:19:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
21:19:35 INFO - Running post-action listener: _resource_record_post_action
21:19:35 INFO - #####
21:19:35 INFO - ##### Running read-buildbot-config step.
21:19:35 INFO - #####
21:19:35 INFO - Running pre-action listener: _resource_record_pre_action
21:19:35 INFO - Running main action method: read_buildbot_config
21:19:35 INFO - Using buildbot properties:
21:19:35 INFO - {
21:19:35 INFO - "project": "",
21:19:35 INFO - "product": "firefox",
21:19:35 INFO - "script_repo_revision": "production",
21:19:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs",
21:19:35 INFO - "repository": "",
21:19:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs",
21:19:35 INFO - "buildid": "20160425204203",
21:19:35 INFO - "pgo_build": "False",
21:19:35 INFO - "basedir": "/builds/slave/test",
21:19:35 INFO - "buildnumber": 1603,
21:19:35 INFO - "slavename": "talos-linux64-ix-039",
21:19:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
21:19:35 INFO - "platform": "ubuntu64_hw",
21:19:35 INFO - "scheduler": "tests-fx-team-linux64-talos",
21:19:35 INFO - "branch": "fx-team",
21:19:35 INFO - "repo_path": "integration/fx-team",
21:19:35 INFO - "revision": "f2b20c6eb71dbf7a2884a776251e760e73b8c69b",
21:19:35 INFO - "stage_platform": "linux64",
21:19:35 INFO - "builduid": "f25ac29b8a8b41e4a2db418ddd501fc3",
21:19:35 INFO - "slavebuilddir": "test"
21:19:35 INFO - }
21:19:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2.
21:19:35 INFO - Running post-action listener: _resource_record_post_action
21:19:35 INFO - #####
21:19:35 INFO - ##### Running download-and-extract step.
21:19:35 INFO - #####
21:19:35 INFO - Running pre-action listener: _resource_record_pre_action
21:19:35 INFO - Running main action method: download_and_extract
21:19:35 INFO - mkdir: /builds/slave/test/build/tests
21:19:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:35 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net
21:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
21:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
21:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
21:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1
21:19:42 INFO - Downloaded 1361 bytes.
21:19:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
21:19:42 INFO - Using the following test package requirements:
21:19:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'],
21:19:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
21:19:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'],
21:19:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'jsshell-linux-x86_64.zip'],
21:19:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
21:19:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'],
21:19:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'],
21:19:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'],
21:19:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
21:19:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
21:19:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
21:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:42 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
21:19:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
21:19:47 INFO - Downloaded 22290132 bytes.
21:19:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests']
21:19:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests
21:19:48 INFO - Return code: 0
21:19:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
21:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:48 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
21:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
21:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
21:19:51 INFO - Downloaded 22290132 bytes.
21:19:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests']
21:19:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests
21:19:52 INFO - Return code: 0
21:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:52 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
21:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip
21:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip
21:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip
21:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
21:19:53 INFO - Downloaded 10840145 bytes.
21:19:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests']
21:19:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests
21:19:54 INFO - Return code: 0
21:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:54 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
21:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
21:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
21:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
21:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
21:19:56 INFO - Downloaded 54818005 bytes.
21:19:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
21:19:56 INFO - mkdir: /builds/slave/test/properties
21:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
21:19:56 INFO - Writing to file /builds/slave/test/properties/build_url
21:19:56 INFO - Contents:
21:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
21:19:57 INFO - Running post-action listener: _resource_record_post_action
21:19:57 INFO - Running post-action listener: set_extra_try_arguments
21:19:57 INFO - #####
21:19:57 INFO - ##### Running populate-webroot step.
21:19:57 INFO - #####
21:19:57 INFO - Running pre-action listener: _resource_record_pre_action
21:19:57 INFO - Running main action method: populate_webroot
21:19:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
21:19:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
21:19:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
21:19:57 INFO - '--tppagecycles',
21:19:57 INFO - '7'],
21:19:57 INFO - 'tests': ['tsvgm']}},
21:19:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['tresize', 'tcanvasmark']},
21:19:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
21:19:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['dromaeo_css', 'kraken']},
21:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
21:19:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:19:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:19:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['damp', 'tps']},
21:19:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'tests': ['damp', 'tps']},
21:19:57 INFO - 'g3': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['dromaeo_dom']},
21:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
21:19:57 INFO - 'other': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'other-e10s': {'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'other-e10s_l64': {'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['a11yr',
21:19:57 INFO - 'ts_paint',
21:19:57 INFO - 'tpaint',
21:19:57 INFO - 'sessionrestore',
21:19:57 INFO - 'sessionrestore_no_auto_restore',
21:19:57 INFO - 'tabpaint']},
21:19:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['tsvgx',
21:19:57 INFO - 'tsvgr_opacity',
21:19:57 INFO - 'tart',
21:19:57 INFO - 'tscrollx',
21:19:57 INFO - 'cart']},
21:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx',
21:19:57 INFO - 'tsvgr_opacity',
21:19:57 INFO - 'tart',
21:19:57 INFO - 'tscrollx',
21:19:57 INFO - 'cart']},
21:19:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'talos_options': ['--disable-e10s'],
21:19:57 INFO - 'tests': ['tp5o']},
21:19:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'tests': ['tp5o']},
21:19:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'talos_options': ['--disable-e10s',
21:19:57 INFO - '--xperf_path',
21:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:19:57 INFO - 'tests': ['tp5n']},
21:19:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
21:19:57 INFO - 'talos_options': ['--xperf_path',
21:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:19:57 INFO - 'tests': ['tp5n']}},
21:19:57 INFO - 'talos.zip': {'path': '',
21:19:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
21:19:57 INFO - Running post-action listener: _resource_record_post_action
21:19:57 INFO - #####
21:19:57 INFO - ##### Running create-virtualenv step.
21:19:57 INFO - #####
21:19:57 INFO - Running pre-action listener: _resource_record_pre_action
21:19:57 INFO - Running main action method: create_virtualenv
21:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv
21:19:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
21:19:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
21:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
21:19:57 INFO - Using real prefix '/usr'
21:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python
21:19:57 INFO - Installing distribute.............................................................................................................................................................................................done.
21:19:59 INFO - Installing pip.................done.
21:19:59 INFO - Return code: 0
21:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
21:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:19:59 INFO - Running command: ['/builds/slave/test/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/build
21:19:59 INFO - Copy/paste: /builds/slave/test/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
21:19:59 INFO - Using env: {'DISPLAY': ':0',
21:19:59 INFO - 'HOME': '/home/cltbld',
21:19:59 INFO - 'LANG': 'en_US.UTF-8',
21:19:59 INFO - 'LANGUAGE': 'en_US:en',
21:19:59 INFO - 'LOGNAME': 'cltbld',
21:19:59 INFO - 'MAIL': '/var/mail/cltbld',
21:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:19:59 INFO - 'MOZ_NO_REMOTE': '1',
21:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:19:59 INFO - 'NO_EM_RESTART': '1',
21:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:19:59 INFO - 'PWD': '/builds/slave/test',
21:19:59 INFO - 'SHELL': '/bin/bash',
21:19:59 INFO - 'SHLVL': '1',
21:19:59 INFO - 'TERM': 'linux',
21:19:59 INFO - 'TMOUT': '86400',
21:19:59 INFO - 'USER': 'cltbld',
21:19:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:19:59 INFO - '_': '/tools/buildbot/bin/python'}
21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:00 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
21:20:00 INFO - Cleaning up...
21:20:00 INFO - Return code: 0
21:20:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv
21:20: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')]}
21:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20: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')]}
21:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:00 INFO - Running command: ['/builds/slave/test/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/build
21:20:00 INFO - Copy/paste: /builds/slave/test/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
21:20:00 INFO - Using env: {'DISPLAY': ':0',
21:20:00 INFO - 'HOME': '/home/cltbld',
21:20:00 INFO - 'LANG': 'en_US.UTF-8',
21:20:00 INFO - 'LANGUAGE': 'en_US:en',
21:20:00 INFO - 'LOGNAME': 'cltbld',
21:20:00 INFO - 'MAIL': '/var/mail/cltbld',
21:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:00 INFO - 'MOZ_NO_REMOTE': '1',
21:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:00 INFO - 'NO_EM_RESTART': '1',
21:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:00 INFO - 'PWD': '/builds/slave/test',
21:20:00 INFO - 'SHELL': '/bin/bash',
21:20:00 INFO - 'SHLVL': '1',
21:20:00 INFO - 'TERM': 'linux',
21:20:00 INFO - 'TMOUT': '86400',
21:20:00 INFO - 'USER': 'cltbld',
21:20:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:00 INFO - '_': '/tools/buildbot/bin/python'}
21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:00 INFO - Downloading/unpacking psutil>=0.7.1
21:20: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
21:20: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
21:20: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
21:20: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
21:20: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
21:20: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
21:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
21:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
21:20:02 INFO - Installing collected packages: psutil
21:20:02 INFO - Running setup.py install for psutil
21:20:02 INFO - building 'psutil._psutil_linux' extension
21:20:02 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
21:20:02 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
21:20:02 INFO - building 'psutil._psutil_posix' extension
21:20:02 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
21:20:02 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
21:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
21:20:02 INFO - Successfully installed psutil
21:20:02 INFO - Cleaning up...
21:20:02 INFO - Return code: 0
21:20:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv
21:20:02 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')]}
21:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:02 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')]}
21:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:02 INFO - Running command: ['/builds/slave/test/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/build
21:20:02 INFO - Copy/paste: /builds/slave/test/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
21:20:02 INFO - Using env: {'DISPLAY': ':0',
21:20:02 INFO - 'HOME': '/home/cltbld',
21:20:02 INFO - 'LANG': 'en_US.UTF-8',
21:20:02 INFO - 'LANGUAGE': 'en_US:en',
21:20:02 INFO - 'LOGNAME': 'cltbld',
21:20:02 INFO - 'MAIL': '/var/mail/cltbld',
21:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:02 INFO - 'MOZ_NO_REMOTE': '1',
21:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:02 INFO - 'NO_EM_RESTART': '1',
21:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:02 INFO - 'PWD': '/builds/slave/test',
21:20:02 INFO - 'SHELL': '/bin/bash',
21:20:02 INFO - 'SHLVL': '1',
21:20:02 INFO - 'TERM': 'linux',
21:20:02 INFO - 'TMOUT': '86400',
21:20:02 INFO - 'USER': 'cltbld',
21:20:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:02 INFO - '_': '/tools/buildbot/bin/python'}
21:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
21:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz
21:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
21:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0)
21:20:04 INFO - Installing collected packages: mozsystemmonitor
21:20:04 INFO - Running setup.py install for mozsystemmonitor
21:20:05 INFO - Successfully installed mozsystemmonitor
21:20:05 INFO - Cleaning up...
21:20:05 INFO - Return code: 0
21:20:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
21:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:05 INFO - Running command: ['/builds/slave/test/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/build
21:20:05 INFO - Copy/paste: /builds/slave/test/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
21:20:05 INFO - Using env: {'DISPLAY': ':0',
21:20:05 INFO - 'HOME': '/home/cltbld',
21:20:05 INFO - 'LANG': 'en_US.UTF-8',
21:20:05 INFO - 'LANGUAGE': 'en_US:en',
21:20:05 INFO - 'LOGNAME': 'cltbld',
21:20:05 INFO - 'MAIL': '/var/mail/cltbld',
21:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:05 INFO - 'MOZ_NO_REMOTE': '1',
21:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:05 INFO - 'NO_EM_RESTART': '1',
21:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:05 INFO - 'PWD': '/builds/slave/test',
21:20:05 INFO - 'SHELL': '/bin/bash',
21:20:05 INFO - 'SHLVL': '1',
21:20:05 INFO - 'TERM': 'linux',
21:20:05 INFO - 'TMOUT': '86400',
21:20:05 INFO - 'USER': 'cltbld',
21:20:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:05 INFO - '_': '/tools/buildbot/bin/python'}
21:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:05 INFO - Downloading/unpacking blobuploader==1.2.4
21:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:07 INFO - Downloading blobuploader-1.2.4.tar.gz
21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
21:20:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
21:20:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:20:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:20:07 INFO - Downloading docopt-0.6.1.tar.gz
21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
21:20:07 INFO - Installing collected packages: blobuploader, requests, docopt
21:20:07 INFO - Running setup.py install for blobuploader
21:20:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
21:20:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
21:20:08 INFO - Running setup.py install for requests
21:20:08 INFO - Running setup.py install for docopt
21:20:08 INFO - Successfully installed blobuploader requests docopt
21:20:08 INFO - Cleaning up...
21:20:08 INFO - Return code: 0
21:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:20:08 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')]}
21:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:08 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')]}
21:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config
21:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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
21:20:08 INFO - Using env: {'DISPLAY': ':0',
21:20:08 INFO - 'HOME': '/home/cltbld',
21:20:08 INFO - 'LANG': 'en_US.UTF-8',
21:20:08 INFO - 'LANGUAGE': 'en_US:en',
21:20:08 INFO - 'LOGNAME': 'cltbld',
21:20:08 INFO - 'MAIL': '/var/mail/cltbld',
21:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:08 INFO - 'MOZ_NO_REMOTE': '1',
21:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:08 INFO - 'NO_EM_RESTART': '1',
21:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:08 INFO - 'PWD': '/builds/slave/test',
21:20:08 INFO - 'SHELL': '/bin/bash',
21:20:08 INFO - 'SHLVL': '1',
21:20:08 INFO - 'TERM': 'linux',
21:20:08 INFO - 'TMOUT': '86400',
21:20:08 INFO - 'USER': 'cltbld',
21:20:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:08 INFO - '_': '/tools/buildbot/bin/python'}
21:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:20:08 INFO - Running setup.py (path:/tmp/pip-3o3KY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:20:08 INFO - Running setup.py (path:/tmp/pip-CqzEKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:20:08 INFO - Running setup.py (path:/tmp/pip-4Tkwly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:20:09 INFO - Running setup.py (path:/tmp/pip-du5FjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:20:09 INFO - Running setup.py (path:/tmp/pip-amw8SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:20:09 INFO - Running setup.py (path:/tmp/pip-S0JJCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:20:09 INFO - Running setup.py (path:/tmp/pip-CtmMqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:20:09 INFO - Running setup.py (path:/tmp/pip-10qGfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:20:09 INFO - Running setup.py (path:/tmp/pip-CITLXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:20:09 INFO - Running setup.py (path:/tmp/pip-KLMxxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:20:09 INFO - Running setup.py (path:/tmp/pip-dlHWT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:20:09 INFO - Running setup.py (path:/tmp/pip-4VdmQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:20:09 INFO - Running setup.py (path:/tmp/pip-rsOWdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:20:09 INFO - Running setup.py (path:/tmp/pip-Z063gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:20:09 INFO - Running setup.py (path:/tmp/pip-SRqLjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:20:09 INFO - Running setup.py (path:/tmp/pip-49sUxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:20:09 INFO - Running setup.py (path:/tmp/pip-NAHjyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:20:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
21:20:09 INFO - Running setup.py install for manifestparser
21:20:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Running setup.py install for mozcrash
21:20:10 INFO - Running setup.py install for mozdebug
21:20:10 INFO - Running setup.py install for mozdevice
21:20:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Running setup.py install for mozfile
21:20:10 INFO - Running setup.py install for mozhttpd
21:20:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Running setup.py install for mozinfo
21:20:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Running setup.py install for mozInstall
21:20:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
21:20:10 INFO - Running setup.py install for mozleak
21:20:10 INFO - Running setup.py install for mozlog
21:20:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Running setup.py install for moznetwork
21:20:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Running setup.py install for mozprocess
21:20:11 INFO - Running setup.py install for mozprofile
21:20:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Running setup.py install for mozrunner
21:20:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Running setup.py install for mozscreenshot
21:20:11 INFO - Running setup.py install for moztest
21:20:11 INFO - Running setup.py install for mozversion
21:20:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
21:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
21:20:11 INFO - Cleaning up...
21:20:11 INFO - Return code: 0
21:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config
21:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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
21:20:11 INFO - Using env: {'DISPLAY': ':0',
21:20:11 INFO - 'HOME': '/home/cltbld',
21:20:11 INFO - 'LANG': 'en_US.UTF-8',
21:20:11 INFO - 'LANGUAGE': 'en_US:en',
21:20:11 INFO - 'LOGNAME': 'cltbld',
21:20:11 INFO - 'MAIL': '/var/mail/cltbld',
21:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:11 INFO - 'MOZ_NO_REMOTE': '1',
21:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:11 INFO - 'NO_EM_RESTART': '1',
21:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:11 INFO - 'PWD': '/builds/slave/test',
21:20:11 INFO - 'SHELL': '/bin/bash',
21:20:11 INFO - 'SHLVL': '1',
21:20:11 INFO - 'TERM': 'linux',
21:20:11 INFO - 'TMOUT': '86400',
21:20:11 INFO - 'USER': 'cltbld',
21:20:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:11 INFO - '_': '/tools/buildbot/bin/python'}
21:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:20:11 INFO - Running setup.py (path:/tmp/pip-OERZCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:20:12 INFO - Running setup.py (path:/tmp/pip-cymErA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:20:12 INFO - Running setup.py (path:/tmp/pip-ueOpLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:20:12 INFO - Running setup.py (path:/tmp/pip-NmNihp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:20:12 INFO - Running setup.py (path:/tmp/pip-ftQ5Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:20:12 INFO - Running setup.py (path:/tmp/pip-ur92G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:20:12 INFO - Running setup.py (path:/tmp/pip-X0JoTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:20:12 INFO - Running setup.py (path:/tmp/pip-BAqnCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:20:12 INFO - Running setup.py (path:/tmp/pip-Bbnlbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:20:12 INFO - Running setup.py (path:/tmp/pip-zax6j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:20:12 INFO - Running setup.py (path:/tmp/pip-hYyMCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:20:12 INFO - Running setup.py (path:/tmp/pip-MZ2R90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:20:12 INFO - Running setup.py (path:/tmp/pip-Mjltv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:20:12 INFO - Running setup.py (path:/tmp/pip-gHx0JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:20:13 INFO - Running setup.py (path:/tmp/pip-waL45C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:20:13 INFO - Running setup.py (path:/tmp/pip-KVTdHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:20:13 INFO - Running setup.py (path:/tmp/pip-QkFRNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:20:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:20:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
21:20:13 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
21:20:13 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
21:20:13 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
21:20:13 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
21:20:13 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
21:20:13 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
21:20:15 INFO - Downloading blessings-1.6.tar.gz
21:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
21:20:15 INFO - Installing collected packages: blessings
21:20:15 INFO - Running setup.py install for blessings
21:20:15 INFO - Successfully installed blessings
21:20:15 INFO - Cleaning up...
21:20:15 INFO - Return code: 0
21:20:15 INFO - Done creating virtualenv /builds/slave/test/build/venv.
21:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:20:15 INFO - Reading from file tmpfile_stdout
21:20:15 INFO - Current package versions:
21:20:15 INFO - argparse == 1.2.1
21:20:15 INFO - blessings == 1.6
21:20:15 INFO - blobuploader == 1.2.4
21:20:15 INFO - docopt == 0.6.1
21:20:15 INFO - manifestparser == 1.1
21:20:15 INFO - mozInstall == 1.12
21:20:15 INFO - mozcrash == 0.17
21:20:15 INFO - mozdebug == 0.1
21:20:15 INFO - mozdevice == 0.48
21:20:15 INFO - mozfile == 1.2
21:20:15 INFO - mozhttpd == 0.7
21:20:15 INFO - mozinfo == 0.9
21:20:15 INFO - mozleak == 0.1
21:20:15 INFO - mozlog == 3.1
21:20:15 INFO - moznetwork == 0.27
21:20:15 INFO - mozprocess == 0.22
21:20:15 INFO - mozprofile == 0.28
21:20:15 INFO - mozrunner == 6.11
21:20:15 INFO - mozscreenshot == 0.1
21:20:15 INFO - mozsystemmonitor == 0.0
21:20:15 INFO - moztest == 0.7
21:20:15 INFO - mozversion == 1.4
21:20:15 INFO - psutil == 3.1.1
21:20:15 INFO - requests == 1.2.3
21:20:15 INFO - wsgiref == 0.1.2
21:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:20:15 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')]}
21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:15 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')]}
21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos
21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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
21:20:15 INFO - Using env: {'DISPLAY': ':0',
21:20:15 INFO - 'HOME': '/home/cltbld',
21:20:15 INFO - 'LANG': 'en_US.UTF-8',
21:20:15 INFO - 'LANGUAGE': 'en_US:en',
21:20:15 INFO - 'LOGNAME': 'cltbld',
21:20:15 INFO - 'MAIL': '/var/mail/cltbld',
21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:15 INFO - 'MOZ_NO_REMOTE': '1',
21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:15 INFO - 'NO_EM_RESTART': '1',
21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:15 INFO - 'PWD': '/builds/slave/test',
21:20:15 INFO - 'SHELL': '/bin/bash',
21:20:15 INFO - 'SHLVL': '1',
21:20:15 INFO - 'TERM': 'linux',
21:20:15 INFO - 'TMOUT': '86400',
21:20:15 INFO - 'USER': 'cltbld',
21:20:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:15 INFO - '_': '/tools/buildbot/bin/python'}
21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
21:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
21:20:15 INFO - Cleaning up...
21:20:15 INFO - Return code: 0
21:20:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
21:20:15 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')]}
21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:15 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')]}
21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:15 INFO - Running command: ['/builds/slave/test/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/build
21:20:15 INFO - Copy/paste: /builds/slave/test/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
21:20:15 INFO - Using env: {'DISPLAY': ':0',
21:20:15 INFO - 'HOME': '/home/cltbld',
21:20:15 INFO - 'LANG': 'en_US.UTF-8',
21:20:15 INFO - 'LANGUAGE': 'en_US:en',
21:20:15 INFO - 'LOGNAME': 'cltbld',
21:20:15 INFO - 'MAIL': '/var/mail/cltbld',
21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:15 INFO - 'MOZ_NO_REMOTE': '1',
21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:15 INFO - 'NO_EM_RESTART': '1',
21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:15 INFO - 'PWD': '/builds/slave/test',
21:20:15 INFO - 'SHELL': '/bin/bash',
21:20:15 INFO - 'SHLVL': '1',
21:20:15 INFO - 'TERM': 'linux',
21:20:15 INFO - 'TMOUT': '86400',
21:20:15 INFO - 'USER': 'cltbld',
21:20:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:15 INFO - '_': '/tools/buildbot/bin/python'}
21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:15 INFO - Downloading/unpacking jsonschema
21:20:15 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
21:20:15 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
21:20:15 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
21:20:15 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
21:20:15 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
21:20:15 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
21:20:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
21:20:17 INFO - Downloading/unpacking functools32 (from jsonschema)
21:20:17 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
21:20:17 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
21:20:17 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
21:20:17 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
21:20:17 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
21:20:17 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
21:20:18 INFO - Downloading functools32-3.2.3-2.tar.gz
21:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
21:20:18 INFO - warning: no files found matching '*.txt'
21:20:18 INFO - no previously-included directories found matching 'build'
21:20:18 INFO - no previously-included directories found matching 'dist'
21:20:18 INFO - no previously-included directories found matching '.git*'
21:20:18 INFO - Installing collected packages: jsonschema, functools32
21:20:18 INFO - Running setup.py install for functools32
21:20:18 INFO - warning: no files found matching '*.txt'
21:20:18 INFO - no previously-included directories found matching 'build'
21:20:18 INFO - no previously-included directories found matching 'dist'
21:20:18 INFO - no previously-included directories found matching '.git*'
21:20:18 INFO - Successfully installed jsonschema functools32
21:20:18 INFO - Cleaning up...
21:20:18 INFO - Return code: 0
21:20:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv
21:20:18 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')]}
21:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:18 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')]}
21:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:20:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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
21:20:18 INFO - Running command: ['/builds/slave/test/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/build
21:20:18 INFO - Copy/paste: /builds/slave/test/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
21:20:18 INFO - Using env: {'DISPLAY': ':0',
21:20:18 INFO - 'HOME': '/home/cltbld',
21:20:18 INFO - 'LANG': 'en_US.UTF-8',
21:20:18 INFO - 'LANGUAGE': 'en_US:en',
21:20:18 INFO - 'LOGNAME': 'cltbld',
21:20:18 INFO - 'MAIL': '/var/mail/cltbld',
21:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:18 INFO - 'MOZ_NO_REMOTE': '1',
21:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:18 INFO - 'NO_EM_RESTART': '1',
21:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:18 INFO - 'PWD': '/builds/slave/test',
21:20:18 INFO - 'SHELL': '/bin/bash',
21:20:18 INFO - 'SHLVL': '1',
21:20:18 INFO - 'TERM': 'linux',
21:20:18 INFO - 'TMOUT': '86400',
21:20:18 INFO - 'USER': 'cltbld',
21:20:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:18 INFO - '_': '/tools/buildbot/bin/python'}
21:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:20:18 INFO - Downloading/unpacking flake8
21:20:18 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
21:20:18 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
21:20:18 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
21:20:18 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
21:20:18 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
21:20:18 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
21:20:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
21:20:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
21:20:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:20 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
21:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8
21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
21:20:21 INFO - no previously-included directories found matching 'docs/_build'
21:20:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
21:20:21 INFO - Running setup.py install for pep8
21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
21:20:21 INFO - no previously-included directories found matching 'docs/_build'
21:20:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin
21:20:21 INFO - Successfully installed flake8 mccabe pyflakes pep8
21:20:21 INFO - Cleaning up...
21:20:21 INFO - Return code: 0
21:20:21 INFO - Running post-action listener: _resource_record_post_action
21:20:21 INFO - Running post-action listener: _start_resource_monitoring
21:20:21 INFO - Starting resource monitoring.
21:20:21 INFO - #####
21:20:21 INFO - ##### Running install step.
21:20:21 INFO - #####
21:20:21 INFO - Running pre-action listener: _resource_record_pre_action
21:20:21 INFO - Running main action method: install
21:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:20:21 INFO - Reading from file tmpfile_stdout
21:20:21 INFO - Detecting whether we're running mozinstall >=1.0...
21:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
21:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
21:20:21 INFO - Reading from file tmpfile_stdout
21:20:21 INFO - Output received:
21:20:21 INFO - Usage: mozinstall [options] installer
21:20:21 INFO - Options:
21:20:21 INFO - -h, --help show this help message and exit
21:20:21 INFO - -d DEST, --destination=DEST
21:20:21 INFO - Directory to install application into. [default:
21:20:21 INFO - "/builds/slave/test"]
21:20:21 INFO - --app=APP Application being installed. [default: firefox]
21:20:21 INFO - mkdir: /builds/slave/test/build/application
21:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application']
21:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application
21:20:37 INFO - Reading from file tmpfile_stdout
21:20:37 INFO - Output received:
21:20:37 INFO - /builds/slave/test/build/application/firefox/firefox
21:20:37 INFO - Running post-action listener: _resource_record_post_action
21:20:37 INFO - #####
21:20:37 INFO - ##### Running run-tests step.
21:20:37 INFO - #####
21:20:37 INFO - Running pre-action listener: _resource_record_pre_action
21:20:37 INFO - Running main action method: run_tests
21:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
21:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
21:20:37 INFO - Python 2.7.3
21:20:37 INFO - Return code: 0
21:20:37 INFO - grabbing minidump binary from tooltool
21:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
21:20:37 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/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 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
21:20:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build
21:20:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache
21:20:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
21:20:37 INFO - Return code: 0
21:20:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
21:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
21:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
21:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
21:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
21:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos']
21:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos
21:20:38 INFO - Return code: 0
21:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build
21:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log
21:20:38 INFO - Using env: {'DISPLAY': ':0',
21:20:38 INFO - 'HOME': '/home/cltbld',
21:20:38 INFO - 'LANG': 'en_US.UTF-8',
21:20:38 INFO - 'LANGUAGE': 'en_US:en',
21:20:38 INFO - 'LOGNAME': 'cltbld',
21:20:38 INFO - 'MAIL': '/var/mail/cltbld',
21:20:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
21:20:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
21:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:20:38 INFO - 'MOZ_NO_REMOTE': '1',
21:20:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
21:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:20:38 INFO - 'NO_EM_RESTART': '1',
21:20:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:20:38 INFO - 'PWD': '/builds/slave/test',
21:20:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
21:20:38 INFO - 'SHELL': '/bin/bash',
21:20:38 INFO - 'SHLVL': '1',
21:20:38 INFO - 'TERM': 'linux',
21:20:38 INFO - 'TMOUT': '86400',
21:20:38 INFO - 'USER': 'cltbld',
21:20:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883',
21:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:20:38 INFO - '_': '/tools/buildbot/bin/python'}
21:20:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600
21:20:38 INFO - mozversion application_buildid: 20160425204203
21:20:38 INFO - mozversion application_changeset: f2b20c6eb71dbf7a2884a776251e760e73b8c69b
21:20:38 INFO - mozversion application_display_name: Nightly
21:20:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
21:20:38 INFO - mozversion application_name: Firefox
21:20:38 INFO - mozversion application_remotingname: firefox
21:20:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team
21:20:38 INFO - mozversion application_vendor: Mozilla
21:20:38 INFO - mozversion application_version: 49.0a1
21:20:38 INFO - mozversion platform_buildid: 20160425204203
21:20:38 INFO - mozversion platform_changeset: f2b20c6eb71dbf7a2884a776251e760e73b8c69b
21:20:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team
21:20:38 INFO - mozversion platform_version: 49.0a1
21:20:38 INFO - using testdate: 1461644438
21:20:38 INFO - actual date: 1461644438
21:20:38 INFO - starting webserver on 'localhost:52549'
21:20:38 INFO - SUITE-START | Running 2 tests
21:20:38 INFO - TEST-START | dromaeo_css
21:20:38 INFO - operating with platform_type : linux_
21:20:38 INFO - Initialising browser for dromaeo_css test...
21:20:38 INFO - TEST-INFO | started process 9320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTyuVQ/profile http://localhost:52549/getInfo.html)
21:20:43 INFO - PROCESS | 9320 | __metrics Screen width/height:1600/1200
21:20:43 INFO - PROCESS | 9320 | colorDepth:24
21:20:43 INFO - PROCESS | 9320 | Browser inner width/height: 1024/697
21:20:43 INFO - PROCESS | 9320 | __metrics
21:20:44 ERROR - PROCESS | 9320 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
21:20:45 INFO - TEST-INFO | 9320: exit 0
21:20:45 INFO - Browser initialized.
21:20:45 INFO - Running cycle 1/1 for dromaeo_css test...
21:20:45 INFO - TEST-INFO | started process 9406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTyuVQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:20:57 INFO - PROCESS | 9406 | RSS: Main: 155533312
21:20:57 INFO - PROCESS | 9406 |
21:21:48 INFO - PROCESS | 9406 | 1461644508758 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]
21:24:00 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52549/tests/dromaeo/cssquery-ext.html)
21:24:01 INFO - PROCESS | 9406 | RSS: Main: 247427072
21:24:01 INFO - PROCESS | 9406 |
21:27:03 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-ext.html (next: http://localhost:52549/tests/dromaeo/cssquery-jquery.html)
21:27:04 INFO - PROCESS | 9406 | RSS: Main: 236052480
21:27:04 INFO - PROCESS | 9406 |
21:30:06 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52549/tests/dromaeo/cssquery-mootools.html)
21:30:06 INFO - PROCESS | 9406 | RSS: Main: 241004544
21:30:06 INFO - PROCESS | 9406 |
21:33:09 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52549/tests/dromaeo/cssquery-prototype.html)
21:33:09 INFO - PROCESS | 9406 | RSS: Main: 235798528
21:33:09 INFO - PROCESS | 9406 |
21:36:12 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52549/tests/dromaeo/cssquery-yui.html)
21:36:13 INFO - PROCESS | 9406 | RSS: Main: 213426176
21:36:13 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-yui.html (next: http://localhost:52549/tests/dromaeo/cssquery-dojo.html)
21:39:16 INFO - PROCESS | 9406 | RSS: Main: 280621056
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | __start_tp_report
21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_page_load
21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_page_load_details
21:39:16 INFO - PROCESS | 9406 | |i|pagename|runs|
21:39:16 INFO - PROCESS | 9406 | |0;dojo.html;2576.4847030593883;2645.8941642334307;2648.417348183399;2670.4659068186365;2687.744664256895;4542.091581683669;4616.12293664204;4628.490866004741;4656;4656.534346565341;4637.559431853977;4652.906941861161;4695.506971767966;4720.622350211984;4732.1245569569655;4229.513605935326;4237.4703162104815;4270.316749320109;4296.656267498593;4392.758398288093;4310.827566897336;4338.826446942118;4350.042990542076;4366.366876802862;4399.142167277382;4158.6673066154635;4189.07840275139;4246.8725938221905;4247.256730072256;4271.743695378287;4202.85290014851;4259.91480170398;4262.850800221977;4309.82760689572;4330.112326972963;4204.705670603059;4247.575242475758;4255.1915136124035;4261.105167914741;4306.935395969063;4414.933775993362;4461.0854774771415;4489.1919454498175;4525.140223357585;4577.610903073243;4992.276119962585;5013.623978201613;5017.347744793154;5021.372328458942;5068.543831055186;5021.497850214986;5040.722760248185;5044.697318160922;5048.29323894655;5060.089183946925;4431.645468362523;4658.627309815274;4688.5545873142;4708.693934894221;4751.548602882721;5068.4424713281505;5069.44236134025;5085.6948583084395;5127.820526281562;5146.022255771391;4868.148074087091;4886.65793394459;4890;4894.608431325485;4935.259711043373;4751.619870410359;4915.188993816052;4929.383827021622;4947.802087916515;5015.448300686921;4886.242632391985;4911.068624172008;4913.950860491421;4919.877003074952;4943.382077240345;4902.730349830794;4905.411350637875;4910.083349563767;4914.778834952435;4931.211006239057;4111.424400583921;4189.790510474464;4191.266528357525;4195.139996300751;4288.485381754147;3667.541557305337;3692.4461330800596;3703.777773333609;3722.6277372262557;3751.1934933989323;4315.762633055149;4316.525182229952;4316.956830431718;4353.564643535621;4364.323529852878;5014.047331007097;5027.271045698353;5035.320231768737;5036.395632524121;5084.313617661643;4125.91748165035;4210.263203939298;4265.125649241898;4290.957090429119;4300.247456695066;4541.091781643619;4541.8183272669385;4546.931796023062;4572.702774319659;4583.977080114578;4711.586524042842;4717.976410117996;4719.551642593948;4720.339152518582;4729.834455794031;4755.310479980452;4867.3915760529935;5000.1749711297225;5008.774605142705;5027.69833809958;4648.418947631546;4660.394148760775;4664.813407463799;4673.976630116827;4711.316859055486;4888.266759986031;4899.240617704261;4900.14247506692;4906.362172917497;4943.011397720398;4732.905341893212;4901.975490122527;4963.131451995814;4974.751262436791;5002.349694539686;4816.735079570657;4837.927431088466;4844.854654360375;4864.635152363658;4883.90232195347;4792.2332426811545;4821.325014498043;4830.4444988826735;4832;4880.048390563806;4504.054148628694;4747.762611869462;4758.095961767253;4844.612431005582;4867.756612169448;4805.831795887128;4809.615230781599;4816.783244753924;4824.903501930012;4828.058528586892;4739.905201896012;4745.549172828576;4747.548982846624;4781.258904869751;4787.257975013878
21:39:16 INFO - PROCESS | 9406 | |1;ext.html;583.9838680695589;603.7343568829715;605.4278706622242;622.5828694774502;624.4972796898501;26657.866710666443;33367.49948750767;33929.49105763409;34364.31271374574;34450;39141.41287880684;39787;39884.80057599715;39897.202055958864;39999;7609.162992070882;7807.648655810473;7815.882761758549;7816.140224575292;7817;7695.653695583685;7805.804854878616;7829.373650108007;7831.138574756772;7831.843363132734;7820.100688420819;7832.373410127205;7889.211078892123;7897.368210543143;7897.605119744018;7754.340881025119;7836;7837;7837.647305871221;7841.96079019607;7621.3902887768845;7729.497582657109;7742.729004484816;7743.264389882952;7748.418868584822;35835;36239.4564081539;36391.81804090989;36406.81796591027;36559.63440365589;3011.6687164411896;3143.984280078585;3191.2341038150676;3438.6045604755523;3733.9813300933592;27596.172114836587;27942;28160.577591336147;28264.858675706695;28753.71246287531;3490.336836001152;3524.1894364296354;3530.699890509284;3552.0587044433246;3638.909027274313;224626.99999999837;224709;226960;227187;228239;49541.50458495441;50409;50516;50591;50614.697750690866;48986;50391.49608503941;50455;50469;50479;13288.601341959757;13445.32773361328;13463;13470.595882123553;13478.056536042579;10786.622468213574;10879.075278601249;10895.019448249695;10900.07349375312;10900.563977440972;17751.11244437773;17831.554211144827;17959.910200448914;17983.73024404635;18603.162857671436;6698.63157526331;6861.656917154122;6952.93047069533;7058.71765129389;7308.707651693979;847.4025811802665;887.8401887660283;896.3232759266842;989.1938070472542;1019.7909428567126;24532.50934981326;24865.129720459696;25067.37331566689;25086.247412577653;25092.372690682878;962.5139304651246;987.8024395121005;1006.436395618456;1030.5227714696364;1071.0253669161182;13615.251161186032;13929.791053134211;14059.437622494986;14175.71648567023;14272.85727142736;312993;314264;318249;318498;319105;45793.5420645796;46574;46577.30134047992;46600.5339946603;46635.30047049297;1059.586761163147;1204.8132539456399;1266.5630357526638;1272.3574594829552;1286.5111257722006;25079.49841003206;27067.864660676572;27208.72791272062;27463.588046178924;27665.446691066467;39920.60079399169;40791.59208407878;40884.18231635291;40939.59060409358;40952.79523602363;220755;221240;221416;221658;222307;21239.256626018014;22564.097436102373;23169.652455213523;23204.76795232026;24051;35217.295654086265;35588.110297242776;35612.28775424529;35625.287494250486;36328.09179770527;30646.233844154074;32698.673013269563;33440;33650.83174584111;33722;30418.695813042472;33274.667253327156;33472.66527334793;33792.15519611931;34023.65976340304;32921.34157316793;33495.33009339751;33660;33744.83127584346;33760;28795.712042879302;29897.850510747307;29968.700312997462;30355.2411189722;30370.54444183295;23400.414989625395;23566.130718303277;23808.642870356613;23932.28203153908;24008.87995560011
21:39:16 INFO - PROCESS | 9406 | |2;jquery.html;381.7270651484189;383.84262452394523;383.99232015359695;386.87813338798276;395.70915377197775;15480.458183963563;16434.096124713134;16528.75206871898;16553.91723041383;16728.163591820423;16039;16417.91791041043;17059.744103838453;17071.48785536433;17077.91461042693;5022.522860328263;5222.007818514489;5243.659162154467;5251.133562962125;5256.027634887539;3620.275944811035;5693.402192769761;6000.18997435345;6015.6992150392525;6021.578489505737;5863.237779088712;5949.5537834662355;5955.464008239258;5962.34414214436;5964.105384192362;5817.796377126801;5963.761449542057;6004.249468816398;6009.158717779536;6012.128241404994;3337.7997320160866;3524.84138213781;3526.453399723047;3528.541289632357;5050.696958182521;19590.902045489824;19596.118174682175;19648.80351196484;20073.096710648057;20804.16783328665;1904.9142788574409;1983.7421135252469;2022.8179463848178;2067.400453868376;2616.7906567474556;8751.649934002633;9049.78280321319;9406.858897116548;11281.461671123932;13041.08712390133;1666.9166541672869;1768.6109056007786;1797.604527004057;1806.9277228910828;1841.686913224755;57943.42056579422;59645.701771490865;59873;59929.99999999956;60753;9780.364276322016;9853.852192217122;9916.900830991597;9979.852316983495;10023.949880250699;13986.230757308242;14280.285985700673;14288.071275367276;14293.928530357281;14312.427502899767;7362.190159082496;7366;7443.590602516913;7539.547627142389;7566;6904.585724856524;6924.4114250289285;6941.201761797458;7072.823179420556;7124.323189297009;4406.669499787465;4410;4430.246858034077;4492.427650322361;4534.161180181677;1721.4491362763795;1743.744503957149;1831.1759708131394;1837.1916356802965;1854;842.9494230346199;843.3084870406208;880.903100658927;886.2156991062827;965.6330594374093;15345.232738363036;15515.456959006606;15973.440929567409;16107.114108724132;16160.595985100466;795.0221227889613;844.6663567890648;847.2290215903498;859.4155973937658;864.2481041493941;9134.451932884049;9552;9593.856092158623;9619.18236949853;9647.602254948193;349437;358129;363865;366989;368225;78025;79159.20840791633;79489.60255198687;80029.59985200036;82518;929.6002718830832;957.9856302155334;979.9657012004545;987.3187500624546;993.0119531066634;14147.64630884236;14477.276136193359;14880.107193568421;15982.120983346027;16212.189390530662;35320.47019294764;35426.82286588551;36185.45721814228;36602.63397366099;37004.25991480209;45266.32100518561;46754.25965922786;46969.29546056744;47157;47275.290870637655;7815.25755053269;7969.481983671043;7999.280064794197;8032.718854840053;8102.716404925799;10852.565897364017;11186.440677966231;11241.49413276388;11488.79367666383;12053.638390847938;10286.691399258034;10549.472526373496;10571.101456376295;10830.241883068109;11248.606298779503;10360.378377297386;10365.84451233217;10624.84062739044;10675.359478431319;10853.294535855144;5633.0705433604635;6834.829129271609;10760.332148516993;10885.23803333759;11148.442577871236;7771.222877712184;7963.16386779403;8110.580648386626;8130.6573786687995;8279.668813247403;8238;10038.19694424459;11002.50488728025;11048.281861678965;11055.557777688802
21:39:16 INFO - PROCESS | 9406 | |3;mootools.html;1196.1088988703407;1290.2129700882463;1399.9370028348724;1436.3033928544653;1816.3098022751353;6161.414665606766;7047.224805271422;7192.352688258055;7200.96399518003;7202.819929501758;6857.554258973163;7011.929880701192;7019.192792828826;7019.227884932666;7026.85946281074;1833.5599456130567;2101.2015434135005;2159.3306075116684;2182.432567532437;2186.4752459409788;2202.548477562104;2233.6426171812514;2234.1398561553838;2238.4851484158653;2242.495438526335;2143.839212059094;2195.034184958613;2196.9450763730956;2196.9780302197014;2198.0658220256405;1833.8441232495254;2130.1053557505884;2184.224600266898;2188;2188.518525924294;2147.957040859174;2160.2547121243147;2169.967450488244;2170.533335332895;2207.7792220777956;7401.888971665429;7527.059117610299;7578.772636820849;7585.658645360972;7603.353714934237;4357.912841743179;4575.816967321303;4578.221702310615;4579;4581.060882519076;2832.9433411331656;2835.248659105339;2878.0070875548113;2887.220450478359;2893.652761668613;924.4129977464358;937.1331518345503;942.3074040580168;958.0515289863055;968.099667309402;10206.387616742944;10225.386476811414;10246.38521688701;10248.538815753309;10262.281640285182;4153.7300075494995;4196.118815048874;4291.957080429156;4296.183725092223;4308.6983911126545;8719.215270625675;8768.430052046597;8788.692395766118;8804.251638610789;8807.779805504786;3761.7366784324836;4552.795124219418;4638.466576343763;4656.976715116402;4660.300954856731;4037.1723796621623;4137.91724165521;4149.688773342012;4151.4395556600075;4152.937705934413;3454.758166928291;3472.722182225416;3590.1024743814046;3610.9638903611153;3618.0412190769466;1162.215504534436;1170.7482891178438;1176.758764453285;1177.370106992772;1182.8876256755595;823.7693445835175;839;846.8729690546468;861.2335021830576;861.9957749222211;4893.804247830119;5088.084144853962;5149.76826042829;5165.199394093921;5185.0148471790235;401.5201833808571;414.9688773342011;423.18536816628483;436.5699785711072;445.62567443347746;3336.899893003214;3395.6264810870784;3455.188030812757;3475.42655461851;3495.4232551629207;8462.61918213682;8757.824843503222;8771.122887711177;8793.296536277083;8865.778355541162;8674.175953284428;8754.649814007496;8758.781030474162;8772.956135219283;8797.736067917973;6677.966610166918;6759.290274521104;6799.286074962058;6807.761728339583;6816.113905192393;4854.126257273725;4942.382202224722;4982.7259500727805;5131.974340128276;5179.326687530597;8265.421420500506;8325.666973321;8327;8387.874181887399;8445.239928406472;8132.942717446694;8433.83132337362;8459.06950235486;8655.82688346217;8660.653573856975;5602.075657516627;6299.716512757029;6314.179156709598;6464.7393758216695;6590.538662293785;7242.420606351585;7244.927550724636;7299.963500182465;7313.049303590499;7333.6699848508015;6365.681715914093;6568.343165683585;6568.8357791055605;6666.066750654815;6670.199576050905;6029.577929545065;6480.481561475165;6515.478761699147;6595.307492713388;6644.800655980328;6011.489023432882;6070.726817293321;6089.421504957022;6090.9390906090375;6092.299385570716;4180.707350485437;4364.148990946735;4385.079133382025;4446.021875187454;4476.888077797951;4327.459067616548;4399.362092496634;4408.470983482002;4434.423524941737;4477.261251893401
21:39:16 INFO - PROCESS | 9406 | |4;prototype.html;283.8297021786927;301.50101581881984;303.59015329305424;305.0710586264824;305.1151660185462;4485.618722408599;4620.676552641316;4634.397528321313;4716;4718.952810471894;4498.415206023221;4601.217792975194;4635.559621835929;4638.072385522892;4641.396618439607;3686.447032945053;3708.83310251038;3720.7581507202012;3729.3100776356323;3740.700743940492;3524.990755269497;3554.7689400188906;3704.259148170363;3740.831662575191;3744.6255374462608;3696.1683621185152;3705.6294370562864;3707.499487569184;3709.202521457886;3710.810621733177;3661.853525858976;3687.3178461984617;3693.319539609471;3697.7041836653;3707.4253490708984;3293.2919422324076;3298.4887342461716;3303.438415469376;3314.005798260512;3315.635280119185;4288.078063216423;4497.123061003105;4529.660275479319;4554.134714404253;4554.316852472122;4152.356384760367;4160.438340824011;4163.458750362433;4176.373543968399;4204.11713540157;4898.730569818694;4905.2642103684375;4908.558229759339;4932.284818701268;4937.802487900515;3308.652591477884;3505.8948231553095;3517.296540691872;3526.1008442847165;3532.6114127445962;5073.162928116856;5093.5415812576675;5120.871978200537;5136.563392111675;5138.897222055575;3553.4136867416587;3567.108222944264;3573.1960308930284;3582.7671201371827;3589.4615807628543;3623.6195199503672;3634.9636503635156;3635.2002559436883;3636.8363423646;3655.415133578668;3918.1771827916455;4158.272302347077;4160;4170.791460426966;4177.227212965611;4892.241702536113;4934.185859333242;4943.24514797249;4944.159492886218;4945.082401383202;1240.9131360804656;1250.8624051354343;1316.776148054833;1324.569514907659;1334.6863487080527;879.5909901895521;884.920357167845;901.7430032440855;905.9909400905907;906.7597086771879;4572.634189264851;4577.244754615451;4578.97710511452;4582;4590.655700822452;5310.336207974004;5316.707581083;5327.866803329948;5345.118055520873;5345.198220266913;4469.904873305995;4576;4596.770161491912;4600.539946005372;4620.353150558924;2836.6170566973196;2856.8428736419282;2865.3409715765074;2869.8421586812924;2871.3682989742224;5000.499950004971;5011.298418221452;5037.722925239073;5040.067587496325;5045.142325804622;5311.442298558673;5444.809431669952;5478.726063696879;5485.972570137204;5491.807786727445;5006.3992320921725;5022.146235140035;5037.19404895215;5039.193729003342;5050.292958985745;5361.490658387447;5361.758720857492;5370.845268267341;5371.946280537145;5382.111951528111;5033.446320904624;5219.451957544555;5237.895242095213;5258.89482210346;5260.158374660036;5030.496950304941;5035.5468007878;5050.141475949171;5074.5686616637995;5077.568406685473;3775.11284848055;3780.0549862534367;3780.2250538640064;3787.3182827091387;3792.1088544192644;4784.569388755029;5218.504242096995;5343.091674415281;5351.1973204019705;5372.952274306473;4743.193657078236;4849.393825771778;4904.449686163104;4924.187509060965;4943.802247910044;4881.755912204305;4897.730624815526;4905.852824415273;4934.100371356982;4940.8764780880765;4637.310359991265;4861.732604706775;4869.902601947871;4880.341153944314;4885.95114048855;4993.650444468853;4994.800207991785;5012.4736902626155;5017.473165317735;5038.319826823332;4905.533974272438;4931.901361972812;4946.505349465168;4965.851024469272;4966.261808367042
21:39:16 INFO - PROCESS | 9406 | |5;yui.html;665.7337065173931;708.7909066825284;760.9505382150163;790.2650535002449;792.7463211772235;12093.879061209385;12440.129190956637;12444.688882777946;12480.812787808167;12489.812652810204;11661.708457288572;11895.881041189585;12027.639170824867;12034.097442691811;12042.759144817099;644.0789670770796;779.4504874063786;808.7856717969743;809.9271065604095;814.8818421328904;767.1484652036236;802.8514724775906;805.3838813307824;805.5851236613149;806.31060443321;851.8935133108362;857.9571021448934;858.669412276275;858.909814469481;859.1794835931702;675.6419097878132;692.3664846665296;852.846487632226;853.803625166209;854.1757204297851;512.7513156119279;609.1684850179518;626.9561130720851;627.3851625407127;627.8179327994876;12181.208221465666;12186.329751863645;12194.75610487794;12212.08409369292;12223.388830558526;11690.649280521598;12060.155789094766;12092.697682557919;12468.875311246953;12851.293178875158;9415.05849415053;9808.95095524525;9814.803703925953;9888.307818452711;10004.449755263458;3331;3354.681305275995;3356.9832150839334;3415.043787739437;3421.3328400961823;43746.34380484295;44461;44810.32784508235;44941.32588011182;46299.76850115762;9415.670451534163;9635.614575416905;9646.565904534313;9682.177014953668;9752.609895604097;16231.594210144605;16384.672306553803;16475.58811029734;16549.338026479047;16584.08787516698;6767.593944363354;6771.762988295484;6839.487038472134;6905.1713794345;6999.265077166926;3806.3909774435956;3849.2493963676816;3888.727789054739;3960.0495880988356;4007.479027726435;2812.774978001755;2906.070057581596;2913.038697229909;2913.4901392256693;2918.124562631202;523.7931017248166;533.557147567518;537.1432565058725;540.2544488605699;544.335910189576;528.6748649580558;583.8569550460079;592.1473078766649;621.3413781391739;641.8491654461197;7576.24237576238;7962.7213047543055;8001.319887809602;8258.958705206556;8471.279941204943;594.3669991459083;608.9360617135226;638.5306799502362;640.078287266335;653.1541653558653;3833.8085782960034;3920.3923391874305;4006.278869803405;4071.1247081877536;4132.483439570054;45811.54188458139;46001;47480.52519474761;50167.498325016284;51689.741551292755;40660.18679626391;41028.79485602553;41223.763287101436;46091;46914.29628555574;44216.55783442124;44220.11559768851;44517.332240016425;44937.32594011027;45285;8586.356023298153;8587.871181932402;8658.134186581292;8733.56332183401;8867;28919.855400722863;28987;29709.702902970694;29768.255793605334;30072;35467.645323546436;36976;39395;39621.60378396179;40091.79954100211;10080.495975201356;10103.494825258855;10150;10221.182305415698;10526.263161578616;11407.714807129889;11491.885081149416;12307.56923507673;12339.568115115928;12477.188982716094;10723.678289651323;11312.20814543007;11370.31778093317;11392.601258956229;11742.295462272292;10949.671509854717;11255.606053788078;11449.42752862337;11523.366214858263;11566;11112.611058612909;11338.65935332573;11427.085833133164;11569.19015668895;11588.420578970849;9294.581743821409;9495.620175192915;9560.76098097553;9681.322307438411;9700.514974251118;9430.82114735658;9540.379875308083;9598.616055357708;9618.086281803218;9670.70987870365
21:39:16 INFO - PROCESS | 9406 | __end_tp_report
21:39:16 INFO - PROCESS | 9406 | __start_cc_report
21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_cycle_collect,937
21:39:16 INFO - PROCESS | 9406 | __end_cc_report
21:39:16 INFO - PROCESS | 9406 | __startTimestamp1461645556566__endTimestamp
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | ------- Summary: start -------
21:39:16 INFO - PROCESS | 9406 | Number of tests: 6
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#0] dojo.html Cycles:165 Average:4591.03 Median:4720.62 stddev:473.39 (10.0%) stddev-sans-first:447.69
21:39:16 INFO - PROCESS | 9406 | Values: 2576.5 2645.9 2648.4 2670.5 2687.7 4542.1 4616.1 4628.5 4656.0 4656.5 4637.6 4652.9 4695.5 4720.6 4732.1 4229.5 4237.5 4270.3 4296.7 4392.8 4310.8 4338.8 4350.0 4366.4 4399.1 4158.7 4189.1 4246.9 4247.3 4271.7 4202.9 4259.9 4262.9 4309.8 4330.1 4204.7 4247.6 4255.2 4261.1 4306.9 4414.9 4461.1 4489.2 4525.1 4577.6 4992.3 5013.6 5017.3 5021.4 5068.5 5021.5 5040.7 5044.7 5048.3 5060.1 4431.6 4658.6 4688.6 4708.7 4751.5 5068.4 5069.4 5085.7 5127.8 5146.0 4868.1 4886.7 4890.0 4894.6 4935.3 4751.6 4915.2 4929.4 4947.8 5015.4 4886.2 4911.1 4914.0 4919.9 4943.4 4902.7 4905.4 4910.1 4914.8 4931.2 4111.4 4189.8 4191.3 4195.1 4288.5 3667.5 3692.4 3703.8 3722.6 3751.2 4315.8 4316.5 4317.0 4353.6 4364.3 5014.0 5027.3 5035.3 5036.4 5084.3 4125.9 4210.3 4265.1 4291.0 4300.2 4541.1 4541.8 4546.9 4572.7 4584.0 4711.6 4718.0 4719.6 4720.3 4729.8 4755.3 4867.4 5000.2 5008.8 5027.7 4648.4 4660.4 4664.8 4674.0 4711.3 4888.3 4899.2 4900.1 4906.4 4943.0 4732.9 4902.0 4963.1 4974.8 5002.3 4816.7 4837.9 4844.9 4864.6 4883.9 4792.2 4821.3 4830.4 4832.0 4880.0 4504.1 4747.8 4758.1 4844.6 4867.8 4805.8 4809.6 4816.8 4824.9 4828.1 4739.9 4745.5 4747.5 4781.3 4787.3
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#1] ext.html Cycles:180 Average:40694.75 Median:33752.42 stddev:67607.46 (200.3%) stddev-sans-first:67730.04
21:39:16 INFO - PROCESS | 9406 | Values: 584.0 603.7 605.4 622.6 624.5 26657.9 33367.5 33929.5 34364.3 34450.0 39141.4 39787.0 39884.8 39897.2 39999.0 7609.2 7807.6 7815.9 7816.1 7817.0 7695.7 7805.8 7829.4 7831.1 7831.8 7820.1 7832.4 7889.2 7897.4 7897.6 7754.3 7836.0 7837.0 7837.6 7842.0 7621.4 7729.5 7742.7 7743.3 7748.4 35835.0 36239.5 36391.8 36406.8 36559.6 3011.7 3144.0 3191.2 3438.6 3734.0 27596.2 27942.0 28160.6 28264.9 28753.7 3490.3 3524.2 3530.7 3552.1 3638.9 224627.0 224709.0 226960.0 227187.0 228239.0 49541.5 50409.0 50516.0 50591.0 50614.7 48986.0 50391.5 50455.0 50469.0 50479.0 13288.6 13445.3 13463.0 13470.6 13478.1 10786.6 10879.1 10895.0 10900.1 10900.6 17751.1 17831.6 17959.9 17983.7 18603.2 6698.6 6861.7 6952.9 7058.7 7308.7 847.4 887.8 896.3 989.2 1019.8 24532.5 24865.1 25067.4 25086.2 25092.4 962.5 987.8 1006.4 1030.5 1071.0 13615.3 13929.8 14059.4 14175.7 14272.9 312993.0 314264.0 318249.0 318498.0 319105.0 45793.5 46574.0 46577.3 46600.5 46635.3 1059.6 1204.8 1266.6 1272.4 1286.5 25079.5 27067.9 27208.7 27463.6 27665.4 39920.6 40791.6 40884.2 40939.6 40952.8 220755.0 221240.0 221416.0 221658.0 222307.0 21239.3 22564.1 23169.7 23204.8 24051.0 35217.3 35588.1 35612.3 35625.3 36328.1 30646.2 32698.7 33440.0 33650.8 33722.0 30418.7 33274.7 33472.7 33792.2 34023.7 32921.3 33495.3 33660.0 33744.8 33760.0 28795.7 29897.9 29968.7 30355.2 30370.5 23400.4 23566.1 23808.6 23932.3 24008.9
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#2] jquery.html Cycles:180 Average:23154.95 Median:4408.33 stddev:59703.28 (1354.3%) stddev-sans-first:59846.28
21:39:16 INFO - PROCESS | 9406 | Values: 381.7 383.8 384.0 386.9 395.7 15480.5 16434.1 16528.8 16553.9 16728.2 16039.0 16417.9 17059.7 17071.5 17077.9 5022.5 5222.0 5243.7 5251.1 5256.0 3620.3 5693.4 6000.2 6015.7 6021.6 5863.2 5949.6 5955.5 5962.3 5964.1 5817.8 5963.8 6004.2 6009.2 6012.1 3337.8 3524.8 3526.5 3528.5 5050.7 19590.9 19596.1 19648.8 20073.1 20804.2 1904.9 1983.7 2022.8 2067.4 2616.8 8751.6 9049.8 9406.9 11281.5 13041.1 1666.9 1768.6 1797.6 1806.9 1841.7 57943.4 59645.7 59873.0 59930.0 60753.0 9780.4 9853.9 9916.9 9979.9 10023.9 13986.2 14280.3 14288.1 14293.9 14312.4 7362.2 7366.0 7443.6 7539.5 7566.0 6904.6 6924.4 6941.2 7072.8 7124.3 4406.7 4410.0 4430.2 4492.4 4534.2 1721.4 1743.7 1831.2 1837.2 1854.0 842.9 843.3 880.9 886.2 965.6 15345.2 15515.5 15973.4 16107.1 16160.6 795.0 844.7 847.2 859.4 864.2 9134.5 9552.0 9593.9 9619.2 9647.6 349437.0 358129.0 363865.0 366989.0 368225.0 78025.0 79159.2 79489.6 80029.6 82518.0 929.6 958.0 980.0 987.3 993.0 14147.6 14477.3 14880.1 15982.1 16212.2 35320.5 35426.8 36185.5 36602.6 37004.3 45266.3 46754.3 46969.3 47157.0 47275.3 7815.3 7969.5 7999.3 8032.7 8102.7 10852.6 11186.4 11241.5 11488.8 12053.6 10286.7 10549.5 10571.1 10830.2 11248.6 10360.4 10365.8 10624.8 10675.4 10853.3 5633.1 6834.8 10760.3 10885.2 11148.4 7771.2 7963.2 8110.6 8130.7 8279.7 8238.0 10038.2 11002.5 11048.3 11055.6
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#3] mootools.html Cycles:180 Average:4886.58 Median:4873.97 stddev:2680.55 (55.0%) stddev-sans-first:2673.72
21:39:16 INFO - PROCESS | 9406 | Values: 1196.1 1290.2 1399.9 1436.3 1816.3 6161.4 7047.2 7192.4 7201.0 7202.8 6857.6 7011.9 7019.2 7019.2 7026.9 1833.6 2101.2 2159.3 2182.4 2186.5 2202.5 2233.6 2234.1 2238.5 2242.5 2143.8 2195.0 2196.9 2197.0 2198.1 1833.8 2130.1 2184.2 2188.0 2188.5 2148.0 2160.3 2170.0 2170.5 2207.8 7401.9 7527.1 7578.8 7585.7 7603.4 4357.9 4575.8 4578.2 4579.0 4581.1 2832.9 2835.2 2878.0 2887.2 2893.7 924.4 937.1 942.3 958.1 968.1 10206.4 10225.4 10246.4 10248.5 10262.3 4153.7 4196.1 4292.0 4296.2 4308.7 8719.2 8768.4 8788.7 8804.3 8807.8 3761.7 4552.8 4638.5 4657.0 4660.3 4037.2 4137.9 4149.7 4151.4 4152.9 3454.8 3472.7 3590.1 3611.0 3618.0 1162.2 1170.7 1176.8 1177.4 1182.9 823.8 839.0 846.9 861.2 862.0 4893.8 5088.1 5149.8 5165.2 5185.0 401.5 415.0 423.2 436.6 445.6 3336.9 3395.6 3455.2 3475.4 3495.4 8462.6 8757.8 8771.1 8793.3 8865.8 8674.2 8754.6 8758.8 8773.0 8797.7 6678.0 6759.3 6799.3 6807.8 6816.1 4854.1 4942.4 4982.7 5132.0 5179.3 8265.4 8325.7 8327.0 8387.9 8445.2 8132.9 8433.8 8459.1 8655.8 8660.7 5602.1 6299.7 6314.2 6464.7 6590.5 7242.4 7244.9 7300.0 7313.0 7333.7 6365.7 6568.3 6568.8 6666.1 6670.2 6029.6 6480.5 6515.5 6595.3 6644.8 6011.5 6070.7 6089.4 6090.9 6092.3 4180.7 4364.1 4385.1 4446.0 4476.9 4327.5 4399.4 4408.5 4434.4 4477.3
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#4] prototype.html Cycles:180 Average:4173.68 Median:4636.43 stddev:1219.17 (26.3%) stddev-sans-first:1187.12
21:39:16 INFO - PROCESS | 9406 | Values: 283.8 301.5 303.6 305.1 305.1 4485.6 4620.7 4634.4 4716.0 4719.0 4498.4 4601.2 4635.6 4638.1 4641.4 3686.4 3708.8 3720.8 3729.3 3740.7 3525.0 3554.8 3704.3 3740.8 3744.6 3696.2 3705.6 3707.5 3709.2 3710.8 3661.9 3687.3 3693.3 3697.7 3707.4 3293.3 3298.5 3303.4 3314.0 3315.6 4288.1 4497.1 4529.7 4554.1 4554.3 4152.4 4160.4 4163.5 4176.4 4204.1 4898.7 4905.3 4908.6 4932.3 4937.8 3308.7 3505.9 3517.3 3526.1 3532.6 5073.2 5093.5 5120.9 5136.6 5138.9 3553.4 3567.1 3573.2 3582.8 3589.5 3623.6 3635.0 3635.2 3636.8 3655.4 3918.2 4158.3 4160.0 4170.8 4177.2 4892.2 4934.2 4943.2 4944.2 4945.1 1240.9 1250.9 1316.8 1324.6 1334.7 879.6 884.9 901.7 906.0 906.8 4572.6 4577.2 4579.0 4582.0 4590.7 5310.3 5316.7 5327.9 5345.1 5345.2 4469.9 4576.0 4596.8 4600.5 4620.4 2836.6 2856.8 2865.3 2869.8 2871.4 5000.5 5011.3 5037.7 5040.1 5045.1 5311.4 5444.8 5478.7 5486.0 5491.8 5006.4 5022.1 5037.2 5039.2 5050.3 5361.5 5361.8 5370.8 5371.9 5382.1 5033.4 5219.5 5237.9 5258.9 5260.2 5030.5 5035.5 5050.1 5074.6 5077.6 3775.1 3780.1 3780.2 3787.3 3792.1 4784.6 5218.5 5343.1 5351.2 5373.0 4743.2 4849.4 4904.4 4924.2 4943.8 4881.8 4897.7 4905.9 4934.1 4940.9 4637.3 4861.7 4869.9 4880.3 4886.0 4993.7 4994.8 5012.5 5017.5 5038.3 4905.5 4931.9 4946.5 4965.9 4966.3
21:39:16 INFO - PROCESS | 9406 |
21:39:16 INFO - PROCESS | 9406 | [#5] yui.html Cycles:180 Average:12577.57 Median:44939.33 stddev:13952.67 (31.0%) stddev-sans-first:13963.13
21:39:16 INFO - PROCESS | 9406 | Values: 665.7 708.8 761.0 790.3 792.7 12093.9 12440.1 12444.7 12480.8 12489.8 11661.7 11895.9 12027.6 12034.1 12042.8 644.1 779.5 808.8 809.9 814.9 767.1 802.9 805.4 805.6 806.3 851.9 858.0 858.7 858.9 859.2 675.6 692.4 852.8 853.8 854.2 512.8 609.2 627.0 627.4 627.8 12181.2 12186.3 12194.8 12212.1 12223.4 11690.6 12060.2 12092.7 12468.9 12851.3 9415.1 9809.0 9814.8 9888.3 10004.4 3331.0 3354.7 3357.0 3415.0 3421.3 43746.3 44461.0 44810.3 44941.3 46299.8 9415.7 9635.6 9646.6 9682.2 9752.6 16231.6 16384.7 16475.6 16549.3 16584.1 6767.6 6771.8 6839.5 6905.2 6999.3 3806.4 3849.2 3888.7 3960.0 4007.5 2812.8 2906.1 2913.0 2913.5 2918.1 523.8 533.6 537.1 540.3 544.3 528.7 583.9 592.1 621.3 641.8 7576.2 7962.7 8001.3 8259.0 8471.3 594.4 608.9 638.5 640.1 653.2 3833.8 3920.4 4006.3 4071.1 4132.5 45811.5 46001.0 47480.5 50167.5 51689.7 40660.2 41028.8 41223.8 46091.0 46914.3 44216.6 44220.1 44517.3 44937.3 45285.0 8586.4 8587.9 8658.1 8733.6 8867.0 28919.9 28987.0 29709.7 29768.3 30072.0 35467.6 36976.0 39395.0 39621.6 40091.8 10080.5 10103.5 10150.0 10221.2 10526.3 11407.7 11491.9 12307.6 12339.6 12477.2 10723.7 11312.2 11370.3 11392.6 11742.3 10949.7 11255.6 11449.4 11523.4 11566.0 11112.6 11338.7 11427.1 11569.2 11588.4 9294.6 9495.6 9560.8 9681.3 9700.5 9430.8 9540.4 9598.6 9618.1 9670.7
21:39:16 INFO - PROCESS | 9406 | -------- Summary: end --------
21:39:16 INFO - PROCESS | 9406 |
21:39:17 INFO - TEST-INFO | 9406: exit 0
21:39:17 INFO - TEST-OK | dromaeo_css | took 1118763ms
21:39:17 INFO - TEST-START | kraken
21:39:17 INFO - operating with platform_type : linux_
21:39:17 INFO - Initialising browser for kraken test...
21:39:17 INFO - TEST-INFO | started process 9581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh3Kab/profile http://localhost:52549/getInfo.html)
21:39:21 INFO - PROCESS | 9581 | __metrics Screen width/height:1600/1200
21:39:21 INFO - PROCESS | 9581 | colorDepth:24
21:39:21 INFO - PROCESS | 9581 | Browser inner width/height: 1024/697
21:39:21 INFO - PROCESS | 9581 | __metrics
21:39:23 ERROR - PROCESS | 9581 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
21:39:23 INFO - TEST-INFO | 9581: exit 0
21:39:23 INFO - Browser initialized.
21:39:23 INFO - Running cycle 1/1 for kraken test...
21:39:23 INFO - TEST-INFO | started process 9665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh3Kab/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:39:35 INFO - PROCESS | 9665 | RSS: Main: 156512256
21:39:35 INFO - PROCESS | 9665 |
21:39:38 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-beat-detection)
21:39:39 INFO - PROCESS | 9665 | RSS: Main: 211550208
21:39:39 INFO - PROCESS | 9665 |
21:39:42 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-dft)
21:39:42 INFO - PROCESS | 9665 | RSS: Main: 195354624
21:39:42 INFO - PROCESS | 9665 |
21:39:46 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-fft)
21:39:46 INFO - PROCESS | 9665 | RSS: Main: 268152832
21:39:46 INFO - PROCESS | 9665 |
21:39:48 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-oscillator)
21:39:49 INFO - PROCESS | 9665 | RSS: Main: 174776320
21:39:49 INFO - PROCESS | 9665 |
21:39:51 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-gaussian-blur)
21:39:52 INFO - PROCESS | 9665 | RSS: Main: 179765248
21:39:52 INFO - PROCESS | 9665 |
21:39:55 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-darkroom)
21:39:56 INFO - PROCESS | 9665 | RSS: Main: 216100864
21:39:56 INFO - PROCESS | 9665 |
21:39:59 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-desaturate)
21:40:00 INFO - PROCESS | 9665 | RSS: Main: 216174592
21:40:00 INFO - PROCESS | 9665 |
21:40:02 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52549/tests/kraken/driver.html?testName=json-parse-financial)
21:40:03 INFO - PROCESS | 9665 | RSS: Main: 217190400
21:40:03 INFO - PROCESS | 9665 |
21:40:05 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52549/tests/kraken/driver.html?testName=json-stringify-tinderbox)
21:40:05 INFO - PROCESS | 9665 | RSS: Main: 205131776
21:40:05 INFO - PROCESS | 9665 |
21:40:07 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-aes)
21:40:08 INFO - PROCESS | 9665 | RSS: Main: 206831616
21:40:08 INFO - PROCESS | 9665 |
21:40:10 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-ccm)
21:40:11 INFO - PROCESS | 9665 | RSS: Main: 217382912
21:40:11 INFO - PROCESS | 9665 |
21:40:14 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
21:40:14 INFO - PROCESS | 9665 | RSS: Main: 225337344
21:40:14 INFO - PROCESS | 9665 |
21:40:17 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
21:40:18 INFO - PROCESS | 9665 | RSS: Main: 220594176
21:40:18 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52549/tests/kraken/driver.html?testName=ai-astar)
21:40:20 INFO - PROCESS | 9665 | RSS: Main: 284393472
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | __start_tp_report
21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_page_load
21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_page_load_details
21:40:20 INFO - PROCESS | 9665 | |i|pagename|runs|
21:40:20 INFO - PROCESS | 9665 | |0;ai-astar;112;113;113;114;114;114;121;112;113;114
21:40:20 INFO - PROCESS | 9665 | |1;audio-beat-detection;154;131;153;198;136;164;158;132;202;134
21:40:20 INFO - PROCESS | 9665 | |2;audio-dft;160;161;160;160;162;163;162;162;160;161
21:40:20 INFO - PROCESS | 9665 | |3;audio-fft;78;75;105;102;75;75;76;115;121;74
21:40:20 INFO - PROCESS | 9665 | |4;audio-oscillator;95;95;141;94;94;94;150;94;93;143
21:40:20 INFO - PROCESS | 9665 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116
21:40:20 INFO - PROCESS | 9665 | |6;imaging-darkroom;146;146;146;146;146;147;147;146;146;147
21:40:20 INFO - PROCESS | 9665 | |7;imaging-desaturate;94;95;94;94;95;94;95;95;95;94
21:40:20 INFO - PROCESS | 9665 | |8;json-parse-financial;66;67;67;67;67;68;68;85;66;64
21:40:20 INFO - PROCESS | 9665 | |9;json-stringify-tinderbox;64;64;65;64;65;66;65;65;64;65
21:40:20 INFO - PROCESS | 9665 | |10;stanford-crypto-aes;80;81;82;79;89;81;81;82;82;89
21:40:20 INFO - PROCESS | 9665 | |11;stanford-crypto-ccm;131;136;129;131;145;127;130;133;170;132
21:40:20 INFO - PROCESS | 9665 | |12;stanford-crypto-pbkdf2;180;183;179;184;179;179;181;185;177;183
21:40:20 INFO - PROCESS | 9665 | |13;stanford-crypto-sha256-iterative;73;77;73;74;74;72;82;73;73;73
21:40:20 INFO - PROCESS | 9665 | __end_tp_report
21:40:20 INFO - PROCESS | 9665 | __start_cc_report
21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_cycle_collect,1894
21:40:20 INFO - PROCESS | 9665 | __end_cc_report
21:40:20 INFO - PROCESS | 9665 | __startTimestamp1461645620359__endTimestamp
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | ------- Summary: start -------
21:40:20 INFO - PROCESS | 9665 | Number of tests: 14
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:2.58 (2.3%) stddev-sans-first:2.64
21:40:20 INFO - PROCESS | 9665 | Values: 112.0 113.0 113.0 114.0 114.0 114.0 121.0 112.0 113.0 114.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:156.00 stddev:25.92 (16.6%) stddev-sans-first:27.48
21:40:20 INFO - PROCESS | 9665 | Values: 154.0 131.0 153.0 198.0 136.0 164.0 158.0 132.0 202.0 134.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09
21:40:20 INFO - PROCESS | 9665 | Values: 160.0 161.0 160.0 160.0 162.0 163.0 162.0 162.0 160.0 161.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#3] audio-fft Cycles:10 Average:89.60 Median:75.00 stddev:18.93 (25.2%) stddev-sans-first:19.61
21:40:20 INFO - PROCESS | 9665 | Values: 78.0 75.0 105.0 102.0 75.0 75.0 76.0 115.0 121.0 74.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:24.51 (26.1%) stddev-sans-first:25.45
21:40:20 INFO - PROCESS | 9665 | Values: 95.0 95.0 141.0 94.0 94.0 94.0 150.0 94.0 93.0 143.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44
21:40:20 INFO - PROCESS | 9665 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50
21:40:20 INFO - PROCESS | 9665 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53
21:40:20 INFO - PROCESS | 9665 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:67.00 stddev:5.91 (8.8%) stddev-sans-first:6.20
21:40:20 INFO - PROCESS | 9665 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 68.0 85.0 66.0 64.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67
21:40:20 INFO - PROCESS | 9665 | Values: 64.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 64.0 65.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.50 (4.3%) stddev-sans-first:3.59
21:40:20 INFO - PROCESS | 9665 | Values: 80.0 81.0 82.0 79.0 89.0 81.0 81.0 82.0 82.0 89.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:132.50 stddev:12.81 (9.7%) stddev-sans-first:13.44
21:40:20 INFO - PROCESS | 9665 | Values: 131.0 136.0 129.0 131.0 145.0 127.0 130.0 133.0 170.0 132.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:182.00 stddev:2.62 (1.4%) stddev-sans-first:2.76
21:40:20 INFO - PROCESS | 9665 | Values: 180.0 183.0 179.0 184.0 179.0 179.0 181.0 185.0 177.0 183.0
21:40:20 INFO - PROCESS | 9665 |
21:40:20 INFO - PROCESS | 9665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:73.50 stddev:2.99 (4.1%) stddev-sans-first:3.13
21:40:20 INFO - PROCESS | 9665 | Values: 73.0 77.0 73.0 74.0 74.0 72.0 82.0 73.0 73.0 73.0
21:40:20 INFO - PROCESS | 9665 | -------- Summary: end --------
21:40:20 INFO - PROCESS | 9665 |
21:40:21 INFO - TEST-INFO | 9665: exit 0
21:40:21 INFO - TEST-OK | kraken | took 64101ms
21:40:21 INFO - SUITE-END | took 1182s
21:40:21 INFO - Completed test suite (00:19:42)
21:40:21 INFO - javascript benchmark
21:40:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.4847030593883, 2645.8941642334307, 2648.417348183399, 2670.4659068186365, 2687.744664256895, 4542.091581683669, 4616.12293664204, 4628.490866004741, 4656.0, 4656.534346565341, 4637.559431853977, 4652.906941861161, 4695.506971767966, 4720.622350211984, 4732.1245569569655, 4229.513605935326, 4237.4703162104815, 4270.316749320109, 4296.656267498593, 4392.758398288093, 4310.827566897336, 4338.826446942118, 4350.042990542076, 4366.366876802862, 4399.142167277382, 4158.6673066154635, 4189.07840275139, 4246.8725938221905, 4247.256730072256, 4271.743695378287, 4202.85290014851, 4259.91480170398, 4262.850800221977, 4309.82760689572, 4330.112326972963, 4204.705670603059, 4247.575242475758, 4255.1915136124035, 4261.105167914741, 4306.935395969063, 4414.933775993362, 4461.0854774771415, 4489.1919454498175, 4525.140223357585, 4577.610903073243, 4992.276119962585, 5013.623978201613, 5017.347744793154, 5021.372328458942, 5068.543831055186, 5021.497850214986, 5040.722760248185, 5044.697318160922, 5048.29323894655, 5060.089183946925, 4431.645468362523, 4658.627309815274, 4688.5545873142, 4708.693934894221, 4751.548602882721, 5068.4424713281505, 5069.44236134025, 5085.6948583084395, 5127.820526281562, 5146.022255771391, 4868.148074087091, 4886.65793394459, 4890.0, 4894.608431325485, 4935.259711043373, 4751.619870410359, 4915.188993816052, 4929.383827021622, 4947.802087916515, 5015.448300686921, 4886.242632391985, 4911.068624172008, 4913.950860491421, 4919.877003074952, 4943.382077240345, 4902.730349830794, 4905.411350637875, 4910.083349563767, 4914.778834952435, 4931.211006239057, 4111.424400583921, 4189.790510474464, 4191.266528357525, 4195.139996300751, 4288.485381754147, 3667.541557305337, 3692.4461330800596, 3703.777773333609, 3722.6277372262557, 3751.1934933989323, 4315.762633055149, 4316.525182229952, 4316.956830431718, 4353.564643535621, 4364.323529852878, 5014.047331007097, 5027.271045698353, 5035.320231768737, 5036.395632524121, 5084.313617661643, 4125.91748165035, 4210.263203939298, 4265.125649241898, 4290.957090429119, 4300.247456695066, 4541.091781643619, 4541.8183272669385, 4546.931796023062, 4572.702774319659, 4583.977080114578, 4711.586524042842, 4717.976410117996, 4719.551642593948, 4720.339152518582, 4729.834455794031, 4755.310479980452, 4867.3915760529935, 5000.1749711297225, 5008.774605142705, 5027.69833809958, 4648.418947631546, 4660.394148760775, 4664.813407463799, 4673.976630116827, 4711.316859055486, 4888.266759986031, 4899.240617704261, 4900.14247506692, 4906.362172917497, 4943.011397720398, 4732.905341893212, 4901.975490122527, 4963.131451995814, 4974.751262436791, 5002.349694539686, 4816.735079570657, 4837.927431088466, 4844.854654360375, 4864.635152363658, 4883.90232195347, 4792.2332426811545, 4821.325014498043, 4830.4444988826735, 4832.0, 4880.048390563806, 4504.054148628694, 4747.762611869462, 4758.095961767253, 4844.612431005582, 4867.756612169448, 4805.831795887128, 4809.615230781599, 4816.783244753924, 4824.903501930012, 4828.058528586892, 4739.905201896012, 4745.549172828576, 4747.548982846624, 4781.258904869751, 4787.257975013878], "value": 4561.698426562047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9838680695589, 603.7343568829715, 605.4278706622242, 622.5828694774502, 624.4972796898501, 26657.866710666443, 33367.49948750767, 33929.49105763409, 34364.31271374574, 34450.0, 39141.41287880684, 39787.0, 39884.80057599715, 39897.202055958864, 39999.0, 7609.162992070882, 7807.648655810473, 7815.882761758549, 7816.140224575292, 7817.0, 7695.653695583685, 7805.804854878616, 7829.373650108007, 7831.138574756772, 7831.843363132734, 7820.100688420819, 7832.373410127205, 7889.211078892123, 7897.368210543143, 7897.605119744018, 7754.340881025119, 7836.0, 7837.0, 7837.647305871221, 7841.96079019607, 7621.3902887768845, 7729.497582657109, 7742.729004484816, 7743.264389882952, 7748.418868584822, 35835.0, 36239.4564081539, 36391.81804090989, 36406.81796591027, 36559.63440365589, 3011.6687164411896, 3143.984280078585, 3191.2341038150676, 3438.6045604755523, 3733.9813300933592, 27596.172114836587, 27942.0, 28160.577591336147, 28264.858675706695, 28753.71246287531, 3490.336836001152, 3524.1894364296354, 3530.699890509284, 3552.0587044433246, 3638.909027274313, 224626.99999999837, 224709.0, 226960.0, 227187.0, 228239.0, 49541.50458495441, 50409.0, 50516.0, 50591.0, 50614.697750690866, 48986.0, 50391.49608503941, 50455.0, 50469.0, 50479.0, 13288.601341959757, 13445.32773361328, 13463.0, 13470.595882123553, 13478.056536042579, 10786.622468213574, 10879.075278601249, 10895.019448249695, 10900.07349375312, 10900.563977440972, 17751.11244437773, 17831.554211144827, 17959.910200448914, 17983.73024404635, 18603.162857671436, 6698.63157526331, 6861.656917154122, 6952.93047069533, 7058.71765129389, 7308.707651693979, 847.4025811802665, 887.8401887660283, 896.3232759266842, 989.1938070472542, 1019.7909428567126, 24532.50934981326, 24865.129720459696, 25067.37331566689, 25086.247412577653, 25092.372690682878, 962.5139304651246, 987.8024395121005, 1006.436395618456, 1030.5227714696364, 1071.0253669161182, 13615.251161186032, 13929.791053134211, 14059.437622494986, 14175.71648567023, 14272.85727142736, 312993.0, 314264.0, 318249.0, 318498.0, 319105.0, 45793.5420645796, 46574.0, 46577.30134047992, 46600.5339946603, 46635.30047049297, 1059.586761163147, 1204.8132539456399, 1266.5630357526638, 1272.3574594829552, 1286.5111257722006, 25079.49841003206, 27067.864660676572, 27208.72791272062, 27463.588046178924, 27665.446691066467, 39920.60079399169, 40791.59208407878, 40884.18231635291, 40939.59060409358, 40952.79523602363, 220755.0, 221240.0, 221416.0, 221658.0, 222307.0, 21239.256626018014, 22564.097436102373, 23169.652455213523, 23204.76795232026, 24051.0, 35217.295654086265, 35588.110297242776, 35612.28775424529, 35625.287494250486, 36328.09179770527, 30646.233844154074, 32698.673013269563, 33440.0, 33650.83174584111, 33722.0, 30418.695813042472, 33274.667253327156, 33472.66527334793, 33792.15519611931, 34023.65976340304, 32921.34157316793, 33495.33009339751, 33660.0, 33744.83127584346, 33760.0, 28795.712042879302, 29897.850510747307, 29968.700312997462, 30355.2411189722, 30370.54444183295, 23400.414989625395, 23566.130718303277, 23808.642870356613, 23932.28203153908, 24008.87995560011], "value": 16607.881799275463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7270651484189, 383.84262452394523, 383.99232015359695, 386.87813338798276, 395.70915377197775, 15480.458183963563, 16434.096124713134, 16528.75206871898, 16553.91723041383, 16728.163591820423, 16039.0, 16417.91791041043, 17059.744103838453, 17071.48785536433, 17077.91461042693, 5022.522860328263, 5222.007818514489, 5243.659162154467, 5251.133562962125, 5256.027634887539, 3620.275944811035, 5693.402192769761, 6000.18997435345, 6015.6992150392525, 6021.578489505737, 5863.237779088712, 5949.5537834662355, 5955.464008239258, 5962.34414214436, 5964.105384192362, 5817.796377126801, 5963.761449542057, 6004.249468816398, 6009.158717779536, 6012.128241404994, 3337.7997320160866, 3524.84138213781, 3526.453399723047, 3528.541289632357, 5050.696958182521, 19590.902045489824, 19596.118174682175, 19648.80351196484, 20073.096710648057, 20804.16783328665, 1904.9142788574409, 1983.7421135252469, 2022.8179463848178, 2067.400453868376, 2616.7906567474556, 8751.649934002633, 9049.78280321319, 9406.858897116548, 11281.461671123932, 13041.08712390133, 1666.9166541672869, 1768.6109056007786, 1797.604527004057, 1806.9277228910828, 1841.686913224755, 57943.42056579422, 59645.701771490865, 59873.0, 59929.99999999956, 60753.0, 9780.364276322016, 9853.852192217122, 9916.900830991597, 9979.852316983495, 10023.949880250699, 13986.230757308242, 14280.285985700673, 14288.071275367276, 14293.928530357281, 14312.427502899767, 7362.190159082496, 7366.0, 7443.590602516913, 7539.547627142389, 7566.0, 6904.585724856524, 6924.4114250289285, 6941.201761797458, 7072.823179420556, 7124.323189297009, 4406.669499787465, 4410.0, 4430.246858034077, 4492.427650322361, 4534.161180181677, 1721.4491362763795, 1743.744503957149, 1831.1759708131394, 1837.1916356802965, 1854.0, 842.9494230346199, 843.3084870406208, 880.903100658927, 886.2156991062827, 965.6330594374093, 15345.232738363036, 15515.456959006606, 15973.440929567409, 16107.114108724132, 16160.595985100466, 795.0221227889613, 844.6663567890648, 847.2290215903498, 859.4155973937658, 864.2481041493941, 9134.451932884049, 9552.0, 9593.856092158623, 9619.18236949853, 9647.602254948193, 349437.0, 358129.0, 363865.0, 366989.0, 368225.0, 78025.0, 79159.20840791633, 79489.60255198687, 80029.59985200036, 82518.0, 929.6002718830832, 957.9856302155334, 979.9657012004545, 987.3187500624546, 993.0119531066634, 14147.64630884236, 14477.276136193359, 14880.107193568421, 15982.120983346027, 16212.189390530662, 35320.47019294764, 35426.82286588551, 36185.45721814228, 36602.63397366099, 37004.25991480209, 45266.32100518561, 46754.25965922786, 46969.29546056744, 47157.0, 47275.290870637655, 7815.25755053269, 7969.481983671043, 7999.280064794197, 8032.718854840053, 8102.716404925799, 10852.565897364017, 11186.440677966231, 11241.49413276388, 11488.79367666383, 12053.638390847938, 10286.691399258034, 10549.472526373496, 10571.101456376295, 10830.241883068109, 11248.606298779503, 10360.378377297386, 10365.84451233217, 10624.84062739044, 10675.359478431319, 10853.294535855144, 5633.0705433604635, 6834.829129271609, 10760.332148516993, 10885.23803333759, 11148.442577871236, 7771.222877712184, 7963.16386779403, 8110.580648386626, 8130.6573786687995, 8279.668813247403, 8238.0, 10038.19694424459, 11002.50488728025, 11048.281861678965, 11055.557777688802], "value": 8165.478593354349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.1088988703407, 1290.2129700882463, 1399.9370028348724, 1436.3033928544653, 1816.3098022751353, 6161.414665606766, 7047.224805271422, 7192.352688258055, 7200.96399518003, 7202.819929501758, 6857.554258973163, 7011.929880701192, 7019.192792828826, 7019.227884932666, 7026.85946281074, 1833.5599456130567, 2101.2015434135005, 2159.3306075116684, 2182.432567532437, 2186.4752459409788, 2202.548477562104, 2233.6426171812514, 2234.1398561553838, 2238.4851484158653, 2242.495438526335, 2143.839212059094, 2195.034184958613, 2196.9450763730956, 2196.9780302197014, 2198.0658220256405, 1833.8441232495254, 2130.1053557505884, 2184.224600266898, 2188.0, 2188.518525924294, 2147.957040859174, 2160.2547121243147, 2169.967450488244, 2170.533335332895, 2207.7792220777956, 7401.888971665429, 7527.059117610299, 7578.772636820849, 7585.658645360972, 7603.353714934237, 4357.912841743179, 4575.816967321303, 4578.221702310615, 4579.0, 4581.060882519076, 2832.9433411331656, 2835.248659105339, 2878.0070875548113, 2887.220450478359, 2893.652761668613, 924.4129977464358, 937.1331518345503, 942.3074040580168, 958.0515289863055, 968.099667309402, 10206.387616742944, 10225.386476811414, 10246.38521688701, 10248.538815753309, 10262.281640285182, 4153.7300075494995, 4196.118815048874, 4291.957080429156, 4296.183725092223, 4308.6983911126545, 8719.215270625675, 8768.430052046597, 8788.692395766118, 8804.251638610789, 8807.779805504786, 3761.7366784324836, 4552.795124219418, 4638.466576343763, 4656.976715116402, 4660.300954856731, 4037.1723796621623, 4137.91724165521, 4149.688773342012, 4151.4395556600075, 4152.937705934413, 3454.758166928291, 3472.722182225416, 3590.1024743814046, 3610.9638903611153, 3618.0412190769466, 1162.215504534436, 1170.7482891178438, 1176.758764453285, 1177.370106992772, 1182.8876256755595, 823.7693445835175, 839.0, 846.8729690546468, 861.2335021830576, 861.9957749222211, 4893.804247830119, 5088.084144853962, 5149.76826042829, 5165.199394093921, 5185.0148471790235, 401.5201833808571, 414.9688773342011, 423.18536816628483, 436.5699785711072, 445.62567443347746, 3336.899893003214, 3395.6264810870784, 3455.188030812757, 3475.42655461851, 3495.4232551629207, 8462.61918213682, 8757.824843503222, 8771.122887711177, 8793.296536277083, 8865.778355541162, 8674.175953284428, 8754.649814007496, 8758.781030474162, 8772.956135219283, 8797.736067917973, 6677.966610166918, 6759.290274521104, 6799.286074962058, 6807.761728339583, 6816.113905192393, 4854.126257273725, 4942.382202224722, 4982.7259500727805, 5131.974340128276, 5179.326687530597, 8265.421420500506, 8325.666973321, 8327.0, 8387.874181887399, 8445.239928406472, 8132.942717446694, 8433.83132337362, 8459.06950235486, 8655.82688346217, 8660.653573856975, 5602.075657516627, 6299.716512757029, 6314.179156709598, 6464.7393758216695, 6590.538662293785, 7242.420606351585, 7244.927550724636, 7299.963500182465, 7313.049303590499, 7333.6699848508015, 6365.681715914093, 6568.343165683585, 6568.8357791055605, 6666.066750654815, 6670.199576050905, 6029.577929545065, 6480.481561475165, 6515.478761699147, 6595.307492713388, 6644.800655980328, 6011.489023432882, 6070.726817293321, 6089.421504957022, 6090.9390906090375, 6092.299385570716, 4180.707350485437, 4364.148990946735, 4385.079133382025, 4446.021875187454, 4476.888077797951, 4327.459067616548, 4399.362092496634, 4408.470983482002, 4434.423524941737, 4477.261251893401], "value": 3920.701514316074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8297021786927, 301.50101581881984, 303.59015329305424, 305.0710586264824, 305.1151660185462, 4485.618722408599, 4620.676552641316, 4634.397528321313, 4716.0, 4718.952810471894, 4498.415206023221, 4601.217792975194, 4635.559621835929, 4638.072385522892, 4641.396618439607, 3686.447032945053, 3708.83310251038, 3720.7581507202012, 3729.3100776356323, 3740.700743940492, 3524.990755269497, 3554.7689400188906, 3704.259148170363, 3740.831662575191, 3744.6255374462608, 3696.1683621185152, 3705.6294370562864, 3707.499487569184, 3709.202521457886, 3710.810621733177, 3661.853525858976, 3687.3178461984617, 3693.319539609471, 3697.7041836653, 3707.4253490708984, 3293.2919422324076, 3298.4887342461716, 3303.438415469376, 3314.005798260512, 3315.635280119185, 4288.078063216423, 4497.123061003105, 4529.660275479319, 4554.134714404253, 4554.316852472122, 4152.356384760367, 4160.438340824011, 4163.458750362433, 4176.373543968399, 4204.11713540157, 4898.730569818694, 4905.2642103684375, 4908.558229759339, 4932.284818701268, 4937.802487900515, 3308.652591477884, 3505.8948231553095, 3517.296540691872, 3526.1008442847165, 3532.6114127445962, 5073.162928116856, 5093.5415812576675, 5120.871978200537, 5136.563392111675, 5138.897222055575, 3553.4136867416587, 3567.108222944264, 3573.1960308930284, 3582.7671201371827, 3589.4615807628543, 3623.6195199503672, 3634.9636503635156, 3635.2002559436883, 3636.8363423646, 3655.415133578668, 3918.1771827916455, 4158.272302347077, 4160.0, 4170.791460426966, 4177.227212965611, 4892.241702536113, 4934.185859333242, 4943.24514797249, 4944.159492886218, 4945.082401383202, 1240.9131360804656, 1250.8624051354343, 1316.776148054833, 1324.569514907659, 1334.6863487080527, 879.5909901895521, 884.920357167845, 901.7430032440855, 905.9909400905907, 906.7597086771879, 4572.634189264851, 4577.244754615451, 4578.97710511452, 4582.0, 4590.655700822452, 5310.336207974004, 5316.707581083, 5327.866803329948, 5345.118055520873, 5345.198220266913, 4469.904873305995, 4576.0, 4596.770161491912, 4600.539946005372, 4620.353150558924, 2836.6170566973196, 2856.8428736419282, 2865.3409715765074, 2869.8421586812924, 2871.3682989742224, 5000.499950004971, 5011.298418221452, 5037.722925239073, 5040.067587496325, 5045.142325804622, 5311.442298558673, 5444.809431669952, 5478.726063696879, 5485.972570137204, 5491.807786727445, 5006.3992320921725, 5022.146235140035, 5037.19404895215, 5039.193729003342, 5050.292958985745, 5361.490658387447, 5361.758720857492, 5370.845268267341, 5371.946280537145, 5382.111951528111, 5033.446320904624, 5219.451957544555, 5237.895242095213, 5258.89482210346, 5260.158374660036, 5030.496950304941, 5035.5468007878, 5050.141475949171, 5074.5686616637995, 5077.568406685473, 3775.11284848055, 3780.0549862534367, 3780.2250538640064, 3787.3182827091387, 3792.1088544192644, 4784.569388755029, 5218.504242096995, 5343.091674415281, 5351.1973204019705, 5372.952274306473, 4743.193657078236, 4849.393825771778, 4904.449686163104, 4924.187509060965, 4943.802247910044, 4881.755912204305, 4897.730624815526, 4905.852824415273, 4934.100371356982, 4940.8764780880765, 4637.310359991265, 4861.732604706775, 4869.902601947871, 4880.341153944314, 4885.95114048855, 4993.650444468853, 4994.800207991785, 5012.4736902626155, 5017.473165317735, 5038.319826823332, 4905.533974272438, 4931.901361972812, 4946.505349465168, 4965.851024469272, 4966.261808367042], "value": 3791.86939211851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.7337065173931, 708.7909066825284, 760.9505382150163, 790.2650535002449, 792.7463211772235, 12093.879061209385, 12440.129190956637, 12444.688882777946, 12480.812787808167, 12489.812652810204, 11661.708457288572, 11895.881041189585, 12027.639170824867, 12034.097442691811, 12042.759144817099, 644.0789670770796, 779.4504874063786, 808.7856717969743, 809.9271065604095, 814.8818421328904, 767.1484652036236, 802.8514724775906, 805.3838813307824, 805.5851236613149, 806.31060443321, 851.8935133108362, 857.9571021448934, 858.669412276275, 858.909814469481, 859.1794835931702, 675.6419097878132, 692.3664846665296, 852.846487632226, 853.803625166209, 854.1757204297851, 512.7513156119279, 609.1684850179518, 626.9561130720851, 627.3851625407127, 627.8179327994876, 12181.208221465666, 12186.329751863645, 12194.75610487794, 12212.08409369292, 12223.388830558526, 11690.649280521598, 12060.155789094766, 12092.697682557919, 12468.875311246953, 12851.293178875158, 9415.05849415053, 9808.95095524525, 9814.803703925953, 9888.307818452711, 10004.449755263458, 3331.0, 3354.681305275995, 3356.9832150839334, 3415.043787739437, 3421.3328400961823, 43746.34380484295, 44461.0, 44810.32784508235, 44941.32588011182, 46299.76850115762, 9415.670451534163, 9635.614575416905, 9646.565904534313, 9682.177014953668, 9752.609895604097, 16231.594210144605, 16384.672306553803, 16475.58811029734, 16549.338026479047, 16584.08787516698, 6767.593944363354, 6771.762988295484, 6839.487038472134, 6905.1713794345, 6999.265077166926, 3806.3909774435956, 3849.2493963676816, 3888.727789054739, 3960.0495880988356, 4007.479027726435, 2812.774978001755, 2906.070057581596, 2913.038697229909, 2913.4901392256693, 2918.124562631202, 523.7931017248166, 533.557147567518, 537.1432565058725, 540.2544488605699, 544.335910189576, 528.6748649580558, 583.8569550460079, 592.1473078766649, 621.3413781391739, 641.8491654461197, 7576.24237576238, 7962.7213047543055, 8001.319887809602, 8258.958705206556, 8471.279941204943, 594.3669991459083, 608.9360617135226, 638.5306799502362, 640.078287266335, 653.1541653558653, 3833.8085782960034, 3920.3923391874305, 4006.278869803405, 4071.1247081877536, 4132.483439570054, 45811.54188458139, 46001.0, 47480.52519474761, 50167.498325016284, 51689.741551292755, 40660.18679626391, 41028.79485602553, 41223.763287101436, 46091.0, 46914.29628555574, 44216.55783442124, 44220.11559768851, 44517.332240016425, 44937.32594011027, 45285.0, 8586.356023298153, 8587.871181932402, 8658.134186581292, 8733.56332183401, 8867.0, 28919.855400722863, 28987.0, 29709.702902970694, 29768.255793605334, 30072.0, 35467.645323546436, 36976.0, 39395.0, 39621.60378396179, 40091.79954100211, 10080.495975201356, 10103.494825258855, 10150.0, 10221.182305415698, 10526.263161578616, 11407.714807129889, 11491.885081149416, 12307.56923507673, 12339.568115115928, 12477.188982716094, 10723.678289651323, 11312.20814543007, 11370.31778093317, 11392.601258956229, 11742.295462272292, 10949.671509854717, 11255.606053788078, 11449.42752862337, 11523.366214858263, 11566.0, 11112.611058612909, 11338.65935332573, 11427.085833133164, 11569.19015668895, 11588.420578970849, 9294.581743821409, 9495.620175192915, 9560.76098097553, 9681.322307438411, 9700.514974251118, 9430.82114735658, 9540.379875308083, 9598.616055357708, 9618.086281803218, 9670.70987870365], "value": 5940.207579168084, "unit": "score"}], "name": "dromaeo_css", "value": 6160.016278035766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 114.0, 114.0, 114.0, 121.0, 112.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 153.0, 198.0, 136.0, 164.0, 158.0, 132.0, 202.0, 134.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 105.0, 102.0, 75.0, 75.0, 76.0, 115.0, 121.0, 74.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 141.0, 94.0, 94.0, 94.0, 150.0, 94.0, 93.0, 143.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 85.0, 66.0, 64.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 82.0, 79.0, 89.0, 81.0, 81.0, 82.0, 82.0, 89.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 136.0, 129.0, 131.0, 145.0, 127.0, 130.0, 133.0, 170.0, 132.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 179.0, 184.0, 179.0, 179.0, 181.0, 185.0, 177.0, 183.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 73.0, 74.0, 74.0, 72.0, 82.0, 73.0, 73.0, 73.0], "value": 74.4, "unit": "score"}], "name": "kraken", "value": 1595.4, "alertThreshold": 2.0}]}
21:40:21 INFO - Return code: 0
21:40:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json
21:40:21 ERROR - # TBPL SUCCESS #
21:40:21 INFO - Running post-action listener: _resource_record_post_action
21:40:21 INFO - Running post-run listener: _resource_record_post_run
21:40:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 527638528; Read time: 0; Write time: 949096
21:40:22 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 234708992; Read time: 0; Write time: 554856
21:40:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 292868096; Read time: 0; Write time: 394020
21:40:22 INFO - Running post-run listener: _upload_blobber_files
21:40:22 INFO - Blob upload gear active.
21:40:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
21:40:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
21:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
21:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
21:40:23 INFO - (blobuploader) - INFO - Open directory for files ...
21:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
21:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
21:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
21:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
21:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
21:40:23 INFO - (blobuploader) - INFO - Done attempting.
21:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
21:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
21:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
21:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
21:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
21:40:24 INFO - (blobuploader) - INFO - Done attempting.
21:40:24 INFO - (blobuploader) - INFO - Iteration through files over.
21:40:24 INFO - Return code: 0
21:40:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
21:40:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
21:40:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"}
21:40:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
21:40:24 INFO - Writing to file /builds/slave/test/properties/blobber_files
21:40:24 INFO - Contents:
21:40:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"}
21:40:24 INFO - Running post-run listener: copy_logs_to_upload_dir
21:40:24 INFO - Copying logs to upload dir...
21:40:24 INFO - mkdir: /builds/slave/test/build/upload/logs
21:40:24 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1249.765615
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 21:40:23.830472) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.834396) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/test/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/properties
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"}
build_url:https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011202
build_url: 'https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"}'
========= master_lag: 0.01 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.859393) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.859716) =========
rm -f oauth.txt
in dir /builds/slave/test/. (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
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004389
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.943008) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 21:40:23.943318) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 21:40:23.943600) =========
========= Total master_lag: 0.17 =========