builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s
slave: t-yosemite-r7-0312
starttime: 1493328850.29
results: success (0)
buildid: 20170427130024
builduid: 2b8e7122be1a4fdba7ea4e9cef99dda4
revision: 2cca333f546f38860f84940d4c72d7470a3410f4
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.287568) =========
master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.288141) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.288443) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.315489) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.315808) =========
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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-27 14:34: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% 242M=0s
2017-04-27 14:34:10 (242 MB/s) - 'archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.129422
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.469521) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.469840) =========
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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.026729
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.518471) =========
========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 14:34:10.518813) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2cca333f546f38860f84940d4c72d7470a3410f4 --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 2cca333f546f38860f84940d4c72d7470a3410f4 --destination scripts --debug']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-27 14:34:10,627 truncating revision to first 12 chars
2017-04-27 14:34:10,627 Setting DEBUG logging.
2017-04-27 14:34:10,627 attempt 1/10
2017-04-27 14:34:10,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2cca333f546f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-04-27 14:34:11,006 unpacking tar archive at: mozilla-central-2cca333f546f/testing/mozharness/
program finished with exit code 0
elapsedTime=0.654341
========= master_lag: 3.11 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 14:34:14.281883) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282216) =========
script_repo_revision: 2cca333f546f38860f84940d4c72d7470a3410f4
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282636) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282925) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.311112) =========
========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 14:34:14.311496) =========
/tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
environment:
Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:34:14 INFO - MultiFileLogger online at 20170427 14:34:14 in /builds/slave/test
14:34:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
14:34:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
14:34:14 INFO - {'append_to_log': False,
14:34:14 INFO - 'base_work_dir': '/builds/slave/test',
14:34:14 INFO - 'blob_upload_branch': 'Firefox',
14:34:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
14:34:14 INFO - 'branch': 'Firefox',
14:34:14 INFO - 'buildbot_json_path': 'buildprops.json',
14:34:14 INFO - 'config_files': ('talos/mac_config.py',),
14:34:14 INFO - 'default_actions': ('clobber',
14:34:14 INFO - 'read-buildbot-config',
14:34:14 INFO - 'download-and-extract',
14:34:14 INFO - 'populate-webroot',
14:34:14 INFO - 'create-virtualenv',
14:34:14 INFO - 'install',
14:34:14 INFO - 'run-tests'),
14:34:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
14:34:14 INFO - 'download_minidump_stackwalk': True,
14:34:14 INFO - 'download_symbols': 'ondemand',
14:34:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
14:34:14 INFO - 'tooltool.py': '/tools/tooltool.py',
14:34:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
14:34:14 INFO - '/tools/misc-python/virtualenv.py')},
14:34:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
14:34:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
14:34:14 INFO - 'gecko_profile': False,
14:34:14 INFO - 'gecko_profile_interval': 0,
14:34:14 INFO - 'installer_path': 'installer.exe',
14:34:14 INFO - 'log_level': 'info',
14:34:14 INFO - 'log_name': 'talos',
14:34:14 INFO - 'log_to_console': True,
14:34:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk',
14:34:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest',
14:34:14 INFO - 'opt_config_files': (),
14:34:14 INFO - 'pip_index': False,
14:34:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
14:34:14 INFO - 'cmd': ('bash',
14:34:14 INFO - '-c',
14:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
14:34:14 INFO - 'enabled': True,
14:34:14 INFO - 'halt_on_failure': False,
14:34:14 INFO - 'name': 'check_screen_resolution'},),
14:34:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'),
14:34:14 INFO - 'cmd': ('bash',
14:34:14 INFO - '-c',
14:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'),
14:34:14 INFO - 'enabled': True,
14:34:14 INFO - 'halt_on_failure': False,
14:34:14 INFO - 'name': 'check_screen_resolution'},),
14:34:14 INFO - 'run_cmd_checks_enabled': True,
14:34:14 INFO - 'suite': 'dromaeojs-e10s',
14:34:14 INFO - 'system_bits': '32',
14:34:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
14:34:14 INFO - 'title': 't-yosemite-r7-0312',
14:34:14 INFO - 'tooltool_cache': '/builds/tooltool_cache',
14:34:14 INFO - 'use_talos_json': True,
14:34:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
14:34:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:34:14 INFO - 'work_dir': 'build'}
14:34:14 INFO - [mozharness: 2017-04-27 21:34:14.635979Z] Running clobber step.
14:34:14 INFO - Running pre-action listener: _resource_record_pre_action
14:34:14 INFO - Running main action method: clobber
14:34:14 INFO - rmtree: /builds/slave/test/build
14:34:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
14:34:17 INFO - Running post-action listener: _resource_record_post_action
14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.432664Z] Finished clobber step (success)
14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.432793Z] Running read-buildbot-config step.
14:34:17 INFO - Running pre-action listener: _resource_record_pre_action
14:34:17 INFO - Running main action method: read_buildbot_config
14:34:17 INFO - Using buildbot properties:
14:34:17 INFO - {
14:34:17 INFO - "project": "",
14:34:17 INFO - "product": "firefox",
14:34:17 INFO - "script_repo_revision": "production",
14:34:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s",
14:34:17 INFO - "repository": "",
14:34:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s",
14:34:17 INFO - "buildid": "20170427130024",
14:34:17 INFO - "pgo_build": "False",
14:34:17 INFO - "basedir": "/builds/slave/test",
14:34:17 INFO - "buildnumber": 47,
14:34:17 INFO - "slavename": "t-yosemite-r7-0312",
14:34:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/",
14:34:17 INFO - "platform": "yosemite_r7",
14:34:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos",
14:34:17 INFO - "branch": "mozilla-central",
14:34:17 INFO - "repo_path": "mozilla-central",
14:34:17 INFO - "revision": "2cca333f546f38860f84940d4c72d7470a3410f4",
14:34:17 INFO - "stage_platform": "macosx64",
14:34:17 INFO - "builduid": "2b8e7122be1a4fdba7ea4e9cef99dda4",
14:34:17 INFO - "slavebuilddir": "test"
14:34:17 INFO - }
14:34:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg.
14:34:17 INFO - Running post-action listener: _resource_record_post_action
14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.436082Z] Finished read-buildbot-config step (success)
14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.436234Z] Running download-and-extract step.
14:34:17 INFO - Running pre-action listener: _resource_record_pre_action
14:34:17 INFO - Running main action method: download_and_extract
14:34:17 INFO - mkdir: /builds/slave/test/build/tests
14:34: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')]}
14:34:17 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json
14:34:17 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/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
14:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/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
14:34:18 INFO - Downloaded 1325 bytes.
14:34:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json
14:34:18 INFO - Using the following test package requirements:
14:34:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'],
14:34:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
14:34:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'],
14:34:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'],
14:34:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'jsshell-mac.zip'],
14:34:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'],
14:34:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'],
14:34:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'],
14:34:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'],
14:34:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'],
14:34:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip',
14:34:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']}
14:34:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common
14:34:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
14:34:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
14:34:18 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
14:34:20 INFO - Content-Length response header: 52695432
14:34:20 INFO - Bytes received: 52695432
14:34:36 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
14:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip
14:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1
14:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory
14:34:38 INFO - Content-Length response header: 52695432
14:34:38 INFO - Bytes received: 52695432
14:34:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip
14:34:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1
14:34:54 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory
14:34:55 INFO - Content-Length response header: 14408809
14:34:55 INFO - Bytes received: 14408809
14:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:34:55 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
14:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg
14:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/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
14:34:57 INFO - Downloaded 71238474 bytes.
14:34:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
14:34:57 INFO - mkdir: /builds/slave/test/properties
14:34:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
14:34:57 INFO - Writing to file /builds/slave/test/properties/build_url
14:34:57 INFO - Contents:
14:34:57 INFO - build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
14:34:58 INFO - Running post-action listener: _resource_record_post_action
14:34:58 INFO - Running post-action listener: set_extra_try_arguments
14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.305609Z] Finished download-and-extract step (success)
14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.305738Z] Running populate-webroot step.
14:34:58 INFO - Running pre-action listener: _resource_record_pre_action
14:34:58 INFO - Running main action method: populate_webroot
14:34:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
14:34:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
14:34:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
14:34:58 INFO - '--tppagecycles',
14:34:58 INFO - '7'],
14:34:58 INFO - 'tests': ['tsvgm']}},
14:34:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['tresize', 'tcanvasmark']},
14:34:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
14:34:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['dromaeo_css', 'kraken']},
14:34:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
14:34:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
14:34:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
14:34:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['damp', 'tps']},
14:34:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'tests': ['damp', 'tps']},
14:34:58 INFO - 'g3': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['dromaeo_dom']},
14:34:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
14:34:58 INFO - 'g4': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']},
14:34:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']},
14:34:58 INFO - 'other': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'other-e10s': {'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'other-e10s_l64': {'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['a11yr',
14:34:58 INFO - 'ts_paint',
14:34:58 INFO - 'tpaint',
14:34:58 INFO - 'sessionrestore',
14:34:58 INFO - 'sessionrestore_no_auto_restore',
14:34:58 INFO - 'tabpaint']},
14:34:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']},
14:34:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic',
14:34:58 INFO - 'bloom_basic_ref']},
14:34:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['tsvgx',
14:34:58 INFO - 'tsvgr_opacity',
14:34:58 INFO - 'tart',
14:34:58 INFO - 'tscrollx',
14:34:58 INFO - 'cart',
14:34:58 INFO - 'tsvg_static']},
14:34:58 INFO - 'svgr-e10s': {'tests': ['tsvgx',
14:34:58 INFO - 'tsvgr_opacity',
14:34:58 INFO - 'tart',
14:34:58 INFO - 'tscrollx',
14:34:58 INFO - 'cart',
14:34:58 INFO - 'tsvg_static']},
14:34:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'talos_options': ['--disable-e10s'],
14:34:58 INFO - 'tests': ['tp5o']},
14:34:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
14:34:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'talos_options': ['--disable-e10s',
14:34:58 INFO - '--xperf_path',
14:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:34:58 INFO - 'tests': ['tp5n']},
14:34:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
14:34:58 INFO - 'talos_options': ['--xperf_path',
14:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:34:58 INFO - 'tests': ['tp5n']}},
14:34:58 INFO - 'talos.zip': {'path': '',
14:34:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
14:34:58 INFO - Running post-action listener: _resource_record_post_action
14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.324922Z] Finished populate-webroot step (success)
14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.325019Z] Running create-virtualenv step.
14:34:58 INFO - Running pre-action listener: _resource_record_pre_action
14:34:58 INFO - Running main action method: create_virtualenv
14:34:58 INFO - Creating virtualenv /builds/slave/test/build/venv
14:34:58 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
14:34:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
14:34:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
14:34:58 INFO - Using real prefix '/tools/python27'
14:34:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python
14:34:59 INFO - Installing distribute.............................................................................................................................................................................................done.
14:35:02 INFO - Installing pip.................done.
14:35:02 INFO - Return code: 0
14:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
14:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
14:35:02 INFO - Reading from file tmpfile_stdout
14:35:02 INFO - Output received:
14:35:02 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)
14:35:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
14:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
14:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:02 INFO - 'HOME': '/Users/cltbld',
14:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:02 INFO - 'LOGNAME': 'cltbld',
14:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:02 INFO - 'MOZ_NO_REMOTE': '1',
14:35:02 INFO - 'NO_EM_RESTART': '1',
14:35:02 INFO - 'PAGER': '/bin/cat',
14:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:02 INFO - 'PWD': '/builds/slave/test',
14:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:02 INFO - 'SHELL': '/bin/bash',
14:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:02 INFO - 'USER': 'cltbld',
14:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:02 INFO - 'XPC_FLAGS': '0x0',
14:35:02 INFO - 'XPC_SERVICE_NAME': '0',
14:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:02 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
14:35:02 INFO - Cleaning up...
14:35:02 INFO - Return code: 0
14:35:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
14:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
14:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:02 INFO - 'HOME': '/Users/cltbld',
14:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:02 INFO - 'LOGNAME': 'cltbld',
14:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:02 INFO - 'MOZ_NO_REMOTE': '1',
14:35:02 INFO - 'NO_EM_RESTART': '1',
14:35:02 INFO - 'PAGER': '/bin/cat',
14:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:02 INFO - 'PWD': '/builds/slave/test',
14:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:02 INFO - 'SHELL': '/bin/bash',
14:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:02 INFO - 'USER': 'cltbld',
14:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:02 INFO - 'XPC_FLAGS': '0x0',
14:35:02 INFO - 'XPC_SERVICE_NAME': '0',
14:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:02 INFO - Downloading/unpacking psutil>=3.1.1
14:35:02 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
14:35:02 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
14:35:02 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
14:35:02 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
14:35:02 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
14:35:02 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
14:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
14:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
14:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
14:35:06 INFO - Installing collected packages: psutil
14:35:06 INFO - Running setup.py install for psutil
14:35:06 INFO - building 'psutil._psutil_osx' extension
14:35:06 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
14:35:07 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
14:35:07 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
14:35:07 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
14:35:07 INFO - building 'psutil._psutil_posix' extension
14:35:07 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
14:35:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration]
14:35:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr);
14:35:07 INFO - ^
14:35:07 INFO - 1 warning generated.
14:35:07 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
14:35:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
14:35:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
14:35:07 INFO - Successfully installed psutil
14:35:07 INFO - Cleaning up...
14:35:07 INFO - Return code: 0
14:35:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
14:35: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')]}
14:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:08 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:08 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
14:35:08 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
14:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:08 INFO - 'HOME': '/Users/cltbld',
14:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:08 INFO - 'LOGNAME': 'cltbld',
14:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:08 INFO - 'MOZ_NO_REMOTE': '1',
14:35:08 INFO - 'NO_EM_RESTART': '1',
14:35:08 INFO - 'PAGER': '/bin/cat',
14:35:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:08 INFO - 'PWD': '/builds/slave/test',
14:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:08 INFO - 'SHELL': '/bin/bash',
14:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:08 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:08 INFO - 'USER': 'cltbld',
14:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:08 INFO - 'XPC_FLAGS': '0x0',
14:35:08 INFO - 'XPC_SERVICE_NAME': '0',
14:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:08 INFO - Downloading/unpacking mozsystemmonitor==0.3
14:35:08 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
14:35:08 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
14:35:08 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
14:35:08 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
14:35:08 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
14:35:08 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
14:35:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz
14:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
14:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
14:35:11 INFO - Installing collected packages: mozsystemmonitor
14:35:11 INFO - Running setup.py install for mozsystemmonitor
14:35:11 INFO - Successfully installed mozsystemmonitor
14:35:11 INFO - Cleaning up...
14:35:11 INFO - Return code: 0
14:35:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
14:35: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')]}
14:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35: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')]}
14:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35: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', '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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35: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', 'jsonschema==2.5.1'] in /builds/slave/test/build
14:35: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 jsonschema==2.5.1
14:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:11 INFO - 'HOME': '/Users/cltbld',
14:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:11 INFO - 'LOGNAME': 'cltbld',
14:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:11 INFO - 'MOZ_NO_REMOTE': '1',
14:35:11 INFO - 'NO_EM_RESTART': '1',
14:35:11 INFO - 'PAGER': '/bin/cat',
14:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:11 INFO - 'PWD': '/builds/slave/test',
14:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:11 INFO - 'SHELL': '/bin/bash',
14:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:11 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:11 INFO - 'USER': 'cltbld',
14:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:11 INFO - 'XPC_FLAGS': '0x0',
14:35:11 INFO - 'XPC_SERVICE_NAME': '0',
14:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:12 INFO - Downloading/unpacking jsonschema==2.5.1
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
14:35:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35:15 INFO - Downloading functools32-3.2.3-2.tar.gz
14:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
14:35:15 INFO - warning: no files found matching '*.txt'
14:35:15 INFO - no previously-included directories found matching 'build'
14:35:15 INFO - no previously-included directories found matching 'dist'
14:35:15 INFO - no previously-included directories found matching '.git*'
14:35:15 INFO - Installing collected packages: jsonschema, functools32
14:35:15 INFO - Running setup.py install for functools32
14:35:15 INFO - warning: no files found matching '*.txt'
14:35:15 INFO - no previously-included directories found matching 'build'
14:35:15 INFO - no previously-included directories found matching 'dist'
14:35:15 INFO - no previously-included directories found matching '.git*'
14:35:15 INFO - Successfully installed jsonschema functools32
14:35:15 INFO - Cleaning up...
14:35:15 INFO - Return code: 0
14:35:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build
14:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
14:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:15 INFO - 'HOME': '/Users/cltbld',
14:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:15 INFO - 'LOGNAME': 'cltbld',
14:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:15 INFO - 'MOZ_NO_REMOTE': '1',
14:35:15 INFO - 'NO_EM_RESTART': '1',
14:35:15 INFO - 'PAGER': '/bin/cat',
14:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:15 INFO - 'PWD': '/builds/slave/test',
14:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:15 INFO - 'SHELL': '/bin/bash',
14:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:15 INFO - 'USER': 'cltbld',
14:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:15 INFO - 'XPC_FLAGS': '0x0',
14:35:15 INFO - 'XPC_SERVICE_NAME': '0',
14:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
14:35:15 INFO - Cleaning up...
14:35:15 INFO - Return code: 0
14:35:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build
14:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
14:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:15 INFO - 'HOME': '/Users/cltbld',
14:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:15 INFO - 'LOGNAME': 'cltbld',
14:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:15 INFO - 'MOZ_NO_REMOTE': '1',
14:35:15 INFO - 'NO_EM_RESTART': '1',
14:35:15 INFO - 'PAGER': '/bin/cat',
14:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:15 INFO - 'PWD': '/builds/slave/test',
14:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:15 INFO - 'SHELL': '/bin/bash',
14:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:15 INFO - 'USER': 'cltbld',
14:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:15 INFO - 'XPC_FLAGS': '0x0',
14:35:15 INFO - 'XPC_SERVICE_NAME': '0',
14:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:15 INFO - Downloading/unpacking blobuploader==1.2.4
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35: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
14:35:18 INFO - Downloading blobuploader-1.2.4.tar.gz
14:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
14:35:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
14:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
14:35:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
14:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:19 INFO - Downloading docopt-0.6.1.tar.gz
14:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
14:35:19 INFO - Installing collected packages: blobuploader, requests, docopt
14:35:19 INFO - Running setup.py install for blobuploader
14:35:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
14:35:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
14:35:20 INFO - Running setup.py install for requests
14:35:20 INFO - Running setup.py install for docopt
14:35:20 INFO - Successfully installed blobuploader requests docopt
14:35:20 INFO - Cleaning up...
14:35:20 INFO - Return code: 0
14:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:20 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:20 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
14:35:20 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
14:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:20 INFO - 'HOME': '/Users/cltbld',
14:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:20 INFO - 'LOGNAME': 'cltbld',
14:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:20 INFO - 'MOZ_NO_REMOTE': '1',
14:35:20 INFO - 'NO_EM_RESTART': '1',
14:35:20 INFO - 'PAGER': '/bin/cat',
14:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:20 INFO - 'PWD': '/builds/slave/test',
14:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:20 INFO - 'SHELL': '/bin/bash',
14:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:20 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:20 INFO - 'USER': 'cltbld',
14:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:20 INFO - 'XPC_FLAGS': '0x0',
14:35:20 INFO - 'XPC_SERVICE_NAME': '0',
14:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-urpYqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VcKOVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6TDc06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nE87n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EDlk8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cEN1Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gg4gYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uAEF63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TgtSJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Dd8vAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-x2OalY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Z4ouWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-reIkzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-IwaDnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NvKrHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-avGaQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GOcJQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
14:35:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
14:35:22 INFO - Running setup.py install for manifestparser
14:35:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
14:35:22 INFO - Running setup.py install for mozcrash
14:35:23 INFO - Running setup.py install for mozdebug
14:35:23 INFO - Running setup.py install for mozdevice
14:35:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Running setup.py install for mozfile
14:35:23 INFO - Running setup.py install for mozhttpd
14:35:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Running setup.py install for mozinfo
14:35:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Running setup.py install for mozInstall
14:35:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
14:35:23 INFO - Running setup.py install for mozleak
14:35:24 INFO - Running setup.py install for mozlog
14:35:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Running setup.py install for moznetwork
14:35:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Running setup.py install for mozprocess
14:35:24 INFO - Running setup.py install for mozprofile
14:35:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Running setup.py install for mozrunner
14:35:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
14:35:24 INFO - Running setup.py install for mozscreenshot
14:35:25 INFO - Running setup.py install for moztest
14:35:25 INFO - Running setup.py install for mozversion
14:35:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
14:35:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
14:35:25 INFO - Cleaning up...
14:35:25 INFO - Return code: 0
14:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:35:25 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')]}
14:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:25 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')]}
14:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:25 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:25 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
14:35:25 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
14:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:25 INFO - 'HOME': '/Users/cltbld',
14:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:25 INFO - 'LOGNAME': 'cltbld',
14:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:25 INFO - 'MOZ_NO_REMOTE': '1',
14:35:25 INFO - 'NO_EM_RESTART': '1',
14:35:25 INFO - 'PAGER': '/bin/cat',
14:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:25 INFO - 'PWD': '/builds/slave/test',
14:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:25 INFO - 'SHELL': '/bin/bash',
14:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:25 INFO - 'USER': 'cltbld',
14:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:25 INFO - 'XPC_FLAGS': '0x0',
14:35:25 INFO - 'XPC_SERVICE_NAME': '0',
14:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-phwrtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
14:35:25 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))
14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uK6TTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
14:35:25 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))
14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-j5kAk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
14:35:25 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))
14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-DPWX0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-S7GBjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0TtF8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KbZiwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZPPuiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-I17s_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eYcf9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-at5tYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-iH4k_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
14:35:26 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))
14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Q2QILs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
14:35:27 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))
14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Sp2KIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
14:35:27 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))
14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SVAb5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
14:35:27 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))
14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cFKCX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
14:35:27 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))
14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CFpcd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
14:35:27 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))
14:35:27 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))
14:35:27 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))
14:35:27 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))
14:35:27 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))
14:35:27 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))
14:35:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
14:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:35:29 INFO - Downloading blessings-1.6.tar.gz
14:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
14:35:30 INFO - Installing collected packages: blessings
14:35:30 INFO - Running setup.py install for blessings
14:35:30 INFO - Successfully installed blessings
14:35:30 INFO - Cleaning up...
14:35:30 INFO - Return code: 0
14:35:30 INFO - Done creating virtualenv /builds/slave/test/build/venv.
14:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
14:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
14:35:30 INFO - Reading from file tmpfile_stdout
14:35:30 INFO - Current package versions:
14:35:30 INFO - blessings == 1.6
14:35:30 INFO - blobuploader == 1.2.4
14:35:30 INFO - docopt == 0.6.1
14:35:30 INFO - functools32 == 3.2.3-2
14:35:30 INFO - jsonschema == 2.5.1
14:35:30 INFO - manifestparser == 1.1
14:35:30 INFO - mozInstall == 1.12
14:35:30 INFO - mozcrash == 1.0
14:35:30 INFO - mozdebug == 0.1
14:35:30 INFO - mozdevice == 0.50
14:35:30 INFO - mozfile == 1.2
14:35:30 INFO - mozhttpd == 0.7
14:35:30 INFO - mozinfo == 0.9
14:35:30 INFO - mozleak == 0.1
14:35:30 INFO - mozlog == 3.4
14:35:30 INFO - moznetwork == 0.27
14:35:30 INFO - mozprocess == 0.25
14:35:30 INFO - mozprofile == 0.28
14:35:30 INFO - mozrunner == 6.13
14:35:30 INFO - mozscreenshot == 0.1
14:35:30 INFO - mozsystemmonitor == 0.3
14:35:30 INFO - moztest == 0.8
14:35:30 INFO - mozversion == 1.4
14:35:30 INFO - psutil == 3.1.1
14:35:30 INFO - requests == 1.2.3
14:35:30 INFO - wsgiref == 0.1.2
14:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:30 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:30 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
14:35:30 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
14:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:30 INFO - 'HOME': '/Users/cltbld',
14:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:30 INFO - 'LOGNAME': 'cltbld',
14:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:30 INFO - 'MOZ_NO_REMOTE': '1',
14:35:30 INFO - 'NO_EM_RESTART': '1',
14:35:30 INFO - 'PAGER': '/bin/cat',
14:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:30 INFO - 'PWD': '/builds/slave/test',
14:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:30 INFO - 'SHELL': '/bin/bash',
14:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:30 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:30 INFO - 'USER': 'cltbld',
14:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:30 INFO - 'XPC_FLAGS': '0x0',
14:35:30 INFO - 'XPC_SERVICE_NAME': '0',
14:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 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))
14:35:30 INFO - Cleaning up...
14:35:30 INFO - Return code: 0
14:35:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
14:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:35:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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
14:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build
14:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
14:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:30 INFO - 'HOME': '/Users/cltbld',
14:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:30 INFO - 'LOGNAME': 'cltbld',
14:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:30 INFO - 'MOZ_NO_REMOTE': '1',
14:35:30 INFO - 'NO_EM_RESTART': '1',
14:35:30 INFO - 'PAGER': '/bin/cat',
14:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:30 INFO - 'PWD': '/builds/slave/test',
14:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:30 INFO - 'SHELL': '/bin/bash',
14:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:30 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:30 INFO - 'USER': 'cltbld',
14:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:30 INFO - 'XPC_FLAGS': '0x0',
14:35:30 INFO - 'XPC_SERVICE_NAME': '0',
14:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
14:35:31 INFO - Cleaning up...
14:35:31 INFO - Return code: 0
14:35:31 INFO - Running post-action listener: _resource_record_post_action
14:35:31 INFO - Running post-action listener: _start_resource_monitoring
14:35:31 INFO - Starting resource monitoring.
14:35:31 INFO - [mozharness: 2017-04-27 21:35:31.201344Z] Finished create-virtualenv step (success)
14:35:31 INFO - [mozharness: 2017-04-27 21:35:31.202401Z] Running install step.
14:35:31 INFO - Running pre-action listener: _resource_record_pre_action
14:35:31 INFO - Running main action method: install
14:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
14:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
14:35:31 INFO - Reading from file tmpfile_stdout
14:35:31 INFO - Detecting whether we're running mozinstall >=1.0...
14:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
14:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
14:35:31 INFO - Reading from file tmpfile_stdout
14:35:31 INFO - Output received:
14:35:31 INFO - Usage: mozinstall [options] installer
14:35:31 INFO - Options:
14:35:31 INFO - -h, --help show this help message and exit
14:35:31 INFO - -d DEST, --destination=DEST
14:35:31 INFO - Directory to install application into. [default:
14:35:31 INFO - "/builds/slave/test"]
14:35:31 INFO - --app=APP Application being installed. [default: firefox]
14:35:31 INFO - mkdir: /builds/slave/test/build/application
14:35:31 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']
14:35:31 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
14:35:50 INFO - Reading from file tmpfile_stdout
14:35:50 INFO - Output received:
14:35:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox
14:35:50 INFO - Running post-action listener: _resource_record_post_action
14:35:50 INFO - [mozharness: 2017-04-27 21:35:50.996460Z] Finished install step (success)
14:35:50 INFO - [mozharness: 2017-04-27 21:35:50.996591Z] Running run-tests step.
14:35:50 INFO - Running pre-action listener: _resource_record_pre_action
14:35:50 INFO - Running main action method: run_tests
14:35:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
14:35:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
14:35:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
14:35:51 INFO - 2017-04-27 14:35:51.012 screenresolution[1621:7366] starting screenresolution argv=screenresolution get
14:35:51 INFO - 2017-04-27 14:35:51.015 screenresolution[1621:7366] Display 0: 1600x1200x32@60
14:35:51 INFO - 2017-04-27 14:35:51.020 screenresolution[1622:7424] starting screenresolution argv=screenresolution list
14:35:51 INFO - Available Modes on Display 0
14:35:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
14:35:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
14:35:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
14:35:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
14:35:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
14:35:51 INFO - Intel Iris:
14:35:51 INFO - Chipset Model: Intel Iris
14:35:51 INFO - Type: GPU
14:35:51 INFO - Bus: Built-In
14:35:51 INFO - VRAM (Dynamic, Max): 1536 MB
14:35:51 INFO - Vendor: Intel (0x8086)
14:35:51 INFO - Device ID: 0x0a2e
14:35:51 INFO - Revision ID: 0x0009
14:35:51 INFO - Displays:
14:35:51 INFO - Display:
14:35:51 INFO - Resolution: 1600 x 1200 @ 60 Hz
14:35:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
14:35:51 INFO - Display Serial Number: 1600x1200 60
14:35:51 INFO - Main Display: Yes
14:35:51 INFO - Mirror: Off
14:35:51 INFO - Online: Yes
14:35:51 INFO - Rotation: Supported
14:35:51 INFO - Return code: 0
14:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
14:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
14:35:51 INFO - Python 2.7.3
14:35:51 INFO - Return code: 0
14:35:51 INFO - grabbing minidump binary from tooltool
14:35: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')]}
14:35:51 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 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
14:35:51 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
14:35:51 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
14:35:51 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
14:35:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
14:35:51 INFO - Return code: 0
14:35:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755
14:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
14:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
14:35:51 INFO - ENV: RUST_BACKTRACE is now 1
14:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk
14:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
14:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
14:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
14:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render',
14:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared',
14:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared',
14:35:51 INFO - 'HOME': '/Users/cltbld',
14:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true',
14:35:51 INFO - 'LOGNAME': 'cltbld',
14:35:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
14:35:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk',
14:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:35:51 INFO - 'MOZ_NO_REMOTE': '1',
14:35:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
14:35:51 INFO - 'NO_EM_RESTART': '1',
14:35:51 INFO - 'PAGER': '/bin/cat',
14:35:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11',
14:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:35:51 INFO - 'PWD': '/builds/slave/test',
14:35:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
14:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg',
14:35:51 INFO - 'RUST_BACKTRACE': '1',
14:35:51 INFO - 'SHELL': '/bin/bash',
14:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners',
14:35:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/',
14:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log',
14:35:51 INFO - 'USER': 'cltbld',
14:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no',
14:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7',
14:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:35:51 INFO - 'XPC_FLAGS': '0x0',
14:35:51 INFO - 'XPC_SERVICE_NAME': '0',
14:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'}
14:35:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
14:35:51 INFO - mozversion application_buildid: 20170427130024
14:35:51 INFO - mozversion application_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4
14:35:51 INFO - mozversion application_display_name: Nightly
14:35:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
14:35:51 INFO - mozversion application_name: Firefox
14:35:51 INFO - mozversion application_remotingname: firefox
14:35:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
14:35:51 INFO - mozversion application_vendor: Mozilla
14:35:51 INFO - mozversion application_version: 55.0a1
14:35:51 INFO - mozversion platform_buildid: 20170427130024
14:35:51 INFO - mozversion platform_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4
14:35:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
14:35:51 INFO - mozversion platform_version: 55.0a1
14:35:51 INFO - using testdate: 1493328951
14:35:51 INFO - actual date: 1493328951
14:35:51 INFO - starting webserver on 'localhost:49234'
14:35:51 INFO - SUITE-START | Running 2 tests
14:35:51 INFO - TEST-START | dromaeo_css
14:35:51 INFO - operating with platform_type : mac_
14:35:51 INFO - Initialising browser for dromaeo_css test...
14:35:51 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXEOdQ9/profile http://localhost:49234/getInfo.html)
14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.160 plugin-container[1634:7668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname'
14:35:54 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.163 plugin-container[1634:7668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d0b, name = 'com.apple.CFPasteboardClient'
14:35:54 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.163 plugin-container[1634:7668] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
14:35:54 INFO - PID 1632 | __metrics Screen width/height:1600/1200
14:35:54 INFO - PID 1632 | colorDepth:24
14:35:54 INFO - PID 1632 | Browser inner width/height: 1024/689
14:35:54 INFO - PID 1632 | __metrics
14:35:54 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined
14:35:55 INFO - TEST-INFO | 1632: exit 0
14:35:55 INFO - Browser initialized.
14:35:55 INFO - Running cycle 1/1 for dromaeo_css test...
14:35:55 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXEOdQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.519 plugin-container[1636:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname'
14:35:57 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.520 plugin-container[1636:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient'
14:35:57 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.520 plugin-container[1636:7796] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
14:36:07 INFO - PID 1635 | RSS: Main: 251232256
14:36:07 INFO - PID 1635 |
14:39:10 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html)
14:39:12 INFO - PID 1635 | RSS: Main: 255221760
14:39:12 INFO - PID 1635 |
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task.
14:40:56 INFO - PID 1635 |
14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource.
14:40:56 INFO - PID 1635 | Full stack:
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task.
14:40:56 INFO - PID 1635 |
14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource.
14:40:56 INFO - PID 1635 | Full stack:
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task.
14:40:56 INFO - PID 1635 |
14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource.
14:40:56 INFO - PID 1635 | Full stack:
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | *************************
14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task.
14:40:56 INFO - PID 1635 |
14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource.
14:40:56 INFO - PID 1635 | Full stack:
14:40:56 INFO - PID 1635 | *************************
14:42:14 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html)
14:42:15 INFO - PID 1635 | RSS: Main: 258920448
14:42:15 INFO - PID 1635 |
14:45:16 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html)
14:45:17 INFO - PID 1635 | RSS: Main: 269828096
14:45:17 INFO - PID 1635 |
14:48:19 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html)
14:48:19 INFO - PID 1635 | RSS: Main: 262742016
14:48:19 INFO - PID 1635 |
14:51:22 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html)
14:51:23 INFO - PID 1635 | RSS: Main: 271310848
14:51:23 INFO - PID 1635 |
14:54:24 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html)
14:54:25 INFO - PID 1635 | RSS: Main: 265986048
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | __start_tp_report
14:54:25 INFO - PID 1635 | _x_x_mozilla_page_load
14:54:25 INFO - PID 1635 | _x_x_mozilla_page_load_details
14:54:25 INFO - PID 1635 | |i|pagename|runs|
14:54:25 INFO - PID 1635 | |0;dojo.html;3237.676232376762;3336.1159292787415;3404.8808291709797;3597.010822023943;3602.675759181674;5809.925163844681;5954;6098.969505152473;6160.845978850531;6184.196054512919;6001.129836173752;6010.398960103998;6057;6061.575689701723;6127.816165515031;4292.6780491463105;5298.655587386817;5311.920321195185;5332.413434522199;5373.785048598052;5363.9463605363835;5367.919481207766;5379.139337705968;5380.811671591495;5396.5952553558445;5222.294990176316;5268.736563171826;5388.084025715618;5420.268263784398;5427.6472029318165;4681.344611754357;4808.374911261513;5217.452167522431;5300.708461034642;5405.297311349519;5220.086484865172;5259.658122222043;5292.550133238641;5296.523312901857;5356.1430171172815;4915.48387419323;6025.276966764016;6046.879062418727;6092.5430592705725;6129.325774164839;5053.191489361721;6499.512536559777;6504.902426463606;6525.347465253484;6558.639274839882;6305.968470157666;6384.138141350904;6551.21385433751;6606.405423511859;6631.27056023837;6258.499320054385;6282.057691346335;6288.056791481269;6295.992641177481;6308.558400911892;6575.408213260829;6769.458443324522;6785.42323902464;6789.25318214996;6820.624865632438;5383.542398896059;6224.751009959551;6286.528510361742;6406.167198264196;6699.933000669931;5435.239066530688;6516.869662606721;6578.111954886125;6595.373439523238;6626.4367528760595;5625.987322281947;6189.133521307021;6432.871342573122;6451.774187903401;6486.189226346707;6253.7185826637915;6299.622022678563;6315.336889626615;6409.230892292861;6444.645544495098;4781.760911954389;4962.727050012284;5182.352205974254;5214.45248248936;5232.581393488512;4677.508861569554;4687.81248750053;4698.600618947427;4716.646251531149;4790.161721698689;5153.639245252872;5995.5803093783015;6237;6241.095041218998;6348.904766428507;6297.716602752887;6356.745730170834;6461.870762584722;6520.739170433129;6525.575837570543;6099.111808770591;6139.048447490646;6149.692515374213;6158.322584515699;6218.471429928416;5773.538116950634;5822.272215973004;5834.883302333929;5845.210896528914;5859.648421094748;6526.608403495806;6588.472922166119;6670.633115178712;6751.223609284897;6778.288279730557;6570.375814297634;6586.110875032001;6605.966970165118;6619.073329733745;6653.800385988428;6509.283978762238;6631.038499417654;6678.766243181465;6802.795916122524;6806.7957961261245;6355;6367.331430199948;6411.5832470889245;6419.325970773001;6432.678366081771;6006;6350.142730731292;6350.587211831216;6383;6455.903161452676;6235.688215589112;6245.96877015612;6321.462675672619;6324.051392291193;6356.523260755369;6361.650109244036;6372.267189273293;6372.394622510854;6374.713137908712;6392.712327945346;5568.470995255444;6252.218472690914;6257.374262573706;6264.718087685974;6289.811305660837;6181.752729890934;6218.440340369389;6242.687865606792;6262.874742505215;6365.299817020216;6214.8135555933395;6215.129881816459;6229.5327850410495;6232.376762323913;6256.499480041494
14:54:25 INFO - PID 1635 | |1;ext.html;747.6897087708597;768.9038870141233;840.4159109418954;1203.1397550751217;1252.1985929005432;31440;31737.73049078037;31781;34451.31097378054;37860.43209351855;37182.62817371826;37416.81291593545;37439;37439.438408423826;37562.624373756254;7955.7215497457455;8125.75622731319;8371.823325935271;8598;8631.093735157812;7429.294217049372;8546.05993340732;8600.8709869352;8647.69733059343;8664.176903194186;6538.8692226155445;7315.707371705125;8188.50868947865;8620.525871077089;8623.223909848113;7993.520388776692;8639.611217495196;8641.95679021604;8654.48073115615;8656.523891185981;7863.8034049148655;8417.663293468315;8434.915650843473;8437.987441506997;8449.408541402105;36974.63025369739;37105.257894841954;37120.628793712254;37178.88463346104;37280.25439491195;3635.2366003139373;3650.34293827111;3674.2467794102145;3675.6140605236333;3677.4483827425834;25691.871540642365;29368.41263174746;30382.54426183609;30562;30583.541246881094;2791.3021744563857;3129.874805007797;3147.8740850365957;3149.9842500787577;3160.873565057395;216555.9172204129;216830.99014059207;272094.999999998;287844;288800.5559972208;47598.76200618975;47708;47844.73707892129;47863.28205076927;47967.60161991887;49398.01203975901;49718.50281497139;49749.75625609316;49802.750986244835;49835.75082124566;13548.187108773505;13646.727065458635;13723.588292351245;13739.381727822272;13755.867840484541;10957.17821163416;10992.28550144238;11052.668419947415;11073.889261107446;11107.94446027781;13296.401661925236;13335.066545341733;13384.93307533456;13519.188848669111;13534.45862165522;5110.514501122388;5998.670073146019;6022.518198544106;6047.637141771508;6062.757489700362;1015.2030655935056;1018.4245901065874;1023.2325755683238;1052.1582733812918;1063.8616979792578;23506.64740028901;24590.754092459203;24597.754022459903;24675.62986555203;25395.49209015809;1109.6060898380958;1132.7904337697553;1140.1278022312938;1153.2503872482785;1169.7601991591703;11054.613088541862;12468.43892024861;12601.684957876127;12616.30610316423;12628.989680825513;309506.9049309523;311946;312260;312750;312835.4358228194;52514.737426312626;52549.68625784386;52636;52730.73634631802;52760.73619631877;1498.8201415829951;1505.1871989125968;1538.8153421589257;1542.2443002928485;1543.8301786803443;23774.88112559426;23941.760582393952;23993.760062399153;24054.39864003414;24646.876765616056;36798.44802328021;36842.44736328904;36869.631303687696;36914.63085369112;36941;259894;261292;261364;261431;262687;33399.49900751442;33468;33806.81676141323;34336.45485953188;34417.82791086029;42323;44665;44683;44722.3291650632;44743.10513789771;29062;29166.27084322909;29698.960536381124;31016.22459438532;31143.221419464695;28515.572266416435;29802.10593682193;30668.386632267677;30851.69148308488;31312.843435782674;35195.648043519235;36209.63790362063;37040.25919481649;37100.25799483941;37111.25777484489;29926.25184370408;30491;31043.84478077595;31150.68849311478;31621.73513059452;21741.782582173975;23196.536069278183;24479.143229986865;24550.508989819748;24579.508409832062
14:54:25 INFO - PID 1635 | |2;jquery.html;439.27300317973766;446.4597836617692;447.55244755244746;462.7501149379335;466.5544405093136;18529.814701852978;18928.716069258953;19911.30310439135;21171.153153873827;21425.928703564838;20387.898060509713;22062.558748825013;22086.00612972416;22296.331110066683;22376.104955801788;5952.7321270542825;6190.040543715709;6217.440430361266;6254.7185376657935;6262.937370626281;5784.56615753818;6014.3985601439945;6106.542009349294;6112.327643959183;6114.144019837227;5836.5914385993;6028.849278768022;6038.33578306386;6055.818325450244;6063.302720187169;5957.1659967604355;6047.909281360783;6090.5736598438125;6095.664738439384;6109.266887973427;5353.839384818422;5356.035913535601;5365;5414.864628384283;5417.702026388547;26017.869910650516;26047.348816279555;26072.73927260722;26275.292106013047;26596.069137580285;2157.0616781699855;2229.3312006398014;2230.8549944253573;2231.553689262154;2235.798778109962;14480.782788258184;15368;17400.825991740174;18036.008019558918;18240;2087.2277257414703;2129.233475948657;2165.274632997932;2166.620841352773;2195.560887822442;128743;143432;153763;154600;157244.42755572413;12187.39063046844;12657.11400201977;12687.68280792969;12767.744645107046;12785.488580456678;14796.298425680969;15304.770428443582;16311.67376652484;16340.591485212964;16374.263158157912;6375.681215939185;7265.709371625181;8413.789655258544;8491.787705307293;8523.531205783742;7754.418418618626;7757.7672669819995;7790.182030886788;7903.249191326815;7915;7894.21057894206;7982.760517184493;7999.200079991954;8062.072861620989;8075.273225409741;1971.7929617389968;2028.3509277031503;2036.1877928643519;2040.8163265305898;2041.285550057468;891.4784850862188;922.9630814767469;960.9855852162223;963.393062370702;993.8956409577034;20134.395968120978;20521.589568208554;20525.58948821045;20527.897360513103;20839.79160208409;906.9455832650062;939.9671011514564;977.8288799460066;1016.598443614768;1016.8017236638784;9073.637054517745;10685.305455145392;10748.570057197781;10788.51451684676;10843.349399036084;535787;544428;544573;558654;560190;129118;129571;131537;134819.32590337182;136019;1179.151011271883;1207.402335843763;1223.7552489502136;1226.6320103968774;1227.6869398303375;20583.691244631642;21790.782092178877;21830.45423864416;21914.890425547772;21950.121995120015;53013.73493132664;56576.717116414155;56921.43078569161;57939.42060579509;58131.709341453025;78390.6080469594;78714;80104;80182;80649;8601.494738420626;8702.782430439289;8807.119288071142;9231.030741772018;9240.399374040666;14070.648233794236;14197.929010355296;14226.573202803518;14539.781903271249;14568.41726330935;11967.880321197024;11974.46114924813;12099.971502422393;12119.333436661069;12178;11482.598109066143;11495.48270327854;11571.6528504145;11853.288802671867;11882.702932426759;12032.338221397908;12194.51221951112;12292.569760058355;12457.252564845776;12561.560345387868;7856.332211762065;8851;8956.149165829236;8975.32685048611;9120.179183873483;10168.440735759605;10262.897371026493;11936.820947685617;11971.401429928643;11995.820062698893
14:54:25 INFO - PID 1635 | |3;mootools.html;1404.782258749893;1409.4714482069223;1415.810718996043;1490.3070072416324;1497.8202615686116;11351.886481135196;11643.883561164386;11659.300441973488;11661.766764664711;11743.41282935854;9975.40147591145;11440.771184576304;11596.884031159685;11610.245334053281;11630.069594432447;2196.857634030311;2463.08865719684;2525.6716626838484;2560.7567281108263;2562.3209849389928;1995.6828493194494;2325.976740232593;2361.917332893349;2375.6080246759266;2376.738558758535;2466.3094333586537;2497.9875100624563;2516.8238223324374;2522.407234299938;2523.7854782343525;2471.1104002559064;2492.67595212623;2504.912328068518;2521.2562294123277;2522.6846644169477;2450.5834008218644;2495.7254701982765;2505.1732928133674;2509.874506274679;2562.744255314882;11672.299662020307;11835.11236657254;11877;11890;11894.286342819458;6584.5061620378665;6782.626955517445;6825.36191314086;6844.589324640538;6847.657617119125;3723;4059.269331520325;4403.22943484892;4443.37792709021;4483.529229430928;1077.8329358949375;1243.359669770069;1252.4301442843575;1291.8901893339078;1300.8959283257316;16029.198540073066;16166.949148305323;16302.592435189215;16484.34062637493;17098.23057962382;4914.754262286871;5369.677819330853;5682.119271512922;5832.3292821326095;5846.947549441142;9605.759856003655;11598.88401115995;11769.117316201318;11778.587749428729;11849.881501185051;5517.61376703635;5856.1508581255475;6352.14246076783;6606.372394622503;6616.933830661728;5750.453706897838;6032.758689652453;6265.749370025148;6271.216097987752;6287.434130928147;4303.655707543389;4415.249407600716;4424.402705634698;4443.311286750559;4444.488883778342;1259.962201133949;1287.575100216926;1291.489861504719;1300.9349532523336;1303.4981532110016;708.9255628159073;779.5985067690144;800.4996876951905;827.1728271728272;828.8176601147737;6598.538102332791;6830.965845170742;6933.11339222719;6974.895376569356;7015.543989640657;900.9234215091791;930.7161315798746;938.1134827587864;948.369334392635;950.626344931581;3948.545917219499;4335.479742430928;4556.316552517149;4569.748663823521;4678.111158879802;15092.1699306537;15138.243087845563;15414.152221627694;15432.92283538575;15433.074015558877;14646.63383415423;14660;15180;15541.378344866305;15542.84457155414;8145.592720363839;8641.56792160402;8702.173293537104;8783.868241976375;8878;6898.586084834926;7066.505344626033;7203.991441198341;7218.855622887618;7238.348548630648;13274.668133296746;13330.466781328638;13569.52506662262;13598.048136630341;13618.727625447635;11378;13382.866171338552;13460.93269533646;13805.964552658792;13967.301634918416;9363.812723745623;9424.670136545188;9474.336796424459;9519.476428796206;9537.47543885093;10673.733156671145;10688.839667405151;10755.247132700635;10811.027007569357;10923.289986150874;9205.585748641193;9243.306751993761;9255.167034966886;9293.86059209126;9335.48654823964;7625.923740762521;8825.470471771714;9024.142706442877;9159.633614655339;9218.492982886006;8130;8200.26197642215;8303.252707256375;8324.0427350853;8362.331013519026;5316.6544174628525;6166.167567378347;6182.352412076896;6191.133241346305;6200.844978875564;6055.273367195965;6128.4790792783115;6219.160413344322;6274.121622972879;6380.840478988062
14:54:25 INFO - PID 1635 | |4;prototype.html;388.947492088568;405.8696530163495;406.19370549459325;409.41862555171656;419.2160659566611;5370.7851685932565;5955;6241.157443745093;6253.71858266378;6265.874682506347;4666.486686464486;5528.336599608043;5898.7935422260225;6057.575969682124;6114.768109639983;4653.464851542082;4691.366665500165;4695.225287827521;4712.717236965776;4715.033418149271;4238.936415953764;4554.749488778116;4704.035672687108;4725.8109675613105;4742.952570474303;3598.85604575818;4054.2702313583545;4604.743675598966;4643.907121857561;4696.272077827942;4650.116477869194;4663.580277775;4669.7898594562985;4697.4832768395445;4709.105269998689;3446;3892.552356479013;4037.253108174997;4099.344104943225;4162.229987452331;5368.91946620801;5938.930992421362;5963.910541341883;5993.910091348634;6079.483243924272;4814.3019262207135;5390.21841832932;5535.114381698909;5543.533127758149;5559.916601250984;6493.70778314977;6566.770163044318;6610.272869984298;6610.6778644271335;6662.600243985328;4486.147631949919;4722.197226471508;4742.316477650419;4750;4757.809687612491;5946.108083787466;6007.927265093579;6966.4078553323025;6979.755708550177;7036.542624729376;4265.893352666146;4832.251001094836;4832.49258827818;4863.076015557032;4872.366592342973;4923.87690307738;4944.53026962438;4949.307097006422;4971.825986090542;4986.227134794112;5399.244105825188;5489.39616642169;5544.500994910478;5546.445355464502;5557.972210138923;5721.456461636138;6599;6604.867902642017;6610.768623098168;6632.204135503771;1493.7609982402764;1688.4174959638906;1701.174930158872;1701.5150682055555;1702.1319127245195;1150.5685367987005;1170.5200867644226;1172.4841069929205;1175.976900096921;1193.3854065156452;6205;6215.564910456224;6217;6221.720022598994;6234.625922444668;5308.761105750251;5473.370562385297;6613.768518101843;6759.290274521203;6795.762148324785;6204.348543402968;6207.317195108534;6208;6209.472194863397;6254.405831446005;2921.5471601901313;3416.940748368014;3435.4331535296897;3452.6374730653424;3549.982250088733;6008.858316919771;6984.825379365455;7046.964765176243;7080.2919708028785;7141.714331426685;6000.669963151981;6022.789202377896;6973;7067.469939754539;7068.858622827514;6977.930220697728;6993.335633114846;7033.507654464139;7058.71765129389;7129.465290103263;5438.320209973754;5769.94230057694;5983.760649573968;6126.5098792097415;6526.074807931766;5894.764209431574;6707.3292670732535;6721.260661327152;6735.64252511617;6744.359285867835;6319.936800632118;6754.5609535380045;7073.3987611053635;7112.288771122846;7136.892946605909;4429.601335879786;4493.460784705856;4774.7851346688785;4839.7096174229655;4859.198232291632;6826.917790074075;6851.9657401712675;6852.211995620568;6870.690818913061;6896.793096207121;5658.641925937827;6158.507319414526;6605.867882642417;6625.536212465274;6632.403083722488;6577.704003319958;6608.471322294301;6624.271330153776;6626.933730662825;6699.464042876656;5170.43125256214;5350.5184533392185;6381.904271436025;6498.772542961163;6530.575512591857;5718.914216286842;6238.220222472191;6591.5056370773345;6608.867822643424;6616.742818864401;5489.58828087887;5744.937186620488;5811.302643682785;5971.940280597139;6416.935830641633
14:54:25 INFO - PID 1635 | |5;yui.html;734.6326836581709;777.0869228656327;782.3662833105182;849.0702680564782;871.6600525794939;16446;16911.40810071648;16965.236564354618;18394.816051839476;19101.42695719127;17987;18299.268029278846;18416.81583184168;18425.07874606271;18576.16407261673;1002.4486532407166;1030.7680771826317;1036.1037702387418;1037.4345981440133;1038.0449986012886;847.516915358246;1019.5157300282343;1028.0644613401805;1032.7160030991463;1033.0650761061252;1080.1628737728283;1085.8642669666292;1089.5478376473754;1089.585957336211;1090.4438736244492;1053.9947300263489;1071.346478648024;1080.9945950270198;1081.5998080710149;1082.6048492300333;769.6498093367504;784.1687810920442;790.5414859381602;794.6702118620766;796.4982061301401;14553.636159096002;16806.075665838496;16935.830641693672;17077.7438338425;17117.743233851503;16921.7461738074;17039.403620873334;17356.218970146372;17443.5639109022;17486.562835929075;13746.725065498735;13950.372233249427;14291.356888940023;14299.356528956221;14315.42738290467;3228.580284563015;3498.8775392861126;3561.5013898054294;3569.839357228931;3581.943326718598;96784;129068.35465822705;129172;130348;131137;12911.35443227835;12998.480060797463;13626.93186534061;13676.179429234278;13697.972652051136;21296.893515532323;24450.144244951698;25142.371440713763;25369.238922832345;25975.350616234744;7546.1321947976685;7621.542707437571;7731.690732370755;7758.340541054074;7808.6095695216145;3334.8666053357592;3795.3927371620407;3868.497095377583;3868.8065596720053;3882.1847412043785;4136.31750761127;4246.66026717868;4322.524522302544;4354.390385346054;4402.933955990663;825.6160885188416;947.4646824544111;953.6471505542855;972.7422233108232;973.756560859785;648.3613640564041;652.7845810882397;678.7149397253165;679.6431873266475;681.4786688183543;10945;11846.703832404259;11995.340256285814;12029;12107.031437485157;648.3484098480997;653.8626888353499;657.8585604095142;667.1893649216129;682.9760958366434;5377.838664840061;5511.421300763443;5545.426091622278;5587.944120558824;5597.104463285936;106151.46924265329;106279.87440251152;106385.46807265915;106961.9303806952;110286;85925;86640.56679716561;87349;87755;88696.556517217;78407.60796195983;82164.58917705492;85027;86651.53393864175;87259.56370218108;11717.707057323634;12352.3823808811;12432.627021189379;12525.311107889154;12603.87396126027;39964.60035399609;41104.38343424791;41396;41746.58253417427;42103.7894810524;53721.73139134279;54464.18303725368;55003.44996550144;55852;56229.15656265241;15686.450974216305;15997.360105595646;16237.350505979628;17029.829701702824;17035.48893533196;18450.630987379907;18473.16870740793;18696;18710.625787484445;18891.811081889005;16598.25307861125;16729.247183877;17257;17284.135793210036;17485.82514174842;13204.933975330061;16719.916400418406;16887.7466838;16943.661126777642;17064.48806535806;16265.268062937434;16619.335226591284;16733.330666773192;16989.915050425163;17136.886102403303;10289.9485502572;11720.765584688088;11780.175387722777;12163.45264463119;12192.268463892195;12598.622041338775;12630.43163057683;12633.368331583568;12634.557790477289;12642.620721378373
14:54:25 INFO - PID 1635 | __end_tp_report
14:54:25 INFO - PID 1635 | __start_cc_report
14:54:25 INFO - PID 1635 | _x_x_mozilla_cycle_collect,422
14:54:25 INFO - PID 1635 | __end_cc_report
14:54:25 INFO - PID 1635 | __startTimestamp1493330065178__endTimestamp
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | ------- Summary: start -------
14:54:25 INFO - PID 1635 | Number of tests: 6
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5958.04 Median:6237.00 stddev:723.70 (11.6%) stddev-sans-first:693.74
14:54:25 INFO - PID 1635 | Values: 3237.7 3336.1 3404.9 3597.0 3602.7 5809.9 5954.0 6099.0 6160.8 6184.2 6001.1 6010.4 6057.0 6061.6 6127.8 4292.7 5298.7 5311.9 5332.4 5373.8 5363.9 5367.9 5379.1 5380.8 5396.6 5222.3 5268.7 5388.1 5420.3 5427.6 4681.3 4808.4 5217.5 5300.7 5405.3 5220.1 5259.7 5292.6 5296.5 5356.1 4915.5 6025.3 6046.9 6092.5 6129.3 5053.2 6499.5 6504.9 6525.3 6558.6 6306.0 6384.1 6551.2 6606.4 6631.3 6258.5 6282.1 6288.1 6296.0 6308.6 6575.4 6769.5 6785.4 6789.3 6820.6 5383.5 6224.8 6286.5 6406.2 6699.9 5435.2 6516.9 6578.1 6595.4 6626.4 5626.0 6189.1 6432.9 6451.8 6486.2 6253.7 6299.6 6315.3 6409.2 6444.6 4781.8 4962.7 5182.4 5214.5 5232.6 4677.5 4687.8 4698.6 4716.6 4790.2 5153.6 5995.6 6237.0 6241.1 6348.9 6297.7 6356.7 6461.9 6520.7 6525.6 6099.1 6139.0 6149.7 6158.3 6218.5 5773.5 5822.3 5834.9 5845.2 5859.6 6526.6 6588.5 6670.6 6751.2 6778.3 6570.4 6586.1 6606.0 6619.1 6653.8 6509.3 6631.0 6678.8 6802.8 6806.8 6355.0 6367.3 6411.6 6419.3 6432.7 6006.0 6350.1 6350.6 6383.0 6455.9 6235.7 6246.0 6321.5 6324.1 6356.5 6361.7 6372.3 6372.4 6374.7 6392.7 5568.5 6252.2 6257.4 6264.7 6289.8 6181.8 6218.4 6242.7 6262.9 6365.3 6214.8 6215.1 6229.5 6232.4 6256.5
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:42808.08 Median:3155.43 stddev:72866.07 (2309.2%) stddev-sans-first:73002.05
14:54:25 INFO - PID 1635 | Values: 747.7 768.9 840.4 1203.1 1252.2 31440.0 31737.7 31781.0 34451.3 37860.4 37182.6 37416.8 37439.0 37439.4 37562.6 7955.7 8125.8 8371.8 8598.0 8631.1 7429.3 8546.1 8600.9 8647.7 8664.2 6538.9 7315.7 8188.5 8620.5 8623.2 7993.5 8639.6 8642.0 8654.5 8656.5 7863.8 8417.7 8434.9 8438.0 8449.4 36974.6 37105.3 37120.6 37178.9 37280.3 3635.2 3650.3 3674.2 3675.6 3677.4 25691.9 29368.4 30382.5 30562.0 30583.5 2791.3 3129.9 3147.9 3150.0 3160.9 216555.9 216831.0 272095.0 287844.0 288800.6 47598.8 47708.0 47844.7 47863.3 47967.6 49398.0 49718.5 49749.8 49802.8 49835.8 13548.2 13646.7 13723.6 13739.4 13755.9 10957.2 10992.3 11052.7 11073.9 11107.9 13296.4 13335.1 13384.9 13519.2 13534.5 5110.5 5998.7 6022.5 6047.6 6062.8 1015.2 1018.4 1023.2 1052.2 1063.9 23506.6 24590.8 24597.8 24675.6 25395.5 1109.6 1132.8 1140.1 1153.3 1169.8 11054.6 12468.4 12601.7 12616.3 12629.0 309506.9 311946.0 312260.0 312750.0 312835.4 52514.7 52549.7 52636.0 52730.7 52760.7 1498.8 1505.2 1538.8 1542.2 1543.8 23774.9 23941.8 23993.8 24054.4 24646.9 36798.4 36842.4 36869.6 36914.6 36941.0 259894.0 261292.0 261364.0 261431.0 262687.0 33399.5 33468.0 33806.8 34336.5 34417.8 42323.0 44665.0 44683.0 44722.3 44743.1 29062.0 29166.3 29699.0 31016.2 31143.2 28515.6 29802.1 30668.4 30851.7 31312.8 35195.6 36209.6 37040.3 37100.3 37111.3 29926.3 30491.0 31043.8 31150.7 31621.7 21741.8 23196.5 24479.1 24550.5 24579.5
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35358.55 Median:12262.83 stddev:93001.33 (758.4%) stddev-sans-first:93225.26
14:54:25 INFO - PID 1635 | Values: 439.3 446.5 447.6 462.8 466.6 18529.8 18928.7 19911.3 21171.2 21425.9 20387.9 22062.6 22086.0 22296.3 22376.1 5952.7 6190.0 6217.4 6254.7 6262.9 5784.6 6014.4 6106.5 6112.3 6114.1 5836.6 6028.8 6038.3 6055.8 6063.3 5957.2 6047.9 6090.6 6095.7 6109.3 5353.8 5356.0 5365.0 5414.9 5417.7 26017.9 26047.3 26072.7 26275.3 26596.1 2157.1 2229.3 2230.9 2231.6 2235.8 14480.8 15368.0 17400.8 18036.0 18240.0 2087.2 2129.2 2165.3 2166.6 2195.6 128743.0 143432.0 153763.0 154600.0 157244.4 12187.4 12657.1 12687.7 12767.7 12785.5 14796.3 15304.8 16311.7 16340.6 16374.3 6375.7 7265.7 8413.8 8491.8 8523.5 7754.4 7757.8 7790.2 7903.2 7915.0 7894.2 7982.8 7999.2 8062.1 8075.3 1971.8 2028.4 2036.2 2040.8 2041.3 891.5 923.0 961.0 963.4 993.9 20134.4 20521.6 20525.6 20527.9 20839.8 906.9 940.0 977.8 1016.6 1016.8 9073.6 10685.3 10748.6 10788.5 10843.3 535787.0 544428.0 544573.0 558654.0 560190.0 129118.0 129571.0 131537.0 134819.3 136019.0 1179.2 1207.4 1223.8 1226.6 1227.7 20583.7 21790.8 21830.5 21914.9 21950.1 53013.7 56576.7 56921.4 57939.4 58131.7 78390.6 78714.0 80104.0 80182.0 80649.0 8601.5 8702.8 8807.1 9231.0 9240.4 14070.6 14197.9 14226.6 14539.8 14568.4 11967.9 11974.5 12100.0 12119.3 12178.0 11482.6 11495.5 11571.7 11853.3 11882.7 12032.3 12194.5 12292.6 12457.3 12561.6 7856.3 8851.0 8956.1 8975.3 9120.2 10168.4 10262.9 11936.8 11971.4 11995.8
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7125.71 Median:4181.46 stddev:4493.84 (107.5%) stddev-sans-first:4485.89
14:54:25 INFO - PID 1635 | Values: 1404.8 1409.5 1415.8 1490.3 1497.8 11351.9 11643.9 11659.3 11661.8 11743.4 9975.4 11440.8 11596.9 11610.2 11630.1 2196.9 2463.1 2525.7 2560.8 2562.3 1995.7 2326.0 2361.9 2375.6 2376.7 2466.3 2498.0 2516.8 2522.4 2523.8 2471.1 2492.7 2504.9 2521.3 2522.7 2450.6 2495.7 2505.2 2509.9 2562.7 11672.3 11835.1 11877.0 11890.0 11894.3 6584.5 6782.6 6825.4 6844.6 6847.7 3723.0 4059.3 4403.2 4443.4 4483.5 1077.8 1243.4 1252.4 1291.9 1300.9 16029.2 16166.9 16302.6 16484.3 17098.2 4914.8 5369.7 5682.1 5832.3 5846.9 9605.8 11598.9 11769.1 11778.6 11849.9 5517.6 5856.2 6352.1 6606.4 6616.9 5750.5 6032.8 6265.7 6271.2 6287.4 4303.7 4415.2 4424.4 4443.3 4444.5 1260.0 1287.6 1291.5 1300.9 1303.5 708.9 779.6 800.5 827.2 828.8 6598.5 6831.0 6933.1 6974.9 7015.5 900.9 930.7 938.1 948.4 950.6 3948.5 4335.5 4556.3 4569.7 4678.1 15092.2 15138.2 15414.2 15432.9 15433.1 14646.6 14660.0 15180.0 15541.4 15542.8 8145.6 8641.6 8702.2 8783.9 8878.0 6898.6 7066.5 7204.0 7218.9 7238.3 13274.7 13330.5 13569.5 13598.0 13618.7 11378.0 13382.9 13460.9 13806.0 13967.3 9363.8 9424.7 9474.3 9519.5 9537.5 10673.7 10688.8 10755.2 10811.0 10923.3 9205.6 9243.3 9255.2 9293.9 9335.5 7625.9 8825.5 9024.1 9159.6 9218.5 8130.0 8200.3 8303.3 8324.0 8362.3 5316.7 6166.2 6182.4 6191.1 6200.8 6055.3 6128.5 6219.2 6274.1 6380.8
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5347.00 Median:5853.03 stddev:1616.68 (27.6%) stddev-sans-first:1577.80
14:54:25 INFO - PID 1635 | Values: 388.9 405.9 406.2 409.4 419.2 5370.8 5955.0 6241.2 6253.7 6265.9 4666.5 5528.3 5898.8 6057.6 6114.8 4653.5 4691.4 4695.2 4712.7 4715.0 4238.9 4554.7 4704.0 4725.8 4743.0 3598.9 4054.3 4604.7 4643.9 4696.3 4650.1 4663.6 4669.8 4697.5 4709.1 3446.0 3892.6 4037.3 4099.3 4162.2 5368.9 5938.9 5963.9 5993.9 6079.5 4814.3 5390.2 5535.1 5543.5 5559.9 6493.7 6566.8 6610.3 6610.7 6662.6 4486.1 4722.2 4742.3 4750.0 4757.8 5946.1 6007.9 6966.4 6979.8 7036.5 4265.9 4832.3 4832.5 4863.1 4872.4 4923.9 4944.5 4949.3 4971.8 4986.2 5399.2 5489.4 5544.5 5546.4 5558.0 5721.5 6599.0 6604.9 6610.8 6632.2 1493.8 1688.4 1701.2 1701.5 1702.1 1150.6 1170.5 1172.5 1176.0 1193.4 6205.0 6215.6 6217.0 6221.7 6234.6 5308.8 5473.4 6613.8 6759.3 6795.8 6204.3 6207.3 6208.0 6209.5 6254.4 2921.5 3416.9 3435.4 3452.6 3550.0 6008.9 6984.8 7047.0 7080.3 7141.7 6000.7 6022.8 6973.0 7067.5 7068.9 6977.9 6993.3 7033.5 7058.7 7129.5 5438.3 5769.9 5983.8 6126.5 6526.1 5894.8 6707.3 6721.3 6735.6 6744.4 6319.9 6754.6 7073.4 7112.3 7136.9 4429.6 4493.5 4774.8 4839.7 4859.2 6826.9 6852.0 6852.2 6870.7 6896.8 5658.6 6158.5 6605.9 6625.5 6632.4 6577.7 6608.5 6624.3 6626.9 6699.5 5170.4 5350.5 6381.9 6498.8 6530.6 5718.9 6238.2 6591.5 6608.9 6616.7 5489.6 5744.9 5811.3 5971.9 6416.9
14:54:25 INFO - PID 1635 |
14:54:25 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21827.46 Median:17736.78 stddev:30591.93 (172.5%) stddev-sans-first:30636.75
14:54:25 INFO - PID 1635 | Values: 734.6 777.1 782.4 849.1 871.7 16446.0 16911.4 16965.2 18394.8 19101.4 17987.0 18299.3 18416.8 18425.1 18576.2 1002.4 1030.8 1036.1 1037.4 1038.0 847.5 1019.5 1028.1 1032.7 1033.1 1080.2 1085.9 1089.5 1089.6 1090.4 1054.0 1071.3 1081.0 1081.6 1082.6 769.6 784.2 790.5 794.7 796.5 14553.6 16806.1 16935.8 17077.7 17117.7 16921.7 17039.4 17356.2 17443.6 17486.6 13746.7 13950.4 14291.4 14299.4 14315.4 3228.6 3498.9 3561.5 3569.8 3581.9 96784.0 129068.4 129172.0 130348.0 131137.0 12911.4 12998.5 13626.9 13676.2 13698.0 21296.9 24450.1 25142.4 25369.2 25975.4 7546.1 7621.5 7731.7 7758.3 7808.6 3334.9 3795.4 3868.5 3868.8 3882.2 4136.3 4246.7 4322.5 4354.4 4402.9 825.6 947.5 953.6 972.7 973.8 648.4 652.8 678.7 679.6 681.5 10945.0 11846.7 11995.3 12029.0 12107.0 648.3 653.9 657.9 667.2 683.0 5377.8 5511.4 5545.4 5587.9 5597.1 106151.5 106279.9 106385.5 106961.9 110286.0 85925.0 86640.6 87349.0 87755.0 88696.6 78407.6 82164.6 85027.0 86651.5 87259.6 11717.7 12352.4 12432.6 12525.3 12603.9 39964.6 41104.4 41396.0 41746.6 42103.8 53721.7 54464.2 55003.4 55852.0 56229.2 15686.5 15997.4 16237.4 17029.8 17035.5 18450.6 18473.2 18696.0 18710.6 18891.8 16598.3 16729.2 17257.0 17284.1 17485.8 13204.9 16719.9 16887.7 16943.7 17064.5 16265.3 16619.3 16733.3 16989.9 17136.9 10289.9 11720.8 11780.2 12163.5 12192.3 12598.6 12630.4 12633.4 12634.6 12642.6
14:54:25 INFO - PID 1635 | -------- Summary: end --------
14:54:25 INFO - PID 1635 |
14:54:25 INFO - TEST-INFO | 1635: exit 0
14:54:25 INFO - TEST-OK | dromaeo_css | took 1114314ms
14:54:25 INFO - TEST-START | kraken
14:54:25 INFO - operating with platform_type : mac_
14:54:25 INFO - Initialising browser for kraken test...
14:54:25 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp9uQFvI/profile http://localhost:49234/getInfo.html)
14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.444 plugin-container[1648:10460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname'
14:54:28 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.447 plugin-container[1648:10460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x962b, name = 'com.apple.CFPasteboardClient'
14:54:28 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.447 plugin-container[1648:10460] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
14:54:28 INFO - PID 1647 | __metrics Screen width/height:1600/1200
14:54:28 INFO - PID 1647 | colorDepth:24
14:54:28 INFO - PID 1647 | Browser inner width/height: 1024/689
14:54:28 INFO - PID 1647 | __metrics
14:54:28 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined
14:54:29 INFO - TEST-INFO | 1647: exit 0
14:54:29 INFO - Browser initialized.
14:54:29 INFO - Running cycle 1/1 for kraken test...
14:54:29 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp9uQFvI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.857 plugin-container[1650:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname'
14:54:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.858 plugin-container[1650:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient'
14:54:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes.
14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.858 plugin-container[1650:10584] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions
14:54:42 INFO - PID 1649 | RSS: Main: 251764736
14:54:42 INFO - PID 1649 |
14:54:44 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection)
14:54:45 INFO - PID 1649 | RSS: Main: 259518464
14:54:45 INFO - PID 1649 |
14:54:48 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft)
14:54:48 INFO - PID 1649 | RSS: Main: 266547200
14:54:48 INFO - PID 1649 |
14:54:52 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft)
14:54:52 INFO - PID 1649 | RSS: Main: 262893568
14:54:52 INFO - PID 1649 |
14:54:54 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator)
14:54:55 INFO - PID 1649 | RSS: Main: 263847936
14:54:55 INFO - PID 1649 |
14:54:57 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur)
14:54:57 INFO - PID 1649 | RSS: Main: 264200192
14:54:57 INFO - PID 1649 |
14:55:00 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom)
14:55:01 INFO - PID 1649 | RSS: Main: 269512704
14:55:01 INFO - PID 1649 |
14:55:04 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate)
14:55:05 INFO - PID 1649 | RSS: Main: 271364096
14:55:05 INFO - PID 1649 |
14:55:08 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial)
14:55:08 INFO - PID 1649 | RSS: Main: 270352384
14:55:08 INFO - PID 1649 |
14:55:10 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox)
14:55:11 INFO - PID 1649 | RSS: Main: 270204928
14:55:11 INFO - PID 1649 |
14:55:12 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes)
14:55:13 INFO - PID 1649 | RSS: Main: 271745024
14:55:13 INFO - PID 1649 |
14:55:15 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm)
14:55:16 INFO - PID 1649 | RSS: Main: 271200256
14:55:16 INFO - PID 1649 |
14:55:19 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
14:55:20 INFO - PID 1649 | RSS: Main: 271667200
14:55:20 INFO - PID 1649 |
14:55:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
14:55:23 INFO - PID 1649 | RSS: Main: 271536128
14:55:23 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar)
14:55:25 INFO - PID 1649 | RSS: Main: 273092608
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | __start_tp_report
14:55:25 INFO - PID 1649 | _x_x_mozilla_page_load
14:55:25 INFO - PID 1649 | _x_x_mozilla_page_load_details
14:55:25 INFO - PID 1649 | |i|pagename|runs|
14:55:25 INFO - PID 1649 | |0;ai-astar;101;116;146;168;144;115;115;118;114;115
14:55:25 INFO - PID 1649 | |1;audio-beat-detection;149;113;108;148;111;110;105;111;138;114
14:55:25 INFO - PID 1649 | |2;audio-dft;206;194;193;213;212;212;201;194;203;194
14:55:25 INFO - PID 1649 | |3;audio-fft;83;58;73;109;58;60;58;60;79;59
14:55:25 INFO - PID 1649 | |4;audio-oscillator;91;71;70;73;88;65;95;102;57;89
14:55:25 INFO - PID 1649 | |5;imaging-gaussian-blur;88;88;88;88;87;89;98;136;110;121
14:55:25 INFO - PID 1649 | |6;imaging-darkroom;100;106;91;123;90;139;153;110;146;107
14:55:25 INFO - PID 1649 | |7;imaging-desaturate;91;94;89;88;96;90;89;92;92;92
14:55:25 INFO - PID 1649 | |8;json-parse-financial;49;50;49;51;51;51;51;67;74;72
14:55:25 INFO - PID 1649 | |9;json-stringify-tinderbox;57;62;57;55;63;58;55;57;57;55
14:55:25 INFO - PID 1649 | |10;stanford-crypto-aes;83;88;107;106;102;83;83;82;85;95
14:55:25 INFO - PID 1649 | |11;stanford-crypto-ccm;126;153;152;155;139;173;151;154;266;155
14:55:25 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;188;185;187;184;183;230;231;163;228;226
14:55:25 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;69;68;69;83;91;99;83;69;67;72
14:55:25 INFO - PID 1649 | __end_tp_report
14:55:25 INFO - PID 1649 | __start_cc_report
14:55:25 INFO - PID 1649 | _x_x_mozilla_cycle_collect,997
14:55:25 INFO - PID 1649 | __end_cc_report
14:55:25 INFO - PID 1649 | __startTimestamp1493330125900__endTimestamp
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | ------- Summary: start -------
14:55:25 INFO - PID 1649 | Number of tests: 14
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:125.20 Median:117.00 stddev:20.49 (17.5%) stddev-sans-first:19.77
14:55:25 INFO - PID 1649 | Values: 101.0 116.0 146.0 168.0 144.0 115.0 115.0 118.0 114.0 115.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:113.50 stddev:17.19 (15.1%) stddev-sans-first:14.88
14:55:25 INFO - PID 1649 | Values: 149.0 113.0 108.0 148.0 111.0 110.0 105.0 111.0 138.0 114.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:202.20 Median:204.50 stddev:8.24 (4.0%) stddev-sans-first:8.63
14:55:25 INFO - PID 1649 | Values: 206.0 194.0 193.0 213.0 212.0 212.0 201.0 194.0 203.0 194.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:69.70 Median:60.00 stddev:16.77 (28.0%) stddev-sans-first:17.09
14:55:25 INFO - PID 1649 | Values: 83.0 58.0 73.0 109.0 58.0 60.0 58.0 60.0 79.0 59.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:80.50 stddev:14.75 (18.3%) stddev-sans-first:15.11
14:55:25 INFO - PID 1649 | Values: 91.0 71.0 70.0 73.0 88.0 65.0 95.0 102.0 57.0 89.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:88.00 stddev:17.33 (19.7%) stddev-sans-first:17.89
14:55:25 INFO - PID 1649 | Values: 88.0 88.0 88.0 88.0 87.0 89.0 98.0 136.0 110.0 121.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:142.50 stddev:22.65 (15.9%) stddev-sans-first:23.23
14:55:25 INFO - PID 1649 | Values: 100.0 106.0 91.0 123.0 90.0 139.0 153.0 110.0 146.0 107.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:92.00 stddev:2.45 (2.7%) stddev-sans-first:2.60
14:55:25 INFO - PID 1649 | Values: 91.0 94.0 89.0 88.0 96.0 90.0 89.0 92.0 92.0 92.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:51.00 stddev:10.18 (20.0%) stddev-sans-first:10.43
14:55:25 INFO - PID 1649 | Values: 49.0 50.0 49.0 51.0 51.0 51.0 51.0 67.0 74.0 72.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.00 stddev:2.80 (4.9%) stddev-sans-first:2.96
14:55:25 INFO - PID 1649 | Values: 57.0 62.0 57.0 55.0 63.0 58.0 55.0 57.0 57.0 55.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:83.00 stddev:10.19 (12.3%) stddev-sans-first:10.34
14:55:25 INFO - PID 1649 | Values: 83.0 88.0 107.0 106.0 102.0 83.0 83.0 82.0 85.0 95.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:154.50 stddev:38.33 (24.8%) stddev-sans-first:38.33
14:55:25 INFO - PID 1649 | Values: 126.0 153.0 152.0 155.0 139.0 173.0 151.0 154.0 266.0 155.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.50 Median:207.00 stddev:25.32 (12.2%) stddev-sans-first:26.45
14:55:25 INFO - PID 1649 | Values: 188.0 185.0 187.0 184.0 183.0 230.0 231.0 163.0 228.0 226.0
14:55:25 INFO - PID 1649 |
14:55:25 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:77.50 stddev:11.30 (14.6%) stddev-sans-first:11.61
14:55:25 INFO - PID 1649 | Values: 69.0 68.0 69.0 83.0 91.0 99.0 83.0 69.0 67.0 72.0
14:55:25 INFO - PID 1649 | -------- Summary: end --------
14:55:25 INFO - PID 1649 |
14:55:26 INFO - TEST-INFO | 1649: exit 0
14:55:26 INFO - TEST-OK | kraken | took 61030ms
14:55:26 INFO - SUITE-END | took 1175s
14:55:27 INFO - Completed test suite (00:19:35)
14:55:27 INFO - javascript benchmark
14:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7839.650153321025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.676232376762, 3336.1159292787415, 3404.8808291709797, 3597.010822023943, 3602.675759181674, 5809.925163844681, 5954.0, 6098.969505152473, 6160.845978850531, 6184.196054512919, 6001.129836173752, 6010.398960103998, 6057.0, 6061.575689701723, 6127.816165515031, 4292.6780491463105, 5298.655587386817, 5311.920321195185, 5332.413434522199, 5373.785048598052, 5363.9463605363835, 5367.919481207766, 5379.139337705968, 5380.811671591495, 5396.5952553558445, 5222.294990176316, 5268.736563171826, 5388.084025715618, 5420.268263784398, 5427.6472029318165, 4681.344611754357, 4808.374911261513, 5217.452167522431, 5300.708461034642, 5405.297311349519, 5220.086484865172, 5259.658122222043, 5292.550133238641, 5296.523312901857, 5356.1430171172815, 4915.48387419323, 6025.276966764016, 6046.879062418727, 6092.5430592705725, 6129.325774164839, 5053.191489361721, 6499.512536559777, 6504.902426463606, 6525.347465253484, 6558.639274839882, 6305.968470157666, 6384.138141350904, 6551.21385433751, 6606.405423511859, 6631.27056023837, 6258.499320054385, 6282.057691346335, 6288.056791481269, 6295.992641177481, 6308.558400911892, 6575.408213260829, 6769.458443324522, 6785.42323902464, 6789.25318214996, 6820.624865632438, 5383.542398896059, 6224.751009959551, 6286.528510361742, 6406.167198264196, 6699.933000669931, 5435.239066530688, 6516.869662606721, 6578.111954886125, 6595.373439523238, 6626.4367528760595, 5625.987322281947, 6189.133521307021, 6432.871342573122, 6451.774187903401, 6486.189226346707, 6253.7185826637915, 6299.622022678563, 6315.336889626615, 6409.230892292861, 6444.645544495098, 4781.760911954389, 4962.727050012284, 5182.352205974254, 5214.45248248936, 5232.581393488512, 4677.508861569554, 4687.81248750053, 4698.600618947427, 4716.646251531149, 4790.161721698689, 5153.639245252872, 5995.5803093783015, 6237.0, 6241.095041218998, 6348.904766428507, 6297.716602752887, 6356.745730170834, 6461.870762584722, 6520.739170433129, 6525.575837570543, 6099.111808770591, 6139.048447490646, 6149.692515374213, 6158.322584515699, 6218.471429928416, 5773.538116950634, 5822.272215973004, 5834.883302333929, 5845.210896528914, 5859.648421094748, 6526.608403495806, 6588.472922166119, 6670.633115178712, 6751.223609284897, 6778.288279730557, 6570.375814297634, 6586.110875032001, 6605.966970165118, 6619.073329733745, 6653.800385988428, 6509.283978762238, 6631.038499417654, 6678.766243181465, 6802.795916122524, 6806.7957961261245, 6355.0, 6367.331430199948, 6411.5832470889245, 6419.325970773001, 6432.678366081771, 6006.0, 6350.142730731292, 6350.587211831216, 6383.0, 6455.903161452676, 6235.688215589112, 6245.96877015612, 6321.462675672619, 6324.051392291193, 6356.523260755369, 6361.650109244036, 6372.267189273293, 6372.394622510854, 6374.713137908712, 6392.712327945346, 5568.470995255444, 6252.218472690914, 6257.374262573706, 6264.718087685974, 6289.811305660837, 6181.752729890934, 6218.440340369389, 6242.687865606792, 6262.874742505215, 6365.299817020216, 6214.8135555933395, 6215.129881816459, 6229.5327850410495, 6232.376762323913, 6256.499480041494], "value": 5911.367796239522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.6897087708597, 768.9038870141233, 840.4159109418954, 1203.1397550751217, 1252.1985929005432, 31440.0, 31737.73049078037, 31781.0, 34451.31097378054, 37860.43209351855, 37182.62817371826, 37416.81291593545, 37439.0, 37439.438408423826, 37562.624373756254, 7955.7215497457455, 8125.75622731319, 8371.823325935271, 8598.0, 8631.093735157812, 7429.294217049372, 8546.05993340732, 8600.8709869352, 8647.69733059343, 8664.176903194186, 6538.8692226155445, 7315.707371705125, 8188.50868947865, 8620.525871077089, 8623.223909848113, 7993.520388776692, 8639.611217495196, 8641.95679021604, 8654.48073115615, 8656.523891185981, 7863.8034049148655, 8417.663293468315, 8434.915650843473, 8437.987441506997, 8449.408541402105, 36974.63025369739, 37105.257894841954, 37120.628793712254, 37178.88463346104, 37280.25439491195, 3635.2366003139373, 3650.34293827111, 3674.2467794102145, 3675.6140605236333, 3677.4483827425834, 25691.871540642365, 29368.41263174746, 30382.54426183609, 30562.0, 30583.541246881094, 2791.3021744563857, 3129.874805007797, 3147.8740850365957, 3149.9842500787577, 3160.873565057395, 216555.9172204129, 216830.99014059207, 272094.999999998, 287844.0, 288800.5559972208, 47598.76200618975, 47708.0, 47844.73707892129, 47863.28205076927, 47967.60161991887, 49398.01203975901, 49718.50281497139, 49749.75625609316, 49802.750986244835, 49835.75082124566, 13548.187108773505, 13646.727065458635, 13723.588292351245, 13739.381727822272, 13755.867840484541, 10957.17821163416, 10992.28550144238, 11052.668419947415, 11073.889261107446, 11107.94446027781, 13296.401661925236, 13335.066545341733, 13384.93307533456, 13519.188848669111, 13534.45862165522, 5110.514501122388, 5998.670073146019, 6022.518198544106, 6047.637141771508, 6062.757489700362, 1015.2030655935056, 1018.4245901065874, 1023.2325755683238, 1052.1582733812918, 1063.8616979792578, 23506.64740028901, 24590.754092459203, 24597.754022459903, 24675.62986555203, 25395.49209015809, 1109.6060898380958, 1132.7904337697553, 1140.1278022312938, 1153.2503872482785, 1169.7601991591703, 11054.613088541862, 12468.43892024861, 12601.684957876127, 12616.30610316423, 12628.989680825513, 309506.9049309523, 311946.0, 312260.0, 312750.0, 312835.4358228194, 52514.737426312626, 52549.68625784386, 52636.0, 52730.73634631802, 52760.73619631877, 1498.8201415829951, 1505.1871989125968, 1538.8153421589257, 1542.2443002928485, 1543.8301786803443, 23774.88112559426, 23941.760582393952, 23993.760062399153, 24054.39864003414, 24646.876765616056, 36798.44802328021, 36842.44736328904, 36869.631303687696, 36914.63085369112, 36941.0, 259894.0, 261292.0, 261364.0, 261431.0, 262687.0, 33399.49900751442, 33468.0, 33806.81676141323, 34336.45485953188, 34417.82791086029, 42323.0, 44665.0, 44683.0, 44722.3291650632, 44743.10513789771, 29062.0, 29166.27084322909, 29698.960536381124, 31016.22459438532, 31143.221419464695, 28515.572266416435, 29802.10593682193, 30668.386632267677, 30851.69148308488, 31312.843435782674, 35195.648043519235, 36209.63790362063, 37040.25919481649, 37100.25799483941, 37111.25777484489, 29926.25184370408, 30491.0, 31043.84478077595, 31150.68849311478, 31621.73513059452, 21741.782582173975, 23196.536069278183, 24479.143229986865, 24550.508989819748, 24579.508409832062], "value": 17217.664451055058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.27300317973766, 446.4597836617692, 447.55244755244746, 462.7501149379335, 466.5544405093136, 18529.814701852978, 18928.716069258953, 19911.30310439135, 21171.153153873827, 21425.928703564838, 20387.898060509713, 22062.558748825013, 22086.00612972416, 22296.331110066683, 22376.104955801788, 5952.7321270542825, 6190.040543715709, 6217.440430361266, 6254.7185376657935, 6262.937370626281, 5784.56615753818, 6014.3985601439945, 6106.542009349294, 6112.327643959183, 6114.144019837227, 5836.5914385993, 6028.849278768022, 6038.33578306386, 6055.818325450244, 6063.302720187169, 5957.1659967604355, 6047.909281360783, 6090.5736598438125, 6095.664738439384, 6109.266887973427, 5353.839384818422, 5356.035913535601, 5365.0, 5414.864628384283, 5417.702026388547, 26017.869910650516, 26047.348816279555, 26072.73927260722, 26275.292106013047, 26596.069137580285, 2157.0616781699855, 2229.3312006398014, 2230.8549944253573, 2231.553689262154, 2235.798778109962, 14480.782788258184, 15368.0, 17400.825991740174, 18036.008019558918, 18240.0, 2087.2277257414703, 2129.233475948657, 2165.274632997932, 2166.620841352773, 2195.560887822442, 128743.0, 143432.0, 153763.0, 154600.0, 157244.42755572413, 12187.39063046844, 12657.11400201977, 12687.68280792969, 12767.744645107046, 12785.488580456678, 14796.298425680969, 15304.770428443582, 16311.67376652484, 16340.591485212964, 16374.263158157912, 6375.681215939185, 7265.709371625181, 8413.789655258544, 8491.787705307293, 8523.531205783742, 7754.418418618626, 7757.7672669819995, 7790.182030886788, 7903.249191326815, 7915.0, 7894.21057894206, 7982.760517184493, 7999.200079991954, 8062.072861620989, 8075.273225409741, 1971.7929617389968, 2028.3509277031503, 2036.1877928643519, 2040.8163265305898, 2041.285550057468, 891.4784850862188, 922.9630814767469, 960.9855852162223, 963.393062370702, 993.8956409577034, 20134.395968120978, 20521.589568208554, 20525.58948821045, 20527.897360513103, 20839.79160208409, 906.9455832650062, 939.9671011514564, 977.8288799460066, 1016.598443614768, 1016.8017236638784, 9073.637054517745, 10685.305455145392, 10748.570057197781, 10788.51451684676, 10843.349399036084, 535787.0, 544428.0, 544573.0, 558654.0, 560190.0, 129118.0, 129571.0, 131537.0, 134819.32590337182, 136019.0, 1179.151011271883, 1207.402335843763, 1223.7552489502136, 1226.6320103968774, 1227.6869398303375, 20583.691244631642, 21790.782092178877, 21830.45423864416, 21914.890425547772, 21950.121995120015, 53013.73493132664, 56576.717116414155, 56921.43078569161, 57939.42060579509, 58131.709341453025, 78390.6080469594, 78714.0, 80104.0, 80182.0, 80649.0, 8601.494738420626, 8702.782430439289, 8807.119288071142, 9231.030741772018, 9240.399374040666, 14070.648233794236, 14197.929010355296, 14226.573202803518, 14539.781903271249, 14568.41726330935, 11967.880321197024, 11974.46114924813, 12099.971502422393, 12119.333436661069, 12178.0, 11482.598109066143, 11495.48270327854, 11571.6528504145, 11853.288802671867, 11882.702932426759, 12032.338221397908, 12194.51221951112, 12292.569760058355, 12457.252564845776, 12561.560345387868, 7856.332211762065, 8851.0, 8956.149165829236, 8975.32685048611, 9120.179183873483, 10168.440735759605, 10262.897371026493, 11936.820947685617, 11971.401429928643, 11995.820062698893], "value": 10331.23667610028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.782258749893, 1409.4714482069223, 1415.810718996043, 1490.3070072416324, 1497.8202615686116, 11351.886481135196, 11643.883561164386, 11659.300441973488, 11661.766764664711, 11743.41282935854, 9975.40147591145, 11440.771184576304, 11596.884031159685, 11610.245334053281, 11630.069594432447, 2196.857634030311, 2463.08865719684, 2525.6716626838484, 2560.7567281108263, 2562.3209849389928, 1995.6828493194494, 2325.976740232593, 2361.917332893349, 2375.6080246759266, 2376.738558758535, 2466.3094333586537, 2497.9875100624563, 2516.8238223324374, 2522.407234299938, 2523.7854782343525, 2471.1104002559064, 2492.67595212623, 2504.912328068518, 2521.2562294123277, 2522.6846644169477, 2450.5834008218644, 2495.7254701982765, 2505.1732928133674, 2509.874506274679, 2562.744255314882, 11672.299662020307, 11835.11236657254, 11877.0, 11890.0, 11894.286342819458, 6584.5061620378665, 6782.626955517445, 6825.36191314086, 6844.589324640538, 6847.657617119125, 3723.0, 4059.269331520325, 4403.22943484892, 4443.37792709021, 4483.529229430928, 1077.8329358949375, 1243.359669770069, 1252.4301442843575, 1291.8901893339078, 1300.8959283257316, 16029.198540073066, 16166.949148305323, 16302.592435189215, 16484.34062637493, 17098.23057962382, 4914.754262286871, 5369.677819330853, 5682.119271512922, 5832.3292821326095, 5846.947549441142, 9605.759856003655, 11598.88401115995, 11769.117316201318, 11778.587749428729, 11849.881501185051, 5517.61376703635, 5856.1508581255475, 6352.14246076783, 6606.372394622503, 6616.933830661728, 5750.453706897838, 6032.758689652453, 6265.749370025148, 6271.216097987752, 6287.434130928147, 4303.655707543389, 4415.249407600716, 4424.402705634698, 4443.311286750559, 4444.488883778342, 1259.962201133949, 1287.575100216926, 1291.489861504719, 1300.9349532523336, 1303.4981532110016, 708.9255628159073, 779.5985067690144, 800.4996876951905, 827.1728271728272, 828.8176601147737, 6598.538102332791, 6830.965845170742, 6933.11339222719, 6974.895376569356, 7015.543989640657, 900.9234215091791, 930.7161315798746, 938.1134827587864, 948.369334392635, 950.626344931581, 3948.545917219499, 4335.479742430928, 4556.316552517149, 4569.748663823521, 4678.111158879802, 15092.1699306537, 15138.243087845563, 15414.152221627694, 15432.92283538575, 15433.074015558877, 14646.63383415423, 14660.0, 15180.0, 15541.378344866305, 15542.84457155414, 8145.592720363839, 8641.56792160402, 8702.173293537104, 8783.868241976375, 8878.0, 6898.586084834926, 7066.505344626033, 7203.991441198341, 7218.855622887618, 7238.348548630648, 13274.668133296746, 13330.466781328638, 13569.52506662262, 13598.048136630341, 13618.727625447635, 11378.0, 13382.866171338552, 13460.93269533646, 13805.964552658792, 13967.301634918416, 9363.812723745623, 9424.670136545188, 9474.336796424459, 9519.476428796206, 9537.47543885093, 10673.733156671145, 10688.839667405151, 10755.247132700635, 10811.027007569357, 10923.289986150874, 9205.585748641193, 9243.306751993761, 9255.167034966886, 9293.86059209126, 9335.48654823964, 7625.923740762521, 8825.470471771714, 9024.142706442877, 9159.633614655339, 9218.492982886006, 8130.0, 8200.26197642215, 8303.252707256375, 8324.0427350853, 8362.331013519026, 5316.6544174628525, 6166.167567378347, 6182.352412076896, 6191.133241346305, 6200.844978875564, 6055.273367195965, 6128.4790792783115, 6219.160413344322, 6274.121622972879, 6380.840478988062], "value": 5394.12731522713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.947492088568, 405.8696530163495, 406.19370549459325, 409.41862555171656, 419.2160659566611, 5370.7851685932565, 5955.0, 6241.157443745093, 6253.71858266378, 6265.874682506347, 4666.486686464486, 5528.336599608043, 5898.7935422260225, 6057.575969682124, 6114.768109639983, 4653.464851542082, 4691.366665500165, 4695.225287827521, 4712.717236965776, 4715.033418149271, 4238.936415953764, 4554.749488778116, 4704.035672687108, 4725.8109675613105, 4742.952570474303, 3598.85604575818, 4054.2702313583545, 4604.743675598966, 4643.907121857561, 4696.272077827942, 4650.116477869194, 4663.580277775, 4669.7898594562985, 4697.4832768395445, 4709.105269998689, 3446.0, 3892.552356479013, 4037.253108174997, 4099.344104943225, 4162.229987452331, 5368.91946620801, 5938.930992421362, 5963.910541341883, 5993.910091348634, 6079.483243924272, 4814.3019262207135, 5390.21841832932, 5535.114381698909, 5543.533127758149, 5559.916601250984, 6493.70778314977, 6566.770163044318, 6610.272869984298, 6610.6778644271335, 6662.600243985328, 4486.147631949919, 4722.197226471508, 4742.316477650419, 4750.0, 4757.809687612491, 5946.108083787466, 6007.927265093579, 6966.4078553323025, 6979.755708550177, 7036.542624729376, 4265.893352666146, 4832.251001094836, 4832.49258827818, 4863.076015557032, 4872.366592342973, 4923.87690307738, 4944.53026962438, 4949.307097006422, 4971.825986090542, 4986.227134794112, 5399.244105825188, 5489.39616642169, 5544.500994910478, 5546.445355464502, 5557.972210138923, 5721.456461636138, 6599.0, 6604.867902642017, 6610.768623098168, 6632.204135503771, 1493.7609982402764, 1688.4174959638906, 1701.174930158872, 1701.5150682055555, 1702.1319127245195, 1150.5685367987005, 1170.5200867644226, 1172.4841069929205, 1175.976900096921, 1193.3854065156452, 6205.0, 6215.564910456224, 6217.0, 6221.720022598994, 6234.625922444668, 5308.761105750251, 5473.370562385297, 6613.768518101843, 6759.290274521203, 6795.762148324785, 6204.348543402968, 6207.317195108534, 6208.0, 6209.472194863397, 6254.405831446005, 2921.5471601901313, 3416.940748368014, 3435.4331535296897, 3452.6374730653424, 3549.982250088733, 6008.858316919771, 6984.825379365455, 7046.964765176243, 7080.2919708028785, 7141.714331426685, 6000.669963151981, 6022.789202377896, 6973.0, 7067.469939754539, 7068.858622827514, 6977.930220697728, 6993.335633114846, 7033.507654464139, 7058.71765129389, 7129.465290103263, 5438.320209973754, 5769.94230057694, 5983.760649573968, 6126.5098792097415, 6526.074807931766, 5894.764209431574, 6707.3292670732535, 6721.260661327152, 6735.64252511617, 6744.359285867835, 6319.936800632118, 6754.5609535380045, 7073.3987611053635, 7112.288771122846, 7136.892946605909, 4429.601335879786, 4493.460784705856, 4774.7851346688785, 4839.7096174229655, 4859.198232291632, 6826.917790074075, 6851.9657401712675, 6852.211995620568, 6870.690818913061, 6896.793096207121, 5658.641925937827, 6158.507319414526, 6605.867882642417, 6625.536212465274, 6632.403083722488, 6577.704003319958, 6608.471322294301, 6624.271330153776, 6626.933730662825, 6699.464042876656, 5170.43125256214, 5350.5184533392185, 6381.904271436025, 6498.772542961163, 6530.575512591857, 5718.914216286842, 6238.220222472191, 6591.5056370773345, 6608.867822643424, 6616.742818864401, 5489.58828087887, 5744.937186620488, 5811.302643682785, 5971.940280597139, 6416.935830641633], "value": 4857.070728957302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6326836581709, 777.0869228656327, 782.3662833105182, 849.0702680564782, 871.6600525794939, 16446.0, 16911.40810071648, 16965.236564354618, 18394.816051839476, 19101.42695719127, 17987.0, 18299.268029278846, 18416.81583184168, 18425.07874606271, 18576.16407261673, 1002.4486532407166, 1030.7680771826317, 1036.1037702387418, 1037.4345981440133, 1038.0449986012886, 847.516915358246, 1019.5157300282343, 1028.0644613401805, 1032.7160030991463, 1033.0650761061252, 1080.1628737728283, 1085.8642669666292, 1089.5478376473754, 1089.585957336211, 1090.4438736244492, 1053.9947300263489, 1071.346478648024, 1080.9945950270198, 1081.5998080710149, 1082.6048492300333, 769.6498093367504, 784.1687810920442, 790.5414859381602, 794.6702118620766, 796.4982061301401, 14553.636159096002, 16806.075665838496, 16935.830641693672, 17077.7438338425, 17117.743233851503, 16921.7461738074, 17039.403620873334, 17356.218970146372, 17443.5639109022, 17486.562835929075, 13746.725065498735, 13950.372233249427, 14291.356888940023, 14299.356528956221, 14315.42738290467, 3228.580284563015, 3498.8775392861126, 3561.5013898054294, 3569.839357228931, 3581.943326718598, 96784.0, 129068.35465822705, 129172.0, 130348.0, 131137.0, 12911.35443227835, 12998.480060797463, 13626.93186534061, 13676.179429234278, 13697.972652051136, 21296.893515532323, 24450.144244951698, 25142.371440713763, 25369.238922832345, 25975.350616234744, 7546.1321947976685, 7621.542707437571, 7731.690732370755, 7758.340541054074, 7808.6095695216145, 3334.8666053357592, 3795.3927371620407, 3868.497095377583, 3868.8065596720053, 3882.1847412043785, 4136.31750761127, 4246.66026717868, 4322.524522302544, 4354.390385346054, 4402.933955990663, 825.6160885188416, 947.4646824544111, 953.6471505542855, 972.7422233108232, 973.756560859785, 648.3613640564041, 652.7845810882397, 678.7149397253165, 679.6431873266475, 681.4786688183543, 10945.0, 11846.703832404259, 11995.340256285814, 12029.0, 12107.031437485157, 648.3484098480997, 653.8626888353499, 657.8585604095142, 667.1893649216129, 682.9760958366434, 5377.838664840061, 5511.421300763443, 5545.426091622278, 5587.944120558824, 5597.104463285936, 106151.46924265329, 106279.87440251152, 106385.46807265915, 106961.9303806952, 110286.0, 85925.0, 86640.56679716561, 87349.0, 87755.0, 88696.556517217, 78407.60796195983, 82164.58917705492, 85027.0, 86651.53393864175, 87259.56370218108, 11717.707057323634, 12352.3823808811, 12432.627021189379, 12525.311107889154, 12603.87396126027, 39964.60035399609, 41104.38343424791, 41396.0, 41746.58253417427, 42103.7894810524, 53721.73139134279, 54464.18303725368, 55003.44996550144, 55852.0, 56229.15656265241, 15686.450974216305, 15997.360105595646, 16237.350505979628, 17029.829701702824, 17035.48893533196, 18450.630987379907, 18473.16870740793, 18696.0, 18710.625787484445, 18891.811081889005, 16598.25307861125, 16729.247183877, 17257.0, 17284.135793210036, 17485.82514174842, 13204.933975330061, 16719.916400418406, 16887.7466838, 16943.661126777642, 17064.48806535806, 16265.268062937434, 16619.335226591284, 16733.330666773192, 16989.915050425163, 17136.886102403303, 10289.9485502572, 11720.765584688088, 11780.175387722777, 12163.45264463119, 12192.268463892195, 12598.622041338775, 12630.43163057683, 12633.368331583568, 12634.557790477289, 12642.620721378373], "value": 8426.362491619735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 116.0, 146.0, 168.0, 144.0, 115.0, 115.0, 118.0, 114.0, 115.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 113.0, 108.0, 148.0, 111.0, 110.0, 105.0, 111.0, 138.0, 114.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 194.0, 193.0, 213.0, 212.0, 212.0, 201.0, 194.0, 203.0, 194.0], "value": 202.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 73.0, 109.0, 58.0, 60.0, 58.0, 60.0, 79.0, 59.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 70.0, 73.0, 88.0, 65.0, 95.0, 102.0, 57.0, 89.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 87.0, 89.0, 98.0, 136.0, 110.0, 121.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 91.0, 123.0, 90.0, 139.0, 153.0, 110.0, 146.0, 107.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 89.0, 88.0, 96.0, 90.0, 89.0, 92.0, 92.0, 92.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 51.0, 51.0, 51.0, 51.0, 67.0, 74.0, 72.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 57.0, 55.0, 63.0, 58.0, 55.0, 57.0, 57.0, 55.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 107.0, 106.0, 102.0, 83.0, 83.0, 82.0, 85.0, 95.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 153.0, 152.0, 155.0, 139.0, 173.0, 151.0, 154.0, 266.0, 155.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 187.0, 184.0, 183.0, 230.0, 231.0, 163.0, 228.0, 226.0], "value": 200.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 83.0, 91.0, 99.0, 83.0, 69.0, 67.0, 72.0], "value": 77.0, "unit": "score"}]}]}
14:55:27 INFO - Return code: 0
14:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
14:55:27 ERROR - # TBPL SUCCESS #
14:55:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'
14:55:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build
14:55:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType"
14:55:27 INFO - 2017-04-27 14:55:27.239 screenresolution[1654:10981] starting screenresolution argv=screenresolution get
14:55:27 INFO - 2017-04-27 14:55:27.241 screenresolution[1654:10981] Display 0: 1600x1200x32@60
14:55:27 INFO - 2017-04-27 14:55:27.247 screenresolution[1655:10984] starting screenresolution argv=screenresolution list
14:55:27 INFO - Available Modes on Display 0
14:55:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75
14:55:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60
14:55:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75
14:55:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60
14:55:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays:
14:55:27 INFO - Intel Iris:
14:55:27 INFO - Chipset Model: Intel Iris
14:55:27 INFO - Type: GPU
14:55:27 INFO - Bus: Built-In
14:55:27 INFO - VRAM (Dynamic, Max): 1536 MB
14:55:27 INFO - Vendor: Intel (0x8086)
14:55:27 INFO - Device ID: 0x0a2e
14:55:27 INFO - Revision ID: 0x0009
14:55:27 INFO - Displays:
14:55:27 INFO - Display:
14:55:27 INFO - Resolution: 1600 x 1200 @ 60 Hz
14:55:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888)
14:55:27 INFO - Display Serial Number: 1600x1200 60
14:55:27 INFO - Main Display: Yes
14:55:27 INFO - Mirror: Off
14:55:27 INFO - Online: Yes
14:55:27 INFO - Rotation: Supported
14:55:27 INFO - Return code: 0
14:55:27 INFO - Running post-action listener: _resource_record_post_action
14:55:27 INFO - [mozharness: 2017-04-27 21:55:27.493458Z] Finished run-tests step (success)
14:55:27 INFO - Running post-run listener: _resource_record_post_run
14:55:27 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 40334848; Write bytes: 511667200; Read time: 263; Write time: 1612
14:55:27 INFO - TinderboxPrint: CPU usage
54.3%
14:55:27 INFO - TinderboxPrint: I/O read bytes / time
40,334,848 / 263
14:55:27 INFO - TinderboxPrint: I/O write bytes / time
511,667,200 / 1,612
14:55:27 INFO - TinderboxPrint: CPU idle
2,186.4 (45.7%)
14:55:27 INFO - TinderboxPrint: CPU system
960.4 (20.1%)
14:55:27 INFO - TinderboxPrint: CPU user
1,634.8 (34.2%)
14:55:27 INFO - TinderboxPrint: Swap in / out
247,988,224 / 0
14:55:27 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197499392; Write bytes: 195762176; Read time: 15023; Write time: 405
14:55:27 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 39319040; Write bytes: 299000832; Read time: 247; Write time: 1157
14:55:27 INFO - Running post-run listener: _upload_blobber_files
14:55:27 INFO - Blob upload gear active.
14:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
14:55:27 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
14:55:27 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']
14:55:27 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
14:55:28 INFO - (blobuploader) - INFO - Open directory for files ...
14:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
14:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
14:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:55:29 INFO - (blobuploader) - INFO - Done attempting.
14:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
14:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
14:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:55:30 INFO - (blobuploader) - INFO - Done attempting.
14:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
14:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
14:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:55:31 INFO - (blobuploader) - INFO - Done attempting.
14:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
14:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
14:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:55:33 INFO - (blobuploader) - INFO - Done attempting.
14:55:33 INFO - (blobuploader) - INFO - Iteration through files over.
14:55:33 INFO - Return code: 0
14:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
14:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
14:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"}
14:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
14:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files
14:55:33 INFO - Contents:
14:55:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"}
14:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir
14:55:33 INFO - Copying logs to upload dir...
14:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs
14:55:33 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1279.316110
========= master_lag: 0.15 =========
========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 14:55:33.778400) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.781707) =========
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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/
TWISTD_LOG_PATH=/builds/slave/twistd.log
USER=cltbld
VERSIONER_PYTHON_PREFER_32_BIT=no
VERSIONER_PYTHON_VERSION=2.7
XPCOM_DEBUG_BREAK=warn
XPC_FLAGS=0x0
XPC_SERVICE_NAME=0
__CF_USER_TEXT_ENCODING=0x1C:0:0
using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"}
build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg
program finished with exit code 0
elapsedTime=0.011162
build_url: 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.817758) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.818100) =========
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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners
TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005177
========= master_lag: 0.04 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.867214) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:33.867554) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:33.867875) =========
========= Total master_lag: 3.37 =========