builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo
slave: talos-linux64-ix-045
starttime: 1472382346.47
results: success (0)
buildid: 20160826110814
builduid: 0dbeb50956e042d4ac8dadee4f76f40d
revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466030) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466491) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.466766) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.481397) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.481750) =========
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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-08-28 04:05:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12141 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 21.0M=0.001s
2016-08-28 04:05:47 (21.0 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.124954
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.620664) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.621018) =========
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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.020092
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.671349) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:46.671724) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f --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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-08-28 04:05:47,461 truncating revision to first 12 chars
2016-08-28 04:05:47,461 Setting DEBUG logging.
2016-08-28 04:05:47,461 attempt 1/10
2016-08-28 04:05:47,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6d0c7b6a6ae1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-08-28 04:05:47,960 unpacking tar archive at: mozilla-beta-6d0c7b6a6ae1/testing/mozharness/
program finished with exit code 0
elapsedTime=0.808753
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.493963) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.494337) =========
script_repo_revision: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.494726) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.495002) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-28 04:05:47.504156) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:05:47.504533) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta
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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta']
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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
04:05:48 INFO - MultiFileLogger online at 20160828 04:05:48 in /builds/slave/test
04:05:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta
04:05:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
04:05:48 INFO - {'append_to_log': False,
04:05:48 INFO - 'base_work_dir': '/builds/slave/test',
04:05:48 INFO - 'blob_upload_branch': 'Mozilla-Beta',
04:05:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
04:05:48 INFO - 'branch': 'Mozilla-Beta',
04:05:48 INFO - 'buildbot_json_path': 'buildprops.json',
04:05:48 INFO - 'config_files': ('talos/linux_config.py',),
04:05:48 INFO - 'default_actions': ('clobber',
04:05:48 INFO - 'read-buildbot-config',
04:05:48 INFO - 'download-and-extract',
04:05:48 INFO - 'populate-webroot',
04:05:48 INFO - 'create-virtualenv',
04:05:48 INFO - 'install',
04:05:48 INFO - 'run-tests'),
04:05:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
04:05:48 INFO - 'download_minidump_stackwalk': True,
04:05:48 INFO - 'download_symbols': 'ondemand',
04:05:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
04:05:48 INFO - 'tooltool.py': '/tools/tooltool.py',
04:05:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
04:05:48 INFO - '/tools/misc-python/virtualenv.py')},
04:05:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
04:05:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
04:05:48 INFO - 'installer_path': 'installer.exe',
04:05:48 INFO - 'log_level': 'info',
04:05:48 INFO - 'log_name': 'talos',
04:05:48 INFO - 'log_to_console': True,
04:05:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
04:05:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
04:05:48 INFO - 'opt_config_files': (),
04:05:48 INFO - 'pip_index': False,
04:05:48 INFO - 'sps_profile': False,
04:05:48 INFO - 'sps_profile_interval': 0,
04:05:48 INFO - 'suite': 'dromaeojs-e10s',
04:05:48 INFO - 'system_bits': '32',
04:05:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
04:05:48 INFO - 'title': 'talos-linux64-ix-045',
04:05:48 INFO - 'tooltool_cache': '/builds/tooltool_cache',
04:05:48 INFO - 'use_talos_json': True,
04:05:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
04:05:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
04:05:48 INFO - 'work_dir': 'build'}
04:05:48 INFO - #####
04:05:48 INFO - ##### Running clobber step.
04:05:48 INFO - #####
04:05:48 INFO - Running pre-action listener: _resource_record_pre_action
04:05:48 INFO - Running main action method: clobber
04:05:48 INFO - rmtree: /builds/slave/test/build
04:05:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
04:05:49 INFO - Running post-action listener: _resource_record_post_action
04:05:49 INFO - #####
04:05:49 INFO - ##### Finished clobber step (success)
04:05:49 INFO - #####
04:05:49 INFO - #####
04:05:49 INFO - ##### Running read-buildbot-config step.
04:05:49 INFO - #####
04:05:49 INFO - Running pre-action listener: _resource_record_pre_action
04:05:49 INFO - Running main action method: read_buildbot_config
04:05:49 INFO - Using buildbot properties:
04:05:49 INFO - {
04:05:49 INFO - "project": "",
04:05:49 INFO - "product": "firefox",
04:05:49 INFO - "script_repo_revision": "production",
04:05:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s",
04:05:49 INFO - "repository": "",
04:05:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s",
04:05:49 INFO - "buildid": "20160826110814",
04:05:49 INFO - "pgo_build": "True",
04:05:49 INFO - "basedir": "/builds/slave/test",
04:05:49 INFO - "buildnumber": 89,
04:05:49 INFO - "slavename": "talos-linux64-ix-045",
04:05:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
04:05:49 INFO - "platform": "ubuntu64_hw",
04:05:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos",
04:05:49 INFO - "branch": "mozilla-beta",
04:05:49 INFO - "repo_path": "releases/mozilla-beta",
04:05:49 INFO - "revision": "6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f",
04:05:49 INFO - "stage_platform": "linux64-pgo",
04:05:49 INFO - "builduid": "0dbeb50956e042d4ac8dadee4f76f40d",
04:05:49 INFO - "slavebuilddir": "test"
04:05:49 INFO - }
04:05:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2.
04:05:49 INFO - Running post-action listener: _resource_record_post_action
04:05:49 INFO - #####
04:05:49 INFO - ##### Finished read-buildbot-config step (success)
04:05:49 INFO - #####
04:05:49 INFO - #####
04:05:49 INFO - ##### Running download-and-extract step.
04:05:49 INFO - #####
04:05:49 INFO - Running pre-action listener: _resource_record_pre_action
04:05:49 INFO - Running main action method: download_and_extract
04:05:49 INFO - mkdir: /builds/slave/test/build/tests
04:05:49 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')]}
04:05:49 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net
04:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1
04:05:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:05:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found
04:05:49 INFO - retry: Failed, sleeping 30 seconds before retrying
04:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #2
04:06:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:06:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found
04:06:19 INFO - retry: Failed, sleeping 60 seconds before retrying
04:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #3
04:07:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:07:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found
04:07:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json!
04:07:19 INFO - Caught exception: HTTP Error 404: Not Found
04:07:19 INFO - Caught exception: HTTP Error 404: Not Found
04:07:19 INFO - Caught exception: HTTP Error 404: Not Found
04:07:19 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:07:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1
04:07:20 INFO - Downloaded 1327 bytes.
04:07:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json
04:07:20 INFO - Using the following test package requirements:
04:07:20 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'],
04:07:20 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'],
04:07:20 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'],
04:07:20 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'jsshell-linux-x86_64.zip'],
04:07:20 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'],
04:07:20 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'],
04:07:20 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'],
04:07:20 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'],
04:07:20 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'],
04:07:20 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip',
04:07:20 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']}
04:07:20 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
04:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:07:20 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
04:07:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:07:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:07:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1
04:07:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:07:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found
04:07:20 INFO - retry: Failed, sleeping 30 seconds before retrying
04:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2
04:07:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:07:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found
04:07:50 INFO - retry: Failed, sleeping 60 seconds before retrying
04:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3
04:08:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found
04:08:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip!
04:08:50 INFO - Caught exception: HTTP Error 404: Not Found
04:08:50 INFO - Caught exception: HTTP Error 404: Not Found
04:08:50 INFO - Caught exception: HTTP Error 404: Not Found
04:08:50 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:50 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1
04:08:50 INFO - Downloaded 21969046 bytes.
04:08:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests']
04:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests
04:08:52 INFO - Return code: 0
04:08:52 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:08:52 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net
04:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1
04:08:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:08:52 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found
04:08:52 INFO - retry: Failed, sleeping 30 seconds before retrying
04:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2
04:09:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:09:22 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found
04:09:22 INFO - retry: Failed, sleeping 60 seconds before retrying
04:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3
04:10:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:10:22 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found
04:10:22 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip!
04:10:22 INFO - Caught exception: HTTP Error 404: Not Found
04:10:22 INFO - Caught exception: HTTP Error 404: Not Found
04:10:22 INFO - Caught exception: HTTP Error 404: Not Found
04:10:22 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:10:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip
04:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1
04:10:23 INFO - Downloaded 21969046 bytes.
04:10:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests']
04:10:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests
04:10:24 INFO - Return code: 0
04:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:10:24 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net
04:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
04:10:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:10:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found
04:10:24 INFO - retry: Failed, sleeping 30 seconds before retrying
04:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2
04:10:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:10:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found
04:10:54 INFO - retry: Failed, sleeping 60 seconds before retrying
04:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3
04:11:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:11:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found
04:11:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip!
04:11:54 INFO - Caught exception: HTTP Error 404: Not Found
04:11:54 INFO - Caught exception: HTTP Error 404: Not Found
04:11:54 INFO - Caught exception: HTTP Error 404: Not Found
04:11:54 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:11:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip
04:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
04:11:55 INFO - Downloaded 10833369 bytes.
04:11:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests']
04:11:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests
04:11:55 INFO - Return code: 0
04:11:55 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')]}
04:11:55 INFO - https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net
04:11:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:11:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:11:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:11:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1
04:11:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:11:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found
04:11:55 INFO - retry: Failed, sleeping 30 seconds before retrying
04:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #2
04:12:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:12:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found
04:12:25 INFO - retry: Failed, sleeping 60 seconds before retrying
04:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #3
04:13:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:13:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found
04:13:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2!
04:13:25 INFO - Caught exception: HTTP Error 404: Not Found
04:13:25 INFO - Caught exception: HTTP Error 404: Not Found
04:13:25 INFO - Caught exception: HTTP Error 404: Not Found
04:13:25 INFO - trying https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:13:25 INFO - Downloading https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:13:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1
04:13:26 INFO - Downloaded 55208267 bytes.
04:13:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:13:26 INFO - mkdir: /builds/slave/test/properties
04:13:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
04:13:26 INFO - Writing to file /builds/slave/test/properties/build_url
04:13:26 INFO - Contents:
04:13:26 INFO - build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
04:13:27 INFO - Running post-action listener: _resource_record_post_action
04:13:27 INFO - Running post-action listener: set_extra_try_arguments
04:13:27 INFO - #####
04:13:27 INFO - ##### Finished download-and-extract step (success)
04:13:27 INFO - #####
04:13:27 INFO - #####
04:13:27 INFO - ##### Running populate-webroot step.
04:13:27 INFO - #####
04:13:27 INFO - Running pre-action listener: _resource_record_pre_action
04:13:27 INFO - Running main action method: populate_webroot
04:13:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
04:13:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
04:13:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
04:13:27 INFO - '--tppagecycles',
04:13:27 INFO - '7'],
04:13:27 INFO - 'tests': ['tsvgm']}},
04:13:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['tresize', 'tcanvasmark']},
04:13:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
04:13:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['dromaeo_css', 'kraken']},
04:13:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
04:13:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
04:13:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
04:13:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['damp', 'tps']},
04:13:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'tests': ['damp', 'tps']},
04:13:27 INFO - 'g3': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['dromaeo_dom']},
04:13:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
04:13:27 INFO - 'other': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'other-e10s': {'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'other-e10s_l64': {'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['a11yr',
04:13:27 INFO - 'ts_paint',
04:13:27 INFO - 'tpaint',
04:13:27 INFO - 'sessionrestore',
04:13:27 INFO - 'sessionrestore_no_auto_restore',
04:13:27 INFO - 'tabpaint']},
04:13:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['tsvgx',
04:13:27 INFO - 'tsvgr_opacity',
04:13:27 INFO - 'tart',
04:13:27 INFO - 'tscrollx',
04:13:27 INFO - 'cart']},
04:13:27 INFO - 'svgr-e10s': {'tests': ['tsvgx',
04:13:27 INFO - 'tsvgr_opacity',
04:13:27 INFO - 'tart',
04:13:27 INFO - 'tscrollx',
04:13:27 INFO - 'cart']},
04:13:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'talos_options': ['--disable-e10s'],
04:13:27 INFO - 'tests': ['tp5o']},
04:13:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'tests': ['tp5o']},
04:13:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'talos_options': ['--disable-e10s',
04:13:27 INFO - '--xperf_path',
04:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
04:13:27 INFO - 'tests': ['tp5n']},
04:13:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
04:13:27 INFO - 'talos_options': ['--xperf_path',
04:13:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
04:13:27 INFO - 'tests': ['tp5n']}},
04:13:27 INFO - 'talos.zip': {'path': '',
04:13:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
04:13:27 INFO - Running post-action listener: _resource_record_post_action
04:13:27 INFO - #####
04:13:27 INFO - ##### Finished populate-webroot step (success)
04:13:27 INFO - #####
04:13:27 INFO - #####
04:13:27 INFO - ##### Running create-virtualenv step.
04:13:27 INFO - #####
04:13:27 INFO - Running pre-action listener: _resource_record_pre_action
04:13:27 INFO - Running main action method: create_virtualenv
04:13:27 INFO - Creating virtualenv /builds/slave/test/build/venv
04:13:27 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
04:13:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
04:13:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
04:13:27 INFO - Using real prefix '/usr'
04:13:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python
04:13:28 INFO - Installing distribute.............................................................................................................................................................................................done.
04:13:30 INFO - Installing pip.................done.
04:13:30 INFO - Return code: 0
04:13:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:30 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:30 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
04:13:30 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
04:13:30 INFO - Using env: {'DISPLAY': ':0',
04:13:30 INFO - 'HOME': '/home/cltbld',
04:13:30 INFO - 'LANG': 'en_US.UTF-8',
04:13:30 INFO - 'LANGUAGE': 'en_US:en',
04:13:30 INFO - 'LOGNAME': 'cltbld',
04:13:30 INFO - 'MAIL': '/var/mail/cltbld',
04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:30 INFO - 'MOZ_NO_REMOTE': '1',
04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:30 INFO - 'NO_EM_RESTART': '1',
04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:30 INFO - 'PWD': '/builds/slave/test',
04:13:30 INFO - 'SHELL': '/bin/bash',
04:13:30 INFO - 'SHLVL': '1',
04:13:30 INFO - 'TERM': 'linux',
04:13:30 INFO - 'TMOUT': '86400',
04:13:30 INFO - 'USER': 'cltbld',
04:13:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:30 INFO - '_': '/tools/buildbot/bin/python'}
04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:30 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
04:13:30 INFO - Cleaning up...
04:13:30 INFO - Return code: 0
04:13:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:30 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:30 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>=3.1.1'] in /builds/slave/test/build
04:13:30 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>=3.1.1
04:13:30 INFO - Using env: {'DISPLAY': ':0',
04:13:30 INFO - 'HOME': '/home/cltbld',
04:13:30 INFO - 'LANG': 'en_US.UTF-8',
04:13:30 INFO - 'LANGUAGE': 'en_US:en',
04:13:30 INFO - 'LOGNAME': 'cltbld',
04:13:30 INFO - 'MAIL': '/var/mail/cltbld',
04:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:30 INFO - 'MOZ_NO_REMOTE': '1',
04:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:30 INFO - 'NO_EM_RESTART': '1',
04:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:30 INFO - 'PWD': '/builds/slave/test',
04:13:30 INFO - 'SHELL': '/bin/bash',
04:13:30 INFO - 'SHLVL': '1',
04:13:30 INFO - 'TERM': 'linux',
04:13:30 INFO - 'TMOUT': '86400',
04:13:30 INFO - 'USER': 'cltbld',
04:13:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:30 INFO - '_': '/tools/buildbot/bin/python'}
04:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:30 INFO - Downloading/unpacking psutil>=3.1.1
04:13:30 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
04:13:30 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
04:13:30 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
04:13:30 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
04:13:30 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
04:13:30 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
04:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
04:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
04:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
04:13:32 INFO - Installing collected packages: psutil
04:13:32 INFO - Running setup.py install for psutil
04:13:32 INFO - building 'psutil._psutil_linux' extension
04:13:32 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
04:13:32 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
04:13:32 INFO - building 'psutil._psutil_posix' extension
04:13:32 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
04:13:32 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
04:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
04:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
04:13:32 INFO - Successfully installed psutil
04:13:32 INFO - Cleaning up...
04:13:33 INFO - Return code: 0
04:13:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
04:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:33 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:33 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.3'] in /builds/slave/test/build
04:13:33 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.3
04:13:33 INFO - Using env: {'DISPLAY': ':0',
04:13:33 INFO - 'HOME': '/home/cltbld',
04:13:33 INFO - 'LANG': 'en_US.UTF-8',
04:13:33 INFO - 'LANGUAGE': 'en_US:en',
04:13:33 INFO - 'LOGNAME': 'cltbld',
04:13:33 INFO - 'MAIL': '/var/mail/cltbld',
04:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:33 INFO - 'MOZ_NO_REMOTE': '1',
04:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:33 INFO - 'NO_EM_RESTART': '1',
04:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:33 INFO - 'PWD': '/builds/slave/test',
04:13:33 INFO - 'SHELL': '/bin/bash',
04:13:33 INFO - 'SHLVL': '1',
04:13:33 INFO - 'TERM': 'linux',
04:13:33 INFO - 'TMOUT': '86400',
04:13:33 INFO - 'USER': 'cltbld',
04:13:33 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:33 INFO - '_': '/tools/buildbot/bin/python'}
04:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:33 INFO - Downloading/unpacking mozsystemmonitor==0.3
04:13:33 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
04:13:33 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
04:13:33 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
04:13:33 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
04:13:33 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
04:13:33 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
04:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz
04:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
04:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
04:13:35 INFO - Installing collected packages: mozsystemmonitor
04:13:35 INFO - Running setup.py install for mozsystemmonitor
04:13:35 INFO - Successfully installed mozsystemmonitor
04:13:35 INFO - Cleaning up...
04:13:35 INFO - Return code: 0
04:13:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:35 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:35 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==2.5.1'] in /builds/slave/test/build
04:13:35 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==2.5.1
04:13:35 INFO - Using env: {'DISPLAY': ':0',
04:13:35 INFO - 'HOME': '/home/cltbld',
04:13:35 INFO - 'LANG': 'en_US.UTF-8',
04:13:35 INFO - 'LANGUAGE': 'en_US:en',
04:13:35 INFO - 'LOGNAME': 'cltbld',
04:13:35 INFO - 'MAIL': '/var/mail/cltbld',
04:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:35 INFO - 'MOZ_NO_REMOTE': '1',
04:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:35 INFO - 'NO_EM_RESTART': '1',
04:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:35 INFO - 'PWD': '/builds/slave/test',
04:13:35 INFO - 'SHELL': '/bin/bash',
04:13:35 INFO - 'SHLVL': '1',
04:13:35 INFO - 'TERM': 'linux',
04:13:35 INFO - 'TMOUT': '86400',
04:13:35 INFO - 'USER': 'cltbld',
04:13:35 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:35 INFO - '_': '/tools/buildbot/bin/python'}
04:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:35 INFO - Downloading/unpacking jsonschema==2.5.1
04:13:35 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
04:13:35 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
04:13:35 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
04:13:35 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
04:13:35 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
04:13:35 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
04:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
04:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
04:13: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
04:13: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
04:13: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
04:13: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
04:13: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
04:13: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
04:13:37 INFO - Downloading functools32-3.2.3-2.tar.gz
04:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
04:13:37 INFO - warning: no files found matching '*.txt'
04:13:37 INFO - no previously-included directories found matching 'build'
04:13:37 INFO - no previously-included directories found matching 'dist'
04:13:37 INFO - no previously-included directories found matching '.git*'
04:13:37 INFO - Installing collected packages: jsonschema, functools32
04:13:37 INFO - Running setup.py install for functools32
04:13:37 INFO - warning: no files found matching '*.txt'
04:13:37 INFO - no previously-included directories found matching 'build'
04:13:37 INFO - no previously-included directories found matching 'dist'
04:13:37 INFO - no previously-included directories found matching '.git*'
04:13:37 INFO - Successfully installed jsonschema functools32
04:13:37 INFO - Cleaning up...
04:13:37 INFO - Return code: 0
04:13:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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', '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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build
04:13: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 blobuploader==1.2.4
04:13:37 INFO - Using env: {'DISPLAY': ':0',
04:13:37 INFO - 'HOME': '/home/cltbld',
04:13:37 INFO - 'LANG': 'en_US.UTF-8',
04:13:37 INFO - 'LANGUAGE': 'en_US:en',
04:13:37 INFO - 'LOGNAME': 'cltbld',
04:13:37 INFO - 'MAIL': '/var/mail/cltbld',
04:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:37 INFO - 'MOZ_NO_REMOTE': '1',
04:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:37 INFO - 'NO_EM_RESTART': '1',
04:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:37 INFO - 'PWD': '/builds/slave/test',
04:13:37 INFO - 'SHELL': '/bin/bash',
04:13:37 INFO - 'SHLVL': '1',
04:13:37 INFO - 'TERM': 'linux',
04:13:37 INFO - 'TMOUT': '86400',
04:13:37 INFO - 'USER': 'cltbld',
04:13:37 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:37 INFO - '_': '/tools/buildbot/bin/python'}
04:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:38 INFO - Downloading/unpacking blobuploader==1.2.4
04:13:38 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
04:13:38 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
04:13:38 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
04:13:38 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
04:13:38 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
04:13:38 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
04:13:39 INFO - Downloading blobuploader-1.2.4.tar.gz
04:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
04:13:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
04:13: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
04:13: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
04:13: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
04:13: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
04:13: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
04:13: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
04:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
04:13:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
04:13:40 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
04:13:40 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
04:13:40 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
04:13:40 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
04:13:40 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
04:13:40 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
04:13:40 INFO - Downloading docopt-0.6.1.tar.gz
04:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
04:13:40 INFO - Installing collected packages: blobuploader, requests, docopt
04:13:40 INFO - Running setup.py install for blobuploader
04:13:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
04:13:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
04:13:40 INFO - Running setup.py install for requests
04:13:41 INFO - Running setup.py install for docopt
04:13:41 INFO - Successfully installed blobuploader requests docopt
04:13:41 INFO - Cleaning up...
04:13:41 INFO - Return code: 0
04:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:41 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:41 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
04:13:41 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
04:13:41 INFO - Using env: {'DISPLAY': ':0',
04:13:41 INFO - 'HOME': '/home/cltbld',
04:13:41 INFO - 'LANG': 'en_US.UTF-8',
04:13:41 INFO - 'LANGUAGE': 'en_US:en',
04:13:41 INFO - 'LOGNAME': 'cltbld',
04:13:41 INFO - 'MAIL': '/var/mail/cltbld',
04:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:41 INFO - 'MOZ_NO_REMOTE': '1',
04:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:41 INFO - 'NO_EM_RESTART': '1',
04:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:41 INFO - 'PWD': '/builds/slave/test',
04:13:41 INFO - 'SHELL': '/bin/bash',
04:13:41 INFO - 'SHLVL': '1',
04:13:41 INFO - 'TERM': 'linux',
04:13:41 INFO - 'TMOUT': '86400',
04:13:41 INFO - 'USER': 'cltbld',
04:13:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:41 INFO - '_': '/tools/buildbot/bin/python'}
04:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
04:13:41 INFO - Running setup.py (path:/tmp/pip-OgdgsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
04:13:41 INFO - Running setup.py (path:/tmp/pip-FOyM0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
04:13:41 INFO - Running setup.py (path:/tmp/pip-RA__XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
04:13:41 INFO - Running setup.py (path:/tmp/pip-e3fjBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
04:13:41 INFO - Running setup.py (path:/tmp/pip-zhWNDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
04:13:41 INFO - Running setup.py (path:/tmp/pip-Qss_yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
04:13:41 INFO - Running setup.py (path:/tmp/pip-rX18EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
04:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
04:13:42 INFO - Running setup.py (path:/tmp/pip-NU5muU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
04:13:42 INFO - Running setup.py (path:/tmp/pip-5BusCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
04:13:42 INFO - Running setup.py (path:/tmp/pip-GCWxxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
04:13:42 INFO - Running setup.py (path:/tmp/pip-uNAEMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
04:13:42 INFO - Running setup.py (path:/tmp/pip-sEV8MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
04:13:42 INFO - Running setup.py (path:/tmp/pip-0TCWlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
04:13:42 INFO - Running setup.py (path:/tmp/pip-sjvr6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:42 INFO - Running setup.py (path:/tmp/pip-W1ahyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
04:13:42 INFO - Running setup.py (path:/tmp/pip-qzpMMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
04:13:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
04:13:42 INFO - Running setup.py (path:/tmp/pip-ERyr86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
04:13:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
04:13:42 INFO - Running setup.py install for manifestparser
04:13:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
04:13:42 INFO - Running setup.py install for mozcrash
04:13:42 INFO - Running setup.py install for mozdebug
04:13:43 INFO - Running setup.py install for mozdevice
04:13:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for mozfile
04:13:43 INFO - Running setup.py install for mozhttpd
04:13:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for mozinfo
04:13:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for mozInstall
04:13:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for mozleak
04:13:43 INFO - Running setup.py install for mozlog
04:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for moznetwork
04:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
04:13:43 INFO - Running setup.py install for mozprocess
04:13:43 INFO - Running setup.py install for mozprofile
04:13:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
04:13:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
04:13:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
04:13:44 INFO - Running setup.py install for mozrunner
04:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
04:13:44 INFO - Running setup.py install for mozscreenshot
04:13:44 INFO - Running setup.py install for moztest
04:13:44 INFO - Running setup.py install for mozversion
04:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
04:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
04:13:44 INFO - Cleaning up...
04:13:44 INFO - Return code: 0
04:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:44 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:44 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
04:13:44 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
04:13:44 INFO - Using env: {'DISPLAY': ':0',
04:13:44 INFO - 'HOME': '/home/cltbld',
04:13:44 INFO - 'LANG': 'en_US.UTF-8',
04:13:44 INFO - 'LANGUAGE': 'en_US:en',
04:13:44 INFO - 'LOGNAME': 'cltbld',
04:13:44 INFO - 'MAIL': '/var/mail/cltbld',
04:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:44 INFO - 'MOZ_NO_REMOTE': '1',
04:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:44 INFO - 'NO_EM_RESTART': '1',
04:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:44 INFO - 'PWD': '/builds/slave/test',
04:13:44 INFO - 'SHELL': '/bin/bash',
04:13:44 INFO - 'SHLVL': '1',
04:13:44 INFO - 'TERM': 'linux',
04:13:44 INFO - 'TMOUT': '86400',
04:13:44 INFO - 'USER': 'cltbld',
04:13:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:44 INFO - '_': '/tools/buildbot/bin/python'}
04:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
04:13:44 INFO - Running setup.py (path:/tmp/pip-Tn7CzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
04:13:44 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))
04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
04:13:44 INFO - Running setup.py (path:/tmp/pip-_C3XE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
04:13:44 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))
04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
04:13:44 INFO - Running setup.py (path:/tmp/pip-mwUcuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
04:13:44 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))
04:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
04:13:44 INFO - Running setup.py (path:/tmp/pip-WRr9cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
04:13:45 INFO - Running setup.py (path:/tmp/pip-GLMltM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
04:13:45 INFO - Running setup.py (path:/tmp/pip-RIxvzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
04:13:45 INFO - Running setup.py (path:/tmp/pip-blHfml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
04:13:45 INFO - Running setup.py (path:/tmp/pip-wUUyX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
04:13:45 INFO - Running setup.py (path:/tmp/pip-LTu5Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
04:13:45 INFO - Running setup.py (path:/tmp/pip-2QlzyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
04:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
04:13:45 INFO - Running setup.py (path:/tmp/pip-6SBVvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
04:13:45 INFO - Running setup.py (path:/tmp/pip-pynrnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
04:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
04:13:45 INFO - Running setup.py (path:/tmp/pip-plZuUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
04:13:45 INFO - Running setup.py (path:/tmp/pip-9gvGlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
04:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:45 INFO - Running setup.py (path:/tmp/pip-WTIATj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
04:13:45 INFO - Running setup.py (path:/tmp/pip-YAGZUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
04:13:45 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))
04:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
04:13:45 INFO - Running setup.py (path:/tmp/pip-fFYE7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
04:13:45 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))
04:13:45 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))
04:13:45 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))
04:13:45 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))
04:13:45 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))
04:13:45 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))
04:13:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:47 INFO - Downloading blessings-1.6.tar.gz
04:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
04:13:47 INFO - Installing collected packages: blessings
04:13:47 INFO - Running setup.py install for blessings
04:13:48 INFO - Successfully installed blessings
04:13:48 INFO - Cleaning up...
04:13:48 INFO - Return code: 0
04:13:48 INFO - Done creating virtualenv /builds/slave/test/build/venv.
04:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
04:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
04:13:48 INFO - Reading from file tmpfile_stdout
04:13:48 INFO - Current package versions:
04:13:48 INFO - argparse == 1.2.1
04:13:48 INFO - blessings == 1.6
04:13:48 INFO - blobuploader == 1.2.4
04:13:48 INFO - docopt == 0.6.1
04:13:48 INFO - functools32 == 3.2.3-2
04:13:48 INFO - jsonschema == 2.5.1
04:13:48 INFO - manifestparser == 1.1
04:13:48 INFO - mozInstall == 1.12
04:13:48 INFO - mozcrash == 0.17
04:13:48 INFO - mozdebug == 0.1
04:13:48 INFO - mozdevice == 0.48
04:13:48 INFO - mozfile == 1.2
04:13:48 INFO - mozhttpd == 0.7
04:13:48 INFO - mozinfo == 0.9
04:13:48 INFO - mozleak == 0.1
04:13:48 INFO - mozlog == 3.2
04:13:48 INFO - moznetwork == 0.27
04:13:48 INFO - mozprocess == 0.23
04:13:48 INFO - mozprofile == 0.28
04:13:48 INFO - mozrunner == 6.12
04:13:48 INFO - mozscreenshot == 0.1
04:13:48 INFO - mozsystemmonitor == 0.3
04:13:48 INFO - moztest == 0.7
04:13:48 INFO - mozversion == 1.4
04:13:48 INFO - psutil == 3.1.1
04:13:48 INFO - requests == 1.2.3
04:13:48 INFO - wsgiref == 0.1.2
04:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:48 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
04:13:48 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
04:13:48 INFO - Using env: {'DISPLAY': ':0',
04:13:48 INFO - 'HOME': '/home/cltbld',
04:13:48 INFO - 'LANG': 'en_US.UTF-8',
04:13:48 INFO - 'LANGUAGE': 'en_US:en',
04:13:48 INFO - 'LOGNAME': 'cltbld',
04:13:48 INFO - 'MAIL': '/var/mail/cltbld',
04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:48 INFO - 'MOZ_NO_REMOTE': '1',
04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:48 INFO - 'NO_EM_RESTART': '1',
04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:48 INFO - 'PWD': '/builds/slave/test',
04:13:48 INFO - 'SHELL': '/bin/bash',
04:13:48 INFO - 'SHLVL': '1',
04:13:48 INFO - 'TERM': 'linux',
04:13:48 INFO - 'TMOUT': '86400',
04:13:48 INFO - 'USER': 'cltbld',
04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:48 INFO - '_': '/tools/buildbot/bin/python'}
04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 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))
04:13:48 INFO - Cleaning up...
04:13:48 INFO - Return code: 0
04:13:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:48 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
04:13:48 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
04:13:48 INFO - Using env: {'DISPLAY': ':0',
04:13:48 INFO - 'HOME': '/home/cltbld',
04:13:48 INFO - 'LANG': 'en_US.UTF-8',
04:13:48 INFO - 'LANGUAGE': 'en_US:en',
04:13:48 INFO - 'LOGNAME': 'cltbld',
04:13:48 INFO - 'MAIL': '/var/mail/cltbld',
04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:48 INFO - 'MOZ_NO_REMOTE': '1',
04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:48 INFO - 'NO_EM_RESTART': '1',
04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:48 INFO - 'PWD': '/builds/slave/test',
04:13:48 INFO - 'SHELL': '/bin/bash',
04:13:48 INFO - 'SHLVL': '1',
04:13:48 INFO - 'TERM': 'linux',
04:13:48 INFO - 'TMOUT': '86400',
04:13:48 INFO - 'USER': 'cltbld',
04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:48 INFO - '_': '/tools/buildbot/bin/python'}
04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
04:13:48 INFO - Cleaning up...
04:13:48 INFO - Return code: 0
04:13:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:48 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 0x7f88d000bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2714020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, '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': '4300f881736b422476174874000001bc-1472382346.584979-960572220', '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
04:13:48 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
04:13:48 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
04:13:48 INFO - Using env: {'DISPLAY': ':0',
04:13:48 INFO - 'HOME': '/home/cltbld',
04:13:48 INFO - 'LANG': 'en_US.UTF-8',
04:13:48 INFO - 'LANGUAGE': 'en_US:en',
04:13:48 INFO - 'LOGNAME': 'cltbld',
04:13:48 INFO - 'MAIL': '/var/mail/cltbld',
04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:48 INFO - 'MOZ_NO_REMOTE': '1',
04:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:13:48 INFO - 'NO_EM_RESTART': '1',
04:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:48 INFO - 'PWD': '/builds/slave/test',
04:13:48 INFO - 'SHELL': '/bin/bash',
04:13:48 INFO - 'SHLVL': '1',
04:13:48 INFO - 'TERM': 'linux',
04:13:48 INFO - 'TMOUT': '86400',
04:13:48 INFO - 'USER': 'cltbld',
04:13:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:48 INFO - '_': '/tools/buildbot/bin/python'}
04:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:48 INFO - Downloading/unpacking flake8
04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl
04:13:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8)
04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl
04:13:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8)
04:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8)
04:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8
04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
04:13:51 INFO - no previously-included directories found matching 'docs/_build'
04:13:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8
04:13:51 INFO - Running setup.py install for pep8
04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs'
04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs'
04:13:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite'
04:13:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite'
04:13:51 INFO - no previously-included directories found matching 'docs/_build'
04:13:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin
04:13:51 INFO - Successfully installed flake8 mccabe pyflakes pep8
04:13:51 INFO - Cleaning up...
04:13:51 INFO - Return code: 0
04:13:51 INFO - Running post-action listener: _resource_record_post_action
04:13:51 INFO - Running post-action listener: _start_resource_monitoring
04:13:51 INFO - Starting resource monitoring.
04:13:51 INFO - #####
04:13:51 INFO - ##### Finished create-virtualenv step (success)
04:13:51 INFO - #####
04:13:51 INFO - #####
04:13:51 INFO - ##### Running install step.
04:13:51 INFO - #####
04:13:51 INFO - Running pre-action listener: _resource_record_pre_action
04:13:51 INFO - Running main action method: install
04:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
04:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
04:13:52 INFO - Reading from file tmpfile_stdout
04:13:52 INFO - Detecting whether we're running mozinstall >=1.0...
04:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
04:13:52 INFO - Reading from file tmpfile_stdout
04:13:52 INFO - Output received:
04:13:52 INFO - Usage: mozinstall [options] installer
04:13:52 INFO - Options:
04:13:52 INFO - -h, --help show this help message and exit
04:13:52 INFO - -d DEST, --destination=DEST
04:13:52 INFO - Directory to install application into. [default:
04:13:52 INFO - "/builds/slave/test"]
04:13:52 INFO - --app=APP Application being installed. [default: firefox]
04:13:52 INFO - mkdir: /builds/slave/test/build/application
04:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application']
04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application
04:14:05 INFO - Reading from file tmpfile_stdout
04:14:05 INFO - Output received:
04:14:05 INFO - /builds/slave/test/build/application/firefox/firefox
04:14:05 INFO - Running post-action listener: _resource_record_post_action
04:14:05 INFO - #####
04:14:05 INFO - ##### Finished install step (success)
04:14:05 INFO - #####
04:14:05 INFO - #####
04:14:05 INFO - ##### Running run-tests step.
04:14:05 INFO - #####
04:14:05 INFO - Running pre-action listener: _resource_record_pre_action
04:14:05 INFO - Running main action method: run_tests
04:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
04:14:05 INFO - Python 2.7.3
04:14:05 INFO - Return code: 0
04:14:05 INFO - grabbing minidump binary from tooltool
04:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]}
04:14:05 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a62e0>, '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 0x2712140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
04:14:05 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
04:14:05 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
04:14:05 INFO - Calling ['/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'] with output_timeout 600
04:14:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
04:14:05 INFO - Return code: 0
04:14:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
04:14:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
04:14:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
04:14:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
04:14:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
04:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos']
04:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos
04:14:06 INFO - Return code: 0
04:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
04:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
04:14:06 INFO - Using env: {'DISPLAY': ':0',
04:14:06 INFO - 'HOME': '/home/cltbld',
04:14:06 INFO - 'LANG': 'en_US.UTF-8',
04:14:06 INFO - 'LANGUAGE': 'en_US:en',
04:14:06 INFO - 'LOGNAME': 'cltbld',
04:14:06 INFO - 'MAIL': '/var/mail/cltbld',
04:14:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
04:14:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
04:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:14:06 INFO - 'MOZ_NO_REMOTE': '1',
04:14:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
04:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
04:14:06 INFO - 'NO_EM_RESTART': '1',
04:14:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
04:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:14:06 INFO - 'PWD': '/builds/slave/test',
04:14:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
04:14:06 INFO - 'SHELL': '/bin/bash',
04:14:06 INFO - 'SHLVL': '1',
04:14:06 INFO - 'TERM': 'linux',
04:14:06 INFO - 'TMOUT': '86400',
04:14:06 INFO - 'USER': 'cltbld',
04:14:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472382346.584979-960572220',
04:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:14:06 INFO - '_': '/tools/buildbot/bin/python'}
04:14:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
04:14:06 INFO - mozversion application_buildid: 20160826110814
04:14:06 INFO - mozversion application_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f
04:14:06 INFO - mozversion application_display_name: Firefox
04:14:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
04:14:06 INFO - mozversion application_name: Firefox
04:14:06 INFO - mozversion application_remotingname: firefox
04:14:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta
04:14:06 INFO - mozversion application_vendor: Mozilla
04:14:06 INFO - mozversion application_version: 49.0
04:14:06 INFO - mozversion platform_buildid: 20160826110814
04:14:06 INFO - mozversion platform_changeset: 6d0c7b6a6ae1b02a00b670a4686bb1c0689f8a6f
04:14:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta
04:14:06 INFO - mozversion platform_version: 49.0
04:14:06 INFO - using testdate: 1472382846
04:14:06 INFO - actual date: 1472382846
04:14:06 INFO - starting webserver on 'localhost:55038'
04:14:06 INFO - SUITE-START | Running 2 tests
04:14:06 INFO - TEST-START | dromaeo_css
04:14:06 INFO - operating with platform_type : linux_
04:14:06 INFO - Initialising browser for dromaeo_css test...
04:14:06 INFO - TEST-INFO | started process 5222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbmVMk/profile http://localhost:55038/getInfo.html)
04:14:11 INFO - PROCESS | 5222 | __metrics Screen width/height:1600/1200
04:14:11 INFO - PROCESS | 5222 | colorDepth:24
04:14:11 INFO - PROCESS | 5222 | Browser inner width/height: 1024/697
04:14:11 INFO - PROCESS | 5222 | __metrics
04:14:11 ERROR - PROCESS | 5222 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined
04:14:12 INFO - TEST-INFO | 5222: exit 0
04:14:12 INFO - Browser initialized.
04:14:12 INFO - Running cycle 1/1 for dromaeo_css test...
04:14:12 INFO - TEST-INFO | started process 5351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptbmVMk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
04:14:24 INFO - PROCESS | 5351 | RSS: Main: 152518656
04:14:24 INFO - PROCESS | 5351 |
04:15:13 INFO - PROCESS | 5351 | 1472382913887 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]
04:17:21 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55038/tests/dromaeo/cssquery-ext.html)
04:17:22 INFO - PROCESS | 5351 | RSS: Main: 157192192
04:17:22 INFO - PROCESS | 5351 |
04:20:24 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-ext.html (next: http://localhost:55038/tests/dromaeo/cssquery-jquery.html)
04:20:25 INFO - PROCESS | 5351 | RSS: Main: 155164672
04:20:25 INFO - PROCESS | 5351 |
04:23:27 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55038/tests/dromaeo/cssquery-mootools.html)
04:23:27 INFO - PROCESS | 5351 | RSS: Main: 154959872
04:23:27 INFO - PROCESS | 5351 |
04:26:29 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55038/tests/dromaeo/cssquery-prototype.html)
04:26:30 INFO - PROCESS | 5351 | RSS: Main: 156102656
04:26:30 INFO - PROCESS | 5351 |
04:29:32 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55038/tests/dromaeo/cssquery-yui.html)
04:29:33 INFO - PROCESS | 5351 | RSS: Main: 155000832
04:29:33 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | Cycle 1(1): loaded http://localhost:55038/tests/dromaeo/cssquery-yui.html (next: http://localhost:55038/tests/dromaeo/cssquery-dojo.html)
04:32:35 INFO - PROCESS | 5351 | RSS: Main: 159145984
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | __start_tp_report
04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_page_load
04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_page_load_details
04:32:35 INFO - PROCESS | 5351 | |i|pagename|runs|
04:32:35 INFO - PROCESS | 5351 | |0;dojo.html;3335.8832440864576;3379.7127244184244;3396.354692608404;3405.4040542904986;3421.5380923575326;5619.3818679945225;5651.2935883014625;5664.376918538957;5699;5702.885942281152;5568.638038527503;5705.629134106281;5712.314522257325;5716.799912003081;5724.742386592603;5010.073136469756;5091.592672586203;5094.363204599425;5113.718745468997;5115.360579927509;5018.824341148061;5087.5421212090905;5093.465186155456;5138.922916156261;5167.199084141964;5104.106781313274;5125.871853203663;5137.717425541594;5139.306193663845;5142.04872098663;5170.45710200431;5170.586353091744;5179.326687530634;5192.428832828386;5195.168772996302;4921.286413470027;4951.950480495185;4983.25251212321;5089.44016158226;5094.7197904115255;5514.972425137848;5533.142362933751;5554.527865131468;5573.6098473106895;5582.078956972095;5982.581219314649;6009.128676341906;6011.57918945674;6015.398460153993;6030.306514750772;5818.970905145489;5842.532597392198;5921.171036054912;5949.791757288474;6062.96968515159;5545.861353466155;5549.084401073818;5554.750036248338;5559.444055594448;5559.833205003856;6018.608790428608;6030.065339872327;6055.909161362583;6073.058675905242;6092.299385570716;5673.801416950387;5804.854878628068;5805.10020946754;5833.88332233353;5880.676562789087;5966.642001479925;5985.970070149621;6005.969970150209;6007.669578173155;6013.669248191304;5838.970805146032;5997.100434934708;5998.580099393088;6010.188624535719;6020.307664618537;5938.495227905676;5973.701314934323;5976.073708575178;5984;5989.850253743604;4653.744044077608;4657.5575320344515;4660.603848672833;4663.906721865612;4694.36626055485;4074.348104303297;4105.69207309447;4175.728577642443;4181.435506206684;4219.767912764827;5599.300087489064;5690.174924635905;5708.0581704019205;5760.3951585083805;5823.737931793079;6053.878922421527;6062.636241825505;6067;6085.604435711664;6104.969475152596;5557.249771280906;5662.292213473316;5774.855628609234;5799.130130480462;5839.124131380327;5192.273081768555;5201.245819356248;5221;5225.529702326809;5282.920756188661;6240.7503699852405;6243.469305109116;6276.309605943343;6277.2153480814895;6277.937220627735;5770.105633626795;5955.255593050869;6010.068439391901;6047.818565443044;6069.2110025696375;6239.78160764371;6276.058591211355;6294.0558916162945;6301.8109456716375;6306.936930630635;5913.34953155144;5927.881442371215;5937.703114844154;5942.346341902301;5954.345022047484;5897.292324920865;5998.640081595118;6008.429199226067;6041.063635136561;6051;5957.046872500379;5974.372690867396;5978.432048955342;5979.192808970907;5986.790462333797;5898.734556945034;5937.228160339301;5939.07944268639;5947.821565353046;5973.850653733692;5665.206871037975;5741.110127930177;5755.165501002248;5795.130730390307;5839.737211825393;5933.614315069507;5968.671723055274;5976.372480889618;5977.551683623658;5984.640921544721;5826.271716035496;5860.355360910211;5887.970560147171;5897.174395584708;5898.587098903035
04:32:35 INFO - PROCESS | 5351 | |1;ext.html;582.1820342418903;638.0110828216264;650.3691419323255;657.9342065793418;665.8468552232986;45432.77283613582;47101.29348059782;47102.293465598;47167.52832471678;50630;48325.516744832545;49109.50890491094;49197.75401122998;49229.52311430654;49282.75358623211;9031.819363612723;9106.817863642756;9179.082091790835;9184.311176661744;9197.126273004054;9074.455532668027;9108;9108.544572771369;9110.817783644356;9123.224525915271;9141.131592498736;9169.724908252763;9222.631094756236;9223.631054757801;9224.262059035262;9137.177654011137;9145.268378529701;9155.954220228923;9162.587683554222;9165.220956218729;8857.291416686714;8878.067802880734;8934.195922367018;8942.105789421072;8946.373753837233;44719.55280447187;45127.32309015367;45156.77421612904;45224.54775452236;45230.32154517685;3769.736118471708;3809.942850857239;3827;3848.5289137666705;3871.361225397806;33788.6621133788;33831;34174.31651366959;34341.656583434095;34605.30789384223;4024.55729869717;4109.97945010276;4111.5477297497255;4117.279476091672;4168.312228482297;360301;361135;361228.9999999974;362145;362727;38056.61943380531;63106;63211.683941580915;63266;63566.682166589795;39593.20813583712;41135.7943210282;41259.1748165041;41335;41406;16851.241694123793;17232.741508877378;17279.827201728072;17360.305587776347;17372.47882563525;14250.857491424953;14379.568612941628;14398.85601143996;14464.493742719165;14466.27668616586;9354.391964522285;9360.297977651704;9384.765380865396;9446.527673616292;9450.149486546106;3556.608773034964;3625.782453052825;3636.127329440915;3667.6332366763645;3692.5753538342897;1088.586337191862;1129.5770572122915;1134.4838098665089;1187.2342339191346;1225.4607972492254;33173.668263317544;33229;33389;33630.99107026793;34043.14892127667;1150.0626989003936;1155.930644161353;1168.1764356129079;1276.3809552367095;1330.388021510097;17326.826731732774;17363.739543906853;17388.217530211172;17409.47771566855;17568.824311756973;566462;597121;810479;841618;842277;59938.10092848611;60591.69704151539;60605.39394605997;60654;60771.6961415199;1501.8347981722002;1504.3832028868112;1511.7127745728276;1521.5815650695927;1522.7868098466224;32003.679963201;32385.51421728723;32864;34525.65474345325;37117.62882371142;62115.689421552604;62690.37309626846;62976.685116574125;63102.68448657727;63167.684161578894;515700;533817;535812;537922.2415551746;538891;47932.5206747928;49244.26133607927;49644;49913.251301231234;50139.74930125472;53753;54212.728936355066;54223.18665219946;54379.18431223614;55295.72352138213;44852.10295794131;45568;45612.24591819465;45716.31425528686;46126.30810537912;43902.56097439113;44180.337294939956;44682.3297650529;45325.18699252125;45707;44274.604184899814;45085;45598.54401456076;45630.771846141884;45789.77105114453;37674;38280.80859595684;38615;39532.80233598813;39617.60382396139;29961.250968725955;30312.973749302302;30342.84828575843;30532.389352212387;30701.846490767402
04:32:35 INFO - PROCESS | 5351 | |2;jquery.html;425.8999135203227;428.2291874625673;428.5200575355602;433.96094351508356;443.66281625964257;18347.082645867704;19341.129649165767;20080.196792128314;20471.488212794688;20471.488212794688;18587.628247435045;18769.155388007537;19027.429177124675;19439.611207775837;19498.805011949877;5839.153322768207;5985.760569577234;6015.578909476339;6018.578699491016;6021.849453763647;4882.41411030675;5879.353271140171;5948.315943666469;6316.178896743417;6340.936590634081;5362;6338.714757835908;6370.522210834206;6402.519811014193;6414.679266036703;5624.831255062334;5754.367019627858;5760.193572899798;5761.539076873861;5767.740451679684;5492.725363731837;5701.315842098975;5704.429557044304;5704.515116215127;5716.428357164292;13028.609141725763;13320.467181312735;13433;13528.25594592297;13633.590992270249;2153.720016397874;2232.609293373653;2258.4930726893135;2391.497785465037;2485.254423672909;10099.091081802673;10315.658964334589;10368.740781480448;10374.429406382646;10476.371417714885;1962.0876292523901;1965.7247985281929;1985.3150663021236;2003.8597298188986;2025.473376921996;73073;75581;76102;82984;85572.57213713953;10857.565697372174;11322.37726925027;11327.660170194908;11453.427328633701;11469.139814513945;15829.287682054335;15949.920250398905;15996.200189990454;16075;16165.4342098026;8305.211004954519;8357.791055223546;8729.432586881832;8760.386772925962;8801.427907186013;8382.036065852382;8463;8597.269232115215;8879.156480134377;8965.148310910454;4464.374987501752;4537.818487260539;4545.749983750926;4554.43069616298;4566.862994110115;1909.627622613577;1921.8654694171273;1926.5857840564347;1938.6413513500047;1958.177565422526;436.6245029274821;448.9842855500042;983.4984158079288;1050.721558786922;1087.065123993365;11536.192466527431;11841.763164736829;11926.105542084379;11988.460519276654;12103.213291136048;459.34084588615445;464.7374233558029;470.901110766736;471.9174144524695;476.49253544974493;6200.193974783339;6321.589096708699;6397.648129352837;10504.42225677595;10992.230543862013;524800;527652;527757;534980;541334;61098.69450652718;86875.56562217275;88061;90261.54869225743;98832.50583747035;1099.2195541165702;1124.4321617583068;1134.6539305511733;1136.5283407386007;1146.0487795130023;17322.39371621987;17720;17886.28454861843;17900.10499474995;18258.543536411697;42206.78896605497;42283;42413.57586424219;42564.36153457639;45188;54699.17951230655;55507;56294.43705562892;62267.443313917516;63526.36473635204;8571.4000019998;8889.866652000355;9055.049219831822;9117.452952822852;9125.087491250822;12341.50633974631;13091.476340946256;13268.071235013456;13562.389692463665;13576.93211533936;11583;11691.707707307385;12001.339926304137;12108.878911210775;12109.152359334763;9886.357386769838;11713.648590542298;11732.354720490455;11824.940875295568;11888.28670279786;12007.879921201025;12134.641238858807;12142.271463712206;12210;12247.755044898873;8604.82790344177;8632.870506942276;8647.697330593399;8797.296216302553;9008.099190080939;9145.725628231165;10596.735081622714;11694.239874408137;11801.881981180079;12030.218035827644
04:32:35 INFO - PROCESS | 5351 | |3;mootools.html;1569.6814675672433;1603.3426295218958;1834.1562881074706;1884.9528761780962;1941.3981665683648;8380;9300.209482194014;9419.811603767937;10018.54916528757;10038.498075096244;9492.857607135882;9776.657816976407;9781.7554561136;9841.114299713025;9884.555195016224;2457.8771061446946;2490.7260201377835;2491.6137998610243;2491.9409251068314;2496.4383013821835;2384.666146739458;2469.4814089041233;2470.086068154776;2476.6408870713826;2476.7647073527987;2460.1143588308196;2465.6301554766837;2480.1443501991785;2492.152668092848;2494.8627825469594;2180.4439867833757;2219.6115679755976;2220.555888822234;2243.8204943604474;2264.9433764155865;2352.788249057593;2372.5847976604027;2390.7848293653483;2398.124684490166;2400.699912510936;9675.806483870283;9722.854157187649;9755.36590121647;9767.218622510181;9783.217342612574;5638.35158956717;5813.6802475863815;5817.476427121579;5821.796237131723;5822.82531524055;3611.747177697562;3647.81760911956;3649.6897763689853;3651.634836516327;3723.2367364690444;1154.1805318224071;1210.9273443593413;1217.7077501399601;1235.4008305971597;1238.2137342787305;13838.515651952133;13863.475017747938;13928.233947132903;13938.651533711636;13971.930140349335;5032.748362581856;5060.240963855377;5070.619703522177;5111.3355263815465;5254.868628284247;11395.829062564067;11418.143639227092;11458.083353331713;11469.942650286695;11474.48364823585;5774.855628609234;5776.595638305278;5789.160571717078;5796.8550786229835;5805.680687562224;4359.956400435955;5075.137226671474;5211.088059589557;5247.134222853263;5382.381026182039;4364.41080454141;4376.978115109404;4401.6698747594055;4427.712198707074;4510;1390.075599726191;1392.470861072786;1406.310907655262;1415.985840141606;1418.3121186224673;891.4364777387901;901.396064636695;957.090763774417;970.1365784451843;991.3902949685892;5887.175795388649;6222.719977601018;6419.101325814389;6546.509011824132;6582.341765823379;985.4530735441755;1002.4987506246877;1023.9129673977646;1039.0804138337473;1057.6383055918654;4006.138680183716;4049.088954985105;4097.733647312915;4100.2619528484565;4104.486939132608;12029.819552706716;12304.81542776859;12401;12405.193662412095;12420.130590858553;11899.88100119005;12192.573259936036;12214.694632634255;12263.448144833505;12425.37873106341;8544.102869198645;8557.657693692183;8697.826043479095;8699.608517616722;8744.213020828156;5795.39148389413;5817.447342502455;5841.795537156179;5852.502537284378;6003.699815009145;10492.160627149657;10505.89688082771;10513.579456821948;10641.89358106409;10765.946170269099;11328.716782080513;11474.713132171762;11528.769424611628;11546.59586914454;11634.418279085843;8392.328613710766;8507.064222935349;8628.611712473079;8695.304375649806;8843.646254149762;9430.905690943002;9529.237660987243;9608.95195524018;9633.470159141314;9727.951360243154;8373.748787536384;8412.87380689278;8509.149085091442;8534.530600817016;8615.22462978335;8107.959460202661;8339.666413343399;8385.790355241168;8417;8501.532415717194;7420.888686669597;7434.702611895464;7497.400207983457;7497.737579184703;7510.737124200627;5119.385673719177;5200.115980283285;5286.550643195218;5304.23088652151;5338.813141540028;5138.922916156335;5172.224166375074;5235.1623740201385;5239.895202096013;5266.78932842682
04:32:35 INFO - PROCESS | 5351 | |4;prototype.html;345.78906866811246;348.35901940429613;348.808155514467;353.2299586900556;355.9003479025872;5726.284214473191;5804.82585522434;5807.186993820868;5807.332156801964;5836.9124463132985;5656.688882111483;5673;5687.146927960808;5697.77208911643;5739.397363276858;4032.193561287747;4368.541303163154;4407.360932664762;4410.867673969786;4411.6250118739945;4405.581469760367;4426.601605855472;4462.219111655448;4465.106978604276;4466.97766511167;4418.293073108303;4440.955590444087;4461.531539188387;4462.1968045751755;4474.619657329131;4292.892677683068;4400.8215933113315;4408.779561021936;4418.491873434532;4450.821967121327;3871.9225615487812;3874.4575759393706;3891.0466935600675;3904.06302487401;3908.7654740715648;5523.453433038715;5526.618345413646;5543.528800052;5545.916811247835;5559.471850174227;4910.558049775537;5045.167547354718;5075.629580013413;5093.770780314895;5115.360579927509;6010.939890601082;6011.57918945674;6016.2479690038745;6022.879542409171;6091.177691011701;4276.66921527765;4293.763842988635;4296;4306.20335237982;4310.547392523803;6104.175936248594;6260;6279.686015699197;6294.9685251574365;6306.527010474187;4285.892852678646;4307.7415355078165;4310.374995625617;4313.317806055641;4322.891927701832;4308.612224899712;4323.891902702395;4363.498197707304;4372.213001659668;4376.65848770906;4893.266010098514;5010.223415370623;5016.648834581544;5022.096022715873;5034.899302014012;5997.460228579362;6000;6008.969955150284;6052.789442111595;6109.5112391008615;1456.1190479759805;1478.7560052591416;1519.080956021613;1525.7482515385059;1527.2974431761513;963.8554216867526;970.8009857979098;1013.690824298596;1040.1314902056715;1042.9426381548935;5804.65172089676;5882.823515294548;5896.941030589725;5900.203472531153;5949.137375080676;6168.753249869955;6215.844603884939;6224.190855188796;6234;6266.905996410058;5722.341930677942;5791.652500849878;5802.535797136219;5828.6211396259105;5856.677882716406;3309.9573634305116;3344.6488118747666;3352.1619595101224;3356.0938546592283;3358.177246574605;6180.165677633552;6436.195475565554;6470.547061705635;6568.967155164193;6570.310117437601;6378.234611846516;6453.4189123665;6456.322086180978;6458.418742313214;6473.805785826433;6335.651539165298;6536.705848236936;6581.539292249592;6587.835304117435;6592.5055620828625;6270.655113968775;6277.717502712298;6295.716692748746;6297.4647154992335;6341.904871427025;6158.7228574715145;6169.259688837368;6214.13575927211;6243.532769799002;6261.3112557617715;6217.041631885942;6507.446867016357;6523.575967562093;6529.563496030865;6579.80260592183;4432.091421258569;4444.599986001275;4452.443444569429;4481.910361792811;4499.842505512292;6213.788311279257;6274.592151510137;6306;6310.5267104968225;6326.905096423466;6150.7539698411565;6180.721867515883;6190.566660333733;6194.969025154845;6206.410391012847;5901.734421950937;6108.389161083856;6131.4860907027905;6136.662483563447;6180.505559555135;5907.852303692442;6013.301819381137;6043.576949613661;6055.6063855849225;6056.36408177135;6199.969000154971;6206.875862482815;6211.223597050369;6216.849882771702;6220.409061139185;5977.22296101504;6020.909686354796;6049.939500604937;6052.425019623305;6053.910296146736
04:32:35 INFO - PROCESS | 5351 | |5;yui.html;723.6851969393314;723.8805597076486;733.8238822682555;757.3373298363931;775.1202385292692;14235.786463203047;14792.556223313319;14825.629359266024;14858.182799945998;14889.329980150906;14880;14912.701745965102;15029.248537573105;15049.322780474877;16225.107619080945;872.8647059705739;881.3610132653806;881.6120906801019;882.0341725810227;885.4642941020654;869.1135042256926;877.5656050255133;878.8198419324024;879.3053487744706;879.7448739865431;914.8444764390069;915.0209276074603;918.9908100918972;919.9586018629178;920.1350730313484;907.9228265597433;909.2498688581913;909.3725329522608;909.9727008189765;911.3347256502724;668.234871072624;668.2849351194224;669.9916625478623;670.0318040431579;670.9396154346083;15343.4629787958;15400.614984625361;15410;15435.922820385938;15442.150681712501;13218.801717974238;13581.864181358258;13815.102018368774;13878.583642490741;13885.305734713224;12323.322217278046;12350.814737778941;12414.193077450027;12831.422585983653;12871.549495767696;3661.707063434919;3799.6580307772433;3893.299206142893;4839.346688197119;4902.142125128088;71898.64050679766;75450;84470;84585.15414845834;86393.56803216007;12333.69165770845;12543.435545400478;12701.872981270253;12813.871861281454;12872.16330938486;22789.31632051041;22969.655455168187;23001;23244.3026709199;23713.644295335584;8504.829903401896;8612.138786121337;8617.224449799549;8622.396432249809;8646.524441155796;4638.0955713636195;4668.50980647034;4724.622030237572;4944.9258261126115;5043.420006699203;3658.63413658632;3740.7194460415035;3740.8877733668032;3762.435634654824;3766.642168993941;655.9770408035696;659.4493597845757;662.059874977533;673.9022841687928;678.1082876018021;550.7246376811594;581.2182614383647;596.749365266589;654.6072356586105;701.529974916807;9070.954645226864;9229.307801914749;9299.628014879465;9489.193418559362;9535.2371810255;597.4205021129497;714.3856283596103;770.2374649097466;814.816666250089;820.5609998650693;4574.5882870541145;4845.055214233261;4851.805927762921;4851.95148048515;4856.781444834991;115621.42189289;117727.41136294264;117914.41042794731;119302.40348798201;120190;72260;73679.63160184165;97772;99770;104070.4796476028;88426;90927;91165.5441722787;92575;92585.53707231421;8960.845992913628;9117.77205569866;9313.487758173094;9331.86002209981;9369.859452108087;52736.47263527469;54042.459575403744;54542;54597.454025459236;55668.721656391455;70910.29089709037;76672.61663691868;77591;77896.01400270588;78379.60810195912;12318;12333.93833030829;12437.689057773629;12566.434510446868;12943.417546210632;13648.014413481513;13896.51362202318;14010.929945350208;14044.78932815988;14421.134731916118;13021.9582433407;13060.151090179108;13240.073194876266;13248.735025299633;13393.531226407029;12205.816912746493;12216.877831221575;12363.62909112728;12428;12458.688532786753;12341.197822141532;12425;13416.932915335361;13657.317134143452;13966;11736.354500502553;12015.12631068884;12138.75722485563;12339.383030848601;12412.875871241173;11924.403779811148;11956.521739130685;12020.879791201976;12025.939870300943;12115.333656648969
04:32:35 INFO - PROCESS | 5351 | __end_tp_report
04:32:35 INFO - PROCESS | 5351 | __start_cc_report
04:32:35 INFO - PROCESS | 5351 | _x_x_mozilla_cycle_collect,329
04:32:35 INFO - PROCESS | 5351 | __end_cc_report
04:32:35 INFO - PROCESS | 5351 | __startTimestamp1472383955458__endTimestamp
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | ------- Summary: start -------
04:32:35 INFO - PROCESS | 5351 | Number of tests: 6
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#0] dojo.html Cycles:165 Average:5594.04 Median:5823.74 stddev:614.11 (10.5%) stddev-sans-first:589.89
04:32:35 INFO - PROCESS | 5351 | Values: 3335.9 3379.7 3396.4 3405.4 3421.5 5619.4 5651.3 5664.4 5699.0 5702.9 5568.6 5705.6 5712.3 5716.8 5724.7 5010.1 5091.6 5094.4 5113.7 5115.4 5018.8 5087.5 5093.5 5138.9 5167.2 5104.1 5125.9 5137.7 5139.3 5142.0 5170.5 5170.6 5179.3 5192.4 5195.2 4921.3 4952.0 4983.3 5089.4 5094.7 5515.0 5533.1 5554.5 5573.6 5582.1 5982.6 6009.1 6011.6 6015.4 6030.3 5819.0 5842.5 5921.2 5949.8 6063.0 5545.9 5549.1 5554.8 5559.4 5559.8 6018.6 6030.1 6055.9 6073.1 6092.3 5673.8 5804.9 5805.1 5833.9 5880.7 5966.6 5986.0 6006.0 6007.7 6013.7 5839.0 5997.1 5998.6 6010.2 6020.3 5938.5 5973.7 5976.1 5984.0 5989.9 4653.7 4657.6 4660.6 4663.9 4694.4 4074.3 4105.7 4175.7 4181.4 4219.8 5599.3 5690.2 5708.1 5760.4 5823.7 6053.9 6062.6 6067.0 6085.6 6105.0 5557.2 5662.3 5774.9 5799.1 5839.1 5192.3 5201.2 5221.0 5225.5 5282.9 6240.8 6243.5 6276.3 6277.2 6277.9 5770.1 5955.3 6010.1 6047.8 6069.2 6239.8 6276.1 6294.1 6301.8 6306.9 5913.3 5927.9 5937.7 5942.3 5954.3 5897.3 5998.6 6008.4 6041.1 6051.0 5957.0 5974.4 5978.4 5979.2 5986.8 5898.7 5937.2 5939.1 5947.8 5973.9 5665.2 5741.1 5755.2 5795.1 5839.7 5933.6 5968.7 5976.4 5977.6 5984.6 5826.3 5860.4 5888.0 5897.2 5898.6
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#1] ext.html Cycles:180 Average:69987.59 Median:45227.43 stddev:151945.67 (336.0%) stddev-sans-first:152282.56
04:32:35 INFO - PROCESS | 5351 | Values: 582.2 638.0 650.4 657.9 665.8 45432.8 47101.3 47102.3 47167.5 50630.0 48325.5 49109.5 49197.8 49229.5 49282.8 9031.8 9106.8 9179.1 9184.3 9197.1 9074.5 9108.0 9108.5 9110.8 9123.2 9141.1 9169.7 9222.6 9223.6 9224.3 9137.2 9145.3 9156.0 9162.6 9165.2 8857.3 8878.1 8934.2 8942.1 8946.4 44719.6 45127.3 45156.8 45224.5 45230.3 3769.7 3809.9 3827.0 3848.5 3871.4 33788.7 33831.0 34174.3 34341.7 34605.3 4024.6 4110.0 4111.5 4117.3 4168.3 360301.0 361135.0 361229.0 362145.0 362727.0 38056.6 63106.0 63211.7 63266.0 63566.7 39593.2 41135.8 41259.2 41335.0 41406.0 16851.2 17232.7 17279.8 17360.3 17372.5 14250.9 14379.6 14398.9 14464.5 14466.3 9354.4 9360.3 9384.8 9446.5 9450.1 3556.6 3625.8 3636.1 3667.6 3692.6 1088.6 1129.6 1134.5 1187.2 1225.5 33173.7 33229.0 33389.0 33631.0 34043.1 1150.1 1155.9 1168.2 1276.4 1330.4 17326.8 17363.7 17388.2 17409.5 17568.8 566462.0 597121.0 810479.0 841618.0 842277.0 59938.1 60591.7 60605.4 60654.0 60771.7 1501.8 1504.4 1511.7 1521.6 1522.8 32003.7 32385.5 32864.0 34525.7 37117.6 62115.7 62690.4 62976.7 63102.7 63167.7 515700.0 533817.0 535812.0 537922.2 538891.0 47932.5 49244.3 49644.0 49913.3 50139.7 53753.0 54212.7 54223.2 54379.2 55295.7 44852.1 45568.0 45612.2 45716.3 46126.3 43902.6 44180.3 44682.3 45325.2 45707.0 44274.6 45085.0 45598.5 45630.8 45789.8 37674.0 38280.8 38615.0 39532.8 39617.6 29961.3 30313.0 30342.8 30532.4 30701.8
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#2] jquery.html Cycles:180 Average:29488.99 Median:21495.13 stddev:87337.36 (406.3%) stddev-sans-first:87555.10
04:32:35 INFO - PROCESS | 5351 | Values: 425.9 428.2 428.5 434.0 443.7 18347.1 19341.1 20080.2 20471.5 20471.5 18587.6 18769.2 19027.4 19439.6 19498.8 5839.2 5985.8 6015.6 6018.6 6021.8 4882.4 5879.4 5948.3 6316.2 6340.9 5362.0 6338.7 6370.5 6402.5 6414.7 5624.8 5754.4 5760.2 5761.5 5767.7 5492.7 5701.3 5704.4 5704.5 5716.4 13028.6 13320.5 13433.0 13528.3 13633.6 2153.7 2232.6 2258.5 2391.5 2485.3 10099.1 10315.7 10368.7 10374.4 10476.4 1962.1 1965.7 1985.3 2003.9 2025.5 73073.0 75581.0 76102.0 82984.0 85572.6 10857.6 11322.4 11327.7 11453.4 11469.1 15829.3 15949.9 15996.2 16075.0 16165.4 8305.2 8357.8 8729.4 8760.4 8801.4 8382.0 8463.0 8597.3 8879.2 8965.1 4464.4 4537.8 4545.7 4554.4 4566.9 1909.6 1921.9 1926.6 1938.6 1958.2 436.6 449.0 983.5 1050.7 1087.1 11536.2 11841.8 11926.1 11988.5 12103.2 459.3 464.7 470.9 471.9 476.5 6200.2 6321.6 6397.6 10504.4 10992.2 524800.0 527652.0 527757.0 534980.0 541334.0 61098.7 86875.6 88061.0 90261.5 98832.5 1099.2 1124.4 1134.7 1136.5 1146.0 17322.4 17720.0 17886.3 17900.1 18258.5 42206.8 42283.0 42413.6 42564.4 45188.0 54699.2 55507.0 56294.4 62267.4 63526.4 8571.4 8889.9 9055.0 9117.5 9125.1 12341.5 13091.5 13268.1 13562.4 13576.9 11583.0 11691.7 12001.3 12108.9 12109.2 9886.4 11713.6 11732.4 11824.9 11888.3 12007.9 12134.6 12142.3 12210.0 12247.8 8604.8 8632.9 8647.7 8797.3 9008.1 9145.7 10596.7 11694.2 11801.9 12030.2
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#3] mootools.html Cycles:180 Average:6303.99 Median:4468.86 stddev:3705.08 (82.9%) stddev-sans-first:3698.39
04:32:35 INFO - PROCESS | 5351 | Values: 1569.7 1603.3 1834.2 1885.0 1941.4 8380.0 9300.2 9419.8 10018.5 10038.5 9492.9 9776.7 9781.8 9841.1 9884.6 2457.9 2490.7 2491.6 2491.9 2496.4 2384.7 2469.5 2470.1 2476.6 2476.8 2460.1 2465.6 2480.1 2492.2 2494.9 2180.4 2219.6 2220.6 2243.8 2264.9 2352.8 2372.6 2390.8 2398.1 2400.7 9675.8 9722.9 9755.4 9767.2 9783.2 5638.4 5813.7 5817.5 5821.8 5822.8 3611.7 3647.8 3649.7 3651.6 3723.2 1154.2 1210.9 1217.7 1235.4 1238.2 13838.5 13863.5 13928.2 13938.7 13971.9 5032.7 5060.2 5070.6 5111.3 5254.9 11395.8 11418.1 11458.1 11469.9 11474.5 5774.9 5776.6 5789.2 5796.9 5805.7 4360.0 5075.1 5211.1 5247.1 5382.4 4364.4 4377.0 4401.7 4427.7 4510.0 1390.1 1392.5 1406.3 1416.0 1418.3 891.4 901.4 957.1 970.1 991.4 5887.2 6222.7 6419.1 6546.5 6582.3 985.5 1002.5 1023.9 1039.1 1057.6 4006.1 4049.1 4097.7 4100.3 4104.5 12029.8 12304.8 12401.0 12405.2 12420.1 11899.9 12192.6 12214.7 12263.4 12425.4 8544.1 8557.7 8697.8 8699.6 8744.2 5795.4 5817.4 5841.8 5852.5 6003.7 10492.2 10505.9 10513.6 10641.9 10765.9 11328.7 11474.7 11528.8 11546.6 11634.4 8392.3 8507.1 8628.6 8695.3 8843.6 9430.9 9529.2 9609.0 9633.5 9728.0 8373.7 8412.9 8509.1 8534.5 8615.2 8108.0 8339.7 8385.8 8417.0 8501.5 7420.9 7434.7 7497.4 7497.7 7510.7 5119.4 5200.1 5286.6 5304.2 5338.8 5138.9 5172.2 5235.2 5239.9 5266.8
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#4] prototype.html Cycles:180 Average:5100.90 Median:5817.98 stddev:1534.45 (26.4%) stddev-sans-first:1496.67
04:32:35 INFO - PROCESS | 5351 | Values: 345.8 348.4 348.8 353.2 355.9 5726.3 5804.8 5807.2 5807.3 5836.9 5656.7 5673.0 5687.1 5697.8 5739.4 4032.2 4368.5 4407.4 4410.9 4411.6 4405.6 4426.6 4462.2 4465.1 4467.0 4418.3 4441.0 4461.5 4462.2 4474.6 4292.9 4400.8 4408.8 4418.5 4450.8 3871.9 3874.5 3891.0 3904.1 3908.8 5523.5 5526.6 5543.5 5545.9 5559.5 4910.6 5045.2 5075.6 5093.8 5115.4 6010.9 6011.6 6016.2 6022.9 6091.2 4276.7 4293.8 4296.0 4306.2 4310.5 6104.2 6260.0 6279.7 6295.0 6306.5 4285.9 4307.7 4310.4 4313.3 4322.9 4308.6 4323.9 4363.5 4372.2 4376.7 4893.3 5010.2 5016.6 5022.1 5034.9 5997.5 6000.0 6009.0 6052.8 6109.5 1456.1 1478.8 1519.1 1525.7 1527.3 963.9 970.8 1013.7 1040.1 1042.9 5804.7 5882.8 5896.9 5900.2 5949.1 6168.8 6215.8 6224.2 6234.0 6266.9 5722.3 5791.7 5802.5 5828.6 5856.7 3310.0 3344.6 3352.2 3356.1 3358.2 6180.2 6436.2 6470.5 6569.0 6570.3 6378.2 6453.4 6456.3 6458.4 6473.8 6335.7 6536.7 6581.5 6587.8 6592.5 6270.7 6277.7 6295.7 6297.5 6341.9 6158.7 6169.3 6214.1 6243.5 6261.3 6217.0 6507.4 6523.6 6529.6 6579.8 4432.1 4444.6 4452.4 4481.9 4499.8 6213.8 6274.6 6306.0 6310.5 6326.9 6150.8 6180.7 6190.6 6195.0 6206.4 5901.7 6108.4 6131.5 6136.7 6180.5 5907.9 6013.3 6043.6 6055.6 6056.4 6200.0 6206.9 6211.2 6216.8 6220.4 5977.2 6020.9 6049.9 6052.4 6053.9
04:32:35 INFO - PROCESS | 5351 |
04:32:35 INFO - PROCESS | 5351 | [#5] yui.html Cycles:180 Average:21067.00 Median:4851.88 stddev:30358.37 (625.7%) stddev-sans-first:30405.10
04:32:35 INFO - PROCESS | 5351 | Values: 723.7 723.9 733.8 757.3 775.1 14235.8 14792.6 14825.6 14858.2 14889.3 14880.0 14912.7 15029.2 15049.3 16225.1 872.9 881.4 881.6 882.0 885.5 869.1 877.6 878.8 879.3 879.7 914.8 915.0 919.0 920.0 920.1 907.9 909.2 909.4 910.0 911.3 668.2 668.3 670.0 670.0 670.9 15343.5 15400.6 15410.0 15435.9 15442.2 13218.8 13581.9 13815.1 13878.6 13885.3 12323.3 12350.8 12414.2 12831.4 12871.5 3661.7 3799.7 3893.3 4839.3 4902.1 71898.6 75450.0 84470.0 84585.2 86393.6 12333.7 12543.4 12701.9 12813.9 12872.2 22789.3 22969.7 23001.0 23244.3 23713.6 8504.8 8612.1 8617.2 8622.4 8646.5 4638.1 4668.5 4724.6 4944.9 5043.4 3658.6 3740.7 3740.9 3762.4 3766.6 656.0 659.4 662.1 673.9 678.1 550.7 581.2 596.7 654.6 701.5 9071.0 9229.3 9299.6 9489.2 9535.2 597.4 714.4 770.2 814.8 820.6 4574.6 4845.1 4851.8 4852.0 4856.8 115621.4 117727.4 117914.4 119302.4 120190.0 72260.0 73679.6 97772.0 99770.0 104070.5 88426.0 90927.0 91165.5 92575.0 92585.5 8960.8 9117.8 9313.5 9331.9 9369.9 52736.5 54042.5 54542.0 54597.5 55668.7 70910.3 76672.6 77591.0 77896.0 78379.6 12318.0 12333.9 12437.7 12566.4 12943.4 13648.0 13896.5 14010.9 14044.8 14421.1 13022.0 13060.2 13240.1 13248.7 13393.5 12205.8 12216.9 12363.6 12428.0 12458.7 12341.2 12425.0 13416.9 13657.3 13966.0 11736.4 12015.1 12138.8 12339.4 12412.9 11924.4 11956.5 12020.9 12025.9 12115.3
04:32:35 INFO - PROCESS | 5351 | -------- Summary: end --------
04:32:35 INFO - PROCESS | 5351 |
04:32:36 INFO - TEST-INFO | 5351: exit 0
04:32:36 INFO - TEST-OK | dromaeo_css | took 1109727ms
04:32:36 INFO - TEST-START | kraken
04:32:36 INFO - operating with platform_type : linux_
04:32:36 INFO - Initialising browser for kraken test...
04:32:36 INFO - TEST-INFO | started process 5593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qsRke/profile http://localhost:55038/getInfo.html)
04:32:40 INFO - PROCESS | 5593 | __metrics Screen width/height:1600/1200
04:32:40 INFO - PROCESS | 5593 | colorDepth:24
04:32:40 INFO - PROCESS | 5593 | Browser inner width/height: 1024/697
04:32:40 INFO - PROCESS | 5593 | __metrics
04:32:41 ERROR - PROCESS | 5593 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined
04:32:42 INFO - TEST-INFO | 5593: exit 0
04:32:42 INFO - Browser initialized.
04:32:42 INFO - Running cycle 1/1 for kraken test...
04:32:42 INFO - TEST-INFO | started process 5718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7qsRke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
04:32:53 INFO - PROCESS | 5718 | RSS: Main: 153071616
04:32:53 INFO - PROCESS | 5718 |
04:32:56 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-beat-detection)
04:32:57 INFO - PROCESS | 5718 | RSS: Main: 158023680
04:32:57 INFO - PROCESS | 5718 |
04:32:59 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-dft)
04:33:00 INFO - PROCESS | 5718 | RSS: Main: 156991488
04:33:00 INFO - PROCESS | 5718 |
04:33:03 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-fft)
04:33:04 INFO - PROCESS | 5718 | RSS: Main: 157761536
04:33:04 INFO - PROCESS | 5718 |
04:33:06 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55038/tests/kraken/driver.html?testName=audio-oscillator)
04:33:06 INFO - PROCESS | 5718 | RSS: Main: 157569024
04:33:06 INFO - PROCESS | 5718 |
04:33:08 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-gaussian-blur)
04:33:09 INFO - PROCESS | 5718 | RSS: Main: 157306880
04:33:09 INFO - PROCESS | 5718 |
04:33:12 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-darkroom)
04:33:13 INFO - PROCESS | 5718 | RSS: Main: 157212672
04:33:13 INFO - PROCESS | 5718 |
04:33:16 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55038/tests/kraken/driver.html?testName=imaging-desaturate)
04:33:17 INFO - PROCESS | 5718 | RSS: Main: 157478912
04:33:17 INFO - PROCESS | 5718 |
04:33:20 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55038/tests/kraken/driver.html?testName=json-parse-financial)
04:33:20 INFO - PROCESS | 5718 | RSS: Main: 158195712
04:33:20 INFO - PROCESS | 5718 |
04:33:22 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55038/tests/kraken/driver.html?testName=json-stringify-tinderbox)
04:33:22 INFO - PROCESS | 5718 | RSS: Main: 157765632
04:33:22 INFO - PROCESS | 5718 |
04:33:24 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-aes)
04:33:25 INFO - PROCESS | 5718 | RSS: Main: 157671424
04:33:25 INFO - PROCESS | 5718 |
04:33:27 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-ccm)
04:33:27 INFO - PROCESS | 5718 | RSS: Main: 157888512
04:33:27 INFO - PROCESS | 5718 |
04:33:30 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
04:33:31 INFO - PROCESS | 5718 | RSS: Main: 158158848
04:33:31 INFO - PROCESS | 5718 |
04:33:33 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
04:33:34 INFO - PROCESS | 5718 | RSS: Main: 157970432
04:33:34 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | Cycle 1(1): loaded http://localhost:55038/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55038/tests/kraken/driver.html?testName=ai-astar)
04:33:36 INFO - PROCESS | 5718 | RSS: Main: 158564352
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | __start_tp_report
04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_page_load
04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_page_load_details
04:33:36 INFO - PROCESS | 5718 | |i|pagename|runs|
04:33:36 INFO - PROCESS | 5718 | |0;ai-astar;112;106;111;110;112;112;111;113;111;110
04:33:36 INFO - PROCESS | 5718 | |1;audio-beat-detection;151;130;156;172;126;159;155;132;182;127
04:33:36 INFO - PROCESS | 5718 | |2;audio-dft;165;164;163;162;164;162;162;165;163;161
04:33:36 INFO - PROCESS | 5718 | |3;audio-fft;76;76;76;170;75;76;76;76;163;75
04:33:36 INFO - PROCESS | 5718 | |4;audio-oscillator;85;85;148;84;84;87;143;84;85;144
04:33:36 INFO - PROCESS | 5718 | |5;imaging-gaussian-blur;117;117;118;116;117;117;117;121;117;117
04:33:36 INFO - PROCESS | 5718 | |6;imaging-darkroom;146;148;148;147;146;148;147;147;147;147
04:33:36 INFO - PROCESS | 5718 | |7;imaging-desaturate;95;97;95;95;95;95;95;95;95;95
04:33:36 INFO - PROCESS | 5718 | |8;json-parse-financial;57;53;53;55;54;55;53;53;53;58
04:33:36 INFO - PROCESS | 5718 | |9;json-stringify-tinderbox;62;61;62;61;63;61;61;62;62;62
04:33:36 INFO - PROCESS | 5718 | |10;stanford-crypto-aes;78;81;81;77;76;78;80;78;115;77
04:33:36 INFO - PROCESS | 5718 | |11;stanford-crypto-ccm;125;127;123;122;121;128;132;130;125;136
04:33:36 INFO - PROCESS | 5718 | |12;stanford-crypto-pbkdf2;154;156;159;155;155;156;153;155;161;152
04:33:36 INFO - PROCESS | 5718 | |13;stanford-crypto-sha256-iterative;63;62;65;61;63;61;61;62;61;62
04:33:36 INFO - PROCESS | 5718 | __end_tp_report
04:33:36 INFO - PROCESS | 5718 | __start_cc_report
04:33:36 INFO - PROCESS | 5718 | _x_x_mozilla_cycle_collect,865
04:33:36 INFO - PROCESS | 5718 | __end_cc_report
04:33:36 INFO - PROCESS | 5718 | __startTimestamp1472384016269__endTimestamp
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | ------- Summary: start -------
04:33:36 INFO - PROCESS | 5718 | Number of tests: 14
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:1.93 (1.7%) stddev-sans-first:2.00
04:33:36 INFO - PROCESS | 5718 | Values: 112.0 106.0 111.0 110.0 112.0 112.0 111.0 113.0 111.0 110.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.50 stddev:19.64 (12.6%) stddev-sans-first:20.81
04:33:36 INFO - PROCESS | 5718 | Values: 151.0 130.0 156.0 172.0 126.0 159.0 155.0 132.0 182.0 127.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:1.37 (0.8%) stddev-sans-first:1.27
04:33:36 INFO - PROCESS | 5718 | Values: 165.0 164.0 163.0 162.0 164.0 162.0 162.0 165.0 163.0 161.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:38.30 (50.4%) stddev-sans-first:40.07
04:33:36 INFO - PROCESS | 5718 | Values: 76.0 76.0 76.0 170.0 75.0 76.0 76.0 76.0 163.0 75.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.50 stddev:29.09 (34.4%) stddev-sans-first:30.13
04:33:36 INFO - PROCESS | 5718 | Values: 85.0 85.0 148.0 84.0 84.0 87.0 143.0 84.0 85.0 144.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:1.35 (1.2%) stddev-sans-first:1.42
04:33:36 INFO - PROCESS | 5718 | Values: 117.0 117.0 118.0 116.0 117.0 117.0 117.0 121.0 117.0 117.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67
04:33:36 INFO - PROCESS | 5718 | Values: 146.0 148.0 148.0 147.0 146.0 148.0 147.0 147.0 147.0 147.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67
04:33:36 INFO - PROCESS | 5718 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.84 (3.4%) stddev-sans-first:1.69
04:33:36 INFO - PROCESS | 5718 | Values: 57.0 53.0 53.0 55.0 54.0 55.0 53.0 53.0 53.0 58.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71
04:33:36 INFO - PROCESS | 5718 | Values: 62.0 61.0 62.0 61.0 63.0 61.0 61.0 62.0 62.0 62.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:78.00 stddev:11.69 (15.0%) stddev-sans-first:12.30
04:33:36 INFO - PROCESS | 5718 | Values: 78.0 81.0 81.0 77.0 76.0 78.0 80.0 78.0 115.0 77.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:127.50 stddev:4.72 (3.7%) stddev-sans-first:4.96
04:33:36 INFO - PROCESS | 5718 | Values: 125.0 127.0 123.0 122.0 121.0 128.0 132.0 130.0 125.0 136.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:155.50 stddev:2.67 (1.7%) stddev-sans-first:2.77
04:33:36 INFO - PROCESS | 5718 | Values: 154.0 156.0 159.0 155.0 155.0 156.0 153.0 155.0 161.0 152.0
04:33:36 INFO - PROCESS | 5718 |
04:33:36 INFO - PROCESS | 5718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.32
04:33:36 INFO - PROCESS | 5718 | Values: 63.0 62.0 65.0 61.0 63.0 61.0 61.0 62.0 61.0 62.0
04:33:36 INFO - PROCESS | 5718 | -------- Summary: end --------
04:33:36 INFO - PROCESS | 5718 |
04:33:37 INFO - TEST-INFO | 5718: exit 0
04:33:37 INFO - TEST-OK | kraken | took 61037ms
04:33:37 INFO - SUITE-END | took 1170s
04:33:37 INFO - Completed test suite (00:19:30)
04:33:37 INFO - javascript benchmark
04:33:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7515.9272769571435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.8832440864576, 3379.7127244184244, 3396.354692608404, 3405.4040542904986, 3421.5380923575326, 5619.3818679945225, 5651.2935883014625, 5664.376918538957, 5699.0, 5702.885942281152, 5568.638038527503, 5705.629134106281, 5712.314522257325, 5716.799912003081, 5724.742386592603, 5010.073136469756, 5091.592672586203, 5094.363204599425, 5113.718745468997, 5115.360579927509, 5018.824341148061, 5087.5421212090905, 5093.465186155456, 5138.922916156261, 5167.199084141964, 5104.106781313274, 5125.871853203663, 5137.717425541594, 5139.306193663845, 5142.04872098663, 5170.45710200431, 5170.586353091744, 5179.326687530634, 5192.428832828386, 5195.168772996302, 4921.286413470027, 4951.950480495185, 4983.25251212321, 5089.44016158226, 5094.7197904115255, 5514.972425137848, 5533.142362933751, 5554.527865131468, 5573.6098473106895, 5582.078956972095, 5982.581219314649, 6009.128676341906, 6011.57918945674, 6015.398460153993, 6030.306514750772, 5818.970905145489, 5842.532597392198, 5921.171036054912, 5949.791757288474, 6062.96968515159, 5545.861353466155, 5549.084401073818, 5554.750036248338, 5559.444055594448, 5559.833205003856, 6018.608790428608, 6030.065339872327, 6055.909161362583, 6073.058675905242, 6092.299385570716, 5673.801416950387, 5804.854878628068, 5805.10020946754, 5833.88332233353, 5880.676562789087, 5966.642001479925, 5985.970070149621, 6005.969970150209, 6007.669578173155, 6013.669248191304, 5838.970805146032, 5997.100434934708, 5998.580099393088, 6010.188624535719, 6020.307664618537, 5938.495227905676, 5973.701314934323, 5976.073708575178, 5984.0, 5989.850253743604, 4653.744044077608, 4657.5575320344515, 4660.603848672833, 4663.906721865612, 4694.36626055485, 4074.348104303297, 4105.69207309447, 4175.728577642443, 4181.435506206684, 4219.767912764827, 5599.300087489064, 5690.174924635905, 5708.0581704019205, 5760.3951585083805, 5823.737931793079, 6053.878922421527, 6062.636241825505, 6067.0, 6085.604435711664, 6104.969475152596, 5557.249771280906, 5662.292213473316, 5774.855628609234, 5799.130130480462, 5839.124131380327, 5192.273081768555, 5201.245819356248, 5221.0, 5225.529702326809, 5282.920756188661, 6240.7503699852405, 6243.469305109116, 6276.309605943343, 6277.2153480814895, 6277.937220627735, 5770.105633626795, 5955.255593050869, 6010.068439391901, 6047.818565443044, 6069.2110025696375, 6239.78160764371, 6276.058591211355, 6294.0558916162945, 6301.8109456716375, 6306.936930630635, 5913.34953155144, 5927.881442371215, 5937.703114844154, 5942.346341902301, 5954.345022047484, 5897.292324920865, 5998.640081595118, 6008.429199226067, 6041.063635136561, 6051.0, 5957.046872500379, 5974.372690867396, 5978.432048955342, 5979.192808970907, 5986.790462333797, 5898.734556945034, 5937.228160339301, 5939.07944268639, 5947.821565353046, 5973.850653733692, 5665.206871037975, 5741.110127930177, 5755.165501002248, 5795.130730390307, 5839.737211825393, 5933.614315069507, 5968.671723055274, 5976.372480889618, 5977.551683623658, 5984.640921544721, 5826.271716035496, 5860.355360910211, 5887.970560147171, 5897.174395584708, 5898.587098903035], "value": 5554.623582353188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.1820342418903, 638.0110828216264, 650.3691419323255, 657.9342065793418, 665.8468552232986, 45432.77283613582, 47101.29348059782, 47102.293465598, 47167.52832471678, 50630.0, 48325.516744832545, 49109.50890491094, 49197.75401122998, 49229.52311430654, 49282.75358623211, 9031.819363612723, 9106.817863642756, 9179.082091790835, 9184.311176661744, 9197.126273004054, 9074.455532668027, 9108.0, 9108.544572771369, 9110.817783644356, 9123.224525915271, 9141.131592498736, 9169.724908252763, 9222.631094756236, 9223.631054757801, 9224.262059035262, 9137.177654011137, 9145.268378529701, 9155.954220228923, 9162.587683554222, 9165.220956218729, 8857.291416686714, 8878.067802880734, 8934.195922367018, 8942.105789421072, 8946.373753837233, 44719.55280447187, 45127.32309015367, 45156.77421612904, 45224.54775452236, 45230.32154517685, 3769.736118471708, 3809.942850857239, 3827.0, 3848.5289137666705, 3871.361225397806, 33788.6621133788, 33831.0, 34174.31651366959, 34341.656583434095, 34605.30789384223, 4024.55729869717, 4109.97945010276, 4111.5477297497255, 4117.279476091672, 4168.312228482297, 360301.0, 361135.0, 361228.9999999974, 362145.0, 362727.0, 38056.61943380531, 63106.0, 63211.683941580915, 63266.0, 63566.682166589795, 39593.20813583712, 41135.7943210282, 41259.1748165041, 41335.0, 41406.0, 16851.241694123793, 17232.741508877378, 17279.827201728072, 17360.305587776347, 17372.47882563525, 14250.857491424953, 14379.568612941628, 14398.85601143996, 14464.493742719165, 14466.27668616586, 9354.391964522285, 9360.297977651704, 9384.765380865396, 9446.527673616292, 9450.149486546106, 3556.608773034964, 3625.782453052825, 3636.127329440915, 3667.6332366763645, 3692.5753538342897, 1088.586337191862, 1129.5770572122915, 1134.4838098665089, 1187.2342339191346, 1225.4607972492254, 33173.668263317544, 33229.0, 33389.0, 33630.99107026793, 34043.14892127667, 1150.0626989003936, 1155.930644161353, 1168.1764356129079, 1276.3809552367095, 1330.388021510097, 17326.826731732774, 17363.739543906853, 17388.217530211172, 17409.47771566855, 17568.824311756973, 566462.0, 597121.0, 810479.0, 841618.0, 842277.0, 59938.10092848611, 60591.69704151539, 60605.39394605997, 60654.0, 60771.6961415199, 1501.8347981722002, 1504.3832028868112, 1511.7127745728276, 1521.5815650695927, 1522.7868098466224, 32003.679963201, 32385.51421728723, 32864.0, 34525.65474345325, 37117.62882371142, 62115.689421552604, 62690.37309626846, 62976.685116574125, 63102.68448657727, 63167.684161578894, 515700.0, 533817.0, 535812.0, 537922.2415551746, 538891.0, 47932.5206747928, 49244.26133607927, 49644.0, 49913.251301231234, 50139.74930125472, 53753.0, 54212.728936355066, 54223.18665219946, 54379.18431223614, 55295.72352138213, 44852.10295794131, 45568.0, 45612.24591819465, 45716.31425528686, 46126.30810537912, 43902.56097439113, 44180.337294939956, 44682.3297650529, 45325.18699252125, 45707.0, 44274.604184899814, 45085.0, 45598.54401456076, 45630.771846141884, 45789.77105114453, 37674.0, 38280.80859595684, 38615.0, 39532.80233598813, 39617.60382396139, 29961.250968725955, 30312.973749302302, 30342.84828575843, 30532.389352212387, 30701.846490767402], "value": 20830.24119345028, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.8999135203227, 428.2291874625673, 428.5200575355602, 433.96094351508356, 443.66281625964257, 18347.082645867704, 19341.129649165767, 20080.196792128314, 20471.488212794688, 20471.488212794688, 18587.628247435045, 18769.155388007537, 19027.429177124675, 19439.611207775837, 19498.805011949877, 5839.153322768207, 5985.760569577234, 6015.578909476339, 6018.578699491016, 6021.849453763647, 4882.41411030675, 5879.353271140171, 5948.315943666469, 6316.178896743417, 6340.936590634081, 5362.0, 6338.714757835908, 6370.522210834206, 6402.519811014193, 6414.679266036703, 5624.831255062334, 5754.367019627858, 5760.193572899798, 5761.539076873861, 5767.740451679684, 5492.725363731837, 5701.315842098975, 5704.429557044304, 5704.515116215127, 5716.428357164292, 13028.609141725763, 13320.467181312735, 13433.0, 13528.25594592297, 13633.590992270249, 2153.720016397874, 2232.609293373653, 2258.4930726893135, 2391.497785465037, 2485.254423672909, 10099.091081802673, 10315.658964334589, 10368.740781480448, 10374.429406382646, 10476.371417714885, 1962.0876292523901, 1965.7247985281929, 1985.3150663021236, 2003.8597298188986, 2025.473376921996, 73073.0, 75581.0, 76102.0, 82984.0, 85572.57213713953, 10857.565697372174, 11322.37726925027, 11327.660170194908, 11453.427328633701, 11469.139814513945, 15829.287682054335, 15949.920250398905, 15996.200189990454, 16075.0, 16165.4342098026, 8305.211004954519, 8357.791055223546, 8729.432586881832, 8760.386772925962, 8801.427907186013, 8382.036065852382, 8463.0, 8597.269232115215, 8879.156480134377, 8965.148310910454, 4464.374987501752, 4537.818487260539, 4545.749983750926, 4554.43069616298, 4566.862994110115, 1909.627622613577, 1921.8654694171273, 1926.5857840564347, 1938.6413513500047, 1958.177565422526, 436.6245029274821, 448.9842855500042, 983.4984158079288, 1050.721558786922, 1087.065123993365, 11536.192466527431, 11841.763164736829, 11926.105542084379, 11988.460519276654, 12103.213291136048, 459.34084588615445, 464.7374233558029, 470.901110766736, 471.9174144524695, 476.49253544974493, 6200.193974783339, 6321.589096708699, 6397.648129352837, 10504.42225677595, 10992.230543862013, 524800.0, 527652.0, 527757.0, 534980.0, 541334.0, 61098.69450652718, 86875.56562217275, 88061.0, 90261.54869225743, 98832.50583747035, 1099.2195541165702, 1124.4321617583068, 1134.6539305511733, 1136.5283407386007, 1146.0487795130023, 17322.39371621987, 17720.0, 17886.28454861843, 17900.10499474995, 18258.543536411697, 42206.78896605497, 42283.0, 42413.57586424219, 42564.36153457639, 45188.0, 54699.17951230655, 55507.0, 56294.43705562892, 62267.443313917516, 63526.36473635204, 8571.4000019998, 8889.866652000355, 9055.049219831822, 9117.452952822852, 9125.087491250822, 12341.50633974631, 13091.476340946256, 13268.071235013456, 13562.389692463665, 13576.93211533936, 11583.0, 11691.707707307385, 12001.339926304137, 12108.878911210775, 12109.152359334763, 9886.357386769838, 11713.648590542298, 11732.354720490455, 11824.940875295568, 11888.28670279786, 12007.879921201025, 12134.641238858807, 12142.271463712206, 12210.0, 12247.755044898873, 8604.82790344177, 8632.870506942276, 8647.697330593399, 8797.296216302553, 9008.099190080939, 9145.725628231165, 10596.735081622714, 11694.239874408137, 11801.881981180079, 12030.218035827644], "value": 8809.452553928217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.6814675672433, 1603.3426295218958, 1834.1562881074706, 1884.9528761780962, 1941.3981665683648, 8380.0, 9300.209482194014, 9419.811603767937, 10018.54916528757, 10038.498075096244, 9492.857607135882, 9776.657816976407, 9781.7554561136, 9841.114299713025, 9884.555195016224, 2457.8771061446946, 2490.7260201377835, 2491.6137998610243, 2491.9409251068314, 2496.4383013821835, 2384.666146739458, 2469.4814089041233, 2470.086068154776, 2476.6408870713826, 2476.7647073527987, 2460.1143588308196, 2465.6301554766837, 2480.1443501991785, 2492.152668092848, 2494.8627825469594, 2180.4439867833757, 2219.6115679755976, 2220.555888822234, 2243.8204943604474, 2264.9433764155865, 2352.788249057593, 2372.5847976604027, 2390.7848293653483, 2398.124684490166, 2400.699912510936, 9675.806483870283, 9722.854157187649, 9755.36590121647, 9767.218622510181, 9783.217342612574, 5638.35158956717, 5813.6802475863815, 5817.476427121579, 5821.796237131723, 5822.82531524055, 3611.747177697562, 3647.81760911956, 3649.6897763689853, 3651.634836516327, 3723.2367364690444, 1154.1805318224071, 1210.9273443593413, 1217.7077501399601, 1235.4008305971597, 1238.2137342787305, 13838.515651952133, 13863.475017747938, 13928.233947132903, 13938.651533711636, 13971.930140349335, 5032.748362581856, 5060.240963855377, 5070.619703522177, 5111.3355263815465, 5254.868628284247, 11395.829062564067, 11418.143639227092, 11458.083353331713, 11469.942650286695, 11474.48364823585, 5774.855628609234, 5776.595638305278, 5789.160571717078, 5796.8550786229835, 5805.680687562224, 4359.956400435955, 5075.137226671474, 5211.088059589557, 5247.134222853263, 5382.381026182039, 4364.41080454141, 4376.978115109404, 4401.6698747594055, 4427.712198707074, 4510.0, 1390.075599726191, 1392.470861072786, 1406.310907655262, 1415.985840141606, 1418.3121186224673, 891.4364777387901, 901.396064636695, 957.090763774417, 970.1365784451843, 991.3902949685892, 5887.175795388649, 6222.719977601018, 6419.101325814389, 6546.509011824132, 6582.341765823379, 985.4530735441755, 1002.4987506246877, 1023.9129673977646, 1039.0804138337473, 1057.6383055918654, 4006.138680183716, 4049.088954985105, 4097.733647312915, 4100.2619528484565, 4104.486939132608, 12029.819552706716, 12304.81542776859, 12401.0, 12405.193662412095, 12420.130590858553, 11899.88100119005, 12192.573259936036, 12214.694632634255, 12263.448144833505, 12425.37873106341, 8544.102869198645, 8557.657693692183, 8697.826043479095, 8699.608517616722, 8744.213020828156, 5795.39148389413, 5817.447342502455, 5841.795537156179, 5852.502537284378, 6003.699815009145, 10492.160627149657, 10505.89688082771, 10513.579456821948, 10641.89358106409, 10765.946170269099, 11328.716782080513, 11474.713132171762, 11528.769424611628, 11546.59586914454, 11634.418279085843, 8392.328613710766, 8507.064222935349, 8628.611712473079, 8695.304375649806, 8843.646254149762, 9430.905690943002, 9529.237660987243, 9608.95195524018, 9633.470159141314, 9727.951360243154, 8373.748787536384, 8412.87380689278, 8509.149085091442, 8534.530600817016, 8615.22462978335, 8107.959460202661, 8339.666413343399, 8385.790355241168, 8417.0, 8501.532415717194, 7420.888686669597, 7434.702611895464, 7497.400207983457, 7497.737579184703, 7510.737124200627, 5119.385673719177, 5200.115980283285, 5286.550643195218, 5304.23088652151, 5338.813141540028, 5138.922916156335, 5172.224166375074, 5235.1623740201385, 5239.895202096013, 5266.78932842682], "value": 4987.016925154833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.78906866811246, 348.35901940429613, 348.808155514467, 353.2299586900556, 355.9003479025872, 5726.284214473191, 5804.82585522434, 5807.186993820868, 5807.332156801964, 5836.9124463132985, 5656.688882111483, 5673.0, 5687.146927960808, 5697.77208911643, 5739.397363276858, 4032.193561287747, 4368.541303163154, 4407.360932664762, 4410.867673969786, 4411.6250118739945, 4405.581469760367, 4426.601605855472, 4462.219111655448, 4465.106978604276, 4466.97766511167, 4418.293073108303, 4440.955590444087, 4461.531539188387, 4462.1968045751755, 4474.619657329131, 4292.892677683068, 4400.8215933113315, 4408.779561021936, 4418.491873434532, 4450.821967121327, 3871.9225615487812, 3874.4575759393706, 3891.0466935600675, 3904.06302487401, 3908.7654740715648, 5523.453433038715, 5526.618345413646, 5543.528800052, 5545.916811247835, 5559.471850174227, 4910.558049775537, 5045.167547354718, 5075.629580013413, 5093.770780314895, 5115.360579927509, 6010.939890601082, 6011.57918945674, 6016.2479690038745, 6022.879542409171, 6091.177691011701, 4276.66921527765, 4293.763842988635, 4296.0, 4306.20335237982, 4310.547392523803, 6104.175936248594, 6260.0, 6279.686015699197, 6294.9685251574365, 6306.527010474187, 4285.892852678646, 4307.7415355078165, 4310.374995625617, 4313.317806055641, 4322.891927701832, 4308.612224899712, 4323.891902702395, 4363.498197707304, 4372.213001659668, 4376.65848770906, 4893.266010098514, 5010.223415370623, 5016.648834581544, 5022.096022715873, 5034.899302014012, 5997.460228579362, 6000.0, 6008.969955150284, 6052.789442111595, 6109.5112391008615, 1456.1190479759805, 1478.7560052591416, 1519.080956021613, 1525.7482515385059, 1527.2974431761513, 963.8554216867526, 970.8009857979098, 1013.690824298596, 1040.1314902056715, 1042.9426381548935, 5804.65172089676, 5882.823515294548, 5896.941030589725, 5900.203472531153, 5949.137375080676, 6168.753249869955, 6215.844603884939, 6224.190855188796, 6234.0, 6266.905996410058, 5722.341930677942, 5791.652500849878, 5802.535797136219, 5828.6211396259105, 5856.677882716406, 3309.9573634305116, 3344.6488118747666, 3352.1619595101224, 3356.0938546592283, 3358.177246574605, 6180.165677633552, 6436.195475565554, 6470.547061705635, 6568.967155164193, 6570.310117437601, 6378.234611846516, 6453.4189123665, 6456.322086180978, 6458.418742313214, 6473.805785826433, 6335.651539165298, 6536.705848236936, 6581.539292249592, 6587.835304117435, 6592.5055620828625, 6270.655113968775, 6277.717502712298, 6295.716692748746, 6297.4647154992335, 6341.904871427025, 6158.7228574715145, 6169.259688837368, 6214.13575927211, 6243.532769799002, 6261.3112557617715, 6217.041631885942, 6507.446867016357, 6523.575967562093, 6529.563496030865, 6579.80260592183, 4432.091421258569, 4444.599986001275, 4452.443444569429, 4481.910361792811, 4499.842505512292, 6213.788311279257, 6274.592151510137, 6306.0, 6310.5267104968225, 6326.905096423466, 6150.7539698411565, 6180.721867515883, 6190.566660333733, 6194.969025154845, 6206.410391012847, 5901.734421950937, 6108.389161083856, 6131.4860907027905, 6136.662483563447, 6180.505559555135, 5907.852303692442, 6013.301819381137, 6043.576949613661, 6055.6063855849225, 6056.36408177135, 6199.969000154971, 6206.875862482815, 6211.223597050369, 6216.849882771702, 6220.409061139185, 5977.22296101504, 6020.909686354796, 6049.939500604937, 6052.425019623305, 6053.910296146736], "value": 4606.437611045951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6851969393314, 723.8805597076486, 733.8238822682555, 757.3373298363931, 775.1202385292692, 14235.786463203047, 14792.556223313319, 14825.629359266024, 14858.182799945998, 14889.329980150906, 14880.0, 14912.701745965102, 15029.248537573105, 15049.322780474877, 16225.107619080945, 872.8647059705739, 881.3610132653806, 881.6120906801019, 882.0341725810227, 885.4642941020654, 869.1135042256926, 877.5656050255133, 878.8198419324024, 879.3053487744706, 879.7448739865431, 914.8444764390069, 915.0209276074603, 918.9908100918972, 919.9586018629178, 920.1350730313484, 907.9228265597433, 909.2498688581913, 909.3725329522608, 909.9727008189765, 911.3347256502724, 668.234871072624, 668.2849351194224, 669.9916625478623, 670.0318040431579, 670.9396154346083, 15343.4629787958, 15400.614984625361, 15410.0, 15435.922820385938, 15442.150681712501, 13218.801717974238, 13581.864181358258, 13815.102018368774, 13878.583642490741, 13885.305734713224, 12323.322217278046, 12350.814737778941, 12414.193077450027, 12831.422585983653, 12871.549495767696, 3661.707063434919, 3799.6580307772433, 3893.299206142893, 4839.346688197119, 4902.142125128088, 71898.64050679766, 75450.0, 84470.0, 84585.15414845834, 86393.56803216007, 12333.69165770845, 12543.435545400478, 12701.872981270253, 12813.871861281454, 12872.16330938486, 22789.31632051041, 22969.655455168187, 23001.0, 23244.3026709199, 23713.644295335584, 8504.829903401896, 8612.138786121337, 8617.224449799549, 8622.396432249809, 8646.524441155796, 4638.0955713636195, 4668.50980647034, 4724.622030237572, 4944.9258261126115, 5043.420006699203, 3658.63413658632, 3740.7194460415035, 3740.8877733668032, 3762.435634654824, 3766.642168993941, 655.9770408035696, 659.4493597845757, 662.059874977533, 673.9022841687928, 678.1082876018021, 550.7246376811594, 581.2182614383647, 596.749365266589, 654.6072356586105, 701.529974916807, 9070.954645226864, 9229.307801914749, 9299.628014879465, 9489.193418559362, 9535.2371810255, 597.4205021129497, 714.3856283596103, 770.2374649097466, 814.816666250089, 820.5609998650693, 4574.5882870541145, 4845.055214233261, 4851.805927762921, 4851.95148048515, 4856.781444834991, 115621.42189289, 117727.41136294264, 117914.41042794731, 119302.40348798201, 120190.0, 72260.0, 73679.63160184165, 97772.0, 99770.0, 104070.4796476028, 88426.0, 90927.0, 91165.5441722787, 92575.0, 92585.53707231421, 8960.845992913628, 9117.77205569866, 9313.487758173094, 9331.86002209981, 9369.859452108087, 52736.47263527469, 54042.459575403744, 54542.0, 54597.454025459236, 55668.721656391455, 70910.29089709037, 76672.61663691868, 77591.0, 77896.01400270588, 78379.60810195912, 12318.0, 12333.93833030829, 12437.689057773629, 12566.434510446868, 12943.417546210632, 13648.014413481513, 13896.51362202318, 14010.929945350208, 14044.78932815988, 14421.134731916118, 13021.9582433407, 13060.151090179108, 13240.073194876266, 13248.735025299633, 13393.531226407029, 12205.816912746493, 12216.877831221575, 12363.62909112728, 12428.0, 12458.688532786753, 12341.197822141532, 12425.0, 13416.932915335361, 13657.317134143452, 13966.0, 11736.354500502553, 12015.12631068884, 12138.75722485563, 12339.383030848601, 12412.875871241173, 11924.403779811148, 11956.521739130685, 12020.879791201976, 12025.939870300943, 12115.333656648969], "value": 7697.542885596994, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 112.0, 112.0, 111.0, 113.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 156.0, 172.0, 126.0, 159.0, 155.0, 132.0, 182.0, 127.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 162.0, 164.0, 162.0, 162.0, 165.0, 163.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 170.0, 75.0, 76.0, 76.0, 76.0, 163.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 148.0, 84.0, 84.0, 87.0, 143.0, 84.0, 85.0, 144.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 116.0, 117.0, 117.0, 117.0, 121.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 148.0, 147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 54.0, 55.0, 53.0, 53.0, 53.0, 58.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 81.0, 77.0, 76.0, 78.0, 80.0, 78.0, 115.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 123.0, 122.0, 121.0, 128.0, 132.0, 130.0, 125.0, 136.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 159.0, 155.0, 155.0, 156.0, 153.0, 155.0, 161.0, 152.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 65.0, 61.0, 63.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 62.1, "unit": "score"}]}]}
04:33:37 INFO - Return code: 0
04:33:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
04:33:37 ERROR - # TBPL SUCCESS #
04:33:37 INFO - Running post-action listener: _resource_record_post_action
04:33:37 INFO - #####
04:33:37 INFO - ##### Finished run-tests step (success)
04:33:37 INFO - #####
04:33:37 INFO - Running post-run listener: _resource_record_post_run
04:33:37 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 24576; Write bytes: 286199808; Read time: 16; Write time: 167796
04:33:37 INFO - TinderboxPrint: CPU usage
13.3%
04:33:37 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 16
04:33:37 INFO - TinderboxPrint: I/O write bytes / time
286,199,808 / 167,796
04:33:37 INFO - TinderboxPrint: CPU idle
8,201.4 (86.7%)
04:33:37 INFO - TinderboxPrint: CPU user
1,205.1 (12.7%)
04:33:37 INFO - TinderboxPrint: Swap in / out
0 / 0
04:33:37 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 68628480; Read time: 0; Write time: 64696
04:33:37 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 215265280; Read time: 0; Write time: 101812
04:33:38 INFO - Running post-run listener: _upload_blobber_files
04:33:38 INFO - Blob upload gear active.
04:33:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
04:33:38 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
04:33:38 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
04:33:38 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
04:33:38 INFO - Traceback (most recent call last):
04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in
04:33:38 INFO - main()
04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main
04:33:38 INFO - filetype_whitelist = get_server_whitelist(args['--url'])
04:33:38 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist
04:33:38 INFO - return set(response.json().get('whitelist', []))
04:33:38 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json
04:33:38 INFO - return json.loads(self.text or self.content, **kwargs)
04:33:38 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads
04:33:38 INFO - return _default_decoder.decode(s)
04:33:38 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode
04:33:38 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end())
04:33:38 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode
04:33:38 INFO - raise ValueError("No JSON object could be decoded")
04:33:38 INFO - ValueError: No JSON object could be decoded
04:33:38 ERROR - Return code: 1
04:33:38 INFO - Setting buildbot property blobber_files to {}
04:33:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
04:33:38 INFO - Writing to file /builds/slave/test/properties/blobber_files
04:33:38 INFO - Contents:
04:33:38 INFO - blobber_files:{}
04:33:38 INFO - Running post-run listener: copy_logs_to_upload_dir
04:33:38 INFO - Copying logs to upload dir...
04:33:38 INFO - mkdir: /builds/slave/test/build/upload/logs
04:33:38 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1670.388929
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 50 secs) (at 2016-08-28 04:33:37.908586) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.912528) =========
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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{}
build_url:https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011220
build_url: 'https://queue.taskcluster.net/v1/task/GdlaXD_eR6Kz1T8VLocPNQ/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'
blobber_files: '{}'
========= master_lag: 0.04 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.965143) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:37.965499) =========
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=4300f881736b422476174874000001bc-1472382346.584979-960572220
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004911
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-28 04:33:38.015656) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.016138) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-28 04:33:38.016619) =========
========= Total master_lag: 0.16 =========