builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1493919031.78 results: success (0) buildid: 20170504084920 builduid: 8bdc4c055b114e9fa3fcb2455753206a revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.780325) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.780836) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.781144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.808978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.809390) ========= 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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-05-04 10:30:31-- 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% 171M=0s 2017-05-04 10:30:31 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098122 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.934165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.934528) ========= 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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.034695 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:31.990541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:30:31.990908) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b255199db9d6a6f189b89b7906f99155bde3726 --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 0b255199db9d6a6f189b89b7906f99155bde3726 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-05-04 10:30:32,088 truncating revision to first 12 chars 2017-05-04 10:30:32,088 Setting DEBUG logging. 2017-05-04 10:30:32,088 attempt 1/10 2017-05-04 10:30:32,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b255199db9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 10:30:33,782 unpacking tar archive at: mozilla-central-0b255199db9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.972096 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 10:30:33.987936) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.988283) ========= script_repo_revision: 0b255199db9d6a6f189b89b7906f99155bde3726 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.988848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:33.989170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 10:30:34.010124) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-04 10:30:34.010522) ========= /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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:30:34 INFO - MultiFileLogger online at 20170504 10:30:34 in /builds/slave/test 10:30:34 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 10:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:30:34 INFO - {'append_to_log': False, 10:30:34 INFO - 'base_work_dir': '/builds/slave/test', 10:30:34 INFO - 'blob_upload_branch': 'Firefox', 10:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:30:34 INFO - 'branch': 'Firefox', 10:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:30:34 INFO - 'config_files': ('talos/mac_config.py',), 10:30:34 INFO - 'default_actions': ('clobber', 10:30:34 INFO - 'read-buildbot-config', 10:30:34 INFO - 'download-and-extract', 10:30:34 INFO - 'populate-webroot', 10:30:34 INFO - 'create-virtualenv', 10:30:34 INFO - 'install', 10:30:34 INFO - 'run-tests'), 10:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:30:34 INFO - 'download_minidump_stackwalk': True, 10:30:34 INFO - 'download_symbols': 'ondemand', 10:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:30:34 INFO - 'gecko_profile': False, 10:30:34 INFO - 'gecko_profile_interval': 0, 10:30:34 INFO - 'installer_path': 'installer.exe', 10:30:34 INFO - 'log_level': 'info', 10:30:34 INFO - 'log_name': 'talos', 10:30:34 INFO - 'log_to_console': True, 10:30:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:30:34 INFO - 'opt_config_files': (), 10:30:34 INFO - 'pip_index': False, 10:30:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:30:34 INFO - 'cmd': ('bash', 10:30:34 INFO - '-c', 10:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:30:34 INFO - 'enabled': True, 10:30:34 INFO - 'halt_on_failure': False, 10:30:34 INFO - 'name': 'check_screen_resolution'},), 10:30:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:30:34 INFO - 'cmd': ('bash', 10:30:34 INFO - '-c', 10:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:30:34 INFO - 'enabled': True, 10:30:34 INFO - 'halt_on_failure': False, 10:30:34 INFO - 'name': 'check_screen_resolution'},), 10:30:34 INFO - 'run_cmd_checks_enabled': True, 10:30:34 INFO - 'suite': 'dromaeojs-e10s', 10:30:34 INFO - 'system_bits': '32', 10:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:30:34 INFO - 'title': 't-yosemite-r7-0066', 10:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:30:34 INFO - 'use_talos_json': True, 10:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:30:34 INFO - 'work_dir': 'build'} 10:30:34 INFO - [mozharness: 2017-05-04 17:30:34.215388Z] Running clobber step. 10:30:34 INFO - Running pre-action listener: _resource_record_pre_action 10:30:34 INFO - Running main action method: clobber 10:30:34 INFO - rmtree: /builds/slave/test/build 10:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:30:36 INFO - Running post-action listener: _resource_record_post_action 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.852398Z] Finished clobber step (success) 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.852529Z] Running read-buildbot-config step. 10:30:36 INFO - Running pre-action listener: _resource_record_pre_action 10:30:36 INFO - Running main action method: read_buildbot_config 10:30:36 INFO - Using buildbot properties: 10:30:36 INFO - { 10:30:36 INFO - "project": "", 10:30:36 INFO - "product": "firefox", 10:30:36 INFO - "script_repo_revision": "production", 10:30:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:30:36 INFO - "repository": "", 10:30:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:30:36 INFO - "buildid": "20170504084920", 10:30:36 INFO - "pgo_build": "False", 10:30:36 INFO - "basedir": "/builds/slave/test", 10:30:36 INFO - "buildnumber": 137, 10:30:36 INFO - "slavename": "t-yosemite-r7-0066", 10:30:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:30:36 INFO - "platform": "yosemite_r7", 10:30:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:30:36 INFO - "branch": "mozilla-central", 10:30:36 INFO - "repo_path": "mozilla-central", 10:30:36 INFO - "revision": "0b255199db9d6a6f189b89b7906f99155bde3726", 10:30:36 INFO - "stage_platform": "macosx64", 10:30:36 INFO - "builduid": "8bdc4c055b114e9fa3fcb2455753206a", 10:30:36 INFO - "slavebuilddir": "test" 10:30:36 INFO - } 10:30:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:30:36 INFO - Running post-action listener: _resource_record_post_action 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.855895Z] Finished read-buildbot-config step (success) 10:30:36 INFO - [mozharness: 2017-05-04 17:30:36.855990Z] Running download-and-extract step. 10:30:36 INFO - Running pre-action listener: _resource_record_pre_action 10:30:36 INFO - Running main action method: download_and_extract 10:30:36 INFO - mkdir: /builds/slave/test/build/tests 10:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:30:36 INFO - trying https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/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 10:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/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 10:30:38 INFO - Downloaded 1325 bytes. 10:30:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:30:38 INFO - Using the following test package requirements: 10:30:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:30:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:30:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:30:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:30:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'jsshell-mac.zip'], 10:30:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:30:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:30:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:30:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:30:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:30:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:30:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:30:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:30:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:30:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:30:38 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:30:40 INFO - Content-Length response header: 52700729 10:30:40 INFO - Bytes received: 52700729 10:30:56 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 10:30:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:30:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:30:56 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:30:58 INFO - Content-Length response header: 52700729 10:30:58 INFO - Bytes received: 52700729 10:31:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:31:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:31:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:31:14 INFO - Content-Length response header: 14408809 10:31:14 INFO - Bytes received: 14408809 10:31: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')]} 10:31:15 INFO - trying https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:15 INFO - Downloading https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/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 10:31:16 INFO - Downloaded 70877244 bytes. 10:31:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:16 INFO - mkdir: /builds/slave/test/properties 10:31:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:31:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:31:16 INFO - Contents: 10:31:16 INFO - build_url:https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:31:17 INFO - Running post-action listener: _resource_record_post_action 10:31:17 INFO - Running post-action listener: set_extra_try_arguments 10:31:17 INFO - [mozharness: 2017-05-04 17:31:17.642606Z] Finished download-and-extract step (success) 10:31:17 INFO - [mozharness: 2017-05-04 17:31:17.642727Z] Running populate-webroot step. 10:31:17 INFO - Running pre-action listener: _resource_record_pre_action 10:31:17 INFO - Running main action method: populate_webroot 10:31:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:31:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:31:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:31:17 INFO - '--tppagecycles', 10:31:17 INFO - '7'], 10:31:17 INFO - 'tests': ['tsvgm']}}, 10:31:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:31:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:31:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:31:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:31:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:31:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['damp', 'tps']}, 10:31:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'tests': ['damp', 'tps']}, 10:31:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['dromaeo_dom']}, 10:31:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:31:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:31:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:31:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['a11yr', 10:31:17 INFO - 'ts_paint', 10:31:17 INFO - 'tpaint', 10:31:17 INFO - 'sessionrestore', 10:31:17 INFO - 'sessionrestore_no_auto_restore', 10:31:17 INFO - 'tabpaint']}, 10:31:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:31:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:31:17 INFO - 'bloom_basic_ref']}, 10:31:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['tsvgx', 10:31:17 INFO - 'tsvgr_opacity', 10:31:17 INFO - 'tart', 10:31:17 INFO - 'tscrollx', 10:31:17 INFO - 'cart', 10:31:17 INFO - 'tsvg_static']}, 10:31:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:31:17 INFO - 'tsvgr_opacity', 10:31:17 INFO - 'tart', 10:31:17 INFO - 'tscrollx', 10:31:17 INFO - 'cart', 10:31:17 INFO - 'tsvg_static']}, 10:31:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'talos_options': ['--disable-e10s'], 10:31:17 INFO - 'tests': ['tp5o']}, 10:31:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:31:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'talos_options': ['--disable-e10s', 10:31:17 INFO - '--xperf_path', 10:31:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:17 INFO - 'tests': ['tp5n']}, 10:31:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:31:17 INFO - 'talos_options': ['--xperf_path', 10:31:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:31:17 INFO - 'tests': ['tp5n']}}, 10:31:17 INFO - 'talos.zip': {'path': '', 10:31:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:31:17 INFO - Running post-action listener: _resource_record_post_action 10:31:17 INFO - [mozharness: 2017-05-04 17:31:17.662106Z] Finished populate-webroot step (success) 10:31:17 INFO - [mozharness: 2017-05-04 17:31:17.662197Z] Running create-virtualenv step. 10:31:17 INFO - Running pre-action listener: _resource_record_pre_action 10:31:17 INFO - Running main action method: create_virtualenv 10:31:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:31:17 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 10:31:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:31:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:31:17 INFO - Using real prefix '/tools/python27' 10:31:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:31:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:31:21 INFO - Installing pip.................done. 10:31:21 INFO - Return code: 0 10:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:31:21 INFO - Reading from file tmpfile_stdout 10:31:21 INFO - Output received: 10:31:21 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) 10:31:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:21 INFO - 'HOME': '/Users/cltbld', 10:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:21 INFO - 'LOGNAME': 'cltbld', 10:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:21 INFO - 'MOZ_NO_REMOTE': '1', 10:31:21 INFO - 'NO_EM_RESTART': '1', 10:31:21 INFO - 'PAGER': '/bin/cat', 10:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:21 INFO - 'PWD': '/builds/slave/test', 10:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:21 INFO - 'SHELL': '/bin/bash', 10:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:21 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:21 INFO - 'USER': 'cltbld', 10:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:21 INFO - 'XPC_FLAGS': '0x0', 10:31:21 INFO - 'XPC_SERVICE_NAME': '0', 10:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:21 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 10:31:21 INFO - Cleaning up... 10:31:21 INFO - Return code: 0 10:31:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:21 INFO - 'HOME': '/Users/cltbld', 10:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:21 INFO - 'LOGNAME': 'cltbld', 10:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:21 INFO - 'MOZ_NO_REMOTE': '1', 10:31:21 INFO - 'NO_EM_RESTART': '1', 10:31:21 INFO - 'PAGER': '/bin/cat', 10:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:21 INFO - 'PWD': '/builds/slave/test', 10:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:21 INFO - 'SHELL': '/bin/bash', 10:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:21 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:21 INFO - 'USER': 'cltbld', 10:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:21 INFO - 'XPC_FLAGS': '0x0', 10:31:21 INFO - 'XPC_SERVICE_NAME': '0', 10:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:22 INFO - Downloading/unpacking psutil>=3.1.1 10:31:22 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 10:31:22 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 10:31:22 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 10:31:22 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 10:31:22 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 10:31:22 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 10:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:24 INFO - Installing collected packages: psutil 10:31:24 INFO - Running setup.py install for psutil 10:31:24 INFO - building 'psutil._psutil_osx' extension 10:31:24 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 10:31:25 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 10:31:25 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 10:31:25 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 10:31:25 INFO - building 'psutil._psutil_posix' extension 10:31:25 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 10:31:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:31:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:31:25 INFO - ^ 10:31:25 INFO - 1 warning generated. 10:31:25 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 10:31:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:31:25 INFO - Successfully installed psutil 10:31:25 INFO - Cleaning up... 10:31:25 INFO - Return code: 0 10:31:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:31: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')]} 10:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31: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')]} 10:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:25 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:25 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 10:31:25 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 10:31:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:25 INFO - 'HOME': '/Users/cltbld', 10:31:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:25 INFO - 'LOGNAME': 'cltbld', 10:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:25 INFO - 'MOZ_NO_REMOTE': '1', 10:31:25 INFO - 'NO_EM_RESTART': '1', 10:31:25 INFO - 'PAGER': '/bin/cat', 10:31:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:25 INFO - 'PWD': '/builds/slave/test', 10:31:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:25 INFO - 'SHELL': '/bin/bash', 10:31:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:25 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:25 INFO - 'USER': 'cltbld', 10:31:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:25 INFO - 'XPC_FLAGS': '0x0', 10:31:25 INFO - 'XPC_SERVICE_NAME': '0', 10:31:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:31:25 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 10:31:25 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 10:31:25 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 10:31:25 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 10:31:25 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 10:31:25 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 10:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:31:27 INFO - Installing collected packages: mozsystemmonitor 10:31:27 INFO - Running setup.py install for mozsystemmonitor 10:31:27 INFO - Successfully installed mozsystemmonitor 10:31:27 INFO - Cleaning up... 10:31:27 INFO - Return code: 0 10:31:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:28 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:28 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 10:31:28 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 10:31:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:28 INFO - 'HOME': '/Users/cltbld', 10:31:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:28 INFO - 'LOGNAME': 'cltbld', 10:31:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:28 INFO - 'MOZ_NO_REMOTE': '1', 10:31:28 INFO - 'NO_EM_RESTART': '1', 10:31:28 INFO - 'PAGER': '/bin/cat', 10:31:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:28 INFO - 'PWD': '/builds/slave/test', 10:31:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:28 INFO - 'SHELL': '/bin/bash', 10:31:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:28 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:28 INFO - 'USER': 'cltbld', 10:31:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:28 INFO - 'XPC_FLAGS': '0x0', 10:31:28 INFO - 'XPC_SERVICE_NAME': '0', 10:31:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:28 INFO - Downloading/unpacking jsonschema==2.5.1 10:31:28 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 10:31:28 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 10:31:28 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 10:31:28 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 10:31:28 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 10:31:28 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 10:31:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:31:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:31:30 INFO - warning: no files found matching '*.txt' 10:31:30 INFO - no previously-included directories found matching 'build' 10:31:30 INFO - no previously-included directories found matching 'dist' 10:31:30 INFO - no previously-included directories found matching '.git*' 10:31:30 INFO - Installing collected packages: jsonschema, functools32 10:31:30 INFO - Running setup.py install for functools32 10:31:30 INFO - warning: no files found matching '*.txt' 10:31:30 INFO - no previously-included directories found matching 'build' 10:31:30 INFO - no previously-included directories found matching 'dist' 10:31:30 INFO - no previously-included directories found matching '.git*' 10:31:30 INFO - Successfully installed jsonschema functools32 10:31:30 INFO - Cleaning up... 10:31:31 INFO - Return code: 0 10:31:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:31:31 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')]} 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 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')]} 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:31 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 10:31:31 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 10:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:31 INFO - 'HOME': '/Users/cltbld', 10:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:31 INFO - 'LOGNAME': 'cltbld', 10:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:31 INFO - 'MOZ_NO_REMOTE': '1', 10:31:31 INFO - 'NO_EM_RESTART': '1', 10:31:31 INFO - 'PAGER': '/bin/cat', 10:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:31 INFO - 'PWD': '/builds/slave/test', 10:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:31 INFO - 'SHELL': '/bin/bash', 10:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:31 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:31 INFO - 'USER': 'cltbld', 10:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:31 INFO - 'XPC_FLAGS': '0x0', 10:31:31 INFO - 'XPC_SERVICE_NAME': '0', 10:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:31:31 INFO - Cleaning up... 10:31:31 INFO - Return code: 0 10:31:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:31:31 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')]} 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 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')]} 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:31 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:31 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 10:31:31 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 10:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:31 INFO - 'HOME': '/Users/cltbld', 10:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:31 INFO - 'LOGNAME': 'cltbld', 10:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:31 INFO - 'MOZ_NO_REMOTE': '1', 10:31:31 INFO - 'NO_EM_RESTART': '1', 10:31:31 INFO - 'PAGER': '/bin/cat', 10:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:31 INFO - 'PWD': '/builds/slave/test', 10:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:31 INFO - 'SHELL': '/bin/bash', 10:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:31 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:31 INFO - 'USER': 'cltbld', 10:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:31 INFO - 'XPC_FLAGS': '0x0', 10:31:31 INFO - 'XPC_SERVICE_NAME': '0', 10:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:31 INFO - Downloading/unpacking blobuploader==1.2.4 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:32 INFO - Downloading blobuploader-1.2.4.tar.gz 10:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:31:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:31:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:31:33 INFO - Downloading docopt-0.6.1.tar.gz 10:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:31:33 INFO - Installing collected packages: blobuploader, requests, docopt 10:31:33 INFO - Running setup.py install for blobuploader 10:31:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:31:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:31:34 INFO - Running setup.py install for requests 10:31:34 INFO - Running setup.py install for docopt 10:31:34 INFO - Successfully installed blobuploader requests docopt 10:31:34 INFO - Cleaning up... 10:31:34 INFO - Return code: 0 10:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:34 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:34 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 10:31:34 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 10:31:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:34 INFO - 'HOME': '/Users/cltbld', 10:31:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:34 INFO - 'LOGNAME': 'cltbld', 10:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:34 INFO - 'MOZ_NO_REMOTE': '1', 10:31:34 INFO - 'NO_EM_RESTART': '1', 10:31:34 INFO - 'PAGER': '/bin/cat', 10:31:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:34 INFO - 'PWD': '/builds/slave/test', 10:31:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:34 INFO - 'SHELL': '/bin/bash', 10:31:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:34 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:34 INFO - 'USER': 'cltbld', 10:31:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:34 INFO - 'XPC_FLAGS': '0x0', 10:31:34 INFO - 'XPC_SERVICE_NAME': '0', 10:31:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-CGv8t9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-PJ6bCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-gbabP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-MilLwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-aEEmk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-XFX3tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-OIpvN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Yj4KYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-W6OVNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:35 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ExNRQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-lr50Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-GMr2Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-yzOD78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Yg0rHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-VYQYdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-9VSD_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:36 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-XrMMCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:31:36 INFO - Running setup.py install for manifestparser 10:31:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:31:36 INFO - Running setup.py install for mozcrash 10:31:37 INFO - Running setup.py install for mozdebug 10:31:37 INFO - Running setup.py install for mozdevice 10:31:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Running setup.py install for mozfile 10:31:37 INFO - Running setup.py install for mozhttpd 10:31:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Running setup.py install for mozinfo 10:31:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Running setup.py install for mozInstall 10:31:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:31:37 INFO - Running setup.py install for mozleak 10:31:38 INFO - Running setup.py install for mozlog 10:31:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for moznetwork 10:31:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozprocess 10:31:38 INFO - Running setup.py install for mozprofile 10:31:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozrunner 10:31:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:31:38 INFO - Running setup.py install for mozscreenshot 10:31:39 INFO - Running setup.py install for moztest 10:31:39 INFO - Running setup.py install for mozversion 10:31:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:31:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:31:39 INFO - Cleaning up... 10:31:39 INFO - Return code: 0 10:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:39 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')]} 10:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:39 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')]} 10:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:39 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:39 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 10:31:39 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 10:31:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:39 INFO - 'HOME': '/Users/cltbld', 10:31:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:39 INFO - 'LOGNAME': 'cltbld', 10:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:39 INFO - 'MOZ_NO_REMOTE': '1', 10:31:39 INFO - 'NO_EM_RESTART': '1', 10:31:39 INFO - 'PAGER': '/bin/cat', 10:31:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:39 INFO - 'PWD': '/builds/slave/test', 10:31:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:39 INFO - 'SHELL': '/bin/bash', 10:31:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:39 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:39 INFO - 'USER': 'cltbld', 10:31:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:39 INFO - 'XPC_FLAGS': '0x0', 10:31:39 INFO - 'XPC_SERVICE_NAME': '0', 10:31:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:31:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ozg0hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:31:39 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)) 10:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:31:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-OSLHxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:31:39 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)) 10:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:31:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-reLZEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:31:39 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)) 10:31:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:31:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-GDRBrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ydzuOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-l3oTZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-GZSovW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-fXmVFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-PCqpyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-fT26t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-CjyIk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-XJFeTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:31:40 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)) 10:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:31:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-112JBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:31:41 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)) 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:31:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-kdjrPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:31:41 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)) 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ynhwoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:31:41 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)) 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:31:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-AKyH7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:31:41 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)) 10:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:31:41 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-vXnFV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:31:41 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)) 10:31:41 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)) 10:31:41 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)) 10:31:41 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)) 10:31:41 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)) 10:31:41 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)) 10:31:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:31:41 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 10:31:41 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 10:31:41 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 10:31:41 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 10:31:41 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 10:31:41 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 10:31:42 INFO - Downloading blessings-1.6.tar.gz 10:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:31:42 INFO - Installing collected packages: blessings 10:31:42 INFO - Running setup.py install for blessings 10:31:43 INFO - Successfully installed blessings 10:31:43 INFO - Cleaning up... 10:31:43 INFO - Return code: 0 10:31:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:43 INFO - Reading from file tmpfile_stdout 10:31:43 INFO - Current package versions: 10:31:43 INFO - blessings == 1.6 10:31:43 INFO - blobuploader == 1.2.4 10:31:43 INFO - docopt == 0.6.1 10:31:43 INFO - functools32 == 3.2.3-2 10:31:43 INFO - jsonschema == 2.5.1 10:31:43 INFO - manifestparser == 1.1 10:31:43 INFO - mozInstall == 1.12 10:31:43 INFO - mozcrash == 1.0 10:31:43 INFO - mozdebug == 0.1 10:31:43 INFO - mozdevice == 0.50 10:31:43 INFO - mozfile == 1.2 10:31:43 INFO - mozhttpd == 0.7 10:31:43 INFO - mozinfo == 0.9 10:31:43 INFO - mozleak == 0.1 10:31:43 INFO - mozlog == 3.4 10:31:43 INFO - moznetwork == 0.27 10:31:43 INFO - mozprocess == 0.25 10:31:43 INFO - mozprofile == 0.28 10:31:43 INFO - mozrunner == 6.13 10:31:43 INFO - mozscreenshot == 0.1 10:31:43 INFO - mozsystemmonitor == 0.3 10:31:43 INFO - moztest == 0.8 10:31:43 INFO - mozversion == 1.4 10:31:43 INFO - psutil == 3.1.1 10:31:43 INFO - requests == 1.2.3 10:31:43 INFO - wsgiref == 0.1.2 10:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:31:43 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')]} 10:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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')]} 10:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:43 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 10:31:43 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 10:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:43 INFO - 'HOME': '/Users/cltbld', 10:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:43 INFO - 'LOGNAME': 'cltbld', 10:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:43 INFO - 'MOZ_NO_REMOTE': '1', 10:31:43 INFO - 'NO_EM_RESTART': '1', 10:31:43 INFO - 'PAGER': '/bin/cat', 10:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:43 INFO - 'PWD': '/builds/slave/test', 10:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:43 INFO - 'SHELL': '/bin/bash', 10:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:43 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:43 INFO - 'USER': 'cltbld', 10:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:43 INFO - 'XPC_FLAGS': '0x0', 10:31:43 INFO - 'XPC_SERVICE_NAME': '0', 10:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 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)) 10:31:43 INFO - Cleaning up... 10:31:43 INFO - Return code: 0 10:31:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:31:43 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')]} 10:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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')]} 10:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:31:43 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 0x10c2a1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2a4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e885ad540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, '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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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 10:31:43 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 10:31:43 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 10:31:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:31:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:31:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:31:43 INFO - 'HOME': '/Users/cltbld', 10:31:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:31:43 INFO - 'LOGNAME': 'cltbld', 10:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:31:43 INFO - 'MOZ_NO_REMOTE': '1', 10:31:43 INFO - 'NO_EM_RESTART': '1', 10:31:43 INFO - 'PAGER': '/bin/cat', 10:31:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:31:43 INFO - 'PWD': '/builds/slave/test', 10:31:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:31:43 INFO - 'SHELL': '/bin/bash', 10:31:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:31:43 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:31:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:31:43 INFO - 'USER': 'cltbld', 10:31:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:31:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:31:43 INFO - 'XPC_FLAGS': '0x0', 10:31:43 INFO - 'XPC_SERVICE_NAME': '0', 10:31:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:31:43 INFO - Cleaning up... 10:31:43 INFO - Return code: 0 10:31:43 INFO - Running post-action listener: _resource_record_post_action 10:31:43 INFO - Running post-action listener: _start_resource_monitoring 10:31:43 INFO - Starting resource monitoring. 10:31:43 INFO - [mozharness: 2017-05-04 17:31:43.955095Z] Finished create-virtualenv step (success) 10:31:43 INFO - [mozharness: 2017-05-04 17:31:43.956029Z] Running install step. 10:31:43 INFO - Running pre-action listener: _resource_record_pre_action 10:31:43 INFO - Running main action method: install 10:31:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:31:44 INFO - Reading from file tmpfile_stdout 10:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:31:44 INFO - Reading from file tmpfile_stdout 10:31:44 INFO - Output received: 10:31:44 INFO - Usage: mozinstall [options] installer 10:31:44 INFO - Options: 10:31:44 INFO - -h, --help show this help message and exit 10:31:44 INFO - -d DEST, --destination=DEST 10:31:44 INFO - Directory to install application into. [default: 10:31:44 INFO - "/builds/slave/test"] 10:31:44 INFO - --app=APP Application being installed. [default: firefox] 10:31:44 INFO - mkdir: /builds/slave/test/build/application 10:31:44 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'] 10:31:44 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 10:32:04 INFO - Reading from file tmpfile_stdout 10:32:04 INFO - Output received: 10:32:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:32:04 INFO - Running post-action listener: _resource_record_post_action 10:32:04 INFO - [mozharness: 2017-05-04 17:32:04.435880Z] Finished install step (success) 10:32:04 INFO - [mozharness: 2017-05-04 17:32:04.436013Z] Running run-tests step. 10:32:04 INFO - Running pre-action listener: _resource_record_pre_action 10:32:04 INFO - Running main action method: run_tests 10:32:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:32:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:32:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:32:04 INFO - 2017-05-04 10:32:04.450 screenresolution[1623:7589] starting screenresolution argv=screenresolution get 10:32:04 INFO - 2017-05-04 10:32:04.452 screenresolution[1623:7589] Display 0: 1600x1200x32@60 10:32:04 INFO - 2017-05-04 10:32:04.458 screenresolution[1624:7592] starting screenresolution argv=screenresolution list 10:32:04 INFO - Available Modes on Display 0 10:32:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:32:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:32:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:32:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:32:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:32:04 INFO - Intel Iris: 10:32:04 INFO - Chipset Model: Intel Iris 10:32:04 INFO - Type: GPU 10:32:04 INFO - Bus: Built-In 10:32:04 INFO - VRAM (Dynamic, Max): 1536 MB 10:32:04 INFO - Vendor: Intel (0x8086) 10:32:04 INFO - Device ID: 0x0a2e 10:32:04 INFO - Revision ID: 0x0009 10:32:04 INFO - Displays: 10:32:04 INFO - Display: 10:32:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:32:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:32:04 INFO - Display Serial Number: 1600x1200 60 10:32:04 INFO - Main Display: Yes 10:32:04 INFO - Mirror: Off 10:32:04 INFO - Online: Yes 10:32:04 INFO - Rotation: Supported 10:32:04 INFO - Return code: 0 10:32:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:32:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:32:04 INFO - Python 2.7.3 10:32:04 INFO - Return code: 0 10:32:04 INFO - grabbing minidump binary from tooltool 10:32:04 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')]} 10:32:04 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 0x10c07fd30>, '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 0x10bfa5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c074be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:32:04 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 10:32:04 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 10:32:04 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 10:32:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:32:04 INFO - Return code: 0 10:32:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:32:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:32:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:32:04 INFO - ENV: RUST_BACKTRACE is now 1 10:32:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:32:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:32:04 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/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 10:32:04 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/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 10:32:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkf1SZKf1j/Render', 10:32:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:32:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:32:04 INFO - 'HOME': '/Users/cltbld', 10:32:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:32:04 INFO - 'LOGNAME': 'cltbld', 10:32:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:32:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:32:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:32:04 INFO - 'MOZ_NO_REMOTE': '1', 10:32:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:32:04 INFO - 'NO_EM_RESTART': '1', 10:32:04 INFO - 'PAGER': '/bin/cat', 10:32:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:32:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:32:04 INFO - 'PWD': '/builds/slave/test', 10:32:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:32:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:32:04 INFO - 'RUST_BACKTRACE': '1', 10:32:04 INFO - 'SHELL': '/bin/bash', 10:32:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jm1JY2ILW2/Listeners', 10:32:04 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 10:32:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:32:04 INFO - 'USER': 'cltbld', 10:32:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:32:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:32:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:32:04 INFO - 'XPC_FLAGS': '0x0', 10:32:04 INFO - 'XPC_SERVICE_NAME': '0', 10:32:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:32:04 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/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 10:32:05 INFO - mozversion application_buildid: 20170504084920 10:32:05 INFO - mozversion application_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:32:05 INFO - mozversion application_display_name: Nightly 10:32:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:32:05 INFO - mozversion application_name: Firefox 10:32:05 INFO - mozversion application_remotingname: firefox 10:32:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:32:05 INFO - mozversion application_vendor: Mozilla 10:32:05 INFO - mozversion application_version: 55.0a1 10:32:05 INFO - mozversion platform_buildid: 20170504084920 10:32:05 INFO - mozversion platform_changeset: 0b255199db9d6a6f189b89b7906f99155bde3726 10:32:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:32:05 INFO - mozversion platform_version: 55.0a1 10:32:05 INFO - using testdate: 1493919125 10:32:05 INFO - actual date: 1493919125 10:32:05 INFO - starting webserver on 'localhost:49240' 10:32:05 INFO - SUITE-START | Running 2 tests 10:32:05 INFO - TEST-START | dromaeo_css 10:32:05 INFO - operating with platform_type : mac_ 10:32:05 INFO - Initialising browser for dromaeo_css test... 10:32:05 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp0wQobE/profile http://localhost:49240/getInfo.html) 10:32:07 INFO - PID 1634 | 2017-05-04 10:32:07.810 plugin-container[1636:7782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 10:32:07 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:07 INFO - PID 1634 | 2017-05-04 10:32:07.812 plugin-container[1636:7782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa00b, name = 'com.apple.CFPasteboardClient' 10:32:07 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:07 INFO - PID 1634 | 2017-05-04 10:32:07.813 plugin-container[1636:7782] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:07 INFO - PID 1634 | __metrics Screen width/height:1600/1200 10:32:07 INFO - PID 1634 | colorDepth:24 10:32:07 INFO - PID 1634 | Browser inner width/height: 1024/691 10:32:07 INFO - PID 1634 | __metrics 10:32:08 INFO - PID 1634 | 2017-05-04 10:32:08.312 plugin-container[1637:7834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 10:32:08 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:08 INFO - PID 1634 | 2017-05-04 10:32:08.312 plugin-container[1637:7834] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 10:32:08 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:08 INFO - PID 1634 | 2017-05-04 10:32:08.312 plugin-container[1637:7834] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:08 INFO - TEST-INFO | 1634: exit 0 10:32:08 INFO - Browser initialized. 10:32:08 INFO - Running cycle 1/1 for dromaeo_css test... 10:32:08 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp0wQobE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.294 plugin-container[1639:7948] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463f, name = 'com.apple.tsm.portname' 10:32:11 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.295 plugin-container[1639:7948] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x431b, name = 'com.apple.CFPasteboardClient' 10:32:11 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.295 plugin-container[1639:7948] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.801 plugin-container[1640:7988] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9143, name = 'com.apple.tsm.portname' 10:32:11 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.802 plugin-container[1640:7988] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9217, name = 'com.apple.CFPasteboardClient' 10:32:11 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:32:11 INFO - PID 1638 | 2017-05-04 10:32:11.802 plugin-container[1640:7988] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:32:21 INFO - PID 1638 | RSS: Main: 233267200 10:32:21 INFO - PID 1638 | 10:35:25 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 10:35:27 INFO - PID 1638 | RSS: Main: 250986496 10:35:27 INFO - PID 1638 | 10:38:28 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 10:38:29 INFO - PID 1638 | RSS: Main: 256204800 10:38:29 INFO - PID 1638 | 10:41:31 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 10:41:32 INFO - PID 1638 | RSS: Main: 264896512 10:41:32 INFO - PID 1638 | 10:44:33 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 10:44:34 INFO - PID 1638 | RSS: Main: 258695168 10:44:34 INFO - PID 1638 | 10:47:37 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 10:47:38 INFO - PID 1638 | RSS: Main: 262672384 10:47:38 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 10:50:39 INFO - PID 1638 | RSS: Main: 269697024 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | __start_tp_report 10:50:39 INFO - PID 1638 | _x_x_mozilla_page_load 10:50:39 INFO - PID 1638 | _x_x_mozilla_page_load_details 10:50:39 INFO - PID 1638 | |i|pagename|runs| 10:50:39 INFO - PID 1638 | |0;dojo.html;2973.5836982822407;3439.810810405428;3478.4608385700217;3588.7846729196235;3617.981910090449;6140.447359737623;6154;6194.690265486719;6218.782342618009;6252.874942501147;5095.592352611791;5180.300659410978;6176.320604733476;6215.067739839026;6252.6561039142825;4436.401085853417;5418.593605479585;5507.449255074481;5508.7521061552325;5534.114541673333;5453.3728621208475;5557;5566.332040155187;5578.804741834037;5588.245586845765;5482.725863706799;5497.835064948018;5514.779408823642;5548.861278468051;5561.165825126223;5507.118860982224;5531.585131115183;5535.723213839332;5557.749901254453;5568.805091821807;4538.228501154812;5410.783568657249;5434.809781657623;5468.453154684539;5495.203195536665;6048.606840555394;6164.321924588292;6217.036359364306;6276.92861355756;6277.713068820926;6654.900176497356;6750.426213771835;6762.120924279861;6764.661766911635;6790.354916282945;6863.416609588191;6871.4502839773195;6874.587524748531;6875.656217189171;6879.449644028516;6246.15676883624;6356.650384228912;6379.808605741835;6385.648789316632;6398;5776.682282474504;6749.392554670005;6888.690008949609;6922.996165556067;6953.687084081229;5889.352171261158;6353.301136875032;6415.069814876817;6642.86714265712;6646.4350530205475;6725;6732.764353247613;6796.4562834973085;6810.557313774589;6824.727010919508;6071.939280607226;6181.165542651775;6471.320511346335;6519.576227545194;6725.562838415487;6657.667116644148;6687.531872768956;6697.497687673444;6770.83072923171;6776.966115169393;5214.426413094557;5344.35867695879;5366.060939335601;5375.5162035417;5392.649477783932;4689.343491911135;4748.810047598057;4776.832810851603;4786.210275304606;4831.0820944020525;5257.684538927677;5901.17383566301;6319.431251187415;6375.521835862329;6426.164598602152;6818.727250910008;6845.0759147514445;6847.93152068473;6853.554518956352;6869.141357330333;6315.400036996478;6427.196600424947;6436.871262574722;6441.871162576722;6474.061261117112;5807.245058142415;5854.590178687451;5893.705314734246;5928.199693041384;5943.613665111754;6899.413549848319;6989.33601307875;7045.471589630695;7064.505484616027;7099.325564071405;6020;6850.486213533905;6885.586864788129;6894.724211031503;6902.516823822284;5797.246357973437;6715.865682686416;7046.929530704832;7080.539764915264;7092.04257425241;6501.2523559791225;6551.737930482727;6652.334766523309;6661.233958094687;6725.8991115134295;6038.064100064497;6589.143411356493;6708.161479815023;6755.1556055493065;6881.552699074544;5543.695096769717;6299.496040316672;6356.586821856749;6433.839154021187;6619.867602648016;5483.259759932517;6573.737050517926;6588.209414870246;6602.075709400784;6611.867762644624;5671.744771485375;6281.371862813682;6332.176817013758;6342.048692696132;6464.5798023128345;6534.967325163344;6585.275619681735;6598.538102332791;6636.601803891782;6639.468842492685;4713.57577817998;6398.1362516059735;6436.710348034256;6445.838854028687;6459.386358295955 10:50:39 INFO - PID 1638 | |1;ext.html;708.4297140801655;813.597269351671;1156.953721851126;1207.0826172109194;1223.3271700564687;36275.45586816197;36846;36853.44719829198;36941.076473088186;37034.81482592587;32976.17559561012;35187.4721879172;36926.26147477055;37473.62526374735;37481.81259093701;7710.306072453478;7845.529268243895;7868.25251601097;8252.504849709007;8325.167483251687;8324.83350332993;8418.536980466071;8421.747347579583;8447.535385553792;8478.872816907751;8356.623951922178;8423.241908228258;8465.238128568428;8481.151884811501;8484.19400156984;8389.370797190204;8443.957780211122;8448.873266901;8453.619587118534;8455.788605284855;8283.627236774299;8287.875681864776;8357.206065423836;8373.790655233606;8387.412881098326;35955.82022089899;35970;36102.458463123075;36139.4579081314;36189.9143025707;3663.4871118043493;3673.2653469306247;3706.814659267026;3707.8516859325596;3719.200371920023;29194.41611167765;29711.81152753909;29717;29722;29778.106656800115;3012.7891047626676;3028.4548781219373;3034.2717747740603;3038.8784448622027;3051.7406020488284;297209;298425;298722;299110.50444747857;305502;45436.36509079266;47822;47879.76060119677;47985.760071199424;48203.75898120487;48213;48863.755681221366;49154.75422622864;49262.0147597046;49275.75362123166;14097.78853317201;14194.006419550738;14216.21810800416;14224.21766802815;14246.145231286157;11242.269252498561;11411.60059397917;11429.428528573704;11431.59989400367;11470.197086204053;12967.22196668184;13065.804012939814;13187;13194.208347499181;13328.733425331438;5357.357117145967;5489.3687225969525;5784.132380142928;5786.2477877876445;5826.096954971901;981.3915372469115;1019.8521214423866;1026.9075783179549;1052.5421441672743;1064.7178497698117;23281.650775238046;24217.91019404131;24385.391643415544;24534;24631.261062168163;1073.2809017957986;1114.648885601033;1134.954601815918;1161.8199179127248;1174.671092094215;11939.820902686466;12376.133670642968;12390.070744694003;12395.690107747378;12420.75158496825;340769;343718;346007;346747.2662636721;347497;51290.23064654033;52025;55027;55245;55294.44705552974;1477.8522147785136;1525.6338478765238;1528.2511569330948;1536.2625939548855;1536.7003434330422;18479.907600461913;20618.69071963952;23922.76077239275;24021.03915843347;24307.756922430548;35663.46504802378;36604.633953661185;36760.26479470342;36862.26275474422;36932.44601331036;273174;295856;296900;297553;299622;30307.393852123274;34113.14717132092;36120.27759444744;36822.8158859204;36858.63141368552;43501.56498434975;45203.32195017012;45286.547134528235;45467;45714;29712;30594.847025764728;30735.231619208804;30872.228194294425;31201.8439907799;30360.54459183158;30449.238769030064;30465.23836904095;31271;31284.217894552818;36492;37596.87209383723;37699.43450848294;37748.245035099695;37864.81067594644;28584.714152859036;30965.29690867024;31120.688793112684;31179.68820311768;31311.84344078265;20699.58600828005;23705.762942370355;24221.394465137808;24671.876640616683;24714.752852471964 10:50:39 INFO - PID 1638 | |2;jquery.html;425.2940119401793;432.6716002975841;438.9363542286367;441.12436812926336;465.31598550131315;21375.35873923781;21449.356519304427;22171;22214;22416.66375004376;22355.664665029995;22899.969501372438;22970.196043138494;23219.535609287803;23386.181483648033;4803.63972702047;5931.584789064767;6188.814335569918;6207.28616209135;6210.720517576698;5208.947910520903;5957.553183511232;6103.938960610381;6106.786262480792;6111.419415155553;5370.462953704638;5777.537796976232;6055.455009049185;6067.787627433041;6081.209442772433;5970.8805823883495;6021.789237376671;6030.155778191057;6034.456898879122;6043.063325184581;4494.550544945512;5218.6868787872845;5352.598555108382;5354.759035843396;5355.732213389315;26910.865445672844;27090.458190836074;27093.729062709317;27220;27251.727482725117;2191.3535507025467;2252.8873556322283;2254.1884921428273;2254.4814692620625;2258.3112150794;14978.400863965537;16982.66034679312;17747.911260443616;17956.55108622282;18143.818561814343;2126.436494329004;2149.0973791007814;2186.8797216153107;2197.5824593327375;2203.019656252968;128002.71997280094;150081.24959375244;150434.24782876126;150921;153474;12270.509179632714;12815.743685126245;12830.80753788694;12871.485140594272;13153.60539183826;13735.656608584864;16363.918180409022;16534.917325413535;16658.250378732988;16684.83315166833;8787.253083487847;9109.726708198765;9125.224355929688;9196.724098277062;9283;8706.259967902672;8714;8732.69435569752;8886.200241978253;8901;7304.671289791972;7326.853462930818;7962.522248665098;8033.317168040665;8055.919440805517;1861.8417434517946;2122.4375540481783;2189.8357623178326;2204.7795220478147;2214.8338874584147;801.32288216457;955.9091886270793;970.1268858027831;1010.6967909627083;1012.9442880641489;20237.392878213675;21186.576268474546;21334.35996920095;21338.679919801216;21431;990.5443495991924;993.4833886379042;1012.9139023182964;1026.609888242478;1029.629333439961;10369.63706270277;10499.737506562396;10830.729231769112;10878.782424351468;10892.836607450894;498457.01542984834;519264;530043;533821;545476;116198.8380116188;119325.80674193321;120380.39809800895;129362.35318823345;134292.32853835865;1098.4123493930708;1172.6540670502222;1233.5334685196103;1243.720162963326;1252.8935040521476;20793.54445188883;21872.562548749254;21963.670544942157;22086.889565552712;22168.889155554763;39752.403713943735;56745;57083.71458142683;58604;60948.781024378375;78062;78691;79300;80390;80685;7837.1770964047955;8083.959580202061;8897.421667591585;9002.189802917768;9027.593758280762;13064.21614703083;14184.36170372315;14277.14337139775;14398;14505.419783208554;10364.429956352473;10641.148708103488;12037.157398981988;12144.878551214375;12160.270383777002;11088.833667494833;11164.274322169033;11334.716632084264;11501.884981150417;11652.475638596114;10459.738506537398;10670.19973502006;10735.89264107349;10768.730781730519;11972;8653.091425400242;8724.214820666171;8854.335924805795;9125.45247285165;9128.908710912805;11613.012893904113;11824.881751182378;11854.525818967144;11947.044236461235;12015.558133024093 10:50:39 INFO - PID 1638 | |3;mootools.html;1382.7718426459635;1424.4515861393368;1438.8705016548508;1445;1455.621538400016;11425.143114266422;11661.183717139782;11841;11882.762344753111;11917.344546049964;11528.827067593971;11610.535578576868;11727;11732.882671173285;11781.823272650896;2231.665250212465;2420.7775073587813;2520.8991640334366;2565.371483986426;2574.87125643718;2132.722746043012;2456.6437866509345;2503.8482298142876;2509.962350564743;2519.2694118705554;2504.198656429943;2509.5357358888573;2512.723600403954;2534.847909125449;2538.390786211305;2482.640017197505;2511.3972646564785;2515.4843257132243;2516.6854143232094;2517.7608127227886;2444.8899799509063;2499.287703004653;2517.1064272183476;2560.2319304208663;2566.47387285606;11808.996235320008;11870.287782733063;11901.464434100486;11919.702007449796;11926.701832454171;6605.636689982049;6783.389494945429;6860.0738900248825;6874.106366172416;6880;3948.1314110895846;4236.4704411948505;4324.567543245682;4348.2607956647125;4354.107407981356;1213.1447329632588;1219.2257916223173;1278.8401449818773;1283.7881749511319;1288.0854593238812;15198.620034499116;15681.607959801097;16319.755203671955;16594.253258603272;16620.418285359956;5454.7272636368025;5535.169724541271;5712.257406537124;5764;5766.481016708516;11263.042641375574;11636.476358563885;11804.70488237801;11816.35010074437;11822;6485.4811615070685;6569;6574.506911981621;6580.76967306142;6590.340965903467;6129.570930034944;6180.938190618036;6278.748850046039;6279.843003924847;6309.526785491106;3786.772793632391;4269.5516970718245;4429.512753597101;4432.667549933768;4466.977665111719;1081.789051135021;1289.4777615065914;1290.9031822613342;1307.8626744191913;1309.3584143769485;799.7360870912585;804.5414113955106;823.333100188837;828.9751307460785;857.1171693156059;5342.5993050521365;6001.4298641628975;6160.969195154085;6279.497640188774;6280.560360774702;598.5510866849862;599.8830228105478;618.3692633513791;629.3989240275525;631.0534198701947;3567.9643203568153;3908.042529580271;3931.8427262909163;4062.431259623655;4102.979485102615;12716.491340346283;14566;14573.92713036428;14808.3336249869;15106.471273505374;14515.350189419261;14832.258387080603;14848.62878428048;15054.247287635575;15192.772108418383;8066.959665201636;8336.458130221516;8435.072142064368;8463.195996380335;8529.147085291544;6424.614523128627;7017.2631873652535;7132.072830531998;7163.426925845815;7267.837146056606;13238.338083096;13342.599722008355;13394.866051339362;13408.798868017182;13418.93290533541;10729.731756705833;13775.242361670204;13792.724145517233;13820.654483637989;14047.471455137764;9162.816743665222;9216.07839216073;9221.123993220634;9252.21356184705;9421.199198067967;10558.577656893638;10672.519736612026;10674.35953842772;10702;10734.248602597743;8786.341024423065;9049.457032578066;9074.546272686208;9082.772930676785;9125.680601178927;7933.60331983387;8051.718189863327;8765.386422950332;8826.470411775314;8945.105489451003;8183;8194.303484203909;8208.302294304813;8294.792630184294;8296.958515207385;5615.129654903333;5643.88712225745;5654.7455364509515;5893.852653683521;6133.815985520441;5744.942550574608;6126.66303353302;6256.468200202851;6275.090111933653;6403.615783053032 10:50:39 INFO - PID 1638 | |4;prototype.html;365.59053859677164;390.61329284008804;398.5337155528032;406.2383031815346;414.4218814753418;5395.839894422703;6179.351168127349;6236.251649802019;6282.308946015934;6332.873342533158;5684.857878553038;6098.39016098391;6251.937480625193;6272.3100458949475;6272.623642581449;4441.378207051015;4545.0000999779995;4547.567981041812;4552.157850797605;4578.198815207342;4327.0047888985555;4535.410396648431;4546.29532422475;4553.4763502197175;4559.430071241095;4168.166366726667;4514.187446259688;4528.298113792351;4531.456225252974;4535.342375355572;3365.8990230292884;4271.765052922088;4303.956960430402;4508.323751437278;4541.114482675879;3209.903702888917;3864.091938394475;3873.9225215495812;3880;3884.7280690351686;5807.622504537191;6111.363738575585;6118.174046503709;6124.846878828021;6134.17188679527;4550.544945505456;4717.315989181549;5067.037262920034;5397.731533089721;5469.535089517396;4911.852644420673;5494.395616482184;6166;6435.549511534195;6677.565958212701;3511.122219445139;4172.624463798243;4367.366731823868;4385.473743150842;4403.405540252057;6814.897776533356;6893.586384816927;6935.237123916365;6996;7127.964360178166;4013.7190396671954;4213.494380674339;4445.355423463644;4455.242608756519;4464.933026004613;3989.3617021276455;4063.9796801015805;4126.184478829306;4529.547045295444;4541.046380260116;4511.413516242867;5067.949320506821;5435.83692489226;5542.63972841764;5718.7426565804635;6740.460763139035;6745.313671582105;6754.155730533684;6760.763373281911;6775.220849602359;1566.8354822743677;1662.7339625659836;1765.143905205974;1766.0992893624343;1771.973420398695;1131.8472006279046;1194.1402190422882;1204.8072308430785;1224.2960297828783;1238.4179435665224;5782.59521833476;5916.615419997686;6426.8714625707225;6458.515611329075;6489.1888513935755;6354.586951848115;6684.1978962523835;6855.348741869514;6915.965420172867;7046.43628509718;6207.162033125561;6407.519436042316;6433.292337842833;6437.195350581177;6515.57648752839;3294.225856923621;3570.5744010841895;3586.7668601540818;3627.3289441453417;3648.8540458381367;5728.942710572841;6510.869782604416;7068.858622827514;7154.678039488235;7341.522801017917;5511.917321240185;5844.766209351578;6823.176823176823;7141.9642901785155;7188.964055179796;5898.970505147447;6194.442500175006;7007.614581197981;7078.849911789307;7092.219855815856;6195.039768835838;6482.448991835747;6905.447564194752;6928.272531384132;6958.8956165658565;5684.857878553069;5974.761009559569;6510.707018184098;6746.561473504403;6814.522983391115;6354.428101470705;7018.192907815666;7234.385077268491;7236.529625574321;7262.782116536512;3607.1162565171703;3743.887683369503;4464.55354464551;4499.325101234841;4512.097580483851;5983.277608687949;6714.462842972648;6835.21395039557;7022.648867556704;7031.40233080194;6761.68147211289;6762.526623136333;6767.830804229934;6796.626185559644;6800.965995169992;5729.942700572941;6164.969175154096;6679.964605486158;6719.294474080151;6826.556273842383;5490.588205884655;6597.736090556324;6631.635260060743;6636.104125942936;6640.767573134917;6354.523410744305;6576.572522786004;6763.628000460022;6781.864362712817;6792.456603471809;6519.315471875385;6587.793089315133;6592.472602191909;6602.570832895846;6616.8345791355605 10:50:39 INFO - PID 1638 | |5;yui.html;727.0983979864966;770.6493545436825;818.9549574773392;865.8571335729605;866.4714524140276;14872.702545949074;15791.210439478009;16394.42619508316;16787.664246715074;16816.24326905289;18113.818861811378;18169.364072257475;18238.270469181218;18351.816481835212;18642.53393665159;990.9454979976081;1010.232223510134;1018.3635227982511;1019.4291196929743;1019.5310157327638;1002.313415310511;1005.2209537608339;1007.2697294461493;1008.3395376028712;1009.7223263602494;1051.0750539525206;1059.7615536504263;1061.4480470155515;1061.5170097605571;1063.6224140430152;1063.1547919404093;1064.0795711709354;1064.1008347945974;1064.2816099133092;1065.1532032034552;773.7949443397448;784.3019712455919;787.0869791042363;787.09877190617;787.1538096546236;13829.930850345683;16693.83306166947;16923.153842307835;17249.396271130576;17250.654986900317;16776.245068971926;17032.233549490178;17037.318507259693;17359.65280694379;17603.119844007877;13610.183388996593;13769.242691651954;14070.929645351707;14074.92962535191;14107.153570785786;3467.5665541807275;3531.5055892175114;3540.415831387818;3542.6988705960025;3546.6453354664586;116373.41813290965;126553.36723316417;129437.35281323627;129774;137322;13345.866541334657;13365.331733413484;13456.461741530426;13533.323333833467;13553.25457099869;24954.625680614805;25131.371715707253;25651.486970260492;25731.228063158134;25914.87042564775;7716.729914452967;7867.409944254204;7878.960605196938;7885.250901164381;7905.762827115081;3551.200979779529;3605.9182245326297;3779.4897688812207;3886.2227554489214;3890.358090915024;4420.491643460979;4437.400950871655;4451.688381813242;4522.706024108423;4528.50186479487;756.8297133144998;851.9062903080656;949.6818565780403;952.0146648219198;958.8130314588727;646.3988490703597;661.7584581627672;678.3826717686882;682.331315310998;688.9931100688929;9945.850812237823;10079.848802267972;10517.106045986176;10968.670939871816;11945.940270298766;646.3794757033301;660.7918505670795;686.2382755141789;688.5145972089665;720.7909706185147;4075.673946084306;5518.889622207614;5555.805546805843;5601;5828.591998560145;98496;98656;99593.00406995982;99795.50102249443;102622;85062.29875402457;85522;85962;86831;87311.1268887303;77030.61484692541;77212.22787772163;77720;80013;80858.59570702109;10158;11930.940345298219;12445.128840981406;12988.5454009113;13333.799992999919;31632.367352653277;39753;39910.40134397928;40449;41015.76952691424;71374.28625713676;71723.64138179275;72534.63732681303;72723.63638181775;73966.63016684882;16391.75412368839;16513.66972660564;17153.399631013355;17160.914195428944;17226.224819882886;17782.288708452033;18285.54286142804;18565.81434185695;18649.881007139615;18760.155792989077;16299.266533005806;17366.39217627377;17651.117444127998;17696.55758606045;17745.556361091076;14300.642483937985;16808.075555844545;17178.484645460656;17192.054437006085;17232.827671723124;16398.754018689968;16445.013299202084;17286.654266914844;17371;17463.56341091483;9253.213476854542;10717.196210284104;10797.028267455968;11208.719782005515;11402.94298528502;9470.289728270269;10621.416056068701;11433.714157145805;12248.693782655504;12319.938400307941 10:50:39 INFO - PID 1638 | __end_tp_report 10:50:39 INFO - PID 1638 | __start_cc_report 10:50:39 INFO - PID 1638 | _x_x_mozilla_cycle_collect,412 10:50:39 INFO - PID 1638 | __end_cc_report 10:50:39 INFO - PID 1638 | __startTimestamp1493920239975__endTimestamp 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | ------- Summary: start ------- 10:50:39 INFO - PID 1638 | Number of tests: 6 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#0] dojo.html Cycles:165 Average:6127.10 Median:6356.65 stddev:783.28 (12.3%) stddev-sans-first:745.60 10:50:39 INFO - PID 1638 | Values: 2973.6 3439.8 3478.5 3588.8 3618.0 6140.4 6154.0 6194.7 6218.8 6252.9 5095.6 5180.3 6176.3 6215.1 6252.7 4436.4 5418.6 5507.4 5508.8 5534.1 5453.4 5557.0 5566.3 5578.8 5588.2 5482.7 5497.8 5514.8 5548.9 5561.2 5507.1 5531.6 5535.7 5557.7 5568.8 4538.2 5410.8 5434.8 5468.5 5495.2 6048.6 6164.3 6217.0 6276.9 6277.7 6654.9 6750.4 6762.1 6764.7 6790.4 6863.4 6871.5 6874.6 6875.7 6879.4 6246.2 6356.7 6379.8 6385.6 6398.0 5776.7 6749.4 6888.7 6923.0 6953.7 5889.4 6353.3 6415.1 6642.9 6646.4 6725.0 6732.8 6796.5 6810.6 6824.7 6071.9 6181.2 6471.3 6519.6 6725.6 6657.7 6687.5 6697.5 6770.8 6777.0 5214.4 5344.4 5366.1 5375.5 5392.6 4689.3 4748.8 4776.8 4786.2 4831.1 5257.7 5901.2 6319.4 6375.5 6426.2 6818.7 6845.1 6847.9 6853.6 6869.1 6315.4 6427.2 6436.9 6441.9 6474.1 5807.2 5854.6 5893.7 5928.2 5943.6 6899.4 6989.3 7045.5 7064.5 7099.3 6020.0 6850.5 6885.6 6894.7 6902.5 5797.2 6715.9 7046.9 7080.5 7092.0 6501.3 6551.7 6652.3 6661.2 6725.9 6038.1 6589.1 6708.2 6755.2 6881.6 5543.7 6299.5 6356.6 6433.8 6619.9 5483.3 6573.7 6588.2 6602.1 6611.9 5671.7 6281.4 6332.2 6342.0 6464.6 6535.0 6585.3 6598.5 6636.6 6639.5 4713.6 6398.1 6436.7 6445.8 6459.4 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#1] ext.html Cycles:180 Average:45884.57 Median:188915.57 stddev:82338.71 (43.6%) stddev-sans-first:82499.83 10:50:39 INFO - PID 1638 | Values: 708.4 813.6 1157.0 1207.1 1223.3 36275.5 36846.0 36853.4 36941.1 37034.8 32976.2 35187.5 36926.3 37473.6 37481.8 7710.3 7845.5 7868.3 8252.5 8325.2 8324.8 8418.5 8421.7 8447.5 8478.9 8356.6 8423.2 8465.2 8481.2 8484.2 8389.4 8444.0 8448.9 8453.6 8455.8 8283.6 8287.9 8357.2 8373.8 8387.4 35955.8 35970.0 36102.5 36139.5 36189.9 3663.5 3673.3 3706.8 3707.9 3719.2 29194.4 29711.8 29717.0 29722.0 29778.1 3012.8 3028.5 3034.3 3038.9 3051.7 297209.0 298425.0 298722.0 299110.5 305502.0 45436.4 47822.0 47879.8 47985.8 48203.8 48213.0 48863.8 49154.8 49262.0 49275.8 14097.8 14194.0 14216.2 14224.2 14246.1 11242.3 11411.6 11429.4 11431.6 11470.2 12967.2 13065.8 13187.0 13194.2 13328.7 5357.4 5489.4 5784.1 5786.2 5826.1 981.4 1019.9 1026.9 1052.5 1064.7 23281.7 24217.9 24385.4 24534.0 24631.3 1073.3 1114.6 1135.0 1161.8 1174.7 11939.8 12376.1 12390.1 12395.7 12420.8 340769.0 343718.0 346007.0 346747.3 347497.0 51290.2 52025.0 55027.0 55245.0 55294.4 1477.9 1525.6 1528.3 1536.3 1536.7 18479.9 20618.7 23922.8 24021.0 24307.8 35663.5 36604.6 36760.3 36862.3 36932.4 273174.0 295856.0 296900.0 297553.0 299622.0 30307.4 34113.1 36120.3 36822.8 36858.6 43501.6 45203.3 45286.5 45467.0 45714.0 29712.0 30594.8 30735.2 30872.2 31201.8 30360.5 30449.2 30465.2 31271.0 31284.2 36492.0 37596.9 37699.4 37748.2 37864.8 28584.7 30965.3 31120.7 31179.7 31311.8 20699.6 23705.8 24221.4 24671.9 24714.8 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#2] jquery.html Cycles:180 Average:34533.40 Median:22386.16 stddev:89141.73 (398.2%) stddev-sans-first:89355.01 10:50:39 INFO - PID 1638 | Values: 425.3 432.7 438.9 441.1 465.3 21375.4 21449.4 22171.0 22214.0 22416.7 22355.7 22900.0 22970.2 23219.5 23386.2 4803.6 5931.6 6188.8 6207.3 6210.7 5208.9 5957.6 6103.9 6106.8 6111.4 5370.5 5777.5 6055.5 6067.8 6081.2 5970.9 6021.8 6030.2 6034.5 6043.1 4494.6 5218.7 5352.6 5354.8 5355.7 26910.9 27090.5 27093.7 27220.0 27251.7 2191.4 2252.9 2254.2 2254.5 2258.3 14978.4 16982.7 17747.9 17956.6 18143.8 2126.4 2149.1 2186.9 2197.6 2203.0 128002.7 150081.2 150434.2 150921.0 153474.0 12270.5 12815.7 12830.8 12871.5 13153.6 13735.7 16363.9 16534.9 16658.3 16684.8 8787.3 9109.7 9125.2 9196.7 9283.0 8706.3 8714.0 8732.7 8886.2 8901.0 7304.7 7326.9 7962.5 8033.3 8055.9 1861.8 2122.4 2189.8 2204.8 2214.8 801.3 955.9 970.1 1010.7 1012.9 20237.4 21186.6 21334.4 21338.7 21431.0 990.5 993.5 1012.9 1026.6 1029.6 10369.6 10499.7 10830.7 10878.8 10892.8 498457.0 519264.0 530043.0 533821.0 545476.0 116198.8 119325.8 120380.4 129362.4 134292.3 1098.4 1172.7 1233.5 1243.7 1252.9 20793.5 21872.6 21963.7 22086.9 22168.9 39752.4 56745.0 57083.7 58604.0 60948.8 78062.0 78691.0 79300.0 80390.0 80685.0 7837.2 8084.0 8897.4 9002.2 9027.6 13064.2 14184.4 14277.1 14398.0 14505.4 10364.4 10641.1 12037.2 12144.9 12160.3 11088.8 11164.3 11334.7 11501.9 11652.5 10459.7 10670.2 10735.9 10768.7 11972.0 8653.1 8724.2 8854.3 9125.5 9128.9 11613.0 11824.9 11854.5 11947.0 12015.6 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#3] mootools.html Cycles:180 Average:7038.96 Median:3677.37 stddev:4447.16 (120.9%) stddev-sans-first:4439.32 10:50:39 INFO - PID 1638 | Values: 1382.8 1424.5 1438.9 1445.0 1455.6 11425.1 11661.2 11841.0 11882.8 11917.3 11528.8 11610.5 11727.0 11732.9 11781.8 2231.7 2420.8 2520.9 2565.4 2574.9 2132.7 2456.6 2503.8 2510.0 2519.3 2504.2 2509.5 2512.7 2534.8 2538.4 2482.6 2511.4 2515.5 2516.7 2517.8 2444.9 2499.3 2517.1 2560.2 2566.5 11809.0 11870.3 11901.5 11919.7 11926.7 6605.6 6783.4 6860.1 6874.1 6880.0 3948.1 4236.5 4324.6 4348.3 4354.1 1213.1 1219.2 1278.8 1283.8 1288.1 15198.6 15681.6 16319.8 16594.3 16620.4 5454.7 5535.2 5712.3 5764.0 5766.5 11263.0 11636.5 11804.7 11816.4 11822.0 6485.5 6569.0 6574.5 6580.8 6590.3 6129.6 6180.9 6278.7 6279.8 6309.5 3786.8 4269.6 4429.5 4432.7 4467.0 1081.8 1289.5 1290.9 1307.9 1309.4 799.7 804.5 823.3 829.0 857.1 5342.6 6001.4 6161.0 6279.5 6280.6 598.6 599.9 618.4 629.4 631.1 3568.0 3908.0 3931.8 4062.4 4103.0 12716.5 14566.0 14573.9 14808.3 15106.5 14515.4 14832.3 14848.6 15054.2 15192.8 8067.0 8336.5 8435.1 8463.2 8529.1 6424.6 7017.3 7132.1 7163.4 7267.8 13238.3 13342.6 13394.9 13408.8 13418.9 10729.7 13775.2 13792.7 13820.7 14047.5 9162.8 9216.1 9221.1 9252.2 9421.2 10558.6 10672.5 10674.4 10702.0 10734.2 8786.3 9049.5 9074.5 9082.8 9125.7 7933.6 8051.7 8765.4 8826.5 8945.1 8183.0 8194.3 8208.3 8294.8 8297.0 5615.1 5643.9 5654.7 5893.9 6133.8 5744.9 6126.7 6256.5 6275.1 6403.6 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#4] prototype.html Cycles:180 Average:5341.81 Median:6040.83 stddev:1702.68 (28.2%) stddev-sans-first:1665.98 10:50:39 INFO - PID 1638 | Values: 365.6 390.6 398.5 406.2 414.4 5395.8 6179.4 6236.3 6282.3 6332.9 5684.9 6098.4 6251.9 6272.3 6272.6 4441.4 4545.0 4547.6 4552.2 4578.2 4327.0 4535.4 4546.3 4553.5 4559.4 4168.2 4514.2 4528.3 4531.5 4535.3 3365.9 4271.8 4304.0 4508.3 4541.1 3209.9 3864.1 3873.9 3880.0 3884.7 5807.6 6111.4 6118.2 6124.8 6134.2 4550.5 4717.3 5067.0 5397.7 5469.5 4911.9 5494.4 6166.0 6435.5 6677.6 3511.1 4172.6 4367.4 4385.5 4403.4 6814.9 6893.6 6935.2 6996.0 7128.0 4013.7 4213.5 4445.4 4455.2 4464.9 3989.4 4064.0 4126.2 4529.5 4541.0 4511.4 5067.9 5435.8 5542.6 5718.7 6740.5 6745.3 6754.2 6760.8 6775.2 1566.8 1662.7 1765.1 1766.1 1772.0 1131.8 1194.1 1204.8 1224.3 1238.4 5782.6 5916.6 6426.9 6458.5 6489.2 6354.6 6684.2 6855.3 6916.0 7046.4 6207.2 6407.5 6433.3 6437.2 6515.6 3294.2 3570.6 3586.8 3627.3 3648.9 5728.9 6510.9 7068.9 7154.7 7341.5 5511.9 5844.8 6823.2 7142.0 7189.0 5899.0 6194.4 7007.6 7078.8 7092.2 6195.0 6482.4 6905.4 6928.3 6958.9 5684.9 5974.8 6510.7 6746.6 6814.5 6354.4 7018.2 7234.4 7236.5 7262.8 3607.1 3743.9 4464.6 4499.3 4512.1 5983.3 6714.5 6835.2 7022.6 7031.4 6761.7 6762.5 6767.8 6796.6 6801.0 5729.9 6165.0 6680.0 6719.3 6826.6 5490.6 6597.7 6631.6 6636.1 6640.8 6354.5 6576.6 6763.6 6781.9 6792.5 6519.3 6587.8 6592.5 6602.6 6616.8 10:50:39 INFO - PID 1638 | 10:50:39 INFO - PID 1638 | [#5] yui.html Cycles:180 Average:21892.17 Median:18261.91 stddev:30721.14 (168.2%) stddev-sans-first:30766.22 10:50:39 INFO - PID 1638 | Values: 727.1 770.6 819.0 865.9 866.5 14872.7 15791.2 16394.4 16787.7 16816.2 18113.8 18169.4 18238.3 18351.8 18642.5 990.9 1010.2 1018.4 1019.4 1019.5 1002.3 1005.2 1007.3 1008.3 1009.7 1051.1 1059.8 1061.4 1061.5 1063.6 1063.2 1064.1 1064.1 1064.3 1065.2 773.8 784.3 787.1 787.1 787.2 13829.9 16693.8 16923.2 17249.4 17250.7 16776.2 17032.2 17037.3 17359.7 17603.1 13610.2 13769.2 14070.9 14074.9 14107.2 3467.6 3531.5 3540.4 3542.7 3546.6 116373.4 126553.4 129437.4 129774.0 137322.0 13345.9 13365.3 13456.5 13533.3 13553.3 24954.6 25131.4 25651.5 25731.2 25914.9 7716.7 7867.4 7879.0 7885.3 7905.8 3551.2 3605.9 3779.5 3886.2 3890.4 4420.5 4437.4 4451.7 4522.7 4528.5 756.8 851.9 949.7 952.0 958.8 646.4 661.8 678.4 682.3 689.0 9945.9 10079.8 10517.1 10968.7 11945.9 646.4 660.8 686.2 688.5 720.8 4075.7 5518.9 5555.8 5601.0 5828.6 98496.0 98656.0 99593.0 99795.5 102622.0 85062.3 85522.0 85962.0 86831.0 87311.1 77030.6 77212.2 77720.0 80013.0 80858.6 10158.0 11930.9 12445.1 12988.5 13333.8 31632.4 39753.0 39910.4 40449.0 41015.8 71374.3 71723.6 72534.6 72723.6 73966.6 16391.8 16513.7 17153.4 17160.9 17226.2 17782.3 18285.5 18565.8 18649.9 18760.2 16299.3 17366.4 17651.1 17696.6 17745.6 14300.6 16808.1 17178.5 17192.1 17232.8 16398.8 16445.0 17286.7 17371.0 17463.6 9253.2 10717.2 10797.0 11208.7 11402.9 9470.3 10621.4 11433.7 12248.7 12319.9 10:50:39 INFO - PID 1638 | -------- Summary: end -------- 10:50:39 INFO - PID 1638 | 10:50:40 INFO - TEST-INFO | 1638: exit 0 10:50:40 INFO - TEST-OK | dromaeo_css | took 1115552ms 10:50:40 INFO - TEST-START | kraken 10:50:40 INFO - operating with platform_type : mac_ 10:50:40 INFO - Initialising browser for kraken test... 10:50:40 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmps5RySS/profile http://localhost:49240/getInfo.html) 10:50:43 INFO - PID 1652 | 2017-05-04 10:50:43.446 plugin-container[1653:10398] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 10:50:43 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:43 INFO - PID 1652 | 2017-05-04 10:50:43.449 plugin-container[1653:10398] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a03, name = 'com.apple.CFPasteboardClient' 10:50:43 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:43 INFO - PID 1652 | 2017-05-04 10:50:43.449 plugin-container[1653:10398] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:50:43 INFO - PID 1652 | __metrics Screen width/height:1600/1200 10:50:43 INFO - PID 1652 | colorDepth:24 10:50:43 INFO - PID 1652 | Browser inner width/height: 1024/691 10:50:43 INFO - PID 1652 | __metrics 10:50:44 INFO - PID 1652 | 2017-05-04 10:50:44.119 plugin-container[1654:10454] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:50:44 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:44 INFO - PID 1652 | 2017-05-04 10:50:44.119 plugin-container[1654:10454] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 10:50:44 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:44 INFO - PID 1652 | 2017-05-04 10:50:44.119 plugin-container[1654:10454] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:50:44 INFO - TEST-INFO | 1652: exit 0 10:50:44 INFO - Browser initialized. 10:50:44 INFO - Running cycle 1/1 for kraken test... 10:50:44 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmps5RySS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.067 plugin-container[1656:10556] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x932f, name = 'com.apple.tsm.portname' 10:50:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.068 plugin-container[1656:10556] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a17, name = 'com.apple.CFPasteboardClient' 10:50:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.068 plugin-container[1656:10556] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.597 plugin-container[1657:10596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 10:50:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.597 plugin-container[1657:10596] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 10:50:47 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:50:47 INFO - PID 1655 | 2017-05-04 10:50:47.597 plugin-container[1657:10596] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:50:56 INFO - PID 1655 | RSS: Main: 235012096 10:50:56 INFO - PID 1655 | 10:50:59 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 10:51:00 INFO - PID 1655 | RSS: Main: 247087104 10:51:00 INFO - PID 1655 | 10:51:03 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 10:51:04 INFO - PID 1655 | RSS: Main: 255381504 10:51:04 INFO - PID 1655 | 10:51:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 10:51:08 INFO - PID 1655 | RSS: Main: 257859584 10:51:08 INFO - PID 1655 | 10:51:10 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 10:51:11 INFO - PID 1655 | RSS: Main: 259915776 10:51:11 INFO - PID 1655 | 10:51:13 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:51:13 INFO - PID 1655 | RSS: Main: 260628480 10:51:13 INFO - PID 1655 | 10:51:16 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 10:51:17 INFO - PID 1655 | RSS: Main: 266522624 10:51:17 INFO - PID 1655 | 10:51:20 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 10:51:21 INFO - PID 1655 | RSS: Main: 267386880 10:51:21 INFO - PID 1655 | 10:51:24 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 10:51:25 INFO - PID 1655 | RSS: Main: 267321344 10:51:25 INFO - PID 1655 | 10:51:26 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:51:27 INFO - PID 1655 | RSS: Main: 266657792 10:51:27 INFO - PID 1655 | 10:51:28 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:51:29 INFO - PID 1655 | RSS: Main: 266657792 10:51:29 INFO - PID 1655 | 10:51:31 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:51:32 INFO - PID 1655 | RSS: Main: 266485760 10:51:32 INFO - PID 1655 | 10:51:35 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:51:36 INFO - PID 1655 | RSS: Main: 266829824 10:51:36 INFO - PID 1655 | 10:51:39 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:51:39 INFO - PID 1655 | RSS: Main: 266678272 10:51:39 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 10:51:41 INFO - PID 1655 | RSS: Main: 268242944 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | __start_tp_report 10:51:41 INFO - PID 1655 | _x_x_mozilla_page_load 10:51:41 INFO - PID 1655 | _x_x_mozilla_page_load_details 10:51:41 INFO - PID 1655 | |i|pagename|runs| 10:51:41 INFO - PID 1655 | |0;ai-astar;102;115;112;113;112;131;171;97;166;135 10:51:41 INFO - PID 1655 | |1;audio-beat-detection;173;150;121;134;132;149;111;140;163;110 10:51:41 INFO - PID 1655 | |2;audio-dft;226;272;215;263;273;188;270;191;266;280 10:51:41 INFO - PID 1655 | |3;audio-fft;74;58;58;80;56;59;59;68;91;81 10:51:41 INFO - PID 1655 | |4;audio-oscillator;80;71;85;79;103;65;81;62;95;116 10:51:41 INFO - PID 1655 | |5;imaging-gaussian-blur;91;91;108;90;105;108;136;93;136;137 10:51:41 INFO - PID 1655 | |6;imaging-darkroom;155;150;154;155;99;98;99;97;98;97 10:51:41 INFO - PID 1655 | |7;imaging-desaturate;91;95;91;92;95;107;147;91;90;94 10:51:41 INFO - PID 1655 | |8;json-parse-financial;52;49;49;52;51;53;53;51;50;51 10:51:41 INFO - PID 1655 | |9;json-stringify-tinderbox;58;63;59;65;62;59;55;54;53;57 10:51:41 INFO - PID 1655 | |10;stanford-crypto-aes;82;84;84;83;84;83;100;104;80;82 10:51:41 INFO - PID 1655 | |11;stanford-crypto-ccm;138;136;130;158;149;127;151;148;221;142 10:51:41 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;186;189;184;180;181;183;186;180;180;182 10:51:41 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;69;70;66;66;75;65;66;69;66;70 10:51:41 INFO - PID 1655 | __end_tp_report 10:51:41 INFO - PID 1655 | __start_cc_report 10:51:41 INFO - PID 1655 | _x_x_mozilla_cycle_collect,975 10:51:41 INFO - PID 1655 | __end_cc_report 10:51:41 INFO - PID 1655 | __startTimestamp1493920301582__endTimestamp 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | ------- Summary: start ------- 10:51:41 INFO - PID 1655 | Number of tests: 14 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:125.40 Median:133.00 stddev:25.44 (19.1%) stddev-sans-first:25.54 10:51:41 INFO - PID 1655 | Values: 102.0 115.0 112.0 113.0 112.0 131.0 171.0 97.0 166.0 135.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:144.50 stddev:21.01 (14.5%) stddev-sans-first:18.15 10:51:41 INFO - PID 1655 | Values: 173.0 150.0 121.0 134.0 132.0 149.0 111.0 140.0 163.0 110.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:244.40 Median:268.00 stddev:35.82 (13.4%) stddev-sans-first:37.37 10:51:41 INFO - PID 1655 | Values: 226.0 272.0 215.0 263.0 273.0 188.0 270.0 191.0 266.0 280.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:68.40 Median:71.00 stddev:12.39 (17.5%) stddev-sans-first:12.98 10:51:41 INFO - PID 1655 | Values: 74.0 58.0 58.0 80.0 56.0 59.0 59.0 68.0 91.0 81.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:79.50 stddev:16.90 (21.3%) stddev-sans-first:17.87 10:51:41 INFO - PID 1655 | Values: 80.0 71.0 85.0 79.0 103.0 65.0 81.0 62.0 95.0 116.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:113.50 stddev:19.78 (17.4%) stddev-sans-first:19.82 10:51:41 INFO - PID 1655 | Values: 91.0 91.0 108.0 90.0 105.0 108.0 136.0 93.0 136.0 137.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:120.20 Median:97.50 stddev:28.70 (29.4%) stddev-sans-first:27.54 10:51:41 INFO - PID 1655 | Values: 155.0 150.0 154.0 155.0 99.0 98.0 99.0 97.0 98.0 97.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:91.50 stddev:17.47 (19.1%) stddev-sans-first:18.27 10:51:41 INFO - PID 1655 | Values: 91.0 95.0 91.0 92.0 95.0 107.0 147.0 91.0 90.0 94.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:1.45 (2.8%) stddev-sans-first:1.50 10:51:41 INFO - PID 1655 | Values: 52.0 49.0 49.0 52.0 51.0 53.0 53.0 51.0 50.0 51.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:3.95 (6.7%) stddev-sans-first:4.19 10:51:41 INFO - PID 1655 | Values: 58.0 63.0 59.0 65.0 62.0 59.0 55.0 54.0 53.0 57.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:83.00 stddev:8.26 (10.0%) stddev-sans-first:8.59 10:51:41 INFO - PID 1655 | Values: 82.0 84.0 84.0 83.0 84.0 83.0 100.0 104.0 80.0 82.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:150.00 Median:148.50 stddev:26.76 (18.0%) stddev-sans-first:28.03 10:51:41 INFO - PID 1655 | Values: 138.0 136.0 130.0 158.0 149.0 127.0 151.0 148.0 221.0 142.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.10 Median:183.50 stddev:3.11 (1.7%) stddev-sans-first:3.11 10:51:41 INFO - PID 1655 | Values: 186.0 189.0 184.0 180.0 181.0 183.0 186.0 180.0 180.0 182.0 10:51:41 INFO - PID 1655 | 10:51:41 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:3.05 (4.4%) stddev-sans-first:3.22 10:51:41 INFO - PID 1655 | Values: 69.0 70.0 66.0 66.0 75.0 65.0 66.0 69.0 66.0 70.0 10:51:41 INFO - PID 1655 | -------- Summary: end -------- 10:51:41 INFO - PID 1655 | 10:51:42 INFO - TEST-INFO | 1655: exit 0 10:51:42 INFO - TEST-OK | kraken | took 62321ms 10:51:42 INFO - SUITE-END | took 1177s 10:51:43 INFO - Completed test suite (00:19:38) 10:51:43 INFO - javascript benchmark 10:51:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7856.046940060228, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2973.5836982822407, 3439.810810405428, 3478.4608385700217, 3588.7846729196235, 3617.981910090449, 6140.447359737623, 6154.0, 6194.690265486719, 6218.782342618009, 6252.874942501147, 5095.592352611791, 5180.300659410978, 6176.320604733476, 6215.067739839026, 6252.6561039142825, 4436.401085853417, 5418.593605479585, 5507.449255074481, 5508.7521061552325, 5534.114541673333, 5453.3728621208475, 5557.0, 5566.332040155187, 5578.804741834037, 5588.245586845765, 5482.725863706799, 5497.835064948018, 5514.779408823642, 5548.861278468051, 5561.165825126223, 5507.118860982224, 5531.585131115183, 5535.723213839332, 5557.749901254453, 5568.805091821807, 4538.228501154812, 5410.783568657249, 5434.809781657623, 5468.453154684539, 5495.203195536665, 6048.606840555394, 6164.321924588292, 6217.036359364306, 6276.92861355756, 6277.713068820926, 6654.900176497356, 6750.426213771835, 6762.120924279861, 6764.661766911635, 6790.354916282945, 6863.416609588191, 6871.4502839773195, 6874.587524748531, 6875.656217189171, 6879.449644028516, 6246.15676883624, 6356.650384228912, 6379.808605741835, 6385.648789316632, 6398.0, 5776.682282474504, 6749.392554670005, 6888.690008949609, 6922.996165556067, 6953.687084081229, 5889.352171261158, 6353.301136875032, 6415.069814876817, 6642.86714265712, 6646.4350530205475, 6725.0, 6732.764353247613, 6796.4562834973085, 6810.557313774589, 6824.727010919508, 6071.939280607226, 6181.165542651775, 6471.320511346335, 6519.576227545194, 6725.562838415487, 6657.667116644148, 6687.531872768956, 6697.497687673444, 6770.83072923171, 6776.966115169393, 5214.426413094557, 5344.35867695879, 5366.060939335601, 5375.5162035417, 5392.649477783932, 4689.343491911135, 4748.810047598057, 4776.832810851603, 4786.210275304606, 4831.0820944020525, 5257.684538927677, 5901.17383566301, 6319.431251187415, 6375.521835862329, 6426.164598602152, 6818.727250910008, 6845.0759147514445, 6847.93152068473, 6853.554518956352, 6869.141357330333, 6315.400036996478, 6427.196600424947, 6436.871262574722, 6441.871162576722, 6474.061261117112, 5807.245058142415, 5854.590178687451, 5893.705314734246, 5928.199693041384, 5943.613665111754, 6899.413549848319, 6989.33601307875, 7045.471589630695, 7064.505484616027, 7099.325564071405, 6020.0, 6850.486213533905, 6885.586864788129, 6894.724211031503, 6902.516823822284, 5797.246357973437, 6715.865682686416, 7046.929530704832, 7080.539764915264, 7092.04257425241, 6501.2523559791225, 6551.737930482727, 6652.334766523309, 6661.233958094687, 6725.8991115134295, 6038.064100064497, 6589.143411356493, 6708.161479815023, 6755.1556055493065, 6881.552699074544, 5543.695096769717, 6299.496040316672, 6356.586821856749, 6433.839154021187, 6619.867602648016, 5483.259759932517, 6573.737050517926, 6588.209414870246, 6602.075709400784, 6611.867762644624, 5671.744771485375, 6281.371862813682, 6332.176817013758, 6342.048692696132, 6464.5798023128345, 6534.967325163344, 6585.275619681735, 6598.538102332791, 6636.601803891782, 6639.468842492685, 4713.57577817998, 6398.1362516059735, 6436.710348034256, 6445.838854028687, 6459.386358295955], "value": 6075.064203022238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.4297140801655, 813.597269351671, 1156.953721851126, 1207.0826172109194, 1223.3271700564687, 36275.45586816197, 36846.0, 36853.44719829198, 36941.076473088186, 37034.81482592587, 32976.17559561012, 35187.4721879172, 36926.26147477055, 37473.62526374735, 37481.81259093701, 7710.306072453478, 7845.529268243895, 7868.25251601097, 8252.504849709007, 8325.167483251687, 8324.83350332993, 8418.536980466071, 8421.747347579583, 8447.535385553792, 8478.872816907751, 8356.623951922178, 8423.241908228258, 8465.238128568428, 8481.151884811501, 8484.19400156984, 8389.370797190204, 8443.957780211122, 8448.873266901, 8453.619587118534, 8455.788605284855, 8283.627236774299, 8287.875681864776, 8357.206065423836, 8373.790655233606, 8387.412881098326, 35955.82022089899, 35970.0, 36102.458463123075, 36139.4579081314, 36189.9143025707, 3663.4871118043493, 3673.2653469306247, 3706.814659267026, 3707.8516859325596, 3719.200371920023, 29194.41611167765, 29711.81152753909, 29717.0, 29722.0, 29778.106656800115, 3012.7891047626676, 3028.4548781219373, 3034.2717747740603, 3038.8784448622027, 3051.7406020488284, 297209.0, 298425.0, 298722.0, 299110.50444747857, 305502.0, 45436.36509079266, 47822.0, 47879.76060119677, 47985.760071199424, 48203.75898120487, 48213.0, 48863.755681221366, 49154.75422622864, 49262.0147597046, 49275.75362123166, 14097.78853317201, 14194.006419550738, 14216.21810800416, 14224.21766802815, 14246.145231286157, 11242.269252498561, 11411.60059397917, 11429.428528573704, 11431.59989400367, 11470.197086204053, 12967.22196668184, 13065.804012939814, 13187.0, 13194.208347499181, 13328.733425331438, 5357.357117145967, 5489.3687225969525, 5784.132380142928, 5786.2477877876445, 5826.096954971901, 981.3915372469115, 1019.8521214423866, 1026.9075783179549, 1052.5421441672743, 1064.7178497698117, 23281.650775238046, 24217.91019404131, 24385.391643415544, 24534.0, 24631.261062168163, 1073.2809017957986, 1114.648885601033, 1134.954601815918, 1161.8199179127248, 1174.671092094215, 11939.820902686466, 12376.133670642968, 12390.070744694003, 12395.690107747378, 12420.75158496825, 340769.0, 343718.0, 346007.0, 346747.2662636721, 347497.0, 51290.23064654033, 52025.0, 55027.0, 55245.0, 55294.44705552974, 1477.8522147785136, 1525.6338478765238, 1528.2511569330948, 1536.2625939548855, 1536.7003434330422, 18479.907600461913, 20618.69071963952, 23922.76077239275, 24021.03915843347, 24307.756922430548, 35663.46504802378, 36604.633953661185, 36760.26479470342, 36862.26275474422, 36932.44601331036, 273174.0, 295856.0, 296900.0, 297553.0, 299622.0, 30307.393852123274, 34113.14717132092, 36120.27759444744, 36822.8158859204, 36858.63141368552, 43501.56498434975, 45203.32195017012, 45286.547134528235, 45467.0, 45714.0, 29712.0, 30594.847025764728, 30735.231619208804, 30872.228194294425, 31201.8439907799, 30360.54459183158, 30449.238769030064, 30465.23836904095, 31271.0, 31284.217894552818, 36492.0, 37596.87209383723, 37699.43450848294, 37748.245035099695, 37864.81067594644, 28584.714152859036, 30965.29690867024, 31120.688793112684, 31179.68820311768, 31311.84344078265, 20699.58600828005, 23705.762942370355, 24221.394465137808, 24671.876640616683, 24714.752852471964], "value": 17452.432742767232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.2940119401793, 432.6716002975841, 438.9363542286367, 441.12436812926336, 465.31598550131315, 21375.35873923781, 21449.356519304427, 22171.0, 22214.0, 22416.66375004376, 22355.664665029995, 22899.969501372438, 22970.196043138494, 23219.535609287803, 23386.181483648033, 4803.63972702047, 5931.584789064767, 6188.814335569918, 6207.28616209135, 6210.720517576698, 5208.947910520903, 5957.553183511232, 6103.938960610381, 6106.786262480792, 6111.419415155553, 5370.462953704638, 5777.537796976232, 6055.455009049185, 6067.787627433041, 6081.209442772433, 5970.8805823883495, 6021.789237376671, 6030.155778191057, 6034.456898879122, 6043.063325184581, 4494.550544945512, 5218.6868787872845, 5352.598555108382, 5354.759035843396, 5355.732213389315, 26910.865445672844, 27090.458190836074, 27093.729062709317, 27220.0, 27251.727482725117, 2191.3535507025467, 2252.8873556322283, 2254.1884921428273, 2254.4814692620625, 2258.3112150794, 14978.400863965537, 16982.66034679312, 17747.911260443616, 17956.55108622282, 18143.818561814343, 2126.436494329004, 2149.0973791007814, 2186.8797216153107, 2197.5824593327375, 2203.019656252968, 128002.71997280094, 150081.24959375244, 150434.24782876126, 150921.0, 153474.0, 12270.509179632714, 12815.743685126245, 12830.80753788694, 12871.485140594272, 13153.60539183826, 13735.656608584864, 16363.918180409022, 16534.917325413535, 16658.250378732988, 16684.83315166833, 8787.253083487847, 9109.726708198765, 9125.224355929688, 9196.724098277062, 9283.0, 8706.259967902672, 8714.0, 8732.69435569752, 8886.200241978253, 8901.0, 7304.671289791972, 7326.853462930818, 7962.522248665098, 8033.317168040665, 8055.919440805517, 1861.8417434517946, 2122.4375540481783, 2189.8357623178326, 2204.7795220478147, 2214.8338874584147, 801.32288216457, 955.9091886270793, 970.1268858027831, 1010.6967909627083, 1012.9442880641489, 20237.392878213675, 21186.576268474546, 21334.35996920095, 21338.679919801216, 21431.0, 990.5443495991924, 993.4833886379042, 1012.9139023182964, 1026.609888242478, 1029.629333439961, 10369.63706270277, 10499.737506562396, 10830.729231769112, 10878.782424351468, 10892.836607450894, 498457.01542984834, 519264.0, 530043.0, 533821.0, 545476.0, 116198.8380116188, 119325.80674193321, 120380.39809800895, 129362.35318823345, 134292.32853835865, 1098.4123493930708, 1172.6540670502222, 1233.5334685196103, 1243.720162963326, 1252.8935040521476, 20793.54445188883, 21872.562548749254, 21963.670544942157, 22086.889565552712, 22168.889155554763, 39752.403713943735, 56745.0, 57083.71458142683, 58604.0, 60948.781024378375, 78062.0, 78691.0, 79300.0, 80390.0, 80685.0, 7837.1770964047955, 8083.959580202061, 8897.421667591585, 9002.189802917768, 9027.593758280762, 13064.21614703083, 14184.36170372315, 14277.14337139775, 14398.0, 14505.419783208554, 10364.429956352473, 10641.148708103488, 12037.157398981988, 12144.878551214375, 12160.270383777002, 11088.833667494833, 11164.274322169033, 11334.716632084264, 11501.884981150417, 11652.475638596114, 10459.738506537398, 10670.19973502006, 10735.89264107349, 10768.730781730519, 11972.0, 8653.091425400242, 8724.214820666171, 8854.335924805795, 9125.45247285165, 9128.908710912805, 11613.012893904113, 11824.881751182378, 11854.525818967144, 11947.044236461235, 12015.558133024093], "value": 10364.589925110633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.7718426459635, 1424.4515861393368, 1438.8705016548508, 1445.0, 1455.621538400016, 11425.143114266422, 11661.183717139782, 11841.0, 11882.762344753111, 11917.344546049964, 11528.827067593971, 11610.535578576868, 11727.0, 11732.882671173285, 11781.823272650896, 2231.665250212465, 2420.7775073587813, 2520.8991640334366, 2565.371483986426, 2574.87125643718, 2132.722746043012, 2456.6437866509345, 2503.8482298142876, 2509.962350564743, 2519.2694118705554, 2504.198656429943, 2509.5357358888573, 2512.723600403954, 2534.847909125449, 2538.390786211305, 2482.640017197505, 2511.3972646564785, 2515.4843257132243, 2516.6854143232094, 2517.7608127227886, 2444.8899799509063, 2499.287703004653, 2517.1064272183476, 2560.2319304208663, 2566.47387285606, 11808.996235320008, 11870.287782733063, 11901.464434100486, 11919.702007449796, 11926.701832454171, 6605.636689982049, 6783.389494945429, 6860.0738900248825, 6874.106366172416, 6880.0, 3948.1314110895846, 4236.4704411948505, 4324.567543245682, 4348.2607956647125, 4354.107407981356, 1213.1447329632588, 1219.2257916223173, 1278.8401449818773, 1283.7881749511319, 1288.0854593238812, 15198.620034499116, 15681.607959801097, 16319.755203671955, 16594.253258603272, 16620.418285359956, 5454.7272636368025, 5535.169724541271, 5712.257406537124, 5764.0, 5766.481016708516, 11263.042641375574, 11636.476358563885, 11804.70488237801, 11816.35010074437, 11822.0, 6485.4811615070685, 6569.0, 6574.506911981621, 6580.76967306142, 6590.340965903467, 6129.570930034944, 6180.938190618036, 6278.748850046039, 6279.843003924847, 6309.526785491106, 3786.772793632391, 4269.5516970718245, 4429.512753597101, 4432.667549933768, 4466.977665111719, 1081.789051135021, 1289.4777615065914, 1290.9031822613342, 1307.8626744191913, 1309.3584143769485, 799.7360870912585, 804.5414113955106, 823.333100188837, 828.9751307460785, 857.1171693156059, 5342.5993050521365, 6001.4298641628975, 6160.969195154085, 6279.497640188774, 6280.560360774702, 598.5510866849862, 599.8830228105478, 618.3692633513791, 629.3989240275525, 631.0534198701947, 3567.9643203568153, 3908.042529580271, 3931.8427262909163, 4062.431259623655, 4102.979485102615, 12716.491340346283, 14566.0, 14573.92713036428, 14808.3336249869, 15106.471273505374, 14515.350189419261, 14832.258387080603, 14848.62878428048, 15054.247287635575, 15192.772108418383, 8066.959665201636, 8336.458130221516, 8435.072142064368, 8463.195996380335, 8529.147085291544, 6424.614523128627, 7017.2631873652535, 7132.072830531998, 7163.426925845815, 7267.837146056606, 13238.338083096, 13342.599722008355, 13394.866051339362, 13408.798868017182, 13418.93290533541, 10729.731756705833, 13775.242361670204, 13792.724145517233, 13820.654483637989, 14047.471455137764, 9162.816743665222, 9216.07839216073, 9221.123993220634, 9252.21356184705, 9421.199198067967, 10558.577656893638, 10672.519736612026, 10674.35953842772, 10702.0, 10734.248602597743, 8786.341024423065, 9049.457032578066, 9074.546272686208, 9082.772930676785, 9125.680601178927, 7933.60331983387, 8051.718189863327, 8765.386422950332, 8826.470411775314, 8945.105489451003, 8183.0, 8194.303484203909, 8208.302294304813, 8294.792630184294, 8296.958515207385, 5615.129654903333, 5643.88712225745, 5654.7455364509515, 5893.852653683521, 6133.815985520441, 5744.942550574608, 6126.66303353302, 6256.468200202851, 6275.090111933653, 6403.615783053032], "value": 5289.146354406227, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.59053859677164, 390.61329284008804, 398.5337155528032, 406.2383031815346, 414.4218814753418, 5395.839894422703, 6179.351168127349, 6236.251649802019, 6282.308946015934, 6332.873342533158, 5684.857878553038, 6098.39016098391, 6251.937480625193, 6272.3100458949475, 6272.623642581449, 4441.378207051015, 4545.0000999779995, 4547.567981041812, 4552.157850797605, 4578.198815207342, 4327.0047888985555, 4535.410396648431, 4546.29532422475, 4553.4763502197175, 4559.430071241095, 4168.166366726667, 4514.187446259688, 4528.298113792351, 4531.456225252974, 4535.342375355572, 3365.8990230292884, 4271.765052922088, 4303.956960430402, 4508.323751437278, 4541.114482675879, 3209.903702888917, 3864.091938394475, 3873.9225215495812, 3880.0, 3884.7280690351686, 5807.622504537191, 6111.363738575585, 6118.174046503709, 6124.846878828021, 6134.17188679527, 4550.544945505456, 4717.315989181549, 5067.037262920034, 5397.731533089721, 5469.535089517396, 4911.852644420673, 5494.395616482184, 6166.0, 6435.549511534195, 6677.565958212701, 3511.122219445139, 4172.624463798243, 4367.366731823868, 4385.473743150842, 4403.405540252057, 6814.897776533356, 6893.586384816927, 6935.237123916365, 6996.0, 7127.964360178166, 4013.7190396671954, 4213.494380674339, 4445.355423463644, 4455.242608756519, 4464.933026004613, 3989.3617021276455, 4063.9796801015805, 4126.184478829306, 4529.547045295444, 4541.046380260116, 4511.413516242867, 5067.949320506821, 5435.83692489226, 5542.63972841764, 5718.7426565804635, 6740.460763139035, 6745.313671582105, 6754.155730533684, 6760.763373281911, 6775.220849602359, 1566.8354822743677, 1662.7339625659836, 1765.143905205974, 1766.0992893624343, 1771.973420398695, 1131.8472006279046, 1194.1402190422882, 1204.8072308430785, 1224.2960297828783, 1238.4179435665224, 5782.59521833476, 5916.615419997686, 6426.8714625707225, 6458.515611329075, 6489.1888513935755, 6354.586951848115, 6684.1978962523835, 6855.348741869514, 6915.965420172867, 7046.43628509718, 6207.162033125561, 6407.519436042316, 6433.292337842833, 6437.195350581177, 6515.57648752839, 3294.225856923621, 3570.5744010841895, 3586.7668601540818, 3627.3289441453417, 3648.8540458381367, 5728.942710572841, 6510.869782604416, 7068.858622827514, 7154.678039488235, 7341.522801017917, 5511.917321240185, 5844.766209351578, 6823.176823176823, 7141.9642901785155, 7188.964055179796, 5898.970505147447, 6194.442500175006, 7007.614581197981, 7078.849911789307, 7092.219855815856, 6195.039768835838, 6482.448991835747, 6905.447564194752, 6928.272531384132, 6958.8956165658565, 5684.857878553069, 5974.761009559569, 6510.707018184098, 6746.561473504403, 6814.522983391115, 6354.428101470705, 7018.192907815666, 7234.385077268491, 7236.529625574321, 7262.782116536512, 3607.1162565171703, 3743.887683369503, 4464.55354464551, 4499.325101234841, 4512.097580483851, 5983.277608687949, 6714.462842972648, 6835.21395039557, 7022.648867556704, 7031.40233080194, 6761.68147211289, 6762.526623136333, 6767.830804229934, 6796.626185559644, 6800.965995169992, 5729.942700572941, 6164.969175154096, 6679.964605486158, 6719.294474080151, 6826.556273842383, 5490.588205884655, 6597.736090556324, 6631.635260060743, 6636.104125942936, 6640.767573134917, 6354.523410744305, 6576.572522786004, 6763.628000460022, 6781.864362712817, 6792.456603471809, 6519.315471875385, 6587.793089315133, 6592.472602191909, 6602.570832895846, 6616.8345791355605], "value": 4830.361806409376, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.0983979864966, 770.6493545436825, 818.9549574773392, 865.8571335729605, 866.4714524140276, 14872.702545949074, 15791.210439478009, 16394.42619508316, 16787.664246715074, 16816.24326905289, 18113.818861811378, 18169.364072257475, 18238.270469181218, 18351.816481835212, 18642.53393665159, 990.9454979976081, 1010.232223510134, 1018.3635227982511, 1019.4291196929743, 1019.5310157327638, 1002.313415310511, 1005.2209537608339, 1007.2697294461493, 1008.3395376028712, 1009.7223263602494, 1051.0750539525206, 1059.7615536504263, 1061.4480470155515, 1061.5170097605571, 1063.6224140430152, 1063.1547919404093, 1064.0795711709354, 1064.1008347945974, 1064.2816099133092, 1065.1532032034552, 773.7949443397448, 784.3019712455919, 787.0869791042363, 787.09877190617, 787.1538096546236, 13829.930850345683, 16693.83306166947, 16923.153842307835, 17249.396271130576, 17250.654986900317, 16776.245068971926, 17032.233549490178, 17037.318507259693, 17359.65280694379, 17603.119844007877, 13610.183388996593, 13769.242691651954, 14070.929645351707, 14074.92962535191, 14107.153570785786, 3467.5665541807275, 3531.5055892175114, 3540.415831387818, 3542.6988705960025, 3546.6453354664586, 116373.41813290965, 126553.36723316417, 129437.35281323627, 129774.0, 137322.0, 13345.866541334657, 13365.331733413484, 13456.461741530426, 13533.323333833467, 13553.25457099869, 24954.625680614805, 25131.371715707253, 25651.486970260492, 25731.228063158134, 25914.87042564775, 7716.729914452967, 7867.409944254204, 7878.960605196938, 7885.250901164381, 7905.762827115081, 3551.200979779529, 3605.9182245326297, 3779.4897688812207, 3886.2227554489214, 3890.358090915024, 4420.491643460979, 4437.400950871655, 4451.688381813242, 4522.706024108423, 4528.50186479487, 756.8297133144998, 851.9062903080656, 949.6818565780403, 952.0146648219198, 958.8130314588727, 646.3988490703597, 661.7584581627672, 678.3826717686882, 682.331315310998, 688.9931100688929, 9945.850812237823, 10079.848802267972, 10517.106045986176, 10968.670939871816, 11945.940270298766, 646.3794757033301, 660.7918505670795, 686.2382755141789, 688.5145972089665, 720.7909706185147, 4075.673946084306, 5518.889622207614, 5555.805546805843, 5601.0, 5828.591998560145, 98496.0, 98656.0, 99593.00406995982, 99795.50102249443, 102622.0, 85062.29875402457, 85522.0, 85962.0, 86831.0, 87311.1268887303, 77030.61484692541, 77212.22787772163, 77720.0, 80013.0, 80858.59570702109, 10158.0, 11930.940345298219, 12445.128840981406, 12988.5454009113, 13333.799992999919, 31632.367352653277, 39753.0, 39910.40134397928, 40449.0, 41015.76952691424, 71374.28625713676, 71723.64138179275, 72534.63732681303, 72723.63638181775, 73966.63016684882, 16391.75412368839, 16513.66972660564, 17153.399631013355, 17160.914195428944, 17226.224819882886, 17782.288708452033, 18285.54286142804, 18565.81434185695, 18649.881007139615, 18760.155792989077, 16299.266533005806, 17366.39217627377, 17651.117444127998, 17696.55758606045, 17745.556361091076, 14300.642483937985, 16808.075555844545, 17178.484645460656, 17192.054437006085, 17232.827671723124, 16398.754018689968, 16445.013299202084, 17286.654266914844, 17371.0, 17463.56341091483, 9253.213476854542, 10717.196210284104, 10797.028267455968, 11208.719782005515, 11402.94298528502, 9470.289728270269, 10621.416056068701, 11433.714157145805, 12248.693782655504, 12319.938400307941], "value": 8372.781083879398, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 112.0, 113.0, 112.0, 131.0, 171.0, 97.0, 166.0, 135.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 150.0, 121.0, 134.0, 132.0, 149.0, 111.0, 140.0, 163.0, 110.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 272.0, 215.0, 263.0, 273.0, 188.0, 270.0, 191.0, 266.0, 280.0], "value": 244.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 58.0, 58.0, 80.0, 56.0, 59.0, 59.0, 68.0, 91.0, 81.0], "value": 68.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 85.0, 79.0, 103.0, 65.0, 81.0, 62.0, 95.0, 116.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 108.0, 90.0, 105.0, 108.0, 136.0, 93.0, 136.0, 137.0], "value": 109.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 150.0, 154.0, 155.0, 99.0, 98.0, 99.0, 97.0, 98.0, 97.0], "value": 120.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 91.0, 92.0, 95.0, 107.0, 147.0, 91.0, 90.0, 94.0], "value": 99.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 49.0, 52.0, 51.0, 53.0, 53.0, 51.0, 50.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 59.0, 65.0, 62.0, 59.0, 55.0, 54.0, 53.0, 57.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 84.0, 83.0, 84.0, 83.0, 100.0, 104.0, 80.0, 82.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 130.0, 158.0, 149.0, 127.0, 151.0, 148.0, 221.0, 142.0], "value": 150.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 189.0, 184.0, 180.0, 181.0, 183.0, 186.0, 180.0, 180.0, 182.0], "value": 183.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 66.0, 66.0, 75.0, 65.0, 66.0, 69.0, 66.0, 70.0], "value": 68.2, "unit": "score"}]}]} 10:51:43 INFO - Return code: 0 10:51:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:51:43 INFO - # TBPL SUCCESS # 10:51:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:51:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:51:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:51:43 INFO - 2017-05-04 10:51:43.421 screenresolution[1662:10979] starting screenresolution argv=screenresolution get 10:51:43 INFO - 2017-05-04 10:51:43.424 screenresolution[1662:10979] Display 0: 1600x1200x32@60 10:51:43 INFO - 2017-05-04 10:51:43.429 screenresolution[1663:10982] starting screenresolution argv=screenresolution list 10:51:43 INFO - Available Modes on Display 0 10:51:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:51:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:51:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:51:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:51:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:51:43 INFO - Intel Iris: 10:51:43 INFO - Chipset Model: Intel Iris 10:51:43 INFO - Type: GPU 10:51:43 INFO - Bus: Built-In 10:51:43 INFO - VRAM (Dynamic, Max): 1536 MB 10:51:43 INFO - Vendor: Intel (0x8086) 10:51:43 INFO - Device ID: 0x0a2e 10:51:43 INFO - Revision ID: 0x0009 10:51:43 INFO - Displays: 10:51:43 INFO - Display: 10:51:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:51:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:51:43 INFO - Display Serial Number: 1600x1200 60 10:51:43 INFO - Main Display: Yes 10:51:43 INFO - Mirror: Off 10:51:43 INFO - Online: Yes 10:51:43 INFO - Rotation: Supported 10:51:43 INFO - Return code: 0 10:51:43 INFO - Running post-action listener: _resource_record_post_action 10:51:43 INFO - [mozharness: 2017-05-04 17:51:43.664365Z] Finished run-tests step (success) 10:51:43 INFO - Running post-run listener: _resource_record_post_run 10:51:43 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38374400; Write bytes: 512262144; Read time: 384; Write time: 1926 10:51:43 INFO - TinderboxPrint: CPU usage
54.2% 10:51:43 INFO - TinderboxPrint: I/O read bytes / time
38,374,400 / 384 10:51:43 INFO - TinderboxPrint: I/O write bytes / time
512,262,144 / 1,926 10:51:43 INFO - TinderboxPrint: CPU idle
2,198.9 (45.8%) 10:51:43 INFO - TinderboxPrint: CPU system
966.6 (20.1%) 10:51:43 INFO - TinderboxPrint: CPU user
1,632.0 (34.0%) 10:51:43 INFO - TinderboxPrint: Swap in / out
247,066,624 / 0 10:51:43 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204687872; Write bytes: 206079488; Read time: 16434; Write time: 588 10:51:43 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36371456; Write bytes: 299371008; Read time: 362; Write time: 1312 10:51:44 INFO - Running post-run listener: _upload_blobber_files 10:51:44 INFO - Blob upload gear active. 10:51:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:51:44 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 10:51:44 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'] 10:51:44 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 10:51:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:45 INFO - (blobuploader) - INFO - Done attempting. 10:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:46 INFO - (blobuploader) - INFO - Done attempting. 10:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:47 INFO - (blobuploader) - INFO - Done attempting. 10:51:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:51:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:51:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:51:50 INFO - (blobuploader) - INFO - Done attempting. 10:51:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:51:50 INFO - Return code: 0 10:51:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:51:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:51:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0434cc128fb0cac44930ec8cf9f46f69f5a24b0ac41e905c9c42e07ed78d8505135f9bad4cc5176d9050966a1fa1fe4c226e868cd66f4710790f34949dec886f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2504a15700ec9343818efbf45fba40bf258ed3387922a0d0caae904695de08f8d5360f0e3c50320196d3ceb6a058597a1410b46a3b01195d10e8aa0fc323420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f472d7bf8d8691856b8aa820484e100367526114c0e5025efd29f6137dc5b81f958e0c0a27f268e9aa948596e8cdcdd309216ca3a61889264504da4105d710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e84864a47bd3520ee3ce0437687fba13158365ca8c537826eaef33b915a9cfa7f857e5fed483ade67831ff48cf9d767c03489b5baca4f4fade247f15ba3224d"} 10:51:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:51:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:51:50 INFO - Contents: 10:51:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0434cc128fb0cac44930ec8cf9f46f69f5a24b0ac41e905c9c42e07ed78d8505135f9bad4cc5176d9050966a1fa1fe4c226e868cd66f4710790f34949dec886f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2504a15700ec9343818efbf45fba40bf258ed3387922a0d0caae904695de08f8d5360f0e3c50320196d3ceb6a058597a1410b46a3b01195d10e8aa0fc323420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f472d7bf8d8691856b8aa820484e100367526114c0e5025efd29f6137dc5b81f958e0c0a27f268e9aa948596e8cdcdd309216ca3a61889264504da4105d710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e84864a47bd3520ee3ce0437687fba13158365ca8c537826eaef33b915a9cfa7f857e5fed483ade67831ff48cf9d767c03489b5baca4f4fade247f15ba3224d"} 10:51:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:51:50 INFO - Copying logs to upload dir... 10:51:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:51:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.051495 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-04 10:51:49.929638) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:49.933593) ========= 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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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/0434cc128fb0cac44930ec8cf9f46f69f5a24b0ac41e905c9c42e07ed78d8505135f9bad4cc5176d9050966a1fa1fe4c226e868cd66f4710790f34949dec886f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2504a15700ec9343818efbf45fba40bf258ed3387922a0d0caae904695de08f8d5360f0e3c50320196d3ceb6a058597a1410b46a3b01195d10e8aa0fc323420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f472d7bf8d8691856b8aa820484e100367526114c0e5025efd29f6137dc5b81f958e0c0a27f268e9aa948596e8cdcdd309216ca3a61889264504da4105d710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e84864a47bd3520ee3ce0437687fba13158365ca8c537826eaef33b915a9cfa7f857e5fed483ade67831ff48cf9d767c03489b5baca4f4fade247f15ba3224d"} build_url:https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011586 build_url: 'https://queue.taskcluster.net/v1/task/UKwPqB0bT7Sv__eK7PXgDQ/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/0434cc128fb0cac44930ec8cf9f46f69f5a24b0ac41e905c9c42e07ed78d8505135f9bad4cc5176d9050966a1fa1fe4c226e868cd66f4710790f34949dec886f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b2504a15700ec9343818efbf45fba40bf258ed3387922a0d0caae904695de08f8d5360f0e3c50320196d3ceb6a058597a1410b46a3b01195d10e8aa0fc323420", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3f472d7bf8d8691856b8aa820484e100367526114c0e5025efd29f6137dc5b81f958e0c0a27f268e9aa948596e8cdcdd309216ca3a61889264504da4105d710", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e84864a47bd3520ee3ce0437687fba13158365ca8c537826eaef33b915a9cfa7f857e5fed483ade67831ff48cf9d767c03489b5baca4f4fade247f15ba3224d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:49.973043) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:49.973391) ========= 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.dkf1SZKf1j/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.jm1JY2ILW2/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.005423 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 10:51:50.022199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:51:50.022594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 10:51:50.022991) ========= ========= Total master_lag: 0.01 =========