builder: mozilla-central_yosemite_r7_test-dromaeojs
slave: t-yosemite-r7-0125
starttime: 1493032330.04
results: success (0)
buildid: 20170424030211
builduid: d867f5e265b34ca1a51c4f50052f3caf
revision: 73752931e273091185e1e4b5231c28beed657cc8
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.044857) =========
master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.045411) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.045708) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.072675) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.073024) =========
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.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-24 04:12:10-- 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% 60.8M=0s
2017-04-24 04:12:10 (60.8 MB/s) - 'archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.094769
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.197471) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.198017) =========
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.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.031689
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:10.255515) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 04:12:10.255861) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73752931e273091185e1e4b5231c28beed657cc8 --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 73752931e273091185e1e4b5231c28beed657cc8 --destination scripts --debug']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-24 04:12:10,357 truncating revision to first 12 chars
2017-04-24 04:12:10,357 Setting DEBUG logging.
2017-04-24 04:12:10,357 attempt 1/10
2017-04-24 04:12:10,357 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73752931e273?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-04-24 04:12:11,646 unpacking tar archive at: mozilla-central-73752931e273/testing/mozharness/
program finished with exit code 0
elapsedTime=1.567132
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 04:12:11.853086) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:11.853989) =========
script_repo_revision: 73752931e273091185e1e4b5231c28beed657cc8
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:11.854707) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:11.855148) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 04:12:11.877501) =========
========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-24 04:12:11.878022) =========
/tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:12:12 INFO - MultiFileLogger online at 20170424 04:12:12 in /builds/slave/test
04:12:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
04:12:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
04:12:12 INFO - {'append_to_log': False,
04:12:12 INFO - 'base_work_dir': '/builds/slave/test',
04:12:12 INFO - 'blob_upload_branch': 'Firefox',
04:12:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
04:12:12 INFO - 'branch': 'Firefox',
04:12:12 INFO - 'buildbot_json_path': 'buildprops.json',
04:12:12 INFO - 'config_files': ('talos/mac_config.py',),
04:12:12 INFO - 'default_actions': ('clobber',
04:12:12 INFO - 'read-buildbot-config',
04:12:12 INFO - 'download-and-extract',
04:12:12 INFO - 'populate-webroot',
04:12:12 INFO - 'create-virtualenv',
04:12:12 INFO - 'install',
04:12:12 INFO - 'run-tests'),
04:12:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
04:12:12 INFO - 'download_minidump_stackwalk': True,
04:12:12 INFO - 'download_symbols': 'ondemand',
04:12:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
04:12:12 INFO - 'tooltool.py': '/tools/tooltool.py',
04:12:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
04:12:12 INFO - '/tools/misc-python/virtualenv.py')},
04:12:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
04:12:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
04:12:12 INFO - 'gecko_profile': False,
04:12:12 INFO - 'gecko_profile_interval': 0,
04:12:12 INFO - 'installer_path': 'installer.exe',
04:12:12 INFO - 'log_level': 'info',
04:12:12 INFO - 'log_name': 'talos',
04:12:12 INFO - 'log_to_console': True,
04:12:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk',
04:12:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest',
04:12:12 INFO - 'opt_config_files': (),
04:12:12 INFO - 'pip_index': False,
04:12:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
04:12:12 INFO - 'cmd': ('bash',
04:12:12 INFO - '-c',
04:12:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
04:12:12 INFO - 'enabled': True,
04:12:12 INFO - 'halt_on_failure': False,
04:12:12 INFO - 'name': 'check_screen_resolution'},),
04:12:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
04:12:12 INFO - 'cmd': ('bash',
04:12:12 INFO - '-c',
04:12:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
04:12:12 INFO - 'enabled': True,
04:12:12 INFO - 'halt_on_failure': False,
04:12:12 INFO - 'name': 'check_screen_resolution'},),
04:12:12 INFO - 'run_cmd_checks_enabled': True,
04:12:12 INFO - 'suite': 'dromaeojs',
04:12:12 INFO - 'system_bits': '32',
04:12:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
04:12:12 INFO - 'title': 't-yosemite-r7-0125',
04:12:12 INFO - 'tooltool_cache': '/builds/tooltool_cache',
04:12:12 INFO - 'use_talos_json': True,
04:12:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
04:12:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
04:12:12 INFO - 'work_dir': 'build'}
04:12:12 INFO - [mozharness: 2017-04-24 11:12:12.092153Z] Running clobber step.
04:12:12 INFO - Running pre-action listener: _resource_record_pre_action
04:12:12 INFO - Running main action method: clobber
04:12:12 INFO - rmtree: /builds/slave/test/build
04:12:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
04:12:14 INFO - Running post-action listener: _resource_record_post_action
04:12:14 INFO - [mozharness: 2017-04-24 11:12:14.560715Z] Finished clobber step (success)
04:12:14 INFO - [mozharness: 2017-04-24 11:12:14.560845Z] Running read-buildbot-config step.
04:12:14 INFO - Running pre-action listener: _resource_record_pre_action
04:12:14 INFO - Running main action method: read_buildbot_config
04:12:14 INFO - Using buildbot properties:
04:12:14 INFO - {
04:12:14 INFO - "project": "",
04:12:14 INFO - "product": "firefox",
04:12:14 INFO - "script_repo_revision": "production",
04:12:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs",
04:12:14 INFO - "repository": "",
04:12:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs",
04:12:14 INFO - "buildid": "20170424030211",
04:12:14 INFO - "stage_platform": "macosx64",
04:12:14 INFO - "basedir": "/builds/slave/test",
04:12:14 INFO - "nightly_build": "True",
04:12:14 INFO - "buildnumber": 18,
04:12:14 INFO - "slavename": "t-yosemite-r7-0125",
04:12:14 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/",
04:12:14 INFO - "platform": "yosemite_r7",
04:12:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos",
04:12:14 INFO - "branch": "mozilla-central",
04:12:14 INFO - "repo_path": "mozilla-central",
04:12:14 INFO - "revision": "73752931e273091185e1e4b5231c28beed657cc8",
04:12:14 INFO - "pgo_build": "False",
04:12:14 INFO - "builduid": "d867f5e265b34ca1a51c4f50052f3caf",
04:12:14 INFO - "slavebuilddir": "test"
04:12:14 INFO - }
04:12:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg.
04:12:14 INFO - Running post-action listener: _resource_record_post_action
04:12:14 INFO - [mozharness: 2017-04-24 11:12:14.564236Z] Finished read-buildbot-config step (success)
04:12:14 INFO - [mozharness: 2017-04-24 11:12:14.564350Z] Running download-and-extract step.
04:12:14 INFO - Running pre-action listener: _resource_record_pre_action
04:12:14 INFO - Running main action method: download_and_extract
04:12:14 INFO - mkdir: /builds/slave/test/build/tests
04:12:14 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')]}
04:12:14 INFO - trying https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json
04:12:14 INFO - Downloading https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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
04:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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
04:12:15 INFO - Downloaded 1325 bytes.
04:12:15 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json
04:12:15 INFO - Using the following test package requirements:
04:12:15 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'],
04:12:15 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
04:12:15 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'],
04:12:15 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'],
04:12:15 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'jsshell-mac.zip'],
04:12:15 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'],
04:12:15 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
04:12:15 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'],
04:12:15 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'],
04:12:15 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'],
04:12:15 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
04:12:15 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']}
04:12:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common
04:12:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
04:12:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
04:12:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
04:12:17 INFO - Content-Length response header: 52526318
04:12:17 INFO - Bytes received: 52526318
04:12:33 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
04:12:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
04:12:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
04:12:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
04:12:35 INFO - Content-Length response header: 52526318
04:12:35 INFO - Bytes received: 52526318
04:12:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip
04:12:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1
04:12:50 INFO - Fetch https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory
04:12:51 INFO - Content-Length response header: 14408822
04:12:51 INFO - Bytes received: 14408822
04:12:51 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')]}
04:12:51 INFO - trying https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
04:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg
04:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/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
04:12:53 INFO - Downloaded 71115004 bytes.
04:12:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
04:12:53 INFO - mkdir: /builds/slave/test/properties
04:12:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
04:12:53 INFO - Writing to file /builds/slave/test/properties/build_url
04:12:53 INFO - Contents:
04:12:53 INFO - build_url:https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
04:12:54 INFO - Running post-action listener: _resource_record_post_action
04:12:54 INFO - Running post-action listener: set_extra_try_arguments
04:12:54 INFO - [mozharness: 2017-04-24 11:12:54.508593Z] Finished download-and-extract step (success)
04:12:54 INFO - [mozharness: 2017-04-24 11:12:54.508706Z] Running populate-webroot step.
04:12:54 INFO - Running pre-action listener: _resource_record_pre_action
04:12:54 INFO - Running main action method: populate_webroot
04:12:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
04:12:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
04:12:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
04:12:54 INFO - '--tppagecycles',
04:12:54 INFO - '7'],
04:12:54 INFO - 'tests': ['tsvgm']}},
04:12:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['tresize', 'tcanvasmark']},
04:12:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
04:12:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['dromaeo_css', 'kraken']},
04:12:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
04:12:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
04:12:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
04:12:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['damp', 'tps']},
04:12:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'tests': ['damp', 'tps']},
04:12:54 INFO - 'g3': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['dromaeo_dom']},
04:12:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
04:12:54 INFO - 'g4': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']},
04:12:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']},
04:12:54 INFO - 'other': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'other-e10s': {'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'other-e10s_l64': {'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['a11yr',
04:12:54 INFO - 'ts_paint',
04:12:54 INFO - 'tpaint',
04:12:54 INFO - 'sessionrestore',
04:12:54 INFO - 'sessionrestore_no_auto_restore',
04:12:54 INFO - 'tabpaint']},
04:12:54 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']},
04:12:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic',
04:12:54 INFO - 'bloom_basic_ref']},
04:12:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['tsvgx',
04:12:54 INFO - 'tsvgr_opacity',
04:12:54 INFO - 'tart',
04:12:54 INFO - 'tscrollx',
04:12:54 INFO - 'cart',
04:12:54 INFO - 'tsvg_static']},
04:12:54 INFO - 'svgr-e10s': {'tests': ['tsvgx',
04:12:54 INFO - 'tsvgr_opacity',
04:12:54 INFO - 'tart',
04:12:54 INFO - 'tscrollx',
04:12:54 INFO - 'cart',
04:12:54 INFO - 'tsvg_static']},
04:12:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'talos_options': ['--disable-e10s'],
04:12:54 INFO - 'tests': ['tp5o']},
04:12:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
04:12:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'talos_options': ['--disable-e10s',
04:12:54 INFO - '--xperf_path',
04:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
04:12:54 INFO - 'tests': ['tp5n']},
04:12:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
04:12:54 INFO - 'talos_options': ['--xperf_path',
04:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
04:12:54 INFO - 'tests': ['tp5n']}},
04:12:54 INFO - 'talos.zip': {'path': '',
04:12:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
04:12:54 INFO - Running post-action listener: _resource_record_post_action
04:12:54 INFO - [mozharness: 2017-04-24 11:12:54.528304Z] Finished populate-webroot step (success)
04:12:54 INFO - [mozharness: 2017-04-24 11:12:54.528437Z] Running create-virtualenv step.
04:12:54 INFO - Running pre-action listener: _resource_record_pre_action
04:12:54 INFO - Running main action method: create_virtualenv
04:12:54 INFO - Creating virtualenv /builds/slave/test/build/venv
04:12:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
04:12:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
04:12:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
04:12:54 INFO - Using real prefix '/tools/python27'
04:12:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python
04:12:55 INFO - Installing distribute.............................................................................................................................................................................................done.
04:12:58 INFO - Installing pip.................done.
04:12:58 INFO - Return code: 0
04:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
04:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
04:12:58 INFO - Reading from file tmpfile_stdout
04:12:58 INFO - Output received:
04:12:58 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)
04:12:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
04:12:58 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')]}
04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:12:58 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')]}
04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:12:58 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
04:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
04:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:12:58 INFO - 'HOME': '/Users/cltbld',
04:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:12:58 INFO - 'LOGNAME': 'cltbld',
04:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:12:58 INFO - 'MOZ_NO_REMOTE': '1',
04:12:58 INFO - 'NO_EM_RESTART': '1',
04:12:58 INFO - 'PAGER': '/bin/cat',
04:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:12:58 INFO - 'PWD': '/builds/slave/test',
04:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:12:58 INFO - 'SHELL': '/bin/bash',
04:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:12:58 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:12:58 INFO - 'USER': 'cltbld',
04:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:12:58 INFO - 'XPC_FLAGS': '0x0',
04:12:58 INFO - 'XPC_SERVICE_NAME': '0',
04:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg
04:12:58 INFO - Cleaning up...
04:12:58 INFO - Return code: 0
04:12:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
04:12:58 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')]}
04:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:12:58 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')]}
04:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:12:58 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:12:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
04:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
04:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:12:58 INFO - 'HOME': '/Users/cltbld',
04:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:12:58 INFO - 'LOGNAME': 'cltbld',
04:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:12:58 INFO - 'MOZ_NO_REMOTE': '1',
04:12:58 INFO - 'NO_EM_RESTART': '1',
04:12:58 INFO - 'PAGER': '/bin/cat',
04:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:12:58 INFO - 'PWD': '/builds/slave/test',
04:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:12:58 INFO - 'SHELL': '/bin/bash',
04:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:12:58 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:12:58 INFO - 'USER': 'cltbld',
04:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:12:58 INFO - 'XPC_FLAGS': '0x0',
04:12:58 INFO - 'XPC_SERVICE_NAME': '0',
04:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:12:59 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:12:59 INFO - Downloading/unpacking psutil>=3.1.1
04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:12:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:12:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:12:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
04:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
04:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
04:13:02 INFO - Installing collected packages: psutil
04:13:02 INFO - Running setup.py install for psutil
04:13:02 INFO - building 'psutil._psutil_osx' extension
04:13:02 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
04:13:03 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
04:13:03 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
04:13:03 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
04:13:03 INFO - building 'psutil._psutil_posix' extension
04:13:03 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
04:13:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration]
04:13:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr);
04:13:03 INFO - ^
04:13:03 INFO - 1 warning generated.
04:13:03 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
04:13:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
04:13:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
04:13:03 INFO - Successfully installed psutil
04:13:03 INFO - Cleaning up...
04:13:03 INFO - Return code: 0
04:13:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
04:13:03 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')]}
04:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:03 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')]}
04:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:03 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build
04:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
04:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:03 INFO - 'HOME': '/Users/cltbld',
04:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:03 INFO - 'LOGNAME': 'cltbld',
04:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:03 INFO - 'MOZ_NO_REMOTE': '1',
04:13:03 INFO - 'NO_EM_RESTART': '1',
04:13:03 INFO - 'PAGER': '/bin/cat',
04:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:03 INFO - 'PWD': '/builds/slave/test',
04:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:03 INFO - 'SHELL': '/bin/bash',
04:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:03 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:03 INFO - 'USER': 'cltbld',
04:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:03 INFO - 'XPC_FLAGS': '0x0',
04:13:03 INFO - 'XPC_SERVICE_NAME': '0',
04:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:04 INFO - Downloading/unpacking mozsystemmonitor==0.3
04:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz
04:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
04:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
04:13:06 INFO - Installing collected packages: mozsystemmonitor
04:13:06 INFO - Running setup.py install for mozsystemmonitor
04:13:06 INFO - Successfully installed mozsystemmonitor
04:13:06 INFO - Cleaning up...
04:13:07 INFO - Return code: 0
04:13:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
04:13:07 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')]}
04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:07 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')]}
04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:07 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build
04:13:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
04:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:07 INFO - 'HOME': '/Users/cltbld',
04:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:07 INFO - 'LOGNAME': 'cltbld',
04:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:07 INFO - 'MOZ_NO_REMOTE': '1',
04:13:07 INFO - 'NO_EM_RESTART': '1',
04:13:07 INFO - 'PAGER': '/bin/cat',
04:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:07 INFO - 'PWD': '/builds/slave/test',
04:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:07 INFO - 'SHELL': '/bin/bash',
04:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:07 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:07 INFO - 'USER': 'cltbld',
04:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:07 INFO - 'XPC_FLAGS': '0x0',
04:13:07 INFO - 'XPC_SERVICE_NAME': '0',
04:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:07 INFO - Downloading/unpacking jsonschema==2.5.1
04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
04:13:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:11 INFO - Downloading functools32-3.2.3-2.tar.gz
04:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
04:13:11 INFO - warning: no files found matching '*.txt'
04:13:11 INFO - no previously-included directories found matching 'build'
04:13:11 INFO - no previously-included directories found matching 'dist'
04:13:11 INFO - no previously-included directories found matching '.git*'
04:13:11 INFO - Installing collected packages: jsonschema, functools32
04:13:11 INFO - Running setup.py install for functools32
04:13:11 INFO - warning: no files found matching '*.txt'
04:13:11 INFO - no previously-included directories found matching 'build'
04:13:11 INFO - no previously-included directories found matching 'dist'
04:13:11 INFO - no previously-included directories found matching '.git*'
04:13:11 INFO - Successfully installed jsonschema functools32
04:13:11 INFO - Cleaning up...
04:13:11 INFO - Return code: 0
04:13:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
04:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:11 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:11 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
04:13:11 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
04:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:11 INFO - 'HOME': '/Users/cltbld',
04:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:11 INFO - 'LOGNAME': 'cltbld',
04:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:11 INFO - 'MOZ_NO_REMOTE': '1',
04:13:11 INFO - 'NO_EM_RESTART': '1',
04:13:11 INFO - 'PAGER': '/bin/cat',
04:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:11 INFO - 'PWD': '/builds/slave/test',
04:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:11 INFO - 'SHELL': '/bin/bash',
04:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:11 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:11 INFO - 'USER': 'cltbld',
04:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:11 INFO - 'XPC_FLAGS': '0x0',
04:13:11 INFO - 'XPC_SERVICE_NAME': '0',
04:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
04:13:11 INFO - Cleaning up...
04:13:12 INFO - Return code: 0
04:13:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
04:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:12 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build
04:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
04:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:12 INFO - 'HOME': '/Users/cltbld',
04:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:12 INFO - 'LOGNAME': 'cltbld',
04:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:12 INFO - 'MOZ_NO_REMOTE': '1',
04:13:12 INFO - 'NO_EM_RESTART': '1',
04:13:12 INFO - 'PAGER': '/bin/cat',
04:13:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:12 INFO - 'PWD': '/builds/slave/test',
04:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:12 INFO - 'SHELL': '/bin/bash',
04:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:12 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:12 INFO - 'USER': 'cltbld',
04:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:12 INFO - 'XPC_FLAGS': '0x0',
04:13:12 INFO - 'XPC_SERVICE_NAME': '0',
04:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:12 INFO - Downloading/unpacking blobuploader==1.2.4
04:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:14 INFO - Downloading blobuploader-1.2.4.tar.gz
04:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
04:13:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
04:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
04:13:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:16 INFO - Downloading docopt-0.6.1.tar.gz
04:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
04:13:16 INFO - Installing collected packages: blobuploader, requests, docopt
04:13:16 INFO - Running setup.py install for blobuploader
04:13:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
04:13:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
04:13:16 INFO - Running setup.py install for requests
04:13:16 INFO - Running setup.py install for docopt
04:13:17 INFO - Successfully installed blobuploader requests docopt
04:13:17 INFO - Cleaning up...
04:13:17 INFO - Return code: 0
04:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:17 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
04:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
04:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:17 INFO - 'HOME': '/Users/cltbld',
04:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:17 INFO - 'LOGNAME': 'cltbld',
04:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:17 INFO - 'MOZ_NO_REMOTE': '1',
04:13:17 INFO - 'NO_EM_RESTART': '1',
04:13:17 INFO - 'PAGER': '/bin/cat',
04:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:17 INFO - 'PWD': '/builds/slave/test',
04:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:17 INFO - 'SHELL': '/bin/bash',
04:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:17 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:17 INFO - 'USER': 'cltbld',
04:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:17 INFO - 'XPC_FLAGS': '0x0',
04:13:17 INFO - 'XPC_SERVICE_NAME': '0',
04:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-l8I53J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-cze1Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-dKhfLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-wLBS0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-MswO3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
04:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
04:13:17 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-WjRixz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-ft7m4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-DeJ3xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-0qeqEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-42eGXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-IjNgsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-r3Fwn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-3Ux5pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-nx6SSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-qmseuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
04:13:18 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-BIRviI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
04:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
04:13:19 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Jj0SfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
04:13:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
04:13:19 INFO - Running setup.py install for manifestparser
04:13:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
04:13:19 INFO - Running setup.py install for mozcrash
04:13:19 INFO - Running setup.py install for mozdebug
04:13:19 INFO - Running setup.py install for mozdevice
04:13:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin
04:13:19 INFO - Running setup.py install for mozfile
04:13:19 INFO - Running setup.py install for mozhttpd
04:13:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Running setup.py install for mozinfo
04:13:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Running setup.py install for mozInstall
04:13:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Running setup.py install for mozleak
04:13:20 INFO - Running setup.py install for mozlog
04:13:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Running setup.py install for moznetwork
04:13:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
04:13:20 INFO - Running setup.py install for mozprocess
04:13:20 INFO - Running setup.py install for mozprofile
04:13:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
04:13:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
04:13:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
04:13:21 INFO - Running setup.py install for mozrunner
04:13:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
04:13:21 INFO - Running setup.py install for mozscreenshot
04:13:21 INFO - Running setup.py install for moztest
04:13:21 INFO - Running setup.py install for mozversion
04:13:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
04:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
04:13:21 INFO - Cleaning up...
04:13:21 INFO - Return code: 0
04:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:21 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
04:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
04:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:21 INFO - 'HOME': '/Users/cltbld',
04:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:21 INFO - 'LOGNAME': 'cltbld',
04:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:21 INFO - 'MOZ_NO_REMOTE': '1',
04:13:21 INFO - 'NO_EM_RESTART': '1',
04:13:21 INFO - 'PAGER': '/bin/cat',
04:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:21 INFO - 'PWD': '/builds/slave/test',
04:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:21 INFO - 'SHELL': '/bin/bash',
04:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:21 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:21 INFO - 'USER': 'cltbld',
04:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:21 INFO - 'XPC_FLAGS': '0x0',
04:13:21 INFO - 'XPC_SERVICE_NAME': '0',
04:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-5Xc78Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-tfwHiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
04:13:22 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))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-80_1OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-47wuGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
04:13:22 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))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-akWZTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-5UDteF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-x6b1U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-FWggAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-mBQ8Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
04:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
04:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
04:13:22 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-FnxNx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
04:13:23 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))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-G70Vez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-PTbs3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
04:13:23 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))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-YuDuWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-KKK0CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
04:13:23 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))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Hj374e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-8UaVi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
04:13:23 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))
04:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
04:13:23 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-sARWol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
04:13:23 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))
04:13:23 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))
04:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
04:13:23 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))
04:13:23 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))
04:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
04:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
04:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
04:13:26 INFO - Downloading blessings-1.6.tar.gz
04:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
04:13:26 INFO - Installing collected packages: blessings
04:13:26 INFO - Running setup.py install for blessings
04:13:26 INFO - Successfully installed blessings
04:13:26 INFO - Cleaning up...
04:13:26 INFO - Return code: 0
04:13:26 INFO - Done creating virtualenv /builds/slave/test/build/venv.
04:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
04:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
04:13:27 INFO - Reading from file tmpfile_stdout
04:13:27 INFO - Current package versions:
04:13:27 INFO - blessings == 1.6
04:13:27 INFO - blobuploader == 1.2.4
04:13:27 INFO - docopt == 0.6.1
04:13:27 INFO - functools32 == 3.2.3-2
04:13:27 INFO - jsonschema == 2.5.1
04:13:27 INFO - manifestparser == 1.1
04:13:27 INFO - mozInstall == 1.12
04:13:27 INFO - mozcrash == 1.0
04:13:27 INFO - mozdebug == 0.1
04:13:27 INFO - mozdevice == 0.50
04:13:27 INFO - mozfile == 1.2
04:13:27 INFO - mozhttpd == 0.7
04:13:27 INFO - mozinfo == 0.9
04:13:27 INFO - mozleak == 0.1
04:13:27 INFO - mozlog == 3.4
04:13:27 INFO - moznetwork == 0.27
04:13:27 INFO - mozprocess == 0.25
04:13:27 INFO - mozprofile == 0.28
04:13:27 INFO - mozrunner == 6.13
04:13:27 INFO - mozscreenshot == 0.1
04:13:27 INFO - mozsystemmonitor == 0.3
04:13:27 INFO - moztest == 0.8
04:13:27 INFO - mozversion == 1.4
04:13:27 INFO - psutil == 3.1.1
04:13:27 INFO - requests == 1.2.3
04:13:27 INFO - wsgiref == 0.1.2
04:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13:27 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 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos
04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
04:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:27 INFO - 'HOME': '/Users/cltbld',
04:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:27 INFO - 'LOGNAME': 'cltbld',
04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:27 INFO - 'MOZ_NO_REMOTE': '1',
04:13:27 INFO - 'NO_EM_RESTART': '1',
04:13:27 INFO - 'PAGER': '/bin/cat',
04:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:27 INFO - 'PWD': '/builds/slave/test',
04:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:27 INFO - 'SHELL': '/bin/bash',
04:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:27 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:27 INFO - 'USER': 'cltbld',
04:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:27 INFO - 'XPC_FLAGS': '0x0',
04:13:27 INFO - 'XPC_SERVICE_NAME': '0',
04:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
04:13:27 INFO - Cleaning up...
04:13:27 INFO - Return code: 0
04:13:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
04:13: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')]}
04:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
04:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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')]}
04:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
04:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
04:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee99b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdbd95e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, '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.X9jjysFSgV/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.5u9AAAAgtm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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
04:13: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', 'jsonschema'] in /builds/slave/test/build
04:13: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 jsonschema
04:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:27 INFO - 'HOME': '/Users/cltbld',
04:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:27 INFO - 'LOGNAME': 'cltbld',
04:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:27 INFO - 'MOZ_NO_REMOTE': '1',
04:13:27 INFO - 'NO_EM_RESTART': '1',
04:13:27 INFO - 'PAGER': '/bin/cat',
04:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:27 INFO - 'PWD': '/builds/slave/test',
04:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:27 INFO - 'SHELL': '/bin/bash',
04:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:27 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:27 INFO - 'USER': 'cltbld',
04:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:27 INFO - 'XPC_FLAGS': '0x0',
04:13:27 INFO - 'XPC_SERVICE_NAME': '0',
04:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/
04:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
04:13:27 INFO - Cleaning up...
04:13:27 INFO - Return code: 0
04:13:27 INFO - Running post-action listener: _resource_record_post_action
04:13:27 INFO - Running post-action listener: _start_resource_monitoring
04:13:27 INFO - Starting resource monitoring.
04:13:27 INFO - [mozharness: 2017-04-24 11:13:27.624313Z] Finished create-virtualenv step (success)
04:13:27 INFO - [mozharness: 2017-04-24 11:13:27.625262Z] Running install step.
04:13:27 INFO - Running pre-action listener: _resource_record_pre_action
04:13:27 INFO - Running main action method: install
04:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
04:13:27 INFO - Reading from file tmpfile_stdout
04:13:27 INFO - Detecting whether we're running mozinstall >=1.0...
04:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
04:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
04:13:27 INFO - Reading from file tmpfile_stdout
04:13:27 INFO - Output received:
04:13:27 INFO - Usage: mozinstall [options] installer
04:13:27 INFO - Options:
04:13:27 INFO - -h, --help show this help message and exit
04:13:27 INFO - -d DEST, --destination=DEST
04:13:27 INFO - Directory to install application into. [default:
04:13:27 INFO - "/builds/slave/test"]
04:13:27 INFO - --app=APP Application being installed. [default: firefox]
04:13:27 INFO - mkdir: /builds/slave/test/build/application
04:13:27 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']
04:13:27 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
04:13:47 INFO - Reading from file tmpfile_stdout
04:13:47 INFO - Output received:
04:13:47 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox
04:13:47 INFO - Running post-action listener: _resource_record_post_action
04:13:47 INFO - [mozharness: 2017-04-24 11:13:47.974085Z] Finished install step (success)
04:13:47 INFO - [mozharness: 2017-04-24 11:13:47.974229Z] Running run-tests step.
04:13:47 INFO - Running pre-action listener: _resource_record_pre_action
04:13:47 INFO - Running main action method: run_tests
04:13:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
04:13:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
04:13:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
04:13:47 INFO - 2017-04-24 04:13:47.988 screenresolution[1624:7551] starting screenresolution argv=screenresolution get
04:13:47 INFO - 2017-04-24 04:13:47.991 screenresolution[1624:7551] Display 0: 1600x1200x32@60
04:13:47 INFO - 2017-04-24 04:13:47.996 screenresolution[1625:7553] starting screenresolution argv=screenresolution list
04:13:47 INFO - Available Modes on Display 0
04:13:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
04:13:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
04:13:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
04:13:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
04:13:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
04:13:48 INFO - Intel Iris:
04:13:48 INFO - Chipset Model: Intel Iris
04:13:48 INFO - Type: GPU
04:13:48 INFO - Bus: Built-In
04:13:48 INFO - VRAM (Dynamic, Max): 1536 MB
04:13:48 INFO - Vendor: Intel (0x8086)
04:13:48 INFO - Device ID: 0x0a2e
04:13:48 INFO - Revision ID: 0x0009
04:13:48 INFO - Displays:
04:13:48 INFO - Display:
04:13:48 INFO - Resolution: 1600 x 1200 @ 60 Hz
04:13:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
04:13:48 INFO - Display Serial Number: 1600x1200 60
04:13:48 INFO - Main Display: Yes
04:13:48 INFO - Mirror: Off
04:13:48 INFO - Online: Yes
04:13:48 INFO - Rotation: Supported
04:13:48 INFO - Return code: 0
04:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
04:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
04:13:48 INFO - Python 2.7.3
04:13:48 INFO - Return code: 0
04:13:48 INFO - grabbing minidump binary from tooltool
04:13:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
04:13:48 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 0x10ec77d30>, '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 0x10eb9ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec6cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
04:13:48 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
04:13:48 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
04:13:48 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
04:13:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
04:13:48 INFO - Return code: 0
04:13:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755
04:13:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
04:13:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
04:13:48 INFO - ENV: RUST_BACKTRACE is now 1
04:13:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk
04:13:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
04:13:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build
04:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log
04:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.X9jjysFSgV/Render',
04:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
04:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
04:13:48 INFO - 'HOME': '/Users/cltbld',
04:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
04:13:48 INFO - 'LOGNAME': 'cltbld',
04:13:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
04:13:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk',
04:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
04:13:48 INFO - 'MOZ_NO_REMOTE': '1',
04:13:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
04:13:48 INFO - 'NO_EM_RESTART': '1',
04:13:48 INFO - 'PAGER': '/bin/cat',
04:13:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
04:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
04:13:48 INFO - 'PWD': '/builds/slave/test',
04:13:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
04:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
04:13:48 INFO - 'RUST_BACKTRACE': '1',
04:13:48 INFO - 'SHELL': '/bin/bash',
04:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5u9AAAAgtm/Listeners',
04:13:48 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/',
04:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
04:13:48 INFO - 'USER': 'cltbld',
04:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
04:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
04:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
04:13:48 INFO - 'XPC_FLAGS': '0x0',
04:13:48 INFO - 'XPC_SERVICE_NAME': '0',
04:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
04:13:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600
04:13:48 INFO - mozversion application_buildid: 20170424030211
04:13:48 INFO - mozversion application_changeset: 73752931e273091185e1e4b5231c28beed657cc8
04:13:48 INFO - mozversion application_display_name: Nightly
04:13:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
04:13:48 INFO - mozversion application_name: Firefox
04:13:48 INFO - mozversion application_remotingname: firefox
04:13:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
04:13:48 INFO - mozversion application_vendor: Mozilla
04:13:48 INFO - mozversion application_version: 55.0a1
04:13:48 INFO - mozversion platform_buildid: 20170424030211
04:13:48 INFO - mozversion platform_changeset: 73752931e273091185e1e4b5231c28beed657cc8
04:13:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
04:13:48 INFO - mozversion platform_version: 55.0a1
04:13:48 INFO - using testdate: 1493032428
04:13:48 INFO - actual date: 1493032428
04:13:48 INFO - starting webserver on 'localhost:49241'
04:13:48 INFO - SUITE-START | Running 2 tests
04:13:48 INFO - TEST-START | dromaeo_css
04:13:48 INFO - operating with platform_type : mac_
04:13:48 INFO - Initialising browser for dromaeo_css test...
04:13:48 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpqXKC5r/profile http://localhost:49241/getInfo.html)
04:13:51 INFO - PID 1635 | __metrics Screen width/height:1600/1200
04:13:51 INFO - PID 1635 | colorDepth:24
04:13:51 INFO - PID 1635 | Browser inner width/height: 1024/689
04:13:51 INFO - PID 1635 | __metrics
04:13:51 INFO - PID 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
04:13:51 INFO - PID 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
04:13:52 INFO - TEST-INFO | 1635: exit 0
04:13:52 INFO - Browser initialized.
04:13:52 INFO - Running cycle 1/1 for dromaeo_css test...
04:13:52 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpqXKC5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
04:14:04 INFO - PID 1638 | RSS: Main: 241676288
04:14:04 INFO - PID 1638 |
04:17:09 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html)
04:17:11 INFO - PID 1638 | RSS: Main: 410107904
04:17:11 INFO - PID 1638 |
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task.
04:18:54 INFO - PID 1638 |
04:18:54 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource.
04:18:54 INFO - PID 1638 | Full stack:
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task.
04:18:54 INFO - PID 1638 |
04:18:54 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource.
04:18:54 INFO - PID 1638 | Full stack:
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task.
04:18:54 INFO - PID 1638 |
04:18:54 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource.
04:18:54 INFO - PID 1638 | Full stack:
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | *************************
04:18:54 INFO - PID 1638 | A coding exception was thrown and uncaught in a Task.
04:18:54 INFO - PID 1638 |
04:18:54 ERROR - PID 1638 | Full message: TypeError: NetworkError when attempting to fetch resource.
04:18:54 INFO - PID 1638 | Full stack:
04:18:54 INFO - PID 1638 | *************************
04:20:14 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html)
04:20:14 INFO - PID 1638 | RSS: Main: 368672768
04:20:14 INFO - PID 1638 |
04:23:16 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html)
04:23:17 INFO - PID 1638 | RSS: Main: 335060992
04:23:17 INFO - PID 1638 |
04:26:20 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html)
04:26:20 INFO - PID 1638 | RSS: Main: 322547712
04:26:20 INFO - PID 1638 |
04:29:24 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html)
04:29:24 INFO - PID 1638 | RSS: Main: 325734400
04:29:24 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html)
04:32:27 INFO - PID 1638 | RSS: Main: 374734848
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | __start_tp_report
04:32:27 INFO - PID 1638 | _x_x_mozilla_page_load
04:32:27 INFO - PID 1638 | _x_x_mozilla_page_load_details
04:32:27 INFO - PID 1638 | |i|pagename|runs|
04:32:27 INFO - PID 1638 | |0;dojo.html;3056.4498390289746;3557.466380042993;3574.106473381655;3596.0829988352966;3598.3343081529933;6083.574149809504;6165.352637973016;6257.906131408021;6317.115603815464;6362.045693146025;6106.786262480825;6187.102870083835;6247.593906396081;6264.6867656617105;6280.905786413196;5256.500632439931;5353.330833645794;5359.356877174744;5401.621886467949;5471.534919531845;5241.816536421226;5395.163749618815;5404.432534583871;5457.099578569531;5472.534834539069;5329.227262047001;5337.199420086979;5343.251944727741;5376.435474275184;5420.105682562373;5325.254464374991;5331.546818520431;5338.679679219259;5341.519263266325;5403.648762830403;5324.653897496651;5341.919871201935;5365.7853685852515;5370.624056316059;5384;6008.158857759917;6102.428659372087;6131.3868613138775;6138.508919286491;6189.535784816157;6618;6620.205575330943;6623.86752264952;6632.602043877383;6639.535232533724;6666.866662666768;6722.159730033746;6735.696893639749;6736.157980252468;6745.730170793162;6127.830981140938;6209.068639704081;6298.811035668938;6394.360563943615;6412.487001039905;6590.110335104795;6778.949262864264;6845.110135682429;6855.280195579492;6866.828329291708;6407.519436042316;6440.452561532228;6445.967770161213;6447.548671593037;6462.676866156768;6608.504362172856;6701.1623547056615;6706.362895524917;6711.563748356439;6712.060311556386;6595.307492713292;6598.3401659833635;6598.60408375499;6599.043138744855;6599.340065993362;6325.399087086719;6362.45919096882;6413.134226879405;6426.4537514311805;6631.834204144839;5248.265242866002;5272.6836389816735;5273.868153296198;5280.894382112337;5306.257124002643;4595.747233902168;4706.811727530929;4727.314539391769;4730.526947305242;4745.83389581363;6089.421504957022;6116.235470566179;6193.907091393633;6293.937060629427;6302.65335406557;5370.3287089113865;6463.192100987377;6618.7021584028835;6623.7350505980185;6711.597304161766;6275.811725648238;6293.653849038347;6303.054541818764;6306.590071645328;6329.367063293634;5812.38969908162;5822.155787410802;5828.88342233153;5856.59003869725;5902.291724992942;6524.902126468011;6632.535722499379;6741.595504269563;6871.690773915186;6916.757913473206;6689.2976237496305;6696.062551242927;6704.899426508508;6719.563228390139;6726.831829204309;6836.350546698056;6879.484038697218;6884.690188941409;6888.173419189729;6890.552114112566;6323.146375239284;6546.116274302908;6589.308122647245;6598.307177746459;6625.801225963229;5415.323084614423;6460.644664543495;6590.5716128451495;6652.567583107082;6686.264510903699;5750.741216645178;6121.714439967656;6389.840253993687;6400.487960963205;6467.870642587028;6347.143135676624;6349.206349206349;6353.745850165941;6411.775587854403;6420.935790642221;6373.904391434039;6425.10048593188;6425.485961123006;6432.3567643237175;6448.580842245239;6311.084892690443;6430.453411460078;6432.9678351607945;6437.291897891135;6444.613323200623;6267.310595834363;6299.716512757029;6305.495560355253;6318.399752023551;6366.267879193952
04:32:27 INFO - PID 1638 | |1;ext.html;713.7787285941358;764.5603777827748;782.5265714242882;1075.354787127723;1081.8972197641226;26249.212523624275;26435.33911652205;26449.47101057978;26460.338491537696;26500.33749156272;36417.08957276069;36525.26949461009;36533;36542.45186322207;36598.26803463929;8251.46365486243;8387.161283871625;8389.370797190204;8398.622062007194;8404.873926891101;5963.612365196248;6051.485623721989;8271.710490132846;8383.748487545354;8391.454555453907;8204.876926846073;8383.790405239857;8390.454620449651;8390.958045209796;8442.535660538699;8376.246137847593;8420.28427583656;8423.284020858235;8436.493810371367;8439.789005274855;5938.851528711773;6051.515878729691;8276.710315139002;8370.623321950467;8378.748637540884;25822.967081316725;26036;26098.478030439284;34718.958431247105;34770;3513.1744040150543;3537.2394935088823;3538.0093573799377;3539.132912436444;3542.574891013069;29487.41025179506;29575;29588;29636.40727185466;29710.96011639582;2663.3741070848337;3120.9219769505717;3136.4511210538294;3153.369326134782;3163.4938409854544;220583.89708051516;287511.56244218856;289072;289779;289933.5503322491;39002.41496377557;47410;47540;47642.761786190844;47709.284360734615;48255;48276.03447931092;48418;48530;48565.02869942581;13544.796828047587;13692.589222323346;13695.520656776966;13700.109492882932;13701.383437745326;11305.773884522263;11308.151888608387;11309.886901130883;11312.321260724382;11322.660320190407;9920.958299378606;10027.899721002843;11461.656150315504;11468.713282168013;11629.1859569831;4419.1382680377665;5204.947950520522;5224.111900976843;5237.423883372826;5269.1569348903995;926.4441335198827;968.6270785747397;1021.279997601689;1022.99488502557;1064.5794911010107;23805.523889522112;23918.64122038171;23994;24027.7597224029;24302.7569724304;1107.9335239885634;1119.6808909460765;1132.3998280910967;1146.7190538318166;1151.205668089016;9334.766630834283;10598.523066462029;11875.40622968848;12139;12195.939020305019;260334.69832650715;312171;313827;314923;315213;41864;51248.74375628173;51479.74260128675;51547.22679159816;51590.74204628953;1469.8162729658793;1502.5417247739763;1514.7576387777904;1524.6569521857716;1526.114853385034;16643.667126657157;21034.632748871274;22832;23668.28995130149;23704.8814755932;36126.458103129;36184.63815361918;36268.63731362758;36292.637073628925;36337.091572710895;277124;277160;277651;277715;278743;26382;33094.50358244676;33111.50332744962;33188.83839065621;33258.50112248366;36499.087522812144;36962.44556331603;37075.81462092672;37103;44287.778561106985;25763;26345.868270658524;26642;30445.54331684982;30761.077167685005;26282.605760913983;27702.03042893489;29935.952241671435;30503.54244686287;30807;36420.635793641726;36472;36565;36573.45139822958;36588.26823463463;28907.710922890503;29115.695210682086;30087.097387078422;30783.53824692676;30937.226569335948;21474.57050859005;22664.433389165402;23754.31427778001;24040.75959240385;24286.514269714153
04:32:27 INFO - PID 1638 | |2;jquery.html;420.95014461212463;430.15045285561;431.0538368281621;436.8012554287799;453.9909201815964;19478.707819382704;20903.790962090392;21484.355469335907;21660.675089873625;21705.612382637897;21407.464813379673;21854.344369668896;21880.45298867529;22153.335399938027;22720.204792832254;5981.730822113004;6303.936960630381;6315.336889626569;6323.810285691414;6323.9051414228825;5850;6171.352008039158;6218.129461875341;6240.531960102988;6242.625442473443;5970.820875373724;6193.0710393440895;6202.162708034402;6211.9378806212035;6216.347283535231;6051.939480605181;6206.100115483275;6213.099100630383;6219.346968568326;6257.906131408033;5250.81622143227;5493.423190564973;5513.972430137864;5515.503604675559;5543.473370029841;26462.206133816017;26702.73297267022;26719.599206011924;26748;26842.865785670947;2209.7900699433526;2263.173941511353;2264.4338915271182;2266.184173697484;2268.2514770125817;17421.041842698647;17447.47657570275;17663.470095897144;17848.46454606364;18161.63676726458;2094.5182608000246;2142.817860481861;2164.0802658869916;2165.2421652421526;2169.316665250441;137643;138635.30682346725;147807.6096195186;148056;154281;11614.883851161549;12122.696932576757;12126.575569855013;12135.453904574315;12235.816462753066;16289.266982985793;16313.918430407772;16337;16346.75479867803;16418;7363.263673632701;8485.32117430604;8654.524001179996;8760.167784060504;8829.072947340437;8227.794305142299;8230.794230144174;8250.16367389155;8384.413091083565;8426.4944103354;6674.899876501856;7492.400607951351;7650.961745191238;7685.884711729329;7823.374130069581;2114.2071723103836;2115.968260476094;2120.3744895255936;2123.1719629344566;2242.8990695418747;905.3933864310927;916.724982505259;927.7448701606977;943.9757862719027;963.7354705428451;16340.836591633932;18735.437936861916;20189.990500474916;21197.78802211989;21439.35830465681;921.8064206516573;956.1585804492003;978.496074521622;1002.2082554781787;1017.4099022566893;10432;10902.291351062155;10986.780264394667;10989.725256868482;11049.558017679363;539650;547469;559892;559903;560138;109846;116826.8317316833;122284;123868;125556;1119.462657924201;1179.121554441929;1202.2425871700773;1225.2709637765515;1225.5649244518247;20925.79074209299;22088.77911220867;22306.442338941008;22464.39479906648;22581.209657661904;55534.61351944417;57318;57365.713171433876;57595.40820663164;58201;80051.59974200092;80194.79707804504;80314.59842700748;81095;81716.59141704254;8599.871001934851;8824.161704638049;8933.240674542476;9026.503542305236;9053.275737941081;12981.286029268482;13797.241151736349;13840.446382145004;14220.431182752574;14260.215688137252;11795.646130616095;11840.28958262507;11886.702832429259;12073.335966521925;12088.516459341528;9580.473073980998;10599.947000264949;10973.50619222121;11009.394483303495;11132.833007504732;11637.359945203096;11771.411429428666;11798.87910648487;12085.274883507018;12113.273203607812;8439.620217090123;8546.743597692079;8990.215069785716;9019.278457723498;9033.322500812597;11660.650180494598;11940.940295298467;12051.216670916363;12068.33624150645;12100.697482563006
04:32:27 INFO - PID 1638 | |3;mootools.html;1194;1382.7994940733595;1414.653409914571;1435.8923080768939;1445.3495926832925;9777.12005919467;10213.948930255348;11650.941745291262;11918.404079795997;11929.284242945409;11542.769144617103;11654.766904661923;11658.533658653643;11660;11708.121890858198;2497.6503289539432;2536.695596528419;2540.707818600866;2543.796496280293;2544.8473091614565;2080.209520382253;2124.925627603034;2200.1529411176653;2550.923472295834;2565.28172111809;2485.1923124984364;2496.0390249753887;2516.6350879122606;2516.987415062922;2519.760622740837;2515.320863366899;2519.533886231053;2520.823542352036;2524.936876578082;2528.3679080230036;2442.841215321016;2468.049800826677;2472.1471092473066;2473.146764366291;2475.616279476684;11593.956543911005;11749.94125029378;11785.528578856836;11790;11794.174407791457;6590.703418346186;6834.965825170842;6835.418989385908;6838.179418469816;6844.28135045823;3897.941530877039;4010.218007488541;4380.67144964129;4381.298992161271;4392.1874453226255;1056.561526966308;1257.9056221087621;1280.7950727883494;1283.9486420543167;1297.221666999802;16809.6638067238;16874.66250674992;16900.66198676032;16908.746368804477;16916.999999999876;5047.570956468668;5860.355360910382;6022.277326720821;6125.081237814364;6143.477804386588;12213.389330533439;13430.93284533571;13770.93114534421;13773.449062037405;13783.586492405044;6461.547691661539;6850.4862135340045;6850.897236541456;6859.794206173823;6861.210960739479;5232.084385232569;6196.938030619726;6247.187865577446;6299.968500157562;6301.684915754194;3542.75200735946;4157.97921010393;4658.138244424792;4737.431508219036;4751.95248047522;1421.7440860645183;1464.6045567696663;1465.1648560320727;1482.1329522229616;1485.3167542930157;666.7099811581977;794.0273165372373;810.8824220487996;815.5555222403805;820.6348175062041;6209.161763162006;6369.71336289868;6392.137061496638;6417.454516366068;6681.298463661343;922.8707980882682;922.8846394200725;928.5403725156091;948.0519480519481;963.3834346018554;4193.35003074524;4548.658850586153;4594.19601569724;4732.107157137104;4768.3085952537385;14652.706945861237;14678.339474723663;15331.310091045929;15357.539273821803;15521.068735875884;14830.62923426923;15071.849281507264;15268.160251186291;15305.46430874914;15500.767488487681;8451.239388454946;8491.490510569509;8715.956420217984;8722.65109395617;8723;6742.595444273359;6780.957679869281;6914.27400123;7026.402755765817;7097.858042839011;12652.240865548096;12969.870301296865;13027.088103833019;13454.798178027533;13893.58319250424;13791.103578267783;13924.91126331018;13997.720045598828;14086.647833804236;14218.217998010208;7320.524165929198;9631.71104866855;9708.466034368177;9723.416595004323;9750.366226195274;8925.196732294125;9492.667756628485;9731.075547822946;10530.894691052992;10594.205434592282;9178.862317065383;9242.630294788134;9262.629494820132;9308.906910931075;9337.019612940816;8834.955825220834;9084.909150908406;9158.358914875895;9246.95376523113;9338.579763910504;8134.389920756085;8221.17788221173;8251.752447426587;8351.039630442578;8364.498130112213;5889.941100589111;5975.283285059819;6137.478314343331;6216.191895053614;6219.0982307566055;6195;6199.884020876286;6209.658468784261;6214.4407003369915;6263.561550691408
04:32:27 INFO - PID 1638 | |4;prototype.html;332.5169742946459;402.05918151525424;407.7268230285707;407.81036817879715;413.60707328038353;5704.315482142144;5716.456936591027;5805;5821.621594596353;5834.358220595742;4625.861224163272;5424.349078110622;5649.322081350233;5689.886202275952;5719.084946408576;4000.2599519088917;4161.895952601187;4394.077243778795;4399.38408622793;4422.690411671184;3621.5110960020456;3853.9614603853884;4422.513523512411;4434.911301773963;4450.866474005768;4204.171185534302;4345.956540434602;4362.389265502817;4398.780060996937;4414.726415895816;4363.607275345218;4363.978180109111;4372.185542999668;4378.6934914555995;4378.934315985262;3454.7754395964434;3914.256291304643;3922.8430862765454;3936.940945885814;3940.876850097737;4742.359781429497;5382.0581398255545;5591.707399965994;5630.521405680522;5677.40387259336;3945.7237993340477;5278.498542638443;5290.312259406291;5308.761105750251;5312.73436328182;5283.709395983258;5331.466853314676;5527.55779537636;5803.767849286023;6144.477719393813;3474.5309383233193;3542.663446972559;4149.808693219869;4488.685791994561;4497.662675299365;6229.221347331583;6384.3296453872135;6412.39082287182;6450.354964503559;6572.638504882229;4144.544100148981;4154.065335299533;4158.979205104016;4168.312228482328;4174.415581818548;3987.1228329767405;4142.5857414258335;4259.680523960716;4357.607815296638;4371.125774845043;4596.6336623776315;4998.575121114746;5052.469490703424;5071.644984851099;5087.796488140433;5909.379515150933;6032.758689652364;6045.546584006217;6060.181875446847;6062.636241825505;1139.3562637110006;1404.1364560795037;1433.813604231464;1477.8004969329004;1487.4496436318416;914.8409752982955;945.7304668169538;997.9950100249453;999.5701848205196;1002.7838476965841;5118.872028199325;5459.2902922619805;5499.422560631157;5731.140328950607;5746.489006130168;6316.873662526724;6322.70384571171;6328.525360597973;6346.809595712136;6351.872962540816;5017.799288028438;5512.531434828004;5750.942490575125;5762.674584845425;5826.213461182686;3126.4841301185506;3298.3238436120537;3326.5841769778776;3348.5814273215847;3353.3293341331832;5222.973885130626;6603.603783772989;6608.603483790988;6613.222446572355;6650.301718319603;6179.16581261533;6571.638559879157;6573.014047892854;6573.441257493071;6585.49751094581;5740.368559458373;6591.6374599397495;6611.603303801788;6649.102371179925;6652.301508341651;5530.336359636869;5997.520198384032;6328.6519241442165;6421.1010458536775;6434.356564343529;6348.9047664286;6353.936460635335;6358.491320694241;6368.777092801915;6401.231852177769;6385.828818201834;6565.901511477236;6622.569532980341;6675.632840193836;6692.063111164538;3745.5130832991535;4266.616004559604;4288.978555107205;4295.196017672522;4310.655147588248;5931.317898441562;6012.7294271757;6146.723397447036;6247.094171345038;6452.709628066655;4351.369051487453;6082;6129.877402451837;6183.350748171377;6185.103160041679;4633.837815676435;4899.926501102557;4988.351514303263;6091.939080609314;6149.354317796567;5041.6470847040355;5282.366116066097;5820.970895145667;6021.367756385516;6053.273607167168;5586.245856809279;5780.277465316835;6236;6246.9062964054665;6257.2491301044165;5636.098224284095;6076.387153524027;6084.421979911901;6093.756249750138;6109.389061093855
04:32:27 INFO - PID 1638 | |5;yui.html;704.1022696062523;844.3751623798383;848.2281124177;851.6210286422543;860.1742327365729;12990.675233119166;18125.27498900044;18737.969411682352;18755.718664220047;18757.99999999998;16651.916740416313;16757.078360690157;16783.992960422354;16784;16848.410305639303;641.0288413054227;654.7577396363353;667.4426853577256;937.3485427627801;938.352536749644;684.4763755726873;931.2736065868634;931.4411353188067;944.3483996042743;958.1663952361455;988.8121256961155;989.5448093876789;989.9208063354914;992.0971915556845;1037.5953378182514;891.5631340643102;984.6110786239395;985.0395864032547;985.4235272365675;1038.3665963762098;729.3180875881068;730.9963450182715;733.6295170938641;741.4105785900223;772.2432016623684;15615.297311621005;15838.52484425469;16051;16220.270087846075;16518.917405413016;16004.03975761458;16104;16333.673326533402;16401.83598164015;16519.91740041304;13469.461221551224;13586.11690240141;13719.931400342934;13723.039387242898;13949.372278247401;3393.6776006279365;3419.8290085495873;3422.3155368926314;3425.794452332868;3427.246005878728;115421.99999999916;118006;124712.37643811814;125716;126565;11508.424578771028;11602.013828824476;11629.767404651859;11724.824127638092;11740.941295293469;19305.710414343797;19320.4203873884;19520.511987200432;19587.412377628694;19624.803751962583;7343.926560734431;7485.812854678567;7495.175530691619;7497.2877576630135;7511.661975211128;3839.404892241707;3915.8433662653742;3920.098377373163;3920.686345092443;3922.627350401707;4066.8576599819457;4674;4786.473487916396;4841.467438581753;4843.854684359475;932.3613324872484;960.5485421851719;974.1135566634329;977.6822532676908;978.814025335184;574.1617238831269;643.829385212919;660.7158921663731;664.8404382948057;688.9069975553336;8894;9849.55676994537;10626.628068017582;10857.45712714361;11744.530218791324;547.854818473105;615.2647586134526;627.3569591168997;634.3339493531773;646.7380710812129;5406.189071639285;5459.781608735686;5497.642653227527;5535.667859928417;5632.408597097246;79964;104715;104730;107154.46422767836;107650;90091.64862527067;92283.53858230666;92765;95042;95530.56704149443;81799.18200818035;83598;83640.32719345701;83888.16111838925;85056;10658.573657053632;10753.46232688378;11017.944910275397;11104;11336.376499292288;39931.00172495711;39986.600133999455;40420.989475263355;40588.79705601571;40772.79613601913;51496;51914.221286679975;52063.219051713495;52313.738431307596;52882.735586321825;13949.232792196526;14069.577912662637;14229.786553201917;14300.640394335234;14405.92797036008;14867.405303787727;14903.403863845324;15036.774448383501;15090.471833485775;15157.317920693375;14393.712125757216;14496.492622758153;14581.489647862274;14628.195449250394;14691.41234350614;14142.78785818234;14449.85550144485;14457.710845782814;14573.344199511259;14577.781333279798;13974;14043.648908777363;14274.429022839386;14328.426862925366;14389;10133.341332813343;10345.63790267337;10493.685189444328;10543.26197166191;10760.946195269287;13402.195868247936;13617.31913404306;13794.655133621338;13796.517121900686;13817.516386926409
04:32:27 INFO - PID 1638 | __end_tp_report
04:32:27 INFO - PID 1638 | __start_cc_report
04:32:27 INFO - PID 1638 | _x_x_mozilla_cycle_collect,1849
04:32:27 INFO - PID 1638 | __end_cc_report
04:32:27 INFO - PID 1638 | __startTimestamp1493033547494__endTimestamp
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | ------- Summary: start -------
04:32:27 INFO - PID 1638 | Number of tests: 6
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6094.02 Median:6329.37 stddev:722.17 (11.4%) stddev-sans-first:683.94
04:32:27 INFO - PID 1638 | Values: 3056.4 3557.5 3574.1 3596.1 3598.3 6083.6 6165.4 6257.9 6317.1 6362.0 6106.8 6187.1 6247.6 6264.7 6280.9 5256.5 5353.3 5359.4 5401.6 5471.5 5241.8 5395.2 5404.4 5457.1 5472.5 5329.2 5337.2 5343.3 5376.4 5420.1 5325.3 5331.5 5338.7 5341.5 5403.6 5324.7 5341.9 5365.8 5370.6 5384.0 6008.2 6102.4 6131.4 6138.5 6189.5 6618.0 6620.2 6623.9 6632.6 6639.5 6666.9 6722.2 6735.7 6736.2 6745.7 6127.8 6209.1 6298.8 6394.4 6412.5 6590.1 6778.9 6845.1 6855.3 6866.8 6407.5 6440.5 6446.0 6447.5 6462.7 6608.5 6701.2 6706.4 6711.6 6712.1 6595.3 6598.3 6598.6 6599.0 6599.3 6325.4 6362.5 6413.1 6426.5 6631.8 5248.3 5272.7 5273.9 5280.9 5306.3 4595.7 4706.8 4727.3 4730.5 4745.8 6089.4 6116.2 6193.9 6293.9 6302.7 5370.3 6463.2 6618.7 6623.7 6711.6 6275.8 6293.7 6303.1 6306.6 6329.4 5812.4 5822.2 5828.9 5856.6 5902.3 6524.9 6632.5 6741.6 6871.7 6916.8 6689.3 6696.1 6704.9 6719.6 6726.8 6836.4 6879.5 6884.7 6888.2 6890.6 6323.1 6546.1 6589.3 6598.3 6625.8 5415.3 6460.6 6590.6 6652.6 6686.3 5750.7 6121.7 6389.8 6400.5 6467.9 6347.1 6349.2 6353.7 6411.8 6420.9 6373.9 6425.1 6425.5 6432.4 6448.6 6311.1 6430.5 6433.0 6437.3 6444.6 6267.3 6299.7 6305.5 6318.4 6366.3
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:42339.92 Median:157653.73 stddev:75216.09 (47.7%) stddev-sans-first:75362.16
04:32:27 INFO - PID 1638 | Values: 713.8 764.6 782.5 1075.4 1081.9 26249.2 26435.3 26449.5 26460.3 26500.3 36417.1 36525.3 36533.0 36542.5 36598.3 8251.5 8387.2 8389.4 8398.6 8404.9 5963.6 6051.5 8271.7 8383.7 8391.5 8204.9 8383.8 8390.5 8391.0 8442.5 8376.2 8420.3 8423.3 8436.5 8439.8 5938.9 6051.5 8276.7 8370.6 8378.7 25823.0 26036.0 26098.5 34719.0 34770.0 3513.2 3537.2 3538.0 3539.1 3542.6 29487.4 29575.0 29588.0 29636.4 29711.0 2663.4 3120.9 3136.5 3153.4 3163.5 220583.9 287511.6 289072.0 289779.0 289933.6 39002.4 47410.0 47540.0 47642.8 47709.3 48255.0 48276.0 48418.0 48530.0 48565.0 13544.8 13692.6 13695.5 13700.1 13701.4 11305.8 11308.2 11309.9 11312.3 11322.7 9921.0 10027.9 11461.7 11468.7 11629.2 4419.1 5204.9 5224.1 5237.4 5269.2 926.4 968.6 1021.3 1023.0 1064.6 23805.5 23918.6 23994.0 24027.8 24302.8 1107.9 1119.7 1132.4 1146.7 1151.2 9334.8 10598.5 11875.4 12139.0 12195.9 260334.7 312171.0 313827.0 314923.0 315213.0 41864.0 51248.7 51479.7 51547.2 51590.7 1469.8 1502.5 1514.8 1524.7 1526.1 16643.7 21034.6 22832.0 23668.3 23704.9 36126.5 36184.6 36268.6 36292.6 36337.1 277124.0 277160.0 277651.0 277715.0 278743.0 26382.0 33094.5 33111.5 33188.8 33258.5 36499.1 36962.4 37075.8 37103.0 44287.8 25763.0 26345.9 26642.0 30445.5 30761.1 26282.6 27702.0 29936.0 30503.5 30807.0 36420.6 36472.0 36565.0 36573.5 36588.3 28907.7 29115.7 30087.1 30783.5 30937.2 21474.6 22664.4 23754.3 24040.8 24286.5
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:35195.60 Median:12422.19 stddev:93304.96 (751.1%) stddev-sans-first:93530.18
04:32:27 INFO - PID 1638 | Values: 421.0 430.2 431.1 436.8 454.0 19478.7 20903.8 21484.4 21660.7 21705.6 21407.5 21854.3 21880.5 22153.3 22720.2 5981.7 6303.9 6315.3 6323.8 6323.9 5850.0 6171.4 6218.1 6240.5 6242.6 5970.8 6193.1 6202.2 6211.9 6216.3 6051.9 6206.1 6213.1 6219.3 6257.9 5250.8 5493.4 5514.0 5515.5 5543.5 26462.2 26702.7 26719.6 26748.0 26842.9 2209.8 2263.2 2264.4 2266.2 2268.3 17421.0 17447.5 17663.5 17848.5 18161.6 2094.5 2142.8 2164.1 2165.2 2169.3 137643.0 138635.3 147807.6 148056.0 154281.0 11614.9 12122.7 12126.6 12135.5 12235.8 16289.3 16313.9 16337.0 16346.8 16418.0 7363.3 8485.3 8654.5 8760.2 8829.1 8227.8 8230.8 8250.2 8384.4 8426.5 6674.9 7492.4 7651.0 7685.9 7823.4 2114.2 2116.0 2120.4 2123.2 2242.9 905.4 916.7 927.7 944.0 963.7 16340.8 18735.4 20190.0 21197.8 21439.4 921.8 956.2 978.5 1002.2 1017.4 10432.0 10902.3 10986.8 10989.7 11049.6 539650.0 547469.0 559892.0 559903.0 560138.0 109846.0 116826.8 122284.0 123868.0 125556.0 1119.5 1179.1 1202.2 1225.3 1225.6 20925.8 22088.8 22306.4 22464.4 22581.2 55534.6 57318.0 57365.7 57595.4 58201.0 80051.6 80194.8 80314.6 81095.0 81716.6 8599.9 8824.2 8933.2 9026.5 9053.3 12981.3 13797.2 13840.4 14220.4 14260.2 11795.6 11840.3 11886.7 12073.3 12088.5 9580.5 10599.9 10973.5 11009.4 11132.8 11637.4 11771.4 11798.9 12085.3 12113.3 8439.6 8546.7 8990.2 9019.3 9033.3 11660.7 11940.9 12051.2 12068.3 12100.7
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7194.44 Median:4287.01 stddev:4570.16 (106.6%) stddev-sans-first:4560.74
04:32:27 INFO - PID 1638 | Values: 1194.0 1382.8 1414.7 1435.9 1445.3 9777.1 10213.9 11650.9 11918.4 11929.3 11542.8 11654.8 11658.5 11660.0 11708.1 2497.7 2536.7 2540.7 2543.8 2544.8 2080.2 2124.9 2200.2 2550.9 2565.3 2485.2 2496.0 2516.6 2517.0 2519.8 2515.3 2519.5 2520.8 2524.9 2528.4 2442.8 2468.0 2472.1 2473.1 2475.6 11594.0 11749.9 11785.5 11790.0 11794.2 6590.7 6835.0 6835.4 6838.2 6844.3 3897.9 4010.2 4380.7 4381.3 4392.2 1056.6 1257.9 1280.8 1283.9 1297.2 16809.7 16874.7 16900.7 16908.7 16917.0 5047.6 5860.4 6022.3 6125.1 6143.5 12213.4 13430.9 13770.9 13773.4 13783.6 6461.5 6850.5 6850.9 6859.8 6861.2 5232.1 6196.9 6247.2 6300.0 6301.7 3542.8 4158.0 4658.1 4737.4 4752.0 1421.7 1464.6 1465.2 1482.1 1485.3 666.7 794.0 810.9 815.6 820.6 6209.2 6369.7 6392.1 6417.5 6681.3 922.9 922.9 928.5 948.1 963.4 4193.4 4548.7 4594.2 4732.1 4768.3 14652.7 14678.3 15331.3 15357.5 15521.1 14830.6 15071.8 15268.2 15305.5 15500.8 8451.2 8491.5 8716.0 8722.7 8723.0 6742.6 6781.0 6914.3 7026.4 7097.9 12652.2 12969.9 13027.1 13454.8 13893.6 13791.1 13924.9 13997.7 14086.6 14218.2 7320.5 9631.7 9708.5 9723.4 9750.4 8925.2 9492.7 9731.1 10530.9 10594.2 9178.9 9242.6 9262.6 9308.9 9337.0 8835.0 9084.9 9158.4 9247.0 9338.6 8134.4 8221.2 8251.8 8351.0 8364.5 5889.9 5975.3 6137.5 6216.2 6219.1 6195.0 6199.9 6209.7 6214.4 6263.6
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:4972.99 Median:5558.29 stddev:1550.09 (27.9%) stddev-sans-first:1514.81
04:32:27 INFO - PID 1638 | Values: 332.5 402.1 407.7 407.8 413.6 5704.3 5716.5 5805.0 5821.6 5834.4 4625.9 5424.3 5649.3 5689.9 5719.1 4000.3 4161.9 4394.1 4399.4 4422.7 3621.5 3854.0 4422.5 4434.9 4450.9 4204.2 4346.0 4362.4 4398.8 4414.7 4363.6 4364.0 4372.2 4378.7 4378.9 3454.8 3914.3 3922.8 3936.9 3940.9 4742.4 5382.1 5591.7 5630.5 5677.4 3945.7 5278.5 5290.3 5308.8 5312.7 5283.7 5331.5 5527.6 5803.8 6144.5 3474.5 3542.7 4149.8 4488.7 4497.7 6229.2 6384.3 6412.4 6450.4 6572.6 4144.5 4154.1 4159.0 4168.3 4174.4 3987.1 4142.6 4259.7 4357.6 4371.1 4596.6 4998.6 5052.5 5071.6 5087.8 5909.4 6032.8 6045.5 6060.2 6062.6 1139.4 1404.1 1433.8 1477.8 1487.4 914.8 945.7 998.0 999.6 1002.8 5118.9 5459.3 5499.4 5731.1 5746.5 6316.9 6322.7 6328.5 6346.8 6351.9 5017.8 5512.5 5750.9 5762.7 5826.2 3126.5 3298.3 3326.6 3348.6 3353.3 5223.0 6603.6 6608.6 6613.2 6650.3 6179.2 6571.6 6573.0 6573.4 6585.5 5740.4 6591.6 6611.6 6649.1 6652.3 5530.3 5997.5 6328.7 6421.1 6434.4 6348.9 6353.9 6358.5 6368.8 6401.2 6385.8 6565.9 6622.6 6675.6 6692.1 3745.5 4266.6 4289.0 4295.2 4310.7 5931.3 6012.7 6146.7 6247.1 6452.7 4351.4 6082.0 6129.9 6183.4 6185.1 4633.8 4899.9 4988.4 6091.9 6149.4 5041.6 5282.4 5821.0 6021.4 6053.3 5586.2 5780.3 6236.0 6246.9 6257.2 5636.1 6076.4 6084.4 6093.8 6109.4
04:32:27 INFO - PID 1638 |
04:32:27 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:20938.19 Median:3421.07 stddev:30346.45 (887.0%) stddev-sans-first:30393.55
04:32:27 INFO - PID 1638 | Values: 704.1 844.4 848.2 851.6 860.2 12990.7 18125.3 18738.0 18755.7 18758.0 16651.9 16757.1 16784.0 16784.0 16848.4 641.0 654.8 667.4 937.3 938.4 684.5 931.3 931.4 944.3 958.2 988.8 989.5 989.9 992.1 1037.6 891.6 984.6 985.0 985.4 1038.4 729.3 731.0 733.6 741.4 772.2 15615.3 15838.5 16051.0 16220.3 16518.9 16004.0 16104.0 16333.7 16401.8 16519.9 13469.5 13586.1 13719.9 13723.0 13949.4 3393.7 3419.8 3422.3 3425.8 3427.2 115422.0 118006.0 124712.4 125716.0 126565.0 11508.4 11602.0 11629.8 11724.8 11740.9 19305.7 19320.4 19520.5 19587.4 19624.8 7343.9 7485.8 7495.2 7497.3 7511.7 3839.4 3915.8 3920.1 3920.7 3922.6 4066.9 4674.0 4786.5 4841.5 4843.9 932.4 960.5 974.1 977.7 978.8 574.2 643.8 660.7 664.8 688.9 8894.0 9849.6 10626.6 10857.5 11744.5 547.9 615.3 627.4 634.3 646.7 5406.2 5459.8 5497.6 5535.7 5632.4 79964.0 104715.0 104730.0 107154.5 107650.0 90091.6 92283.5 92765.0 95042.0 95530.6 81799.2 83598.0 83640.3 83888.2 85056.0 10658.6 10753.5 11017.9 11104.0 11336.4 39931.0 39986.6 40421.0 40588.8 40772.8 51496.0 51914.2 52063.2 52313.7 52882.7 13949.2 14069.6 14229.8 14300.6 14405.9 14867.4 14903.4 15036.8 15090.5 15157.3 14393.7 14496.5 14581.5 14628.2 14691.4 14142.8 14449.9 14457.7 14573.3 14577.8 13974.0 14043.6 14274.4 14328.4 14389.0 10133.3 10345.6 10493.7 10543.3 10760.9 13402.2 13617.3 13794.7 13796.5 13817.5
04:32:27 INFO - PID 1638 | -------- Summary: end --------
04:32:27 INFO - PID 1638 |
04:32:28 INFO - TEST-INFO | 1638: exit 0
04:32:28 INFO - TEST-OK | dromaeo_css | took 1119596ms
04:32:28 INFO - TEST-START | kraken
04:32:28 INFO - operating with platform_type : mac_
04:32:28 INFO - Initialising browser for kraken test...
04:32:28 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpDHFCZ0/profile http://localhost:49241/getInfo.html)
04:32:30 INFO - PID 1648 | __metrics Screen width/height:1600/1200
04:32:30 INFO - PID 1648 | colorDepth:24
04:32:30 INFO - PID 1648 | Browser inner width/height: 1024/689
04:32:30 INFO - PID 1648 | __metrics
04:32:30 INFO - PID 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
04:32:30 INFO - PID 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
04:32:31 INFO - TEST-INFO | 1648: exit 0
04:32:31 INFO - Browser initialized.
04:32:31 INFO - Running cycle 1/1 for kraken test...
04:32:31 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpDHFCZ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
04:32:44 INFO - PID 1650 | RSS: Main: 241827840
04:32:44 INFO - PID 1650 |
04:32:46 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection)
04:32:47 INFO - PID 1650 | RSS: Main: 312868864
04:32:47 INFO - PID 1650 |
04:32:50 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft)
04:32:50 INFO - PID 1650 | RSS: Main: 294973440
04:32:50 INFO - PID 1650 |
04:32:53 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft)
04:32:54 INFO - PID 1650 | RSS: Main: 385265664
04:32:54 INFO - PID 1650 |
04:32:56 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator)
04:32:57 INFO - PID 1650 | RSS: Main: 290234368
04:32:57 INFO - PID 1650 |
04:32:59 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur)
04:32:59 INFO - PID 1650 | RSS: Main: 292380672
04:32:59 INFO - PID 1650 |
04:33:02 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom)
04:33:03 INFO - PID 1650 | RSS: Main: 355717120
04:33:03 INFO - PID 1650 |
04:33:06 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate)
04:33:06 INFO - PID 1650 | RSS: Main: 375263232
04:33:06 INFO - PID 1650 |
04:33:09 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial)
04:33:10 INFO - PID 1650 | RSS: Main: 383393792
04:33:10 INFO - PID 1650 |
04:33:11 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox)
04:33:12 INFO - PID 1650 | RSS: Main: 332242944
04:33:12 INFO - PID 1650 |
04:33:13 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes)
04:33:14 INFO - PID 1650 | RSS: Main: 334409728
04:33:14 INFO - PID 1650 |
04:33:16 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm)
04:33:17 INFO - PID 1650 | RSS: Main: 336965632
04:33:17 INFO - PID 1650 |
04:33:20 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
04:33:20 INFO - PID 1650 | RSS: Main: 346394624
04:33:20 INFO - PID 1650 |
04:33:24 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
04:33:24 INFO - PID 1650 | RSS: Main: 343789568
04:33:24 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar)
04:33:26 INFO - PID 1650 | RSS: Main: 386772992
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | __start_tp_report
04:33:26 INFO - PID 1650 | _x_x_mozilla_page_load
04:33:26 INFO - PID 1650 | _x_x_mozilla_page_load_details
04:33:26 INFO - PID 1650 | |i|pagename|runs|
04:33:26 INFO - PID 1650 | |0;ai-astar;112;111;111;111;112;113;112;111;112;112
04:33:26 INFO - PID 1650 | |1;audio-beat-detection;140;106;108;148;109;106;106;106;133;112
04:33:26 INFO - PID 1650 | |2;audio-dft;187;187;182;185;187;186;185;187;186;184
04:33:26 INFO - PID 1650 | |3;audio-fft;85;58;59;89;61;60;58;58;80;55
04:33:26 INFO - PID 1650 | |4;audio-oscillator;93;70;85;69;68;69;90;64;66;90
04:33:26 INFO - PID 1650 | |5;imaging-gaussian-blur;89;87;88;87;87;87;89;88;89;88
04:33:26 INFO - PID 1650 | |6;imaging-darkroom;96;96;96;95;95;95;95;94;96;94
04:33:26 INFO - PID 1650 | |7;imaging-desaturate;83;83;85;86;92;85;83;83;86;86
04:33:26 INFO - PID 1650 | |8;json-parse-financial;49;48;47;47;47;49;48;47;49;49
04:33:26 INFO - PID 1650 | |9;json-stringify-tinderbox;54;54;59;58;65;58;57;57;57;58
04:33:26 INFO - PID 1650 | |10;stanford-crypto-aes;84;83;83;81;81;83;81;83;82;82
04:33:26 INFO - PID 1650 | |11;stanford-crypto-ccm;140;138;147;143;151;125;138;135;223;149
04:33:26 INFO - PID 1650 | |12;stanford-crypto-pbkdf2;185;184;185;182;190;184;189;188;185;239
04:33:26 INFO - PID 1650 | |13;stanford-crypto-sha256-iterative;70;69;68;67;69;70;70;68;68;68
04:33:26 INFO - PID 1650 | __end_tp_report
04:33:26 INFO - PID 1650 | __start_cc_report
04:33:26 INFO - PID 1650 | _x_x_mozilla_cycle_collect,2167
04:33:26 INFO - PID 1650 | __end_cc_report
04:33:26 INFO - PID 1650 | __startTimestamp1493033606715__endTimestamp
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | ------- Summary: start -------
04:33:26 INFO - PID 1650 | Number of tests: 14
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:0.67 (0.6%) stddev-sans-first:0.71
04:33:26 INFO - PID 1650 | Values: 112.0 111.0 111.0 111.0 112.0 113.0 112.0 111.0 112.0 112.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:110.50 stddev:16.32 (14.8%) stddev-sans-first:15.13
04:33:26 INFO - PID 1650 | Values: 140.0 106.0 108.0 148.0 109.0 106.0 106.0 106.0 133.0 112.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.50 stddev:1.65 (0.9%) stddev-sans-first:1.67
04:33:26 INFO - PID 1650 | Values: 187.0 187.0 182.0 185.0 187.0 186.0 185.0 187.0 186.0 184.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:12.94 (21.4%) stddev-sans-first:11.83
04:33:26 INFO - PID 1650 | Values: 85.0 58.0 59.0 89.0 61.0 60.0 58.0 58.0 80.0 55.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#4] audio-oscillator Cycles:10 Average:76.40 Median:77.50 stddev:11.56 (14.9%) stddev-sans-first:10.58
04:33:26 INFO - PID 1650 | Values: 93.0 70.0 85.0 69.0 68.0 69.0 90.0 64.0 66.0 90.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.88 (1.0%) stddev-sans-first:0.83
04:33:26 INFO - PID 1650 | Values: 89.0 87.0 88.0 87.0 87.0 87.0 89.0 88.0 89.0 88.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.78
04:33:26 INFO - PID 1650 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 94.0 96.0 94.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:2.74 (3.2%) stddev-sans-first:2.79
04:33:26 INFO - PID 1650 | Values: 83.0 83.0 85.0 86.0 92.0 85.0 83.0 83.0 86.0 86.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.50 stddev:0.94 (1.9%) stddev-sans-first:0.93
04:33:26 INFO - PID 1650 | Values: 49.0 48.0 47.0 47.0 47.0 49.0 48.0 47.0 49.0 49.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:3.06 (5.3%) stddev-sans-first:2.93
04:33:26 INFO - PID 1650 | Values: 54.0 54.0 59.0 58.0 65.0 58.0 57.0 57.0 57.0 58.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.06 (1.3%) stddev-sans-first:0.93
04:33:26 INFO - PID 1650 | Values: 84.0 83.0 83.0 81.0 81.0 83.0 81.0 83.0 82.0 82.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:145.00 stddev:27.11 (18.7%) stddev-sans-first:28.56
04:33:26 INFO - PID 1650 | Values: 140.0 138.0 147.0 143.0 151.0 125.0 138.0 135.0 223.0 149.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:186.50 stddev:17.01 (9.1%) stddev-sans-first:17.90
04:33:26 INFO - PID 1650 | Values: 185.0 184.0 185.0 182.0 190.0 184.0 189.0 188.0 185.0 239.0
04:33:26 INFO - PID 1650 |
04:33:26 INFO - PID 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.01
04:33:26 INFO - PID 1650 | Values: 70.0 69.0 68.0 67.0 69.0 70.0 70.0 68.0 68.0 68.0
04:33:26 INFO - PID 1650 | -------- Summary: end --------
04:33:26 INFO - PID 1650 |
04:33:27 INFO - TEST-INFO | 1650: exit 0
04:33:27 INFO - TEST-OK | kraken | took 59630ms
04:33:27 INFO - SUITE-END | took 1179s
04:33:27 INFO - Completed test suite (00:19:39)
04:33:27 INFO - javascript benchmark
04:33:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7634.817070458826, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.4498390289746, 3557.466380042993, 3574.106473381655, 3596.0829988352966, 3598.3343081529933, 6083.574149809504, 6165.352637973016, 6257.906131408021, 6317.115603815464, 6362.045693146025, 6106.786262480825, 6187.102870083835, 6247.593906396081, 6264.6867656617105, 6280.905786413196, 5256.500632439931, 5353.330833645794, 5359.356877174744, 5401.621886467949, 5471.534919531845, 5241.816536421226, 5395.163749618815, 5404.432534583871, 5457.099578569531, 5472.534834539069, 5329.227262047001, 5337.199420086979, 5343.251944727741, 5376.435474275184, 5420.105682562373, 5325.254464374991, 5331.546818520431, 5338.679679219259, 5341.519263266325, 5403.648762830403, 5324.653897496651, 5341.919871201935, 5365.7853685852515, 5370.624056316059, 5384.0, 6008.158857759917, 6102.428659372087, 6131.3868613138775, 6138.508919286491, 6189.535784816157, 6618.0, 6620.205575330943, 6623.86752264952, 6632.602043877383, 6639.535232533724, 6666.866662666768, 6722.159730033746, 6735.696893639749, 6736.157980252468, 6745.730170793162, 6127.830981140938, 6209.068639704081, 6298.811035668938, 6394.360563943615, 6412.487001039905, 6590.110335104795, 6778.949262864264, 6845.110135682429, 6855.280195579492, 6866.828329291708, 6407.519436042316, 6440.452561532228, 6445.967770161213, 6447.548671593037, 6462.676866156768, 6608.504362172856, 6701.1623547056615, 6706.362895524917, 6711.563748356439, 6712.060311556386, 6595.307492713292, 6598.3401659833635, 6598.60408375499, 6599.043138744855, 6599.340065993362, 6325.399087086719, 6362.45919096882, 6413.134226879405, 6426.4537514311805, 6631.834204144839, 5248.265242866002, 5272.6836389816735, 5273.868153296198, 5280.894382112337, 5306.257124002643, 4595.747233902168, 4706.811727530929, 4727.314539391769, 4730.526947305242, 4745.83389581363, 6089.421504957022, 6116.235470566179, 6193.907091393633, 6293.937060629427, 6302.65335406557, 5370.3287089113865, 6463.192100987377, 6618.7021584028835, 6623.7350505980185, 6711.597304161766, 6275.811725648238, 6293.653849038347, 6303.054541818764, 6306.590071645328, 6329.367063293634, 5812.38969908162, 5822.155787410802, 5828.88342233153, 5856.59003869725, 5902.291724992942, 6524.902126468011, 6632.535722499379, 6741.595504269563, 6871.690773915186, 6916.757913473206, 6689.2976237496305, 6696.062551242927, 6704.899426508508, 6719.563228390139, 6726.831829204309, 6836.350546698056, 6879.484038697218, 6884.690188941409, 6888.173419189729, 6890.552114112566, 6323.146375239284, 6546.116274302908, 6589.308122647245, 6598.307177746459, 6625.801225963229, 5415.323084614423, 6460.644664543495, 6590.5716128451495, 6652.567583107082, 6686.264510903699, 5750.741216645178, 6121.714439967656, 6389.840253993687, 6400.487960963205, 6467.870642587028, 6347.143135676624, 6349.206349206349, 6353.745850165941, 6411.775587854403, 6420.935790642221, 6373.904391434039, 6425.10048593188, 6425.485961123006, 6432.3567643237175, 6448.580842245239, 6311.084892690443, 6430.453411460078, 6432.9678351607945, 6437.291897891135, 6444.613323200623, 6267.310595834363, 6299.716512757029, 6305.495560355253, 6318.399752023551, 6366.267879193952], "value": 6045.135680779624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.7787285941358, 764.5603777827748, 782.5265714242882, 1075.354787127723, 1081.8972197641226, 26249.212523624275, 26435.33911652205, 26449.47101057978, 26460.338491537696, 26500.33749156272, 36417.08957276069, 36525.26949461009, 36533.0, 36542.45186322207, 36598.26803463929, 8251.46365486243, 8387.161283871625, 8389.370797190204, 8398.622062007194, 8404.873926891101, 5963.612365196248, 6051.485623721989, 8271.710490132846, 8383.748487545354, 8391.454555453907, 8204.876926846073, 8383.790405239857, 8390.454620449651, 8390.958045209796, 8442.535660538699, 8376.246137847593, 8420.28427583656, 8423.284020858235, 8436.493810371367, 8439.789005274855, 5938.851528711773, 6051.515878729691, 8276.710315139002, 8370.623321950467, 8378.748637540884, 25822.967081316725, 26036.0, 26098.478030439284, 34718.958431247105, 34770.0, 3513.1744040150543, 3537.2394935088823, 3538.0093573799377, 3539.132912436444, 3542.574891013069, 29487.41025179506, 29575.0, 29588.0, 29636.40727185466, 29710.96011639582, 2663.3741070848337, 3120.9219769505717, 3136.4511210538294, 3153.369326134782, 3163.4938409854544, 220583.89708051516, 287511.56244218856, 289072.0, 289779.0, 289933.5503322491, 39002.41496377557, 47410.0, 47540.0, 47642.761786190844, 47709.284360734615, 48255.0, 48276.03447931092, 48418.0, 48530.0, 48565.02869942581, 13544.796828047587, 13692.589222323346, 13695.520656776966, 13700.109492882932, 13701.383437745326, 11305.773884522263, 11308.151888608387, 11309.886901130883, 11312.321260724382, 11322.660320190407, 9920.958299378606, 10027.899721002843, 11461.656150315504, 11468.713282168013, 11629.1859569831, 4419.1382680377665, 5204.947950520522, 5224.111900976843, 5237.423883372826, 5269.1569348903995, 926.4441335198827, 968.6270785747397, 1021.279997601689, 1022.99488502557, 1064.5794911010107, 23805.523889522112, 23918.64122038171, 23994.0, 24027.7597224029, 24302.7569724304, 1107.9335239885634, 1119.6808909460765, 1132.3998280910967, 1146.7190538318166, 1151.205668089016, 9334.766630834283, 10598.523066462029, 11875.40622968848, 12139.0, 12195.939020305019, 260334.69832650715, 312171.0, 313827.0, 314923.0, 315213.0, 41864.0, 51248.74375628173, 51479.74260128675, 51547.22679159816, 51590.74204628953, 1469.8162729658793, 1502.5417247739763, 1514.7576387777904, 1524.6569521857716, 1526.114853385034, 16643.667126657157, 21034.632748871274, 22832.0, 23668.28995130149, 23704.8814755932, 36126.458103129, 36184.63815361918, 36268.63731362758, 36292.637073628925, 36337.091572710895, 277124.0, 277160.0, 277651.0, 277715.0, 278743.0, 26382.0, 33094.50358244676, 33111.50332744962, 33188.83839065621, 33258.50112248366, 36499.087522812144, 36962.44556331603, 37075.81462092672, 37103.0, 44287.778561106985, 25763.0, 26345.868270658524, 26642.0, 30445.54331684982, 30761.077167685005, 26282.605760913983, 27702.03042893489, 29935.952241671435, 30503.54244686287, 30807.0, 36420.635793641726, 36472.0, 36565.0, 36573.45139822958, 36588.26823463463, 28907.710922890503, 29115.695210682086, 30087.097387078422, 30783.53824692676, 30937.226569335948, 21474.57050859005, 22664.433389165402, 23754.31427778001, 24040.75959240385, 24286.514269714153], "value": 16376.691853048365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.95014461212463, 430.15045285561, 431.0538368281621, 436.8012554287799, 453.9909201815964, 19478.707819382704, 20903.790962090392, 21484.355469335907, 21660.675089873625, 21705.612382637897, 21407.464813379673, 21854.344369668896, 21880.45298867529, 22153.335399938027, 22720.204792832254, 5981.730822113004, 6303.936960630381, 6315.336889626569, 6323.810285691414, 6323.9051414228825, 5850.0, 6171.352008039158, 6218.129461875341, 6240.531960102988, 6242.625442473443, 5970.820875373724, 6193.0710393440895, 6202.162708034402, 6211.9378806212035, 6216.347283535231, 6051.939480605181, 6206.100115483275, 6213.099100630383, 6219.346968568326, 6257.906131408033, 5250.81622143227, 5493.423190564973, 5513.972430137864, 5515.503604675559, 5543.473370029841, 26462.206133816017, 26702.73297267022, 26719.599206011924, 26748.0, 26842.865785670947, 2209.7900699433526, 2263.173941511353, 2264.4338915271182, 2266.184173697484, 2268.2514770125817, 17421.041842698647, 17447.47657570275, 17663.470095897144, 17848.46454606364, 18161.63676726458, 2094.5182608000246, 2142.817860481861, 2164.0802658869916, 2165.2421652421526, 2169.316665250441, 137643.0, 138635.30682346725, 147807.6096195186, 148056.0, 154281.0, 11614.883851161549, 12122.696932576757, 12126.575569855013, 12135.453904574315, 12235.816462753066, 16289.266982985793, 16313.918430407772, 16337.0, 16346.75479867803, 16418.0, 7363.263673632701, 8485.32117430604, 8654.524001179996, 8760.167784060504, 8829.072947340437, 8227.794305142299, 8230.794230144174, 8250.16367389155, 8384.413091083565, 8426.4944103354, 6674.899876501856, 7492.400607951351, 7650.961745191238, 7685.884711729329, 7823.374130069581, 2114.2071723103836, 2115.968260476094, 2120.3744895255936, 2123.1719629344566, 2242.8990695418747, 905.3933864310927, 916.724982505259, 927.7448701606977, 943.9757862719027, 963.7354705428451, 16340.836591633932, 18735.437936861916, 20189.990500474916, 21197.78802211989, 21439.35830465681, 921.8064206516573, 956.1585804492003, 978.496074521622, 1002.2082554781787, 1017.4099022566893, 10432.0, 10902.291351062155, 10986.780264394667, 10989.725256868482, 11049.558017679363, 539650.0, 547469.0, 559892.0, 559903.0, 560138.0, 109846.0, 116826.8317316833, 122284.0, 123868.0, 125556.0, 1119.462657924201, 1179.121554441929, 1202.2425871700773, 1225.2709637765515, 1225.5649244518247, 20925.79074209299, 22088.77911220867, 22306.442338941008, 22464.39479906648, 22581.209657661904, 55534.61351944417, 57318.0, 57365.713171433876, 57595.40820663164, 58201.0, 80051.59974200092, 80194.79707804504, 80314.59842700748, 81095.0, 81716.59141704254, 8599.871001934851, 8824.161704638049, 8933.240674542476, 9026.503542305236, 9053.275737941081, 12981.286029268482, 13797.241151736349, 13840.446382145004, 14220.431182752574, 14260.215688137252, 11795.646130616095, 11840.28958262507, 11886.702832429259, 12073.335966521925, 12088.516459341528, 9580.473073980998, 10599.947000264949, 10973.50619222121, 11009.394483303495, 11132.833007504732, 11637.359945203096, 11771.411429428666, 11798.87910648487, 12085.274883507018, 12113.273203607812, 8439.620217090123, 8546.743597692079, 8990.215069785716, 9019.278457723498, 9033.322500812597, 11660.650180494598, 11940.940295298467, 12051.216670916363, 12068.33624150645, 12100.697482563006], "value": 10362.213001623046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.0, 1382.7994940733595, 1414.653409914571, 1435.8923080768939, 1445.3495926832925, 9777.12005919467, 10213.948930255348, 11650.941745291262, 11918.404079795997, 11929.284242945409, 11542.769144617103, 11654.766904661923, 11658.533658653643, 11660.0, 11708.121890858198, 2497.6503289539432, 2536.695596528419, 2540.707818600866, 2543.796496280293, 2544.8473091614565, 2080.209520382253, 2124.925627603034, 2200.1529411176653, 2550.923472295834, 2565.28172111809, 2485.1923124984364, 2496.0390249753887, 2516.6350879122606, 2516.987415062922, 2519.760622740837, 2515.320863366899, 2519.533886231053, 2520.823542352036, 2524.936876578082, 2528.3679080230036, 2442.841215321016, 2468.049800826677, 2472.1471092473066, 2473.146764366291, 2475.616279476684, 11593.956543911005, 11749.94125029378, 11785.528578856836, 11790.0, 11794.174407791457, 6590.703418346186, 6834.965825170842, 6835.418989385908, 6838.179418469816, 6844.28135045823, 3897.941530877039, 4010.218007488541, 4380.67144964129, 4381.298992161271, 4392.1874453226255, 1056.561526966308, 1257.9056221087621, 1280.7950727883494, 1283.9486420543167, 1297.221666999802, 16809.6638067238, 16874.66250674992, 16900.66198676032, 16908.746368804477, 16916.999999999876, 5047.570956468668, 5860.355360910382, 6022.277326720821, 6125.081237814364, 6143.477804386588, 12213.389330533439, 13430.93284533571, 13770.93114534421, 13773.449062037405, 13783.586492405044, 6461.547691661539, 6850.4862135340045, 6850.897236541456, 6859.794206173823, 6861.210960739479, 5232.084385232569, 6196.938030619726, 6247.187865577446, 6299.968500157562, 6301.684915754194, 3542.75200735946, 4157.97921010393, 4658.138244424792, 4737.431508219036, 4751.95248047522, 1421.7440860645183, 1464.6045567696663, 1465.1648560320727, 1482.1329522229616, 1485.3167542930157, 666.7099811581977, 794.0273165372373, 810.8824220487996, 815.5555222403805, 820.6348175062041, 6209.161763162006, 6369.71336289868, 6392.137061496638, 6417.454516366068, 6681.298463661343, 922.8707980882682, 922.8846394200725, 928.5403725156091, 948.0519480519481, 963.3834346018554, 4193.35003074524, 4548.658850586153, 4594.19601569724, 4732.107157137104, 4768.3085952537385, 14652.706945861237, 14678.339474723663, 15331.310091045929, 15357.539273821803, 15521.068735875884, 14830.62923426923, 15071.849281507264, 15268.160251186291, 15305.46430874914, 15500.767488487681, 8451.239388454946, 8491.490510569509, 8715.956420217984, 8722.65109395617, 8723.0, 6742.595444273359, 6780.957679869281, 6914.27400123, 7026.402755765817, 7097.858042839011, 12652.240865548096, 12969.870301296865, 13027.088103833019, 13454.798178027533, 13893.58319250424, 13791.103578267783, 13924.91126331018, 13997.720045598828, 14086.647833804236, 14218.217998010208, 7320.524165929198, 9631.71104866855, 9708.466034368177, 9723.416595004323, 9750.366226195274, 8925.196732294125, 9492.667756628485, 9731.075547822946, 10530.894691052992, 10594.205434592282, 9178.862317065383, 9242.630294788134, 9262.629494820132, 9308.906910931075, 9337.019612940816, 8834.955825220834, 9084.909150908406, 9158.358914875895, 9246.95376523113, 9338.579763910504, 8134.389920756085, 8221.17788221173, 8251.752447426587, 8351.039630442578, 8364.498130112213, 5889.941100589111, 5975.283285059819, 6137.478314343331, 6216.191895053614, 6219.0982307566055, 6195.0, 6199.884020876286, 6209.658468784261, 6214.4407003369915, 6263.561550691408], "value": 5440.700296254258, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5169742946459, 402.05918151525424, 407.7268230285707, 407.81036817879715, 413.60707328038353, 5704.315482142144, 5716.456936591027, 5805.0, 5821.621594596353, 5834.358220595742, 4625.861224163272, 5424.349078110622, 5649.322081350233, 5689.886202275952, 5719.084946408576, 4000.2599519088917, 4161.895952601187, 4394.077243778795, 4399.38408622793, 4422.690411671184, 3621.5110960020456, 3853.9614603853884, 4422.513523512411, 4434.911301773963, 4450.866474005768, 4204.171185534302, 4345.956540434602, 4362.389265502817, 4398.780060996937, 4414.726415895816, 4363.607275345218, 4363.978180109111, 4372.185542999668, 4378.6934914555995, 4378.934315985262, 3454.7754395964434, 3914.256291304643, 3922.8430862765454, 3936.940945885814, 3940.876850097737, 4742.359781429497, 5382.0581398255545, 5591.707399965994, 5630.521405680522, 5677.40387259336, 3945.7237993340477, 5278.498542638443, 5290.312259406291, 5308.761105750251, 5312.73436328182, 5283.709395983258, 5331.466853314676, 5527.55779537636, 5803.767849286023, 6144.477719393813, 3474.5309383233193, 3542.663446972559, 4149.808693219869, 4488.685791994561, 4497.662675299365, 6229.221347331583, 6384.3296453872135, 6412.39082287182, 6450.354964503559, 6572.638504882229, 4144.544100148981, 4154.065335299533, 4158.979205104016, 4168.312228482328, 4174.415581818548, 3987.1228329767405, 4142.5857414258335, 4259.680523960716, 4357.607815296638, 4371.125774845043, 4596.6336623776315, 4998.575121114746, 5052.469490703424, 5071.644984851099, 5087.796488140433, 5909.379515150933, 6032.758689652364, 6045.546584006217, 6060.181875446847, 6062.636241825505, 1139.3562637110006, 1404.1364560795037, 1433.813604231464, 1477.8004969329004, 1487.4496436318416, 914.8409752982955, 945.7304668169538, 997.9950100249453, 999.5701848205196, 1002.7838476965841, 5118.872028199325, 5459.2902922619805, 5499.422560631157, 5731.140328950607, 5746.489006130168, 6316.873662526724, 6322.70384571171, 6328.525360597973, 6346.809595712136, 6351.872962540816, 5017.799288028438, 5512.531434828004, 5750.942490575125, 5762.674584845425, 5826.213461182686, 3126.4841301185506, 3298.3238436120537, 3326.5841769778776, 3348.5814273215847, 3353.3293341331832, 5222.973885130626, 6603.603783772989, 6608.603483790988, 6613.222446572355, 6650.301718319603, 6179.16581261533, 6571.638559879157, 6573.014047892854, 6573.441257493071, 6585.49751094581, 5740.368559458373, 6591.6374599397495, 6611.603303801788, 6649.102371179925, 6652.301508341651, 5530.336359636869, 5997.520198384032, 6328.6519241442165, 6421.1010458536775, 6434.356564343529, 6348.9047664286, 6353.936460635335, 6358.491320694241, 6368.777092801915, 6401.231852177769, 6385.828818201834, 6565.901511477236, 6622.569532980341, 6675.632840193836, 6692.063111164538, 3745.5130832991535, 4266.616004559604, 4288.978555107205, 4295.196017672522, 4310.655147588248, 5931.317898441562, 6012.7294271757, 6146.723397447036, 6247.094171345038, 6452.709628066655, 4351.369051487453, 6082.0, 6129.877402451837, 6183.350748171377, 6185.103160041679, 4633.837815676435, 4899.926501102557, 4988.351514303263, 6091.939080609314, 6149.354317796567, 5041.6470847040355, 5282.366116066097, 5820.970895145667, 6021.367756385516, 6053.273607167168, 5586.245856809279, 5780.277465316835, 6236.0, 6246.9062964054665, 6257.2491301044165, 5636.098224284095, 6076.387153524027, 6084.421979911901, 6093.756249750138, 6109.389061093855], "value": 4496.131980980269, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.1022696062523, 844.3751623798383, 848.2281124177, 851.6210286422543, 860.1742327365729, 12990.675233119166, 18125.27498900044, 18737.969411682352, 18755.718664220047, 18757.99999999998, 16651.916740416313, 16757.078360690157, 16783.992960422354, 16784.0, 16848.410305639303, 641.0288413054227, 654.7577396363353, 667.4426853577256, 937.3485427627801, 938.352536749644, 684.4763755726873, 931.2736065868634, 931.4411353188067, 944.3483996042743, 958.1663952361455, 988.8121256961155, 989.5448093876789, 989.9208063354914, 992.0971915556845, 1037.5953378182514, 891.5631340643102, 984.6110786239395, 985.0395864032547, 985.4235272365675, 1038.3665963762098, 729.3180875881068, 730.9963450182715, 733.6295170938641, 741.4105785900223, 772.2432016623684, 15615.297311621005, 15838.52484425469, 16051.0, 16220.270087846075, 16518.917405413016, 16004.03975761458, 16104.0, 16333.673326533402, 16401.83598164015, 16519.91740041304, 13469.461221551224, 13586.11690240141, 13719.931400342934, 13723.039387242898, 13949.372278247401, 3393.6776006279365, 3419.8290085495873, 3422.3155368926314, 3425.794452332868, 3427.246005878728, 115421.99999999916, 118006.0, 124712.37643811814, 125716.0, 126565.0, 11508.424578771028, 11602.013828824476, 11629.767404651859, 11724.824127638092, 11740.941295293469, 19305.710414343797, 19320.4203873884, 19520.511987200432, 19587.412377628694, 19624.803751962583, 7343.926560734431, 7485.812854678567, 7495.175530691619, 7497.2877576630135, 7511.661975211128, 3839.404892241707, 3915.8433662653742, 3920.098377373163, 3920.686345092443, 3922.627350401707, 4066.8576599819457, 4674.0, 4786.473487916396, 4841.467438581753, 4843.854684359475, 932.3613324872484, 960.5485421851719, 974.1135566634329, 977.6822532676908, 978.814025335184, 574.1617238831269, 643.829385212919, 660.7158921663731, 664.8404382948057, 688.9069975553336, 8894.0, 9849.55676994537, 10626.628068017582, 10857.45712714361, 11744.530218791324, 547.854818473105, 615.2647586134526, 627.3569591168997, 634.3339493531773, 646.7380710812129, 5406.189071639285, 5459.781608735686, 5497.642653227527, 5535.667859928417, 5632.408597097246, 79964.0, 104715.0, 104730.0, 107154.46422767836, 107650.0, 90091.64862527067, 92283.53858230666, 92765.0, 95042.0, 95530.56704149443, 81799.18200818035, 83598.0, 83640.32719345701, 83888.16111838925, 85056.0, 10658.573657053632, 10753.46232688378, 11017.944910275397, 11104.0, 11336.376499292288, 39931.00172495711, 39986.600133999455, 40420.989475263355, 40588.79705601571, 40772.79613601913, 51496.0, 51914.221286679975, 52063.219051713495, 52313.738431307596, 52882.735586321825, 13949.232792196526, 14069.577912662637, 14229.786553201917, 14300.640394335234, 14405.92797036008, 14867.405303787727, 14903.403863845324, 15036.774448383501, 15090.471833485775, 15157.317920693375, 14393.712125757216, 14496.492622758153, 14581.489647862274, 14628.195449250394, 14691.41234350614, 14142.78785818234, 14449.85550144485, 14457.710845782814, 14573.344199511259, 14577.781333279798, 13974.0, 14043.648908777363, 14274.429022839386, 14328.426862925366, 14389.0, 10133.341332813343, 10345.63790267337, 10493.685189444328, 10543.26197166191, 10760.946195269287, 13402.195868247936, 13617.31913404306, 13794.655133621338, 13796.517121900686, 13817.516386926409], "value": 7891.922376438471, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1422.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 111.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 108.0, 148.0, 109.0, 106.0, 106.0, 106.0, 133.0, 112.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 182.0, 185.0, 187.0, 186.0, 185.0, 187.0, 186.0, 184.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 58.0, 59.0, 89.0, 61.0, 60.0, 58.0, 58.0, 80.0, 55.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 85.0, 69.0, 68.0, 69.0, 90.0, 64.0, 66.0, 90.0], "value": 76.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 87.0, 87.0, 87.0, 89.0, 88.0, 89.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 86.0, 92.0, 85.0, 83.0, 83.0, 86.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 47.0, 47.0, 47.0, 49.0, 48.0, 47.0, 49.0, 49.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 59.0, 58.0, 65.0, 58.0, 57.0, 57.0, 57.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 81.0, 81.0, 83.0, 81.0, 83.0, 82.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 147.0, 143.0, 151.0, 125.0, 138.0, 135.0, 223.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 185.0, 182.0, 190.0, 184.0, 189.0, 188.0, 185.0, 239.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 67.0, 69.0, 70.0, 70.0, 68.0, 68.0, 68.0], "value": 68.7, "unit": "score"}]}]}
04:33:27 INFO - Return code: 0
04:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
04:33:28 ERROR - # TBPL SUCCESS #
04:33:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
04:33:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
04:33:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
04:33:28 INFO - 2017-04-24 04:33:28.041 screenresolution[1654:9903] starting screenresolution argv=screenresolution get
04:33:28 INFO - 2017-04-24 04:33:28.044 screenresolution[1654:9903] Display 0: 1600x1200x32@60
04:33:28 INFO - 2017-04-24 04:33:28.050 screenresolution[1655:9906] starting screenresolution argv=screenresolution list
04:33:28 INFO - Available Modes on Display 0
04:33:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
04:33:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
04:33:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
04:33:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
04:33:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
04:33:28 INFO - Intel Iris:
04:33:28 INFO - Chipset Model: Intel Iris
04:33:28 INFO - Type: GPU
04:33:28 INFO - Bus: Built-In
04:33:28 INFO - VRAM (Dynamic, Max): 1536 MB
04:33:28 INFO - Vendor: Intel (0x8086)
04:33:28 INFO - Device ID: 0x0a2e
04:33:28 INFO - Revision ID: 0x0009
04:33:28 INFO - Displays:
04:33:28 INFO - Display:
04:33:28 INFO - Resolution: 1600 x 1200 @ 60 Hz
04:33:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
04:33:28 INFO - Display Serial Number: 1600x1200 60
04:33:28 INFO - Main Display: Yes
04:33:28 INFO - Mirror: Off
04:33:28 INFO - Online: Yes
04:33:28 INFO - Rotation: Supported
04:33:28 INFO - Return code: 0
04:33:28 INFO - Running post-action listener: _resource_record_post_action
04:33:28 INFO - [mozharness: 2017-04-24 11:33:28.295463Z] Finished run-tests step (success)
04:33:28 INFO - Running post-run listener: _resource_record_post_run
04:33:28 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 40301568; Write bytes: 511938560; Read time: 401; Write time: 1755
04:33:28 INFO - TinderboxPrint: CPU usage
53.4%
04:33:28 INFO - TinderboxPrint: I/O read bytes / time
40,301,568 / 401
04:33:28 INFO - TinderboxPrint: I/O write bytes / time
511,938,560 / 1,755
04:33:28 INFO - TinderboxPrint: CPU idle
2,235.9 (46.6%)
04:33:28 INFO - TinderboxPrint: CPU system
959.0 (20.0%)
04:33:28 INFO - TinderboxPrint: CPU user
1,606.6 (33.5%)
04:33:28 INFO - TinderboxPrint: Swap in / out
246,591,488 / 0
04:33:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205609472; Write bytes: 206514176; Read time: 15867; Write time: 468
04:33:28 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 38122496; Write bytes: 298375168; Read time: 375; Write time: 1258
04:33:28 INFO - Running post-run listener: _upload_blobber_files
04:33:28 INFO - Blob upload gear active.
04:33:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
04:33:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
04:33:28 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']
04:33:28 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
04:33:29 INFO - (blobuploader) - INFO - Open directory for files ...
04:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
04:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
04:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:33:30 INFO - (blobuploader) - INFO - Done attempting.
04:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
04:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
04:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:33:31 INFO - (blobuploader) - INFO - Done attempting.
04:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
04:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
04:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:33:32 INFO - (blobuploader) - INFO - Done attempting.
04:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
04:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:33:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
04:33:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:33:34 INFO - (blobuploader) - INFO - Done attempting.
04:33:34 INFO - (blobuploader) - INFO - Iteration through files over.
04:33:34 INFO - Return code: 0
04:33:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
04:33:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
04:33:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d6e709772306eca31e45bd9d7e67fb70d2b03b572186252e524c800504f4cde8ffce82fae81f50f8e73d0a49773167cb10268e15d42570cf11728f5872f855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bcd6f5768e02adbbbfae826310a0c3c2711b9c6e373302d9f5d959bba070aede85d830be9c9a4fafe6dbdfba6a7395dac4b7ff5cc9b25ac361c89bf70c738e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84f9cfc456854fdf868294d359fda78c0e288ca93330242c5c07dc8a889f214fede0f39f69030d23b5d2cebcbbcfdeedc27e060327dd8ced84d62a5047cc488", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a2600f9417f4b868a1d71d661d3e0fddf2212a69542ef72242f104133bd248add50892c3d47b9c475254a1c0bd81a9c854f3090e74b2648222b36ff231ae53"}
04:33:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
04:33:34 INFO - Writing to file /builds/slave/test/properties/blobber_files
04:33:34 INFO - Contents:
04:33:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d6e709772306eca31e45bd9d7e67fb70d2b03b572186252e524c800504f4cde8ffce82fae81f50f8e73d0a49773167cb10268e15d42570cf11728f5872f855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bcd6f5768e02adbbbfae826310a0c3c2711b9c6e373302d9f5d959bba070aede85d830be9c9a4fafe6dbdfba6a7395dac4b7ff5cc9b25ac361c89bf70c738e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84f9cfc456854fdf868294d359fda78c0e288ca93330242c5c07dc8a889f214fede0f39f69030d23b5d2cebcbbcfdeedc27e060327dd8ced84d62a5047cc488", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a2600f9417f4b868a1d71d661d3e0fddf2212a69542ef72242f104133bd248add50892c3d47b9c475254a1c0bd81a9c854f3090e74b2648222b36ff231ae53"}
04:33:34 INFO - Running post-run listener: copy_logs_to_upload_dir
04:33:34 INFO - Copying logs to upload dir...
04:33:34 INFO - mkdir: /builds/slave/test/build/upload/logs
04:33:34 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1282.500855
========= master_lag: 0.04 =========
========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-04-24 04:33:34.418760) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:34.421974) =========
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.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d6e709772306eca31e45bd9d7e67fb70d2b03b572186252e524c800504f4cde8ffce82fae81f50f8e73d0a49773167cb10268e15d42570cf11728f5872f855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bcd6f5768e02adbbbfae826310a0c3c2711b9c6e373302d9f5d959bba070aede85d830be9c9a4fafe6dbdfba6a7395dac4b7ff5cc9b25ac361c89bf70c738e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84f9cfc456854fdf868294d359fda78c0e288ca93330242c5c07dc8a889f214fede0f39f69030d23b5d2cebcbbcfdeedc27e060327dd8ced84d62a5047cc488", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a2600f9417f4b868a1d71d661d3e0fddf2212a69542ef72242f104133bd248add50892c3d47b9c475254a1c0bd81a9c854f3090e74b2648222b36ff231ae53"}
build_url:https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
program finished with exit code 0
elapsedTime=0.011055
build_url: 'https://queue.taskcluster.net/v1/task/HS31eIruQsiqT94wS3l6yQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03d6e709772306eca31e45bd9d7e67fb70d2b03b572186252e524c800504f4cde8ffce82fae81f50f8e73d0a49773167cb10268e15d42570cf11728f5872f855", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43bcd6f5768e02adbbbfae826310a0c3c2711b9c6e373302d9f5d959bba070aede85d830be9c9a4fafe6dbdfba6a7395dac4b7ff5cc9b25ac361c89bf70c738e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e84f9cfc456854fdf868294d359fda78c0e288ca93330242c5c07dc8a889f214fede0f39f69030d23b5d2cebcbbcfdeedc27e060327dd8ced84d62a5047cc488", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56a2600f9417f4b868a1d71d661d3e0fddf2212a69542ef72242f104133bd248add50892c3d47b9c475254a1c0bd81a9c854f3090e74b2648222b36ff231ae53"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:34.457913) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:34.458286) =========
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.X9jjysFSgV/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.5u9AAAAgtm/Listeners
TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005086
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 04:33:34.507877) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 04:33:34.508288) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 04:33:34.508701) =========
========= Total master_lag: 0.19 =========