builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1485790462.82 results: success (0) buildid: 20170130061443 builduid: 17e14983f42e46dba2756560ec1bbaac revision: 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:22.817853) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:22.818324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:22.818699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:22.844581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:22.844928) ========= 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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-01-30 07:34:22-- 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% 19.6M=0.001s 2017-01-30 07:34:22 (19.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:23.007528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:23.007888) ========= 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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.025760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:23.059370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 07:34:23.060036) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-01-30 07:34:23,169 truncating revision to first 12 chars 2017-01-30 07:34:23,169 Setting DEBUG logging. 2017-01-30 07:34:23,169 attempt 1/10 2017-01-30 07:34:23,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1d9713abc2cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-30 07:34:24,407 unpacking tar archive at: mozilla-aurora-1d9713abc2cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510785 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-30 07:34:24.596296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:24.596666) ========= script_repo_revision: 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:24.597118) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:24.601484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-30 07:34:24.625062) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-30 07:34:24.625490) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:34:24 INFO - MultiFileLogger online at 20170130 07:34:24 in /builds/slave/test 07:34:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:34:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:34:24 INFO - {'append_to_log': False, 07:34:24 INFO - 'base_work_dir': '/builds/slave/test', 07:34:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:34:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:34:24 INFO - 'branch': 'Mozilla-Aurora', 07:34:24 INFO - 'buildbot_json_path': 'buildprops.json', 07:34:24 INFO - 'config_files': ('talos/mac_config.py',), 07:34:24 INFO - 'default_actions': ('clobber', 07:34:24 INFO - 'read-buildbot-config', 07:34:24 INFO - 'download-and-extract', 07:34:24 INFO - 'populate-webroot', 07:34:24 INFO - 'create-virtualenv', 07:34:24 INFO - 'install', 07:34:24 INFO - 'run-tests'), 07:34:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:34:24 INFO - 'download_minidump_stackwalk': True, 07:34:24 INFO - 'download_symbols': 'ondemand', 07:34:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:34:24 INFO - 'tooltool.py': '/tools/tooltool.py', 07:34:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:34:24 INFO - '/tools/misc-python/virtualenv.py')}, 07:34:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:34:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:34:24 INFO - 'installer_path': 'installer.exe', 07:34:24 INFO - 'log_level': 'info', 07:34:24 INFO - 'log_name': 'talos', 07:34:24 INFO - 'log_to_console': True, 07:34:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:34:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:34:24 INFO - 'opt_config_files': (), 07:34:24 INFO - 'pip_index': False, 07:34:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:24 INFO - 'cmd': ('bash', 07:34:24 INFO - '-c', 07:34:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:24 INFO - 'enabled': True, 07:34:24 INFO - 'halt_on_failure': False, 07:34:24 INFO - 'name': 'check_screen_resolution'},), 07:34:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:34:24 INFO - 'cmd': ('bash', 07:34:24 INFO - '-c', 07:34:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:34:24 INFO - 'enabled': True, 07:34:24 INFO - 'halt_on_failure': False, 07:34:24 INFO - 'name': 'check_screen_resolution'},), 07:34:24 INFO - 'run_cmd_checks_enabled': True, 07:34:24 INFO - 'sps_profile': False, 07:34:24 INFO - 'sps_profile_interval': 0, 07:34:24 INFO - 'suite': 'dromaeojs', 07:34:24 INFO - 'system_bits': '32', 07:34:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:34:24 INFO - 'title': 't-yosemite-r7-0309', 07:34:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:34:24 INFO - 'use_talos_json': True, 07:34:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:34:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:34:24 INFO - 'work_dir': 'build'} 07:34:24 INFO - [mozharness: 2017-01-30 15:34:24.840672Z] Running clobber step. 07:34:24 INFO - Running pre-action listener: _resource_record_pre_action 07:34:24 INFO - Running main action method: clobber 07:34:24 INFO - rmtree: /builds/slave/test/build 07:34:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:34:27 INFO - Running post-action listener: _resource_record_post_action 07:34:27 INFO - [mozharness: 2017-01-30 15:34:27.271646Z] Finished clobber step (success) 07:34:27 INFO - [mozharness: 2017-01-30 15:34:27.271840Z] Running read-buildbot-config step. 07:34:27 INFO - Running pre-action listener: _resource_record_pre_action 07:34:27 INFO - Running main action method: read_buildbot_config 07:34:27 INFO - Using buildbot properties: 07:34:27 INFO - { 07:34:27 INFO - "project": "", 07:34:27 INFO - "product": "firefox", 07:34:27 INFO - "script_repo_revision": "production", 07:34:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:34:27 INFO - "repository": "", 07:34:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:34:27 INFO - "buildid": "20170130061443", 07:34:27 INFO - "pgo_build": "False", 07:34:27 INFO - "basedir": "/builds/slave/test", 07:34:27 INFO - "buildnumber": 82, 07:34:27 INFO - "slavename": "t-yosemite-r7-0309", 07:34:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 07:34:27 INFO - "platform": "yosemite_r7", 07:34:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:34:27 INFO - "branch": "mozilla-aurora", 07:34:27 INFO - "repo_path": "releases/mozilla-aurora", 07:34:27 INFO - "revision": "1d9713abc2cfcbbb8e1724dbb55b07efab093e17", 07:34:27 INFO - "stage_platform": "macosx64", 07:34:27 INFO - "builduid": "17e14983f42e46dba2756560ec1bbaac", 07:34:27 INFO - "slavebuilddir": "test" 07:34:27 INFO - } 07:34:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:34:27 INFO - Running post-action listener: _resource_record_post_action 07:34:27 INFO - [mozharness: 2017-01-30 15:34:27.275314Z] Finished read-buildbot-config step (success) 07:34:27 INFO - [mozharness: 2017-01-30 15:34:27.275422Z] Running download-and-extract step. 07:34:27 INFO - Running pre-action listener: _resource_record_pre_action 07:34:27 INFO - Running main action method: download_and_extract 07:34:27 INFO - mkdir: /builds/slave/test/build/tests 07:34: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')]} 07:34:27 INFO - trying https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:34:27 INFO - Downloading https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:34:28 INFO - Downloaded 1199 bytes. 07:34:28 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:34:28 INFO - Using the following test package requirements: 07:34:28 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:34:28 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:34:28 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:34:28 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'jsshell-mac.zip'], 07:34:28 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:34:28 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:34:28 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:34:28 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:34:28 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:34:28 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:34:28 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:34:28 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:34:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:34:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:34:28 INFO - Fetch https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:34:29 INFO - Expected file size: 16351759 07:34:29 INFO - Obtained file size: 16351759 07:34:35 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:34:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:34:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:34:35 INFO - Fetch https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:34:36 INFO - Expected file size: 16351759 07:34:36 INFO - Obtained file size: 16351759 07:34:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:34:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:34:43 INFO - Fetch https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:34:43 INFO - Expected file size: 14403485 07:34:43 INFO - Obtained file size: 14403485 07:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:44 INFO - trying https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:34:46 INFO - Downloaded 73869667 bytes. 07:34:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:34:46 INFO - mkdir: /builds/slave/test/properties 07:34:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:46 INFO - Contents: 07:34:46 INFO - build_url:https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:34:47 INFO - Running post-action listener: _resource_record_post_action 07:34:47 INFO - Running post-action listener: set_extra_try_arguments 07:34:47 INFO - [mozharness: 2017-01-30 15:34:47.449658Z] Finished download-and-extract step (success) 07:34:47 INFO - [mozharness: 2017-01-30 15:34:47.449815Z] Running populate-webroot step. 07:34:47 INFO - Running pre-action listener: _resource_record_pre_action 07:34:47 INFO - Running main action method: populate_webroot 07:34:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:47 INFO - '--tppagecycles', 07:34:47 INFO - '7'], 07:34:47 INFO - 'tests': ['tsvgm']}}, 07:34:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['damp', 'tps']}, 07:34:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'tests': ['damp', 'tps']}, 07:34:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['dromaeo_dom']}, 07:34:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['basic_compositor_video']}, 07:34:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['a11yr', 07:34:47 INFO - 'ts_paint', 07:34:47 INFO - 'tpaint', 07:34:47 INFO - 'sessionrestore', 07:34:47 INFO - 'sessionrestore_no_auto_restore', 07:34:47 INFO - 'tabpaint']}, 07:34:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['tsvgx', 07:34:47 INFO - 'tsvgr_opacity', 07:34:47 INFO - 'tart', 07:34:47 INFO - 'tscrollx', 07:34:47 INFO - 'cart', 07:34:47 INFO - 'tsvg_static']}, 07:34:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:47 INFO - 'tsvgr_opacity', 07:34:47 INFO - 'tart', 07:34:47 INFO - 'tscrollx', 07:34:47 INFO - 'cart', 07:34:47 INFO - 'tsvg_static']}, 07:34:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'talos_options': ['--disable-e10s'], 07:34:47 INFO - 'tests': ['tp5o']}, 07:34:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'talos_options': ['--disable-e10s', 07:34:47 INFO - '--xperf_path', 07:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:47 INFO - 'tests': ['tp5n']}, 07:34:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:47 INFO - 'talos_options': ['--xperf_path', 07:34:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:47 INFO - 'tests': ['tp5n']}}, 07:34:47 INFO - 'talos.zip': {'path': '', 07:34:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:47 INFO - Running post-action listener: _resource_record_post_action 07:34:47 INFO - [mozharness: 2017-01-30 15:34:47.468887Z] Finished populate-webroot step (success) 07:34:47 INFO - [mozharness: 2017-01-30 15:34:47.469004Z] Running create-virtualenv step. 07:34:47 INFO - Running pre-action listener: _resource_record_pre_action 07:34:47 INFO - Running main action method: create_virtualenv 07:34:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:47 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 07:34:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:47 INFO - Using real prefix '/tools/python27' 07:34:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:51 INFO - Installing pip.................done. 07:34:51 INFO - Return code: 0 07:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:51 INFO - Reading from file tmpfile_stdout 07:34:51 INFO - Output received: 07:34:51 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) 07:34:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:34:51 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 07:34:51 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 07:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:51 INFO - 'HOME': '/Users/cltbld', 07:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:51 INFO - 'LOGNAME': 'cltbld', 07:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:51 INFO - 'MOZ_NO_REMOTE': '1', 07:34:51 INFO - 'NO_EM_RESTART': '1', 07:34:51 INFO - 'PAGER': '/bin/cat', 07:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:51 INFO - 'PWD': '/builds/slave/test', 07:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:51 INFO - 'SHELL': '/bin/bash', 07:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:34:51 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:51 INFO - 'USER': 'cltbld', 07:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:51 INFO - 'XPC_FLAGS': '0x0', 07:34:51 INFO - 'XPC_SERVICE_NAME': '0', 07:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:51 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 07:34:51 INFO - Cleaning up... 07:34:51 INFO - Return code: 0 07:34:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:51 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:34:51 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 07:34:51 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 07:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:51 INFO - 'HOME': '/Users/cltbld', 07:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:51 INFO - 'LOGNAME': 'cltbld', 07:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:51 INFO - 'MOZ_NO_REMOTE': '1', 07:34:51 INFO - 'NO_EM_RESTART': '1', 07:34:51 INFO - 'PAGER': '/bin/cat', 07:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:51 INFO - 'PWD': '/builds/slave/test', 07:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:51 INFO - 'SHELL': '/bin/bash', 07:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:34:51 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:51 INFO - 'USER': 'cltbld', 07:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:51 INFO - 'XPC_FLAGS': '0x0', 07:34:51 INFO - 'XPC_SERVICE_NAME': '0', 07:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:51 INFO - Downloading/unpacking psutil>=3.1.1 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:55 INFO - Installing collected packages: psutil 07:34:55 INFO - Running setup.py install for psutil 07:34:55 INFO - building 'psutil._psutil_osx' extension 07:34:55 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 07:34:56 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 07:34:56 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 07:34:56 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 07:34:56 INFO - building 'psutil._psutil_posix' extension 07:34:56 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 07:34:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:56 INFO - ^ 07:34:56 INFO - 1 warning generated. 07:34:56 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 07:34:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:56 INFO - Successfully installed psutil 07:34:56 INFO - Cleaning up... 07:34:56 INFO - Return code: 0 07:34:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34:56 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')]} 07:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 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')]} 07:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:56 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:34:56 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 07:34:56 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 07:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:56 INFO - 'HOME': '/Users/cltbld', 07:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:56 INFO - 'LOGNAME': 'cltbld', 07:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:56 INFO - 'MOZ_NO_REMOTE': '1', 07:34:56 INFO - 'NO_EM_RESTART': '1', 07:34:56 INFO - 'PAGER': '/bin/cat', 07:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:56 INFO - 'PWD': '/builds/slave/test', 07:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:56 INFO - 'SHELL': '/bin/bash', 07:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:34:56 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:56 INFO - 'USER': 'cltbld', 07:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:56 INFO - 'XPC_FLAGS': '0x0', 07:34:56 INFO - 'XPC_SERVICE_NAME': '0', 07:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:56 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 07:34:56 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 07:34:56 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 07:34:56 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 07:34:56 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 07:34:56 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 07:34:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:59 INFO - Installing collected packages: mozsystemmonitor 07:34:59 INFO - Running setup.py install for mozsystemmonitor 07:34:59 INFO - Successfully installed mozsystemmonitor 07:34:59 INFO - Cleaning up... 07:34:59 INFO - Return code: 0 07:34:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:59 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')]} 07:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:59 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')]} 07:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:59 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:34:59 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 07:34:59 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 07:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:59 INFO - 'HOME': '/Users/cltbld', 07:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:59 INFO - 'LOGNAME': 'cltbld', 07:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:59 INFO - 'MOZ_NO_REMOTE': '1', 07:34:59 INFO - 'NO_EM_RESTART': '1', 07:34:59 INFO - 'PAGER': '/bin/cat', 07:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:59 INFO - 'PWD': '/builds/slave/test', 07:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:59 INFO - 'SHELL': '/bin/bash', 07:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:34:59 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:59 INFO - 'USER': 'cltbld', 07:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:59 INFO - 'XPC_FLAGS': '0x0', 07:34:59 INFO - 'XPC_SERVICE_NAME': '0', 07:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:00 INFO - Downloading/unpacking jsonschema==2.5.1 07:35:00 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 07:35:00 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 07:35:00 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 07:35:00 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 07:35:00 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 07:35:00 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 07:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:35:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:35:03 INFO - warning: no files found matching '*.txt' 07:35:03 INFO - no previously-included directories found matching 'build' 07:35:03 INFO - no previously-included directories found matching 'dist' 07:35:03 INFO - no previously-included directories found matching '.git*' 07:35:03 INFO - Installing collected packages: jsonschema, functools32 07:35:03 INFO - Running setup.py install for functools32 07:35:03 INFO - warning: no files found matching '*.txt' 07:35:03 INFO - no previously-included directories found matching 'build' 07:35:03 INFO - no previously-included directories found matching 'dist' 07:35:03 INFO - no previously-included directories found matching '.git*' 07:35:03 INFO - Successfully installed jsonschema functools32 07:35:03 INFO - Cleaning up... 07:35:03 INFO - Return code: 0 07:35:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:03 INFO - 'HOME': '/Users/cltbld', 07:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:03 INFO - 'LOGNAME': 'cltbld', 07:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:03 INFO - 'MOZ_NO_REMOTE': '1', 07:35:03 INFO - 'NO_EM_RESTART': '1', 07:35:03 INFO - 'PAGER': '/bin/cat', 07:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:03 INFO - 'PWD': '/builds/slave/test', 07:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:03 INFO - 'SHELL': '/bin/bash', 07:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:03 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:03 INFO - 'USER': 'cltbld', 07:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:03 INFO - 'XPC_FLAGS': '0x0', 07:35:03 INFO - 'XPC_SERVICE_NAME': '0', 07:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:35:03 INFO - Cleaning up... 07:35:03 INFO - Return code: 0 07:35:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:03 INFO - 'HOME': '/Users/cltbld', 07:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:03 INFO - 'LOGNAME': 'cltbld', 07:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:03 INFO - 'MOZ_NO_REMOTE': '1', 07:35:03 INFO - 'NO_EM_RESTART': '1', 07:35:03 INFO - 'PAGER': '/bin/cat', 07:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:03 INFO - 'PWD': '/builds/slave/test', 07:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:03 INFO - 'SHELL': '/bin/bash', 07:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:03 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:03 INFO - 'USER': 'cltbld', 07:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:03 INFO - 'XPC_FLAGS': '0x0', 07:35:03 INFO - 'XPC_SERVICE_NAME': '0', 07:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:35:03 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 07:35:03 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 07:35:03 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 07:35:03 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 07:35:03 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 07:35:03 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 07:35:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:35:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:35:06 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 07:35:06 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 07:35:06 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 07:35:06 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 07:35:06 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 07:35:06 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 07:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:35:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:07 INFO - Downloading docopt-0.6.1.tar.gz 07:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:35:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:35:07 INFO - Running setup.py install for blobuploader 07:35:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:35:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:35:08 INFO - Running setup.py install for requests 07:35:08 INFO - Running setup.py install for docopt 07:35:08 INFO - Successfully installed blobuploader requests docopt 07:35:08 INFO - Cleaning up... 07:35:08 INFO - Return code: 0 07:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:08 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:08 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 07:35:08 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 07:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:08 INFO - 'HOME': '/Users/cltbld', 07:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:08 INFO - 'LOGNAME': 'cltbld', 07:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:08 INFO - 'MOZ_NO_REMOTE': '1', 07:35:08 INFO - 'NO_EM_RESTART': '1', 07:35:08 INFO - 'PAGER': '/bin/cat', 07:35:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:08 INFO - 'PWD': '/builds/slave/test', 07:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:08 INFO - 'SHELL': '/bin/bash', 07:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:08 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:08 INFO - 'USER': 'cltbld', 07:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:08 INFO - 'XPC_FLAGS': '0x0', 07:35:08 INFO - 'XPC_SERVICE_NAME': '0', 07:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JGIFZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-c2HrNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-OLOi4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Q40EF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-_TLmNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jV_laZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-MwPf9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-GipJLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:09 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-8SCov6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-e9nNkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-p9muAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-lQ_53H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-KgCUgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Zlo_QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-aLDTNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rGq7eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:10 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-JrZ3sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:35:10 INFO - Running setup.py install for manifestparser 07:35:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:35:11 INFO - Running setup.py install for mozcrash 07:35:11 INFO - Running setup.py install for mozdebug 07:35:11 INFO - Running setup.py install for mozdevice 07:35:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:35:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:35:11 INFO - Running setup.py install for mozfile 07:35:11 INFO - Running setup.py install for mozhttpd 07:35:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:35:11 INFO - Running setup.py install for mozinfo 07:35:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:35:11 INFO - Running setup.py install for mozInstall 07:35:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Running setup.py install for mozleak 07:35:12 INFO - Running setup.py install for mozlog 07:35:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Running setup.py install for moznetwork 07:35:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Running setup.py install for mozprocess 07:35:12 INFO - Running setup.py install for mozprofile 07:35:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:35:12 INFO - Running setup.py install for mozrunner 07:35:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Running setup.py install for mozscreenshot 07:35:13 INFO - Running setup.py install for moztest 07:35:13 INFO - Running setup.py install for mozversion 07:35:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:35:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:35:13 INFO - Cleaning up... 07:35:13 INFO - Return code: 0 07:35:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:13 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')]} 07:35:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:13 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')]} 07:35:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:13 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:13 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 07:35:13 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 07:35:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:13 INFO - 'HOME': '/Users/cltbld', 07:35:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:13 INFO - 'LOGNAME': 'cltbld', 07:35:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:13 INFO - 'MOZ_NO_REMOTE': '1', 07:35:13 INFO - 'NO_EM_RESTART': '1', 07:35:13 INFO - 'PAGER': '/bin/cat', 07:35:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:13 INFO - 'PWD': '/builds/slave/test', 07:35:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:13 INFO - 'SHELL': '/bin/bash', 07:35:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:13 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:13 INFO - 'USER': 'cltbld', 07:35:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:13 INFO - 'XPC_FLAGS': '0x0', 07:35:13 INFO - 'XPC_SERVICE_NAME': '0', 07:35:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-AfxG_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:35:13 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)) 07:35:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:35:13 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-NIXon7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-92ZWHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-FQUsgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:35:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-5qCsse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-weD4ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-q_mpp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-B6uURI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tWXOZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ZadbRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:35:14 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)) 07:35:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:35:14 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-6lmYOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fiVA6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tDP8Ni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-eEyeGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tBaiy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-OkUPZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:35:15 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)) 07:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:35:15 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-BaUf8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:35:15 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)) 07:35:15 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)) 07:35:15 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)) 07:35:15 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)) 07:35:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:15 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:35:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:35:18 INFO - Downloading blessings-1.6.tar.gz 07:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:35:18 INFO - Installing collected packages: blessings 07:35:18 INFO - Running setup.py install for blessings 07:35:18 INFO - Successfully installed blessings 07:35:18 INFO - Cleaning up... 07:35:18 INFO - Return code: 0 07:35:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:35:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:19 INFO - Reading from file tmpfile_stdout 07:35:19 INFO - Current package versions: 07:35:19 INFO - blessings == 1.6 07:35:19 INFO - blobuploader == 1.2.4 07:35:19 INFO - docopt == 0.6.1 07:35:19 INFO - functools32 == 3.2.3-2 07:35:19 INFO - jsonschema == 2.5.1 07:35:19 INFO - manifestparser == 1.1 07:35:19 INFO - mozInstall == 1.12 07:35:19 INFO - mozcrash == 1.0 07:35:19 INFO - mozdebug == 0.1 07:35:19 INFO - mozdevice == 0.49 07:35:19 INFO - mozfile == 1.2 07:35:19 INFO - mozhttpd == 0.7 07:35:19 INFO - mozinfo == 0.9 07:35:19 INFO - mozleak == 0.1 07:35:19 INFO - mozlog == 3.4 07:35:19 INFO - moznetwork == 0.27 07:35:19 INFO - mozprocess == 0.24 07:35:19 INFO - mozprofile == 0.28 07:35:19 INFO - mozrunner == 6.13 07:35:19 INFO - mozscreenshot == 0.1 07:35:19 INFO - mozsystemmonitor == 0.3 07:35:19 INFO - moztest == 0.8 07:35:19 INFO - mozversion == 1.4 07:35:19 INFO - psutil == 3.1.1 07:35:19 INFO - requests == 1.2.3 07:35:19 INFO - wsgiref == 0.1.2 07:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:35:19 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')]} 07:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:19 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')]} 07:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:19 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:19 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 07:35:19 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 07:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:19 INFO - 'HOME': '/Users/cltbld', 07:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:19 INFO - 'LOGNAME': 'cltbld', 07:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:19 INFO - 'MOZ_NO_REMOTE': '1', 07:35:19 INFO - 'NO_EM_RESTART': '1', 07:35:19 INFO - 'PAGER': '/bin/cat', 07:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:19 INFO - 'PWD': '/builds/slave/test', 07:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:19 INFO - 'SHELL': '/bin/bash', 07:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:19 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:19 INFO - 'USER': 'cltbld', 07:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:19 INFO - 'XPC_FLAGS': '0x0', 07:35:19 INFO - 'XPC_SERVICE_NAME': '0', 07:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 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)) 07:35:20 INFO - Cleaning up... 07:35:20 INFO - Return code: 0 07:35:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:35:20 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 0x10a3b8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3bb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa29b5935a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, '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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 07:35:20 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 07:35:20 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 07:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:20 INFO - 'HOME': '/Users/cltbld', 07:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:20 INFO - 'LOGNAME': 'cltbld', 07:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:20 INFO - 'MOZ_NO_REMOTE': '1', 07:35:20 INFO - 'NO_EM_RESTART': '1', 07:35:20 INFO - 'PAGER': '/bin/cat', 07:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:20 INFO - 'PWD': '/builds/slave/test', 07:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:20 INFO - 'SHELL': '/bin/bash', 07:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:20 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:20 INFO - 'USER': 'cltbld', 07:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:20 INFO - 'XPC_FLAGS': '0x0', 07:35:20 INFO - 'XPC_SERVICE_NAME': '0', 07:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:35:20 INFO - Cleaning up... 07:35:20 INFO - Return code: 0 07:35:20 INFO - Running post-action listener: _resource_record_post_action 07:35:20 INFO - Running post-action listener: _start_resource_monitoring 07:35:20 INFO - Starting resource monitoring. 07:35:20 INFO - [mozharness: 2017-01-30 15:35:20.862870Z] Finished create-virtualenv step (success) 07:35:20 INFO - [mozharness: 2017-01-30 15:35:20.863786Z] Running install step. 07:35:20 INFO - Running pre-action listener: _resource_record_pre_action 07:35:20 INFO - Running main action method: install 07:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:35:21 INFO - Reading from file tmpfile_stdout 07:35:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:35:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:35:21 INFO - Reading from file tmpfile_stdout 07:35:21 INFO - Output received: 07:35:21 INFO - Usage: mozinstall [options] installer 07:35:21 INFO - Options: 07:35:21 INFO - -h, --help show this help message and exit 07:35:21 INFO - -d DEST, --destination=DEST 07:35:21 INFO - Directory to install application into. [default: 07:35:21 INFO - "/builds/slave/test"] 07:35:21 INFO - --app=APP Application being installed. [default: firefox] 07:35:21 INFO - mkdir: /builds/slave/test/build/application 07:35:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:35:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:35:41 INFO - Reading from file tmpfile_stdout 07:35:41 INFO - Output received: 07:35:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:35:41 INFO - Running post-action listener: _resource_record_post_action 07:35:41 INFO - [mozharness: 2017-01-30 15:35:41.433190Z] Finished install step (success) 07:35:41 INFO - [mozharness: 2017-01-30 15:35:41.433353Z] Running run-tests step. 07:35:41 INFO - Running pre-action listener: _resource_record_pre_action 07:35:41 INFO - Running main action method: run_tests 07:35:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:41 INFO - 2017-01-30 07:35:41.447 screenresolution[1633:7328] starting screenresolution argv=screenresolution get 07:35:41 INFO - 2017-01-30 07:35:41.449 screenresolution[1633:7328] Display 0: 1600x1200x32@60 07:35:41 INFO - 2017-01-30 07:35:41.454 screenresolution[1634:7331] starting screenresolution argv=screenresolution list 07:35:41 INFO - Available Modes on Display 0 07:35:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:41 INFO - Intel Iris: 07:35:41 INFO - Chipset Model: Intel Iris 07:35:41 INFO - Type: GPU 07:35:41 INFO - Bus: Built-In 07:35:41 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:41 INFO - Vendor: Intel (0x8086) 07:35:41 INFO - Device ID: 0x0a2e 07:35:41 INFO - Revision ID: 0x0009 07:35:41 INFO - Displays: 07:35:41 INFO - Display: 07:35:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:41 INFO - Display Serial Number: 1600x1200 60 07:35:41 INFO - Main Display: Yes 07:35:41 INFO - Mirror: Off 07:35:41 INFO - Online: Yes 07:35:41 INFO - Rotation: Supported 07:35:41 INFO - Return code: 0 07:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:41 INFO - Python 2.7.3 07:35:41 INFO - Return code: 0 07:35:41 INFO - grabbing minidump binary from tooltool 07:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:41 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 0x10a196d30>, '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 0x10a0bddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a18bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:41 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 07:35:41 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 07:35:41 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 07:35:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:41 INFO - Return code: 0 07:35:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xxqvhSZnLi/Render', 07:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:41 INFO - 'HOME': '/Users/cltbld', 07:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:41 INFO - 'LOGNAME': 'cltbld', 07:35:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:41 INFO - 'MOZ_NO_REMOTE': '1', 07:35:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:41 INFO - 'NO_EM_RESTART': '1', 07:35:41 INFO - 'PAGER': '/bin/cat', 07:35:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:41 INFO - 'PWD': '/builds/slave/test', 07:35:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:41 INFO - 'SHELL': '/bin/bash', 07:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AZ7UwMXMjC/Listeners', 07:35:41 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 07:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:41 INFO - 'USER': 'cltbld', 07:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:41 INFO - 'XPC_FLAGS': '0x0', 07:35:41 INFO - 'XPC_SERVICE_NAME': '0', 07:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:35:42 INFO - mozversion application_buildid: 20170130061443 07:35:42 INFO - mozversion application_changeset: 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 07:35:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:35:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:42 INFO - mozversion application_name: Firefox 07:35:42 INFO - mozversion application_remotingname: firefox-dev 07:35:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:35:42 INFO - mozversion application_vendor: Mozilla 07:35:42 INFO - mozversion application_version: 53.0a2 07:35:42 INFO - mozversion platform_buildid: 20170130061443 07:35:42 INFO - mozversion platform_changeset: 1d9713abc2cfcbbb8e1724dbb55b07efab093e17 07:35:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:35:42 INFO - mozversion platform_version: 53.0a2 07:35:42 INFO - using testdate: 1485790542 07:35:42 INFO - actual date: 1485790542 07:35:42 INFO - starting webserver on 'localhost:49243' 07:35:42 INFO - SUITE-START | Running 2 tests 07:35:42 INFO - TEST-START | dromaeo_css 07:35:42 INFO - operating with platform_type : mac_ 07:35:42 INFO - Initialising browser for dromaeo_css test... 07:35:42 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmp1AK2Jg/profile http://localhost:49243/getInfo.html) 07:35:44 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 07:35:44 INFO - PROCESS | 1644 | colorDepth:24 07:35:44 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 07:35:44 INFO - PROCESS | 1644 | __metrics 07:35:44 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:44 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:45 INFO - TEST-INFO | 1644: exit 0 07:35:45 INFO - Browser initialized. 07:35:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:45 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmp1AK2Jg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:57 INFO - PROCESS | 1646 | RSS: Main: 213139456 07:35:57 INFO - PROCESS | 1646 | 07:39:00 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 07:39:02 INFO - PROCESS | 1646 | RSS: Main: 339566592 07:39:02 INFO - PROCESS | 1646 | 07:40:47 INFO - PROCESS | 1646 | ************************* 07:40:47 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 07:40:47 INFO - PROCESS | 1646 | 07:40:47 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:40:47 INFO - PROCESS | 1646 | Full stack: 07:40:47 INFO - PROCESS | 1646 | ************************* 07:42:05 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 07:42:05 INFO - PROCESS | 1646 | RSS: Main: 351780864 07:42:05 INFO - PROCESS | 1646 | 07:45:08 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 07:45:08 INFO - PROCESS | 1646 | RSS: Main: 318255104 07:45:08 INFO - PROCESS | 1646 | 07:48:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 07:48:11 INFO - PROCESS | 1646 | RSS: Main: 329641984 07:48:11 INFO - PROCESS | 1646 | 07:51:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 07:51:15 INFO - PROCESS | 1646 | RSS: Main: 309833728 07:51:15 INFO - PROCESS | 1646 | 07:54:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 07:54:19 INFO - PROCESS | 1646 | RSS: Main: 385581056 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | __start_tp_report 07:54:19 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 07:54:19 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 07:54:19 INFO - PROCESS | 1646 | |i|pagename|runs| 07:54:19 INFO - PROCESS | 1646 | |0;dojo.html;3338.2488939988502;3359.66403359664;3371.8145501997396;3385.6614338566146;3395.422778127718;5762.481376676098;5791.507721843648;5811.6803575803315;5816.156657284691;5845.941540584598;5715.3141623005295;5798.217240672508;5801.941980580193;5808.82573522795;5834.708264586775;4329.610335069843;4612.8385506507275;5228.764705588239;5286.550643195333;5323.627346085776;5132.230165475171;5136;5145.25393817898;5259.316288882459;5355.410904800468;5267.420583735786;5297.8940421191555;5318.946810531903;5327.200919862013;5350.117230656937;5319.787208511655;5327.413984461706;5327.46725327468;5340.385855626614;5396.19057141428;5065.696058236481;5185.377754669464;5265.842024739264;5266.447023062561;5291.391489978625;5686.829395118153;5705.572082093818;5766.336871259775;5785.363610002938;5828.06750919855;6222.066689996492;6299.181106456177;6300.180976473075;6302.68486575674;6327.114204011442;5629.408912064216;6202.162708034402;6271.310155882849;6292.182016337847;6322.557420980534;5821.912671309934;5898.8820223595285;5935.525157987437;5952.226210592596;6072.908906366408;6319.684015799192;6382.712777925005;6391.2330520337855;6398.8720225595225;6404.647744374011;6096.512279017668;6260.280067792171;6284.402981716729;6285.214348206474;6293.716782744787;6165.537584681167;6228.532860035515;6241.313455519889;6284.622922624657;6312.621242725451;6220.440160385587;6288.496920246369;6305.054241863665;6308.116863639094;6323.5889667172405;5050.267711181858;6292.056191571301;6294.842628934313;6303.275123360872;6310.305866354697;4242.257604919188;4955.182394904872;5023.09584274834;5026.371703537058;5072.797088116434;4535.727856328631;4542.954570454319;4548.204064288736;4560.749158796231;4573.085382923428;5895.764169433261;5903.2325797646035;5932.58471906971;5934.465898069195;5938.8218353449465;6199.225096862892;6199.721012554446;6207.720652570645;6268.49852011838;6283.717232724538;5805.129230615357;5858.5898987070495;5860.941390586039;5862.853428664317;5906.645601263938;5459.3994660587305;5481.232627432163;5529.336479622471;5529.668219906818;5532.419095994863;6240.906386404116;6303.432691057827;6317.273513545817;6564.704588293538;6634.336566343327;6281.214848143982;6285.402886725754;6304.991201407753;6311.96844015777;6313.116163737172;6391.840203994937;6395.104685343963;6406.903896441464;6413.35866413355;6427.100205971261;6155.907661385172;6220.657863817352;6253.8749225014335;6284.214473190851;6289.465395441256;6173.41352571505;6200.503959683124;6246.9062964054665;6248.68756562161;6281.685915704105;4810.254410566367;6162.291336496181;6204.410580994799;6218.409251121137;6219.502439804895;4913.533214344631;6116.5412594056515;6204.224471941007;6222.968885155546;6227.034809604518;4973.45292017885;5864.853378665567;6078.756849726138;6094;6122.123717501779;6080.148779170831;6154.261488621394;6187.288461826947;6210.472109870531;6247.5939063960695;6083.55169424821;6102.633841969496;6110.908336374869;6124.0201567748945;6131.938680613137 07:54:19 INFO - PROCESS | 1646 | |1;ext.html;415.1945226261053;452.98305304591196;453.75497231494995;500;500.67456153500234;31357.52963705546;40702;42800.57199428005;42981.78509107458;43014.35478467817;43701;44150.33774493385;44244;44250.672479825655;44323;8474.957625211866;9329.860052099208;9510.66712665057;9526.42841429513;9527.523623818815;8414.621342039592;11161;11380.829287560651;11417.54329826806;11574.305541667527;11158.553657853676;11169.944150279278;11175.44122793861;11178.44107794607;11201.383923884183;8486.108958559324;9650.758731031745;11345.26255793375;11431.256968297117;11444.885551144465;8552.871706924401;11071.446427678664;11353;11376.317420954769;11585.478653460614;40945.59054409448;41284;41286.79356603228;41307;41312.58687413117;3461.6884480396634;3947;4013.6387725104883;4063.7155399122075;4231.30183519722;30131;30544.847275763477;31042.379152416826;31153.532697009563;31997.8400107998;2962.4963756161505;3013.9698603014126;3073.247054471669;3120.1263646179104;3124.937501249985;355222.99999999744;355684.22157889046;356416;356695;356705;61345;61750.38249617446;61886.69056654688;62032.37967620356;62111.068333975025;65504;65511.34488655148;65640.67179664072;65761.6847663044;65823;16599;16891.91554042222;16897.831021689624;16928.32286708518;16944.068076255677;11725.941370293265;12027.939860300818;12938.029647776455;13013.609591712264;13022.413991370411;12863.807042894365;17323.48029559115;17571.472855814347;17583.20875560603;17792.91103544474;5649.406812284651;5689.9146512802345;6758.324167583301;6766.69549870257;6789.524733268624;863.9956800215958;866.1425189062783;881.1100788203833;887.1704955866286;913.36064754672;24198;24728.629070563955;25160.74839251584;30885.38229235403;31156.688433115833;1081.9729506762394;1103.9834402483968;1115.8047341715167;1119.2445099557765;1186.2230239193343;15397;15735.44925927587;15755.763663545056;15842.7623585644;16133.515994520183;619635;628068.859655708;633020;638041;639635;62063.75872482525;62214.68892655508;62251.68874155691;62281.37718622756;62353.688231559456;1440.877525410331;1455.1341951538818;1470.7205630930089;1472.874805641511;1476.402057166849;27680;29850;30035.849820750755;30646.693533065274;30672.926447574227;52367.73816130895;52933.47066529285;53098.73450632722;53151;53178;551321;553185;555975;556562.2171889115;557327;40832.1833563333;41565.37651935284;41710.791446042575;41889.79055104705;41958.37062444127;46928.061438771714;47233.76383118062;47703.76148119376;47855;48319.275210871165;38186.42720359141;39556;39622.40566391564;40637.98405039779;40930;38057.23885522219;38650.6134938647;39234.411483828335;40399.3940090893;40601.39097913475;37639.62360376361;38336.80831595824;38639.80680096694;38668.6133138665;38684.80657596694;33582.83208584039;33926.660733393335;34729;34803.82598087095;34839.65160348364;25148;25289.873550632128;25426.618600721373;25779.484410312063;25992.480150396506 07:54:19 INFO - PROCESS | 1646 | |2;jquery.html;370.9870154544588;392.65838720313315;395.0676403687298;400.48537629146546;419.43167008703205;14741.852581474182;16259.34962601496;19635.705464418046;21133.04901279442;21955.231566895163;21334.46663833401;21520.03159857806;22009.779902200975;22146.44633884154;22408.55182896341;4792.353032340642;5777.537796976242;6037.154798328237;6071.757129714806;6134.785282515113;3941.17235380569;6075.513958883301;6122.969385153068;6124.908126378108;6127.938720612781;4134.751914885116;5715.628484148517;5979.431953964367;6010.789622363218;6109.35851735568;5802.12968054791;5877.67672777997;6070.848228794272;6071.544634152457;6093.0555763856455;6022.397760223943;6037.215162028952;6038.607490513103;6046.637201767908;6064.666443345658;13593.184408935396;14815.925920370437;19782.41740660758;25425.745742542524;26061.869690651427;2446.3028037009544;2512.69847618287;2563.2054063240457;2613.9805475864428;2665.520206362854;10186.541605627765;10188.286819922609;10555;12456.501739930392;15904.522864314089;1805.404216608516;1887.4715079777684;1893.867429279951;1896.4500294914596;1902;124118.54141222873;129331;135823.32088339594;138862.30568847092;140104.29947850297;11403.657890263139;11540;11864.169508134348;11924.284542927453;11947.701307467383;14991.250437478082;15033.774493382609;15066.246687665793;15570.676492498038;15679.05925644465;8679.045305016443;8767.868481972775;8769.517676527725;8875.467471951704;8877.556122193864;8529;8536.829263414696;8538.914610853812;8692.869606955901;8694.608862581956;4606.930896036562;4674.672772905864;4806.014766972762;4811.446683631357;4846.200376937836;2014.9194032238547;2054.096197673019;2058.5985732781965;2061.690746388054;2063.8658487198286;953.4374718915873;956.3496822160859;994.125169850527;998.4159266828841;999.605155963405;21132;21815.141607321555;23926.52146957051;24086.63870041951;24329.148479803123;939.6570251858022;1059.0891833023593;1060.3213943076437;1060.9946950265198;1083.9729006774735;10892.237543371888;10945.945270273756;11452.198346115858;11477.655670329903;11491.310521368745;424353;617195;621159;640272;782857;121879.54480711256;148854;152622;154895.22552387166;162901.36728005376;977.7066879935991;994.9950549944608;1029.130384824822;1029.315505189041;1032.4837581209395;15482.690346193238;17331.393401230896;19662.132097450718;20308.390748277576;20810;60669;60739.78520429655;61139.69430152821;61464.77070458655;62520.37479625145;89185.55407222922;91755;92709.53645232001;93432;93708;6593.3736295051895;8391.07698153215;8401.621927013177;8677.522736249566;8753.124687531195;12619.179753316004;13509.054366194272;13518.662033448849;13738.931305343409;13825.792613111013;10134.543945522322;11322.716932076764;11493.885061149282;11917.16579839403;11950;11104.666859994213;11373.20387572895;11412.258203216765;11490.655280341603;11729;11613;11633.41832908368;11682.94158529202;12072.456739446921;12128.93935530352;7304.4156467483535;7569.697212111454;7677.30904218623;7876.291133797986;8713.041565427924;10267.58929642806;11533.250338727956;11637.476313565741;11881.287122772315;11976.341301228516 07:54:19 INFO - PROCESS | 1646 | |3;mootools.html;1221.7067903703112;1458.1469840143516;1477.5198060630291;1480.6816534445093;1483.7403454395478;8188.181181881816;8610.138986101387;8619;8630.007549131851;8630.784230394243;7528.021357223567;7833.843323133534;7849.058113026431;7979.52122872628;8271.25558699717;2268.5803126421665;2332.463533387322;2337.439014636492;2337.7077865266842;2338.5322935412987;2307.4923516826357;2348.6946696929376;2363.361892289081;2363.7872591466767;2364.84628499147;2056.9897150514225;2144.0994782191437;2235.284708893155;2302.5855346037706;2321.45623160598;2332.696749422573;2342.543204075206;2343.4492894169857;2345.835791494596;2346.9061237550563;2283;2332.2187067332293;2334.323046316566;2364.47981444082;2367.9052837886466;8355.415120941536;8442.493450392996;8464;8466.280366168883;8472.15278472154;5051.797928082872;5204.453532379083;5208.088584497697;5214.06146893559;5220.895582088375;3235.126515840733;3402.4726167444087;3444.2078321986082;3496.3881320768764;3533.152043509565;1126.718320419895;1172.7537217184401;1209.9637010889687;1211.7515909238584;1232.9383530823422;10427.843582346195;10817.675469735921;11029;11045.171612129043;11065.391403472806;4548.658850586219;4686.36734040907;4739.123262196505;4739.265413860857;4742.264948932921;9702.51487425626;9715.70852874415;9716.854247186298;9736.805263894683;9738.561764720605;4647.95352046482;5099.821506247264;5240.475952404805;5241.528262456321;5253.001929633358;4653.418322709661;4764.618830493552;4806.975965120152;4859;4869.780859861315;3728.9440658389603;3807.8667246646232;3834.3481608126685;3873.4770805941403;3895.4156876468755;1052.578968412641;1244.7386048929827;1245.7508498300376;1260.6785269756153;1262.2741923394085;743.5055687967441;752.7139686918936;778.2956424435781;785.8389030248785;789.4292049036131;5402.432744561765;5557.833265001976;5600.4959553640365;5630.60585758993;5646.689432081275;557.946995035471;578.6383510306059;593.4154857465393;938.3009657804979;966.8929076207843;2943.2788966703297;3621.6921561667555;3697.141801957384;3712.424574191005;3789.692556068152;9850.753731156778;9880.110790028932;10167.7458063549;10185.694429166988;10219.080282774587;9840.753981150528;9880.65417710391;9992.700218993441;10130.898691012995;10177.18582513397;7355.7057717690695;7682.961585192038;7742.380609551223;7932.643031063616;7943.682252709827;5496.780128794963;5621.269234999424;5732.828015159552;5811.94188058114;5814.883702326015;8996.775080623036;9099.49952752605;9243.953780231055;9303.302252331237;9478.95260523693;8189.7133600323705;8330.625121869653;9356.766080848034;9563.952180239054;9690.224782017282;7218.097737782778;7376.594287314249;7383.667734952048;7385.150707668472;7394.519356241827;7610.200928902607;7687.846243075219;7872.685092596232;7896.605169741605;7900.525968441912;7097.0064191014335;7159.212486626363;7161.641917904188;7205.639718014183;7226.494145409771;6992.2308546058875;7104.431645468247;7106.680199390937;7201.6399180041835;7214.89177662325;6435.356464353527;6445.742170313135;6451.290358060516;6518.413342799171;6609.372109649576;4362.25841606934;4427.380166776718;4869.780859861244;4893.388326459192;4974.328465657235;5086.720230387365;5093.6943783371635;5169.7673604687125;5178.533931946143;5192.922106168486 07:54:19 INFO - PROCESS | 1646 | |4;prototype.html;348.24778478486473;356.4830995057168;359.917219039621;371.20747204717935;372.0865275748039;5242.895142097156;5250.6324557281005;5273.630845840793;5301.867453313669;5328.573714102872;4153.276390298022;4891.804327826882;5020.723860187688;5059.721715305656;5259.894802103956;3342.5988881334274;3736.626337366262;3777.6411240932066;4016.518017837849;4049.6355328020472;3917.7071566383024;4072.7846678687565;4102.794860256975;4122.525909520398;4166.9791651041705;3934.075492259317;4066.9186616267807;4089.9182016359655;4106.815193316293;4109.445224894631;3743.270062337845;3792.5019617251305;4120.608542188487;4134.896627584304;4138.6482149017365;3318.257914594833;3577.6422357764277;3665.1936573953953;3677.8528858845616;3679.172186258097;4280.807363668642;5098.847034588968;5117.257997590365;5132.101882170605;5140.228965655144;3851.940716303011;3978.880633580968;4748.4539277982785;4766.523347665206;4775.832845850413;5109.390541979302;5536.806211782608;5568.99758043552;5575.006867617328;5581.6930068846195;3985.900352491182;4091.2431200227757;4094.529129150156;4101.349798679178;4116.279651061052;4392.912141757179;5032.798688052437;5180.642807522569;5181.082999290286;5766.452187042266;4060.796960151981;4065.7560546367313;4085.7957102144774;4098.446709694213;4114.547399786021;4124.793760311973;4129.194807012604;4145.657703397631;4170.70805043644;4179.749215047107;4432.3351497275025;4680.438347398334;4685.81256749733;4726.456457507362;4780;4402.471703395613;5263.973680131575;5522.22688823565;5539.72586305144;5561.332640083216;1234.9876501234874;1303.6767680803991;1320.5576131995888;1357.4095268558208;1376.8416632087237;798.5448294472095;810.1412502746989;840.0175585617936;842.8705534583687;947.5833628725101;4123.731957422758;4192.909843440666;4371.584699453547;4842.8619274470475;4893.311807426432;5243.790248390022;5272.472752724697;5276.287701160294;5293.470652934753;5318.468153184651;4142.171565686875;4328.458942632171;4481.3726078349055;4746.525347465225;4769.35613692154;2333.906643734266;2651.3504191472825;2654.9469010619678;2758.089830355978;2766.879413837399;4882.5605695486865;5225;5369.087255166631;5433.701146436905;5476.741338903346;5075.543201111917;5369.946300536944;5376.064616737971;5397.920415916832;5430.728463576885;4934.136526107988;5453.672779633234;5463.31708536433;5558.249636299048;5558.277423934863;4991.9500804991485;5243.1200911326105;5252.238425428368;5267.235476115544;5268.367795864521;5028.899422011613;5103.617228707788;5635.492805647511;5642.60501764889;5667.8866422672145;5199.66202196856;5824.912626310694;5866.911996319973;5909.674967876808;5926.762364909111;3570.553680789901;3853.3064048470424;3854.9545858771257;3893.8831835044994;3904.629060239273;5280.339957505312;5331.813386531453;5696.287964004499;5705.800296989585;5728.596493859031;4989.675671081368;5444.673319600836;5456.317960254968;5477.1510415885605;5486.780528778804;4629.1898917688595;5267.789288428573;5270.552003079782;5366.6779993200535;5475.4524547544925;4324.78376081201;5141.562967147835;5339.626226164131;5363.597730170331;5377.327834020747;4487.842925497592;4931.5315045070665;5193.76628051731;5232.9534093180755;5335.733213339395;4358.455193100863;5334.573234141182;5362.675141412349;5362.889524075948;5370.62405631602 07:54:19 INFO - PROCESS | 1646 | |5;yui.html;663.5156335874808;663.5653646861305;738.1658725640026;751.6016511249038;763.2329508843611;13154.802677959826;15127.621809454755;15298.31157597908;15788.131652759093;15847.603809904744;14423.495177668783;14429.92785036076;14451.494197703083;14459.20474373909;14556.417743290256;666.8966310221912;692.1866806502339;766.4826242286463;852.7484392104344;856.5973992223676;851.8722191671268;857.8584533551956;863.9179277968583;864.8054187807755;865.3423398217337;902.9819403611924;903.0698380667923;903.0788595632483;904.516083895113;906.3429013964889;698.5878331784221;727.745289148799;900.9684661036865;902.345799295512;902.8961669408004;635.3551145587232;653.1606885152604;656.1535619051418;657.4543129202798;657.6514447342915;15034;15088.849111508964;15090.471833485775;15095.622609434742;15099;12233;12240.449179786841;12312.569060082944;12451.315177665225;12507.49970001208;11215.775684486347;11415.828762568568;11522.884771152265;12045.879541204564;12396.56612018584;4051.1897620476025;4127.876163715094;4166.104287578155;4257.723247988871;4264.296391095466;89112;107500.92499075066;110226;110651;110764.4461777694;9474.478903660365;9561.378510396802;9673.903260967441;9825.213982881352;9928.702138935843;21112.366629001153;21413;21417.89291053566;21447.571048578942;21466.892665536885;7069.116360454943;7186.461015423864;7191.8561628768175;7231.855362892713;7317.378022868116;3918.6277303656107;3919.568847426781;3922.3332033554366;3972.960270397259;3986.681065514752;3368.528406023159;3447.482877568385;3500.4749287606555;3504.1064528545057;3511.525943997579;607.0954278125649;614.7172300741709;618.7494064903722;623.1089541955048;623.8222106699569;505.47430672100603;511.8950615123891;520.8359316926666;521.7130578181984;538.1201735162958;8893.244074253631;8917.821643567093;9281.67514137002;9290.628374865066;9310.487923164292;584.8713283077716;587.5094296262583;599.7421108923118;603.6619493083887;609.3753902250229;4243.745375277494;4408.735475871458;4438.334249862546;4452.732836029849;4459.353393757887;90696;93758;94471;95095.52452237695;99510;83375.16624833795;84458;85430;86565.56717216373;89820.5508972464;48431;64084.67957660275;65628;75645.24354756493;76932.61533692296;10382.273240873066;10653.840192396965;10900.454977251264;10915.345079295268;10924.617638382619;42068.94827629211;42639.7868010658;46468.767656162854;46549;50009.24986125138;53873;57016.429835701114;61868.69065654823;62395;64985.35014649982;12582.748345032865;12643.683907902008;12648.43082061291;12812.245367246087;12865.807012894627;11689.824652630388;14013.229272390117;14216.147031178163;14310.356033978287;14327.850822376728;12872.742545149233;13229.000734056692;13345.66635834112;13412;13788.310584470937;13125.34373281313;13173.538926137539;13197.868021320048;13263.071584989344;13420;12580.87419125797;12756.338923774181;12801.61595152147;13060.412281447549;13201;10833.620823271147;11026.834597480884;11385.601503947322;11470.655880323604;11471.078492349794;10693.94653026761;10716.19628527848;10730.839037414602;10740.033396994308;10769.515371808131 07:54:19 INFO - PROCESS | 1646 | __end_tp_report 07:54:19 INFO - PROCESS | 1646 | __start_cc_report 07:54:19 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1352 07:54:19 INFO - PROCESS | 1646 | __end_cc_report 07:54:19 INFO - PROCESS | 1646 | __startTimestamp1485791659031__endTimestamp 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | ------- Summary: start ------- 07:54:19 INFO - PROCESS | 1646 | Number of tests: 6 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5782.70 Median:6080.15 stddev:675.16 (11.1%) stddev-sans-first:649.43 07:54:19 INFO - PROCESS | 1646 | Values: 3338.2 3359.7 3371.8 3385.7 3395.4 5762.5 5791.5 5811.7 5816.2 5845.9 5715.3 5798.2 5801.9 5808.8 5834.7 4329.6 4612.8 5228.8 5286.6 5323.6 5132.2 5136.0 5145.3 5259.3 5355.4 5267.4 5297.9 5318.9 5327.2 5350.1 5319.8 5327.4 5327.5 5340.4 5396.2 5065.7 5185.4 5265.8 5266.4 5291.4 5686.8 5705.6 5766.3 5785.4 5828.1 6222.1 6299.2 6300.2 6302.7 6327.1 5629.4 6202.2 6271.3 6292.2 6322.6 5821.9 5898.9 5935.5 5952.2 6072.9 6319.7 6382.7 6391.2 6398.9 6404.6 6096.5 6260.3 6284.4 6285.2 6293.7 6165.5 6228.5 6241.3 6284.6 6312.6 6220.4 6288.5 6305.1 6308.1 6323.6 5050.3 6292.1 6294.8 6303.3 6310.3 4242.3 4955.2 5023.1 5026.4 5072.8 4535.7 4543.0 4548.2 4560.7 4573.1 5895.8 5903.2 5932.6 5934.5 5938.8 6199.2 6199.7 6207.7 6268.5 6283.7 5805.1 5858.6 5860.9 5862.9 5906.6 5459.4 5481.2 5529.3 5529.7 5532.4 6240.9 6303.4 6317.3 6564.7 6634.3 6281.2 6285.4 6305.0 6312.0 6313.1 6391.8 6395.1 6406.9 6413.4 6427.1 6155.9 6220.7 6253.9 6284.2 6289.5 6173.4 6200.5 6246.9 6248.7 6281.7 4810.3 6162.3 6204.4 6218.4 6219.5 4913.5 6116.5 6204.2 6223.0 6227.0 4973.5 5864.9 6078.8 6094.0 6122.1 6080.1 6154.3 6187.3 6210.5 6247.6 6083.6 6102.6 6110.9 6124.0 6131.9 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:66585.95 Median:38959.61 stddev:140720.09 (361.2%) stddev-sans-first:141027.15 07:54:19 INFO - PROCESS | 1646 | Values: 415.2 453.0 453.8 500.0 500.7 31357.5 40702.0 42800.6 42981.8 43014.4 43701.0 44150.3 44244.0 44250.7 44323.0 8475.0 9329.9 9510.7 9526.4 9527.5 8414.6 11161.0 11380.8 11417.5 11574.3 11158.6 11169.9 11175.4 11178.4 11201.4 8486.1 9650.8 11345.3 11431.3 11444.9 8552.9 11071.4 11353.0 11376.3 11585.5 40945.6 41284.0 41286.8 41307.0 41312.6 3461.7 3947.0 4013.6 4063.7 4231.3 30131.0 30544.8 31042.4 31153.5 31997.8 2962.5 3014.0 3073.2 3120.1 3124.9 355223.0 355684.2 356416.0 356695.0 356705.0 61345.0 61750.4 61886.7 62032.4 62111.1 65504.0 65511.3 65640.7 65761.7 65823.0 16599.0 16891.9 16897.8 16928.3 16944.1 11725.9 12027.9 12938.0 13013.6 13022.4 12863.8 17323.5 17571.5 17583.2 17792.9 5649.4 5689.9 6758.3 6766.7 6789.5 864.0 866.1 881.1 887.2 913.4 24198.0 24728.6 25160.7 30885.4 31156.7 1082.0 1104.0 1115.8 1119.2 1186.2 15397.0 15735.4 15755.8 15842.8 16133.5 619635.0 628068.9 633020.0 638041.0 639635.0 62063.8 62214.7 62251.7 62281.4 62353.7 1440.9 1455.1 1470.7 1472.9 1476.4 27680.0 29850.0 30035.8 30646.7 30672.9 52367.7 52933.5 53098.7 53151.0 53178.0 551321.0 553185.0 555975.0 556562.2 557327.0 40832.2 41565.4 41710.8 41889.8 41958.4 46928.1 47233.8 47703.8 47855.0 48319.3 38186.4 39556.0 39622.4 40638.0 40930.0 38057.2 38650.6 39234.4 40399.4 40601.4 37639.6 38336.8 38639.8 38668.6 38684.8 33582.8 33926.7 34729.0 34803.8 34839.7 25148.0 25289.9 25426.6 25779.5 25992.5 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:37266.28 Median:22277.50 stddev:105736.61 (474.6%) stddev-sans-first:105996.94 07:54:19 INFO - PROCESS | 1646 | Values: 371.0 392.7 395.1 400.5 419.4 14741.9 16259.3 19635.7 21133.0 21955.2 21334.5 21520.0 22009.8 22146.4 22408.6 4792.4 5777.5 6037.2 6071.8 6134.8 3941.2 6075.5 6123.0 6124.9 6127.9 4134.8 5715.6 5979.4 6010.8 6109.4 5802.1 5877.7 6070.8 6071.5 6093.1 6022.4 6037.2 6038.6 6046.6 6064.7 13593.2 14815.9 19782.4 25425.7 26061.9 2446.3 2512.7 2563.2 2614.0 2665.5 10186.5 10188.3 10555.0 12456.5 15904.5 1805.4 1887.5 1893.9 1896.5 1902.0 124118.5 129331.0 135823.3 138862.3 140104.3 11403.7 11540.0 11864.2 11924.3 11947.7 14991.3 15033.8 15066.2 15570.7 15679.1 8679.0 8767.9 8769.5 8875.5 8877.6 8529.0 8536.8 8538.9 8692.9 8694.6 4606.9 4674.7 4806.0 4811.4 4846.2 2014.9 2054.1 2058.6 2061.7 2063.9 953.4 956.3 994.1 998.4 999.6 21132.0 21815.1 23926.5 24086.6 24329.1 939.7 1059.1 1060.3 1061.0 1084.0 10892.2 10945.9 11452.2 11477.7 11491.3 424353.0 617195.0 621159.0 640272.0 782857.0 121879.5 148854.0 152622.0 154895.2 162901.4 977.7 995.0 1029.1 1029.3 1032.5 15482.7 17331.4 19662.1 20308.4 20810.0 60669.0 60739.8 61139.7 61464.8 62520.4 89185.6 91755.0 92709.5 93432.0 93708.0 6593.4 8391.1 8401.6 8677.5 8753.1 12619.2 13509.1 13518.7 13738.9 13825.8 10134.5 11322.7 11493.9 11917.2 11950.0 11104.7 11373.2 11412.3 11490.7 11729.0 11613.0 11633.4 11682.9 12072.5 12128.9 7304.4 7569.7 7677.3 7876.3 8713.0 10267.6 11533.3 11637.5 11881.3 11976.3 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5444.69 Median:5217.48 stddev:2996.13 (57.4%) stddev-sans-first:2987.72 07:54:19 INFO - PROCESS | 1646 | Values: 1221.7 1458.1 1477.5 1480.7 1483.7 8188.2 8610.1 8619.0 8630.0 8630.8 7528.0 7833.8 7849.1 7979.5 8271.3 2268.6 2332.5 2337.4 2337.7 2338.5 2307.5 2348.7 2363.4 2363.8 2364.8 2057.0 2144.1 2235.3 2302.6 2321.5 2332.7 2342.5 2343.4 2345.8 2346.9 2283.0 2332.2 2334.3 2364.5 2367.9 8355.4 8442.5 8464.0 8466.3 8472.2 5051.8 5204.5 5208.1 5214.1 5220.9 3235.1 3402.5 3444.2 3496.4 3533.2 1126.7 1172.8 1210.0 1211.8 1232.9 10427.8 10817.7 11029.0 11045.2 11065.4 4548.7 4686.4 4739.1 4739.3 4742.3 9702.5 9715.7 9716.9 9736.8 9738.6 4648.0 5099.8 5240.5 5241.5 5253.0 4653.4 4764.6 4807.0 4859.0 4869.8 3728.9 3807.9 3834.3 3873.5 3895.4 1052.6 1244.7 1245.8 1260.7 1262.3 743.5 752.7 778.3 785.8 789.4 5402.4 5557.8 5600.5 5630.6 5646.7 557.9 578.6 593.4 938.3 966.9 2943.3 3621.7 3697.1 3712.4 3789.7 9850.8 9880.1 10167.7 10185.7 10219.1 9840.8 9880.7 9992.7 10130.9 10177.2 7355.7 7683.0 7742.4 7932.6 7943.7 5496.8 5621.3 5732.8 5811.9 5814.9 8996.8 9099.5 9244.0 9303.3 9479.0 8189.7 8330.6 9356.8 9564.0 9690.2 7218.1 7376.6 7383.7 7385.2 7394.5 7610.2 7687.8 7872.7 7896.6 7900.5 7097.0 7159.2 7161.6 7205.6 7226.5 6992.2 7104.4 7106.7 7201.6 7214.9 6435.4 6445.7 6451.3 6518.4 6609.4 4362.3 4427.4 4869.8 4893.4 4974.3 5086.7 5093.7 5169.8 5178.5 5192.9 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4413.11 Median:4932.83 stddev:1302.29 (26.4%) stddev-sans-first:1269.70 07:54:19 INFO - PROCESS | 1646 | Values: 348.2 356.5 359.9 371.2 372.1 5242.9 5250.6 5273.6 5301.9 5328.6 4153.3 4891.8 5020.7 5059.7 5259.9 3342.6 3736.6 3777.6 4016.5 4049.6 3917.7 4072.8 4102.8 4122.5 4167.0 3934.1 4066.9 4089.9 4106.8 4109.4 3743.3 3792.5 4120.6 4134.9 4138.6 3318.3 3577.6 3665.2 3677.9 3679.2 4280.8 5098.8 5117.3 5132.1 5140.2 3851.9 3978.9 4748.5 4766.5 4775.8 5109.4 5536.8 5569.0 5575.0 5581.7 3985.9 4091.2 4094.5 4101.3 4116.3 4392.9 5032.8 5180.6 5181.1 5766.5 4060.8 4065.8 4085.8 4098.4 4114.5 4124.8 4129.2 4145.7 4170.7 4179.7 4432.3 4680.4 4685.8 4726.5 4780.0 4402.5 5264.0 5522.2 5539.7 5561.3 1235.0 1303.7 1320.6 1357.4 1376.8 798.5 810.1 840.0 842.9 947.6 4123.7 4192.9 4371.6 4842.9 4893.3 5243.8 5272.5 5276.3 5293.5 5318.5 4142.2 4328.5 4481.4 4746.5 4769.4 2333.9 2651.4 2654.9 2758.1 2766.9 4882.6 5225.0 5369.1 5433.7 5476.7 5075.5 5369.9 5376.1 5397.9 5430.7 4934.1 5453.7 5463.3 5558.2 5558.3 4992.0 5243.1 5252.2 5267.2 5268.4 5028.9 5103.6 5635.5 5642.6 5667.9 5199.7 5824.9 5866.9 5909.7 5926.8 3570.6 3853.3 3855.0 3893.9 3904.6 5280.3 5331.8 5696.3 5705.8 5728.6 4989.7 5444.7 5456.3 5477.2 5486.8 4629.2 5267.8 5270.6 5366.7 5475.5 4324.8 5141.6 5339.6 5363.6 5377.3 4487.8 4931.5 5193.8 5233.0 5335.7 4358.5 5334.6 5362.7 5362.9 5370.6 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19308.37 Median:23452.04 stddev:27612.27 (117.7%) stddev-sans-first:27654.24 07:54:19 INFO - PROCESS | 1646 | Values: 663.5 663.6 738.2 751.6 763.2 13154.8 15127.6 15298.3 15788.1 15847.6 14423.5 14429.9 14451.5 14459.2 14556.4 666.9 692.2 766.5 852.7 856.6 851.9 857.9 863.9 864.8 865.3 903.0 903.1 903.1 904.5 906.3 698.6 727.7 901.0 902.3 902.9 635.4 653.2 656.2 657.5 657.7 15034.0 15088.8 15090.5 15095.6 15099.0 12233.0 12240.4 12312.6 12451.3 12507.5 11215.8 11415.8 11522.9 12045.9 12396.6 4051.2 4127.9 4166.1 4257.7 4264.3 89112.0 107500.9 110226.0 110651.0 110764.4 9474.5 9561.4 9673.9 9825.2 9928.7 21112.4 21413.0 21417.9 21447.6 21466.9 7069.1 7186.5 7191.9 7231.9 7317.4 3918.6 3919.6 3922.3 3973.0 3986.7 3368.5 3447.5 3500.5 3504.1 3511.5 607.1 614.7 618.7 623.1 623.8 505.5 511.9 520.8 521.7 538.1 8893.2 8917.8 9281.7 9290.6 9310.5 584.9 587.5 599.7 603.7 609.4 4243.7 4408.7 4438.3 4452.7 4459.4 90696.0 93758.0 94471.0 95095.5 99510.0 83375.2 84458.0 85430.0 86565.6 89820.6 48431.0 64084.7 65628.0 75645.2 76932.6 10382.3 10653.8 10900.5 10915.3 10924.6 42068.9 42639.8 46468.8 46549.0 50009.2 53873.0 57016.4 61868.7 62395.0 64985.4 12582.7 12643.7 12648.4 12812.2 12865.8 11689.8 14013.2 14216.1 14310.4 14327.9 12872.7 13229.0 13345.7 13412.0 13788.3 13125.3 13173.5 13197.9 13263.1 13420.0 12580.9 12756.3 12801.6 13060.4 13201.0 10833.6 11026.8 11385.6 11470.7 11471.1 10693.9 10716.2 10730.8 10740.0 10769.5 07:54:19 INFO - PROCESS | 1646 | -------- Summary: end -------- 07:54:19 INFO - PROCESS | 1646 | 07:54:19 INFO - TEST-INFO | 1646: exit 0 07:54:19 INFO - TEST-OK | dromaeo_css | took 1117624ms 07:54:19 INFO - TEST-START | kraken 07:54:19 INFO - operating with platform_type : mac_ 07:54:19 INFO - Initialising browser for kraken test... 07:54:19 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpcEhv8Q/profile http://localhost:49243/getInfo.html) 07:54:22 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:54:22 INFO - PROCESS | 1655 | colorDepth:24 07:54:22 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:54:22 INFO - PROCESS | 1655 | __metrics 07:54:22 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:54:22 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:23 INFO - TEST-INFO | 1655: exit 0 07:54:23 INFO - Browser initialized. 07:54:23 INFO - Running cycle 1/1 for kraken test... 07:54:23 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpcEhv8Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:35 INFO - PROCESS | 1656 | RSS: Main: 213049344 07:54:35 INFO - PROCESS | 1656 | 07:54:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:39 INFO - PROCESS | 1656 | RSS: Main: 265936896 07:54:39 INFO - PROCESS | 1656 | 07:54:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 07:54:42 INFO - PROCESS | 1656 | RSS: Main: 274735104 07:54:42 INFO - PROCESS | 1656 | 07:54:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 07:54:46 INFO - PROCESS | 1656 | RSS: Main: 371351552 07:54:46 INFO - PROCESS | 1656 | 07:54:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 07:54:48 INFO - PROCESS | 1656 | RSS: Main: 275894272 07:54:48 INFO - PROCESS | 1656 | 07:54:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:51 INFO - PROCESS | 1656 | RSS: Main: 279425024 07:54:51 INFO - PROCESS | 1656 | 07:54:54 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:54 INFO - PROCESS | 1656 | RSS: Main: 318537728 07:54:54 INFO - PROCESS | 1656 | 07:54:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:58 INFO - PROCESS | 1656 | RSS: Main: 319119360 07:54:58 INFO - PROCESS | 1656 | 07:55:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 07:55:01 INFO - PROCESS | 1656 | RSS: Main: 317788160 07:55:01 INFO - PROCESS | 1656 | 07:55:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:55:03 INFO - PROCESS | 1656 | RSS: Main: 295059456 07:55:03 INFO - PROCESS | 1656 | 07:55:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:55:06 INFO - PROCESS | 1656 | RSS: Main: 296574976 07:55:06 INFO - PROCESS | 1656 | 07:55:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:55:09 INFO - PROCESS | 1656 | RSS: Main: 300711936 07:55:09 INFO - PROCESS | 1656 | 07:55:12 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:55:12 INFO - PROCESS | 1656 | RSS: Main: 315465728 07:55:12 INFO - PROCESS | 1656 | 07:55:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:55:16 INFO - PROCESS | 1656 | RSS: Main: 308621312 07:55:16 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 07:55:18 INFO - PROCESS | 1656 | RSS: Main: 353157120 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | __start_tp_report 07:55:18 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 07:55:18 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 07:55:18 INFO - PROCESS | 1656 | |i|pagename|runs| 07:55:18 INFO - PROCESS | 1656 | |0;ai-astar;116;114;115;114;112;114;113;115;114;114 07:55:18 INFO - PROCESS | 1656 | |1;audio-beat-detection;138;111;108;143;110;109;104;107;124;120 07:55:18 INFO - PROCESS | 1656 | |2;audio-dft;184;183;181;187;182;191;261;221;185;182 07:55:18 INFO - PROCESS | 1656 | |3;audio-fft;84;59;59;89;61;59;58;59;72;57 07:55:18 INFO - PROCESS | 1656 | |4;audio-oscillator;85;70;86;71;69;71;82;73;97;112 07:55:18 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;92;86;75;130;134;89;91;86;89;85 07:55:18 INFO - PROCESS | 1656 | |6;imaging-darkroom;93;94;95;94;94;94;95;94;94;95 07:55:18 INFO - PROCESS | 1656 | |7;imaging-desaturate;87;84;88;87;86;84;84;84;84;87 07:55:18 INFO - PROCESS | 1656 | |8;json-parse-financial;58;56;55;54;54;58;57;56;56;56 07:55:18 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;67;79;80;76;71;71;72;71;71 07:55:18 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;86;84;84;83;83;83;85;84;86;84 07:55:18 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;140;142;133;139;143;147;142;141;216;171 07:55:18 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;214;214;170;166;166;168;167;163;148;204 07:55:18 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;66;66;66;68;76;82;82;80;74 07:55:18 INFO - PROCESS | 1656 | __end_tp_report 07:55:18 INFO - PROCESS | 1656 | __start_cc_report 07:55:18 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1957 07:55:18 INFO - PROCESS | 1656 | __end_cc_report 07:55:18 INFO - PROCESS | 1656 | __startTimestamp1485791718623__endTimestamp 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | ------- Summary: start ------- 07:55:18 INFO - PROCESS | 1656 | Number of tests: 14 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:0.93 07:55:18 INFO - PROCESS | 1656 | Values: 116.0 114.0 115.0 114.0 112.0 114.0 113.0 115.0 114.0 114.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:117.40 Median:115.50 stddev:13.63 (11.8%) stddev-sans-first:12.25 07:55:18 INFO - PROCESS | 1656 | Values: 138.0 111.0 108.0 143.0 110.0 109.0 104.0 107.0 124.0 120.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:195.70 Median:186.00 stddev:25.83 (13.9%) stddev-sans-first:27.05 07:55:18 INFO - PROCESS | 1656 | Values: 184.0 183.0 181.0 187.0 182.0 191.0 261.0 221.0 185.0 182.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.80 (19.7%) stddev-sans-first:10.50 07:55:18 INFO - PROCESS | 1656 | Values: 84.0 59.0 59.0 89.0 61.0 59.0 58.0 59.0 72.0 57.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:81.60 Median:77.50 stddev:14.08 (18.2%) stddev-sans-first:14.88 07:55:18 INFO - PROCESS | 1656 | Values: 85.0 70.0 86.0 71.0 69.0 71.0 82.0 73.0 97.0 112.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:87.50 stddev:19.72 (22.5%) stddev-sans-first:20.87 07:55:18 INFO - PROCESS | 1656 | Values: 92.0 86.0 75.0 130.0 134.0 89.0 91.0 86.0 89.0 85.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 07:55:18 INFO - PROCESS | 1656 | Values: 93.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.66 07:55:18 INFO - PROCESS | 1656 | Values: 87.0 84.0 88.0 87.0 86.0 84.0 84.0 84.0 84.0 87.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.41 (2.5%) stddev-sans-first:1.30 07:55:18 INFO - PROCESS | 1656 | Values: 58.0 56.0 55.0 54.0 54.0 58.0 57.0 56.0 56.0 56.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:72.30 Median:71.50 stddev:4.79 (6.7%) stddev-sans-first:4.28 07:55:18 INFO - PROCESS | 1656 | Values: 65.0 67.0 79.0 80.0 76.0 71.0 71.0 72.0 71.0 71.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.14 (1.4%) stddev-sans-first:1.00 07:55:18 INFO - PROCESS | 1656 | Values: 86.0 84.0 84.0 83.0 83.0 83.0 85.0 84.0 86.0 84.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:142.50 stddev:24.84 (17.4%) stddev-sans-first:26.00 07:55:18 INFO - PROCESS | 1656 | Values: 140.0 142.0 133.0 139.0 143.0 147.0 142.0 141.0 216.0 171.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:169.00 stddev:23.49 (13.9%) stddev-sans-first:20.99 07:55:18 INFO - PROCESS | 1656 | Values: 214.0 214.0 170.0 166.0 166.0 168.0 167.0 163.0 148.0 204.0 07:55:18 INFO - PROCESS | 1656 | 07:55:18 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:75.00 stddev:6.90 (9.2%) stddev-sans-first:7.00 07:55:18 INFO - PROCESS | 1656 | Values: 67.0 66.0 66.0 66.0 68.0 76.0 82.0 82.0 80.0 74.0 07:55:18 INFO - PROCESS | 1656 | -------- Summary: end -------- 07:55:18 INFO - PROCESS | 1656 | 07:55:19 INFO - TEST-INFO | 1656: exit 0 07:55:19 INFO - TEST-OK | kraken | took 59831ms 07:55:19 INFO - SUITE-END | took 1177s 07:55:19 INFO - Completed test suite (00:19:37) 07:55:19 INFO - javascript benchmark 07:55:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.2488939988502, 3359.66403359664, 3371.8145501997396, 3385.6614338566146, 3395.422778127718, 5762.481376676098, 5791.507721843648, 5811.6803575803315, 5816.156657284691, 5845.941540584598, 5715.3141623005295, 5798.217240672508, 5801.941980580193, 5808.82573522795, 5834.708264586775, 4329.610335069843, 4612.8385506507275, 5228.764705588239, 5286.550643195333, 5323.627346085776, 5132.230165475171, 5136.0, 5145.25393817898, 5259.316288882459, 5355.410904800468, 5267.420583735786, 5297.8940421191555, 5318.946810531903, 5327.200919862013, 5350.117230656937, 5319.787208511655, 5327.413984461706, 5327.46725327468, 5340.385855626614, 5396.19057141428, 5065.696058236481, 5185.377754669464, 5265.842024739264, 5266.447023062561, 5291.391489978625, 5686.829395118153, 5705.572082093818, 5766.336871259775, 5785.363610002938, 5828.06750919855, 6222.066689996492, 6299.181106456177, 6300.180976473075, 6302.68486575674, 6327.114204011442, 5629.408912064216, 6202.162708034402, 6271.310155882849, 6292.182016337847, 6322.557420980534, 5821.912671309934, 5898.8820223595285, 5935.525157987437, 5952.226210592596, 6072.908906366408, 6319.684015799192, 6382.712777925005, 6391.2330520337855, 6398.8720225595225, 6404.647744374011, 6096.512279017668, 6260.280067792171, 6284.402981716729, 6285.214348206474, 6293.716782744787, 6165.537584681167, 6228.532860035515, 6241.313455519889, 6284.622922624657, 6312.621242725451, 6220.440160385587, 6288.496920246369, 6305.054241863665, 6308.116863639094, 6323.5889667172405, 5050.267711181858, 6292.056191571301, 6294.842628934313, 6303.275123360872, 6310.305866354697, 4242.257604919188, 4955.182394904872, 5023.09584274834, 5026.371703537058, 5072.797088116434, 4535.727856328631, 4542.954570454319, 4548.204064288736, 4560.749158796231, 4573.085382923428, 5895.764169433261, 5903.2325797646035, 5932.58471906971, 5934.465898069195, 5938.8218353449465, 6199.225096862892, 6199.721012554446, 6207.720652570645, 6268.49852011838, 6283.717232724538, 5805.129230615357, 5858.5898987070495, 5860.941390586039, 5862.853428664317, 5906.645601263938, 5459.3994660587305, 5481.232627432163, 5529.336479622471, 5529.668219906818, 5532.419095994863, 6240.906386404116, 6303.432691057827, 6317.273513545817, 6564.704588293538, 6634.336566343327, 6281.214848143982, 6285.402886725754, 6304.991201407753, 6311.96844015777, 6313.116163737172, 6391.840203994937, 6395.104685343963, 6406.903896441464, 6413.35866413355, 6427.100205971261, 6155.907661385172, 6220.657863817352, 6253.8749225014335, 6284.214473190851, 6289.465395441256, 6173.41352571505, 6200.503959683124, 6246.9062964054665, 6248.68756562161, 6281.685915704105, 4810.254410566367, 6162.291336496181, 6204.410580994799, 6218.409251121137, 6219.502439804895, 4913.533214344631, 6116.5412594056515, 6204.224471941007, 6222.968885155546, 6227.034809604518, 4973.45292017885, 5864.853378665567, 6078.756849726138, 6094.0, 6122.123717501779, 6080.148779170831, 6154.261488621394, 6187.288461826947, 6210.472109870531, 6247.5939063960695, 6083.55169424821, 6102.633841969496, 6110.908336374869, 6124.0201567748945, 6131.938680613137], "value": 5740.341814345868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.1945226261053, 452.98305304591196, 453.75497231494995, 500.0, 500.67456153500234, 31357.52963705546, 40702.0, 42800.57199428005, 42981.78509107458, 43014.35478467817, 43701.0, 44150.33774493385, 44244.0, 44250.672479825655, 44323.0, 8474.957625211866, 9329.860052099208, 9510.66712665057, 9526.42841429513, 9527.523623818815, 8414.621342039592, 11161.0, 11380.829287560651, 11417.54329826806, 11574.305541667527, 11158.553657853676, 11169.944150279278, 11175.44122793861, 11178.44107794607, 11201.383923884183, 8486.108958559324, 9650.758731031745, 11345.26255793375, 11431.256968297117, 11444.885551144465, 8552.871706924401, 11071.446427678664, 11353.0, 11376.317420954769, 11585.478653460614, 40945.59054409448, 41284.0, 41286.79356603228, 41307.0, 41312.58687413117, 3461.6884480396634, 3947.0, 4013.6387725104883, 4063.7155399122075, 4231.30183519722, 30131.0, 30544.847275763477, 31042.379152416826, 31153.532697009563, 31997.8400107998, 2962.4963756161505, 3013.9698603014126, 3073.247054471669, 3120.1263646179104, 3124.937501249985, 355222.99999999744, 355684.22157889046, 356416.0, 356695.0, 356705.0, 61345.0, 61750.38249617446, 61886.69056654688, 62032.37967620356, 62111.068333975025, 65504.0, 65511.34488655148, 65640.67179664072, 65761.6847663044, 65823.0, 16599.0, 16891.91554042222, 16897.831021689624, 16928.32286708518, 16944.068076255677, 11725.941370293265, 12027.939860300818, 12938.029647776455, 13013.609591712264, 13022.413991370411, 12863.807042894365, 17323.48029559115, 17571.472855814347, 17583.20875560603, 17792.91103544474, 5649.406812284651, 5689.9146512802345, 6758.324167583301, 6766.69549870257, 6789.524733268624, 863.9956800215958, 866.1425189062783, 881.1100788203833, 887.1704955866286, 913.36064754672, 24198.0, 24728.629070563955, 25160.74839251584, 30885.38229235403, 31156.688433115833, 1081.9729506762394, 1103.9834402483968, 1115.8047341715167, 1119.2445099557765, 1186.2230239193343, 15397.0, 15735.44925927587, 15755.763663545056, 15842.7623585644, 16133.515994520183, 619635.0, 628068.859655708, 633020.0, 638041.0, 639635.0, 62063.75872482525, 62214.68892655508, 62251.68874155691, 62281.37718622756, 62353.688231559456, 1440.877525410331, 1455.1341951538818, 1470.7205630930089, 1472.874805641511, 1476.402057166849, 27680.0, 29850.0, 30035.849820750755, 30646.693533065274, 30672.926447574227, 52367.73816130895, 52933.47066529285, 53098.73450632722, 53151.0, 53178.0, 551321.0, 553185.0, 555975.0, 556562.2171889115, 557327.0, 40832.1833563333, 41565.37651935284, 41710.791446042575, 41889.79055104705, 41958.37062444127, 46928.061438771714, 47233.76383118062, 47703.76148119376, 47855.0, 48319.275210871165, 38186.42720359141, 39556.0, 39622.40566391564, 40637.98405039779, 40930.0, 38057.23885522219, 38650.6134938647, 39234.411483828335, 40399.3940090893, 40601.39097913475, 37639.62360376361, 38336.80831595824, 38639.80680096694, 38668.6133138665, 38684.80657596694, 33582.83208584039, 33926.660733393335, 34729.0, 34803.82598087095, 34839.65160348364, 25148.0, 25289.873550632128, 25426.618600721373, 25779.484410312063, 25992.480150396506], "value": 20292.168579825666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.9870154544588, 392.65838720313315, 395.0676403687298, 400.48537629146546, 419.43167008703205, 14741.852581474182, 16259.34962601496, 19635.705464418046, 21133.04901279442, 21955.231566895163, 21334.46663833401, 21520.03159857806, 22009.779902200975, 22146.44633884154, 22408.55182896341, 4792.353032340642, 5777.537796976242, 6037.154798328237, 6071.757129714806, 6134.785282515113, 3941.17235380569, 6075.513958883301, 6122.969385153068, 6124.908126378108, 6127.938720612781, 4134.751914885116, 5715.628484148517, 5979.431953964367, 6010.789622363218, 6109.35851735568, 5802.12968054791, 5877.67672777997, 6070.848228794272, 6071.544634152457, 6093.0555763856455, 6022.397760223943, 6037.215162028952, 6038.607490513103, 6046.637201767908, 6064.666443345658, 13593.184408935396, 14815.925920370437, 19782.41740660758, 25425.745742542524, 26061.869690651427, 2446.3028037009544, 2512.69847618287, 2563.2054063240457, 2613.9805475864428, 2665.520206362854, 10186.541605627765, 10188.286819922609, 10555.0, 12456.501739930392, 15904.522864314089, 1805.404216608516, 1887.4715079777684, 1893.867429279951, 1896.4500294914596, 1902.0, 124118.54141222873, 129331.0, 135823.32088339594, 138862.30568847092, 140104.29947850297, 11403.657890263139, 11540.0, 11864.169508134348, 11924.284542927453, 11947.701307467383, 14991.250437478082, 15033.774493382609, 15066.246687665793, 15570.676492498038, 15679.05925644465, 8679.045305016443, 8767.868481972775, 8769.517676527725, 8875.467471951704, 8877.556122193864, 8529.0, 8536.829263414696, 8538.914610853812, 8692.869606955901, 8694.608862581956, 4606.930896036562, 4674.672772905864, 4806.014766972762, 4811.446683631357, 4846.200376937836, 2014.9194032238547, 2054.096197673019, 2058.5985732781965, 2061.690746388054, 2063.8658487198286, 953.4374718915873, 956.3496822160859, 994.125169850527, 998.4159266828841, 999.605155963405, 21132.0, 21815.141607321555, 23926.52146957051, 24086.63870041951, 24329.148479803123, 939.6570251858022, 1059.0891833023593, 1060.3213943076437, 1060.9946950265198, 1083.9729006774735, 10892.237543371888, 10945.945270273756, 11452.198346115858, 11477.655670329903, 11491.310521368745, 424353.0, 617195.0, 621159.0, 640272.0, 782857.0, 121879.54480711256, 148854.0, 152622.0, 154895.22552387166, 162901.36728005376, 977.7066879935991, 994.9950549944608, 1029.130384824822, 1029.315505189041, 1032.4837581209395, 15482.690346193238, 17331.393401230896, 19662.132097450718, 20308.390748277576, 20810.0, 60669.0, 60739.78520429655, 61139.69430152821, 61464.77070458655, 62520.37479625145, 89185.55407222922, 91755.0, 92709.53645232001, 93432.0, 93708.0, 6593.3736295051895, 8391.07698153215, 8401.621927013177, 8677.522736249566, 8753.124687531195, 12619.179753316004, 13509.054366194272, 13518.662033448849, 13738.931305343409, 13825.792613111013, 10134.543945522322, 11322.716932076764, 11493.885061149282, 11917.16579839403, 11950.0, 11104.666859994213, 11373.20387572895, 11412.258203216765, 11490.655280341603, 11729.0, 11613.0, 11633.41832908368, 11682.94158529202, 12072.456739446921, 12128.93935530352, 7304.4156467483535, 7569.697212111454, 7677.30904218623, 7876.291133797986, 8713.041565427924, 10267.58929642806, 11533.250338727956, 11637.476313565741, 11881.287122772315, 11976.341301228516], "value": 9954.267739374267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.7067903703112, 1458.1469840143516, 1477.5198060630291, 1480.6816534445093, 1483.7403454395478, 8188.181181881816, 8610.138986101387, 8619.0, 8630.007549131851, 8630.784230394243, 7528.021357223567, 7833.843323133534, 7849.058113026431, 7979.52122872628, 8271.25558699717, 2268.5803126421665, 2332.463533387322, 2337.439014636492, 2337.7077865266842, 2338.5322935412987, 2307.4923516826357, 2348.6946696929376, 2363.361892289081, 2363.7872591466767, 2364.84628499147, 2056.9897150514225, 2144.0994782191437, 2235.284708893155, 2302.5855346037706, 2321.45623160598, 2332.696749422573, 2342.543204075206, 2343.4492894169857, 2345.835791494596, 2346.9061237550563, 2283.0, 2332.2187067332293, 2334.323046316566, 2364.47981444082, 2367.9052837886466, 8355.415120941536, 8442.493450392996, 8464.0, 8466.280366168883, 8472.15278472154, 5051.797928082872, 5204.453532379083, 5208.088584497697, 5214.06146893559, 5220.895582088375, 3235.126515840733, 3402.4726167444087, 3444.2078321986082, 3496.3881320768764, 3533.152043509565, 1126.718320419895, 1172.7537217184401, 1209.9637010889687, 1211.7515909238584, 1232.9383530823422, 10427.843582346195, 10817.675469735921, 11029.0, 11045.171612129043, 11065.391403472806, 4548.658850586219, 4686.36734040907, 4739.123262196505, 4739.265413860857, 4742.264948932921, 9702.51487425626, 9715.70852874415, 9716.854247186298, 9736.805263894683, 9738.561764720605, 4647.95352046482, 5099.821506247264, 5240.475952404805, 5241.528262456321, 5253.001929633358, 4653.418322709661, 4764.618830493552, 4806.975965120152, 4859.0, 4869.780859861315, 3728.9440658389603, 3807.8667246646232, 3834.3481608126685, 3873.4770805941403, 3895.4156876468755, 1052.578968412641, 1244.7386048929827, 1245.7508498300376, 1260.6785269756153, 1262.2741923394085, 743.5055687967441, 752.7139686918936, 778.2956424435781, 785.8389030248785, 789.4292049036131, 5402.432744561765, 5557.833265001976, 5600.4959553640365, 5630.60585758993, 5646.689432081275, 557.946995035471, 578.6383510306059, 593.4154857465393, 938.3009657804979, 966.8929076207843, 2943.2788966703297, 3621.6921561667555, 3697.141801957384, 3712.424574191005, 3789.692556068152, 9850.753731156778, 9880.110790028932, 10167.7458063549, 10185.694429166988, 10219.080282774587, 9840.753981150528, 9880.65417710391, 9992.700218993441, 10130.898691012995, 10177.18582513397, 7355.7057717690695, 7682.961585192038, 7742.380609551223, 7932.643031063616, 7943.682252709827, 5496.780128794963, 5621.269234999424, 5732.828015159552, 5811.94188058114, 5814.883702326015, 8996.775080623036, 9099.49952752605, 9243.953780231055, 9303.302252331237, 9478.95260523693, 8189.7133600323705, 8330.625121869653, 9356.766080848034, 9563.952180239054, 9690.224782017282, 7218.097737782778, 7376.594287314249, 7383.667734952048, 7385.150707668472, 7394.519356241827, 7610.200928902607, 7687.846243075219, 7872.685092596232, 7896.605169741605, 7900.525968441912, 7097.0064191014335, 7159.212486626363, 7161.641917904188, 7205.639718014183, 7226.494145409771, 6992.2308546058875, 7104.431645468247, 7106.680199390937, 7201.6399180041835, 7214.89177662325, 6435.356464353527, 6445.742170313135, 6451.290358060516, 6518.413342799171, 6609.372109649576, 4362.25841606934, 4427.380166776718, 4869.780859861244, 4893.388326459192, 4974.328465657235, 5086.720230387365, 5093.6943783371635, 5169.7673604687125, 5178.533931946143, 5192.922106168486], "value": 4375.902948403339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.24778478486473, 356.4830995057168, 359.917219039621, 371.20747204717935, 372.0865275748039, 5242.895142097156, 5250.6324557281005, 5273.630845840793, 5301.867453313669, 5328.573714102872, 4153.276390298022, 4891.804327826882, 5020.723860187688, 5059.721715305656, 5259.894802103956, 3342.5988881334274, 3736.626337366262, 3777.6411240932066, 4016.518017837849, 4049.6355328020472, 3917.7071566383024, 4072.7846678687565, 4102.794860256975, 4122.525909520398, 4166.9791651041705, 3934.075492259317, 4066.9186616267807, 4089.9182016359655, 4106.815193316293, 4109.445224894631, 3743.270062337845, 3792.5019617251305, 4120.608542188487, 4134.896627584304, 4138.6482149017365, 3318.257914594833, 3577.6422357764277, 3665.1936573953953, 3677.8528858845616, 3679.172186258097, 4280.807363668642, 5098.847034588968, 5117.257997590365, 5132.101882170605, 5140.228965655144, 3851.940716303011, 3978.880633580968, 4748.4539277982785, 4766.523347665206, 4775.832845850413, 5109.390541979302, 5536.806211782608, 5568.99758043552, 5575.006867617328, 5581.6930068846195, 3985.900352491182, 4091.2431200227757, 4094.529129150156, 4101.349798679178, 4116.279651061052, 4392.912141757179, 5032.798688052437, 5180.642807522569, 5181.082999290286, 5766.452187042266, 4060.796960151981, 4065.7560546367313, 4085.7957102144774, 4098.446709694213, 4114.547399786021, 4124.793760311973, 4129.194807012604, 4145.657703397631, 4170.70805043644, 4179.749215047107, 4432.3351497275025, 4680.438347398334, 4685.81256749733, 4726.456457507362, 4780.0, 4402.471703395613, 5263.973680131575, 5522.22688823565, 5539.72586305144, 5561.332640083216, 1234.9876501234874, 1303.6767680803991, 1320.5576131995888, 1357.4095268558208, 1376.8416632087237, 798.5448294472095, 810.1412502746989, 840.0175585617936, 842.8705534583687, 947.5833628725101, 4123.731957422758, 4192.909843440666, 4371.584699453547, 4842.8619274470475, 4893.311807426432, 5243.790248390022, 5272.472752724697, 5276.287701160294, 5293.470652934753, 5318.468153184651, 4142.171565686875, 4328.458942632171, 4481.3726078349055, 4746.525347465225, 4769.35613692154, 2333.906643734266, 2651.3504191472825, 2654.9469010619678, 2758.089830355978, 2766.879413837399, 4882.5605695486865, 5225.0, 5369.087255166631, 5433.701146436905, 5476.741338903346, 5075.543201111917, 5369.946300536944, 5376.064616737971, 5397.920415916832, 5430.728463576885, 4934.136526107988, 5453.672779633234, 5463.31708536433, 5558.249636299048, 5558.277423934863, 4991.9500804991485, 5243.1200911326105, 5252.238425428368, 5267.235476115544, 5268.367795864521, 5028.899422011613, 5103.617228707788, 5635.492805647511, 5642.60501764889, 5667.8866422672145, 5199.66202196856, 5824.912626310694, 5866.911996319973, 5909.674967876808, 5926.762364909111, 3570.553680789901, 3853.3064048470424, 3854.9545858771257, 3893.8831835044994, 3904.629060239273, 5280.339957505312, 5331.813386531453, 5696.287964004499, 5705.800296989585, 5728.596493859031, 4989.675671081368, 5444.673319600836, 5456.317960254968, 5477.1510415885605, 5486.780528778804, 4629.1898917688595, 5267.789288428573, 5270.552003079782, 5366.6779993200535, 5475.4524547544925, 4324.78376081201, 5141.562967147835, 5339.626226164131, 5363.597730170331, 5377.327834020747, 4487.842925497592, 4931.5315045070665, 5193.76628051731, 5232.9534093180755, 5335.733213339395, 4358.455193100863, 5334.573234141182, 5362.675141412349, 5362.889524075948, 5370.62405631602], "value": 4011.7244786, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.5156335874808, 663.5653646861305, 738.1658725640026, 751.6016511249038, 763.2329508843611, 13154.802677959826, 15127.621809454755, 15298.31157597908, 15788.131652759093, 15847.603809904744, 14423.495177668783, 14429.92785036076, 14451.494197703083, 14459.20474373909, 14556.417743290256, 666.8966310221912, 692.1866806502339, 766.4826242286463, 852.7484392104344, 856.5973992223676, 851.8722191671268, 857.8584533551956, 863.9179277968583, 864.8054187807755, 865.3423398217337, 902.9819403611924, 903.0698380667923, 903.0788595632483, 904.516083895113, 906.3429013964889, 698.5878331784221, 727.745289148799, 900.9684661036865, 902.345799295512, 902.8961669408004, 635.3551145587232, 653.1606885152604, 656.1535619051418, 657.4543129202798, 657.6514447342915, 15034.0, 15088.849111508964, 15090.471833485775, 15095.622609434742, 15099.0, 12233.0, 12240.449179786841, 12312.569060082944, 12451.315177665225, 12507.49970001208, 11215.775684486347, 11415.828762568568, 11522.884771152265, 12045.879541204564, 12396.56612018584, 4051.1897620476025, 4127.876163715094, 4166.104287578155, 4257.723247988871, 4264.296391095466, 89112.0, 107500.92499075066, 110226.0, 110651.0, 110764.4461777694, 9474.478903660365, 9561.378510396802, 9673.903260967441, 9825.213982881352, 9928.702138935843, 21112.366629001153, 21413.0, 21417.89291053566, 21447.571048578942, 21466.892665536885, 7069.116360454943, 7186.461015423864, 7191.8561628768175, 7231.855362892713, 7317.378022868116, 3918.6277303656107, 3919.568847426781, 3922.3332033554366, 3972.960270397259, 3986.681065514752, 3368.528406023159, 3447.482877568385, 3500.4749287606555, 3504.1064528545057, 3511.525943997579, 607.0954278125649, 614.7172300741709, 618.7494064903722, 623.1089541955048, 623.8222106699569, 505.47430672100603, 511.8950615123891, 520.8359316926666, 521.7130578181984, 538.1201735162958, 8893.244074253631, 8917.821643567093, 9281.67514137002, 9290.628374865066, 9310.487923164292, 584.8713283077716, 587.5094296262583, 599.7421108923118, 603.6619493083887, 609.3753902250229, 4243.745375277494, 4408.735475871458, 4438.334249862546, 4452.732836029849, 4459.353393757887, 90696.0, 93758.0, 94471.0, 95095.52452237695, 99510.0, 83375.16624833795, 84458.0, 85430.0, 86565.56717216373, 89820.5508972464, 48431.0, 64084.67957660275, 65628.0, 75645.24354756493, 76932.61533692296, 10382.273240873066, 10653.840192396965, 10900.454977251264, 10915.345079295268, 10924.617638382619, 42068.94827629211, 42639.7868010658, 46468.767656162854, 46549.0, 50009.24986125138, 53873.0, 57016.429835701114, 61868.69065654823, 62395.0, 64985.35014649982, 12582.748345032865, 12643.683907902008, 12648.43082061291, 12812.245367246087, 12865.807012894627, 11689.824652630388, 14013.229272390117, 14216.147031178163, 14310.356033978287, 14327.850822376728, 12872.742545149233, 13229.000734056692, 13345.66635834112, 13412.0, 13788.310584470937, 13125.34373281313, 13173.538926137539, 13197.868021320048, 13263.071584989344, 13420.0, 12580.87419125797, 12756.338923774181, 12801.61595152147, 13060.412281447549, 13201.0, 10833.620823271147, 11026.834597480884, 11385.601503947322, 11470.655880323604, 11471.078492349794, 10693.94653026761, 10716.19628527848, 10730.839037414602, 10740.033396994308, 10769.515371808131], "value": 7153.328352025611, "unit": "score"}], "name": "dromaeo_css", "value": 7253.350855255754, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 115.0, 114.0, 112.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 111.0, 108.0, 143.0, 110.0, 109.0, 104.0, 107.0, 124.0, 120.0], "value": 117.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 183.0, 181.0, 187.0, 182.0, 191.0, 261.0, 221.0, 185.0, 182.0], "value": 195.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 59.0, 89.0, 61.0, 59.0, 58.0, 59.0, 72.0, 57.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 86.0, 71.0, 69.0, 71.0, 82.0, 73.0, 97.0, 112.0], "value": 81.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 86.0, 75.0, 130.0, 134.0, 89.0, 91.0, 86.0, 89.0, 85.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 88.0, 87.0, 86.0, 84.0, 84.0, 84.0, 84.0, 87.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 55.0, 54.0, 54.0, 58.0, 57.0, 56.0, 56.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 79.0, 80.0, 76.0, 71.0, 71.0, 72.0, 71.0, 71.0], "value": 72.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 83.0, 83.0, 83.0, 85.0, 84.0, 86.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 133.0, 139.0, 143.0, 147.0, 142.0, 141.0, 216.0, 171.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 214.0, 170.0, 166.0, 166.0, 168.0, 167.0, 163.0, 148.0, 204.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 68.0, 76.0, 82.0, 82.0, 80.0, 74.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1464.5000000000002, "alertThreshold": 2.0}]} 07:55:19 INFO - Return code: 0 07:55:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:55:19 ERROR - # TBPL SUCCESS # 07:55:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:55:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:55:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:55:19 INFO - 2017-01-30 07:55:19.938 screenresolution[1660:9725] starting screenresolution argv=screenresolution get 07:55:19 INFO - 2017-01-30 07:55:19.940 screenresolution[1660:9725] Display 0: 1600x1200x32@60 07:55:19 INFO - 2017-01-30 07:55:19.947 screenresolution[1661:9728] starting screenresolution argv=screenresolution list 07:55:19 INFO - Available Modes on Display 0 07:55:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:55:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:55:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:55:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:55:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:55:20 INFO - Intel Iris: 07:55:20 INFO - Chipset Model: Intel Iris 07:55:20 INFO - Type: GPU 07:55:20 INFO - Bus: Built-In 07:55:20 INFO - VRAM (Dynamic, Max): 1536 MB 07:55:20 INFO - Vendor: Intel (0x8086) 07:55:20 INFO - Device ID: 0x0a2e 07:55:20 INFO - Revision ID: 0x0009 07:55:20 INFO - Displays: 07:55:20 INFO - Display: 07:55:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:55:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:55:20 INFO - Display Serial Number: 1600x1200 60 07:55:20 INFO - Main Display: Yes 07:55:20 INFO - Mirror: Off 07:55:20 INFO - Online: Yes 07:55:20 INFO - Rotation: Supported 07:55:20 INFO - Return code: 0 07:55:20 INFO - Running post-action listener: _resource_record_post_action 07:55:20 INFO - [mozharness: 2017-01-30 15:55:20.183408Z] Finished run-tests step (success) 07:55:20 INFO - Running post-run listener: _resource_record_post_run 07:55:20 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37602304; Write bytes: 504803840; Read time: 238; Write time: 1555 07:55:20 INFO - TinderboxPrint: CPU usage
53.3% 07:55:20 INFO - TinderboxPrint: I/O read bytes / time
37,602,304 / 238 07:55:20 INFO - TinderboxPrint: I/O write bytes / time
504,803,840 / 1,555 07:55:20 INFO - TinderboxPrint: CPU idle
2,237.1 (46.7%) 07:55:20 INFO - TinderboxPrint: CPU system
955.6 (19.9%) 07:55:20 INFO - TinderboxPrint: CPU user
1,600.9 (33.4%) 07:55:20 INFO - TinderboxPrint: Swap in / out
244,830,208 / 0 07:55:20 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201134592; Write bytes: 198664192; Read time: 15472; Write time: 421 07:55:20 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35697664; Write bytes: 295461376; Read time: 221; Write time: 1100 07:55:20 INFO - Running post-run listener: _upload_blobber_files 07:55:20 INFO - Blob upload gear active. 07:55:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:55:20 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 07:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 07:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:22 INFO - (blobuploader) - INFO - Done attempting. 07:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:23 INFO - (blobuploader) - INFO - Done attempting. 07:55:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:55:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:55:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:24 INFO - (blobuploader) - INFO - Done attempting. 07:55:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:27 INFO - (blobuploader) - INFO - Done attempting. 07:55:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:27 INFO - Return code: 0 07:55:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f0eac4ff4131a074031e99fa3dcc03420b2fc7edc03fe8e0abf4bc588f443d3f294689967e5ba1efe7a189a9c65c24a7bacd504b6be2db3945bd680f4482961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d6f785335596347df3cde7f7c3b30dcde53f0ce5bb96a62b84c386c563d55482a76b26c40b286ebd547928a5e5d4b1dba535d87e5b5c346b5dab53e991dd96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad53721ec6735881153617a8d51de6d836c1c873d8ce5af01c5394d926d9c5bf341b059742c7d3987acdb6b4e0de48e7725879504bf655ff1333b43d1cb78f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa5e0d8728faaf7cf88bbbc17646c1b867384f8d32173671fa5e13a2220adab8f64949d77216e3a47dc65388deca98428bc035696e77be098ac8f0205389f6f"} 07:55:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:27 INFO - Contents: 07:55:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f0eac4ff4131a074031e99fa3dcc03420b2fc7edc03fe8e0abf4bc588f443d3f294689967e5ba1efe7a189a9c65c24a7bacd504b6be2db3945bd680f4482961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d6f785335596347df3cde7f7c3b30dcde53f0ce5bb96a62b84c386c563d55482a76b26c40b286ebd547928a5e5d4b1dba535d87e5b5c346b5dab53e991dd96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad53721ec6735881153617a8d51de6d836c1c873d8ce5af01c5394d926d9c5bf341b059742c7d3987acdb6b4e0de48e7725879504bf655ff1333b43d1cb78f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa5e0d8728faaf7cf88bbbc17646c1b867384f8d32173671fa5e13a2220adab8f64949d77216e3a47dc65388deca98428bc035696e77be098ac8f0205389f6f"} 07:55:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:27 INFO - Copying logs to upload dir... 07:55:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.148261 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-30 07:55:27.822350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 07:55:27.825756) ========= 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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f0eac4ff4131a074031e99fa3dcc03420b2fc7edc03fe8e0abf4bc588f443d3f294689967e5ba1efe7a189a9c65c24a7bacd504b6be2db3945bd680f4482961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d6f785335596347df3cde7f7c3b30dcde53f0ce5bb96a62b84c386c563d55482a76b26c40b286ebd547928a5e5d4b1dba535d87e5b5c346b5dab53e991dd96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad53721ec6735881153617a8d51de6d836c1c873d8ce5af01c5394d926d9c5bf341b059742c7d3987acdb6b4e0de48e7725879504bf655ff1333b43d1cb78f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa5e0d8728faaf7cf88bbbc17646c1b867384f8d32173671fa5e13a2220adab8f64949d77216e3a47dc65388deca98428bc035696e77be098ac8f0205389f6f"} build_url:https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011206 build_url: 'https://queue.taskcluster.net/v1/task/T4CTCnRwTqKhRK4q94_ezg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f0eac4ff4131a074031e99fa3dcc03420b2fc7edc03fe8e0abf4bc588f443d3f294689967e5ba1efe7a189a9c65c24a7bacd504b6be2db3945bd680f4482961", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/92d6f785335596347df3cde7f7c3b30dcde53f0ce5bb96a62b84c386c563d55482a76b26c40b286ebd547928a5e5d4b1dba535d87e5b5c346b5dab53e991dd96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad53721ec6735881153617a8d51de6d836c1c873d8ce5af01c5394d926d9c5bf341b059742c7d3987acdb6b4e0de48e7725879504bf655ff1333b43d1cb78f1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa5e0d8728faaf7cf88bbbc17646c1b867384f8d32173671fa5e13a2220adab8f64949d77216e3a47dc65388deca98428bc035696e77be098ac8f0205389f6f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-30 07:55:27.869183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:55:27.870016) ========= 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.xxqvhSZnLi/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.AZ7UwMXMjC/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.004977 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-30 07:55:27.923514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 07:55:27.924284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-30 07:55:27.924941) ========= ========= Total master_lag: 0.20 =========