builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo
slave: talos-linux64-ix-054
starttime: 1462715854.94
results: success (0)
buildid: 20160508043009
builduid: 69ccf00b48cd45eb93ed4d475da849af
revision: 01b755909dc18b700bd88eb616862e4872a6daf9
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:34.936857) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:34.937307) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:34.937617) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:34.989166) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:34.989907) =========
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=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-05-08 06:57:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12141 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 45.8M=0s
2016-05-08 06:57:36 (45.8 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.108733
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.143014) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.143308) =========
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=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.018402
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.193616) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.193943) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 01b755909dc18b700bd88eb616862e4872a6daf9 --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 01b755909dc18b700bd88eb616862e4872a6daf9 --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=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-05-08 06:57:36,629 truncating revision to first 12 chars
2016-05-08 06:57:36,629 Setting DEBUG logging.
2016-05-08 06:57:36,629 attempt 1/10
2016-05-08 06:57:36,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/01b755909dc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-05-08 06:57:36,996 unpacking tar archive at: mozilla-inbound-01b755909dc1/testing/mozharness/
program finished with exit code 0
elapsedTime=0.630163
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.837415) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.837702) =========
script_repo_revision: 01b755909dc18b700bd88eb616862e4872a6daf9
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.838074) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.838336) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-08 06:57:35.846981) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-08 06:57:35.847263) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PROPERTIES_FILE=/builds/slave/test/buildprops.json
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
06:57:37 INFO - MultiFileLogger online at 20160508 06:57:37 in /builds/slave/test
06:57:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
06:57:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
06:57:37 INFO - {'append_to_log': False,
06:57:37 INFO - 'base_work_dir': '/builds/slave/test',
06:57:37 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
06:57:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
06:57:37 INFO - 'branch': 'Mozilla-Inbound',
06:57:37 INFO - 'buildbot_json_path': 'buildprops.json',
06:57:37 INFO - 'config_files': ('talos/linux_config.py',),
06:57:37 INFO - 'default_actions': ('clobber',
06:57:37 INFO - 'read-buildbot-config',
06:57:37 INFO - 'download-and-extract',
06:57:37 INFO - 'populate-webroot',
06:57:37 INFO - 'create-virtualenv',
06:57:37 INFO - 'install',
06:57:37 INFO - 'run-tests'),
06:57:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
06:57:37 INFO - 'download_minidump_stackwalk': True,
06:57:37 INFO - 'download_symbols': 'ondemand',
06:57:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
06:57:37 INFO - 'tooltool.py': '/tools/tooltool.py',
06:57:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
06:57:37 INFO - '/tools/misc-python/virtualenv.py')},
06:57:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
06:57:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
06:57:37 INFO - 'installer_path': 'installer.exe',
06:57:37 INFO - 'log_level': 'info',
06:57:37 INFO - 'log_name': 'talos',
06:57:37 INFO - 'log_to_console': True,
06:57:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
06:57:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
06:57:37 INFO - 'opt_config_files': (),
06:57:37 INFO - 'pip_index': False,
06:57:37 INFO - 'sps_profile': False,
06:57:37 INFO - 'sps_profile_interval': 0,
06:57:37 INFO - 'suite': 'dromaeojs',
06:57:37 INFO - 'system_bits': '32',
06:57:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
06:57:37 INFO - 'title': 'talos-linux64-ix-054',
06:57:37 INFO - 'tooltool_cache': '/builds/tooltool_cache',
06:57:37 INFO - 'use_talos_json': True,
06:57:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
06:57:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
06:57:37 INFO - 'work_dir': 'build'}
06:57:37 INFO - #####
06:57:37 INFO - ##### Running clobber step.
06:57:37 INFO - #####
06:57:37 INFO - Running pre-action listener: _resource_record_pre_action
06:57:37 INFO - Running main action method: clobber
06:57:37 INFO - rmtree: /builds/slave/test/build
06:57:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
06:57:38 INFO - Running post-action listener: _resource_record_post_action
06:57:38 INFO - #####
06:57:38 INFO - ##### Finished clobber step (success)
06:57:38 INFO - #####
06:57:38 INFO - #####
06:57:38 INFO - ##### Running read-buildbot-config step.
06:57:38 INFO - #####
06:57:38 INFO - Running pre-action listener: _resource_record_pre_action
06:57:38 INFO - Running main action method: read_buildbot_config
06:57:38 INFO - Using buildbot properties:
06:57:38 INFO - {
06:57:38 INFO - "project": "",
06:57:38 INFO - "product": "firefox",
06:57:38 INFO - "script_repo_revision": "production",
06:57:38 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs",
06:57:38 INFO - "repository": "",
06:57:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs",
06:57:38 INFO - "buildid": "20160508043009",
06:57:38 INFO - "pgo_build": "True",
06:57:38 INFO - "basedir": "/builds/slave/test",
06:57:38 INFO - "buildnumber": 955,
06:57:38 INFO - "slavename": "talos-linux64-ix-054",
06:57:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
06:57:38 INFO - "platform": "ubuntu64_hw",
06:57:38 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos",
06:57:38 INFO - "branch": "mozilla-inbound",
06:57:38 INFO - "repo_path": "integration/mozilla-inbound",
06:57:38 INFO - "revision": "01b755909dc18b700bd88eb616862e4872a6daf9",
06:57:38 INFO - "stage_platform": "linux64-pgo",
06:57:38 INFO - "builduid": "69ccf00b48cd45eb93ed4d475da849af",
06:57:38 INFO - "slavebuilddir": "test"
06:57:38 INFO - }
06:57:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2.
06:57:38 INFO - Running post-action listener: _resource_record_post_action
06:57:38 INFO - #####
06:57:38 INFO - ##### Finished read-buildbot-config step (success)
06:57:38 INFO - #####
06:57:38 INFO - #####
06:57:38 INFO - ##### Running download-and-extract step.
06:57:38 INFO - #####
06:57:38 INFO - Running pre-action listener: _resource_record_pre_action
06:57:38 INFO - Running main action method: download_and_extract
06:57:38 INFO - mkdir: /builds/slave/test/build/tests
06:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:57:38 INFO - https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net
06:57:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
06:57:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
06:57:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:57:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:57:42 INFO - Downloaded 1361 bytes.
06:57:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json
06:57:42 INFO - Using the following test package requirements:
06:57:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'],
06:57:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
06:57:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'],
06:57:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'jsshell-linux-x86_64.zip'],
06:57:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
06:57:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'],
06:57:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'],
06:57:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'],
06:57:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
06:57:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip',
06:57:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
06:57:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
06:57: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')]}
06:57:42 INFO - https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
06:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
06:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
06:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:57:55 INFO - Downloaded 23895402 bytes.
06:57:55 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']
06:57:55 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
06:57:56 INFO - Return code: 0
06:57:56 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
06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:57:56 INFO - https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
06:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
06:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip
06:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:58:07 INFO - Downloaded 23895402 bytes.
06:58:07 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']
06:58:07 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
06:58:08 INFO - Return code: 0
06:58: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')]}
06:58:08 INFO - https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
06:58:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip
06:58:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip
06:58:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:58:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:58:11 INFO - Downloaded 10840152 bytes.
06:58:11 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']
06:58:11 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
06:58:12 INFO - Return code: 0
06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:12 INFO - https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
06:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
06:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
06:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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
06:58:15 INFO - Downloaded 58416659 bytes.
06:58:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
06:58:15 INFO - mkdir: /builds/slave/test/properties
06:58:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
06:58:15 INFO - Writing to file /builds/slave/test/properties/build_url
06:58:15 INFO - Contents:
06:58:15 INFO - build_url:https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
06:58:15 INFO - Running post-action listener: _resource_record_post_action
06:58:15 INFO - Running post-action listener: set_extra_try_arguments
06:58:15 INFO - #####
06:58:15 INFO - ##### Finished download-and-extract step (success)
06:58:15 INFO - #####
06:58:15 INFO - #####
06:58:15 INFO - ##### Running populate-webroot step.
06:58:15 INFO - #####
06:58:15 INFO - Running pre-action listener: _resource_record_pre_action
06:58:15 INFO - Running main action method: populate_webroot
06:58:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
06:58:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
06:58:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
06:58:15 INFO - '--tppagecycles',
06:58:15 INFO - '7'],
06:58:15 INFO - 'tests': ['tsvgm']}},
06:58:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['tresize', 'tcanvasmark']},
06:58:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
06:58:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['dromaeo_css', 'kraken']},
06:58:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
06:58:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
06:58:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
06:58:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['damp', 'tps']},
06:58:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'tests': ['damp', 'tps']},
06:58:15 INFO - 'g3': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['dromaeo_dom']},
06:58:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
06:58:15 INFO - 'other': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'other-e10s': {'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'other-e10s_l64': {'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['a11yr',
06:58:15 INFO - 'ts_paint',
06:58:15 INFO - 'tpaint',
06:58:15 INFO - 'sessionrestore',
06:58:15 INFO - 'sessionrestore_no_auto_restore',
06:58:15 INFO - 'tabpaint']},
06:58:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['tsvgx',
06:58:15 INFO - 'tsvgr_opacity',
06:58:15 INFO - 'tart',
06:58:15 INFO - 'tscrollx',
06:58:15 INFO - 'cart']},
06:58:15 INFO - 'svgr-e10s': {'tests': ['tsvgx',
06:58:15 INFO - 'tsvgr_opacity',
06:58:15 INFO - 'tart',
06:58:15 INFO - 'tscrollx',
06:58:15 INFO - 'cart']},
06:58:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'talos_options': ['--disable-e10s'],
06:58:15 INFO - 'tests': ['tp5o']},
06:58:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'tests': ['tp5o']},
06:58:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'talos_options': ['--disable-e10s',
06:58:15 INFO - '--xperf_path',
06:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
06:58:15 INFO - 'tests': ['tp5n']},
06:58:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
06:58:15 INFO - 'talos_options': ['--xperf_path',
06:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
06:58:15 INFO - 'tests': ['tp5n']}},
06:58:15 INFO - 'talos.zip': {'path': '',
06:58:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
06:58:15 INFO - Running post-action listener: _resource_record_post_action
06:58:15 INFO - #####
06:58:15 INFO - ##### Finished populate-webroot step (success)
06:58:15 INFO - #####
06:58:15 INFO - #####
06:58:15 INFO - ##### Running create-virtualenv step.
06:58:15 INFO - #####
06:58:15 INFO - Running pre-action listener: _resource_record_pre_action
06:58:15 INFO - Running main action method: create_virtualenv
06:58:15 INFO - Creating virtualenv /builds/slave/test/build/venv
06:58:15 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
06:58:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
06:58:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
06:58:16 INFO - Using real prefix '/usr'
06:58:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python
06:58:16 INFO - Installing distribute.............................................................................................................................................................................................done.
06:58:18 INFO - Installing pip.................done.
06:58:18 INFO - Return code: 0
06:58:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
06:58: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')]}
06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58: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')]}
06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58: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', 'pip>=1.5'] in /builds/slave/test/build
06:58: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 pip>=1.5
06:58:18 INFO - Using env: {'DISPLAY': ':0',
06:58:18 INFO - 'HOME': '/home/cltbld',
06:58:18 INFO - 'LANG': 'en_US.UTF-8',
06:58:18 INFO - 'LANGUAGE': 'en_US:en',
06:58:18 INFO - 'LOGNAME': 'cltbld',
06:58:18 INFO - 'MAIL': '/var/mail/cltbld',
06:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:18 INFO - 'MOZ_NO_REMOTE': '1',
06:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:18 INFO - 'NO_EM_RESTART': '1',
06:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:18 INFO - 'PWD': '/builds/slave/test',
06:58:18 INFO - 'SHELL': '/bin/bash',
06:58:18 INFO - 'SHLVL': '1',
06:58:18 INFO - 'TERM': 'linux',
06:58:18 INFO - 'TMOUT': '86400',
06:58:18 INFO - 'USER': 'cltbld',
06:58:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:18 INFO - '_': '/tools/buildbot/bin/python'}
06:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg
06:58:18 INFO - Cleaning up...
06:58:18 INFO - Return code: 0
06:58:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv
06:58: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')]}
06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58: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')]}
06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58: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', '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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58: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', 'psutil>=0.7.1'] in /builds/slave/test/build
06:58: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 psutil>=0.7.1
06:58:18 INFO - Using env: {'DISPLAY': ':0',
06:58:18 INFO - 'HOME': '/home/cltbld',
06:58:18 INFO - 'LANG': 'en_US.UTF-8',
06:58:18 INFO - 'LANGUAGE': 'en_US:en',
06:58:18 INFO - 'LOGNAME': 'cltbld',
06:58:18 INFO - 'MAIL': '/var/mail/cltbld',
06:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:18 INFO - 'MOZ_NO_REMOTE': '1',
06:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:18 INFO - 'NO_EM_RESTART': '1',
06:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:18 INFO - 'PWD': '/builds/slave/test',
06:58:18 INFO - 'SHELL': '/bin/bash',
06:58:18 INFO - 'SHLVL': '1',
06:58:18 INFO - 'TERM': 'linux',
06:58:18 INFO - 'TMOUT': '86400',
06:58:18 INFO - 'USER': 'cltbld',
06:58:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:18 INFO - '_': '/tools/buildbot/bin/python'}
06:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:19 INFO - Downloading/unpacking psutil>=0.7.1
06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
06:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
06:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
06:58:21 INFO - Installing collected packages: psutil
06:58:21 INFO - Running setup.py install for psutil
06:58:21 INFO - building 'psutil._psutil_linux' extension
06:58:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o
06:58:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so
06:58:21 INFO - building 'psutil._psutil_posix' extension
06:58:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o
06:58:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so
06:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
06:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
06:58:21 INFO - Successfully installed psutil
06:58:21 INFO - Cleaning up...
06:58:21 INFO - Return code: 0
06:58:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv
06:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:21 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:21 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
06:58:21 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
06:58:21 INFO - Using env: {'DISPLAY': ':0',
06:58:21 INFO - 'HOME': '/home/cltbld',
06:58:21 INFO - 'LANG': 'en_US.UTF-8',
06:58:21 INFO - 'LANGUAGE': 'en_US:en',
06:58:21 INFO - 'LOGNAME': 'cltbld',
06:58:21 INFO - 'MAIL': '/var/mail/cltbld',
06:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:21 INFO - 'MOZ_NO_REMOTE': '1',
06:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:21 INFO - 'NO_EM_RESTART': '1',
06:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:21 INFO - 'PWD': '/builds/slave/test',
06:58:21 INFO - 'SHELL': '/bin/bash',
06:58:21 INFO - 'SHLVL': '1',
06:58:21 INFO - 'TERM': 'linux',
06:58:21 INFO - 'TMOUT': '86400',
06:58:21 INFO - 'USER': 'cltbld',
06:58:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:21 INFO - '_': '/tools/buildbot/bin/python'}
06:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0
06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz
06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
06:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0)
06:58:23 INFO - Installing collected packages: mozsystemmonitor
06:58:23 INFO - Running setup.py install for mozsystemmonitor
06:58:23 INFO - Successfully installed mozsystemmonitor
06:58:23 INFO - Cleaning up...
06:58:23 INFO - Return code: 0
06:58:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:23 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:23 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
06:58:23 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
06:58:23 INFO - Using env: {'DISPLAY': ':0',
06:58:23 INFO - 'HOME': '/home/cltbld',
06:58:23 INFO - 'LANG': 'en_US.UTF-8',
06:58:23 INFO - 'LANGUAGE': 'en_US:en',
06:58:23 INFO - 'LOGNAME': 'cltbld',
06:58:23 INFO - 'MAIL': '/var/mail/cltbld',
06:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:23 INFO - 'MOZ_NO_REMOTE': '1',
06:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:23 INFO - 'NO_EM_RESTART': '1',
06:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:23 INFO - 'PWD': '/builds/slave/test',
06:58:23 INFO - 'SHELL': '/bin/bash',
06:58:23 INFO - 'SHLVL': '1',
06:58:23 INFO - 'TERM': 'linux',
06:58:23 INFO - 'TMOUT': '86400',
06:58:23 INFO - 'USER': 'cltbld',
06:58:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:23 INFO - '_': '/tools/buildbot/bin/python'}
06:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:24 INFO - Downloading/unpacking blobuploader==1.2.4
06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:25 INFO - Downloading blobuploader-1.2.4.tar.gz
06:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
06:58:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
06:58:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:26 INFO - Downloading docopt-0.6.1.tar.gz
06:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
06:58:26 INFO - Installing collected packages: blobuploader, requests, docopt
06:58:26 INFO - Running setup.py install for blobuploader
06:58:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
06:58:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
06:58:26 INFO - Running setup.py install for requests
06:58:27 INFO - Running setup.py install for docopt
06:58:27 INFO - Successfully installed blobuploader requests docopt
06:58:27 INFO - Cleaning up...
06:58:27 INFO - Return code: 0
06:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv
06:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:27 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:27 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
06:58:27 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
06:58:27 INFO - Using env: {'DISPLAY': ':0',
06:58:27 INFO - 'HOME': '/home/cltbld',
06:58:27 INFO - 'LANG': 'en_US.UTF-8',
06:58:27 INFO - 'LANGUAGE': 'en_US:en',
06:58:27 INFO - 'LOGNAME': 'cltbld',
06:58:27 INFO - 'MAIL': '/var/mail/cltbld',
06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:27 INFO - 'MOZ_NO_REMOTE': '1',
06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:27 INFO - 'NO_EM_RESTART': '1',
06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:27 INFO - 'PWD': '/builds/slave/test',
06:58:27 INFO - 'SHELL': '/bin/bash',
06:58:27 INFO - 'SHLVL': '1',
06:58:27 INFO - 'TERM': 'linux',
06:58:27 INFO - 'TMOUT': '86400',
06:58:27 INFO - 'USER': 'cltbld',
06:58:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:27 INFO - '_': '/tools/buildbot/bin/python'}
06:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
06:58:27 INFO - Running setup.py (path:/tmp/pip-baC6e5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
06:58:27 INFO - Running setup.py (path:/tmp/pip-5tsIcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
06:58:27 INFO - Running setup.py (path:/tmp/pip-HnDZ7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
06:58:27 INFO - Running setup.py (path:/tmp/pip-nNXDhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
06:58:27 INFO - Running setup.py (path:/tmp/pip-OSOHLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
06:58:27 INFO - Running setup.py (path:/tmp/pip-ROEAd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
06:58:27 INFO - Running setup.py (path:/tmp/pip-9itiGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
06:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
06:58:27 INFO - Running setup.py (path:/tmp/pip-wrhTYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
06:58:28 INFO - Running setup.py (path:/tmp/pip-zjBDME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
06:58:28 INFO - Running setup.py (path:/tmp/pip-dOCj5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
06:58:28 INFO - Running setup.py (path:/tmp/pip-i6WDdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
06:58:28 INFO - Running setup.py (path:/tmp/pip-To6f3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
06:58:28 INFO - Running setup.py (path:/tmp/pip-Oz5toi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
06:58:28 INFO - Running setup.py (path:/tmp/pip-Kby73B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
06:58:28 INFO - Running setup.py (path:/tmp/pip-zjujqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
06:58:28 INFO - Running setup.py (path:/tmp/pip-hROEyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
06:58:28 INFO - Running setup.py (path:/tmp/pip-3xe8PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
06:58:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
06:58:28 INFO - Running setup.py install for manifestparser
06:58:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
06:58:28 INFO - Running setup.py install for mozcrash
06:58:28 INFO - Running setup.py install for mozdebug
06:58:29 INFO - Running setup.py install for mozdevice
06:58:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for mozfile
06:58:29 INFO - Running setup.py install for mozhttpd
06:58:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for mozinfo
06:58:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for mozInstall
06:58:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for mozleak
06:58:29 INFO - Running setup.py install for mozlog
06:58:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for moznetwork
06:58:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
06:58:29 INFO - Running setup.py install for mozprocess
06:58:29 INFO - Running setup.py install for mozprofile
06:58:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
06:58:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
06:58:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
06:58:30 INFO - Running setup.py install for mozrunner
06:58:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
06:58:30 INFO - Running setup.py install for mozscreenshot
06:58:30 INFO - Running setup.py install for moztest
06:58:30 INFO - Running setup.py install for mozversion
06:58:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
06:58:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
06:58:30 INFO - Cleaning up...
06:58:30 INFO - Return code: 0
06:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv
06:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:30 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:30 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
06:58:30 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
06:58:30 INFO - Using env: {'DISPLAY': ':0',
06:58:30 INFO - 'HOME': '/home/cltbld',
06:58:30 INFO - 'LANG': 'en_US.UTF-8',
06:58:30 INFO - 'LANGUAGE': 'en_US:en',
06:58:30 INFO - 'LOGNAME': 'cltbld',
06:58:30 INFO - 'MAIL': '/var/mail/cltbld',
06:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:30 INFO - 'MOZ_NO_REMOTE': '1',
06:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:30 INFO - 'NO_EM_RESTART': '1',
06:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:30 INFO - 'PWD': '/builds/slave/test',
06:58:30 INFO - 'SHELL': '/bin/bash',
06:58:30 INFO - 'SHLVL': '1',
06:58:30 INFO - 'TERM': 'linux',
06:58:30 INFO - 'TMOUT': '86400',
06:58:30 INFO - 'USER': 'cltbld',
06:58:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:30 INFO - '_': '/tools/buildbot/bin/python'}
06:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
06:58:30 INFO - Running setup.py (path:/tmp/pip-ZWlJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
06:58:30 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))
06:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
06:58:30 INFO - Running setup.py (path:/tmp/pip-dFJdHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
06:58:30 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))
06:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
06:58:30 INFO - Running setup.py (path:/tmp/pip-2WECwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
06:58:30 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))
06:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
06:58:30 INFO - Running setup.py (path:/tmp/pip-Q5TZ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
06:58:31 INFO - Running setup.py (path:/tmp/pip-dN_BIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
06:58:31 INFO - Running setup.py (path:/tmp/pip-HPX7Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
06:58:31 INFO - Running setup.py (path:/tmp/pip-es1cVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
06:58:31 INFO - Running setup.py (path:/tmp/pip-N_dDeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
06:58:31 INFO - Running setup.py (path:/tmp/pip-4KcZLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
06:58:31 INFO - Running setup.py (path:/tmp/pip-pL5KgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
06:58:31 INFO - Running setup.py (path:/tmp/pip-yQcchu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
06:58:31 INFO - Running setup.py (path:/tmp/pip-Mv6DXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
06:58:31 INFO - Running setup.py (path:/tmp/pip-fYoWkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
06:58:31 INFO - Running setup.py (path:/tmp/pip-1OPedf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
06:58:31 INFO - Running setup.py (path:/tmp/pip-pd27HV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
06:58:31 INFO - Running setup.py (path:/tmp/pip-mnxIMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
06:58:31 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))
06:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
06:58:31 INFO - Running setup.py (path:/tmp/pip-jrD1Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
06:58:31 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))
06:58:31 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))
06:58:31 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))
06:58:31 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))
06:58:31 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))
06:58:31 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))
06:58:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
06:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:33 INFO - Downloading blessings-1.6.tar.gz
06:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
06:58:33 INFO - Installing collected packages: blessings
06:58:33 INFO - Running setup.py install for blessings
06:58:34 INFO - Successfully installed blessings
06:58:34 INFO - Cleaning up...
06:58:34 INFO - Return code: 0
06:58:34 INFO - Done creating virtualenv /builds/slave/test/build/venv.
06:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
06:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
06:58:34 INFO - Reading from file tmpfile_stdout
06:58:34 INFO - Current package versions:
06:58:34 INFO - argparse == 1.2.1
06:58:34 INFO - blessings == 1.6
06:58:34 INFO - blobuploader == 1.2.4
06:58:34 INFO - docopt == 0.6.1
06:58:34 INFO - manifestparser == 1.1
06:58:34 INFO - mozInstall == 1.12
06:58:34 INFO - mozcrash == 0.17
06:58:34 INFO - mozdebug == 0.1
06:58:34 INFO - mozdevice == 0.48
06:58:34 INFO - mozfile == 1.2
06:58:34 INFO - mozhttpd == 0.7
06:58:34 INFO - mozinfo == 0.9
06:58:34 INFO - mozleak == 0.1
06:58:34 INFO - mozlog == 3.1
06:58:34 INFO - moznetwork == 0.27
06:58:34 INFO - mozprocess == 0.22
06:58:34 INFO - mozprofile == 0.28
06:58:34 INFO - mozrunner == 6.11
06:58:34 INFO - mozscreenshot == 0.1
06:58:34 INFO - mozsystemmonitor == 0.0
06:58:34 INFO - moztest == 0.7
06:58:34 INFO - mozversion == 1.4
06:58:34 INFO - psutil == 3.1.1
06:58:34 INFO - requests == 1.2.3
06:58:34 INFO - wsgiref == 0.1.2
06:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv
06:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:34 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:34 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
06:58:34 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
06:58:34 INFO - Using env: {'DISPLAY': ':0',
06:58:34 INFO - 'HOME': '/home/cltbld',
06:58:34 INFO - 'LANG': 'en_US.UTF-8',
06:58:34 INFO - 'LANGUAGE': 'en_US:en',
06:58:34 INFO - 'LOGNAME': 'cltbld',
06:58:34 INFO - 'MAIL': '/var/mail/cltbld',
06:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:34 INFO - 'MOZ_NO_REMOTE': '1',
06:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:34 INFO - 'NO_EM_RESTART': '1',
06:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:34 INFO - 'PWD': '/builds/slave/test',
06:58:34 INFO - 'SHELL': '/bin/bash',
06:58:34 INFO - 'SHLVL': '1',
06:58:34 INFO - 'TERM': 'linux',
06:58:34 INFO - 'TMOUT': '86400',
06:58:34 INFO - 'USER': 'cltbld',
06:58:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:34 INFO - '_': '/tools/buildbot/bin/python'}
06:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 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))
06:58:34 INFO - Cleaning up...
06:58:34 INFO - Return code: 0
06:58:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
06:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:34 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:34 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
06:58:34 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
06:58:34 INFO - Using env: {'DISPLAY': ':0',
06:58:34 INFO - 'HOME': '/home/cltbld',
06:58:34 INFO - 'LANG': 'en_US.UTF-8',
06:58:34 INFO - 'LANGUAGE': 'en_US:en',
06:58:34 INFO - 'LOGNAME': 'cltbld',
06:58:34 INFO - 'MAIL': '/var/mail/cltbld',
06:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:34 INFO - 'MOZ_NO_REMOTE': '1',
06:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:34 INFO - 'NO_EM_RESTART': '1',
06:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:34 INFO - 'PWD': '/builds/slave/test',
06:58:34 INFO - 'SHELL': '/bin/bash',
06:58:34 INFO - 'SHLVL': '1',
06:58:34 INFO - 'TERM': 'linux',
06:58:34 INFO - 'TMOUT': '86400',
06:58:34 INFO - 'USER': 'cltbld',
06:58:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:34 INFO - '_': '/tools/buildbot/bin/python'}
06:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:34 INFO - Downloading/unpacking jsonschema
06:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
06:58:36 INFO - Downloading/unpacking functools32 (from jsonschema)
06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:36 INFO - Downloading functools32-3.2.3-2.tar.gz
06:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
06:58:36 INFO - warning: no files found matching '*.txt'
06:58:36 INFO - no previously-included directories found matching 'build'
06:58:36 INFO - no previously-included directories found matching 'dist'
06:58:36 INFO - no previously-included directories found matching '.git*'
06:58:36 INFO - Installing collected packages: jsonschema, functools32
06:58:36 INFO - Running setup.py install for functools32
06:58:36 INFO - warning: no files found matching '*.txt'
06:58:36 INFO - no previously-included directories found matching 'build'
06:58:36 INFO - no previously-included directories found matching 'dist'
06:58:36 INFO - no previously-included directories found matching '.git*'
06:58:37 INFO - Successfully installed jsonschema functools32
06:58:37 INFO - Cleaning up...
06:58:37 INFO - Return code: 0
06:58:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv
06:58: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')]}
06:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
06:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58: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')]}
06:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
06:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
06:58:37 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 0x7f069594df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2515770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662', '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
06:58:37 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
06:58:37 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
06:58:37 INFO - Using env: {'DISPLAY': ':0',
06:58:37 INFO - 'HOME': '/home/cltbld',
06:58:37 INFO - 'LANG': 'en_US.UTF-8',
06:58:37 INFO - 'LANGUAGE': 'en_US:en',
06:58:37 INFO - 'LOGNAME': 'cltbld',
06:58:37 INFO - 'MAIL': '/var/mail/cltbld',
06:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:37 INFO - 'MOZ_NO_REMOTE': '1',
06:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:37 INFO - 'NO_EM_RESTART': '1',
06:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:37 INFO - 'PWD': '/builds/slave/test',
06:58:37 INFO - 'SHELL': '/bin/bash',
06:58:37 INFO - 'SHLVL': '1',
06:58:37 INFO - 'TERM': 'linux',
06:58:37 INFO - 'TMOUT': '86400',
06:58:37 INFO - 'USER': 'cltbld',
06:58:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:37 INFO - '_': '/tools/buildbot/bin/python'}
06:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/
06:58:37 INFO - Downloading/unpacking flake8
06:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
06:58:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
06:58:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
06:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
06:58:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
06:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8
06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
06:58:39 INFO - no previously-included directories found matching 'docs/_build'
06:58:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
06:58:39 INFO - Running setup.py install for pep8
06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
06:58:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
06:58:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
06:58:39 INFO - no previously-included directories found matching 'docs/_build'
06:58:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin
06:58:40 INFO - Successfully installed flake8 mccabe pyflakes pep8
06:58:40 INFO - Cleaning up...
06:58:40 INFO - Return code: 0
06:58:40 INFO - Running post-action listener: _resource_record_post_action
06:58:40 INFO - Running post-action listener: _start_resource_monitoring
06:58:40 INFO - Starting resource monitoring.
06:58:40 INFO - #####
06:58:40 INFO - ##### Finished create-virtualenv step (success)
06:58:40 INFO - #####
06:58:40 INFO - #####
06:58:40 INFO - ##### Running install step.
06:58:40 INFO - #####
06:58:40 INFO - Running pre-action listener: _resource_record_pre_action
06:58:40 INFO - Running main action method: install
06:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
06:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
06:58:40 INFO - Reading from file tmpfile_stdout
06:58:40 INFO - Detecting whether we're running mozinstall >=1.0...
06:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
06:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
06:58:40 INFO - Reading from file tmpfile_stdout
06:58:40 INFO - Output received:
06:58:40 INFO - Usage: mozinstall [options] installer
06:58:40 INFO - Options:
06:58:40 INFO - -h, --help show this help message and exit
06:58:40 INFO - -d DEST, --destination=DEST
06:58:40 INFO - Directory to install application into. [default:
06:58:40 INFO - "/builds/slave/test"]
06:58:40 INFO - --app=APP Application being installed. [default: firefox]
06:58:40 INFO - mkdir: /builds/slave/test/build/application
06:58:40 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']
06:58:40 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
06:58:57 INFO - Reading from file tmpfile_stdout
06:58:57 INFO - Output received:
06:58:57 INFO - /builds/slave/test/build/application/firefox/firefox
06:58:57 INFO - Running post-action listener: _resource_record_post_action
06:58:57 INFO - #####
06:58:57 INFO - ##### Finished install step (success)
06:58:57 INFO - #####
06:58:57 INFO - #####
06:58:57 INFO - ##### Running run-tests step.
06:58:57 INFO - #####
06:58:57 INFO - Running pre-action listener: _resource_record_pre_action
06:58:57 INFO - Running main action method: run_tests
06:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
06:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
06:58:57 INFO - Python 2.7.3
06:58:57 INFO - Return code: 0
06:58:57 INFO - grabbing minidump binary from tooltool
06:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
06:58:57 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 0x25a49c0>, '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 0x25a58c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a5d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
06:58:57 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
06:58:57 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
06:58:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
06:58:57 INFO - Return code: 0
06:58:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
06:58:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
06:58:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
06:58:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
06:58:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
06:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos']
06:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos
06:58:58 INFO - Return code: 0
06:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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
06:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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
06:58:58 INFO - Using env: {'DISPLAY': ':0',
06:58:58 INFO - 'HOME': '/home/cltbld',
06:58:58 INFO - 'LANG': 'en_US.UTF-8',
06:58:58 INFO - 'LANGUAGE': 'en_US:en',
06:58:58 INFO - 'LOGNAME': 'cltbld',
06:58:58 INFO - 'MAIL': '/var/mail/cltbld',
06:58:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
06:58:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
06:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
06:58:58 INFO - 'MOZ_NO_REMOTE': '1',
06:58:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
06:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
06:58:58 INFO - 'NO_EM_RESTART': '1',
06:58:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
06:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
06:58:58 INFO - 'PWD': '/builds/slave/test',
06:58:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
06:58:58 INFO - 'SHELL': '/bin/bash',
06:58:58 INFO - 'SHLVL': '1',
06:58:58 INFO - 'TERM': 'linux',
06:58:58 INFO - 'TMOUT': '86400',
06:58:58 INFO - 'USER': 'cltbld',
06:58:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662',
06:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
06:58:58 INFO - '_': '/tools/buildbot/bin/python'}
06:58:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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
06:58:58 INFO - mozversion application_buildid: 20160508043009
06:58:58 INFO - mozversion application_changeset: 01b755909dc18b700bd88eb616862e4872a6daf9
06:58:58 INFO - mozversion application_display_name: Nightly
06:58:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
06:58:58 INFO - mozversion application_name: Firefox
06:58:58 INFO - mozversion application_remotingname: firefox
06:58:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
06:58:58 INFO - mozversion application_vendor: Mozilla
06:58:58 INFO - mozversion application_version: 49.0a1
06:58:58 INFO - mozversion platform_buildid: 20160508043009
06:58:58 INFO - mozversion platform_changeset: 01b755909dc18b700bd88eb616862e4872a6daf9
06:58:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
06:58:58 INFO - mozversion platform_version: 49.0a1
06:58:58 INFO - using testdate: 1462715938
06:58:58 INFO - actual date: 1462715938
06:58:58 INFO - starting webserver on 'localhost:45200'
06:58:58 INFO - SUITE-START | Running 2 tests
06:58:58 INFO - TEST-START | dromaeo_css
06:58:58 INFO - operating with platform_type : linux_
06:58:58 INFO - Initialising browser for dromaeo_css test...
06:58:58 INFO - TEST-INFO | started process 5757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphZ8uYZ/profile http://localhost:45200/getInfo.html)
06:59:02 INFO - PROCESS | 5757 | __metrics Screen width/height:1600/1200
06:59:02 INFO - PROCESS | 5757 | colorDepth:24
06:59:02 INFO - PROCESS | 5757 | Browser inner width/height: 1024/697
06:59:02 INFO - PROCESS | 5757 | __metrics
06:59:03 ERROR - PROCESS | 5757 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
06:59:04 INFO - TEST-INFO | 5757: exit 0
06:59:04 INFO - Browser initialized.
06:59:04 INFO - Running cycle 1/1 for dromaeo_css test...
06:59:04 INFO - TEST-INFO | started process 5841 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphZ8uYZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
06:59:16 INFO - PROCESS | 5841 | RSS: Main: 152690688
06:59:16 INFO - PROCESS | 5841 |
07:00:07 INFO - PROCESS | 5841 | 1462716007631 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]
07:02:15 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45200/tests/dromaeo/cssquery-ext.html)
07:02:17 INFO - PROCESS | 5841 | RSS: Main: 266567680
07:02:17 INFO - PROCESS | 5841 |
07:05:19 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-ext.html (next: http://localhost:45200/tests/dromaeo/cssquery-jquery.html)
07:05:19 INFO - PROCESS | 5841 | RSS: Main: 237387776
07:05:19 INFO - PROCESS | 5841 |
07:08:21 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45200/tests/dromaeo/cssquery-mootools.html)
07:08:22 INFO - PROCESS | 5841 | RSS: Main: 237334528
07:08:22 INFO - PROCESS | 5841 |
07:11:24 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45200/tests/dromaeo/cssquery-prototype.html)
07:11:24 INFO - PROCESS | 5841 | RSS: Main: 231518208
07:11:24 INFO - PROCESS | 5841 |
07:14:27 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45200/tests/dromaeo/cssquery-yui.html)
07:14:28 INFO - PROCESS | 5841 | RSS: Main: 223031296
07:14:28 INFO - PROCESS | 5841 |
07:17:30 INFO - PROCESS | 5841 | Cycle 1(1): loaded http://localhost:45200/tests/dromaeo/cssquery-yui.html (next: http://localhost:45200/tests/dromaeo/cssquery-dojo.html)
07:17:31 INFO - PROCESS | 5841 | RSS: Main: 268582912
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | __start_tp_report
07:17:31 INFO - PROCESS | 5841 | _x_x_mozilla_page_load
07:17:31 INFO - PROCESS | 5841 | _x_x_mozilla_page_load_details
07:17:31 INFO - PROCESS | 5841 | |i|pagename|runs|
07:17:31 INFO - PROCESS | 5841 | |0;dojo.html;3140.4504211762937;3146.056183145056;3172.524121381793;3188.6811318868104;3211.0527394418646;5191.117510023296;5220.425753167154;5297.682139071649;5308.283381743464;5332.3601167859815;5338;5344.652597581155;5398.4601539846;5452.127659574468;5475.698836563997;4769.666123371357;4784.97607511962;4785.377900872899;4895.020995800836;4966.453690094087;4779.330893674888;4974.577160941324;4991.825286114987;4994.35073440454;5015.523525265094;4727.952720472803;4774.618030557547;4783.665143439961;4921.655484116113;4940.703557786526;4829.3721816164025;4834.129856625806;4835.178019736618;4837.7097374157665;4848.345473361086;4772.451168115676;4802.327674125625;4816.157172494799;4849.733264670442;4864.878378040542;5242.449542798027;5268.92096618551;5320.813771517978;5403.027455058088;5413.133898576249;5799.2750906136735;5826.184334193216;5836.416358364172;5843.065109582446;5843.5033022193165;5536.889262214773;5697.829065128011;5762.394948530427;5768.596198266123;5833.037548804442;5364.570834333244;5374.892502149935;5422.566194704415;5438.428964958702;5439.728013599383;5680.573956953245;5933.3473317934995;5938.792142275086;5942.3361458791605;5950.553708471882;5670.206171136044;5731.025725626653;5735.1684005818925;5751.626144300607;5812.360640329561;5779.797707080232;5850.414958504116;5857.20927674767;5857.648541087548;5892.440218179266;5553.444655534414;5634.943650563442;5810.854728631733;5819.883602328015;5829.854253643608;5687.0616348302065;5743.511801496836;5750.7987220447085;5761.049426844524;5804.477597016289;4338.783060846945;4343.956560434419;4349.064951035542;4361.956380436219;4386.583274588909;3825.445310429972;3860.3051450739135;3910.765354078764;3917.3536366499206;3933.056066544066;5434.347878254555;5480.6437581557075;5486.561075113981;5490.066688662937;5534.391216966131;5793.507551858139;5795.536357091422;5797.797077102281;5803.7968671096305;5808.157817116495;5328.3605967284175;5403.108487099663;5427.267318911975;5461.126219804892;5466.453354664502;4655.883602909887;4704.741239231875;4709.175894218498;4710.175719249118;4752.572268495852;5950.107483877367;5966.880662386728;5972.104184372379;5972.313183983897;5972.671503067286;5549.667019978814;5603.187537807076;5653.717314134359;5661.2923384576925;5685.834403947264;5870.647761134345;5870.677112758839;5878.29460464747;5879.029960056543;5879.323877754113;5483.8080667176455;5564.860878478071;5613.494785469327;5615.3823079462045;5619.466150715675;5696.344920334049;5720.08478643415;5735.225744524436;5742.339630942495;5749.511291540266;5609.579281553818;5613.158026296088;5615.2700148980375;5620.690862002465;5622.5501959842295;5395.244665746877;5501.229827824028;5620.550355971594;5629.971850140887;5639.520640745583;5425.240466334795;5500.58745594074;5506.091494903296;5509.641873278224;5549.750261238173;5603.971980140236;5636;5690.402507736628;5691.630044047124;5695.857603559944;5348.679079255257;5398;5473.397926228032;5509;5547.694876781654
07:17:31 INFO - PROCESS | 5841 | |1;ext.html;590.9763609455622;636.8885445047117;639.4947991087039;646.2116218213778;650.0444346810191;29010;29686.257843553896;41466;42316;42389.57610423895;40110.598894011055;44180.558194418045;44226.778866105626;44235.33646995298;44268.11463770723;8749.343799215052;8935.865962010575;8941.061188575204;8952.194302512773;8957.37298389113;8804.251638610694;8909.509976951265;8917.242034427081;8921.375503714742;8931;8878.556072196398;8898.688545900895;8916;8919;8934.55327233639;8808.64765409383;8837.558122093933;8860.335474839381;8861.468311901242;8863.113688631118;8768.386212965095;8835.337349698799;8841.204291613785;8844.11558844117;8844.955775221148;40556.59443405558;40972;41084.79457602723;41265.58734412648;41342.79328603368;3438.5186073949667;3587.677109060197;3629.1290090378384;4012.293323488009;4149.2531344358;31114.377712445625;31348.52977205321;31350.52974205389;31762;31924.521132183036;4296.205202037633;4308.267594508941;4406.184855801687;4422.911541769179;4437.955620443819;319778.9999999977;319854;320111;321011;321697;55069;55602.443975560534;55656.443435565125;55676.16485752717;55708;36683.26633467316;36923;37053.44419833705;39237.2152556953;39285.41071883924;16166.43417480406;16188.919055404647;16298.42955496552;16303.83696163047;16311.510654680378;11555.76888462226;11594.188406811441;11601.825972610417;11603.361815100081;11613.593524226611;19782.604347912962;20005.899970500344;20030.198792048446;20055.59888802245;20106.899465502578;7101.857962840818;7156.642167891585;7162.534435261691;7278.344948954514;7349.7060117595765;984.4536282363357;1052.2423854824515;1148.8047032004579;1150.2408410449063;1171.6719318590808;31160.53259201114;31780.523292150636;31796.20509487235;32145;32312.838435808142;1119.2221406122828;1126.8028095083328;1159.8202278646822;1216.975660486803;1257.270782945889;16948.57628559296;17016.149192540324;17153.742693859604;17229;17396.565085872953;471067;472365;475140;477725;478360;56910;57283;57325.713371432874;57351.71324143436;57375.42624573784;1292.3925754895183;1307.5881097454271;1358.9796153057712;1390.8122403475604;1422.6087825847974;30219;32607.34785304328;32656.34687306288;32764.180895477803;32988.50517242195;47788.7610561945;48221.27668085052;48344.274835876786;48384.27423588719;48391.75804120957;339283;339602;340711;340822;341543;25817.741822581535;26216.475670486863;26228.73771262339;26448.8677556611;27750.02874899369;47613;48193.27710084282;48497.27254091121;48601.75699121482;49179.262311064645;40407.3938890911;40469.19061618692;40560.79719601501;40937.38593921034;41724;39991.40012899867;40179.39730904097;40401.1919761609;40456.3931541033;41107.177856442104;36592;37244.81377593095;37422.8128859354;37451;37474.063148421505;33464.1633959153;35515.28969420649;35604.465933010506;35645.39410921503;35683.46474802828;27550.5867411993;27786;28016.159515214575;28090;28120.57819132674
07:17:31 INFO - PROCESS | 5841 | |2;jquery.html;380.5719509529203;390.40073487197174;391.2741863842571;395.9227950549643;418.48108345651383;18018.369357072504;19291.13189906454;19423.12595933183;19495.805041949578;20339.28812491563;17056.658866822658;17690.469285921412;17726.113694315296;17990.82009179908;18022.369217077372;5578.581606379527;5659.462351076641;5724.141378793172;5730.828075157752;5748.310202775673;5526.392096869341;5671.943280567183;5680.914786278209;5703.40114288;5711.885762284752;5543.501084902358;5622.8313150605545;5644.633098848582;5663.886722265553;5667.178259152421;5512.228288039678;5597.104463285875;5623.0159722048475;5629.746661400247;5672.319321681404;4840.927386089212;5010.949890501085;5016.648834581581;5021.221710634857;5022.899542009176;19747.308844190527;19767.80232197674;20647.17411303561;22469.662955055686;22998.77001229983;2236.586231547169;2288.3249441414823;2338.228384633067;2925.970740292591;3095.1178914009624;10019.348742331798;10048.849267260997;10093.142082922961;10421.5831366746;10435.582576696923;1922.2503223742751;1954.3257576136211;1970.231609672229;1989.7512810898638;2057.6296266671993;85110.57444712799;85302.57348713216;85394;86886.5655671724;87656.56171719101;10829.566817327219;10851.51168197433;10914.126869850394;10927.125829933586;11104.888951110386;15247.771283430757;15342;15351.309191086428;15375.231238438033;15388.615284617974;7732.729354472566;7836.568988705676;7917.208279172037;7919.089304729914;8021;7615;7666.041744781903;7757.883631745528;7823.217678232245;7916.366690664733;4480.103979204172;4556.589906908394;4558.088382323483;4580.679352445363;4622.352870598119;1800.225902861782;1877.643247782917;1891.7162425636266;1925.3742533676332;1976.377441106047;906.71891713569;991.8760154980628;996.3025881882711;1078.2775540387959;1102.525913857049;18037.098145092692;18505.7224141638;19337.903310483358;19427.4171774847;19552.21791128339;1027.3219675014604;1033.9327943683636;1041.4532370505544;1051.9631812886512;1064.5848119233506;10320.935812837313;10867;10996.615118470816;11020.779584408267;11060;485782;488631;494003;503750;514491;83290;92589.5370523143;93755;96145;97007.51496242474;1084.7505073833063;1110.972225694348;1129.4635048352131;1148.8047032004579;1152.475623591264;17361.652766944844;17458.30166793314;17793;17849.464516064538;17879.910600446914;30061.549076764302;38693.41959870548;40762;40975.7951210242;42711.7864410676;54489;55198.724006379714;55221;56480;57003.42996569981;8430.15698430152;8457.323414126731;8761.342899282452;8800.603972821367;8918.86621700688;11976;13195.538156164488;13401.195928244337;13424.731505370033;13458.327083645583;11477.770444590895;11488.94255528717;11609.419529023684;11687.298762074302;11855.466504007169;11555.595554155565;11569.363684997406;11673.12451566119;11682.357470338873;11784.58753943608;11748.94125529401;11835.11236657237;11841.82237266459;11953.282803031498;12010.699732506757;8607;8645.286066055918;8681.479111253346;8690.130986901258;8695.999960004681;10506.369617822955;11359.261647992855;11547.884521154681;11590.768184636092;11678.416079196177
07:17:31 INFO - PROCESS | 5841 | |3;mootools.html;1365.9521916732917;1552.0222259976213;1571.300771156835;1746.4411388355722;1835.779706435228;7887.132415434305;8185.959070204648;8226.383021273414;8419.621117049732;8426.620802063906;8192.262696357328;8363.623636936338;8392.874106888386;8421.747347579567;8439.32485401168;2048.641487739647;2341.75411581784;2372.2171683344454;2398.676178715877;2433.4038160650666;2408.458096928186;2423.3820375804144;2425.3451568076607;2425.757424257569;2426.0780903256828;2374.0385144016614;2434.6469761884514;2436.062116085311;2437.4150203951012;2450.742672019439;2051.0360130738527;2340.32130682102;2406.470576473173;2412.0592968742203;2414.215380001489;2332.4052366646565;2336.4859730859184;2337.8947947342413;2346.0498498108295;2366.3255972048055;8439.57802109892;8485.490870547786;8489.151084891462;8496.78758031048;8503.277221436185;5200.349956255468;5342.358916929955;5346.304980352568;5346.492083252085;5351.866203344908;3406.131436483681;3508.0878971467346;3536.2220311531423;3547.627499112582;3577.8568857245677;1129.2772625519674;1151;1166.5333866453486;1174.2719513901436;1188.7087663522407;11716.94141529287;11916.940415297868;11923.523059077626;11948.103892208119;12011.219270747373;4559.107970192333;4594.632429405639;4720.386349774507;4720.480747117815;4726.598239149711;9326.860097098548;9368.156865881967;9418.717438476857;9423.199028082552;9443.386179898285;4683.320918466803;5176.663516871391;5181.4559471255725;5196.298499702491;5205.817796377109;4468.218061839165;4505.5719706627815;4505.594496495331;4835.178019736653;4967.875803104879;3741.0273328934127;3883.0874744435037;3892.6691231245663;3943.8168549435627;3948.2498325318097;1174.3364998775664;1175.4122938530734;1184.236167671847;1200.75984803038;1206.10748046445;969.1907257439975;983.1495756171004;990.2573070197352;995.2635050062902;1010.5553556435292;5797.652140871477;5911.408859114054;6064.090386442069;6067.696615169224;6072.544559157993;466.86694292126583;467.2104143996635;467.84327250371507;476.65680709888824;479.63547703745405;4107.8973025674;4110.46563946685;4116.444280022219;4117.3206420940805;4182.498100227992;10092.747681308027;10542.156627469783;10582.947085264525;10622.415767132881;10666.786664266827;10015.499225038864;10289.74275643115;10321.63874264397;10396.688099357032;10706.357618542912;8184.754457366289;8196.606576881944;8332.583370831435;8346.707865224687;8359.331253499706;5948.464638182584;6002.0996850472775;6118.694065296629;6148.508119350352;6191.907121393273;9642.180414664832;9680.177184939359;9721.9027809721;9802.950985245028;9890.763654543181;9862.457564834003;9900.25748068912;10018.298719089593;10018.849717254392;10094.596216151565;6387.201599800025;6912.135983002125;7049.330313620198;7136.536125151849;7203.927960720326;8332.708355207538;8344.457610255315;8409.411341206056;8409.579521023801;8427.789305267417;7205.387542058774;7296.890546641911;7464.738734144279;7597.278258565428;7766.650500727594;7376.077990251219;7380.409567234716;7428.665710042953;7653.732119375795;7805.9609701953395;6888.104546408935;6903.723851045902;6938.5836849789175;6958.512904096665;6966.303369663196;5286.233496143114;5363.704996225245;5388.730563471732;5417.945820541744;5487.094629386106;5158.664686795346;5260.605454590845;5268.1044222481505;5295.682259064469;5385.757640906247
07:17:31 INFO - PROCESS | 5841 | |4;prototype.html;327.167359071164;335.1286654697786;338.4060972992399;340.7274180655475;344.51251479156963;5343.866403339918;5348.117560602501;5351.438098999607;5351.73241337933;5355.544778693806;4994.8501544953615;5121.5390614844655;5159.66462179958;5173.275741396198;5304.602154838393;3997.620226078518;4079.2861249281405;4158.937615935748;4158.958410415902;4186.35111557709;4105.3020986432375;4130.628243458088;4147.771872547009;4154.0030392705685;4171.624553790159;3995.8201880915285;4102.835886564549;4113.8354465821485;4123.216588848124;4133.42132101506;4087.550369459357;4092.7135100542973;4105.91788164235;4110.7122501424765;4112.506499220083;3635.2005757150114;3650.5254316938626;3665.4685070664605;3670.522832031819;3686.5760437549757;5025.246213068032;5110.5911527078115;5167.302414174076;5204.245384419238;5223.738813059332;4720.315554244616;4722.220833562458;4760.024195040009;4768.7615619218905;4772.188727916263;5528.336599608033;5534.229046705056;5540.972295138498;5542.39033706292;5572.164175373686;3955.8417663293435;3959.307121253769;4030;4042.6765858731233;4063.2889244382113;5682.886342273173;5707.6575405475805;5756.589635539278;5773.538116950634;5776.797812076599;4113.732607380511;4116.238495878212;4121.258173528734;4154.709170358106;4156.8129434175535;4102.343625019982;4185.183889141588;4204.474440694913;4207.410962465257;4215.304474761691;4721.362616046858;4731.243001119804;4746.95253047472;4747.169245382113;4762.52374762521;5572.442755724476;5604.075327570987;5608.46719561641;5617.859553511195;5627.212190293362;1341;1366.221253885276;1393.770027945398;1407.7043820797746;1414.6887684709347;963.3016063354012;966.4974213408988;979.8628192053118;981.7005813227034;994.4132961552574;5125.666831655931;5162.303089082926;5178.81874134411;5212.582993360522;5240.34495688039;5495.873345964068;5497.862553436196;5511.972440137773;5538;5566.944330556724;4954.5540901319055;5193.844184674465;5206.869828254324;5240.716024574004;5256.369235691665;2901.622789037454;2910.5052141136057;2931.311141881656;2933.2080338308538;2937.2510009947327;5633.352164501053;5691.446842525963;5727.823427097676;5734.569907256889;5740.483356497935;5516.889662206733;5592.384837667853;5887.852803679856;5897.439743224387;5899.823005309848;5958.46373826349;5960.135780311831;5960.910586341209;5966.045432730916;5982.371850955587;5538.252335934759;5754.597178197486;5787;5788.479036886701;5788.536917046542;5636.2954630671165;5640.210370548045;5668.461496157858;5714.5999780015;5719.142128680731;5962.37395073511;5973.581849270509;5998.760049597967;6004.459598636144;6010.3088144863905;3875.7286989910435;4027.778472184058;4036.313826649418;4041.332720404519;4047.838086476626;5516.834494965157;5667.384795333311;5709.371969083314;5715.199872017838;5748.310202775694;5438.70087145195;5611.803586874603;5617.634853734494;5646.35066967304;5650.152477128299;5524.4199359066715;5550.583706221969;5605.32736071674;5610.747516361856;5616.494515493625;5249.895002100013;5480.72596370172;5491.368492623399;5536.501714845522;5543.445655434585;5617.297837770278;5663.631863928831;5678.7728490861555;5680.147977803363;5709.8287051388525;5451.966754607053;5549.944500555104;5562.332520097614;5564.77740890376;5594.188842617879
07:17:31 INFO - PROCESS | 5841 | |5;yui.html;752.270297811123;759.1497522774494;800.5196881870877;812.7764864662221;860.8837806896071;13804.516841910536;14146.929265353685;14147.292635368241;14199.645008874782;14203.076800008004;10983.780324393527;11877;11891.940540297286;11900.523979040829;11904.523819047228;813.5891374855704;835.6239692138531;837.7654256808104;841.8190089130836;844.2781421884292;829.4732844643664;832.1512057701141;833.7332053742805;834.9039860416069;838.8573942429771;706.7738323736406;863.0506442912808;876.1545108969843;877.3463769491706;877.6533269358599;860.9440386374865;865.5715420866649;866.8223014282057;867.600903584352;867.8568036274039;633.2243002322118;634.1945728924286;634.238913304037;634.2642534659773;635.4566845347254;14379.85620143806;14387.568372948723;14388.92805535976;14460.927695361455;14497.855021449755;13541.796873046913;13545.525906593222;13698.38357273925;13792.793108103386;13843.30783460823;11687.344173710973;11767.941160294144;11981.341026243554;12033.51865925362;12176.772457774863;4329.2423825830665;4382.715123516961;4454.420925279725;4499.257622492285;4598.747068911209;55610.72194639041;55678;56041.159382609294;56080;56263;10855.457227138611;11045.723856903642;11234.662960111209;11262.887371126184;11459.656210313704;19537.413877583695;19768.11043503046;19770;19786.50533736668;19799.218070373736;8257.587120643944;8306.293965013041;8347.081820999685;8578.91421085781;8681.782955426039;4115.753054816721;4240.787960601958;4258;4299.032717638506;4346.630536404377;3228.6287076985977;3315.635280119185;3332.500124981272;3357.9496307555405;3360.7143392811886;604.9455549000611;669.1835960128635;701.2706784943601;714.5391222661458;726.2882375272263;730.4594599995964;740.7888751705738;743.3198623259657;762.7826069570257;767.800371903298;9591.856122158173;9626.181774549103;9637.71086867395;9780.364276322016;9867.605295788231;662.4700239808134;746.2052913646949;757.8976838126893;767.1484652036236;770.1335997003371;4440.156370289635;4642.210824159901;4694.389729335165;4711.293306004127;4866.124097662384;58529;60287.69856150691;60662;60794;65632.67183664051;55184.17223741647;56421.43578564244;57258.42741572531;58312.70843645839;59029.40970590239;47256.291155632694;52272.477275227524;53783.73108134434;54068;55365.44634553603;8490.320774337915;8873.157050080232;8915.55422228873;9023.774405639911;9026.774330641787;34715;34944.475832863034;35151.82424087863;36041.819790900874;36143;42578.5742142587;45360.31959520676;46305;46336.304955425025;46969.06061878811;12269.93865030669;12344.75310493803;12345.691357716129;12596;12604.684882878002;13744.437952267694;13844.238566878917;14292.35684394184;14351.928240358731;14646.926765366105;11860.40697965081;12347.19743216688;12410.503579856704;12914.160579562298;13311.933440332736;12795.744085118431;12930.288834114213;12963.287019214034;12963.546275880299;13042.04369344568;11945.940270298941;12737.490500380252;13000.219986800823;13071.346432678138;13272.601821945356;10422.322549034288;10657.41384223844;10789.676309710721;10874.945625271823;11047.392393418439;11015.339079655247;11041.736444029115;11209.775804484028;11328.773424531628;11351.54593816238
07:17:31 INFO - PROCESS | 5841 | __end_tp_report
07:17:31 INFO - PROCESS | 5841 | __start_cc_report
07:17:31 INFO - PROCESS | 5841 | _x_x_mozilla_cycle_collect,858
07:17:31 INFO - PROCESS | 5841 | __end_cc_report
07:17:31 INFO - PROCESS | 5841 | __startTimestamp1462717051003__endTimestamp
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | ------- Summary: start -------
07:17:31 INFO - PROCESS | 5841 | Number of tests: 6
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#0] dojo.html Cycles:165 Average:5320.97 Median:5506.09 stddev:613.95 (11.2%) stddev-sans-first:591.52
07:17:31 INFO - PROCESS | 5841 | Values: 3140.5 3146.1 3172.5 3188.7 3211.1 5191.1 5220.4 5297.7 5308.3 5332.4 5338.0 5344.7 5398.5 5452.1 5475.7 4769.7 4785.0 4785.4 4895.0 4966.5 4779.3 4974.6 4991.8 4994.4 5015.5 4728.0 4774.6 4783.7 4921.7 4940.7 4829.4 4834.1 4835.2 4837.7 4848.3 4772.5 4802.3 4816.2 4849.7 4864.9 5242.4 5268.9 5320.8 5403.0 5413.1 5799.3 5826.2 5836.4 5843.1 5843.5 5536.9 5697.8 5762.4 5768.6 5833.0 5364.6 5374.9 5422.6 5438.4 5439.7 5680.6 5933.3 5938.8 5942.3 5950.6 5670.2 5731.0 5735.2 5751.6 5812.4 5779.8 5850.4 5857.2 5857.6 5892.4 5553.4 5634.9 5810.9 5819.9 5829.9 5687.1 5743.5 5750.8 5761.0 5804.5 4338.8 4344.0 4349.1 4362.0 4386.6 3825.4 3860.3 3910.8 3917.4 3933.1 5434.3 5480.6 5486.6 5490.1 5534.4 5793.5 5795.5 5797.8 5803.8 5808.2 5328.4 5403.1 5427.3 5461.1 5466.5 4655.9 4704.7 4709.2 4710.2 4752.6 5950.1 5966.9 5972.1 5972.3 5972.7 5549.7 5603.2 5653.7 5661.3 5685.8 5870.6 5870.7 5878.3 5879.0 5879.3 5483.8 5564.9 5613.5 5615.4 5619.5 5696.3 5720.1 5735.2 5742.3 5749.5 5609.6 5613.2 5615.3 5620.7 5622.6 5395.2 5501.2 5620.6 5630.0 5639.5 5425.2 5500.6 5506.1 5509.6 5549.8 5604.0 5636.0 5690.4 5691.6 5695.9 5348.7 5398.0 5473.4 5509.0 5547.7
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#1] ext.html Cycles:180 Average:53809.88 Median:22061.45 stddev:101577.89 (460.4%) stddev-sans-first:101784.25
07:17:31 INFO - PROCESS | 5841 | Values: 591.0 636.9 639.5 646.2 650.0 29010.0 29686.3 41466.0 42316.0 42389.6 40110.6 44180.6 44226.8 44235.3 44268.1 8749.3 8935.9 8941.1 8952.2 8957.4 8804.3 8909.5 8917.2 8921.4 8931.0 8878.6 8898.7 8916.0 8919.0 8934.6 8808.6 8837.6 8860.3 8861.5 8863.1 8768.4 8835.3 8841.2 8844.1 8845.0 40556.6 40972.0 41084.8 41265.6 41342.8 3438.5 3587.7 3629.1 4012.3 4149.3 31114.4 31348.5 31350.5 31762.0 31924.5 4296.2 4308.3 4406.2 4422.9 4438.0 319779.0 319854.0 320111.0 321011.0 321697.0 55069.0 55602.4 55656.4 55676.2 55708.0 36683.3 36923.0 37053.4 39237.2 39285.4 16166.4 16188.9 16298.4 16303.8 16311.5 11555.8 11594.2 11601.8 11603.4 11613.6 19782.6 20005.9 20030.2 20055.6 20106.9 7101.9 7156.6 7162.5 7278.3 7349.7 984.5 1052.2 1148.8 1150.2 1171.7 31160.5 31780.5 31796.2 32145.0 32312.8 1119.2 1126.8 1159.8 1217.0 1257.3 16948.6 17016.1 17153.7 17229.0 17396.6 471067.0 472365.0 475140.0 477725.0 478360.0 56910.0 57283.0 57325.7 57351.7 57375.4 1292.4 1307.6 1359.0 1390.8 1422.6 30219.0 32607.3 32656.3 32764.2 32988.5 47788.8 48221.3 48344.3 48384.3 48391.8 339283.0 339602.0 340711.0 340822.0 341543.0 25817.7 26216.5 26228.7 26448.9 27750.0 47613.0 48193.3 48497.3 48601.8 49179.3 40407.4 40469.2 40560.8 40937.4 41724.0 39991.4 40179.4 40401.2 40456.4 41107.2 36592.0 37244.8 37422.8 37451.0 37474.1 33464.2 35515.3 35604.5 35645.4 35683.5 27550.6 27786.0 28016.2 28090.0 28120.6
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#2] jquery.html Cycles:180 Average:29085.95 Median:12353.12 stddev:82076.47 (664.4%) stddev-sans-first:82278.41
07:17:31 INFO - PROCESS | 5841 | Values: 380.6 390.4 391.3 395.9 418.5 18018.4 19291.1 19423.1 19495.8 20339.3 17056.7 17690.5 17726.1 17990.8 18022.4 5578.6 5659.5 5724.1 5730.8 5748.3 5526.4 5671.9 5680.9 5703.4 5711.9 5543.5 5622.8 5644.6 5663.9 5667.2 5512.2 5597.1 5623.0 5629.7 5672.3 4840.9 5010.9 5016.6 5021.2 5022.9 19747.3 19767.8 20647.2 22469.7 22998.8 2236.6 2288.3 2338.2 2926.0 3095.1 10019.3 10048.8 10093.1 10421.6 10435.6 1922.3 1954.3 1970.2 1989.8 2057.6 85110.6 85302.6 85394.0 86886.6 87656.6 10829.6 10851.5 10914.1 10927.1 11104.9 15247.8 15342.0 15351.3 15375.2 15388.6 7732.7 7836.6 7917.2 7919.1 8021.0 7615.0 7666.0 7757.9 7823.2 7916.4 4480.1 4556.6 4558.1 4580.7 4622.4 1800.2 1877.6 1891.7 1925.4 1976.4 906.7 991.9 996.3 1078.3 1102.5 18037.1 18505.7 19337.9 19427.4 19552.2 1027.3 1033.9 1041.5 1052.0 1064.6 10320.9 10867.0 10996.6 11020.8 11060.0 485782.0 488631.0 494003.0 503750.0 514491.0 83290.0 92589.5 93755.0 96145.0 97007.5 1084.8 1111.0 1129.5 1148.8 1152.5 17361.7 17458.3 17793.0 17849.5 17879.9 30061.5 38693.4 40762.0 40975.8 42711.8 54489.0 55198.7 55221.0 56480.0 57003.4 8430.2 8457.3 8761.3 8800.6 8918.9 11976.0 13195.5 13401.2 13424.7 13458.3 11477.8 11488.9 11609.4 11687.3 11855.5 11555.6 11569.4 11673.1 11682.4 11784.6 11748.9 11835.1 11841.8 11953.3 12010.7 8607.0 8645.3 8681.5 8690.1 8696.0 10506.4 11359.3 11547.9 11590.8 11678.4
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#3] mootools.html Cycles:180 Average:5658.88 Median:5167.66 stddev:3140.21 (60.8%) stddev-sans-first:3132.45
07:17:31 INFO - PROCESS | 5841 | Values: 1366.0 1552.0 1571.3 1746.4 1835.8 7887.1 8186.0 8226.4 8419.6 8426.6 8192.3 8363.6 8392.9 8421.7 8439.3 2048.6 2341.8 2372.2 2398.7 2433.4 2408.5 2423.4 2425.3 2425.8 2426.1 2374.0 2434.6 2436.1 2437.4 2450.7 2051.0 2340.3 2406.5 2412.1 2414.2 2332.4 2336.5 2337.9 2346.0 2366.3 8439.6 8485.5 8489.2 8496.8 8503.3 5200.3 5342.4 5346.3 5346.5 5351.9 3406.1 3508.1 3536.2 3547.6 3577.9 1129.3 1151.0 1166.5 1174.3 1188.7 11716.9 11916.9 11923.5 11948.1 12011.2 4559.1 4594.6 4720.4 4720.5 4726.6 9326.9 9368.2 9418.7 9423.2 9443.4 4683.3 5176.7 5181.5 5196.3 5205.8 4468.2 4505.6 4505.6 4835.2 4967.9 3741.0 3883.1 3892.7 3943.8 3948.2 1174.3 1175.4 1184.2 1200.8 1206.1 969.2 983.1 990.3 995.3 1010.6 5797.7 5911.4 6064.1 6067.7 6072.5 466.9 467.2 467.8 476.7 479.6 4107.9 4110.5 4116.4 4117.3 4182.5 10092.7 10542.2 10582.9 10622.4 10666.8 10015.5 10289.7 10321.6 10396.7 10706.4 8184.8 8196.6 8332.6 8346.7 8359.3 5948.5 6002.1 6118.7 6148.5 6191.9 9642.2 9680.2 9721.9 9803.0 9890.8 9862.5 9900.3 10018.3 10018.8 10094.6 6387.2 6912.1 7049.3 7136.5 7203.9 8332.7 8344.5 8409.4 8409.6 8427.8 7205.4 7296.9 7464.7 7597.3 7766.7 7376.1 7380.4 7428.7 7653.7 7806.0 6888.1 6903.7 6938.6 6958.5 6966.3 5286.2 5363.7 5388.7 5417.9 5487.1 5158.7 5260.6 5268.1 5295.7 5385.8
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#4] prototype.html Cycles:180 Average:4675.56 Median:5324.23 stddev:1377.01 (25.9%) stddev-sans-first:1341.64
07:17:31 INFO - PROCESS | 5841 | Values: 327.2 335.1 338.4 340.7 344.5 5343.9 5348.1 5351.4 5351.7 5355.5 4994.9 5121.5 5159.7 5173.3 5304.6 3997.6 4079.3 4158.9 4159.0 4186.4 4105.3 4130.6 4147.8 4154.0 4171.6 3995.8 4102.8 4113.8 4123.2 4133.4 4087.6 4092.7 4105.9 4110.7 4112.5 3635.2 3650.5 3665.5 3670.5 3686.6 5025.2 5110.6 5167.3 5204.2 5223.7 4720.3 4722.2 4760.0 4768.8 4772.2 5528.3 5534.2 5541.0 5542.4 5572.2 3955.8 3959.3 4030.0 4042.7 4063.3 5682.9 5707.7 5756.6 5773.5 5776.8 4113.7 4116.2 4121.3 4154.7 4156.8 4102.3 4185.2 4204.5 4207.4 4215.3 4721.4 4731.2 4747.0 4747.2 4762.5 5572.4 5604.1 5608.5 5617.9 5627.2 1341.0 1366.2 1393.8 1407.7 1414.7 963.3 966.5 979.9 981.7 994.4 5125.7 5162.3 5178.8 5212.6 5240.3 5495.9 5497.9 5512.0 5538.0 5566.9 4954.6 5193.8 5206.9 5240.7 5256.4 2901.6 2910.5 2931.3 2933.2 2937.3 5633.4 5691.4 5727.8 5734.6 5740.5 5516.9 5592.4 5887.9 5897.4 5899.8 5958.5 5960.1 5960.9 5966.0 5982.4 5538.3 5754.6 5787.0 5788.5 5788.5 5636.3 5640.2 5668.5 5714.6 5719.1 5962.4 5973.6 5998.8 6004.5 6010.3 3875.7 4027.8 4036.3 4041.3 4047.8 5516.8 5667.4 5709.4 5715.2 5748.3 5438.7 5611.8 5617.6 5646.4 5650.2 5524.4 5550.6 5605.3 5610.7 5616.5 5249.9 5480.7 5491.4 5536.5 5543.4 5617.3 5663.6 5678.8 5680.1 5709.8 5452.0 5549.9 5562.3 5564.8 5594.2
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - PROCESS | 5841 | [#5] yui.html Cycles:180 Average:15058.66 Median:24929.79 stddev:17435.82 (69.9%) stddev-sans-first:17451.63
07:17:31 INFO - PROCESS | 5841 | Values: 752.3 759.1 800.5 812.8 860.9 13804.5 14146.9 14147.3 14199.6 14203.1 10983.8 11877.0 11891.9 11900.5 11904.5 813.6 835.6 837.8 841.8 844.3 829.5 832.2 833.7 834.9 838.9 706.8 863.1 876.2 877.3 877.7 860.9 865.6 866.8 867.6 867.9 633.2 634.2 634.2 634.3 635.5 14379.9 14387.6 14388.9 14460.9 14497.9 13541.8 13545.5 13698.4 13792.8 13843.3 11687.3 11767.9 11981.3 12033.5 12176.8 4329.2 4382.7 4454.4 4499.3 4598.7 55610.7 55678.0 56041.2 56080.0 56263.0 10855.5 11045.7 11234.7 11262.9 11459.7 19537.4 19768.1 19770.0 19786.5 19799.2 8257.6 8306.3 8347.1 8578.9 8681.8 4115.8 4240.8 4258.0 4299.0 4346.6 3228.6 3315.6 3332.5 3357.9 3360.7 604.9 669.2 701.3 714.5 726.3 730.5 740.8 743.3 762.8 767.8 9591.9 9626.2 9637.7 9780.4 9867.6 662.5 746.2 757.9 767.1 770.1 4440.2 4642.2 4694.4 4711.3 4866.1 58529.0 60287.7 60662.0 60794.0 65632.7 55184.2 56421.4 57258.4 58312.7 59029.4 47256.3 52272.5 53783.7 54068.0 55365.4 8490.3 8873.2 8915.6 9023.8 9026.8 34715.0 34944.5 35151.8 36041.8 36143.0 42578.6 45360.3 46305.0 46336.3 46969.1 12269.9 12344.8 12345.7 12596.0 12604.7 13744.4 13844.2 14292.4 14351.9 14646.9 11860.4 12347.2 12410.5 12914.2 13311.9 12795.7 12930.3 12963.3 12963.5 13042.0 11945.9 12737.5 13000.2 13071.3 13272.6 10422.3 10657.4 10789.7 10874.9 11047.4 11015.3 11041.7 11209.8 11328.8 11351.5
07:17:31 INFO - PROCESS | 5841 | -------- Summary: end --------
07:17:31 INFO - PROCESS | 5841 |
07:17:31 INFO - TEST-INFO | 5841: exit 0
07:17:31 INFO - TEST-OK | dromaeo_css | took 1113548ms
07:17:31 INFO - TEST-START | kraken
07:17:31 INFO - operating with platform_type : linux_
07:17:31 INFO - Initialising browser for kraken test...
07:17:31 INFO - TEST-INFO | started process 6026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEZULCv/profile http://localhost:45200/getInfo.html)
07:17:36 INFO - PROCESS | 6026 | __metrics Screen width/height:1600/1200
07:17:36 INFO - PROCESS | 6026 | colorDepth:24
07:17:36 INFO - PROCESS | 6026 | Browser inner width/height: 1024/697
07:17:36 INFO - PROCESS | 6026 | __metrics
07:17:37 ERROR - PROCESS | 6026 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null
07:17:37 INFO - TEST-INFO | 6026: exit 0
07:17:37 INFO - Browser initialized.
07:17:37 INFO - Running cycle 1/1 for kraken test...
07:17:37 INFO - TEST-INFO | started process 6111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEZULCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
07:17:49 INFO - PROCESS | 6111 | RSS: Main: 152039424
07:17:49 INFO - PROCESS | 6111 |
07:17:52 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45200/tests/kraken/driver.html?testName=audio-beat-detection)
07:17:53 INFO - PROCESS | 6111 | RSS: Main: 208658432
07:17:53 INFO - PROCESS | 6111 |
07:17:55 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45200/tests/kraken/driver.html?testName=audio-dft)
07:17:56 INFO - PROCESS | 6111 | RSS: Main: 197967872
07:17:56 INFO - PROCESS | 6111 |
07:17:59 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45200/tests/kraken/driver.html?testName=audio-fft)
07:18:00 INFO - PROCESS | 6111 | RSS: Main: 264957952
07:18:00 INFO - PROCESS | 6111 |
07:18:02 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45200/tests/kraken/driver.html?testName=audio-oscillator)
07:18:03 INFO - PROCESS | 6111 | RSS: Main: 174948352
07:18:03 INFO - PROCESS | 6111 |
07:18:05 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45200/tests/kraken/driver.html?testName=imaging-gaussian-blur)
07:18:05 INFO - PROCESS | 6111 | RSS: Main: 178671616
07:18:05 INFO - PROCESS | 6111 |
07:18:09 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45200/tests/kraken/driver.html?testName=imaging-darkroom)
07:18:09 INFO - PROCESS | 6111 | RSS: Main: 214536192
07:18:09 INFO - PROCESS | 6111 |
07:18:13 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45200/tests/kraken/driver.html?testName=imaging-desaturate)
07:18:13 INFO - PROCESS | 6111 | RSS: Main: 212353024
07:18:13 INFO - PROCESS | 6111 |
07:18:16 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45200/tests/kraken/driver.html?testName=json-parse-financial)
07:18:17 INFO - PROCESS | 6111 | RSS: Main: 213356544
07:18:17 INFO - PROCESS | 6111 |
07:18:19 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45200/tests/kraken/driver.html?testName=json-stringify-tinderbox)
07:18:19 INFO - PROCESS | 6111 | RSS: Main: 202240000
07:18:19 INFO - PROCESS | 6111 |
07:18:21 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-aes)
07:18:22 INFO - PROCESS | 6111 | RSS: Main: 207249408
07:18:22 INFO - PROCESS | 6111 |
07:18:24 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-ccm)
07:18:24 INFO - PROCESS | 6111 | RSS: Main: 216748032
07:18:24 INFO - PROCESS | 6111 |
07:18:27 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
07:18:28 INFO - PROCESS | 6111 | RSS: Main: 223211520
07:18:28 INFO - PROCESS | 6111 |
07:18:31 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
07:18:31 INFO - PROCESS | 6111 | RSS: Main: 218873856
07:18:31 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | Cycle 1(1): loaded http://localhost:45200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45200/tests/kraken/driver.html?testName=ai-astar)
07:18:33 INFO - PROCESS | 6111 | RSS: Main: 264876032
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | __start_tp_report
07:18:33 INFO - PROCESS | 6111 | _x_x_mozilla_page_load
07:18:33 INFO - PROCESS | 6111 | _x_x_mozilla_page_load_details
07:18:33 INFO - PROCESS | 6111 | |i|pagename|runs|
07:18:33 INFO - PROCESS | 6111 | |0;ai-astar;112;107;110;110;110;111;110;113;111;113
07:18:33 INFO - PROCESS | 6111 | |1;audio-beat-detection;150;129;149;207;131;153;154;126;187;132
07:18:33 INFO - PROCESS | 6111 | |2;audio-dft;160;159;161;162;159;159;161;161;161;162
07:18:33 INFO - PROCESS | 6111 | |3;audio-fft;76;75;76;147;76;75;76;74;135;75
07:18:33 INFO - PROCESS | 6111 | |4;audio-oscillator;91;91;149;93;92;91;120;91;92;132
07:18:33 INFO - PROCESS | 6111 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;116;117;116
07:18:33 INFO - PROCESS | 6111 | |6;imaging-darkroom;145;145;145;145;145;145;145;145;145;148
07:18:33 INFO - PROCESS | 6111 | |7;imaging-desaturate;95;95;95;95;95;96;96;96;95;95
07:18:33 INFO - PROCESS | 6111 | |8;json-parse-financial;57;58;58;57;61;58;57;110;56;62
07:18:33 INFO - PROCESS | 6111 | |9;json-stringify-tinderbox;58;58;58;59;59;59;59;59;59;59
07:18:33 INFO - PROCESS | 6111 | |10;stanford-crypto-aes;86;79;79;78;80;80;81;80;80;80
07:18:33 INFO - PROCESS | 6111 | |11;stanford-crypto-ccm;131;123;128;131;138;125;125;125;191;124
07:18:33 INFO - PROCESS | 6111 | |12;stanford-crypto-pbkdf2;170;184;171;172;173;178;169;170;170;171
07:18:33 INFO - PROCESS | 6111 | |13;stanford-crypto-sha256-iterative;66;64;66;65;66;63;68;65;64;64
07:18:33 INFO - PROCESS | 6111 | __end_tp_report
07:18:33 INFO - PROCESS | 6111 | __start_cc_report
07:18:33 INFO - PROCESS | 6111 | _x_x_mozilla_cycle_collect,1827
07:18:33 INFO - PROCESS | 6111 | __end_cc_report
07:18:33 INFO - PROCESS | 6111 | __startTimestamp1462717113622__endTimestamp
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | ------- Summary: start -------
07:18:33 INFO - PROCESS | 6111 | Number of tests: 14
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.77 (1.6%) stddev-sans-first:1.81
07:18:33 INFO - PROCESS | 6111 | Values: 112.0 107.0 110.0 110.0 110.0 111.0 110.0 113.0 111.0 113.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:151.50 stddev:26.49 (17.5%) stddev-sans-first:28.08
07:18:33 INFO - PROCESS | 6111 | Values: 150.0 129.0 149.0 207.0 131.0 153.0 154.0 126.0 187.0 132.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24
07:18:33 INFO - PROCESS | 6111 | Values: 160.0 159.0 161.0 162.0 159.0 159.0 161.0 161.0 161.0 162.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.50 stddev:27.82 (36.9%) stddev-sans-first:29.14
07:18:33 INFO - PROCESS | 6111 | Values: 76.0 75.0 76.0 147.0 76.0 75.0 76.0 74.0 135.0 75.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:91.00 stddev:21.47 (23.6%) stddev-sans-first:22.24
07:18:33 INFO - PROCESS | 6111 | Values: 91.0 91.0 149.0 93.0 92.0 91.0 120.0 91.0 92.0 132.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53
07:18:33 INFO - PROCESS | 6111 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 116.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.95 (0.7%) stddev-sans-first:1.00
07:18:33 INFO - PROCESS | 6111 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 148.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50
07:18:33 INFO - PROCESS | 6111 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:58.00 stddev:16.48 (28.4%) stddev-sans-first:17.32
07:18:33 INFO - PROCESS | 6111 | Values: 57.0 58.0 58.0 57.0 61.0 58.0 57.0 110.0 56.0 62.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44
07:18:33 INFO - PROCESS | 6111 | Values: 58.0 58.0 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:2.16 (2.7%) stddev-sans-first:0.87
07:18:33 INFO - PROCESS | 6111 | Values: 86.0 79.0 79.0 78.0 80.0 80.0 81.0 80.0 80.0 80.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:129.50 stddev:20.50 (15.8%) stddev-sans-first:21.71
07:18:33 INFO - PROCESS | 6111 | Values: 131.0 123.0 128.0 131.0 138.0 125.0 125.0 125.0 191.0 124.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:171.50 stddev:4.69 (2.7%) stddev-sans-first:4.86
07:18:33 INFO - PROCESS | 6111 | Values: 170.0 184.0 171.0 172.0 173.0 178.0 169.0 170.0 170.0 171.0
07:18:33 INFO - PROCESS | 6111 |
07:18:33 INFO - PROCESS | 6111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:1.45 (2.2%) stddev-sans-first:1.50
07:18:33 INFO - PROCESS | 6111 | Values: 66.0 64.0 66.0 65.0 66.0 63.0 68.0 65.0 64.0 64.0
07:18:33 INFO - PROCESS | 6111 | -------- Summary: end --------
07:18:33 INFO - PROCESS | 6111 |
07:18:34 INFO - TEST-INFO | 6111: exit 0
07:18:34 INFO - TEST-OK | kraken | took 62867ms
07:18:34 INFO - SUITE-END | took 1176s
07:18:34 INFO - Completed test suite (00:19:36)
07:18:34 INFO - javascript benchmark
07:18:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.4504211762937, 3146.056183145056, 3172.524121381793, 3188.6811318868104, 3211.0527394418646, 5191.117510023296, 5220.425753167154, 5297.682139071649, 5308.283381743464, 5332.3601167859815, 5338.0, 5344.652597581155, 5398.4601539846, 5452.127659574468, 5475.698836563997, 4769.666123371357, 4784.97607511962, 4785.377900872899, 4895.020995800836, 4966.453690094087, 4779.330893674888, 4974.577160941324, 4991.825286114987, 4994.35073440454, 5015.523525265094, 4727.952720472803, 4774.618030557547, 4783.665143439961, 4921.655484116113, 4940.703557786526, 4829.3721816164025, 4834.129856625806, 4835.178019736618, 4837.7097374157665, 4848.345473361086, 4772.451168115676, 4802.327674125625, 4816.157172494799, 4849.733264670442, 4864.878378040542, 5242.449542798027, 5268.92096618551, 5320.813771517978, 5403.027455058088, 5413.133898576249, 5799.2750906136735, 5826.184334193216, 5836.416358364172, 5843.065109582446, 5843.5033022193165, 5536.889262214773, 5697.829065128011, 5762.394948530427, 5768.596198266123, 5833.037548804442, 5364.570834333244, 5374.892502149935, 5422.566194704415, 5438.428964958702, 5439.728013599383, 5680.573956953245, 5933.3473317934995, 5938.792142275086, 5942.3361458791605, 5950.553708471882, 5670.206171136044, 5731.025725626653, 5735.1684005818925, 5751.626144300607, 5812.360640329561, 5779.797707080232, 5850.414958504116, 5857.20927674767, 5857.648541087548, 5892.440218179266, 5553.444655534414, 5634.943650563442, 5810.854728631733, 5819.883602328015, 5829.854253643608, 5687.0616348302065, 5743.511801496836, 5750.7987220447085, 5761.049426844524, 5804.477597016289, 4338.783060846945, 4343.956560434419, 4349.064951035542, 4361.956380436219, 4386.583274588909, 3825.445310429972, 3860.3051450739135, 3910.765354078764, 3917.3536366499206, 3933.056066544066, 5434.347878254555, 5480.6437581557075, 5486.561075113981, 5490.066688662937, 5534.391216966131, 5793.507551858139, 5795.536357091422, 5797.797077102281, 5803.7968671096305, 5808.157817116495, 5328.3605967284175, 5403.108487099663, 5427.267318911975, 5461.126219804892, 5466.453354664502, 4655.883602909887, 4704.741239231875, 4709.175894218498, 4710.175719249118, 4752.572268495852, 5950.107483877367, 5966.880662386728, 5972.104184372379, 5972.313183983897, 5972.671503067286, 5549.667019978814, 5603.187537807076, 5653.717314134359, 5661.2923384576925, 5685.834403947264, 5870.647761134345, 5870.677112758839, 5878.29460464747, 5879.029960056543, 5879.323877754113, 5483.8080667176455, 5564.860878478071, 5613.494785469327, 5615.3823079462045, 5619.466150715675, 5696.344920334049, 5720.08478643415, 5735.225744524436, 5742.339630942495, 5749.511291540266, 5609.579281553818, 5613.158026296088, 5615.2700148980375, 5620.690862002465, 5622.5501959842295, 5395.244665746877, 5501.229827824028, 5620.550355971594, 5629.971850140887, 5639.520640745583, 5425.240466334795, 5500.58745594074, 5506.091494903296, 5509.641873278224, 5549.750261238173, 5603.971980140236, 5636.0, 5690.402507736628, 5691.630044047124, 5695.857603559944, 5348.679079255257, 5398.0, 5473.397926228032, 5509.0, 5547.694876781654], "value": 5279.609117477534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9763609455622, 636.8885445047117, 639.4947991087039, 646.2116218213778, 650.0444346810191, 29010.0, 29686.257843553896, 41466.0, 42316.0, 42389.57610423895, 40110.598894011055, 44180.558194418045, 44226.778866105626, 44235.33646995298, 44268.11463770723, 8749.343799215052, 8935.865962010575, 8941.061188575204, 8952.194302512773, 8957.37298389113, 8804.251638610694, 8909.509976951265, 8917.242034427081, 8921.375503714742, 8931.0, 8878.556072196398, 8898.688545900895, 8916.0, 8919.0, 8934.55327233639, 8808.64765409383, 8837.558122093933, 8860.335474839381, 8861.468311901242, 8863.113688631118, 8768.386212965095, 8835.337349698799, 8841.204291613785, 8844.11558844117, 8844.955775221148, 40556.59443405558, 40972.0, 41084.79457602723, 41265.58734412648, 41342.79328603368, 3438.5186073949667, 3587.677109060197, 3629.1290090378384, 4012.293323488009, 4149.2531344358, 31114.377712445625, 31348.52977205321, 31350.52974205389, 31762.0, 31924.521132183036, 4296.205202037633, 4308.267594508941, 4406.184855801687, 4422.911541769179, 4437.955620443819, 319778.9999999977, 319854.0, 320111.0, 321011.0, 321697.0, 55069.0, 55602.443975560534, 55656.443435565125, 55676.16485752717, 55708.0, 36683.26633467316, 36923.0, 37053.44419833705, 39237.2152556953, 39285.41071883924, 16166.43417480406, 16188.919055404647, 16298.42955496552, 16303.83696163047, 16311.510654680378, 11555.76888462226, 11594.188406811441, 11601.825972610417, 11603.361815100081, 11613.593524226611, 19782.604347912962, 20005.899970500344, 20030.198792048446, 20055.59888802245, 20106.899465502578, 7101.857962840818, 7156.642167891585, 7162.534435261691, 7278.344948954514, 7349.7060117595765, 984.4536282363357, 1052.2423854824515, 1148.8047032004579, 1150.2408410449063, 1171.6719318590808, 31160.53259201114, 31780.523292150636, 31796.20509487235, 32145.0, 32312.838435808142, 1119.2221406122828, 1126.8028095083328, 1159.8202278646822, 1216.975660486803, 1257.270782945889, 16948.57628559296, 17016.149192540324, 17153.742693859604, 17229.0, 17396.565085872953, 471067.0, 472365.0, 475140.0, 477725.0, 478360.0, 56910.0, 57283.0, 57325.713371432874, 57351.71324143436, 57375.42624573784, 1292.3925754895183, 1307.5881097454271, 1358.9796153057712, 1390.8122403475604, 1422.6087825847974, 30219.0, 32607.34785304328, 32656.34687306288, 32764.180895477803, 32988.50517242195, 47788.7610561945, 48221.27668085052, 48344.274835876786, 48384.27423588719, 48391.75804120957, 339283.0, 339602.0, 340711.0, 340822.0, 341543.0, 25817.741822581535, 26216.475670486863, 26228.73771262339, 26448.8677556611, 27750.02874899369, 47613.0, 48193.27710084282, 48497.27254091121, 48601.75699121482, 49179.262311064645, 40407.3938890911, 40469.19061618692, 40560.79719601501, 40937.38593921034, 41724.0, 39991.40012899867, 40179.39730904097, 40401.1919761609, 40456.3931541033, 41107.177856442104, 36592.0, 37244.81377593095, 37422.8128859354, 37451.0, 37474.063148421505, 33464.1633959153, 35515.28969420649, 35604.465933010506, 35645.39410921503, 35683.46474802828, 27550.5867411993, 27786.0, 28016.159515214575, 28090.0, 28120.57819132674], "value": 19409.51864228007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.5719509529203, 390.40073487197174, 391.2741863842571, 395.9227950549643, 418.48108345651383, 18018.369357072504, 19291.13189906454, 19423.12595933183, 19495.805041949578, 20339.28812491563, 17056.658866822658, 17690.469285921412, 17726.113694315296, 17990.82009179908, 18022.369217077372, 5578.581606379527, 5659.462351076641, 5724.141378793172, 5730.828075157752, 5748.310202775673, 5526.392096869341, 5671.943280567183, 5680.914786278209, 5703.40114288, 5711.885762284752, 5543.501084902358, 5622.8313150605545, 5644.633098848582, 5663.886722265553, 5667.178259152421, 5512.228288039678, 5597.104463285875, 5623.0159722048475, 5629.746661400247, 5672.319321681404, 4840.927386089212, 5010.949890501085, 5016.648834581581, 5021.221710634857, 5022.899542009176, 19747.308844190527, 19767.80232197674, 20647.17411303561, 22469.662955055686, 22998.77001229983, 2236.586231547169, 2288.3249441414823, 2338.228384633067, 2925.970740292591, 3095.1178914009624, 10019.348742331798, 10048.849267260997, 10093.142082922961, 10421.5831366746, 10435.582576696923, 1922.2503223742751, 1954.3257576136211, 1970.231609672229, 1989.7512810898638, 2057.6296266671993, 85110.57444712799, 85302.57348713216, 85394.0, 86886.5655671724, 87656.56171719101, 10829.566817327219, 10851.51168197433, 10914.126869850394, 10927.125829933586, 11104.888951110386, 15247.771283430757, 15342.0, 15351.309191086428, 15375.231238438033, 15388.615284617974, 7732.729354472566, 7836.568988705676, 7917.208279172037, 7919.089304729914, 8021.0, 7615.0, 7666.041744781903, 7757.883631745528, 7823.217678232245, 7916.366690664733, 4480.103979204172, 4556.589906908394, 4558.088382323483, 4580.679352445363, 4622.352870598119, 1800.225902861782, 1877.643247782917, 1891.7162425636266, 1925.3742533676332, 1976.377441106047, 906.71891713569, 991.8760154980628, 996.3025881882711, 1078.2775540387959, 1102.525913857049, 18037.098145092692, 18505.7224141638, 19337.903310483358, 19427.4171774847, 19552.21791128339, 1027.3219675014604, 1033.9327943683636, 1041.4532370505544, 1051.9631812886512, 1064.5848119233506, 10320.935812837313, 10867.0, 10996.615118470816, 11020.779584408267, 11060.0, 485782.0, 488631.0, 494003.0, 503750.0, 514491.0, 83290.0, 92589.5370523143, 93755.0, 96145.0, 97007.51496242474, 1084.7505073833063, 1110.972225694348, 1129.4635048352131, 1148.8047032004579, 1152.475623591264, 17361.652766944844, 17458.30166793314, 17793.0, 17849.464516064538, 17879.910600446914, 30061.549076764302, 38693.41959870548, 40762.0, 40975.7951210242, 42711.7864410676, 54489.0, 55198.724006379714, 55221.0, 56480.0, 57003.42996569981, 8430.15698430152, 8457.323414126731, 8761.342899282452, 8800.603972821367, 8918.86621700688, 11976.0, 13195.538156164488, 13401.195928244337, 13424.731505370033, 13458.327083645583, 11477.770444590895, 11488.94255528717, 11609.419529023684, 11687.298762074302, 11855.466504007169, 11555.595554155565, 11569.363684997406, 11673.12451566119, 11682.357470338873, 11784.58753943608, 11748.94125529401, 11835.11236657237, 11841.82237266459, 11953.282803031498, 12010.699732506757, 8607.0, 8645.286066055918, 8681.479111253346, 8690.130986901258, 8695.999960004681, 10506.369617822955, 11359.261647992855, 11547.884521154681, 11590.768184636092, 11678.416079196177], "value": 9171.254965087259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.9521916732917, 1552.0222259976213, 1571.300771156835, 1746.4411388355722, 1835.779706435228, 7887.132415434305, 8185.959070204648, 8226.383021273414, 8419.621117049732, 8426.620802063906, 8192.262696357328, 8363.623636936338, 8392.874106888386, 8421.747347579567, 8439.32485401168, 2048.641487739647, 2341.75411581784, 2372.2171683344454, 2398.676178715877, 2433.4038160650666, 2408.458096928186, 2423.3820375804144, 2425.3451568076607, 2425.757424257569, 2426.0780903256828, 2374.0385144016614, 2434.6469761884514, 2436.062116085311, 2437.4150203951012, 2450.742672019439, 2051.0360130738527, 2340.32130682102, 2406.470576473173, 2412.0592968742203, 2414.215380001489, 2332.4052366646565, 2336.4859730859184, 2337.8947947342413, 2346.0498498108295, 2366.3255972048055, 8439.57802109892, 8485.490870547786, 8489.151084891462, 8496.78758031048, 8503.277221436185, 5200.349956255468, 5342.358916929955, 5346.304980352568, 5346.492083252085, 5351.866203344908, 3406.131436483681, 3508.0878971467346, 3536.2220311531423, 3547.627499112582, 3577.8568857245677, 1129.2772625519674, 1151.0, 1166.5333866453486, 1174.2719513901436, 1188.7087663522407, 11716.94141529287, 11916.940415297868, 11923.523059077626, 11948.103892208119, 12011.219270747373, 4559.107970192333, 4594.632429405639, 4720.386349774507, 4720.480747117815, 4726.598239149711, 9326.860097098548, 9368.156865881967, 9418.717438476857, 9423.199028082552, 9443.386179898285, 4683.320918466803, 5176.663516871391, 5181.4559471255725, 5196.298499702491, 5205.817796377109, 4468.218061839165, 4505.5719706627815, 4505.594496495331, 4835.178019736653, 4967.875803104879, 3741.0273328934127, 3883.0874744435037, 3892.6691231245663, 3943.8168549435627, 3948.2498325318097, 1174.3364998775664, 1175.4122938530734, 1184.236167671847, 1200.75984803038, 1206.10748046445, 969.1907257439975, 983.1495756171004, 990.2573070197352, 995.2635050062902, 1010.5553556435292, 5797.652140871477, 5911.408859114054, 6064.090386442069, 6067.696615169224, 6072.544559157993, 466.86694292126583, 467.2104143996635, 467.84327250371507, 476.65680709888824, 479.63547703745405, 4107.8973025674, 4110.46563946685, 4116.444280022219, 4117.3206420940805, 4182.498100227992, 10092.747681308027, 10542.156627469783, 10582.947085264525, 10622.415767132881, 10666.786664266827, 10015.499225038864, 10289.74275643115, 10321.63874264397, 10396.688099357032, 10706.357618542912, 8184.754457366289, 8196.606576881944, 8332.583370831435, 8346.707865224687, 8359.331253499706, 5948.464638182584, 6002.0996850472775, 6118.694065296629, 6148.508119350352, 6191.907121393273, 9642.180414664832, 9680.177184939359, 9721.9027809721, 9802.950985245028, 9890.763654543181, 9862.457564834003, 9900.25748068912, 10018.298719089593, 10018.849717254392, 10094.596216151565, 6387.201599800025, 6912.135983002125, 7049.330313620198, 7136.536125151849, 7203.927960720326, 8332.708355207538, 8344.457610255315, 8409.411341206056, 8409.579521023801, 8427.789305267417, 7205.387542058774, 7296.890546641911, 7464.738734144279, 7597.278258565428, 7766.650500727594, 7376.077990251219, 7380.409567234716, 7428.665710042953, 7653.732119375795, 7805.9609701953395, 6888.104546408935, 6903.723851045902, 6938.5836849789175, 6958.512904096665, 6966.303369663196, 5286.233496143114, 5363.704996225245, 5388.730563471732, 5417.945820541744, 5487.094629386106, 5158.664686795346, 5260.605454590845, 5268.1044222481505, 5295.682259064469, 5385.757640906247], "value": 4505.913663843814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.167359071164, 335.1286654697786, 338.4060972992399, 340.7274180655475, 344.51251479156963, 5343.866403339918, 5348.117560602501, 5351.438098999607, 5351.73241337933, 5355.544778693806, 4994.8501544953615, 5121.5390614844655, 5159.66462179958, 5173.275741396198, 5304.602154838393, 3997.620226078518, 4079.2861249281405, 4158.937615935748, 4158.958410415902, 4186.35111557709, 4105.3020986432375, 4130.628243458088, 4147.771872547009, 4154.0030392705685, 4171.624553790159, 3995.8201880915285, 4102.835886564549, 4113.8354465821485, 4123.216588848124, 4133.42132101506, 4087.550369459357, 4092.7135100542973, 4105.91788164235, 4110.7122501424765, 4112.506499220083, 3635.2005757150114, 3650.5254316938626, 3665.4685070664605, 3670.522832031819, 3686.5760437549757, 5025.246213068032, 5110.5911527078115, 5167.302414174076, 5204.245384419238, 5223.738813059332, 4720.315554244616, 4722.220833562458, 4760.024195040009, 4768.7615619218905, 4772.188727916263, 5528.336599608033, 5534.229046705056, 5540.972295138498, 5542.39033706292, 5572.164175373686, 3955.8417663293435, 3959.307121253769, 4030.0, 4042.6765858731233, 4063.2889244382113, 5682.886342273173, 5707.6575405475805, 5756.589635539278, 5773.538116950634, 5776.797812076599, 4113.732607380511, 4116.238495878212, 4121.258173528734, 4154.709170358106, 4156.8129434175535, 4102.343625019982, 4185.183889141588, 4204.474440694913, 4207.410962465257, 4215.304474761691, 4721.362616046858, 4731.243001119804, 4746.95253047472, 4747.169245382113, 4762.52374762521, 5572.442755724476, 5604.075327570987, 5608.46719561641, 5617.859553511195, 5627.212190293362, 1341.0, 1366.221253885276, 1393.770027945398, 1407.7043820797746, 1414.6887684709347, 963.3016063354012, 966.4974213408988, 979.8628192053118, 981.7005813227034, 994.4132961552574, 5125.666831655931, 5162.303089082926, 5178.81874134411, 5212.582993360522, 5240.34495688039, 5495.873345964068, 5497.862553436196, 5511.972440137773, 5538.0, 5566.944330556724, 4954.5540901319055, 5193.844184674465, 5206.869828254324, 5240.716024574004, 5256.369235691665, 2901.622789037454, 2910.5052141136057, 2931.311141881656, 2933.2080338308538, 2937.2510009947327, 5633.352164501053, 5691.446842525963, 5727.823427097676, 5734.569907256889, 5740.483356497935, 5516.889662206733, 5592.384837667853, 5887.852803679856, 5897.439743224387, 5899.823005309848, 5958.46373826349, 5960.135780311831, 5960.910586341209, 5966.045432730916, 5982.371850955587, 5538.252335934759, 5754.597178197486, 5787.0, 5788.479036886701, 5788.536917046542, 5636.2954630671165, 5640.210370548045, 5668.461496157858, 5714.5999780015, 5719.142128680731, 5962.37395073511, 5973.581849270509, 5998.760049597967, 6004.459598636144, 6010.3088144863905, 3875.7286989910435, 4027.778472184058, 4036.313826649418, 4041.332720404519, 4047.838086476626, 5516.834494965157, 5667.384795333311, 5709.371969083314, 5715.199872017838, 5748.310202775694, 5438.70087145195, 5611.803586874603, 5617.634853734494, 5646.35066967304, 5650.152477128299, 5524.4199359066715, 5550.583706221969, 5605.32736071674, 5610.747516361856, 5616.494515493625, 5249.895002100013, 5480.72596370172, 5491.368492623399, 5536.501714845522, 5543.445655434585, 5617.297837770278, 5663.631863928831, 5678.7728490861555, 5680.147977803363, 5709.8287051388525, 5451.966754607053, 5549.944500555104, 5562.332520097614, 5564.77740890376, 5594.188842617879], "value": 4238.8516563848625, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.270297811123, 759.1497522774494, 800.5196881870877, 812.7764864662221, 860.8837806896071, 13804.516841910536, 14146.929265353685, 14147.292635368241, 14199.645008874782, 14203.076800008004, 10983.780324393527, 11877.0, 11891.940540297286, 11900.523979040829, 11904.523819047228, 813.5891374855704, 835.6239692138531, 837.7654256808104, 841.8190089130836, 844.2781421884292, 829.4732844643664, 832.1512057701141, 833.7332053742805, 834.9039860416069, 838.8573942429771, 706.7738323736406, 863.0506442912808, 876.1545108969843, 877.3463769491706, 877.6533269358599, 860.9440386374865, 865.5715420866649, 866.8223014282057, 867.600903584352, 867.8568036274039, 633.2243002322118, 634.1945728924286, 634.238913304037, 634.2642534659773, 635.4566845347254, 14379.85620143806, 14387.568372948723, 14388.92805535976, 14460.927695361455, 14497.855021449755, 13541.796873046913, 13545.525906593222, 13698.38357273925, 13792.793108103386, 13843.30783460823, 11687.344173710973, 11767.941160294144, 11981.341026243554, 12033.51865925362, 12176.772457774863, 4329.2423825830665, 4382.715123516961, 4454.420925279725, 4499.257622492285, 4598.747068911209, 55610.72194639041, 55678.0, 56041.159382609294, 56080.0, 56263.0, 10855.457227138611, 11045.723856903642, 11234.662960111209, 11262.887371126184, 11459.656210313704, 19537.413877583695, 19768.11043503046, 19770.0, 19786.50533736668, 19799.218070373736, 8257.587120643944, 8306.293965013041, 8347.081820999685, 8578.91421085781, 8681.782955426039, 4115.753054816721, 4240.787960601958, 4258.0, 4299.032717638506, 4346.630536404377, 3228.6287076985977, 3315.635280119185, 3332.500124981272, 3357.9496307555405, 3360.7143392811886, 604.9455549000611, 669.1835960128635, 701.2706784943601, 714.5391222661458, 726.2882375272263, 730.4594599995964, 740.7888751705738, 743.3198623259657, 762.7826069570257, 767.800371903298, 9591.856122158173, 9626.181774549103, 9637.71086867395, 9780.364276322016, 9867.605295788231, 662.4700239808134, 746.2052913646949, 757.8976838126893, 767.1484652036236, 770.1335997003371, 4440.156370289635, 4642.210824159901, 4694.389729335165, 4711.293306004127, 4866.124097662384, 58529.0, 60287.69856150691, 60662.0, 60794.0, 65632.67183664051, 55184.17223741647, 56421.43578564244, 57258.42741572531, 58312.70843645839, 59029.40970590239, 47256.291155632694, 52272.477275227524, 53783.73108134434, 54068.0, 55365.44634553603, 8490.320774337915, 8873.157050080232, 8915.55422228873, 9023.774405639911, 9026.774330641787, 34715.0, 34944.475832863034, 35151.82424087863, 36041.819790900874, 36143.0, 42578.5742142587, 45360.31959520676, 46305.0, 46336.304955425025, 46969.06061878811, 12269.93865030669, 12344.75310493803, 12345.691357716129, 12596.0, 12604.684882878002, 13744.437952267694, 13844.238566878917, 14292.35684394184, 14351.928240358731, 14646.926765366105, 11860.40697965081, 12347.19743216688, 12410.503579856704, 12914.160579562298, 13311.933440332736, 12795.744085118431, 12930.288834114213, 12963.287019214034, 12963.546275880299, 13042.04369344568, 11945.940270298941, 12737.490500380252, 13000.219986800823, 13071.346432678138, 13272.601821945356, 10422.322549034288, 10657.41384223844, 10789.676309710721, 10874.945625271823, 11047.392393418439, 11015.339079655247, 11041.736444029115, 11209.775804484028, 11328.773424531628, 11351.54593816238], "value": 6864.091987771418, "unit": "score"}], "name": "dromaeo_css", "value": 7054.247553114162, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 110.0, 110.0, 110.0, 111.0, 110.0, 113.0, 111.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 129.0, 149.0, 207.0, 131.0, 153.0, 154.0, 126.0, 187.0, 132.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 162.0, 159.0, 159.0, 161.0, 161.0, 161.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 147.0, 76.0, 75.0, 76.0, 74.0, 135.0, 75.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 149.0, 93.0, 92.0, 91.0, 120.0, 91.0, 92.0, 132.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 148.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 61.0, 58.0, 57.0, 110.0, 56.0, 62.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 79.0, 78.0, 80.0, 80.0, 81.0, 80.0, 80.0, 80.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 123.0, 128.0, 131.0, 138.0, 125.0, 125.0, 125.0, 191.0, 124.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 184.0, 171.0, 172.0, 173.0, 178.0, 169.0, 170.0, 170.0, 171.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 66.0, 63.0, 68.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1547.1999999999998, "alertThreshold": 2.0}]}
07:18:34 INFO - Return code: 0
07:18:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json
07:18:34 ERROR - # TBPL SUCCESS #
07:18:34 INFO - Running post-action listener: _resource_record_post_action
07:18:34 INFO - #####
07:18:34 INFO - ##### Finished run-tests step (success)
07:18:34 INFO - #####
07:18:34 INFO - Running post-run listener: _resource_record_post_run
07:18:35 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 538464256; Read time: 600; Write time: 708828
07:18:35 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 251256832; Read time: 288; Write time: 369412
07:18:36 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287207424; Read time: 312; Write time: 339416
07:18:36 INFO - Running post-run listener: _upload_blobber_files
07:18:36 INFO - Blob upload gear active.
07:18:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
07:18:36 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
07:18:36 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
07:18:36 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
07:18:36 INFO - (blobuploader) - INFO - Open directory for files ...
07:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
07:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
07:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1.
07:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
07:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
07:18:37 INFO - (blobuploader) - INFO - Done attempting.
07:18:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
07:18:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
07:18:37 INFO - (blobuploader) - INFO - Uploading, attempt #1.
07:18:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
07:18:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
07:18:38 INFO - (blobuploader) - INFO - Done attempting.
07:18:38 INFO - (blobuploader) - INFO - Iteration through files over.
07:18:38 INFO - Return code: 0
07:18:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
07:18:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
07:18:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed2521540fcb9e33da656a740df866df44dd80c7b27a2d73ce8d6824847f527a525e82aebf0f5e2e939fe8e9b9e775e2b355fbcc8da6ae3ce19ec0e274622af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bdb406fa8eb58a00080d86c580f14aa5250c8ecea556466f4e9851201e1a177c90bc7be942af72ca17e81fc1650bebb925f2305013cce089ba8314f6ceb98f31"}
07:18:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
07:18:38 INFO - Writing to file /builds/slave/test/properties/blobber_files
07:18:38 INFO - Contents:
07:18:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed2521540fcb9e33da656a740df866df44dd80c7b27a2d73ce8d6824847f527a525e82aebf0f5e2e939fe8e9b9e775e2b355fbcc8da6ae3ce19ec0e274622af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bdb406fa8eb58a00080d86c580f14aa5250c8ecea556466f4e9851201e1a177c90bc7be942af72ca17e81fc1650bebb925f2305013cce089ba8314f6ceb98f31"}
07:18:38 INFO - Running post-run listener: copy_logs_to_upload_dir
07:18:38 INFO - Copying logs to upload dir...
07:18:38 INFO - mkdir: /builds/slave/test/build/upload/logs
07:18:38 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1260.968527
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-05-08 07:18:36.835606) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 07:18:36.839191) =========
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=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ed2521540fcb9e33da656a740df866df44dd80c7b27a2d73ce8d6824847f527a525e82aebf0f5e2e939fe8e9b9e775e2b355fbcc8da6ae3ce19ec0e274622af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bdb406fa8eb58a00080d86c580f14aa5250c8ecea556466f4e9851201e1a177c90bc7be942af72ca17e81fc1650bebb925f2305013cce089ba8314f6ceb98f31"}
build_url:https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011161
build_url: 'https://queue.taskcluster.net/v1/task/fyzGNi46Q-GrzMjwEuJR2Q/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/Mozilla-Inbound/sha512/ed2521540fcb9e33da656a740df866df44dd80c7b27a2d73ce8d6824847f527a525e82aebf0f5e2e939fe8e9b9e775e2b355fbcc8da6ae3ce19ec0e274622af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bdb406fa8eb58a00080d86c580f14aa5250c8ecea556466f4e9851201e1a177c90bc7be942af72ca17e81fc1650bebb925f2305013cce089ba8314f6ceb98f31"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-08 07:18:36.870915) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 07:18:36.871536) =========
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=cbe409c6de289db6ac707de3000001d4-1462713418.921727-124403662
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004492
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-08 07:18:36.954693) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 07:18:36.955009) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-08 07:18:36.955328) =========
========= Total master_lag: 0.21 =========