builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s
slave: t-yosemite-r7-0266
starttime: 1491972518.54
results: success (0)
buildid: 20170411201809
builduid: 0d8be032e19847518a63d8bbbbdcfe58
revision: f40e24f40b4c4556944c762d4764eace261297f5
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.537978) =========
master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.538408) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.538696) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.565465) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.566032) =========
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:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
--2017-04-11 21:48:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: 'archiver_client.py'
0K .......... . 100% 16.9M=0.001s
2017-04-11 21:48:38 (16.9 MB/s) - 'archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.129748
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.720663) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.721011) =========
rm -rf scripts properties
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts', 'properties']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
program finished with exit code 0
elapsedTime=0.026694
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.771361) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:38.771908) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f40e24f40b4c4556944c762d4764eace261297f5 --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f40e24f40b4c4556944c762d4764eace261297f5 --destination scripts --debug']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
2017-04-11 21:48:39,053 truncating revision to first 12 chars
2017-04-11 21:48:39,053 Setting DEBUG logging.
2017-04-11 21:48:39,053 attempt 1/10
2017-04-11 21:48:39,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f40e24f40b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-04-11 21:48:39,665 unpacking tar archive at: mozilla-central-f40e24f40b4c/testing/mozharness/
program finished with exit code 0
elapsedTime=0.901327
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:39.699662) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:39.700191) =========
script_repo_revision: f40e24f40b4c4556944c762d4764eace261297f5
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:39.700872) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:39.701323) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-11 21:48:39.722850) =========
========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-11 21:48:39.723451) =========
/tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PROPERTIES_FILE=/builds/slave/test/buildprops.json
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
21:48:40 INFO - MultiFileLogger online at 20170411 21:48:40 in /builds/slave/test
21:48:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
21:48:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
21:48:40 INFO - {'append_to_log': False,
21:48:40 INFO - 'base_work_dir': '/builds/slave/test',
21:48:40 INFO - 'blob_upload_branch': 'Firefox',
21:48:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
21:48:40 INFO - 'branch': 'Firefox',
21:48:40 INFO - 'buildbot_json_path': 'buildprops.json',
21:48:40 INFO - 'config_files': ('talos/mac_config.py',),
21:48:40 INFO - 'default_actions': ('clobber',
21:48:40 INFO - 'read-buildbot-config',
21:48:40 INFO - 'download-and-extract',
21:48:40 INFO - 'populate-webroot',
21:48:40 INFO - 'create-virtualenv',
21:48:40 INFO - 'install',
21:48:40 INFO - 'run-tests'),
21:48:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
21:48:40 INFO - 'download_minidump_stackwalk': True,
21:48:40 INFO - 'download_symbols': 'ondemand',
21:48:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
21:48:40 INFO - 'tooltool.py': '/tools/tooltool.py',
21:48:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
21:48:40 INFO - '/tools/misc-python/virtualenv.py')},
21:48:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
21:48:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
21:48:40 INFO - 'gecko_profile': False,
21:48:40 INFO - 'gecko_profile_interval': 0,
21:48:40 INFO - 'installer_path': 'installer.exe',
21:48:40 INFO - 'log_level': 'info',
21:48:40 INFO - 'log_name': 'talos',
21:48:40 INFO - 'log_to_console': True,
21:48:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk',
21:48:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest',
21:48:40 INFO - 'opt_config_files': (),
21:48:40 INFO - 'pip_index': False,
21:48:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
21:48:40 INFO - 'cmd': ('bash',
21:48:40 INFO - '-c',
21:48:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
21:48:40 INFO - 'enabled': True,
21:48:40 INFO - 'halt_on_failure': False,
21:48:40 INFO - 'name': 'check_screen_resolution'},),
21:48:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
21:48:40 INFO - 'cmd': ('bash',
21:48:40 INFO - '-c',
21:48:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
21:48:40 INFO - 'enabled': True,
21:48:40 INFO - 'halt_on_failure': False,
21:48:40 INFO - 'name': 'check_screen_resolution'},),
21:48:40 INFO - 'run_cmd_checks_enabled': True,
21:48:40 INFO - 'suite': 'dromaeojs-e10s',
21:48:40 INFO - 'system_bits': '32',
21:48:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
21:48:40 INFO - 'title': 't-yosemite-r7-0266',
21:48:40 INFO - 'tooltool_cache': '/builds/tooltool_cache',
21:48:40 INFO - 'use_talos_json': True,
21:48:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
21:48:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:48:40 INFO - 'work_dir': 'build'}
21:48:40 INFO - [mozharness: 2017-04-12 04:48:40.108766Z] Running clobber step.
21:48:40 INFO - Running pre-action listener: _resource_record_pre_action
21:48:40 INFO - Running main action method: clobber
21:48:40 INFO - rmtree: /builds/slave/test/build
21:48:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
21:48:42 INFO - Running post-action listener: _resource_record_post_action
21:48:42 INFO - [mozharness: 2017-04-12 04:48:42.426538Z] Finished clobber step (success)
21:48:42 INFO - [mozharness: 2017-04-12 04:48:42.426738Z] Running read-buildbot-config step.
21:48:42 INFO - Running pre-action listener: _resource_record_pre_action
21:48:42 INFO - Running main action method: read_buildbot_config
21:48:42 INFO - Using buildbot properties:
21:48:42 INFO - {
21:48:42 INFO - "project": "",
21:48:42 INFO - "product": "firefox",
21:48:42 INFO - "script_repo_revision": "production",
21:48:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s",
21:48:42 INFO - "repository": "",
21:48:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s",
21:48:42 INFO - "buildid": "20170411201809",
21:48:42 INFO - "pgo_build": "False",
21:48:42 INFO - "basedir": "/builds/slave/test",
21:48:42 INFO - "buildnumber": 9,
21:48:42 INFO - "slavename": "t-yosemite-r7-0266",
21:48:42 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/",
21:48:42 INFO - "platform": "yosemite_r7",
21:48:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos",
21:48:42 INFO - "branch": "mozilla-central",
21:48:42 INFO - "repo_path": "mozilla-central",
21:48:42 INFO - "revision": "f40e24f40b4c4556944c762d4764eace261297f5",
21:48:42 INFO - "stage_platform": "macosx64",
21:48:42 INFO - "builduid": "0d8be032e19847518a63d8bbbbdcfe58",
21:48:42 INFO - "slavebuilddir": "test"
21:48:42 INFO - }
21:48:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg.
21:48:42 INFO - Running post-action listener: _resource_record_post_action
21:48:42 INFO - [mozharness: 2017-04-12 04:48:42.430019Z] Finished read-buildbot-config step (success)
21:48:42 INFO - [mozharness: 2017-04-12 04:48:42.430146Z] Running download-and-extract step.
21:48:42 INFO - Running pre-action listener: _resource_record_pre_action
21:48:42 INFO - Running main action method: download_and_extract
21:48:42 INFO - mkdir: /builds/slave/test/build/tests
21:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:48:42 INFO - trying https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json
21:48:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json
21:48:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1
21:48:43 INFO - Downloaded 1325 bytes.
21:48:43 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json
21:48:43 INFO - Using the following test package requirements:
21:48:43 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'],
21:48:43 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
21:48:43 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'],
21:48:43 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'],
21:48:43 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'jsshell-mac.zip'],
21:48:43 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'],
21:48:43 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
21:48:43 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'],
21:48:43 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'],
21:48:43 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'],
21:48:43 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
21:48:43 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']}
21:48:43 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common
21:48:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
21:48:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
21:48:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
21:48:45 INFO - Expected file size: 52596071
21:48:45 INFO - Obtained file size: 52596071
21:49:01 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos
21:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
21:49:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
21:49:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
21:49:03 INFO - Expected file size: 52596071
21:49:03 INFO - Obtained file size: 52596071
21:49:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip
21:49:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1
21:49:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory
21:49:20 INFO - Expected file size: 14405596
21:49:20 INFO - Obtained file size: 14405596
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:20 INFO - trying https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
21:49:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg
21:49:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1
21:49:22 INFO - Downloaded 70964126 bytes.
21:49:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
21:49:22 INFO - mkdir: /builds/slave/test/properties
21:49:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
21:49:22 INFO - Writing to file /builds/slave/test/properties/build_url
21:49:22 INFO - Contents:
21:49:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
21:49:23 INFO - Running post-action listener: _resource_record_post_action
21:49:23 INFO - Running post-action listener: set_extra_try_arguments
21:49:23 INFO - [mozharness: 2017-04-12 04:49:23.160556Z] Finished download-and-extract step (success)
21:49:23 INFO - [mozharness: 2017-04-12 04:49:23.160660Z] Running populate-webroot step.
21:49:23 INFO - Running pre-action listener: _resource_record_pre_action
21:49:23 INFO - Running main action method: populate_webroot
21:49:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
21:49:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
21:49:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
21:49:23 INFO - '--tppagecycles',
21:49:23 INFO - '7'],
21:49:23 INFO - 'tests': ['tsvgm']}},
21:49:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['tresize', 'tcanvasmark']},
21:49:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
21:49:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['dromaeo_css', 'kraken']},
21:49:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
21:49:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:49:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:49:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['damp', 'tps']},
21:49:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'tests': ['damp', 'tps']},
21:49:23 INFO - 'g3': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['dromaeo_dom']},
21:49:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
21:49:23 INFO - 'g4': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['basic_compositor_video']},
21:49:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
21:49:23 INFO - 'other': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'other-e10s': {'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'other-e10s_l64': {'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['a11yr',
21:49:23 INFO - 'ts_paint',
21:49:23 INFO - 'tpaint',
21:49:23 INFO - 'sessionrestore',
21:49:23 INFO - 'sessionrestore_no_auto_restore',
21:49:23 INFO - 'tabpaint']},
21:49:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['tsvgx',
21:49:23 INFO - 'tsvgr_opacity',
21:49:23 INFO - 'tart',
21:49:23 INFO - 'tscrollx',
21:49:23 INFO - 'cart',
21:49:23 INFO - 'tsvg_static']},
21:49:23 INFO - 'svgr-e10s': {'tests': ['tsvgx',
21:49:23 INFO - 'tsvgr_opacity',
21:49:23 INFO - 'tart',
21:49:23 INFO - 'tscrollx',
21:49:23 INFO - 'cart',
21:49:23 INFO - 'tsvg_static']},
21:49:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'talos_options': ['--disable-e10s'],
21:49:23 INFO - 'tests': ['tp5o']},
21:49:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
21:49:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'talos_options': ['--disable-e10s',
21:49:23 INFO - '--xperf_path',
21:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:49:23 INFO - 'tests': ['tp5n']},
21:49:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
21:49:23 INFO - 'talos_options': ['--xperf_path',
21:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:49:23 INFO - 'tests': ['tp5n']}},
21:49:23 INFO - 'talos.zip': {'path': '',
21:49:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
21:49:23 INFO - Running post-action listener: _resource_record_post_action
21:49:23 INFO - [mozharness: 2017-04-12 04:49:23.179193Z] Finished populate-webroot step (success)
21:49:23 INFO - [mozharness: 2017-04-12 04:49:23.179327Z] Running create-virtualenv step.
21:49:23 INFO - Running pre-action listener: _resource_record_pre_action
21:49:23 INFO - Running main action method: create_virtualenv
21:49:23 INFO - Creating virtualenv /builds/slave/test/build/venv
21:49:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
21:49:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
21:49:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
21:49:23 INFO - Using real prefix '/tools/python27'
21:49:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python
21:49:24 INFO - Installing distribute.............................................................................................................................................................................................done.
21:49:26 INFO - Installing pip.................done.
21:49:26 INFO - Return code: 0
21:49:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
21:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
21:49:27 INFO - Reading from file tmpfile_stdout
21:49:27 INFO - Output received:
21:49:27 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7)
21:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
21:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:27 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
21:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
21:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:27 INFO - 'HOME': '/Users/cltbld',
21:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:27 INFO - 'LOGNAME': 'cltbld',
21:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:27 INFO - 'MOZ_NO_REMOTE': '1',
21:49:27 INFO - 'NO_EM_RESTART': '1',
21:49:27 INFO - 'PAGER': '/bin/cat',
21:49:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:27 INFO - 'PWD': '/builds/slave/test',
21:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:27 INFO - 'SHELL': '/bin/bash',
21:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:27 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:27 INFO - 'USER': 'cltbld',
21:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:27 INFO - 'XPC_FLAGS': '0x0',
21:49:27 INFO - 'XPC_SERVICE_NAME': '0',
21:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg
21:49:27 INFO - Cleaning up...
21:49:27 INFO - Return code: 0
21:49:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
21:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:27 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:27 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
21:49:27 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
21:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:27 INFO - 'HOME': '/Users/cltbld',
21:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:27 INFO - 'LOGNAME': 'cltbld',
21:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:27 INFO - 'MOZ_NO_REMOTE': '1',
21:49:27 INFO - 'NO_EM_RESTART': '1',
21:49:27 INFO - 'PAGER': '/bin/cat',
21:49:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:27 INFO - 'PWD': '/builds/slave/test',
21:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:27 INFO - 'SHELL': '/bin/bash',
21:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:27 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:27 INFO - 'USER': 'cltbld',
21:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:27 INFO - 'XPC_FLAGS': '0x0',
21:49:27 INFO - 'XPC_SERVICE_NAME': '0',
21:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:27 INFO - Downloading/unpacking psutil>=3.1.1
21:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
21:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
21:49:31 INFO - Installing collected packages: psutil
21:49:31 INFO - Running setup.py install for psutil
21:49:31 INFO - building 'psutil._psutil_osx' extension
21:49:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o
21:49:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o
21:49:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o
21:49:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit
21:49:32 INFO - building 'psutil._psutil_posix' extension
21:49:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o
21:49:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration]
21:49:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr);
21:49:32 INFO - ^
21:49:32 INFO - 1 warning generated.
21:49:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so
21:49:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:49:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
21:49:32 INFO - Successfully installed psutil
21:49:32 INFO - Cleaning up...
21:49:32 INFO - Return code: 0
21:49:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
21:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:32 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:32 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
21:49:32 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
21:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:32 INFO - 'HOME': '/Users/cltbld',
21:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:32 INFO - 'LOGNAME': 'cltbld',
21:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:32 INFO - 'MOZ_NO_REMOTE': '1',
21:49:32 INFO - 'NO_EM_RESTART': '1',
21:49:32 INFO - 'PAGER': '/bin/cat',
21:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:32 INFO - 'PWD': '/builds/slave/test',
21:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:32 INFO - 'SHELL': '/bin/bash',
21:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:32 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:32 INFO - 'USER': 'cltbld',
21:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:32 INFO - 'XPC_FLAGS': '0x0',
21:49:32 INFO - 'XPC_SERVICE_NAME': '0',
21:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:32 INFO - Downloading/unpacking mozsystemmonitor==0.3
21:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz
21:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
21:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
21:49:35 INFO - Installing collected packages: mozsystemmonitor
21:49:35 INFO - Running setup.py install for mozsystemmonitor
21:49:35 INFO - Successfully installed mozsystemmonitor
21:49:35 INFO - Cleaning up...
21:49:35 INFO - Return code: 0
21:49:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:36 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:36 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
21:49:36 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
21:49:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:36 INFO - 'HOME': '/Users/cltbld',
21:49:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:36 INFO - 'LOGNAME': 'cltbld',
21:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:36 INFO - 'MOZ_NO_REMOTE': '1',
21:49:36 INFO - 'NO_EM_RESTART': '1',
21:49:36 INFO - 'PAGER': '/bin/cat',
21:49:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:36 INFO - 'PWD': '/builds/slave/test',
21:49:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:36 INFO - 'SHELL': '/bin/bash',
21:49:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:36 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:36 INFO - 'USER': 'cltbld',
21:49:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:36 INFO - 'XPC_FLAGS': '0x0',
21:49:36 INFO - 'XPC_SERVICE_NAME': '0',
21:49:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:36 INFO - Downloading/unpacking jsonschema==2.5.1
21:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
21:49:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
21:49: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
21:49: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
21:49: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
21:49: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
21:49: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
21:49: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
21:49:40 INFO - Downloading functools32-3.2.3-2.tar.gz
21:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
21:49:40 INFO - warning: no files found matching '*.txt'
21:49:40 INFO - no previously-included directories found matching 'build'
21:49:40 INFO - no previously-included directories found matching 'dist'
21:49:40 INFO - no previously-included directories found matching '.git*'
21:49:40 INFO - Installing collected packages: jsonschema, functools32
21:49:40 INFO - Running setup.py install for functools32
21:49:40 INFO - warning: no files found matching '*.txt'
21:49:40 INFO - no previously-included directories found matching 'build'
21:49:40 INFO - no previously-included directories found matching 'dist'
21:49:40 INFO - no previously-included directories found matching '.git*'
21:49:40 INFO - Successfully installed jsonschema functools32
21:49:40 INFO - Cleaning up...
21:49:40 INFO - Return code: 0
21:49:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
21:49:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:40 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:40 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', 'functools32==3.2.3-2'] in /builds/slave/test/build
21:49:40 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 functools32==3.2.3-2
21:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:40 INFO - 'HOME': '/Users/cltbld',
21:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:40 INFO - 'LOGNAME': 'cltbld',
21:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:40 INFO - 'MOZ_NO_REMOTE': '1',
21:49:40 INFO - 'NO_EM_RESTART': '1',
21:49:40 INFO - 'PAGER': '/bin/cat',
21:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:40 INFO - 'PWD': '/builds/slave/test',
21:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:40 INFO - 'SHELL': '/bin/bash',
21:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:40 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:40 INFO - 'USER': 'cltbld',
21:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:40 INFO - 'XPC_FLAGS': '0x0',
21:49:40 INFO - 'XPC_SERVICE_NAME': '0',
21:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
21:49:40 INFO - Cleaning up...
21:49:40 INFO - Return code: 0
21:49:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
21:49:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:40 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build
21:49:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
21:49:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:40 INFO - 'HOME': '/Users/cltbld',
21:49:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:40 INFO - 'LOGNAME': 'cltbld',
21:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:40 INFO - 'MOZ_NO_REMOTE': '1',
21:49:40 INFO - 'NO_EM_RESTART': '1',
21:49:40 INFO - 'PAGER': '/bin/cat',
21:49:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:40 INFO - 'PWD': '/builds/slave/test',
21:49:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:40 INFO - 'SHELL': '/bin/bash',
21:49:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:40 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:40 INFO - 'USER': 'cltbld',
21:49:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:40 INFO - 'XPC_FLAGS': '0x0',
21:49:40 INFO - 'XPC_SERVICE_NAME': '0',
21:49:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:40 INFO - Downloading/unpacking blobuploader==1.2.4
21:49: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
21:49: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
21:49: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
21:49: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
21:49: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
21:49: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
21:49:43 INFO - Downloading blobuploader-1.2.4.tar.gz
21:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
21:49:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
21:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
21:49:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
21:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:44 INFO - Downloading docopt-0.6.1.tar.gz
21:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
21:49:44 INFO - Installing collected packages: blobuploader, requests, docopt
21:49:44 INFO - Running setup.py install for blobuploader
21:49:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
21:49:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
21:49:45 INFO - Running setup.py install for requests
21:49:45 INFO - Running setup.py install for docopt
21:49:45 INFO - Successfully installed blobuploader requests docopt
21:49:45 INFO - Cleaning up...
21:49:45 INFO - Return code: 0
21:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:45 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
21:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:45 INFO - 'HOME': '/Users/cltbld',
21:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:45 INFO - 'LOGNAME': 'cltbld',
21:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:45 INFO - 'MOZ_NO_REMOTE': '1',
21:49:45 INFO - 'NO_EM_RESTART': '1',
21:49:45 INFO - 'PAGER': '/bin/cat',
21:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:45 INFO - 'PWD': '/builds/slave/test',
21:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:45 INFO - 'SHELL': '/bin/bash',
21:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:45 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:45 INFO - 'USER': 'cltbld',
21:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:45 INFO - 'XPC_FLAGS': '0x0',
21:49:45 INFO - 'XPC_SERVICE_NAME': '0',
21:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-HLL2iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-hiAFQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-U1GkjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-8CDP4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-WQWIHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-TxI9c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-f_PMEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-neZwWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-TC4DJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:49:46 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-3qIkLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-I_dvD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-LuNHd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-nyEfWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-IR0SY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-jY8JC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-1aDtQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:49:47 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-CUnK2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:49:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
21:49:47 INFO - Running setup.py install for manifestparser
21:49:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
21:49:47 INFO - Running setup.py install for mozcrash
21:49:48 INFO - Running setup.py install for mozdebug
21:49:48 INFO - Running setup.py install for mozdevice
21:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Running setup.py install for mozfile
21:49:48 INFO - Running setup.py install for mozhttpd
21:49:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Running setup.py install for mozinfo
21:49:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Running setup.py install for mozInstall
21:49:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
21:49:48 INFO - Running setup.py install for mozleak
21:49:49 INFO - Running setup.py install for mozlog
21:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Running setup.py install for moznetwork
21:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Running setup.py install for mozprocess
21:49:49 INFO - Running setup.py install for mozprofile
21:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Running setup.py install for mozrunner
21:49:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
21:49:49 INFO - Running setup.py install for mozscreenshot
21:49:50 INFO - Running setup.py install for moztest
21:49:50 INFO - Running setup.py install for mozversion
21:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
21:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
21:49:50 INFO - Cleaning up...
21:49:50 INFO - Return code: 0
21:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:50 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
21:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:50 INFO - 'HOME': '/Users/cltbld',
21:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:50 INFO - 'LOGNAME': 'cltbld',
21:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:50 INFO - 'MOZ_NO_REMOTE': '1',
21:49:50 INFO - 'NO_EM_RESTART': '1',
21:49:50 INFO - 'PAGER': '/bin/cat',
21:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:50 INFO - 'PWD': '/builds/slave/test',
21:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:50 INFO - 'SHELL': '/bin/bash',
21:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:50 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:50 INFO - 'USER': 'cltbld',
21:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:50 INFO - 'XPC_FLAGS': '0x0',
21:49:50 INFO - 'XPC_SERVICE_NAME': '0',
21:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:49:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-B0QI_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
21:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:49:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-JhvKNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:49:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-MfrK5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
21:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:49:50 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-TmFR6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-IDXk6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-yV0l0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-WDOtLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-jI3D9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-2cNtRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-CeJSnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-P6bDMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-KU7qbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:49:51 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-E53PfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
21:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:49:52 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-Xk668M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
21:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:49:52 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-pIEmvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
21:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:49:52 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-5zFajx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
21:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:49:52 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-pITa7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
21:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
21:49:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:49:52 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
21:49:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
21:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:49:55 INFO - Downloading blessings-1.6.tar.gz
21:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
21:49:55 INFO - Installing collected packages: blessings
21:49:55 INFO - Running setup.py install for blessings
21:49:55 INFO - Successfully installed blessings
21:49:55 INFO - Cleaning up...
21:49:55 INFO - Return code: 0
21:49:55 INFO - Done creating virtualenv /builds/slave/test/build/venv.
21:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:49:55 INFO - Reading from file tmpfile_stdout
21:49:55 INFO - Current package versions:
21:49:55 INFO - blessings == 1.6
21:49:55 INFO - blobuploader == 1.2.4
21:49:55 INFO - docopt == 0.6.1
21:49:55 INFO - functools32 == 3.2.3-2
21:49:55 INFO - jsonschema == 2.5.1
21:49:55 INFO - manifestparser == 1.1
21:49:55 INFO - mozInstall == 1.12
21:49:55 INFO - mozcrash == 1.0
21:49:55 INFO - mozdebug == 0.1
21:49:55 INFO - mozdevice == 0.50
21:49:55 INFO - mozfile == 1.2
21:49:55 INFO - mozhttpd == 0.7
21:49:55 INFO - mozinfo == 0.9
21:49:55 INFO - mozleak == 0.1
21:49:55 INFO - mozlog == 3.4
21:49:55 INFO - moznetwork == 0.27
21:49:55 INFO - mozprocess == 0.25
21:49:55 INFO - mozprofile == 0.28
21:49:55 INFO - mozrunner == 6.13
21:49:55 INFO - mozscreenshot == 0.1
21:49:55 INFO - mozsystemmonitor == 0.3
21:49:55 INFO - moztest == 0.8
21:49:55 INFO - mozversion == 1.4
21:49:55 INFO - psutil == 3.1.1
21:49:55 INFO - requests == 1.2.3
21:49:55 INFO - wsgiref == 0.1.2
21:49:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:55 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos
21:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
21:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:55 INFO - 'HOME': '/Users/cltbld',
21:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:55 INFO - 'LOGNAME': 'cltbld',
21:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:55 INFO - 'MOZ_NO_REMOTE': '1',
21:49:55 INFO - 'NO_EM_RESTART': '1',
21:49:55 INFO - 'PAGER': '/bin/cat',
21:49:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:55 INFO - 'PWD': '/builds/slave/test',
21:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:55 INFO - 'SHELL': '/bin/bash',
21:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:55 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:55 INFO - 'USER': 'cltbld',
21:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:55 INFO - 'XPC_FLAGS': '0x0',
21:49:55 INFO - 'XPC_SERVICE_NAME': '0',
21:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
21:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
21:49:55 INFO - Cleaning up...
21:49:55 INFO - Return code: 0
21:49:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:49:55 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 0x108aabb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aae768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bfb470af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1
21:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build
21:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
21:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:49:56 INFO - 'HOME': '/Users/cltbld',
21:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:49:56 INFO - 'LOGNAME': 'cltbld',
21:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:49:56 INFO - 'MOZ_NO_REMOTE': '1',
21:49:56 INFO - 'NO_EM_RESTART': '1',
21:49:56 INFO - 'PAGER': '/bin/cat',
21:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:49:56 INFO - 'PWD': '/builds/slave/test',
21:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:49:56 INFO - 'SHELL': '/bin/bash',
21:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:49:56 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:49:56 INFO - 'USER': 'cltbld',
21:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:49:56 INFO - 'XPC_FLAGS': '0x0',
21:49:56 INFO - 'XPC_SERVICE_NAME': '0',
21:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:49:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
21:49:56 INFO - Cleaning up...
21:49:56 INFO - Return code: 0
21:49:56 INFO - Running post-action listener: _resource_record_post_action
21:49:56 INFO - Running post-action listener: _start_resource_monitoring
21:49:56 INFO - Starting resource monitoring.
21:49:56 INFO - [mozharness: 2017-04-12 04:49:56.288059Z] Finished create-virtualenv step (success)
21:49:56 INFO - [mozharness: 2017-04-12 04:49:56.289008Z] Running install step.
21:49:56 INFO - Running pre-action listener: _resource_record_pre_action
21:49:56 INFO - Running main action method: install
21:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:49:56 INFO - Reading from file tmpfile_stdout
21:49:56 INFO - Detecting whether we're running mozinstall >=1.0...
21:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
21:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
21:49:56 INFO - Reading from file tmpfile_stdout
21:49:56 INFO - Output received:
21:49:56 INFO - Usage: mozinstall [options] installer
21:49:56 INFO - Options:
21:49:56 INFO - -h, --help show this help message and exit
21:49:56 INFO - -d DEST, --destination=DEST
21:49:56 INFO - Directory to install application into. [default:
21:49:56 INFO - "/builds/slave/test"]
21:49:56 INFO - --app=APP Application being installed. [default: firefox]
21:49:56 INFO - mkdir: /builds/slave/test/build/application
21:49:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application']
21:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application
21:50:16 INFO - Reading from file tmpfile_stdout
21:50:16 INFO - Output received:
21:50:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox
21:50:16 INFO - Running post-action listener: _resource_record_post_action
21:50:16 INFO - [mozharness: 2017-04-12 04:50:16.948027Z] Finished install step (success)
21:50:16 INFO - [mozharness: 2017-04-12 04:50:16.948163Z] Running run-tests step.
21:50:16 INFO - Running pre-action listener: _resource_record_pre_action
21:50:16 INFO - Running main action method: run_tests
21:50:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
21:50:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
21:50:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
21:50:16 INFO - 2017-04-11 21:50:16.962 screenresolution[1629:7368] starting screenresolution argv=screenresolution get
21:50:16 INFO - 2017-04-11 21:50:16.965 screenresolution[1629:7368] Display 0: 1600x1200x32@60
21:50:16 INFO - 2017-04-11 21:50:16.971 screenresolution[1630:7370] starting screenresolution argv=screenresolution list
21:50:16 INFO - Available Modes on Display 0
21:50:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
21:50:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
21:50:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
21:50:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
21:50:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
21:50:17 INFO - Intel Iris:
21:50:17 INFO - Chipset Model: Intel Iris
21:50:17 INFO - Type: GPU
21:50:17 INFO - Bus: Built-In
21:50:17 INFO - VRAM (Dynamic, Max): 1536 MB
21:50:17 INFO - Vendor: Intel (0x8086)
21:50:17 INFO - Device ID: 0x0a2e
21:50:17 INFO - Revision ID: 0x0009
21:50:17 INFO - Displays:
21:50:17 INFO - Display:
21:50:17 INFO - Resolution: 1600 x 1200 @ 60 Hz
21:50:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
21:50:17 INFO - Display Serial Number: 1600x1200 60
21:50:17 INFO - Main Display: Yes
21:50:17 INFO - Mirror: Off
21:50:17 INFO - Online: Yes
21:50:17 INFO - Rotation: Supported
21:50:17 INFO - Return code: 0
21:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
21:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
21:50:17 INFO - Python 2.7.3
21:50:17 INFO - Return code: 0
21:50:17 INFO - grabbing minidump binary from tooltool
21:50:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:50:17 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/macosx64/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 0x108889d30>, '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 0x1087b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10887ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
21:50:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build
21:50:17 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/macosx64/releng.manifest -o -c /builds/tooltool_cache
21:50:17 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600
21:50:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
21:50:17 INFO - Return code: 0
21:50:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755
21:50:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
21:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
21:50:17 INFO - ENV: RUST_BACKTRACE is now 1
21:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk
21:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
21:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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
21:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0266 --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
21:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IJAXQbEFYD/Render',
21:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
21:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
21:50:17 INFO - 'HOME': '/Users/cltbld',
21:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
21:50:17 INFO - 'LOGNAME': 'cltbld',
21:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
21:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk',
21:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:50:17 INFO - 'MOZ_NO_REMOTE': '1',
21:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
21:50:17 INFO - 'NO_EM_RESTART': '1',
21:50:17 INFO - 'PAGER': '/bin/cat',
21:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
21:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:50:17 INFO - 'PWD': '/builds/slave/test',
21:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
21:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
21:50:17 INFO - 'RUST_BACKTRACE': '1',
21:50:17 INFO - 'SHELL': '/bin/bash',
21:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners',
21:50:17 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/',
21:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
21:50:17 INFO - 'USER': 'cltbld',
21:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
21:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
21:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:50:17 INFO - 'XPC_FLAGS': '0x0',
21:50:17 INFO - 'XPC_SERVICE_NAME': '0',
21:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
21:50:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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
21:50:17 INFO - mozversion application_buildid: 20170411201809
21:50:17 INFO - mozversion application_changeset: f40e24f40b4c4556944c762d4764eace261297f5
21:50:17 INFO - mozversion application_display_name: Nightly
21:50:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
21:50:17 INFO - mozversion application_name: Firefox
21:50:17 INFO - mozversion application_remotingname: firefox
21:50:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
21:50:17 INFO - mozversion application_vendor: Mozilla
21:50:17 INFO - mozversion application_version: 55.0a1
21:50:17 INFO - mozversion platform_buildid: 20170411201809
21:50:17 INFO - mozversion platform_changeset: f40e24f40b4c4556944c762d4764eace261297f5
21:50:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
21:50:17 INFO - mozversion platform_version: 55.0a1
21:50:17 INFO - using testdate: 1491972617
21:50:17 INFO - actual date: 1491972617
21:50:17 INFO - starting webserver on 'localhost:49238'
21:50:17 INFO - SUITE-START | Running 2 tests
21:50:17 INFO - TEST-START | dromaeo_css
21:50:17 INFO - operating with platform_type : mac_
21:50:17 INFO - Initialising browser for dromaeo_css test...
21:50:17 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpYPGV4A/profile http://localhost:49238/getInfo.html)
21:50:20 INFO - PID 1640 | 2017-04-11 21:50:20.514 plugin-container[1642:7545] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname'
21:50:20 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes.
21:50:20 INFO - PID 1640 | 2017-04-11 21:50:20.516 plugin-container[1642:7545] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient'
21:50:20 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes.
21:50:20 INFO - PID 1640 | 2017-04-11 21:50:20.516 plugin-container[1642:7545] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
21:50:20 INFO - PID 1640 | __metrics Screen width/height:1600/1200
21:50:20 INFO - PID 1640 | colorDepth:24
21:50:20 INFO - PID 1640 | Browser inner width/height: 1024/689
21:50:20 INFO - PID 1640 | __metrics
21:50:20 ERROR - PID 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined
21:50:21 INFO - TEST-INFO | 1640: exit 0
21:50:21 INFO - Browser initialized.
21:50:21 INFO - Running cycle 1/1 for dromaeo_css test...
21:50:21 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpYPGV4A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:50:24 INFO - PID 1643 | 2017-04-11 21:50:24.374 plugin-container[1644:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname'
21:50:24 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes.
21:50:24 INFO - PID 1643 | 2017-04-11 21:50:24.377 plugin-container[1644:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient'
21:50:24 INFO - PID 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes.
21:50:24 INFO - PID 1643 | 2017-04-11 21:50:24.377 plugin-container[1644:7673] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
21:50:34 INFO - PID 1643 | RSS: Main: 234926080
21:50:34 INFO - PID 1643 |
21:53:37 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html)
21:53:39 INFO - PID 1643 | RSS: Main: 255172608
21:53:39 INFO - PID 1643 |
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task.
21:55:22 INFO - PID 1643 |
21:55:22 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource.
21:55:22 INFO - PID 1643 | Full stack:
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task.
21:55:22 INFO - PID 1643 |
21:55:22 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource.
21:55:22 INFO - PID 1643 | Full stack:
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task.
21:55:22 INFO - PID 1643 |
21:55:22 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource.
21:55:22 INFO - PID 1643 | Full stack:
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | *************************
21:55:22 INFO - PID 1643 | A coding exception was thrown and uncaught in a Task.
21:55:22 INFO - PID 1643 |
21:55:22 ERROR - PID 1643 | Full message: TypeError: NetworkError when attempting to fetch resource.
21:55:22 INFO - PID 1643 | Full stack:
21:55:22 INFO - PID 1643 | *************************
21:56:41 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html)
21:56:42 INFO - PID 1643 | RSS: Main: 266297344
21:56:42 INFO - PID 1643 |
21:59:43 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html)
21:59:44 INFO - PID 1643 | RSS: Main: 277389312
21:59:44 INFO - PID 1643 |
22:02:46 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html)
22:02:46 INFO - PID 1643 | RSS: Main: 269762560
22:02:46 INFO - PID 1643 |
22:05:49 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html)
22:05:50 INFO - PID 1643 | RSS: Main: 279937024
22:05:50 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html)
22:08:52 INFO - PID 1643 | RSS: Main: 273580032
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | __start_tp_report
22:08:52 INFO - PID 1643 | _x_x_mozilla_page_load
22:08:52 INFO - PID 1643 | _x_x_mozilla_page_load_details
22:08:52 INFO - PID 1643 | |i|pagename|runs|
22:08:52 INFO - PID 1643 | |0;dojo.html;3030.2727345437097;3556.164301389175;3571.6071232164463;3613.2412193439377;3633.5094762207095;6070.453659170674;6182.938170618292;6244.46922011629;6272.717727702253;6351.428371446569;6096.375503402309;6098.008671753297;6111.236095488064;6212.565120441571;6241.375862413756;5323.547498462635;5416.945830541703;5430.456954304557;5490.6431081979745;5514.80698175564;5379.946200538003;5437.510624043835;5514.310711161105;5523.696196709179;5523.861903452405;5452.236686863842;5456.699881506535;5495.587830912657;5501.380310222237;5518.779248830042;5268.92096618551;5341.03861304965;5342.171963345688;5349.090654588729;5366.114591092465;4670.8365207217585;5339.492748188916;5376.623636345457;5401.000814849265;5403.162509810985;5274.55166310864;6181.134641150197;6189.9381006189815;6292.842678933018;6304.621722696653;5706.144078388275;6352.523560732963;6438.034294855763;6676.632785196813;6680;6662.20053593567;6754.527183097185;6759.7296108155615;6763.188417389944;6782.457403407716;5257.947420525746;6303.338149494283;6352.396522330371;6353.205849268841;6367.108604795332;6567.573107747981;6768.932310676831;6899.517033807686;6906.930930690729;6914.308569143146;6289.119523266746;6376.936230637727;6455.225372955276;6506.056621789814;6509.088727578142;5637.9718101409235;6481.222253329631;6578.309277525791;6709.429698475684;6736.865262694719;5588.497035266845;6515.022746587955;6590.275069742324;6611.702473388709;6652.600843949282;6338.492920566344;6407.775727849503;6627.370399812106;6653.135092437952;6672.332766723289;5257.553107985787;5263.973680131651;5272.156454967187;5281.234221037928;5289.365276166807;4682.41469816273;4725.763711814396;4736.550027747358;4738.691985020962;4761.4524329701835;6152.815415537541;6343.936560634427;6347.301796802348;6348.269948955929;6358.904616430757;6407.295197528269;6669.599824010575;6688.966555167193;6718.764843230463;6767.627780472121;6254.437100660963;6270.341614130451;6311.558190926683;6355.968220158869;6359.332270111571;5914.201582786355;5915.142304365929;5916.083007133901;5921.911171332434;5924.792632257937;6778.8644227116165;6825.761098361533;6861.348171923659;6866;6913.3777959983845;6421.614703117828;6530.542861999805;6623.867522649616;6707.698153583003;6725.327467253235;6845.247022827385;6872.965635171792;6877.415419689382;6894.586324820527;6900.6204658742245;6590.406863382319;6620.635865027277;6635.568688035262;6640.701168447528;6657.866842663217;6004.309504407049;6351.523635727246;6612.966935165294;6682;6698.631575263407;6494.935050649433;6514.869702605826;6520.152380190545;6533;6543.1821022372205;6249.875002500015;6270;6492.285848556749;6498.902516462163;6515.6742162892615;5424.864378390572;6343.619382837044;6363.077353783768;6369.9681501592195;6388.105665206967;5045.722485263199;5407.513323800877;6537.8692426152165;6544.44372228366;6565.409113179646;5482.917756233739;6320.209973753281;6383.7127329271225;6384.904226436514;6389.904151437825
22:08:52 INFO - PID 1643 | |1;ext.html;744.9702011919524;795.8885755994162;826.5949684654519;1176.9819106472903;1249.0507214516977;33778.99999999997;35768.82115589421;38745.22509549807;38764.80617596912;38768.22463550727;38106.8094659527;38301.61698383015;38491.42262866059;38500;38588.26352814123;7740.916271721963;8134.186581341848;8277.420580559363;8575.828483430327;8849.867251991225;8686.609102590366;8812.8678069829;8815.471071735685;8817;8825.940887093559;8765.430247033953;8804.64781408743;8820.382573219877;8850.73447796564;8859.069797671249;8760.561971901412;8790.64837406503;8793.472391656522;8798.384113112084;8824.382293239443;8565.700200493015;8602.225799678059;8608.655653773842;8631.956840215758;8651.95674021626;29631.962881299267;37170;37366.43950340747;37433.62566374329;37443;3648.1791596890753;3685.4840322354894;3688.520492336006;3691.2063906260014;3695.9260814783825;30724.078277651704;30920;30929.536056959165;30942.53586196209;30981.070567882998;3144.9056528304186;3198.088544764731;3205.871765129392;3213.469777486712;3229.3056992746674;219262;224324.8783756087;255458;275294.6235268811;277003;47778.04443911102;47841.282380764314;48158.518414816106;48175;48199;49524.75237623789;49664.0067198654;49730.0053998918;49958.50041499611;50062.499375005784;14136;14233.359498822578;14366.281685915663;14366.85633143676;14372.712545749026;11677.416129193507;11759.176857619885;11867.821982670266;11871.228370155912;11901.642950711492;13305.467781288833;13337.666558335924;13355.53255636048;13377.531786387624;13463.730725385438;5907.202527658797;5920.911186332209;5929.466348028698;5942.643441393444;6019.337872833985;943.2265542255285;1042.2287507244737;1045.2004216774174;1074.8065348237235;1095.9506822192861;20944.162233510488;24099.638505422434;24237.394065148514;24399;24453.144139955017;1021.7088129883097;1078.7518870659792;1145.6448500964727;1174.2308787744041;1182.6274723462082;12209.389530523438;12361.925031099625;12402.317872517098;12437.440315185657;12483.93886519656;332204;332510;333519;334339;334433;53111.73444132755;53280;53546;53569;53638;1529.8852586055868;1564.1944398634712;1567.4748959098602;1571.4028669105896;1581.1777875504672;20869.895650521652;23030.42423939415;23417.648735269326;23746.287611371685;23859.284221473383;31660.5250921241;33046.66953330436;37782.2443551133;38172.85481435561;38180.427293590066;306002;306663;307135;307315;313407;33857.66142338545;34281.31437371189;34882.47676284807;35008.649913500536;35070.298594028485;44600.43898463538;45261;45368.77315613401;45444.545554544035;45880;30259;30279.394412112077;31083.378332433676;31107.844460777553;31244.375112498077;30179.396412072074;30241.69758302477;30522.236944076576;31022.379552408373;31204.531932020585;36946.63053369432;37015.074623134635;37068.25863482661;37110;37171.44242836306;24973.625395618717;30008.79964801471;30275.243118922204;31033.758649653762;31221.53167702441;24520.93488313961;24591.508169836146;24651.50696986086;24785.876070620252;25049.749502504743
22:08:52 INFO - PID 1643 | |2;jquery.html;422.8773655639865;436.45007290813567;438.38018521562816;448.49320268097046;448.96183824374924;19885.304014359517;21328.253511127095;21897.233596824113;21914;22088.570257271687;21694.457638559044;23091.538169236606;23190.3042908713;23248.302550923458;23509.647355289686;6219.471344935686;6282.434580887731;6494.415502604765;6531.314212007742;6545.738170473175;6233.438990490855;6358.078078678589;6409.487241020731;6431.581947173442;6453.322401147882;4890.828820991266;5517.2551705519645;5853.414658534134;6318.652474113922;6406.583572067824;5431.8098866539485;6342.4926005919415;6414.422701956823;6418.582792118497;6421.550491465599;5615.0454422748235;5624.128260119688;5703.173039909231;5704.087346024658;5704.743286552115;26864;26915.86542067277;26947.461050778875;27044.053458129067;27167.864160679266;2229.8996545155505;2295.3228797504607;2296.368498662881;2300.0454811253308;2307.180950762472;17888.195031223495;17942.551436214068;18013.099345032697;18439.815601843944;18593;2167.783221677835;2194.5830292244423;2238.563480121377;2244.730632324115;2245.6182448983714;129682;134243.32878335644;135215.999999999;136055.31972340174;136076.27847442994;10847.75250846147;12325.198862073936;12673;12693.555725549746;12741.55404560836;16029.679406411806;16333.836661633231;16472.4234651789;16522.173891305385;16572.005679659258;7094.787156385317;8833.69082082124;9051.185393314634;9054.094590541024;9173.954130229306;7037.4018208451835;7090.958153852254;8727.167294868148;8744.69393571222;8751.343649226334;7875.960620196863;7993.9607850979;8055.597220139087;8064.935324576741;8069.256452806074;2163.5889181055863;2166.1118941234017;2171.8045375916245;2178.7385513738454;2190.539986602799;893.446063440671;1002.7057138309737;1018.9949050254701;1025.646152077532;1070.1545778834789;19314.903425482782;20586.558940874296;20922;25484.362890927874;27256;1012.5443550402348;1019.2966852871494;1021.7088129882948;1045.4406892312577;1047.7328281288223;9010.189082982562;10808.62169824068;11212.439378031066;11226.438678066064;11369.488373023234;685556;694925;707943;724046;724844;151735.24132379267;153175;156416;157526;159163;1202.9939850300693;1204.903607711381;1260.9936950315373;1264.393091316155;1270.5870592057618;17334.82665173332;20729.68905466389;21154.894225528773;21672.458188545414;22027.559448810614;57574.7121264391;58506;58741.82516349564;59164.112538312824;59633.701831490565;81014;81377.59311203405;81421;83196.58401708194;83583.16416835754;7665.540067595962;8698.869516957124;8718.084601117045;8820.911790882266;9025.548722563713;10253.436061016715;11095.445227738743;11427.942860285977;14265.64335891611;14310.427582896567;11653.53385864556;11731.765364692488;11836.46735896904;12093.637190884288;12134.211276267015;9663.661771837951;9705.757356066155;10863.130949524177;11112.444377781241;11334.716632083933;11430.314181149157;11772.823407649063;12115.757684846078;12253.203541769757;12254.693632659255;8741.956290218763;8746.431481953652;8788.956055219684;9025.232855207381;9135.132162444557;11638;11787.528498859949;12013.219140756173;12115.454804533994;12163.817542737042
22:08:52 INFO - PID 1643 | |3;mootools.html;1374.2785037855124;1460.2260801775062;1468.1044562816687;1471.587955372496;1486.191098823224;11083.833742493858;11575.073994080474;11602.419879006047;11819.40902954851;12264.93867530661;11734;11947.940260298708;11982.221155624879;11987.460564274606;11998.640040798768;2493.164789795421;2534.4550921551863;2540.479201763634;2543.898244070235;2544.0459827564664;2400.987995060022;2420.165043060141;2425.4542727886173;2427.1141033522727;2441.694788151481;2454.2514533067406;2461.520003599299;2478.4423504711385;2492.314613481289;2494.950100997979;2423.9757602423924;2424.4544977380037;2443.2548072837776;2457.0663148003823;2476.2447453526665;1915.8850468971907;2431.8540887546806;2454.828162028659;2455.9877200613882;2496.737842526527;10843.295185812896;11034.668959931134;11830.822537661941;11938.343391113485;11951.581694640732;6488.416042556192;6685.465162787014;6740.12378390806;6740.1237839081095;6755.831104222385;4015.3976903464422;4250.617444430016;4324.135172965388;4338.826446942118;4375.5405682403525;1163.6567212672282;1174.8531433570804;1203.1758245601704;1205.2226314027491;1209.842720446345;13058.934705326508;14914.925425372912;15810.13044282564;15974.201289935456;16127.193640318055;5467.371252305956;5573.108302671553;5703.486686198179;5788.131780232915;5812.041013232853;10294.588216471408;12262.938685306695;12353.135280530276;12365.443555039865;12373.93813030929;6173.536984726074;6478.125453063871;6538.0192971053775;6538.574992625464;6544.934550654528;6026.12117071511;6051.939480605226;6175.413335733188;6227.470664993526;6257.186565746424;4310.030243195319;4419.1382680377665;4457.442819647544;4475.910481790411;4506;1141.2809929744208;1257.3838818978634;1281.564268148834;1296.0817989375776;1297.1892567145535;742.7140550887839;783.8158032862273;791.4855344026429;825.5542007316102;826.0954255090666;5428.728563571805;6134.662593557308;6234.657093859791;6283.59156654816;6359.682015899187;588.3351812451901;588.6850534963773;594.180031556458;608.6256951974592;615.3354377272535;3704.592494825567;4160.54234034256;4294.720843145248;4407.184670835905;4422.845200418034;14668.339924703414;14880.776788348183;14948;15329.770053449207;15366.231688415535;12506.936910362721;15159.848401516065;15309.617259568377;15322.080675159303;15387.538373848802;10889.292196007234;10930.836037459445;10958;10970.670879873616;11079.058280046125;5780.306363236438;6576.309487503934;6694.765683201064;6803.7618683345845;6859.416949559343;13253.602391928258;13280.867191327963;13296.534621288209;13341.799873001719;13571.457141714222;11840.75672054422;13722.382492788049;13858.376373063034;13982.650433739238;14021.29893505341;8678.566071696263;8732.039475657799;8775.385722999328;8779.385443018928;8799.868001979847;10509.579616815241;10607.4165920872;10717.892821072;10726.570937162425;10762.46187690628;7611.733589324347;8006.439549231498;9011;9110.772230694285;9181.540922953693;8846.690365837165;8861.822763544822;8982.101789820965;8994.775130621787;9012.729618111467;6512.5766825156215;8086.070101938352;8113.553754543556;8209.917900820916;8256.504609723435;5821.388754180919;6007.12896629995;6018.337982821974;6122.632642041492;6190.845228869314;6074.210352654127;6128.111423843607;6203.0075187969705;6291.339409361951;6322.36776322364
22:08:52 INFO - PID 1643 | |4;prototype.html;392.8899908025753;402.86392373506703;403.9050823056579;405.61871840469956;410.97739624320667;6078.513718902488;6221.351341894401;6239.469645080162;6256.781012664557;6258.968705156473;4781.904361912769;4951.900961980758;5830.766769329232;6088.634681919088;6116.44951954324;4044.9483134384977;4107.404426358176;4279.679024073192;4313.340346084237;4689.57793798558;3939.1333906540517;4076.7769669099152;4551.431071116111;4642.767861606923;4748.596369308613;4567.246404343296;4587.151416634872;4591.471980722226;4671.976640116812;4679.415073115861;4209.0529630833125;4517.435320584927;4626.560476754703;4628.953710462886;4661.184292748772;3610.422332426799;4139.606737359946;4140.399642051916;4171.457710497646;4200.096979149467;5099.903520743021;5457.372402173761;5474.591179880839;5514.042514907191;5829.941700582982;4585.518520555327;4616.976915115437;5529.198266251411;5532.640378375393;5541.476094074122;6230.470410015154;6450.419462248373;6494.512911531607;6498;6535.091884111573;3952.9209415811524;4539.364488971547;4663.580277774982;4683.672142949995;4732.574068333866;5429.321334833146;6146.231721034871;6356.103627564098;6794.218664853555;6849.520533562652;4439.001224724476;4665.650076244296;4770.833020844254;4823.421189457287;4865.854024379274;4203.76879271643;4926.743680361485;4950.975245123824;4955.653104282737;4955.752212389366;4899.3385892904;5314.548263397654;5484.561235101182;5544.889102217933;5581.6930068845795;5363.356397232357;6231.940570103094;6234.812955611339;6501.024846273097;6593.406593406617;1425.2374979386186;1636.35364031207;1676.8574671152844;1710.7938903073552;1714.9657006859793;997.7954519323521;1149.8332741752567;1177.1465687376583;1179.151011271883;1181.7931861924128;5305.840824775263;5458.533831017253;5540.445955404427;6220.688965551704;6246.219222597176;5423.864403389947;6202.255729312421;6772.255051944282;6786.117804685359;6814.454843612499;6116.235470566179;6173.69131543421;6221.2845522764555;6252.718627661675;6261.96869015652;2832.937648381857;3529.3823580873245;3549.432090865449;3549.6450354964295;3553.271579326232;5659.349174844946;6037.034074548052;6533.901991470132;7043.225245223021;7056.400205982549;6037.63774173551;6127.325994140641;7055.506114572034;7064.293570642894;7084.610346430893;6151.738893526726;6421.839454013687;6474.6762661866715;6776.76281330161;7008.579485230801;5371.328583927009;6123.755049797958;6126.509879209563;6730.562513436611;6776.833081895452;5537.169424586184;6391.616503009835;6611.570247934062;6644.60132392058;6651.567648102858;5182.274481572658;6260.280067792262;6536.379043990813;6794.966025169842;6936.098307220029;4418.873187337208;4425.82296708141;4429.468463784237;4452.30989196675;4466.285394336891;6606.273309935999;6653.767118150841;6711.46308295345;6759.831004224934;6771.6614169292325;5606.635568688022;6104.69476526163;6458.580192287486;6581;6587.571807832475;5913.704314784158;6533.705983230861;6534.281229064894;6558.606483610999;6814.250432452525;5361.35663720356;6340.461060809883;6409;6430;6464.773732919325;6588.769393071219;6598.538102332791;6599.373059559334;6600.471962243105;6609.339066093352;5567.526760225426;5960.109346966804;6137.539684523589;6140.263168419819;6416.197975253093
22:08:52 INFO - PID 1643 | |5;yui.html;781.3046388714043;822.404535201709;834.1783343406747;862.693743720979;875.6234819027818;14007.299635018258;14592.197429141394;16517.256723447445;16903.577410564743;17124.65750684987;16869.819112662117;17342.132893355345;17504.949703017795;17632.64734705305;17841;976.4092723902044;982.6855406269997;984.6110786239467;985.7042887133867;988.298308201178;874.7725591346264;966.9806603867919;997.1922742578498;1001.8346972749524;1004.4324956399647;1034.3897100710578;1037.2946396450411;1037.4605205293242;1037.9931466477506;1038.3458421194637;1025.220832167558;1029.8455231715227;1030.4023666273542;1032.8450732390127;1040.7294103533097;757.6249756370631;759.4531937005403;760.2701406649624;761.7372006657695;767.6545554500497;16276.26756795947;16887.915560422243;17030.914845425817;17126.657466850593;17137.314507419687;15784.447544336008;16228.675426491522;16238.431654892021;16409.097499637515;16477.67044659112;13089.803652945213;13409.798853017115;13551.322433878366;13551.39018744149;13566.186028838203;3346.0965539304493;3371.2920286739813;3384.5769278840144;3446.190145315849;3546.85812567497;81032;97704;106293.46853265761;108715.45642271738;109387;13094.476220951055;13489.527866524624;13492.93253533726;13505.392257348443;13563.525276615272;24138.39654008664;24549.754502455104;25020.624690629655;25038.874805625856;25047.248582542554;7308.990027742413;7585.355244804254;8592;8915;8988.280937525113;4821.132196204647;4928.6303527235605;4930.6795058321095;4934.309196712463;4941.332920055818;4374.737515749065;4829.444613869379;4837.467878533358;4870.4155501340065;4888.046830868017;946.9337146399823;974.5273542331963;979.480875136179;994.9154321882721;995.4425521707722;637.6492928889093;648.5492582655104;649.5972497051858;652.8106849013733;667.2693400726197;10311.381317120848;11210.327380357205;11817.350045747395;11942.283462992249;11994.220375675553;622.8069298517474;644.3105876711874;656.8456412743002;663.3234101216732;665.3944910131756;5498.945010549924;5517.972410137923;5633.267675202197;5649.6327738696855;5737.397573254748;88462;97523.51238243764;98980.51529227068;107125.4643726792;107369;63382.09853704396;78453;79601.80597291046;79874.60062699765;82357;58853;63213.419664507834;63275.6836215816;63944.36055639477;64392.03411948824;11598.826017609912;12115.697107572028;12155.270683759003;12175.452104655134;12290.754184916073;37554.436683450316;37618.623813761515;37807;37883.67407140737;38394.42408363933;48426.75786621044;48825.75587122042;48873.75563122162;48906;49529.50470495249;15689.607759806097;15759.448419305269;16106.27521761547;16686.16335222991;16886.324547017983;17636.294548217928;18171.273149073888;18225;18599.44201673898;18609.976451295308;16194.109323986822;16882.24029918632;17047.659046818746;17126.571835704206;17193.742093868852;16293.022418654919;16588.170591470138;16629.83370166283;16840.831591683927;16899.66200675955;16133.75799362987;16213.756793647868;16266.755998659793;16451;16598.502044938672;11696.70758231017;11941.044716422839;11971.341576213392;12073;12116.818247726467;11279.266847654877;12740.299283539494;12753;12857;13064.21614703083
22:08:52 INFO - PID 1643 | __end_tp_report
22:08:52 INFO - PID 1643 | __start_cc_report
22:08:52 INFO - PID 1643 | _x_x_mozilla_cycle_collect,435
22:08:52 INFO - PID 1643 | __end_cc_report
22:08:52 INFO - PID 1643 | __startTimestamp1491973732404__endTimestamp
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | ------- Summary: start -------
22:08:52 INFO - PID 1643 | Number of tests: 6
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#0] dojo.html Cycles:165 Average:6080.33 Median:6351.43 stddev:737.40 (11.6%) stddev-sans-first:699.77
22:08:52 INFO - PID 1643 | Values: 3030.3 3556.2 3571.6 3613.2 3633.5 6070.5 6182.9 6244.5 6272.7 6351.4 6096.4 6098.0 6111.2 6212.6 6241.4 5323.5 5416.9 5430.5 5490.6 5514.8 5379.9 5437.5 5514.3 5523.7 5523.9 5452.2 5456.7 5495.6 5501.4 5518.8 5268.9 5341.0 5342.2 5349.1 5366.1 4670.8 5339.5 5376.6 5401.0 5403.2 5274.6 6181.1 6189.9 6292.8 6304.6 5706.1 6352.5 6438.0 6676.6 6680.0 6662.2 6754.5 6759.7 6763.2 6782.5 5257.9 6303.3 6352.4 6353.2 6367.1 6567.6 6768.9 6899.5 6906.9 6914.3 6289.1 6376.9 6455.2 6506.1 6509.1 5638.0 6481.2 6578.3 6709.4 6736.9 5588.5 6515.0 6590.3 6611.7 6652.6 6338.5 6407.8 6627.4 6653.1 6672.3 5257.6 5264.0 5272.2 5281.2 5289.4 4682.4 4725.8 4736.6 4738.7 4761.5 6152.8 6343.9 6347.3 6348.3 6358.9 6407.3 6669.6 6689.0 6718.8 6767.6 6254.4 6270.3 6311.6 6356.0 6359.3 5914.2 5915.1 5916.1 5921.9 5924.8 6778.9 6825.8 6861.3 6866.0 6913.4 6421.6 6530.5 6623.9 6707.7 6725.3 6845.2 6873.0 6877.4 6894.6 6900.6 6590.4 6620.6 6635.6 6640.7 6657.9 6004.3 6351.5 6613.0 6682.0 6698.6 6494.9 6514.9 6520.2 6533.0 6543.2 6249.9 6270.0 6492.3 6498.9 6515.7 5424.9 6343.6 6363.1 6370.0 6388.1 5045.7 5407.5 6537.9 6544.4 6565.4 5482.9 6320.2 6383.7 6384.9 6389.9
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#1] ext.html Cycles:180 Average:44805.94 Median:333014.50 stddev:78622.04 (23.6%) stddev-sans-first:78773.00
22:08:52 INFO - PID 1643 | Values: 745.0 795.9 826.6 1177.0 1249.1 33779.0 35768.8 38745.2 38764.8 38768.2 38106.8 38301.6 38491.4 38500.0 38588.3 7740.9 8134.2 8277.4 8575.8 8849.9 8686.6 8812.9 8815.5 8817.0 8825.9 8765.4 8804.6 8820.4 8850.7 8859.1 8760.6 8790.6 8793.5 8798.4 8824.4 8565.7 8602.2 8608.7 8632.0 8652.0 29632.0 37170.0 37366.4 37433.6 37443.0 3648.2 3685.5 3688.5 3691.2 3695.9 30724.1 30920.0 30929.5 30942.5 30981.1 3144.9 3198.1 3205.9 3213.5 3229.3 219262.0 224324.9 255458.0 275294.6 277003.0 47778.0 47841.3 48158.5 48175.0 48199.0 49524.8 49664.0 49730.0 49958.5 50062.5 14136.0 14233.4 14366.3 14366.9 14372.7 11677.4 11759.2 11867.8 11871.2 11901.6 13305.5 13337.7 13355.5 13377.5 13463.7 5907.2 5920.9 5929.5 5942.6 6019.3 943.2 1042.2 1045.2 1074.8 1096.0 20944.2 24099.6 24237.4 24399.0 24453.1 1021.7 1078.8 1145.6 1174.2 1182.6 12209.4 12361.9 12402.3 12437.4 12483.9 332204.0 332510.0 333519.0 334339.0 334433.0 53111.7 53280.0 53546.0 53569.0 53638.0 1529.9 1564.2 1567.5 1571.4 1581.2 20869.9 23030.4 23417.6 23746.3 23859.3 31660.5 33046.7 37782.2 38172.9 38180.4 306002.0 306663.0 307135.0 307315.0 313407.0 33857.7 34281.3 34882.5 35008.6 35070.3 44600.4 45261.0 45368.8 45444.5 45880.0 30259.0 30279.4 31083.4 31107.8 31244.4 30179.4 30241.7 30522.2 31022.4 31204.5 36946.6 37015.1 37068.3 37110.0 37171.4 24973.6 30008.8 30275.2 31033.8 31221.5 24520.9 24591.5 24651.5 24785.9 25049.7
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#2] jquery.html Cycles:180 Average:40333.81 Median:2270.47 stddev:118110.43 (5202.0%) stddev-sans-first:118403.74
22:08:52 INFO - PID 1643 | Values: 422.9 436.5 438.4 448.5 449.0 19885.3 21328.3 21897.2 21914.0 22088.6 21694.5 23091.5 23190.3 23248.3 23509.6 6219.5 6282.4 6494.4 6531.3 6545.7 6233.4 6358.1 6409.5 6431.6 6453.3 4890.8 5517.3 5853.4 6318.7 6406.6 5431.8 6342.5 6414.4 6418.6 6421.6 5615.0 5624.1 5703.2 5704.1 5704.7 26864.0 26915.9 26947.5 27044.1 27167.9 2229.9 2295.3 2296.4 2300.0 2307.2 17888.2 17942.6 18013.1 18439.8 18593.0 2167.8 2194.6 2238.6 2244.7 2245.6 129682.0 134243.3 135216.0 136055.3 136076.3 10847.8 12325.2 12673.0 12693.6 12741.6 16029.7 16333.8 16472.4 16522.2 16572.0 7094.8 8833.7 9051.2 9054.1 9174.0 7037.4 7091.0 8727.2 8744.7 8751.3 7876.0 7994.0 8055.6 8064.9 8069.3 2163.6 2166.1 2171.8 2178.7 2190.5 893.4 1002.7 1019.0 1025.6 1070.2 19314.9 20586.6 20922.0 25484.4 27256.0 1012.5 1019.3 1021.7 1045.4 1047.7 9010.2 10808.6 11212.4 11226.4 11369.5 685556.0 694925.0 707943.0 724046.0 724844.0 151735.2 153175.0 156416.0 157526.0 159163.0 1203.0 1204.9 1261.0 1264.4 1270.6 17334.8 20729.7 21154.9 21672.5 22027.6 57574.7 58506.0 58741.8 59164.1 59633.7 81014.0 81377.6 81421.0 83196.6 83583.2 7665.5 8698.9 8718.1 8820.9 9025.5 10253.4 11095.4 11427.9 14265.6 14310.4 11653.5 11731.8 11836.5 12093.6 12134.2 9663.7 9705.8 10863.1 11112.4 11334.7 11430.3 11772.8 12115.8 12253.2 12254.7 8742.0 8746.4 8789.0 9025.2 9135.1 11638.0 11787.5 12013.2 12115.5 12163.8
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#3] mootools.html Cycles:180 Average:7078.04 Median:2515.60 stddev:4476.80 (178.0%) stddev-sans-first:4468.84
22:08:52 INFO - PID 1643 | Values: 1374.3 1460.2 1468.1 1471.6 1486.2 11083.8 11575.1 11602.4 11819.4 12264.9 11734.0 11947.9 11982.2 11987.5 11998.6 2493.2 2534.5 2540.5 2543.9 2544.0 2401.0 2420.2 2425.5 2427.1 2441.7 2454.3 2461.5 2478.4 2492.3 2495.0 2424.0 2424.5 2443.3 2457.1 2476.2 1915.9 2431.9 2454.8 2456.0 2496.7 10843.3 11034.7 11830.8 11938.3 11951.6 6488.4 6685.5 6740.1 6740.1 6755.8 4015.4 4250.6 4324.1 4338.8 4375.5 1163.7 1174.9 1203.2 1205.2 1209.8 13058.9 14914.9 15810.1 15974.2 16127.2 5467.4 5573.1 5703.5 5788.1 5812.0 10294.6 12262.9 12353.1 12365.4 12373.9 6173.5 6478.1 6538.0 6538.6 6544.9 6026.1 6051.9 6175.4 6227.5 6257.2 4310.0 4419.1 4457.4 4475.9 4506.0 1141.3 1257.4 1281.6 1296.1 1297.2 742.7 783.8 791.5 825.6 826.1 5428.7 6134.7 6234.7 6283.6 6359.7 588.3 588.7 594.2 608.6 615.3 3704.6 4160.5 4294.7 4407.2 4422.8 14668.3 14880.8 14948.0 15329.8 15366.2 12506.9 15159.8 15309.6 15322.1 15387.5 10889.3 10930.8 10958.0 10970.7 11079.1 5780.3 6576.3 6694.8 6803.8 6859.4 13253.6 13280.9 13296.5 13341.8 13571.5 11840.8 13722.4 13858.4 13982.7 14021.3 8678.6 8732.0 8775.4 8779.4 8799.9 10509.6 10607.4 10717.9 10726.6 10762.5 7611.7 8006.4 9011.0 9110.8 9181.5 8846.7 8861.8 8982.1 8994.8 9012.7 6512.6 8086.1 8113.6 8209.9 8256.5 5821.4 6007.1 6018.3 6122.6 6190.8 6074.2 6128.1 6203.0 6291.3 6322.4
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#4] prototype.html Cycles:180 Average:5247.58 Median:5594.16 stddev:1588.07 (28.4%) stddev-sans-first:1550.16
22:08:52 INFO - PID 1643 | Values: 392.9 402.9 403.9 405.6 411.0 6078.5 6221.4 6239.5 6256.8 6259.0 4781.9 4951.9 5830.8 6088.6 6116.4 4044.9 4107.4 4279.7 4313.3 4689.6 3939.1 4076.8 4551.4 4642.8 4748.6 4567.2 4587.2 4591.5 4672.0 4679.4 4209.1 4517.4 4626.6 4629.0 4661.2 3610.4 4139.6 4140.4 4171.5 4200.1 5099.9 5457.4 5474.6 5514.0 5829.9 4585.5 4617.0 5529.2 5532.6 5541.5 6230.5 6450.4 6494.5 6498.0 6535.1 3952.9 4539.4 4663.6 4683.7 4732.6 5429.3 6146.2 6356.1 6794.2 6849.5 4439.0 4665.7 4770.8 4823.4 4865.9 4203.8 4926.7 4951.0 4955.7 4955.8 4899.3 5314.5 5484.6 5544.9 5581.7 5363.4 6231.9 6234.8 6501.0 6593.4 1425.2 1636.4 1676.9 1710.8 1715.0 997.8 1149.8 1177.1 1179.2 1181.8 5305.8 5458.5 5540.4 6220.7 6246.2 5423.9 6202.3 6772.3 6786.1 6814.5 6116.2 6173.7 6221.3 6252.7 6262.0 2832.9 3529.4 3549.4 3549.6 3553.3 5659.3 6037.0 6533.9 7043.2 7056.4 6037.6 6127.3 7055.5 7064.3 7084.6 6151.7 6421.8 6474.7 6776.8 7008.6 5371.3 6123.8 6126.5 6730.6 6776.8 5537.2 6391.6 6611.6 6644.6 6651.6 5182.3 6260.3 6536.4 6795.0 6936.1 4418.9 4425.8 4429.5 4452.3 4466.3 6606.3 6653.8 6711.5 6759.8 6771.7 5606.6 6104.7 6458.6 6581.0 6587.6 5913.7 6533.7 6534.3 6558.6 6814.3 5361.4 6340.5 6409.0 6430.0 6464.8 6588.8 6598.5 6599.4 6600.5 6609.3 5567.5 5960.1 6137.5 6140.3 6416.2
22:08:52 INFO - PID 1643 |
22:08:52 INFO - PID 1643 | [#5] yui.html Cycles:180 Average:19777.80 Median:18604.71 stddev:25963.80 (139.6%) stddev-sans-first:25997.45
22:08:52 INFO - PID 1643 | Values: 781.3 822.4 834.2 862.7 875.6 14007.3 14592.2 16517.3 16903.6 17124.7 16869.8 17342.1 17504.9 17632.6 17841.0 976.4 982.7 984.6 985.7 988.3 874.8 967.0 997.2 1001.8 1004.4 1034.4 1037.3 1037.5 1038.0 1038.3 1025.2 1029.8 1030.4 1032.8 1040.7 757.6 759.5 760.3 761.7 767.7 16276.3 16887.9 17030.9 17126.7 17137.3 15784.4 16228.7 16238.4 16409.1 16477.7 13089.8 13409.8 13551.3 13551.4 13566.2 3346.1 3371.3 3384.6 3446.2 3546.9 81032.0 97704.0 106293.5 108715.5 109387.0 13094.5 13489.5 13492.9 13505.4 13563.5 24138.4 24549.8 25020.6 25038.9 25047.2 7309.0 7585.4 8592.0 8915.0 8988.3 4821.1 4928.6 4930.7 4934.3 4941.3 4374.7 4829.4 4837.5 4870.4 4888.0 946.9 974.5 979.5 994.9 995.4 637.6 648.5 649.6 652.8 667.3 10311.4 11210.3 11817.4 11942.3 11994.2 622.8 644.3 656.8 663.3 665.4 5498.9 5518.0 5633.3 5649.6 5737.4 88462.0 97523.5 98980.5 107125.5 107369.0 63382.1 78453.0 79601.8 79874.6 82357.0 58853.0 63213.4 63275.7 63944.4 64392.0 11598.8 12115.7 12155.3 12175.5 12290.8 37554.4 37618.6 37807.0 37883.7 38394.4 48426.8 48825.8 48873.8 48906.0 49529.5 15689.6 15759.4 16106.3 16686.2 16886.3 17636.3 18171.3 18225.0 18599.4 18610.0 16194.1 16882.2 17047.7 17126.6 17193.7 16293.0 16588.2 16629.8 16840.8 16899.7 16133.8 16213.8 16266.8 16451.0 16598.5 11696.7 11941.0 11971.3 12073.0 12116.8 11279.3 12740.3 12753.0 12857.0 13064.2
22:08:52 INFO - PID 1643 | -------- Summary: end --------
22:08:52 INFO - PID 1643 |
22:08:53 INFO - TEST-INFO | 1643: exit 0
22:08:53 INFO - TEST-OK | dromaeo_css | took 1115489ms
22:08:53 INFO - TEST-START | kraken
22:08:53 INFO - operating with platform_type : mac_
22:08:53 INFO - Initialising browser for kraken test...
22:08:53 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpm980WA/profile http://localhost:49238/getInfo.html)
22:08:56 INFO - PID 1654 | 2017-04-11 22:08:56.200 plugin-container[1655:10077] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.tsm.portname'
22:08:56 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes.
22:08:56 INFO - PID 1654 | 2017-04-11 22:08:56.204 plugin-container[1655:10077] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient'
22:08:56 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes.
22:08:56 INFO - PID 1654 | 2017-04-11 22:08:56.204 plugin-container[1655:10077] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
22:08:56 INFO - PID 1654 | __metrics Screen width/height:1600/1200
22:08:56 INFO - PID 1654 | colorDepth:24
22:08:56 INFO - PID 1654 | Browser inner width/height: 1024/689
22:08:56 INFO - PID 1654 | __metrics
22:08:56 ERROR - PID 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined
22:08:57 INFO - TEST-INFO | 1654: exit 0
22:08:57 INFO - Browser initialized.
22:08:57 INFO - Running cycle 1/1 for kraken test...
22:08:57 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpm980WA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
22:08:59 INFO - PID 1656 | 2017-04-11 22:08:59.963 plugin-container[1657:10209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4f, name = 'com.apple.tsm.portname'
22:08:59 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes.
22:08:59 INFO - PID 1656 | 2017-04-11 22:08:59.964 plugin-container[1657:10209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient'
22:08:59 INFO - PID 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes.
22:08:59 INFO - PID 1656 | 2017-04-11 22:08:59.964 plugin-container[1657:10209] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
22:09:09 INFO - PID 1656 | RSS: Main: 235261952
22:09:09 INFO - PID 1656 |
22:09:12 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection)
22:09:13 INFO - PID 1656 | RSS: Main: 250068992
22:09:13 INFO - PID 1656 |
22:09:16 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft)
22:09:16 INFO - PID 1656 | RSS: Main: 258633728
22:09:16 INFO - PID 1656 |
22:09:20 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft)
22:09:21 INFO - PID 1656 | RSS: Main: 260714496
22:09:21 INFO - PID 1656 |
22:09:23 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator)
22:09:23 INFO - PID 1656 | RSS: Main: 262897664
22:09:23 INFO - PID 1656 |
22:09:26 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur)
22:09:26 INFO - PID 1656 | RSS: Main: 263229440
22:09:26 INFO - PID 1656 |
22:09:29 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom)
22:09:30 INFO - PID 1656 | RSS: Main: 269000704
22:09:30 INFO - PID 1656 |
22:09:33 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate)
22:09:33 INFO - PID 1656 | RSS: Main: 269152256
22:09:33 INFO - PID 1656 |
22:09:37 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial)
22:09:38 INFO - PID 1656 | RSS: Main: 269422592
22:09:38 INFO - PID 1656 |
22:09:39 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox)
22:09:40 INFO - PID 1656 | RSS: Main: 269021184
22:09:40 INFO - PID 1656 |
22:09:42 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes)
22:09:42 INFO - PID 1656 | RSS: Main: 269004800
22:09:42 INFO - PID 1656 |
22:09:44 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm)
22:09:45 INFO - PID 1656 | RSS: Main: 268988416
22:09:45 INFO - PID 1656 |
22:09:48 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
22:09:49 INFO - PID 1656 | RSS: Main: 269324288
22:09:49 INFO - PID 1656 |
22:09:52 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
22:09:53 INFO - PID 1656 | RSS: Main: 266706944
22:09:53 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar)
22:09:55 INFO - PID 1656 | RSS: Main: 270077952
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | __start_tp_report
22:09:55 INFO - PID 1656 | _x_x_mozilla_page_load
22:09:55 INFO - PID 1656 | _x_x_mozilla_page_load_details
22:09:55 INFO - PID 1656 | |i|pagename|runs|
22:09:55 INFO - PID 1656 | |0;ai-astar;111;124;113;121;120;124;122;145;125;127
22:09:55 INFO - PID 1656 | |1;audio-beat-detection;150;123;143;163;115;116;117;120;133;111
22:09:55 INFO - PID 1656 | |2;audio-dft;220;226;226;228;222;242;301;271;226;292
22:09:55 INFO - PID 1656 | |3;audio-fft;80;67;88;120;84;68;61;63;75;64
22:09:55 INFO - PID 1656 | |4;audio-oscillator;91;74;87;82;110;105;86;73;74;86
22:09:55 INFO - PID 1656 | |5;imaging-gaussian-blur;94;92;94;94;94;93;94;92;93;94
22:09:55 INFO - PID 1656 | |6;imaging-darkroom;102;101;101;100;100;110;102;100;101;99
22:09:55 INFO - PID 1656 | |7;imaging-desaturate;146;129;104;103;102;99;161;128;101;157
22:09:55 INFO - PID 1656 | |8;json-parse-financial;52;49;51;52;52;54;51;52;52;52
22:09:55 INFO - PID 1656 | |9;json-stringify-tinderbox;66;85;91;92;67;61;60;60;62;60
22:09:55 INFO - PID 1656 | |10;stanford-crypto-aes;87;88;88;89;88;87;100;88;77;76
22:09:55 INFO - PID 1656 | |11;stanford-crypto-ccm;147;146;160;156;165;168;170;154;282;168
22:09:55 INFO - PID 1656 | |12;stanford-crypto-pbkdf2;215;249;208;219;246;204;196;197;193;194
22:09:55 INFO - PID 1656 | |13;stanford-crypto-sha256-iterative;72;71;73;72;68;101;84;70;69;72
22:09:55 INFO - PID 1656 | __end_tp_report
22:09:55 INFO - PID 1656 | __start_cc_report
22:09:55 INFO - PID 1656 | _x_x_mozilla_cycle_collect,1018
22:09:55 INFO - PID 1656 | __end_cc_report
22:09:55 INFO - PID 1656 | __startTimestamp1491973795698__endTimestamp
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | ------- Summary: start -------
22:09:55 INFO - PID 1656 | Number of tests: 14
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#0] ai-astar Cycles:10 Average:123.20 Median:124.00 stddev:9.21 (7.4%) stddev-sans-first:8.65
22:09:55 INFO - PID 1656 | Values: 111.0 124.0 113.0 121.0 120.0 124.0 122.0 145.0 125.0 127.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:128.00 stddev:17.51 (13.7%) stddev-sans-first:16.86
22:09:55 INFO - PID 1656 | Values: 150.0 123.0 143.0 163.0 115.0 116.0 117.0 120.0 133.0 111.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#2] audio-dft Cycles:10 Average:245.40 Median:235.00 stddev:30.83 (13.1%) stddev-sans-first:31.30
22:09:55 INFO - PID 1656 | Values: 220.0 226.0 226.0 228.0 222.0 242.0 301.0 271.0 226.0 292.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#3] audio-fft Cycles:10 Average:77.00 Median:71.50 stddev:17.75 (24.8%) stddev-sans-first:18.79
22:09:55 INFO - PID 1656 | Values: 80.0 67.0 88.0 120.0 84.0 68.0 61.0 63.0 75.0 64.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:84.00 stddev:12.60 (15.0%) stddev-sans-first:13.28
22:09:55 INFO - PID 1656 | Values: 91.0 74.0 87.0 82.0 110.0 105.0 86.0 73.0 74.0 86.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:94.00 stddev:0.84 (0.9%) stddev-sans-first:0.87
22:09:55 INFO - PID 1656 | Values: 94.0 92.0 94.0 94.0 94.0 93.0 94.0 92.0 93.0 94.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#6] imaging-darkroom Cycles:10 Average:101.60 Median:101.50 stddev:3.10 (3.1%) stddev-sans-first:3.28
22:09:55 INFO - PID 1656 | Values: 102.0 101.0 101.0 100.0 100.0 110.0 102.0 100.0 101.0 99.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#7] imaging-desaturate Cycles:10 Average:123.00 Median:137.50 stddev:24.61 (17.9%) stddev-sans-first:24.66
22:09:55 INFO - PID 1656 | Values: 146.0 129.0 104.0 103.0 102.0 99.0 161.0 128.0 101.0 157.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:1.25 (2.4%) stddev-sans-first:1.32
22:09:55 INFO - PID 1656 | Values: 52.0 49.0 51.0 52.0 52.0 54.0 51.0 52.0 52.0 52.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:66.50 stddev:13.41 (20.2%) stddev-sans-first:14.13
22:09:55 INFO - PID 1656 | Values: 66.0 85.0 91.0 92.0 67.0 61.0 60.0 60.0 62.0 60.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:88.00 stddev:6.65 (7.6%) stddev-sans-first:7.05
22:09:55 INFO - PID 1656 | Values: 87.0 88.0 88.0 89.0 88.0 87.0 100.0 88.0 77.0 76.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:171.60 Median:166.50 stddev:39.73 (23.9%) stddev-sans-first:41.13
22:09:55 INFO - PID 1656 | Values: 147.0 146.0 160.0 156.0 165.0 168.0 170.0 154.0 282.0 168.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.10 Median:211.50 stddev:20.63 (9.8%) stddev-sans-first:21.85
22:09:55 INFO - PID 1656 | Values: 215.0 249.0 208.0 219.0 246.0 204.0 196.0 197.0 193.0 194.0
22:09:55 INFO - PID 1656 |
22:09:55 INFO - PID 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:72.00 stddev:10.08 (14.0%) stddev-sans-first:10.62
22:09:55 INFO - PID 1656 | Values: 72.0 71.0 73.0 72.0 68.0 101.0 84.0 70.0 69.0 72.0
22:09:55 INFO - PID 1656 | -------- Summary: end --------
22:09:55 INFO - PID 1656 |
22:09:56 INFO - TEST-INFO | 1656: exit 0
22:09:56 INFO - TEST-OK | kraken | took 63713ms
22:09:56 INFO - SUITE-END | took 1179s
22:09:56 INFO - Completed test suite (00:19:39)
22:09:56 INFO - javascript benchmark
22:09:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7848.3351165125905, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3030.2727345437097, 3556.164301389175, 3571.6071232164463, 3613.2412193439377, 3633.5094762207095, 6070.453659170674, 6182.938170618292, 6244.46922011629, 6272.717727702253, 6351.428371446569, 6096.375503402309, 6098.008671753297, 6111.236095488064, 6212.565120441571, 6241.375862413756, 5323.547498462635, 5416.945830541703, 5430.456954304557, 5490.6431081979745, 5514.80698175564, 5379.946200538003, 5437.510624043835, 5514.310711161105, 5523.696196709179, 5523.861903452405, 5452.236686863842, 5456.699881506535, 5495.587830912657, 5501.380310222237, 5518.779248830042, 5268.92096618551, 5341.03861304965, 5342.171963345688, 5349.090654588729, 5366.114591092465, 4670.8365207217585, 5339.492748188916, 5376.623636345457, 5401.000814849265, 5403.162509810985, 5274.55166310864, 6181.134641150197, 6189.9381006189815, 6292.842678933018, 6304.621722696653, 5706.144078388275, 6352.523560732963, 6438.034294855763, 6676.632785196813, 6680.0, 6662.20053593567, 6754.527183097185, 6759.7296108155615, 6763.188417389944, 6782.457403407716, 5257.947420525746, 6303.338149494283, 6352.396522330371, 6353.205849268841, 6367.108604795332, 6567.573107747981, 6768.932310676831, 6899.517033807686, 6906.930930690729, 6914.308569143146, 6289.119523266746, 6376.936230637727, 6455.225372955276, 6506.056621789814, 6509.088727578142, 5637.9718101409235, 6481.222253329631, 6578.309277525791, 6709.429698475684, 6736.865262694719, 5588.497035266845, 6515.022746587955, 6590.275069742324, 6611.702473388709, 6652.600843949282, 6338.492920566344, 6407.775727849503, 6627.370399812106, 6653.135092437952, 6672.332766723289, 5257.553107985787, 5263.973680131651, 5272.156454967187, 5281.234221037928, 5289.365276166807, 4682.41469816273, 4725.763711814396, 4736.550027747358, 4738.691985020962, 4761.4524329701835, 6152.815415537541, 6343.936560634427, 6347.301796802348, 6348.269948955929, 6358.904616430757, 6407.295197528269, 6669.599824010575, 6688.966555167193, 6718.764843230463, 6767.627780472121, 6254.437100660963, 6270.341614130451, 6311.558190926683, 6355.968220158869, 6359.332270111571, 5914.201582786355, 5915.142304365929, 5916.083007133901, 5921.911171332434, 5924.792632257937, 6778.8644227116165, 6825.761098361533, 6861.348171923659, 6866.0, 6913.3777959983845, 6421.614703117828, 6530.542861999805, 6623.867522649616, 6707.698153583003, 6725.327467253235, 6845.247022827385, 6872.965635171792, 6877.415419689382, 6894.586324820527, 6900.6204658742245, 6590.406863382319, 6620.635865027277, 6635.568688035262, 6640.701168447528, 6657.866842663217, 6004.309504407049, 6351.523635727246, 6612.966935165294, 6682.0, 6698.631575263407, 6494.935050649433, 6514.869702605826, 6520.152380190545, 6533.0, 6543.1821022372205, 6249.875002500015, 6270.0, 6492.285848556749, 6498.902516462163, 6515.6742162892615, 5424.864378390572, 6343.619382837044, 6363.077353783768, 6369.9681501592195, 6388.105665206967, 5045.722485263199, 5407.513323800877, 6537.8692426152165, 6544.44372228366, 6565.409113179646, 5482.917756233739, 6320.209973753281, 6383.7127329271225, 6384.904226436514, 6389.904151437825], "value": 6032.630683024069, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.9702011919524, 795.8885755994162, 826.5949684654519, 1176.9819106472903, 1249.0507214516977, 33778.99999999997, 35768.82115589421, 38745.22509549807, 38764.80617596912, 38768.22463550727, 38106.8094659527, 38301.61698383015, 38491.42262866059, 38500.0, 38588.26352814123, 7740.916271721963, 8134.186581341848, 8277.420580559363, 8575.828483430327, 8849.867251991225, 8686.609102590366, 8812.8678069829, 8815.471071735685, 8817.0, 8825.940887093559, 8765.430247033953, 8804.64781408743, 8820.382573219877, 8850.73447796564, 8859.069797671249, 8760.561971901412, 8790.64837406503, 8793.472391656522, 8798.384113112084, 8824.382293239443, 8565.700200493015, 8602.225799678059, 8608.655653773842, 8631.956840215758, 8651.95674021626, 29631.962881299267, 37170.0, 37366.43950340747, 37433.62566374329, 37443.0, 3648.1791596890753, 3685.4840322354894, 3688.520492336006, 3691.2063906260014, 3695.9260814783825, 30724.078277651704, 30920.0, 30929.536056959165, 30942.53586196209, 30981.070567882998, 3144.9056528304186, 3198.088544764731, 3205.871765129392, 3213.469777486712, 3229.3056992746674, 219262.0, 224324.8783756087, 255458.0, 275294.6235268811, 277003.0, 47778.04443911102, 47841.282380764314, 48158.518414816106, 48175.0, 48199.0, 49524.75237623789, 49664.0067198654, 49730.0053998918, 49958.50041499611, 50062.499375005784, 14136.0, 14233.359498822578, 14366.281685915663, 14366.85633143676, 14372.712545749026, 11677.416129193507, 11759.176857619885, 11867.821982670266, 11871.228370155912, 11901.642950711492, 13305.467781288833, 13337.666558335924, 13355.53255636048, 13377.531786387624, 13463.730725385438, 5907.202527658797, 5920.911186332209, 5929.466348028698, 5942.643441393444, 6019.337872833985, 943.2265542255285, 1042.2287507244737, 1045.2004216774174, 1074.8065348237235, 1095.9506822192861, 20944.162233510488, 24099.638505422434, 24237.394065148514, 24399.0, 24453.144139955017, 1021.7088129883097, 1078.7518870659792, 1145.6448500964727, 1174.2308787744041, 1182.6274723462082, 12209.389530523438, 12361.925031099625, 12402.317872517098, 12437.440315185657, 12483.93886519656, 332204.0, 332510.0, 333519.0, 334339.0, 334433.0, 53111.73444132755, 53280.0, 53546.0, 53569.0, 53638.0, 1529.8852586055868, 1564.1944398634712, 1567.4748959098602, 1571.4028669105896, 1581.1777875504672, 20869.895650521652, 23030.42423939415, 23417.648735269326, 23746.287611371685, 23859.284221473383, 31660.5250921241, 33046.66953330436, 37782.2443551133, 38172.85481435561, 38180.427293590066, 306002.0, 306663.0, 307135.0, 307315.0, 313407.0, 33857.66142338545, 34281.31437371189, 34882.47676284807, 35008.649913500536, 35070.298594028485, 44600.43898463538, 45261.0, 45368.77315613401, 45444.545554544035, 45880.0, 30259.0, 30279.394412112077, 31083.378332433676, 31107.844460777553, 31244.375112498077, 30179.396412072074, 30241.69758302477, 30522.236944076576, 31022.379552408373, 31204.531932020585, 36946.63053369432, 37015.074623134635, 37068.25863482661, 37110.0, 37171.44242836306, 24973.625395618717, 30008.79964801471, 30275.243118922204, 31033.758649653762, 31221.53167702441, 24520.93488313961, 24591.508169836146, 24651.50696986086, 24785.876070620252, 25049.749502504743], "value": 17589.577916483995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8773655639865, 436.45007290813567, 438.38018521562816, 448.49320268097046, 448.96183824374924, 19885.304014359517, 21328.253511127095, 21897.233596824113, 21914.0, 22088.570257271687, 21694.457638559044, 23091.538169236606, 23190.3042908713, 23248.302550923458, 23509.647355289686, 6219.471344935686, 6282.434580887731, 6494.415502604765, 6531.314212007742, 6545.738170473175, 6233.438990490855, 6358.078078678589, 6409.487241020731, 6431.581947173442, 6453.322401147882, 4890.828820991266, 5517.2551705519645, 5853.414658534134, 6318.652474113922, 6406.583572067824, 5431.8098866539485, 6342.4926005919415, 6414.422701956823, 6418.582792118497, 6421.550491465599, 5615.0454422748235, 5624.128260119688, 5703.173039909231, 5704.087346024658, 5704.743286552115, 26864.0, 26915.86542067277, 26947.461050778875, 27044.053458129067, 27167.864160679266, 2229.8996545155505, 2295.3228797504607, 2296.368498662881, 2300.0454811253308, 2307.180950762472, 17888.195031223495, 17942.551436214068, 18013.099345032697, 18439.815601843944, 18593.0, 2167.783221677835, 2194.5830292244423, 2238.563480121377, 2244.730632324115, 2245.6182448983714, 129682.0, 134243.32878335644, 135215.999999999, 136055.31972340174, 136076.27847442994, 10847.75250846147, 12325.198862073936, 12673.0, 12693.555725549746, 12741.55404560836, 16029.679406411806, 16333.836661633231, 16472.4234651789, 16522.173891305385, 16572.005679659258, 7094.787156385317, 8833.69082082124, 9051.185393314634, 9054.094590541024, 9173.954130229306, 7037.4018208451835, 7090.958153852254, 8727.167294868148, 8744.69393571222, 8751.343649226334, 7875.960620196863, 7993.9607850979, 8055.597220139087, 8064.935324576741, 8069.256452806074, 2163.5889181055863, 2166.1118941234017, 2171.8045375916245, 2178.7385513738454, 2190.539986602799, 893.446063440671, 1002.7057138309737, 1018.9949050254701, 1025.646152077532, 1070.1545778834789, 19314.903425482782, 20586.558940874296, 20922.0, 25484.362890927874, 27256.0, 1012.5443550402348, 1019.2966852871494, 1021.7088129882948, 1045.4406892312577, 1047.7328281288223, 9010.189082982562, 10808.62169824068, 11212.439378031066, 11226.438678066064, 11369.488373023234, 685556.0, 694925.0, 707943.0, 724046.0, 724844.0, 151735.24132379267, 153175.0, 156416.0, 157526.0, 159163.0, 1202.9939850300693, 1204.903607711381, 1260.9936950315373, 1264.393091316155, 1270.5870592057618, 17334.82665173332, 20729.68905466389, 21154.894225528773, 21672.458188545414, 22027.559448810614, 57574.7121264391, 58506.0, 58741.82516349564, 59164.112538312824, 59633.701831490565, 81014.0, 81377.59311203405, 81421.0, 83196.58401708194, 83583.16416835754, 7665.540067595962, 8698.869516957124, 8718.084601117045, 8820.911790882266, 9025.548722563713, 10253.436061016715, 11095.445227738743, 11427.942860285977, 14265.64335891611, 14310.427582896567, 11653.53385864556, 11731.765364692488, 11836.46735896904, 12093.637190884288, 12134.211276267015, 9663.661771837951, 9705.757356066155, 10863.130949524177, 11112.444377781241, 11334.716632083933, 11430.314181149157, 11772.823407649063, 12115.757684846078, 12253.203541769757, 12254.693632659255, 8741.956290218763, 8746.431481953652, 8788.956055219684, 9025.232855207381, 9135.132162444557, 11638.0, 11787.528498859949, 12013.219140756173, 12115.454804533994, 12163.817542737042], "value": 10609.873525813913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.2785037855124, 1460.2260801775062, 1468.1044562816687, 1471.587955372496, 1486.191098823224, 11083.833742493858, 11575.073994080474, 11602.419879006047, 11819.40902954851, 12264.93867530661, 11734.0, 11947.940260298708, 11982.221155624879, 11987.460564274606, 11998.640040798768, 2493.164789795421, 2534.4550921551863, 2540.479201763634, 2543.898244070235, 2544.0459827564664, 2400.987995060022, 2420.165043060141, 2425.4542727886173, 2427.1141033522727, 2441.694788151481, 2454.2514533067406, 2461.520003599299, 2478.4423504711385, 2492.314613481289, 2494.950100997979, 2423.9757602423924, 2424.4544977380037, 2443.2548072837776, 2457.0663148003823, 2476.2447453526665, 1915.8850468971907, 2431.8540887546806, 2454.828162028659, 2455.9877200613882, 2496.737842526527, 10843.295185812896, 11034.668959931134, 11830.822537661941, 11938.343391113485, 11951.581694640732, 6488.416042556192, 6685.465162787014, 6740.12378390806, 6740.1237839081095, 6755.831104222385, 4015.3976903464422, 4250.617444430016, 4324.135172965388, 4338.826446942118, 4375.5405682403525, 1163.6567212672282, 1174.8531433570804, 1203.1758245601704, 1205.2226314027491, 1209.842720446345, 13058.934705326508, 14914.925425372912, 15810.13044282564, 15974.201289935456, 16127.193640318055, 5467.371252305956, 5573.108302671553, 5703.486686198179, 5788.131780232915, 5812.041013232853, 10294.588216471408, 12262.938685306695, 12353.135280530276, 12365.443555039865, 12373.93813030929, 6173.536984726074, 6478.125453063871, 6538.0192971053775, 6538.574992625464, 6544.934550654528, 6026.12117071511, 6051.939480605226, 6175.413335733188, 6227.470664993526, 6257.186565746424, 4310.030243195319, 4419.1382680377665, 4457.442819647544, 4475.910481790411, 4506.0, 1141.2809929744208, 1257.3838818978634, 1281.564268148834, 1296.0817989375776, 1297.1892567145535, 742.7140550887839, 783.8158032862273, 791.4855344026429, 825.5542007316102, 826.0954255090666, 5428.728563571805, 6134.662593557308, 6234.657093859791, 6283.59156654816, 6359.682015899187, 588.3351812451901, 588.6850534963773, 594.180031556458, 608.6256951974592, 615.3354377272535, 3704.592494825567, 4160.54234034256, 4294.720843145248, 4407.184670835905, 4422.845200418034, 14668.339924703414, 14880.776788348183, 14948.0, 15329.770053449207, 15366.231688415535, 12506.936910362721, 15159.848401516065, 15309.617259568377, 15322.080675159303, 15387.538373848802, 10889.292196007234, 10930.836037459445, 10958.0, 10970.670879873616, 11079.058280046125, 5780.306363236438, 6576.309487503934, 6694.765683201064, 6803.7618683345845, 6859.416949559343, 13253.602391928258, 13280.867191327963, 13296.534621288209, 13341.799873001719, 13571.457141714222, 11840.75672054422, 13722.382492788049, 13858.376373063034, 13982.650433739238, 14021.29893505341, 8678.566071696263, 8732.039475657799, 8775.385722999328, 8779.385443018928, 8799.868001979847, 10509.579616815241, 10607.4165920872, 10717.892821072, 10726.570937162425, 10762.46187690628, 7611.733589324347, 8006.439549231498, 9011.0, 9110.772230694285, 9181.540922953693, 8846.690365837165, 8861.822763544822, 8982.101789820965, 8994.775130621787, 9012.729618111467, 6512.5766825156215, 8086.070101938352, 8113.553754543556, 8209.917900820916, 8256.504609723435, 5821.388754180919, 6007.12896629995, 6018.337982821974, 6122.632642041492, 6190.845228869314, 6074.210352654127, 6128.111423843607, 6203.0075187969705, 6291.339409361951, 6322.36776322364], "value": 5295.043363446079, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.8899908025753, 402.86392373506703, 403.9050823056579, 405.61871840469956, 410.97739624320667, 6078.513718902488, 6221.351341894401, 6239.469645080162, 6256.781012664557, 6258.968705156473, 4781.904361912769, 4951.900961980758, 5830.766769329232, 6088.634681919088, 6116.44951954324, 4044.9483134384977, 4107.404426358176, 4279.679024073192, 4313.340346084237, 4689.57793798558, 3939.1333906540517, 4076.7769669099152, 4551.431071116111, 4642.767861606923, 4748.596369308613, 4567.246404343296, 4587.151416634872, 4591.471980722226, 4671.976640116812, 4679.415073115861, 4209.0529630833125, 4517.435320584927, 4626.560476754703, 4628.953710462886, 4661.184292748772, 3610.422332426799, 4139.606737359946, 4140.399642051916, 4171.457710497646, 4200.096979149467, 5099.903520743021, 5457.372402173761, 5474.591179880839, 5514.042514907191, 5829.941700582982, 4585.518520555327, 4616.976915115437, 5529.198266251411, 5532.640378375393, 5541.476094074122, 6230.470410015154, 6450.419462248373, 6494.512911531607, 6498.0, 6535.091884111573, 3952.9209415811524, 4539.364488971547, 4663.580277774982, 4683.672142949995, 4732.574068333866, 5429.321334833146, 6146.231721034871, 6356.103627564098, 6794.218664853555, 6849.520533562652, 4439.001224724476, 4665.650076244296, 4770.833020844254, 4823.421189457287, 4865.854024379274, 4203.76879271643, 4926.743680361485, 4950.975245123824, 4955.653104282737, 4955.752212389366, 4899.3385892904, 5314.548263397654, 5484.561235101182, 5544.889102217933, 5581.6930068845795, 5363.356397232357, 6231.940570103094, 6234.812955611339, 6501.024846273097, 6593.406593406617, 1425.2374979386186, 1636.35364031207, 1676.8574671152844, 1710.7938903073552, 1714.9657006859793, 997.7954519323521, 1149.8332741752567, 1177.1465687376583, 1179.151011271883, 1181.7931861924128, 5305.840824775263, 5458.533831017253, 5540.445955404427, 6220.688965551704, 6246.219222597176, 5423.864403389947, 6202.255729312421, 6772.255051944282, 6786.117804685359, 6814.454843612499, 6116.235470566179, 6173.69131543421, 6221.2845522764555, 6252.718627661675, 6261.96869015652, 2832.937648381857, 3529.3823580873245, 3549.432090865449, 3549.6450354964295, 3553.271579326232, 5659.349174844946, 6037.034074548052, 6533.901991470132, 7043.225245223021, 7056.400205982549, 6037.63774173551, 6127.325994140641, 7055.506114572034, 7064.293570642894, 7084.610346430893, 6151.738893526726, 6421.839454013687, 6474.6762661866715, 6776.76281330161, 7008.579485230801, 5371.328583927009, 6123.755049797958, 6126.509879209563, 6730.562513436611, 6776.833081895452, 5537.169424586184, 6391.616503009835, 6611.570247934062, 6644.60132392058, 6651.567648102858, 5182.274481572658, 6260.280067792262, 6536.379043990813, 6794.966025169842, 6936.098307220029, 4418.873187337208, 4425.82296708141, 4429.468463784237, 4452.30989196675, 4466.285394336891, 6606.273309935999, 6653.767118150841, 6711.46308295345, 6759.831004224934, 6771.6614169292325, 5606.635568688022, 6104.69476526163, 6458.580192287486, 6581.0, 6587.571807832475, 5913.704314784158, 6533.705983230861, 6534.281229064894, 6558.606483610999, 6814.250432452525, 5361.35663720356, 6340.461060809883, 6409.0, 6430.0, 6464.773732919325, 6588.769393071219, 6598.538102332791, 6599.373059559334, 6600.471962243105, 6609.339066093352, 5567.526760225426, 5960.109346966804, 6137.539684523589, 6140.263168419819, 6416.197975253093], "value": 4769.467851976018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.3046388714043, 822.404535201709, 834.1783343406747, 862.693743720979, 875.6234819027818, 14007.299635018258, 14592.197429141394, 16517.256723447445, 16903.577410564743, 17124.65750684987, 16869.819112662117, 17342.132893355345, 17504.949703017795, 17632.64734705305, 17841.0, 976.4092723902044, 982.6855406269997, 984.6110786239467, 985.7042887133867, 988.298308201178, 874.7725591346264, 966.9806603867919, 997.1922742578498, 1001.8346972749524, 1004.4324956399647, 1034.3897100710578, 1037.2946396450411, 1037.4605205293242, 1037.9931466477506, 1038.3458421194637, 1025.220832167558, 1029.8455231715227, 1030.4023666273542, 1032.8450732390127, 1040.7294103533097, 757.6249756370631, 759.4531937005403, 760.2701406649624, 761.7372006657695, 767.6545554500497, 16276.26756795947, 16887.915560422243, 17030.914845425817, 17126.657466850593, 17137.314507419687, 15784.447544336008, 16228.675426491522, 16238.431654892021, 16409.097499637515, 16477.67044659112, 13089.803652945213, 13409.798853017115, 13551.322433878366, 13551.39018744149, 13566.186028838203, 3346.0965539304493, 3371.2920286739813, 3384.5769278840144, 3446.190145315849, 3546.85812567497, 81032.0, 97704.0, 106293.46853265761, 108715.45642271738, 109387.0, 13094.476220951055, 13489.527866524624, 13492.93253533726, 13505.392257348443, 13563.525276615272, 24138.39654008664, 24549.754502455104, 25020.624690629655, 25038.874805625856, 25047.248582542554, 7308.990027742413, 7585.355244804254, 8592.0, 8915.0, 8988.280937525113, 4821.132196204647, 4928.6303527235605, 4930.6795058321095, 4934.309196712463, 4941.332920055818, 4374.737515749065, 4829.444613869379, 4837.467878533358, 4870.4155501340065, 4888.046830868017, 946.9337146399823, 974.5273542331963, 979.480875136179, 994.9154321882721, 995.4425521707722, 637.6492928889093, 648.5492582655104, 649.5972497051858, 652.8106849013733, 667.2693400726197, 10311.381317120848, 11210.327380357205, 11817.350045747395, 11942.283462992249, 11994.220375675553, 622.8069298517474, 644.3105876711874, 656.8456412743002, 663.3234101216732, 665.3944910131756, 5498.945010549924, 5517.972410137923, 5633.267675202197, 5649.6327738696855, 5737.397573254748, 88462.0, 97523.51238243764, 98980.51529227068, 107125.4643726792, 107369.0, 63382.09853704396, 78453.0, 79601.80597291046, 79874.60062699765, 82357.0, 58853.0, 63213.419664507834, 63275.6836215816, 63944.36055639477, 64392.03411948824, 11598.826017609912, 12115.697107572028, 12155.270683759003, 12175.452104655134, 12290.754184916073, 37554.436683450316, 37618.623813761515, 37807.0, 37883.67407140737, 38394.42408363933, 48426.75786621044, 48825.75587122042, 48873.75563122162, 48906.0, 49529.50470495249, 15689.607759806097, 15759.448419305269, 16106.27521761547, 16686.16335222991, 16886.324547017983, 17636.294548217928, 18171.273149073888, 18225.0, 18599.44201673898, 18609.976451295308, 16194.109323986822, 16882.24029918632, 17047.659046818746, 17126.571835704206, 17193.742093868852, 16293.022418654919, 16588.170591470138, 16629.83370166283, 16840.831591683927, 16899.66200675955, 16133.75799362987, 16213.756793647868, 16266.755998659793, 16451.0, 16598.502044938672, 11696.70758231017, 11941.044716422839, 11971.341576213392, 12073.0, 12116.818247726467, 11279.266847654877, 12740.299283539494, 12753.0, 12857.0, 13064.21614703083], "value": 8219.055522784252, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1647.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 124.0, 113.0, 121.0, 120.0, 124.0, 122.0, 145.0, 125.0, 127.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 143.0, 163.0, 115.0, 116.0, 117.0, 120.0, 133.0, 111.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 226.0, 226.0, 228.0, 222.0, 242.0, 301.0, 271.0, 226.0, 292.0], "value": 245.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 67.0, 88.0, 120.0, 84.0, 68.0, 61.0, 63.0, 75.0, 64.0], "value": 77.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 74.0, 87.0, 82.0, 110.0, 105.0, 86.0, 73.0, 74.0, 86.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 92.0, 94.0, 94.0, 94.0, 93.0, 94.0, 92.0, 93.0, 94.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 101.0, 100.0, 100.0, 110.0, 102.0, 100.0, 101.0, 99.0], "value": 101.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 129.0, 104.0, 103.0, 102.0, 99.0, 161.0, 128.0, 101.0, 157.0], "value": 123.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 51.0, 52.0, 52.0, 54.0, 51.0, 52.0, 52.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 85.0, 91.0, 92.0, 67.0, 61.0, 60.0, 60.0, 62.0, 60.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 89.0, 88.0, 87.0, 100.0, 88.0, 77.0, 76.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 160.0, 156.0, 165.0, 168.0, 170.0, 154.0, 282.0, 168.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 249.0, 208.0, 219.0, 246.0, 204.0, 196.0, 197.0, 193.0, 194.0], "value": 212.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 72.0, 68.0, 101.0, 84.0, 70.0, 69.0, 72.0], "value": 75.2, "unit": "score"}]}]}
22:09:56 INFO - Return code: 0
22:09:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
22:09:57 ERROR - # TBPL SUCCESS #
22:09:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
22:09:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
22:09:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
22:09:57 INFO - 2017-04-11 22:09:57.019 screenresolution[1661:10597] starting screenresolution argv=screenresolution get
22:09:57 INFO - 2017-04-11 22:09:57.023 screenresolution[1661:10597] Display 0: 1600x1200x32@60
22:09:57 INFO - 2017-04-11 22:09:57.029 screenresolution[1662:10600] starting screenresolution argv=screenresolution list
22:09:57 INFO - Available Modes on Display 0
22:09:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
22:09:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
22:09:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
22:09:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
22:09:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
22:09:57 INFO - Intel Iris:
22:09:57 INFO - Chipset Model: Intel Iris
22:09:57 INFO - Type: GPU
22:09:57 INFO - Bus: Built-In
22:09:57 INFO - VRAM (Dynamic, Max): 1536 MB
22:09:57 INFO - Vendor: Intel (0x8086)
22:09:57 INFO - Device ID: 0x0a2e
22:09:57 INFO - Revision ID: 0x0009
22:09:57 INFO - Displays:
22:09:57 INFO - Display:
22:09:57 INFO - Resolution: 1600 x 1200 @ 60 Hz
22:09:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
22:09:57 INFO - Display Serial Number: 1600x1200 60
22:09:57 INFO - Main Display: Yes
22:09:57 INFO - Mirror: Off
22:09:57 INFO - Online: Yes
22:09:57 INFO - Rotation: Supported
22:09:57 INFO - Return code: 0
22:09:57 INFO - Running post-action listener: _resource_record_post_action
22:09:57 INFO - [mozharness: 2017-04-12 05:09:57.274869Z] Finished run-tests step (success)
22:09:57 INFO - Running post-run listener: _resource_record_post_run
22:09:57 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39053824; Write bytes: 521432576; Read time: 249; Write time: 1643
22:09:57 INFO - TinderboxPrint: CPU usage
54.2%
22:09:57 INFO - TinderboxPrint: I/O read bytes / time
39,053,824 / 249
22:09:57 INFO - TinderboxPrint: I/O write bytes / time
521,432,576 / 1,643
22:09:57 INFO - TinderboxPrint: CPU idle
2,200.1 (45.8%)
22:09:57 INFO - TinderboxPrint: CPU system
963.3 (20.1%)
22:09:57 INFO - TinderboxPrint: CPU user
1,638.2 (34.1%)
22:09:57 INFO - TinderboxPrint: Swap in / out
247,148,544 / 0
22:09:57 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 200688128; Write bytes: 194459136; Read time: 15552; Write time: 411
22:09:57 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 37235200; Write bytes: 310319104; Read time: 232; Write time: 1182
22:09:57 INFO - Running post-run listener: _upload_blobber_files
22:09:57 INFO - Blob upload gear active.
22:09:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
22:09:57 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
22:09:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
22:09:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
22:09:58 INFO - (blobuploader) - INFO - Open directory for files ...
22:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
22:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
22:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:09:59 INFO - (blobuploader) - INFO - Done attempting.
22:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
22:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
22:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:10:00 INFO - (blobuploader) - INFO - Done attempting.
22:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
22:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
22:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:10:01 INFO - (blobuploader) - INFO - Done attempting.
22:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
22:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
22:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:10:03 INFO - (blobuploader) - INFO - Done attempting.
22:10:03 INFO - (blobuploader) - INFO - Iteration through files over.
22:10:03 INFO - Return code: 0
22:10:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
22:10:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
22:10:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/090b6b50dc58bcc9e2ce48e2c6bff881c56adb9c70a3ec7bd97f148c4fd61be117ac47f28d420d0e119e4e59841eec55922027a92a93e68903c7567836a946e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5044349a263e6c2a7039e892258541221d6df986db79d8410f742d98844bf03fe197b81a74c87d2921474db951d1cd8e94213884a057b30eff40538daf82cb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80fae02209c03e376e5eabc567810e9cb22000c25318d6490ea550fffd73df4b848640c766a22f24b06ef8345afd00c36a70aab8f873b63cd427bca537b4d68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02935d5a812fbdf08c10ebb1f8c674ed8daa9a70a1dbb677fd83e124c8f3657e79051396e4aee1c793027fddfca4f9b8154aa4fa6f3598a732f82543de12a8fb"}
22:10:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
22:10:03 INFO - Writing to file /builds/slave/test/properties/blobber_files
22:10:03 INFO - Contents:
22:10:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/090b6b50dc58bcc9e2ce48e2c6bff881c56adb9c70a3ec7bd97f148c4fd61be117ac47f28d420d0e119e4e59841eec55922027a92a93e68903c7567836a946e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5044349a263e6c2a7039e892258541221d6df986db79d8410f742d98844bf03fe197b81a74c87d2921474db951d1cd8e94213884a057b30eff40538daf82cb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80fae02209c03e376e5eabc567810e9cb22000c25318d6490ea550fffd73df4b848640c766a22f24b06ef8345afd00c36a70aab8f873b63cd427bca537b4d68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02935d5a812fbdf08c10ebb1f8c674ed8daa9a70a1dbb677fd83e124c8f3657e79051396e4aee1c793027fddfca4f9b8154aa4fa6f3598a732f82543de12a8fb"}
22:10:03 INFO - Running post-run listener: copy_logs_to_upload_dir
22:10:03 INFO - Copying logs to upload dir...
22:10:03 INFO - mkdir: /builds/slave/test/build/upload/logs
22:10:03 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1283.771960
========= master_lag: 0.22 =========
========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-11 22:10:03.712808) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 22:10:03.716902) =========
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:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test/properties
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/090b6b50dc58bcc9e2ce48e2c6bff881c56adb9c70a3ec7bd97f148c4fd61be117ac47f28d420d0e119e4e59841eec55922027a92a93e68903c7567836a946e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5044349a263e6c2a7039e892258541221d6df986db79d8410f742d98844bf03fe197b81a74c87d2921474db951d1cd8e94213884a057b30eff40538daf82cb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80fae02209c03e376e5eabc567810e9cb22000c25318d6490ea550fffd73df4b848640c766a22f24b06ef8345afd00c36a70aab8f873b63cd427bca537b4d68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02935d5a812fbdf08c10ebb1f8c674ed8daa9a70a1dbb677fd83e124c8f3657e79051396e4aee1c793027fddfca4f9b8154aa4fa6f3598a732f82543de12a8fb"}
build_url:https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
program finished with exit code 0
elapsedTime=0.011200
build_url: 'https://queue.taskcluster.net/v1/task/Y50WiuXNTXOAF6_FMsGpQw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/090b6b50dc58bcc9e2ce48e2c6bff881c56adb9c70a3ec7bd97f148c4fd61be117ac47f28d420d0e119e4e59841eec55922027a92a93e68903c7567836a946e2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5044349a263e6c2a7039e892258541221d6df986db79d8410f742d98844bf03fe197b81a74c87d2921474db951d1cd8e94213884a057b30eff40538daf82cb3c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b80fae02209c03e376e5eabc567810e9cb22000c25318d6490ea550fffd73df4b848640c766a22f24b06ef8345afd00c36a70aab8f873b63cd427bca537b4d68", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/02935d5a812fbdf08c10ebb1f8c674ed8daa9a70a1dbb677fd83e124c8f3657e79051396e4aee1c793027fddfca4f9b8154aa4fa6f3598a732f82543de12a8fb"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-11 22:10:03.752690) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 22:10:03.753064) =========
rm -f oauth.txt
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IJAXQbEFYD/Render
GIT_SHARE_BASE_DIR=/builds/git-shared
HG_SHARE_BASE_DIR=/builds/hg-shared
HOME=/Users/cltbld
IDLEIZER_DISABLE_SHUTDOWN=true
LOGNAME=cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NO_EM_RESTART=1
PAGER=/bin/cat
PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
PWD=/builds/slave/test
RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
SHELL=/bin/bash
SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.RA15kkdZUc/Listeners
TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
program finished with exit code 0
elapsedTime=0.005156
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-11 22:10:03.804693) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 22:10:03.805198) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-11 22:10:03.805788) =========
========= Total master_lag: 0.36 =========