builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0256 starttime: 1476975393.32 results: success (0) buildid: 20161020065049 builduid: 8689e5b19be84d7c951db8ec90d0addb revision: 28693367b10643274c2a1e754b98f35231d765b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.315775) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.316242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.316541) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.341324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.341758) ========= 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.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 --2016-10-20 07:56:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2016-10-20 07:56:33 (21.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143877 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.611162) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.611515) ========= 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.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.024708 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:33.656670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 07:56:33.657017) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 28693367b10643274c2a1e754b98f35231d765b7 --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 28693367b10643274c2a1e754b98f35231d765b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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 2016-10-20 07:56:33,736 truncating revision to first 12 chars 2016-10-20 07:56:33,736 Setting DEBUG logging. 2016-10-20 07:56:33,736 attempt 1/10 2016-10-20 07:56:33,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/28693367b106?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 07:56:35,722 unpacking tar archive at: mozilla-aurora-28693367b106/testing/mozharness/ program finished with exit code 0 elapsedTime=2.254827 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 07:56:35.933938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:35.934259) ========= script_repo_revision: 28693367b10643274c2a1e754b98f35231d765b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:35.934671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:35.934935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 07:56:35.954158) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 07:56:35.954569) ========= /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.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:56:36 INFO - MultiFileLogger online at 20161020 07:56:36 in /builds/slave/test 07:56:36 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:56:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:36 INFO - {'append_to_log': False, 07:56:36 INFO - 'base_work_dir': '/builds/slave/test', 07:56:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:56:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:36 INFO - 'branch': 'Mozilla-Aurora', 07:56:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:36 INFO - 'config_files': ('talos/mac_config.py',), 07:56:36 INFO - 'default_actions': ('clobber', 07:56:36 INFO - 'read-buildbot-config', 07:56:36 INFO - 'download-and-extract', 07:56:36 INFO - 'populate-webroot', 07:56:36 INFO - 'create-virtualenv', 07:56:36 INFO - 'install', 07:56:36 INFO - 'run-tests'), 07:56:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:36 INFO - 'download_minidump_stackwalk': True, 07:56:36 INFO - 'download_symbols': 'ondemand', 07:56:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:36 INFO - 'installer_path': 'installer.exe', 07:56:36 INFO - 'log_level': 'info', 07:56:36 INFO - 'log_name': 'talos', 07:56:36 INFO - 'log_to_console': True, 07:56:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:36 INFO - 'opt_config_files': (), 07:56:36 INFO - 'pip_index': False, 07:56:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:36 INFO - 'cmd': ('bash', 07:56:36 INFO - '-c', 07:56:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:36 INFO - 'enabled': True, 07:56:36 INFO - 'halt_on_failure': False, 07:56:36 INFO - 'name': 'check_screen_resolution'},), 07:56:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:36 INFO - 'cmd': ('bash', 07:56:36 INFO - '-c', 07:56:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:36 INFO - 'enabled': True, 07:56:36 INFO - 'halt_on_failure': False, 07:56:36 INFO - 'name': 'check_screen_resolution'},), 07:56:36 INFO - 'run_cmd_checks_enabled': True, 07:56:36 INFO - 'sps_profile': False, 07:56:36 INFO - 'sps_profile_interval': 0, 07:56:36 INFO - 'suite': 'dromaeojs', 07:56:36 INFO - 'system_bits': '32', 07:56:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:36 INFO - 'title': 't-yosemite-r7-0256', 07:56:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:36 INFO - 'use_talos_json': True, 07:56:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:36 INFO - 'work_dir': 'build'} 07:56:36 INFO - [mozharness: 2016-10-20 14:56:36.167713Z] Running clobber step. 07:56:36 INFO - Running pre-action listener: _resource_record_pre_action 07:56:36 INFO - Running main action method: clobber 07:56:36 INFO - rmtree: /builds/slave/test/build 07:56:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:38 INFO - Running post-action listener: _resource_record_post_action 07:56:38 INFO - [mozharness: 2016-10-20 14:56:38.403617Z] Finished clobber step (success) 07:56:38 INFO - [mozharness: 2016-10-20 14:56:38.403784Z] Running read-buildbot-config step. 07:56:38 INFO - Running pre-action listener: _resource_record_pre_action 07:56:38 INFO - Running main action method: read_buildbot_config 07:56:38 INFO - Using buildbot properties: 07:56:38 INFO - { 07:56:38 INFO - "project": "", 07:56:38 INFO - "product": "firefox", 07:56:38 INFO - "script_repo_revision": "production", 07:56:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:56:38 INFO - "repository": "", 07:56:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:56:38 INFO - "buildid": "20161020065049", 07:56:38 INFO - "pgo_build": "False", 07:56:38 INFO - "basedir": "/builds/slave/test", 07:56:38 INFO - "buildnumber": 45, 07:56:38 INFO - "slavename": "t-yosemite-r7-0256", 07:56:38 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:56:38 INFO - "platform": "yosemite_r7", 07:56:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:56:38 INFO - "branch": "mozilla-aurora", 07:56:38 INFO - "repo_path": "releases/mozilla-aurora", 07:56:38 INFO - "revision": "28693367b10643274c2a1e754b98f35231d765b7", 07:56:38 INFO - "stage_platform": "macosx64", 07:56:38 INFO - "builduid": "8689e5b19be84d7c951db8ec90d0addb", 07:56:38 INFO - "slavebuilddir": "test" 07:56:38 INFO - } 07:56:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 07:56:38 INFO - Running post-action listener: _resource_record_post_action 07:56:38 INFO - [mozharness: 2016-10-20 14:56:38.407108Z] Finished read-buildbot-config step (success) 07:56:38 INFO - [mozharness: 2016-10-20 14:56:38.407229Z] Running download-and-extract step. 07:56:38 INFO - Running pre-action listener: _resource_record_pre_action 07:56:38 INFO - Running main action method: download_and_extract 07:56:38 INFO - mkdir: /builds/slave/test/build/tests 07:56:38 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:56:38 INFO - trying https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 07:56:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 07:56:39 INFO - Downloaded 1199 bytes. 07:56:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 07:56:39 INFO - Using the following test package requirements: 07:56:39 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:56:39 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 07:56:39 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 07:56:39 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'jsshell-mac.zip'], 07:56:39 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 07:56:39 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 07:56:39 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 07:56:39 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 07:56:39 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 07:56:39 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 07:56:39 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 07:56:39 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:56:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:56:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:39 INFO - Fetch https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:56:40 INFO - Expected file size: 16436084 07:56:47 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 07:56:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:47 INFO - Fetch https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 07:56:47 INFO - Expected file size: 16436084 07:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 07:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 07:56:54 INFO - Expected file size: 14414081 07:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:56:55 INFO - trying https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 07:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 07:56:58 INFO - Downloaded 115423448 bytes. 07:56:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:56:58 INFO - mkdir: /builds/slave/test/properties 07:56:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:58 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:58 INFO - Contents: 07:56:58 INFO - build_url:https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 07:56:59 INFO - Running post-action listener: _resource_record_post_action 07:56:59 INFO - Running post-action listener: set_extra_try_arguments 07:56:59 INFO - [mozharness: 2016-10-20 14:56:59.243812Z] Finished download-and-extract step (success) 07:56:59 INFO - [mozharness: 2016-10-20 14:56:59.243935Z] Running populate-webroot step. 07:56:59 INFO - Running pre-action listener: _resource_record_pre_action 07:56:59 INFO - Running main action method: populate_webroot 07:56:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:59 INFO - '--tppagecycles', 07:56:59 INFO - '7'], 07:56:59 INFO - 'tests': ['tsvgm']}}, 07:56:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['damp', 'tps']}, 07:56:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'tests': ['damp', 'tps']}, 07:56:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['dromaeo_dom']}, 07:56:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['basic_compositor_video']}, 07:56:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['a11yr', 07:56:59 INFO - 'ts_paint', 07:56:59 INFO - 'tpaint', 07:56:59 INFO - 'sessionrestore', 07:56:59 INFO - 'sessionrestore_no_auto_restore', 07:56:59 INFO - 'tabpaint']}, 07:56:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['tsvgx', 07:56:59 INFO - 'tsvgr_opacity', 07:56:59 INFO - 'tart', 07:56:59 INFO - 'tscrollx', 07:56:59 INFO - 'cart']}, 07:56:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:59 INFO - 'tsvgr_opacity', 07:56:59 INFO - 'tart', 07:56:59 INFO - 'tscrollx', 07:56:59 INFO - 'cart']}, 07:56:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'talos_options': ['--disable-e10s'], 07:56:59 INFO - 'tests': ['tp5o']}, 07:56:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'tests': ['tp5o']}, 07:56:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'talos_options': ['--disable-e10s', 07:56:59 INFO - '--xperf_path', 07:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:59 INFO - 'tests': ['tp5n']}, 07:56:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:56:59 INFO - 'talos_options': ['--xperf_path', 07:56:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:59 INFO - 'tests': ['tp5n']}}, 07:56:59 INFO - 'talos.zip': {'path': '', 07:56:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:59 INFO - Running post-action listener: _resource_record_post_action 07:56:59 INFO - [mozharness: 2016-10-20 14:56:59.263120Z] Finished populate-webroot step (success) 07:56:59 INFO - [mozharness: 2016-10-20 14:56:59.263224Z] Running create-virtualenv step. 07:56:59 INFO - Running pre-action listener: _resource_record_pre_action 07:56:59 INFO - Running main action method: create_virtualenv 07:56:59 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:59 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:56:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:59 INFO - Using real prefix '/tools/python27' 07:56:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:57:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:57:03 INFO - Installing pip.................done. 07:57:03 INFO - Return code: 0 07:57:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:57: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:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57: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', 'pip>=1.5'] in /builds/slave/test/build 07:57: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 pip>=1.5 07:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:03 INFO - 'HOME': '/Users/cltbld', 07:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:03 INFO - 'LOGNAME': 'cltbld', 07:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:03 INFO - 'MOZ_NO_REMOTE': '1', 07:57:03 INFO - 'NO_EM_RESTART': '1', 07:57:03 INFO - 'PAGER': '/bin/cat', 07:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:03 INFO - 'PWD': '/builds/slave/test', 07:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:03 INFO - 'SHELL': '/bin/bash', 07:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:03 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:03 INFO - 'USER': 'cltbld', 07:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:03 INFO - 'XPC_FLAGS': '0x0', 07:57:03 INFO - 'XPC_SERVICE_NAME': '0', 07:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:03 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:57:03 INFO - Cleaning up... 07:57:03 INFO - Return code: 0 07:57:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:57: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:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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', '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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:57: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 psutil>=3.1.1 07:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:03 INFO - 'HOME': '/Users/cltbld', 07:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:03 INFO - 'LOGNAME': 'cltbld', 07:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:03 INFO - 'MOZ_NO_REMOTE': '1', 07:57:03 INFO - 'NO_EM_RESTART': '1', 07:57:03 INFO - 'PAGER': '/bin/cat', 07:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:03 INFO - 'PWD': '/builds/slave/test', 07:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:03 INFO - 'SHELL': '/bin/bash', 07:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:03 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:03 INFO - 'USER': 'cltbld', 07:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:03 INFO - 'XPC_FLAGS': '0x0', 07:57:03 INFO - 'XPC_SERVICE_NAME': '0', 07:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:03 INFO - Downloading/unpacking psutil>=3.1.1 07:57: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:57: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:57: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:57: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:57: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:57: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:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:57:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:06 INFO - Installing collected packages: psutil 07:57:06 INFO - Running setup.py install for psutil 07:57:07 INFO - building 'psutil._psutil_osx' extension 07:57:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:57:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:57:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:57:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:57:07 INFO - building 'psutil._psutil_posix' extension 07:57:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:57:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:57:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:57:07 INFO - ^ 07:57:07 INFO - 1 warning generated. 07:57:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:08 INFO - Successfully installed psutil 07:57:08 INFO - Cleaning up... 07:57:08 INFO - Return code: 0 07:57:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:57: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:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:08 INFO - 'HOME': '/Users/cltbld', 07:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:08 INFO - 'LOGNAME': 'cltbld', 07:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:08 INFO - 'MOZ_NO_REMOTE': '1', 07:57:08 INFO - 'NO_EM_RESTART': '1', 07:57:08 INFO - 'PAGER': '/bin/cat', 07:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:08 INFO - 'PWD': '/builds/slave/test', 07:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:08 INFO - 'SHELL': '/bin/bash', 07:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:08 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:08 INFO - 'USER': 'cltbld', 07:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:08 INFO - 'XPC_FLAGS': '0x0', 07:57:08 INFO - 'XPC_SERVICE_NAME': '0', 07:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:57:10 INFO - Installing collected packages: mozsystemmonitor 07:57:10 INFO - Running setup.py install for mozsystemmonitor 07:57:11 INFO - Successfully installed mozsystemmonitor 07:57:11 INFO - Cleaning up... 07:57:11 INFO - Return code: 0 07:57:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:11 INFO - 'HOME': '/Users/cltbld', 07:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:11 INFO - 'LOGNAME': 'cltbld', 07:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:11 INFO - 'MOZ_NO_REMOTE': '1', 07:57:11 INFO - 'NO_EM_RESTART': '1', 07:57:11 INFO - 'PAGER': '/bin/cat', 07:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:11 INFO - 'PWD': '/builds/slave/test', 07:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:11 INFO - 'SHELL': '/bin/bash', 07:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:11 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:11 INFO - 'USER': 'cltbld', 07:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:11 INFO - 'XPC_FLAGS': '0x0', 07:57:11 INFO - 'XPC_SERVICE_NAME': '0', 07:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:57:11 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:57:11 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:57:11 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:57:11 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:57:11 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:57:11 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:57:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:57:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:57:13 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:57:13 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:57:13 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:57:13 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:57:13 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:57:13 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:57:14 INFO - Downloading functools32-3.2.3-2.tar.gz 07:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:57:14 INFO - warning: no files found matching '*.txt' 07:57:14 INFO - no previously-included directories found matching 'build' 07:57:14 INFO - no previously-included directories found matching 'dist' 07:57:14 INFO - no previously-included directories found matching '.git*' 07:57:14 INFO - Installing collected packages: jsonschema, functools32 07:57:14 INFO - Running setup.py install for functools32 07:57:14 INFO - warning: no files found matching '*.txt' 07:57:14 INFO - no previously-included directories found matching 'build' 07:57:14 INFO - no previously-included directories found matching 'dist' 07:57:14 INFO - no previously-included directories found matching '.git*' 07:57:14 INFO - Successfully installed jsonschema functools32 07:57:14 INFO - Cleaning up... 07:57:14 INFO - Return code: 0 07:57:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:14 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:57:14 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:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:14 INFO - 'HOME': '/Users/cltbld', 07:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:14 INFO - 'LOGNAME': 'cltbld', 07:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:14 INFO - 'MOZ_NO_REMOTE': '1', 07:57:14 INFO - 'NO_EM_RESTART': '1', 07:57:14 INFO - 'PAGER': '/bin/cat', 07:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:14 INFO - 'PWD': '/builds/slave/test', 07:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:14 INFO - 'SHELL': '/bin/bash', 07:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:14 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:14 INFO - 'USER': 'cltbld', 07:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:14 INFO - 'XPC_FLAGS': '0x0', 07:57:14 INFO - 'XPC_SERVICE_NAME': '0', 07:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:57:14 INFO - Cleaning up... 07:57:14 INFO - Return code: 0 07:57:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:14 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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:14 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:57:14 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:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:14 INFO - 'HOME': '/Users/cltbld', 07:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:14 INFO - 'LOGNAME': 'cltbld', 07:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:14 INFO - 'MOZ_NO_REMOTE': '1', 07:57:14 INFO - 'NO_EM_RESTART': '1', 07:57:14 INFO - 'PAGER': '/bin/cat', 07:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:14 INFO - 'PWD': '/builds/slave/test', 07:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:14 INFO - 'SHELL': '/bin/bash', 07:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:14 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:14 INFO - 'USER': 'cltbld', 07:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:14 INFO - 'XPC_FLAGS': '0x0', 07:57:14 INFO - 'XPC_SERVICE_NAME': '0', 07:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:57: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:57: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:57: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:57: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:57: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:57: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:57:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:17 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:57:17 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:57:17 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:57:17 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:57:17 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:57:17 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:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:18 INFO - Downloading docopt-0.6.1.tar.gz 07:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:18 INFO - Running setup.py install for blobuploader 07:57:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:19 INFO - Running setup.py install for requests 07:57:19 INFO - Running setup.py install for docopt 07:57:19 INFO - Successfully installed blobuploader requests docopt 07:57:19 INFO - Cleaning up... 07:57:19 INFO - Return code: 0 07:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57: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:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:19 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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:19 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:57:19 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:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:19 INFO - 'HOME': '/Users/cltbld', 07:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:19 INFO - 'LOGNAME': 'cltbld', 07:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:19 INFO - 'MOZ_NO_REMOTE': '1', 07:57:19 INFO - 'NO_EM_RESTART': '1', 07:57:19 INFO - 'PAGER': '/bin/cat', 07:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:19 INFO - 'PWD': '/builds/slave/test', 07:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:19 INFO - 'SHELL': '/bin/bash', 07:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:19 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:19 INFO - 'USER': 'cltbld', 07:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:19 INFO - 'XPC_FLAGS': '0x0', 07:57:19 INFO - 'XPC_SERVICE_NAME': '0', 07:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mhUQgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Uaai54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-HEFVwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-_8tCdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-kGkdk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-G5mYwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Rc7eWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-j934Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-KQM_ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:20 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-MUeiOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1umQAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-HMevfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-I3XzT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-r_idgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-V2Upeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-6k_OjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:21 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-tED9EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:21 INFO - Running setup.py install for manifestparser 07:57:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:21 INFO - Running setup.py install for mozcrash 07:57:22 INFO - Running setup.py install for mozdebug 07:57:22 INFO - Running setup.py install for mozdevice 07:57:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Running setup.py install for mozfile 07:57:22 INFO - Running setup.py install for mozhttpd 07:57:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Running setup.py install for mozinfo 07:57:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Running setup.py install for mozInstall 07:57:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:22 INFO - Running setup.py install for mozleak 07:57:23 INFO - Running setup.py install for mozlog 07:57:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Running setup.py install for moznetwork 07:57:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Running setup.py install for mozprocess 07:57:23 INFO - Running setup.py install for mozprofile 07:57:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Running setup.py install for mozrunner 07:57:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:23 INFO - Running setup.py install for mozscreenshot 07:57:24 INFO - Running setup.py install for moztest 07:57:24 INFO - Running setup.py install for mozversion 07:57:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:24 INFO - Cleaning up... 07:57:24 INFO - Return code: 0 07:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:24 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:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:24 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:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:24 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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:24 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:57:24 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:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:24 INFO - 'HOME': '/Users/cltbld', 07:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:24 INFO - 'LOGNAME': 'cltbld', 07:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:24 INFO - 'MOZ_NO_REMOTE': '1', 07:57:24 INFO - 'NO_EM_RESTART': '1', 07:57:24 INFO - 'PAGER': '/bin/cat', 07:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:24 INFO - 'PWD': '/builds/slave/test', 07:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:24 INFO - 'SHELL': '/bin/bash', 07:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:24 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:24 INFO - 'USER': 'cltbld', 07:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:24 INFO - 'XPC_FLAGS': '0x0', 07:57:24 INFO - 'XPC_SERVICE_NAME': '0', 07:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:24 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Re87fq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:24 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-J6NARd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:24 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-mrRANw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:24 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:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:24 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-497FfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-OOugua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-1DBfYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-pT2YG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-sDUeDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-vny2at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-LCw8z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-HcWyZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:25 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-yxv_67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:25 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-cOgDDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:26 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:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:26 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-CMSbzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:26 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-QXv2yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:26 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:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:26 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-ne0mOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:57:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:26 INFO - Running setup.py (path:/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/pip-Eac71u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:26 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:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:57:26 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:57:26 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:26 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:26 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:57:29 INFO - Downloading blessings-1.6.tar.gz 07:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:29 INFO - Installing collected packages: blessings 07:57:29 INFO - Running setup.py install for blessings 07:57:29 INFO - Successfully installed blessings 07:57:29 INFO - Cleaning up... 07:57:29 INFO - Return code: 0 07:57:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:29 INFO - Reading from file tmpfile_stdout 07:57:29 INFO - Current package versions: 07:57:29 INFO - blessings == 1.6 07:57:29 INFO - blobuploader == 1.2.4 07:57:29 INFO - docopt == 0.6.1 07:57:29 INFO - functools32 == 3.2.3-2 07:57:29 INFO - jsonschema == 2.5.1 07:57:29 INFO - manifestparser == 1.1 07:57:29 INFO - mozInstall == 1.12 07:57:29 INFO - mozcrash == 0.17 07:57:29 INFO - mozdebug == 0.1 07:57:29 INFO - mozdevice == 0.48 07:57:29 INFO - mozfile == 1.2 07:57:29 INFO - mozhttpd == 0.7 07:57:29 INFO - mozinfo == 0.9 07:57:29 INFO - mozleak == 0.1 07:57:29 INFO - mozlog == 3.4 07:57:29 INFO - moznetwork == 0.27 07:57:29 INFO - mozprocess == 0.23 07:57:29 INFO - mozprofile == 0.28 07:57:29 INFO - mozrunner == 6.12 07:57:29 INFO - mozscreenshot == 0.1 07:57:29 INFO - mozsystemmonitor == 0.3 07:57:29 INFO - moztest == 0.7 07:57:29 INFO - mozversion == 1.4 07:57:29 INFO - psutil == 3.1.1 07:57:29 INFO - requests == 1.2.3 07:57:29 INFO - wsgiref == 0.1.2 07:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:29 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:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:29 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:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:29 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 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:29 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:57:29 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:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:29 INFO - 'HOME': '/Users/cltbld', 07:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:29 INFO - 'LOGNAME': 'cltbld', 07:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:29 INFO - 'MOZ_NO_REMOTE': '1', 07:57:29 INFO - 'NO_EM_RESTART': '1', 07:57:29 INFO - 'PAGER': '/bin/cat', 07:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:29 INFO - 'PWD': '/builds/slave/test', 07:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:29 INFO - 'SHELL': '/bin/bash', 07:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:29 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:29 INFO - 'USER': 'cltbld', 07:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:29 INFO - 'XPC_FLAGS': '0x0', 07:57:29 INFO - 'XPC_SERVICE_NAME': '0', 07:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 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:57:29 INFO - Cleaning up... 07:57:29 INFO - Return code: 0 07:57:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:29 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:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1057bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105732570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84b2d945d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, '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.TSHtqO9j48/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.d5tf8jreBa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:30 INFO - 'HOME': '/Users/cltbld', 07:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:30 INFO - 'LOGNAME': 'cltbld', 07:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:30 INFO - 'MOZ_NO_REMOTE': '1', 07:57:30 INFO - 'NO_EM_RESTART': '1', 07:57:30 INFO - 'PAGER': '/bin/cat', 07:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:30 INFO - 'PWD': '/builds/slave/test', 07:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:30 INFO - 'SHELL': '/bin/bash', 07:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:57:30 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:30 INFO - 'USER': 'cltbld', 07:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:30 INFO - 'XPC_FLAGS': '0x0', 07:57:30 INFO - 'XPC_SERVICE_NAME': '0', 07:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:30 INFO - Cleaning up... 07:57:30 INFO - Return code: 0 07:57:30 INFO - Running post-action listener: _resource_record_post_action 07:57:30 INFO - Running post-action listener: _start_resource_monitoring 07:57:30 INFO - Starting resource monitoring. 07:57:30 INFO - [mozharness: 2016-10-20 14:57:30.569612Z] Finished create-virtualenv step (success) 07:57:30 INFO - [mozharness: 2016-10-20 14:57:30.570648Z] Running install step. 07:57:30 INFO - Running pre-action listener: _resource_record_pre_action 07:57:30 INFO - Running main action method: install 07:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:30 INFO - Reading from file tmpfile_stdout 07:57:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:30 INFO - Reading from file tmpfile_stdout 07:57:30 INFO - Output received: 07:57:30 INFO - Usage: mozinstall [options] installer 07:57:30 INFO - Options: 07:57:30 INFO - -h, --help show this help message and exit 07:57:30 INFO - -d DEST, --destination=DEST 07:57:30 INFO - Directory to install application into. [default: 07:57:30 INFO - "/builds/slave/test"] 07:57:30 INFO - --app=APP Application being installed. [default: firefox] 07:57:30 INFO - mkdir: /builds/slave/test/build/application 07:57:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:58:03 INFO - Reading from file tmpfile_stdout 07:58:03 INFO - Output received: 07:58:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:58:03 INFO - Running post-action listener: _resource_record_post_action 07:58:03 INFO - [mozharness: 2016-10-20 14:58:03.646174Z] Finished install step (success) 07:58:03 INFO - [mozharness: 2016-10-20 14:58:03.646296Z] Running run-tests step. 07:58:03 INFO - Running pre-action listener: _resource_record_pre_action 07:58:03 INFO - Running main action method: run_tests 07:58:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:03 INFO - 2016-10-20 07:58:03.660 screenresolution[1644:7612] starting screenresolution argv=screenresolution get 07:58:03 INFO - 2016-10-20 07:58:03.663 screenresolution[1644:7612] Display 0: 1600x1200x32@60 07:58:03 INFO - 2016-10-20 07:58:03.669 screenresolution[1645:7614] starting screenresolution argv=screenresolution list 07:58:03 INFO - Available Modes on Display 0 07:58:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:03 INFO - Intel Iris: 07:58:03 INFO - Chipset Model: Intel Iris 07:58:03 INFO - Type: GPU 07:58:03 INFO - Bus: Built-In 07:58:03 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:03 INFO - Vendor: Intel (0x8086) 07:58:03 INFO - Device ID: 0x0a2e 07:58:03 INFO - Revision ID: 0x0009 07:58:03 INFO - Displays: 07:58:03 INFO - Display: 07:58:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:03 INFO - Display Serial Number: 1600x1200 60 07:58:03 INFO - Main Display: Yes 07:58:03 INFO - Mirror: Off 07:58:03 INFO - Online: Yes 07:58:03 INFO - Rotation: Supported 07:58:03 INFO - Return code: 0 07:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:03 INFO - Python 2.7.3 07:58:03 INFO - Return code: 0 07:58:03 INFO - grabbing minidump binary from tooltool 07:58: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:58:03 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 0x1055d0d30>, '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 0x105436db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055c8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:03 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:58:03 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:58:03 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:58:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:04 INFO - Return code: 0 07:58:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:58:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:58:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:04 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/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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:58:04 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/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0256 --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:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TSHtqO9j48/Render', 07:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:04 INFO - 'HOME': '/Users/cltbld', 07:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:04 INFO - 'LOGNAME': 'cltbld', 07:58:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:04 INFO - 'MOZ_NO_REMOTE': '1', 07:58:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:04 INFO - 'NO_EM_RESTART': '1', 07:58:04 INFO - 'PAGER': '/bin/cat', 07:58:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:04 INFO - 'PWD': '/builds/slave/test', 07:58:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:04 INFO - 'SHELL': '/bin/bash', 07:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d5tf8jreBa/Listeners', 07:58:04 INFO - 'TMPDIR': '/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/', 07:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:04 INFO - 'USER': 'cltbld', 07:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:04 INFO - 'XPC_FLAGS': '0x0', 07:58:04 INFO - 'XPC_SERVICE_NAME': '0', 07:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:04 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/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0256', '--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:58:04 INFO - mozversion application_buildid: 20161020065049 07:58:04 INFO - mozversion application_changeset: 28693367b10643274c2a1e754b98f35231d765b7 07:58:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:58:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:04 INFO - mozversion application_name: Firefox 07:58:04 INFO - mozversion application_remotingname: firefox-dev 07:58:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:58:04 INFO - mozversion application_vendor: Mozilla 07:58:04 INFO - mozversion application_version: 51.0a2 07:58:04 INFO - mozversion platform_buildid: 20161020065049 07:58:04 INFO - mozversion platform_changeset: 28693367b10643274c2a1e754b98f35231d765b7 07:58:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:58:04 INFO - mozversion platform_version: 51.0a2 07:58:04 INFO - using testdate: 1476975484 07:58:04 INFO - actual date: 1476975484 07:58:04 INFO - starting webserver on 'localhost:49267' 07:58:04 INFO - SUITE-START | Running 2 tests 07:58:04 INFO - TEST-START | dromaeo_css 07:58:04 INFO - operating with platform_type : mac_ 07:58:04 INFO - Initialising browser for dromaeo_css test... 07:58:04 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpOgf4Si/profile http://localhost:49267/getInfo.html) 07:58:06 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 07:58:06 INFO - PROCESS | 1655 | colorDepth:24 07:58:06 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 07:58:06 INFO - PROCESS | 1655 | __metrics 07:58:06 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:58:06 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:07 INFO - TEST-INFO | 1655: exit 0 07:58:07 INFO - Browser initialized. 07:58:07 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:07 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpOgf4Si/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:19 INFO - PROCESS | 1657 | RSS: Main: 219955200 07:58:19 INFO - PROCESS | 1657 | 07:59:10 INFO - PROCESS | 1657 | 1476975550125 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:01:21 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 08:01:23 INFO - PROCESS | 1657 | RSS: Main: 417513472 08:01:23 INFO - PROCESS | 1657 | 08:04:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 08:04:27 INFO - PROCESS | 1657 | RSS: Main: 352923648 08:04:27 INFO - PROCESS | 1657 | 08:07:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 08:07:30 INFO - PROCESS | 1657 | RSS: Main: 338251776 08:07:30 INFO - PROCESS | 1657 | 08:10:32 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 08:10:33 INFO - PROCESS | 1657 | RSS: Main: 334561280 08:10:33 INFO - PROCESS | 1657 | 08:13:36 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 08:13:37 INFO - PROCESS | 1657 | RSS: Main: 317943808 08:13:37 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 08:16:40 INFO - PROCESS | 1657 | RSS: Main: 409112576 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | __start_tp_report 08:16:40 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 08:16:40 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 08:16:40 INFO - PROCESS | 1657 | |i|pagename|runs| 08:16:40 INFO - PROCESS | 1657 | |0;dojo.html;3287.1946373138576;3314.6188188358337;3353.597568291805;3354.0608629583708;3400.574928133983;5764.337101233359;5805.36141024487;5834.066549352105;5856.2386889704385;5892.764289428423;4736.573708366246;5728.369879313273;5801.245838041049;5813.389594092623;5815.680137592431;5222.007818514489;5227.398849132342;5243.370795504536;5272.446393128724;5275.736213189344;4362.367456718774;5188.7146206958605;5190.974045129769;5317.149256119022;5334.279872217259;5218.765155568009;5239.869003274929;5261.316028916254;5281.023010743005;5284.39229488608;4377.6935614507;5254.395744489394;5317.813876514342;5334.546563542103;5336.866578335534;5230;5256.526912577848;5290.127129023706;5311.070562651559;5331.946680533184;5678.886422271573;5691.288588926384;5732.656040637575;5756.625819321731;5762.049261871828;5222.8694282642855;6195.473384762301;6221.222347206599;6250.218722659668;6410.134631824691;6233.252009758812;6248.937510624881;6296.96851515744;6301.117843501914;6315.842103947392;5731.9140212897255;5756.280464941882;5760.654360738369;5787.768489260382;5874.9118763218585;6208.099825525273;6237.875242495124;6284.12022316876;6293.716782744787;6303.054541818764;6229;6237.781677641261;6241.251049873953;6245.125682404467;6254.437100660963;6103.398280005586;6226.750929962751;6286.8428289292215;6322.747090116436;6325.7785977491485;6174.104754810617;6210.223722034746;6235.158253635792;6321.841953951096;6335.588186767845;6277.1525844010475;6295.653739044396;6308.400701933309;6310.62136271816;6321.146645202839;4853.781579828917;4912.926306105412;4961.4294356148785;4972.900541989212;4999.000199960023;4443.355713421536;4478.507364189936;4506.864794056183;4506.932396014063;4527.1172121436;5641.351244606841;5686.2323586315315;5696.11710184922;5703.486686198262;5704.771809127671;5231.215317702375;6317.810465686037;6321.65230912295;6330.272018717907;6339.397757213057;5687.146927960839;5712.7714891403875;5729.427057294237;5740.225069615549;5750.856228594235;5275.630705850554;5404.243405923174;5408.702521361284;5419.078756611386;5425.13197888336;6255.343188965184;6296.8425789354715;6304.211973503312;6304.275008373912;6309.810705678837;6214.25428948529;6281.214848143982;6286.277078136073;6327.651979141191;6330.715117819617;6287.748490060347;6303.243610766737;6312.368763123651;6318.020706790455;6323.336049714898;6016.338202797776;6265.686715664289;6280.152179455898;6290.339514350927;6296.150019747275;4862.610991120772;5324.520793128637;6002.429769171922;6193.349698281796;6193.845153871009;6054.606450580698;6055.757769689163;6073.453389194994;6087.934611443068;6094.39056094387;6005.90991135142;6094.055421409688;6098.207233059851;6101.816945491642;6109.877802444015;5044.873878153076;5941.22764040672;6031.638101713911;6096.481799047131;6106.389361063858;6173.660448675366;6186.845328866814;6194.0708893666315;6196.47329976957;6203.503719702323;5842.211301474246;6042.637441753509;6060.847840505181;6063.060225665029;6104.145419641342 08:16:40 INFO - PROCESS | 1657 | |1;ext.html;490.8306634211197;493.42762395621077;513.3788116379181;526.5445389737873;547.7179252684865;30576.38847223054;30614.693853061464;30926.690733092662;40032.59967400325;41438.792806035926;42175.57824421755;42524.14951700964;42646;42678.573214267846;42820.35769463461;9736.734224550817;9918.752031199241;9926.90073099267;9940.850887236697;9946.701598952042;8736.039035706068;8917.063708310632;10055.49722513875;10264;12139.514419423213;12011.939940300286;12072.879271207263;12110.333931633757;12111.576094836682;12167.756644867097;12111.394430278495;12179.269243845354;12195.512179512809;12207.023438124928;12225;7961.800954976114;8757.912420875773;11731.061515078858;12035.578754743541;12080.214786038967;39999.60000400017;40286.79856600727;40316.39525407121;40347.59652403497;40455;3312.7681062325646;3322.568066151409;3358.042957757052;3389.915252118692;3390.4066788312193;29601.703982960327;30854.92007779717;30930.690693093005;30997.69002309993;31260;3180.522921561761;3202.3595280943673;3225.741940644743;3241.3031198292247;3250.983745081283;494698;497647;501288;504576;504878;60741;60984.39015609787;61019;61102.38897610967;61240;63068;63104.684476578244;63285.367146327946;63295.68352158302;63296;16366;16882;16882.155892205585;16896.324147034225;16917.90033647809;11809.996150327146;13082.607521774362;13180.011499137412;13197;13242.602721918358;14401.78397324041;14864.777028344584;15996.360145594046;16414.343426263054;16491.257893394584;6830.59016459014;7252;7337.59643219628;7384.372328352043;7406.592637404887;805.8871757953891;945.7966537194536;969.8739163908647;993.9701808945598;1048.8269435543202;29189;30089.097327080224;30428.695713043027;30849.228769280948;30868.691313086583;901.5987885390938;996.14829320931;1019.6235082638378;1025.415513157493;1058.7617785998088;12394.132410731343;15567.052200715487;15626;15722.528324150293;16283.59291017734;692495;697592;699626;699730;701637;49478.257826132634;57606;57725.26824195281;57950.710246449344;57964;1288.7680217560928;1345.6366780969279;1394.6652803327331;1403.6069900427897;1404.206623257856;30204.69795302019;31242.375152496366;31242.687573123978;31421.057368278987;32110;45054;46253.30620040769;46387.30419043785;49565.50434495753;49573.25640115474;559004;579149;580312;584197;665680;25096.498070038862;26159;26163.34591635148;26428.489293517086;26493.602595960692;45783.77108114438;46043.76978115088;46376.768116159205;46504;46838.765806172116;37443.43834842534;38173.373529514654;39004.80497597494;39279.41080883846;40479.392809107296;38958.636447724195;39232.41151382789;40169;40499;40590.59409405986;37827.62172378241;38199.2360152801;38244.23511529698;38275.80862095672;38910.80544597259;32256.516152257267;33708.7374775427;34467.4829877547;34734.65265347415;35113.771018014246;25805.870970645028;25815.612765808903;25928.8703556481;26243.475130497663;26265.474690506464 08:16:40 INFO - PROCESS | 1657 | |2;jquery.html;355.71365051133824;378.1057798307004;382.48364707644686;389.59287544515985;411.1796965054716;15226.010309329886;15383.307751151196;18205.99999999998;20690.068946897387;20838.895805520988;19636;20130.09414576344;20223.494412639655;20745.688814667792;20760.792392076073;5901.645901245917;5953.2260806095255;6124.1732366130445;6133.325334213233;6205.875882482348;4185.28850095483;4386.254336762742;4386.451693538308;5364.329458817648;5993.61041532299;6754.324567543255;6866.690998905036;6885.621290829003;6897.206821215575;6898.551594146389;6573.112629794964;6789.219239787439;6870.141232345957;6871.587704737682;6876.209235937881;5746.25298711169;5884.529237660977;5976.820695379146;5986.491148252404;5996.2504686914135;25330.620040699403;25416.745832541623;25439.855206515753;25464.745352546423;25487.235382938543;2227.12028748645;2292.0487997481027;2307.8499897506777;2334.8482348647453;2468.7654672806057;15320.846791532054;15463.845361546466;15590.142542160176;15750.44873429436;15983;1854.6383455226237;1860.711589703598;1920.4142736465371;1928.5082304012387;1956.8043195680461;114761.4261928685;118370.40814795958;118723.81276187213;119000.40499797532;119299.4035029828;9003;10859.728506787393;11035.95158459945;11113.388353736866;11277;11505.597304094317;14039.50861719835;14046.508372207129;14068.08557443763;14093.71812563743;7180.8922866157045;8591.785205369792;8685.83141785326;8695.130486951255;8844.33667474942;8866.645334186689;8901.554922253861;8930.598123084477;9002.144796244347;9035.909640903637;6658.334166583303;6690.29751876046;6698.83252918681;6701.597904125768;6707.66461676924;1709.598244412562;1774.1661419132986;1815.546113471632;1844.5112045308003;1876.5402476393372;830.2942498875907;908.2280061947292;966.9419834809934;970.2965350121247;980.5244456438621;21638.675419868716;21926.336847041464;21940.365374085384;22127.889360553094;22128.660332139276;941.289326558444;957.6552441121191;989.5596459575564;1001.1190152665607;1002.3484734922358;10500.894991050145;11644.0102591279;11767.646970590897;11817.940910295394;11854.822177667342;617508;618864;620719;633081;633774;121701.39149304197;124228;124265.37867310605;125806.37096814458;128066;991.945443000642;993.1855878179967;1024.636254129788;1026.58423338548;1027.0551092994463;18725.90637046806;19020.144093515548;19269.325573604856;19272.93998830078;19284.325048623232;44446.555534445535;54635;54942;56984;57186.7140664294;74656;77229;79430.20569794228;79605;80019;7896.7236146734585;7983.640736167003;8125.349972002107;8164.387670924586;8165.632546535539;11026.724331891766;12860.935695321838;13142.277174755098;13154.736905262032;13342.93328533351;9814.165795907142;11052.392118433563;11211.495482703134;11415.200935934405;11514.596989105676;9874.815022197383;10906.50920708554;10999.450027498753;11074.944625276821;11548;11383.317000979967;11559.248648837798;11565.248258863146;11683.357415342238;11900.523979041087;6764.16636758772;6878.484113691593;7958.0848202457455;8098.635561399869;8173.754787356389;11242.437878106226;11595.710107247387;11599.76800463969;11673.533058677898;11744.647660570197 08:16:40 INFO - PROCESS | 1657 | |3;mootools.html;1536.3854458216713;1551.286408252204;1781.688204564201;1906.8855868647875;1942.8542859285558;8501.872471912919;9120.543972801366;9138.177564019254;9165.450072995616;9192.586333614987;8022.719204827832;8089.959550202256;8113.797155071126;8644.913550864505;8923.866142007859;2337.859728416292;2387.940301492468;2391.378241657173;2391.4380120671626;2396.6405039244164;2367.3726462487452;2390.2231774673214;2405.7113146422453;2409.7469765674614;2410.517896420714;2329.7186547398946;2336.9298921032396;2358.5636657218383;2358.6226203807396;2405.8436201646923;2125.3730149605826;2341.309313752447;2371.5612611666897;2374.3114496795906;2388.032846697073;2351.71779386473;2363.775441333071;2373.430376709577;2375.8099352051795;2378.4767351182713;8832.205101540829;9008.684696035607;9034.45793252407;9036.909630903738;9043.547822608909;5291.629585928987;5452.727363631802;5460.372057213432;5471.972640136813;5474.069408200616;3590.1922067534597;3620.5112309838096;3646.74472786905;3682.852685892561;3685.7972811495356;954.1746389373211;956.8277710012195;1100.8018556659797;1108.817045187543;1131.6378758797189;11694.239874408137;11839.64481065578;11845;11874.762504749942;11882.930536251779;4767.818224436598;4785.9042819144115;4789.856304310876;4908.141075311806;4912.410510738734;10154.54304556282;10159.644412445528;10162.898371016196;10188.949055254676;10210.744731381776;5422.349318081855;5426.593005524523;5431.131019036935;5432.728363581805;5437.401885792559;3869.6517313441364;4414.4702635683925;4539.72761634303;4635.629149668019;4956.504349565087;3915.647591716702;3967.444557761916;4024.074462873497;4059.6143366380147;4070.816813243411;1307.0719788949762;1314.2377421095741;1317.8682131786936;1329.3751936589788;1331.407523651985;907.6550910653909;916.4363916191628;930.2604429478446;930.5300823084434;941.0683423410911;4728.834490792806;5776.011919543084;5815.9709201453725;6117.143599896018;6246.937530624727;916.093067862811;953.594722243044;964.2816102003911;971.9805603888024;1019.7508052635462;3802.125511132455;3993.940090898639;4035.2736507428945;4064.7154699171365;4066.580384671116;10594.258401911793;10835.566577336818;10978.12175025996;10998.06516446095;11149.72125696864;10457.477126143662;10743.409112498888;10791.352518848895;10953.671389858317;11073.889261107446;8210.753677389568;8431.704890328809;8436.578171091543;8440;8453.830923381498;5906.763729450774;5976.641401515923;5994.3705910878725;5995.190649262294;6224.41848856954;10011;10285.897141028494;10330.845037324596;10339.844902326622;10366.844497332395;9733.318667693193;10038;10123.696289111338;10552.788944221225;10629.20280978945;6989.47578931572;7144.67848946809;7154.427645788429;7571.886421703569;7717.729879454192;6860.897086543606;8227.958860205661;8361.331093512383;8548.316134709332;8564.785880353042;7436.256374362521;7578.014858068415;7597.126330472067;7618.885716714364;7718.228177182237;6213.409726076015;7295.197528271779;7322.890156647761;7471.327580517779;7565.6973721050545;7030.718771249093;7045.11936007999;7079.504434689522;7096.609686467294;7106.182788979334;4985.75071246429;4995.950040499549;5007.599392048554;5024.271480635361;5049.671771334998;4508.639308855218;4914.336564563738;4962.8759281018265;5061.215511595708;5102.872428189325 08:16:40 INFO - PROCESS | 1657 | |4;prototype.html;254.89167103980816;304.81406342131305;314.50936538999156;316.74027297615936;319.3405617400069;4668.229742092559;4910.705357678542;5148.639595228336;5393.164059570763;5538.729121060366;4799.760011999395;4921.686807200619;5191.948080519193;5297.973510132453;5302.469753024705;3749.568799588048;3837.6737977271964;4041.4341992121126;4098.692598055143;4118.341065429532;3740.4763333133383;4096.938545921814;4105.774182419966;4123.917521649565;4132.752034877902;3542.5040494330815;3835.7506762060516;3895.8636447724334;4046.534648515429;4108;3928.37146056631;4075.347944328923;4082.183563287325;4119.258533463991;4140.627343539096;3262.4453842846774;3300.14196308959;3538.85844566217;3546.9113272168142;3574.891783547109;4682.461516925563;5042.899142017139;5332;5361.544268737162;5378.623496355257;4364.585364390377;4679.836205732817;4705.1765940960195;4727.527247275245;4730.0776348612035;4987.603471028118;5723.57073219506;5781;5800.709964501801;5813.505852002585;3925.234579257046;3944.921101577981;3947.585503522146;3949.19041596472;3955.6044395560502;5032.396112466491;5585.1063829787445;6014.428629280255;6024.57827952048;6030.577859549833;3451.620321764604;3455.6544345565244;3905.3751399776465;3955.940660890089;3980.089557012592;4033.2135233629747;4050;4056.7363121397016;4057.33054046085;4058.350663893822;4388.692791504564;4638.281066434708;4662.906741865211;4668.299755036704;4747.124885670141;4530.343100250511;5710.7430165642645;5755.640187523096;5781.595288329777;5805.506531944832;1216.2702378572785;1235.499622652809;1289.2973329535425;1321.8149459075737;1376.876081152681;859.8839156713889;862.9560220511228;882.4793371910475;917.8898532176181;918.2470374293016;5301.257823904656;5323.950279142558;5349.919751203735;5407.78368865241;5410.567154627621;5326.324835863242;5860.120981852756;5939.227900372924;5972.402759723993;5990.64056156632;5116.360454943132;5399.298091248191;5478.424765399655;5479.698616576047;5496.422875598085;2654.681438227425;2981.9552706709414;3063.969360306413;3092.2219723658536;3104.674009229044;5578.721063946868;6006.249218847644;6041.395860413923;6086.147939288503;6097.603655762361;5469;6009.789657361971;6039.758409663652;6070.544709146743;6099.8475038123515;5430.832371040246;5449.3460784706085;6001.179445660532;6037.335893051849;6077.4226448487325;5056.696598204119;5139.588832893434;5484;5880.14737863016;5902.468777810018;5775.653460792366;5788.797392091256;5812.244408227072;5828.883422331445;5842.824715258549;4784.30627558995;5245.501677340647;5953.553483488842;5992.550558708202;6009.369016253405;3905.687544996337;3931.4495970564717;3949.980250098731;3974.1852920150723;3977.6618987386396;5527.811520523107;5664.85837854057;5739.8565035874435;5961.314448838439;5993.61041532299;4990.72551009698;5275.762590683506;5591.82571659956;5863.941360586339;5919.881602368015;5573.749181286933;5846.258394627527;5857.677827719516;5860.0075974168985;5868.794592189253;4767.070421267819;5321.175217841241;5637.548996080386;5639.7744090237575;5712.742926568231;5634.985702573576;5760.366359700346;5791.942080579141;5822.272215973004;5823.912641310299;5057.468965758542;5454.78840548155;5697.971510142588;5711.942880571141;5722.938228047974 08:16:40 INFO - PROCESS | 1657 | |5;yui.html;590.3545605883668;683.9487038472113;756.3419824752459;763.9465237433382;820.6143112737011;15004.924975375121;16448.671026579475;16490;16901.408450704195;17453.47639570815;16455.588610284718;16804.915975420136;16850;16872.66254674906;16960.23678934448;690.4959379652831;844.2950136635901;868.288003836854;868.3617541107282;869.3219288954625;710.6411262312525;844.2317491083115;873.3842640938155;876.7282142535803;877.1535468273115;924.8982611912718;928.7213835849252;931.9767005824841;932.2774849491665;932.7341707613298;923.6166990698852;926.0184204742994;926.3237836379413;929.2890938432071;933.1834644685899;537.4169026606137;553.7120697237414;658.2002866517157;675.1796567170862;685.9984422742801;15527.922360388126;15544.06735595868;15549.144797036159;15563.221838908123;15590.142542160176;12907.870921290854;13258.204507729568;13349.998750093684;13464.5287414941;13471.191728496322;10896.836547451716;11488.655340339803;11503.654890353302;12847.871521284855;13142.277174755385;3887.5334959805004;3949.7235193536176;3970.682345412389;3977.2244412339605;3978.6817054635558;112258;114703.42648286706;116739;118429;120746;11028.944855275673;11064.557417703363;11074.224804263624;11109.888901110886;11147.944260278648;21909.671354929687;22057.11771529121;22134.22530211467;22138.88930555337;22190;7480.3641690456925;7559.055118110236;7811.257930496594;7903.091144518454;7937.404694647925;4272.46594175728;4374.868753937387;4458.888527786831;4586.197415452282;4629.699069560468;3130.89041883533;3516.824158792101;3542.911427214289;3557.6086630470627;3610.693091087287;646.6992848325457;648.1347401219425;650.5381179362611;650.9641969691712;660.089077073645;559.5188138201144;566.6345207341324;663.1213641924469;665.2615596687673;690.6098054599136;8925.275141936394;9493.762655933519;9521.285903557122;9557.856632150524;9907.950460247652;553.6318348298337;650.5836264790538;652.1326635574675;658.4403257231315;679.8776220280397;4442.267025940748;4498.842540511132;4678.251479763289;4679.555442232982;4719.0561887621925;103953;139646;156350.21824890803;158557;162053;111427.44286278517;136716;139245;140677;142846;102942;122833;124278.37860810637;128242;131993.34003329923;9037.382991038481;9134.314926380415;9203.447793132433;9608.471534065693;9973.950130249592;49734;51150;57753;61289.69355153374;62100.68949655223;66102;68721;69179;78651.21348786438;95936;11138.832917506406;12502.812457813323;12710.936445317715;13329.333533323488;13764.587062388144;14290.071145375518;15158.924205378902;15228.847711523185;15891.125988070768;15899.443519476763;14030.438782448588;14135;14158.646033849236;14508.709825803637;14630.414783408545;13092.541761038317;13203.735925281248;14109.2945352734;14132.010759246754;14659.70680586361;13430.261335626243;13642.522511712043;13828.516001939885;14479.20364379927;14516.129032258099;10709.08972737295;10782.245242832927;10892.836607450736;11487.25332853362;11805.996490298077;10203;11437.256578322382;11573.247738896946;11834.171607987359;11839.230450020721 08:16:40 INFO - PROCESS | 1657 | __end_tp_report 08:16:40 INFO - PROCESS | 1657 | __start_cc_report 08:16:40 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1817 08:16:40 INFO - PROCESS | 1657 | __end_cc_report 08:16:40 INFO - PROCESS | 1657 | __startTimestamp1476976600877__endTimestamp 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | ------- Summary: start ------- 08:16:40 INFO - PROCESS | 1657 | Number of tests: 6 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5736.19 Median:6002.43 stddev:665.59 (11.1%) stddev-sans-first:639.30 08:16:40 INFO - PROCESS | 1657 | Values: 3287.2 3314.6 3353.6 3354.1 3400.6 5764.3 5805.4 5834.1 5856.2 5892.8 4736.6 5728.4 5801.2 5813.4 5815.7 5222.0 5227.4 5243.4 5272.4 5275.7 4362.4 5188.7 5191.0 5317.1 5334.3 5218.8 5239.9 5261.3 5281.0 5284.4 4377.7 5254.4 5317.8 5334.5 5336.9 5230.0 5256.5 5290.1 5311.1 5331.9 5678.9 5691.3 5732.7 5756.6 5762.0 5222.9 6195.5 6221.2 6250.2 6410.1 6233.3 6248.9 6297.0 6301.1 6315.8 5731.9 5756.3 5760.7 5787.8 5874.9 6208.1 6237.9 6284.1 6293.7 6303.1 6229.0 6237.8 6241.3 6245.1 6254.4 6103.4 6226.8 6286.8 6322.7 6325.8 6174.1 6210.2 6235.2 6321.8 6335.6 6277.2 6295.7 6308.4 6310.6 6321.1 4853.8 4912.9 4961.4 4972.9 4999.0 4443.4 4478.5 4506.9 4506.9 4527.1 5641.4 5686.2 5696.1 5703.5 5704.8 5231.2 6317.8 6321.7 6330.3 6339.4 5687.1 5712.8 5729.4 5740.2 5750.9 5275.6 5404.2 5408.7 5419.1 5425.1 6255.3 6296.8 6304.2 6304.3 6309.8 6214.3 6281.2 6286.3 6327.7 6330.7 6287.7 6303.2 6312.4 6318.0 6323.3 6016.3 6265.7 6280.2 6290.3 6296.2 4862.6 5324.5 6002.4 6193.3 6193.8 6054.6 6055.8 6073.5 6087.9 6094.4 6005.9 6094.1 6098.2 6101.8 6109.9 5044.9 5941.2 6031.6 6096.5 6106.4 6173.7 6186.8 6194.1 6196.5 6203.5 5842.2 6042.6 6060.8 6063.1 6104.1 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:72565.94 Median:38186.30 stddev:161510.87 (423.0%) stddev-sans-first:161873.30 08:16:40 INFO - PROCESS | 1657 | Values: 490.8 493.4 513.4 526.5 547.7 30576.4 30614.7 30926.7 40032.6 41438.8 42175.6 42524.1 42646.0 42678.6 42820.4 9736.7 9918.8 9926.9 9940.9 9946.7 8736.0 8917.1 10055.5 10264.0 12139.5 12011.9 12072.9 12110.3 12111.6 12167.8 12111.4 12179.3 12195.5 12207.0 12225.0 7961.8 8757.9 11731.1 12035.6 12080.2 39999.6 40286.8 40316.4 40347.6 40455.0 3312.8 3322.6 3358.0 3389.9 3390.4 29601.7 30854.9 30930.7 30997.7 31260.0 3180.5 3202.4 3225.7 3241.3 3251.0 494698.0 497647.0 501288.0 504576.0 504878.0 60741.0 60984.4 61019.0 61102.4 61240.0 63068.0 63104.7 63285.4 63295.7 63296.0 16366.0 16882.0 16882.2 16896.3 16917.9 11810.0 13082.6 13180.0 13197.0 13242.6 14401.8 14864.8 15996.4 16414.3 16491.3 6830.6 7252.0 7337.6 7384.4 7406.6 805.9 945.8 969.9 994.0 1048.8 29189.0 30089.1 30428.7 30849.2 30868.7 901.6 996.1 1019.6 1025.4 1058.8 12394.1 15567.1 15626.0 15722.5 16283.6 692495.0 697592.0 699626.0 699730.0 701637.0 49478.3 57606.0 57725.3 57950.7 57964.0 1288.8 1345.6 1394.7 1403.6 1404.2 30204.7 31242.4 31242.7 31421.1 32110.0 45054.0 46253.3 46387.3 49565.5 49573.3 559004.0 579149.0 580312.0 584197.0 665680.0 25096.5 26159.0 26163.3 26428.5 26493.6 45783.8 46043.8 46376.8 46504.0 46838.8 37443.4 38173.4 39004.8 39279.4 40479.4 38958.6 39232.4 40169.0 40499.0 40590.6 37827.6 38199.2 38244.2 38275.8 38910.8 32256.5 33708.7 34467.5 34734.7 35113.8 25805.9 25815.6 25928.9 26243.5 26265.5 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:35915.82 Median:2401.81 stddev:103919.93 (4326.7%) stddev-sans-first:104177.15 08:16:40 INFO - PROCESS | 1657 | Values: 355.7 378.1 382.5 389.6 411.2 15226.0 15383.3 18206.0 20690.1 20838.9 19636.0 20130.1 20223.5 20745.7 20760.8 5901.6 5953.2 6124.2 6133.3 6205.9 4185.3 4386.3 4386.5 5364.3 5993.6 6754.3 6866.7 6885.6 6897.2 6898.6 6573.1 6789.2 6870.1 6871.6 6876.2 5746.3 5884.5 5976.8 5986.5 5996.3 25330.6 25416.7 25439.9 25464.7 25487.2 2227.1 2292.0 2307.8 2334.8 2468.8 15320.8 15463.8 15590.1 15750.4 15983.0 1854.6 1860.7 1920.4 1928.5 1956.8 114761.4 118370.4 118723.8 119000.4 119299.4 9003.0 10859.7 11036.0 11113.4 11277.0 11505.6 14039.5 14046.5 14068.1 14093.7 7180.9 8591.8 8685.8 8695.1 8844.3 8866.6 8901.6 8930.6 9002.1 9035.9 6658.3 6690.3 6698.8 6701.6 6707.7 1709.6 1774.2 1815.5 1844.5 1876.5 830.3 908.2 966.9 970.3 980.5 21638.7 21926.3 21940.4 22127.9 22128.7 941.3 957.7 989.6 1001.1 1002.3 10500.9 11644.0 11767.6 11817.9 11854.8 617508.0 618864.0 620719.0 633081.0 633774.0 121701.4 124228.0 124265.4 125806.4 128066.0 991.9 993.2 1024.6 1026.6 1027.1 18725.9 19020.1 19269.3 19272.9 19284.3 44446.6 54635.0 54942.0 56984.0 57186.7 74656.0 77229.0 79430.2 79605.0 80019.0 7896.7 7983.6 8125.3 8164.4 8165.6 11026.7 12860.9 13142.3 13154.7 13342.9 9814.2 11052.4 11211.5 11415.2 11514.6 9874.8 10906.5 10999.5 11074.9 11548.0 11383.3 11559.2 11565.2 11683.4 11900.5 6764.2 6878.5 7958.1 8098.6 8173.8 11242.4 11595.7 11599.8 11673.5 11744.6 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5765.60 Median:4787.88 stddev:3243.84 (67.8%) stddev-sans-first:3237.37 08:16:40 INFO - PROCESS | 1657 | Values: 1536.4 1551.3 1781.7 1906.9 1942.9 8501.9 9120.5 9138.2 9165.5 9192.6 8022.7 8090.0 8113.8 8644.9 8923.9 2337.9 2387.9 2391.4 2391.4 2396.6 2367.4 2390.2 2405.7 2409.7 2410.5 2329.7 2336.9 2358.6 2358.6 2405.8 2125.4 2341.3 2371.6 2374.3 2388.0 2351.7 2363.8 2373.4 2375.8 2378.5 8832.2 9008.7 9034.5 9036.9 9043.5 5291.6 5452.7 5460.4 5472.0 5474.1 3590.2 3620.5 3646.7 3682.9 3685.8 954.2 956.8 1100.8 1108.8 1131.6 11694.2 11839.6 11845.0 11874.8 11882.9 4767.8 4785.9 4789.9 4908.1 4912.4 10154.5 10159.6 10162.9 10188.9 10210.7 5422.3 5426.6 5431.1 5432.7 5437.4 3869.7 4414.5 4539.7 4635.6 4956.5 3915.6 3967.4 4024.1 4059.6 4070.8 1307.1 1314.2 1317.9 1329.4 1331.4 907.7 916.4 930.3 930.5 941.1 4728.8 5776.0 5816.0 6117.1 6246.9 916.1 953.6 964.3 972.0 1019.8 3802.1 3993.9 4035.3 4064.7 4066.6 10594.3 10835.6 10978.1 10998.1 11149.7 10457.5 10743.4 10791.4 10953.7 11073.9 8210.8 8431.7 8436.6 8440.0 8453.8 5906.8 5976.6 5994.4 5995.2 6224.4 10011.0 10285.9 10330.8 10339.8 10366.8 9733.3 10038.0 10123.7 10552.8 10629.2 6989.5 7144.7 7154.4 7571.9 7717.7 6860.9 8228.0 8361.3 8548.3 8564.8 7436.3 7578.0 7597.1 7618.9 7718.2 6213.4 7295.2 7322.9 7471.3 7565.7 7030.7 7045.1 7079.5 7096.6 7106.2 4985.8 4996.0 5007.6 5024.3 5049.7 4508.6 4914.3 4962.9 5061.2 5102.9 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4641.09 Median:5299.62 stddev:1438.56 (27.1%) stddev-sans-first:1404.42 08:16:40 INFO - PROCESS | 1657 | Values: 254.9 304.8 314.5 316.7 319.3 4668.2 4910.7 5148.6 5393.2 5538.7 4799.8 4921.7 5191.9 5298.0 5302.5 3749.6 3837.7 4041.4 4098.7 4118.3 3740.5 4096.9 4105.8 4123.9 4132.8 3542.5 3835.8 3895.9 4046.5 4108.0 3928.4 4075.3 4082.2 4119.3 4140.6 3262.4 3300.1 3538.9 3546.9 3574.9 4682.5 5042.9 5332.0 5361.5 5378.6 4364.6 4679.8 4705.2 4727.5 4730.1 4987.6 5723.6 5781.0 5800.7 5813.5 3925.2 3944.9 3947.6 3949.2 3955.6 5032.4 5585.1 6014.4 6024.6 6030.6 3451.6 3455.7 3905.4 3955.9 3980.1 4033.2 4050.0 4056.7 4057.3 4058.4 4388.7 4638.3 4662.9 4668.3 4747.1 4530.3 5710.7 5755.6 5781.6 5805.5 1216.3 1235.5 1289.3 1321.8 1376.9 859.9 863.0 882.5 917.9 918.2 5301.3 5324.0 5349.9 5407.8 5410.6 5326.3 5860.1 5939.2 5972.4 5990.6 5116.4 5399.3 5478.4 5479.7 5496.4 2654.7 2982.0 3064.0 3092.2 3104.7 5578.7 6006.2 6041.4 6086.1 6097.6 5469.0 6009.8 6039.8 6070.5 6099.8 5430.8 5449.3 6001.2 6037.3 6077.4 5056.7 5139.6 5484.0 5880.1 5902.5 5775.7 5788.8 5812.2 5828.9 5842.8 4784.3 5245.5 5953.6 5992.6 6009.4 3905.7 3931.4 3950.0 3974.2 3977.7 5527.8 5664.9 5739.9 5961.3 5993.6 4990.7 5275.8 5591.8 5863.9 5919.9 5573.7 5846.3 5857.7 5860.0 5868.8 4767.1 5321.2 5637.5 5639.8 5712.7 5635.0 5760.4 5791.9 5822.3 5823.9 5057.5 5454.8 5698.0 5711.9 5722.9 08:16:40 INFO - PROCESS | 1657 | 08:16:40 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24966.35 Median:3323.86 stddev:40205.49 (1209.6%) stddev-sans-first:40276.62 08:16:40 INFO - PROCESS | 1657 | Values: 590.4 683.9 756.3 763.9 820.6 15004.9 16448.7 16490.0 16901.4 17453.5 16455.6 16804.9 16850.0 16872.7 16960.2 690.5 844.3 868.3 868.4 869.3 710.6 844.2 873.4 876.7 877.2 924.9 928.7 932.0 932.3 932.7 923.6 926.0 926.3 929.3 933.2 537.4 553.7 658.2 675.2 686.0 15527.9 15544.1 15549.1 15563.2 15590.1 12907.9 13258.2 13350.0 13464.5 13471.2 10896.8 11488.7 11503.7 12847.9 13142.3 3887.5 3949.7 3970.7 3977.2 3978.7 112258.0 114703.4 116739.0 118429.0 120746.0 11028.9 11064.6 11074.2 11109.9 11147.9 21909.7 22057.1 22134.2 22138.9 22190.0 7480.4 7559.1 7811.3 7903.1 7937.4 4272.5 4374.9 4458.9 4586.2 4629.7 3130.9 3516.8 3542.9 3557.6 3610.7 646.7 648.1 650.5 651.0 660.1 559.5 566.6 663.1 665.3 690.6 8925.3 9493.8 9521.3 9557.9 9908.0 553.6 650.6 652.1 658.4 679.9 4442.3 4498.8 4678.3 4679.6 4719.1 103953.0 139646.0 156350.2 158557.0 162053.0 111427.4 136716.0 139245.0 140677.0 142846.0 102942.0 122833.0 124278.4 128242.0 131993.3 9037.4 9134.3 9203.4 9608.5 9974.0 49734.0 51150.0 57753.0 61289.7 62100.7 66102.0 68721.0 69179.0 78651.2 95936.0 11138.8 12502.8 12710.9 13329.3 13764.6 14290.1 15158.9 15228.8 15891.1 15899.4 14030.4 14135.0 14158.6 14508.7 14630.4 13092.5 13203.7 14109.3 14132.0 14659.7 13430.3 13642.5 13828.5 14479.2 14516.1 10709.1 10782.2 10892.8 11487.3 11806.0 10203.0 11437.3 11573.2 11834.2 11839.2 08:16:40 INFO - PROCESS | 1657 | -------- Summary: end -------- 08:16:40 INFO - PROCESS | 1657 | 08:16:41 INFO - TEST-INFO | 1657: exit 0 08:16:41 INFO - TEST-OK | dromaeo_css | took 1117208ms 08:16:41 INFO - TEST-START | kraken 08:16:41 INFO - operating with platform_type : mac_ 08:16:41 INFO - Initialising browser for kraken test... 08:16:41 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpTifcHK/profile http://localhost:49267/getInfo.html) 08:16:43 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 08:16:43 INFO - PROCESS | 1663 | colorDepth:24 08:16:43 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 08:16:43 INFO - PROCESS | 1663 | __metrics 08:16:43 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:43 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:44 INFO - TEST-INFO | 1663: exit 0 08:16:44 INFO - Browser initialized. 08:16:44 INFO - Running cycle 1/1 for kraken test... 08:16:44 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/T/tmpTifcHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:56 INFO - PROCESS | 1664 | RSS: Main: 219549696 08:16:56 INFO - PROCESS | 1664 | 08:16:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:00 INFO - PROCESS | 1664 | RSS: Main: 270077952 08:17:00 INFO - PROCESS | 1664 | 08:17:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 08:17:03 INFO - PROCESS | 1664 | RSS: Main: 281034752 08:17:03 INFO - PROCESS | 1664 | 08:17:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 08:17:07 INFO - PROCESS | 1664 | RSS: Main: 376897536 08:17:07 INFO - PROCESS | 1664 | 08:17:09 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 08:17:09 INFO - PROCESS | 1664 | RSS: Main: 281001984 08:17:09 INFO - PROCESS | 1664 | 08:17:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:17:12 INFO - PROCESS | 1664 | RSS: Main: 281501696 08:17:12 INFO - PROCESS | 1664 | 08:17:15 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 08:17:15 INFO - PROCESS | 1664 | RSS: Main: 320196608 08:17:15 INFO - PROCESS | 1664 | 08:17:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 08:17:19 INFO - PROCESS | 1664 | RSS: Main: 321683456 08:17:19 INFO - PROCESS | 1664 | 08:17:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 08:17:22 INFO - PROCESS | 1664 | RSS: Main: 316243968 08:17:22 INFO - PROCESS | 1664 | 08:17:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:17:24 INFO - PROCESS | 1664 | RSS: Main: 295907328 08:17:24 INFO - PROCESS | 1664 | 08:17:26 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:17:27 INFO - PROCESS | 1664 | RSS: Main: 298696704 08:17:27 INFO - PROCESS | 1664 | 08:17:29 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:30 INFO - PROCESS | 1664 | RSS: Main: 302927872 08:17:30 INFO - PROCESS | 1664 | 08:17:33 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:33 INFO - PROCESS | 1664 | RSS: Main: 316805120 08:17:33 INFO - PROCESS | 1664 | 08:17:36 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:37 INFO - PROCESS | 1664 | RSS: Main: 310771712 08:17:37 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 08:17:39 INFO - PROCESS | 1664 | RSS: Main: 354832384 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | __start_tp_report 08:17:39 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 08:17:39 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 08:17:39 INFO - PROCESS | 1664 | |i|pagename|runs| 08:17:39 INFO - PROCESS | 1664 | |0;ai-astar;113;116;114;115;115;115;115;114;115;115 08:17:39 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;108;107;142;108;109;112;106;139;103 08:17:39 INFO - PROCESS | 1664 | |2;audio-dft;183;183;184;184;182;181;181;191;259;203 08:17:39 INFO - PROCESS | 1664 | |3;audio-fft;81;59;59;88;62;58;58;59;82;73 08:17:39 INFO - PROCESS | 1664 | |4;audio-oscillator;82;71;93;69;68;69;90;66;67;88 08:17:39 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;84;87;84;87;83;87;84;86;84 08:17:39 INFO - PROCESS | 1664 | |6;imaging-darkroom;147;135;93;94;93;93;93;94;93;93 08:17:39 INFO - PROCESS | 1664 | |7;imaging-desaturate;84;84;80;77;133;134;139;84;81;83 08:17:39 INFO - PROCESS | 1664 | |8;json-parse-financial;56;53;54;53;57;57;58;56;59;57 08:17:39 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;65;74;71;74;72;68;69;68;67;99 08:17:39 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;82;83;82;93;98;77;83;85;82;83 08:17:39 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;135;136;136;178;156;136;139;140;165;138 08:17:39 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;164;164;162;195;167;163;217;183;163;163 08:17:39 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;66;66;67;66;68;66;65;65;66;66 08:17:39 INFO - PROCESS | 1664 | __end_tp_report 08:17:39 INFO - PROCESS | 1664 | __start_cc_report 08:17:39 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1965 08:17:39 INFO - PROCESS | 1664 | __end_cc_report 08:17:39 INFO - PROCESS | 1664 | __startTimestamp1476976659314__endTimestamp 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | ------- Summary: start ------- 08:17:39 INFO - PROCESS | 1664 | Number of tests: 14 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 08:17:39 INFO - PROCESS | 1664 | Values: 113.0 116.0 114.0 115.0 115.0 115.0 115.0 114.0 115.0 115.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:110.50 stddev:16.49 (14.9%) stddev-sans-first:14.73 08:17:39 INFO - PROCESS | 1664 | Values: 143.0 108.0 107.0 142.0 108.0 109.0 112.0 106.0 139.0 103.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:193.10 Median:184.00 stddev:24.11 (13.1%) stddev-sans-first:25.29 08:17:39 INFO - PROCESS | 1664 | Values: 183.0 183.0 184.0 184.0 182.0 181.0 181.0 191.0 259.0 203.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:67.90 Median:67.50 stddev:11.87 (17.6%) stddev-sans-first:11.61 08:17:39 INFO - PROCESS | 1664 | Values: 81.0 59.0 59.0 88.0 62.0 58.0 58.0 59.0 82.0 73.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.50 stddev:10.71 (14.0%) stddev-sans-first:11.16 08:17:39 INFO - PROCESS | 1664 | Values: 82.0 71.0 93.0 69.0 68.0 69.0 90.0 66.0 67.0 88.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.78 (2.1%) stddev-sans-first:1.62 08:17:39 INFO - PROCESS | 1664 | Values: 88.0 84.0 87.0 84.0 87.0 83.0 87.0 84.0 86.0 84.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:102.80 Median:93.00 stddev:20.33 (21.9%) stddev-sans-first:13.92 08:17:39 INFO - PROCESS | 1664 | Values: 147.0 135.0 93.0 94.0 93.0 93.0 93.0 94.0 93.0 93.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:82.00 stddev:25.97 (31.7%) stddev-sans-first:27.05 08:17:39 INFO - PROCESS | 1664 | Values: 84.0 84.0 80.0 77.0 133.0 134.0 139.0 84.0 81.0 83.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:2.05 (3.6%) stddev-sans-first:2.18 08:17:39 INFO - PROCESS | 1664 | Values: 56.0 53.0 54.0 53.0 57.0 57.0 58.0 56.0 59.0 57.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:71.50 stddev:9.71 (13.6%) stddev-sans-first:9.89 08:17:39 INFO - PROCESS | 1664 | Values: 65.0 74.0 71.0 74.0 72.0 68.0 69.0 68.0 67.0 99.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:6.11 (7.4%) stddev-sans-first:6.39 08:17:39 INFO - PROCESS | 1664 | Values: 82.0 83.0 82.0 93.0 98.0 77.0 83.0 85.0 82.0 83.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:139.50 stddev:15.11 (10.8%) stddev-sans-first:15.50 08:17:39 INFO - PROCESS | 1664 | Values: 135.0 136.0 136.0 178.0 156.0 136.0 139.0 140.0 165.0 138.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:165.50 stddev:18.64 (11.3%) stddev-sans-first:19.41 08:17:39 INFO - PROCESS | 1664 | Values: 164.0 164.0 162.0 195.0 167.0 163.0 217.0 183.0 163.0 163.0 08:17:39 INFO - PROCESS | 1664 | 08:17:39 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 08:17:39 INFO - PROCESS | 1664 | Values: 66.0 66.0 67.0 66.0 68.0 66.0 65.0 65.0 66.0 66.0 08:17:39 INFO - PROCESS | 1664 | -------- Summary: end -------- 08:17:39 INFO - PROCESS | 1664 | 08:17:40 INFO - TEST-INFO | 1664: exit 0 08:17:40 INFO - TEST-OK | kraken | took 58681ms 08:17:40 INFO - SUITE-END | took 1175s 08:17:40 INFO - Completed test suite (00:19:36) 08:17:40 INFO - javascript benchmark 08:17:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3287.1946373138576, 3314.6188188358337, 3353.597568291805, 3354.0608629583708, 3400.574928133983, 5764.337101233359, 5805.36141024487, 5834.066549352105, 5856.2386889704385, 5892.764289428423, 4736.573708366246, 5728.369879313273, 5801.245838041049, 5813.389594092623, 5815.680137592431, 5222.007818514489, 5227.398849132342, 5243.370795504536, 5272.446393128724, 5275.736213189344, 4362.367456718774, 5188.7146206958605, 5190.974045129769, 5317.149256119022, 5334.279872217259, 5218.765155568009, 5239.869003274929, 5261.316028916254, 5281.023010743005, 5284.39229488608, 4377.6935614507, 5254.395744489394, 5317.813876514342, 5334.546563542103, 5336.866578335534, 5230.0, 5256.526912577848, 5290.127129023706, 5311.070562651559, 5331.946680533184, 5678.886422271573, 5691.288588926384, 5732.656040637575, 5756.625819321731, 5762.049261871828, 5222.8694282642855, 6195.473384762301, 6221.222347206599, 6250.218722659668, 6410.134631824691, 6233.252009758812, 6248.937510624881, 6296.96851515744, 6301.117843501914, 6315.842103947392, 5731.9140212897255, 5756.280464941882, 5760.654360738369, 5787.768489260382, 5874.9118763218585, 6208.099825525273, 6237.875242495124, 6284.12022316876, 6293.716782744787, 6303.054541818764, 6229.0, 6237.781677641261, 6241.251049873953, 6245.125682404467, 6254.437100660963, 6103.398280005586, 6226.750929962751, 6286.8428289292215, 6322.747090116436, 6325.7785977491485, 6174.104754810617, 6210.223722034746, 6235.158253635792, 6321.841953951096, 6335.588186767845, 6277.1525844010475, 6295.653739044396, 6308.400701933309, 6310.62136271816, 6321.146645202839, 4853.781579828917, 4912.926306105412, 4961.4294356148785, 4972.900541989212, 4999.000199960023, 4443.355713421536, 4478.507364189936, 4506.864794056183, 4506.932396014063, 4527.1172121436, 5641.351244606841, 5686.2323586315315, 5696.11710184922, 5703.486686198262, 5704.771809127671, 5231.215317702375, 6317.810465686037, 6321.65230912295, 6330.272018717907, 6339.397757213057, 5687.146927960839, 5712.7714891403875, 5729.427057294237, 5740.225069615549, 5750.856228594235, 5275.630705850554, 5404.243405923174, 5408.702521361284, 5419.078756611386, 5425.13197888336, 6255.343188965184, 6296.8425789354715, 6304.211973503312, 6304.275008373912, 6309.810705678837, 6214.25428948529, 6281.214848143982, 6286.277078136073, 6327.651979141191, 6330.715117819617, 6287.748490060347, 6303.243610766737, 6312.368763123651, 6318.020706790455, 6323.336049714898, 6016.338202797776, 6265.686715664289, 6280.152179455898, 6290.339514350927, 6296.150019747275, 4862.610991120772, 5324.520793128637, 6002.429769171922, 6193.349698281796, 6193.845153871009, 6054.606450580698, 6055.757769689163, 6073.453389194994, 6087.934611443068, 6094.39056094387, 6005.90991135142, 6094.055421409688, 6098.207233059851, 6101.816945491642, 6109.877802444015, 5044.873878153076, 5941.22764040672, 6031.638101713911, 6096.481799047131, 6106.389361063858, 6173.660448675366, 6186.845328866814, 6194.0708893666315, 6196.47329976957, 6203.503719702323, 5842.211301474246, 6042.637441753509, 6060.847840505181, 6063.060225665029, 6104.145419641342], "value": 5694.612858394471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.8306634211197, 493.42762395621077, 513.3788116379181, 526.5445389737873, 547.7179252684865, 30576.38847223054, 30614.693853061464, 30926.690733092662, 40032.59967400325, 41438.792806035926, 42175.57824421755, 42524.14951700964, 42646.0, 42678.573214267846, 42820.35769463461, 9736.734224550817, 9918.752031199241, 9926.90073099267, 9940.850887236697, 9946.701598952042, 8736.039035706068, 8917.063708310632, 10055.49722513875, 10264.0, 12139.514419423213, 12011.939940300286, 12072.879271207263, 12110.333931633757, 12111.576094836682, 12167.756644867097, 12111.394430278495, 12179.269243845354, 12195.512179512809, 12207.023438124928, 12225.0, 7961.800954976114, 8757.912420875773, 11731.061515078858, 12035.578754743541, 12080.214786038967, 39999.60000400017, 40286.79856600727, 40316.39525407121, 40347.59652403497, 40455.0, 3312.7681062325646, 3322.568066151409, 3358.042957757052, 3389.915252118692, 3390.4066788312193, 29601.703982960327, 30854.92007779717, 30930.690693093005, 30997.69002309993, 31260.0, 3180.522921561761, 3202.3595280943673, 3225.741940644743, 3241.3031198292247, 3250.983745081283, 494698.0, 497647.0, 501288.0, 504576.0, 504878.0, 60741.0, 60984.39015609787, 61019.0, 61102.38897610967, 61240.0, 63068.0, 63104.684476578244, 63285.367146327946, 63295.68352158302, 63296.0, 16366.0, 16882.0, 16882.155892205585, 16896.324147034225, 16917.90033647809, 11809.996150327146, 13082.607521774362, 13180.011499137412, 13197.0, 13242.602721918358, 14401.78397324041, 14864.777028344584, 15996.360145594046, 16414.343426263054, 16491.257893394584, 6830.59016459014, 7252.0, 7337.59643219628, 7384.372328352043, 7406.592637404887, 805.8871757953891, 945.7966537194536, 969.8739163908647, 993.9701808945598, 1048.8269435543202, 29189.0, 30089.097327080224, 30428.695713043027, 30849.228769280948, 30868.691313086583, 901.5987885390938, 996.14829320931, 1019.6235082638378, 1025.415513157493, 1058.7617785998088, 12394.132410731343, 15567.052200715487, 15626.0, 15722.528324150293, 16283.59291017734, 692495.0, 697592.0, 699626.0, 699730.0, 701637.0, 49478.257826132634, 57606.0, 57725.26824195281, 57950.710246449344, 57964.0, 1288.7680217560928, 1345.6366780969279, 1394.6652803327331, 1403.6069900427897, 1404.206623257856, 30204.69795302019, 31242.375152496366, 31242.687573123978, 31421.057368278987, 32110.0, 45054.0, 46253.30620040769, 46387.30419043785, 49565.50434495753, 49573.25640115474, 559004.0, 579149.0, 580312.0, 584197.0, 665680.0, 25096.498070038862, 26159.0, 26163.34591635148, 26428.489293517086, 26493.602595960692, 45783.77108114438, 46043.76978115088, 46376.768116159205, 46504.0, 46838.765806172116, 37443.43834842534, 38173.373529514654, 39004.80497597494, 39279.41080883846, 40479.392809107296, 38958.636447724195, 39232.41151382789, 40169.0, 40499.0, 40590.59409405986, 37827.62172378241, 38199.2360152801, 38244.23511529698, 38275.80862095672, 38910.80544597259, 32256.516152257267, 33708.7374775427, 34467.4829877547, 34734.65265347415, 35113.771018014246, 25805.870970645028, 25815.612765808903, 25928.8703556481, 26243.475130497663, 26265.474690506464], "value": 20192.37584517415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.71365051133824, 378.1057798307004, 382.48364707644686, 389.59287544515985, 411.1796965054716, 15226.010309329886, 15383.307751151196, 18205.99999999998, 20690.068946897387, 20838.895805520988, 19636.0, 20130.09414576344, 20223.494412639655, 20745.688814667792, 20760.792392076073, 5901.645901245917, 5953.2260806095255, 6124.1732366130445, 6133.325334213233, 6205.875882482348, 4185.28850095483, 4386.254336762742, 4386.451693538308, 5364.329458817648, 5993.61041532299, 6754.324567543255, 6866.690998905036, 6885.621290829003, 6897.206821215575, 6898.551594146389, 6573.112629794964, 6789.219239787439, 6870.141232345957, 6871.587704737682, 6876.209235937881, 5746.25298711169, 5884.529237660977, 5976.820695379146, 5986.491148252404, 5996.2504686914135, 25330.620040699403, 25416.745832541623, 25439.855206515753, 25464.745352546423, 25487.235382938543, 2227.12028748645, 2292.0487997481027, 2307.8499897506777, 2334.8482348647453, 2468.7654672806057, 15320.846791532054, 15463.845361546466, 15590.142542160176, 15750.44873429436, 15983.0, 1854.6383455226237, 1860.711589703598, 1920.4142736465371, 1928.5082304012387, 1956.8043195680461, 114761.4261928685, 118370.40814795958, 118723.81276187213, 119000.40499797532, 119299.4035029828, 9003.0, 10859.728506787393, 11035.95158459945, 11113.388353736866, 11277.0, 11505.597304094317, 14039.50861719835, 14046.508372207129, 14068.08557443763, 14093.71812563743, 7180.8922866157045, 8591.785205369792, 8685.83141785326, 8695.130486951255, 8844.33667474942, 8866.645334186689, 8901.554922253861, 8930.598123084477, 9002.144796244347, 9035.909640903637, 6658.334166583303, 6690.29751876046, 6698.83252918681, 6701.597904125768, 6707.66461676924, 1709.598244412562, 1774.1661419132986, 1815.546113471632, 1844.5112045308003, 1876.5402476393372, 830.2942498875907, 908.2280061947292, 966.9419834809934, 970.2965350121247, 980.5244456438621, 21638.675419868716, 21926.336847041464, 21940.365374085384, 22127.889360553094, 22128.660332139276, 941.289326558444, 957.6552441121191, 989.5596459575564, 1001.1190152665607, 1002.3484734922358, 10500.894991050145, 11644.0102591279, 11767.646970590897, 11817.940910295394, 11854.822177667342, 617508.0, 618864.0, 620719.0, 633081.0, 633774.0, 121701.39149304197, 124228.0, 124265.37867310605, 125806.37096814458, 128066.0, 991.945443000642, 993.1855878179967, 1024.636254129788, 1026.58423338548, 1027.0551092994463, 18725.90637046806, 19020.144093515548, 19269.325573604856, 19272.93998830078, 19284.325048623232, 44446.555534445535, 54635.0, 54942.0, 56984.0, 57186.7140664294, 74656.0, 77229.0, 79430.20569794228, 79605.0, 80019.0, 7896.7236146734585, 7983.640736167003, 8125.349972002107, 8164.387670924586, 8165.632546535539, 11026.724331891766, 12860.935695321838, 13142.277174755098, 13154.736905262032, 13342.93328533351, 9814.165795907142, 11052.392118433563, 11211.495482703134, 11415.200935934405, 11514.596989105676, 9874.815022197383, 10906.50920708554, 10999.450027498753, 11074.944625276821, 11548.0, 11383.317000979967, 11559.248648837798, 11565.248258863146, 11683.357415342238, 11900.523979041087, 6764.16636758772, 6878.484113691593, 7958.0848202457455, 8098.635561399869, 8173.754787356389, 11242.437878106226, 11595.710107247387, 11599.76800463969, 11673.533058677898, 11744.647660570197], "value": 9845.432905419928, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.3854458216713, 1551.286408252204, 1781.688204564201, 1906.8855868647875, 1942.8542859285558, 8501.872471912919, 9120.543972801366, 9138.177564019254, 9165.450072995616, 9192.586333614987, 8022.719204827832, 8089.959550202256, 8113.797155071126, 8644.913550864505, 8923.866142007859, 2337.859728416292, 2387.940301492468, 2391.378241657173, 2391.4380120671626, 2396.6405039244164, 2367.3726462487452, 2390.2231774673214, 2405.7113146422453, 2409.7469765674614, 2410.517896420714, 2329.7186547398946, 2336.9298921032396, 2358.5636657218383, 2358.6226203807396, 2405.8436201646923, 2125.3730149605826, 2341.309313752447, 2371.5612611666897, 2374.3114496795906, 2388.032846697073, 2351.71779386473, 2363.775441333071, 2373.430376709577, 2375.8099352051795, 2378.4767351182713, 8832.205101540829, 9008.684696035607, 9034.45793252407, 9036.909630903738, 9043.547822608909, 5291.629585928987, 5452.727363631802, 5460.372057213432, 5471.972640136813, 5474.069408200616, 3590.1922067534597, 3620.5112309838096, 3646.74472786905, 3682.852685892561, 3685.7972811495356, 954.1746389373211, 956.8277710012195, 1100.8018556659797, 1108.817045187543, 1131.6378758797189, 11694.239874408137, 11839.64481065578, 11845.0, 11874.762504749942, 11882.930536251779, 4767.818224436598, 4785.9042819144115, 4789.856304310876, 4908.141075311806, 4912.410510738734, 10154.54304556282, 10159.644412445528, 10162.898371016196, 10188.949055254676, 10210.744731381776, 5422.349318081855, 5426.593005524523, 5431.131019036935, 5432.728363581805, 5437.401885792559, 3869.6517313441364, 4414.4702635683925, 4539.72761634303, 4635.629149668019, 4956.504349565087, 3915.647591716702, 3967.444557761916, 4024.074462873497, 4059.6143366380147, 4070.816813243411, 1307.0719788949762, 1314.2377421095741, 1317.8682131786936, 1329.3751936589788, 1331.407523651985, 907.6550910653909, 916.4363916191628, 930.2604429478446, 930.5300823084434, 941.0683423410911, 4728.834490792806, 5776.011919543084, 5815.9709201453725, 6117.143599896018, 6246.937530624727, 916.093067862811, 953.594722243044, 964.2816102003911, 971.9805603888024, 1019.7508052635462, 3802.125511132455, 3993.940090898639, 4035.2736507428945, 4064.7154699171365, 4066.580384671116, 10594.258401911793, 10835.566577336818, 10978.12175025996, 10998.06516446095, 11149.72125696864, 10457.477126143662, 10743.409112498888, 10791.352518848895, 10953.671389858317, 11073.889261107446, 8210.753677389568, 8431.704890328809, 8436.578171091543, 8440.0, 8453.830923381498, 5906.763729450774, 5976.641401515923, 5994.3705910878725, 5995.190649262294, 6224.41848856954, 10011.0, 10285.897141028494, 10330.845037324596, 10339.844902326622, 10366.844497332395, 9733.318667693193, 10038.0, 10123.696289111338, 10552.788944221225, 10629.20280978945, 6989.47578931572, 7144.67848946809, 7154.427645788429, 7571.886421703569, 7717.729879454192, 6860.897086543606, 8227.958860205661, 8361.331093512383, 8548.316134709332, 8564.785880353042, 7436.256374362521, 7578.014858068415, 7597.126330472067, 7618.885716714364, 7718.228177182237, 6213.409726076015, 7295.197528271779, 7322.890156647761, 7471.327580517779, 7565.6973721050545, 7030.718771249093, 7045.11936007999, 7079.504434689522, 7096.609686467294, 7106.182788979334, 4985.75071246429, 4995.950040499549, 5007.599392048554, 5024.271480635361, 5049.671771334998, 4508.639308855218, 4914.336564563738, 4962.8759281018265, 5061.215511595708, 5102.872428189325], "value": 4639.179488966688, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.89167103980816, 304.81406342131305, 314.50936538999156, 316.74027297615936, 319.3405617400069, 4668.229742092559, 4910.705357678542, 5148.639595228336, 5393.164059570763, 5538.729121060366, 4799.760011999395, 4921.686807200619, 5191.948080519193, 5297.973510132453, 5302.469753024705, 3749.568799588048, 3837.6737977271964, 4041.4341992121126, 4098.692598055143, 4118.341065429532, 3740.4763333133383, 4096.938545921814, 4105.774182419966, 4123.917521649565, 4132.752034877902, 3542.5040494330815, 3835.7506762060516, 3895.8636447724334, 4046.534648515429, 4108.0, 3928.37146056631, 4075.347944328923, 4082.183563287325, 4119.258533463991, 4140.627343539096, 3262.4453842846774, 3300.14196308959, 3538.85844566217, 3546.9113272168142, 3574.891783547109, 4682.461516925563, 5042.899142017139, 5332.0, 5361.544268737162, 5378.623496355257, 4364.585364390377, 4679.836205732817, 4705.1765940960195, 4727.527247275245, 4730.0776348612035, 4987.603471028118, 5723.57073219506, 5781.0, 5800.709964501801, 5813.505852002585, 3925.234579257046, 3944.921101577981, 3947.585503522146, 3949.19041596472, 3955.6044395560502, 5032.396112466491, 5585.1063829787445, 6014.428629280255, 6024.57827952048, 6030.577859549833, 3451.620321764604, 3455.6544345565244, 3905.3751399776465, 3955.940660890089, 3980.089557012592, 4033.2135233629747, 4050.0, 4056.7363121397016, 4057.33054046085, 4058.350663893822, 4388.692791504564, 4638.281066434708, 4662.906741865211, 4668.299755036704, 4747.124885670141, 4530.343100250511, 5710.7430165642645, 5755.640187523096, 5781.595288329777, 5805.506531944832, 1216.2702378572785, 1235.499622652809, 1289.2973329535425, 1321.8149459075737, 1376.876081152681, 859.8839156713889, 862.9560220511228, 882.4793371910475, 917.8898532176181, 918.2470374293016, 5301.257823904656, 5323.950279142558, 5349.919751203735, 5407.78368865241, 5410.567154627621, 5326.324835863242, 5860.120981852756, 5939.227900372924, 5972.402759723993, 5990.64056156632, 5116.360454943132, 5399.298091248191, 5478.424765399655, 5479.698616576047, 5496.422875598085, 2654.681438227425, 2981.9552706709414, 3063.969360306413, 3092.2219723658536, 3104.674009229044, 5578.721063946868, 6006.249218847644, 6041.395860413923, 6086.147939288503, 6097.603655762361, 5469.0, 6009.789657361971, 6039.758409663652, 6070.544709146743, 6099.8475038123515, 5430.832371040246, 5449.3460784706085, 6001.179445660532, 6037.335893051849, 6077.4226448487325, 5056.696598204119, 5139.588832893434, 5484.0, 5880.14737863016, 5902.468777810018, 5775.653460792366, 5788.797392091256, 5812.244408227072, 5828.883422331445, 5842.824715258549, 4784.30627558995, 5245.501677340647, 5953.553483488842, 5992.550558708202, 6009.369016253405, 3905.687544996337, 3931.4495970564717, 3949.980250098731, 3974.1852920150723, 3977.6618987386396, 5527.811520523107, 5664.85837854057, 5739.8565035874435, 5961.314448838439, 5993.61041532299, 4990.72551009698, 5275.762590683506, 5591.82571659956, 5863.941360586339, 5919.881602368015, 5573.749181286933, 5846.258394627527, 5857.677827719516, 5860.0075974168985, 5868.794592189253, 4767.070421267819, 5321.175217841241, 5637.548996080386, 5639.7744090237575, 5712.742926568231, 5634.985702573576, 5760.366359700346, 5791.942080579141, 5822.272215973004, 5823.912641310299, 5057.468965758542, 5454.78840548155, 5697.971510142588, 5711.942880571141, 5722.938228047974], "value": 4173.154356306024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3545605883668, 683.9487038472113, 756.3419824752459, 763.9465237433382, 820.6143112737011, 15004.924975375121, 16448.671026579475, 16490.0, 16901.408450704195, 17453.47639570815, 16455.588610284718, 16804.915975420136, 16850.0, 16872.66254674906, 16960.23678934448, 690.4959379652831, 844.2950136635901, 868.288003836854, 868.3617541107282, 869.3219288954625, 710.6411262312525, 844.2317491083115, 873.3842640938155, 876.7282142535803, 877.1535468273115, 924.8982611912718, 928.7213835849252, 931.9767005824841, 932.2774849491665, 932.7341707613298, 923.6166990698852, 926.0184204742994, 926.3237836379413, 929.2890938432071, 933.1834644685899, 537.4169026606137, 553.7120697237414, 658.2002866517157, 675.1796567170862, 685.9984422742801, 15527.922360388126, 15544.06735595868, 15549.144797036159, 15563.221838908123, 15590.142542160176, 12907.870921290854, 13258.204507729568, 13349.998750093684, 13464.5287414941, 13471.191728496322, 10896.836547451716, 11488.655340339803, 11503.654890353302, 12847.871521284855, 13142.277174755385, 3887.5334959805004, 3949.7235193536176, 3970.682345412389, 3977.2244412339605, 3978.6817054635558, 112258.0, 114703.42648286706, 116739.0, 118429.0, 120746.0, 11028.944855275673, 11064.557417703363, 11074.224804263624, 11109.888901110886, 11147.944260278648, 21909.671354929687, 22057.11771529121, 22134.22530211467, 22138.88930555337, 22190.0, 7480.3641690456925, 7559.055118110236, 7811.257930496594, 7903.091144518454, 7937.404694647925, 4272.46594175728, 4374.868753937387, 4458.888527786831, 4586.197415452282, 4629.699069560468, 3130.89041883533, 3516.824158792101, 3542.911427214289, 3557.6086630470627, 3610.693091087287, 646.6992848325457, 648.1347401219425, 650.5381179362611, 650.9641969691712, 660.089077073645, 559.5188138201144, 566.6345207341324, 663.1213641924469, 665.2615596687673, 690.6098054599136, 8925.275141936394, 9493.762655933519, 9521.285903557122, 9557.856632150524, 9907.950460247652, 553.6318348298337, 650.5836264790538, 652.1326635574675, 658.4403257231315, 679.8776220280397, 4442.267025940748, 4498.842540511132, 4678.251479763289, 4679.555442232982, 4719.0561887621925, 103953.0, 139646.0, 156350.21824890803, 158557.0, 162053.0, 111427.44286278517, 136716.0, 139245.0, 140677.0, 142846.0, 102942.0, 122833.0, 124278.37860810637, 128242.0, 131993.34003329923, 9037.382991038481, 9134.314926380415, 9203.447793132433, 9608.471534065693, 9973.950130249592, 49734.0, 51150.0, 57753.0, 61289.69355153374, 62100.68949655223, 66102.0, 68721.0, 69179.0, 78651.21348786438, 95936.0, 11138.832917506406, 12502.812457813323, 12710.936445317715, 13329.333533323488, 13764.587062388144, 14290.071145375518, 15158.924205378902, 15228.847711523185, 15891.125988070768, 15899.443519476763, 14030.438782448588, 14135.0, 14158.646033849236, 14508.709825803637, 14630.414783408545, 13092.541761038317, 13203.735925281248, 14109.2945352734, 14132.010759246754, 14659.70680586361, 13430.261335626243, 13642.522511712043, 13828.516001939885, 14479.20364379927, 14516.129032258099, 10709.08972737295, 10782.245242832927, 10892.836607450736, 11487.25332853362, 11805.996490298077, 10203.0, 11437.256578322382, 11573.247738896946, 11834.171607987359, 11839.230450020721], "value": 7875.915825752251, "unit": "score"}], "name": "dromaeo_css", "value": 7462.020494983536, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 107.0, 142.0, 108.0, 109.0, 112.0, 106.0, 139.0, 103.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 184.0, 184.0, 182.0, 181.0, 181.0, 191.0, 259.0, 203.0], "value": 193.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 88.0, 62.0, 58.0, 58.0, 59.0, 82.0, 73.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 93.0, 69.0, 68.0, 69.0, 90.0, 66.0, 67.0, 88.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 135.0, 93.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 102.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 80.0, 77.0, 133.0, 134.0, 139.0, 84.0, 81.0, 83.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 53.0, 57.0, 57.0, 58.0, 56.0, 59.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 71.0, 74.0, 72.0, 68.0, 69.0, 68.0, 67.0, 99.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 93.0, 98.0, 77.0, 83.0, 85.0, 82.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 136.0, 178.0, 156.0, 136.0, 139.0, 140.0, 165.0, 138.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 195.0, 167.0, 163.0, 217.0, 183.0, 163.0, 163.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 68.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1455.3999999999999, "alertThreshold": 2.0}]} 08:17:40 INFO - Return code: 0 08:17:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:17:40 INFO - # TBPL SUCCESS # 08:17:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:40 INFO - 2016-10-20 08:17:40.666 screenresolution[1668:9888] starting screenresolution argv=screenresolution get 08:17:40 INFO - 2016-10-20 08:17:40.669 screenresolution[1668:9888] Display 0: 1600x1200x32@60 08:17:40 INFO - 2016-10-20 08:17:40.675 screenresolution[1669:9891] starting screenresolution argv=screenresolution list 08:17:40 INFO - Available Modes on Display 0 08:17:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:40 INFO - Intel Iris: 08:17:40 INFO - Chipset Model: Intel Iris 08:17:40 INFO - Type: GPU 08:17:40 INFO - Bus: Built-In 08:17:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:40 INFO - Vendor: Intel (0x8086) 08:17:40 INFO - Device ID: 0x0a2e 08:17:40 INFO - Revision ID: 0x0009 08:17:40 INFO - Displays: 08:17:40 INFO - Display: 08:17:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:40 INFO - Display Serial Number: 1600x1200 60 08:17:40 INFO - Main Display: Yes 08:17:40 INFO - Mirror: Off 08:17:40 INFO - Online: Yes 08:17:40 INFO - Rotation: Supported 08:17:40 INFO - Return code: 0 08:17:40 INFO - Running post-action listener: _resource_record_post_action 08:17:40 INFO - [mozharness: 2016-10-20 15:17:40.910936Z] Finished run-tests step (success) 08:17:40 INFO - Running post-run listener: _resource_record_post_run 08:17:40 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 36623360; Write bytes: 662225408; Read time: 232; Write time: 1865 08:17:40 INFO - TinderboxPrint: CPU usage
53.6% 08:17:40 INFO - TinderboxPrint: I/O read bytes / time
36,623,360 / 232 08:17:40 INFO - TinderboxPrint: I/O write bytes / time
662,225,408 / 1,865 08:17:40 INFO - TinderboxPrint: CPU idle
2,246.5 (46.4%) 08:17:40 INFO - TinderboxPrint: CPU system
971.8 (20.1%) 08:17:40 INFO - TinderboxPrint: CPU user
1,619.3 (33.5%) 08:17:40 INFO - TinderboxPrint: Swap in / out
399,806,464 / 0 08:17:40 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 369861120; Write bytes: 367392768; Read time: 28156; Write time: 758 08:17:40 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 29137920; Write bytes: 293251584; Read time: 172; Write time: 1099 08:17:41 INFO - Running post-run listener: _upload_blobber_files 08:17:41 INFO - Blob upload gear active. 08:17:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:41 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 08:17:41 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'] 08:17:41 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 08:17:41 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:43 INFO - (blobuploader) - INFO - Done attempting. 08:17:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:44 INFO - (blobuploader) - INFO - Done attempting. 08:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:46 INFO - (blobuploader) - INFO - Done attempting. 08:17:46 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:46 INFO - Return code: 0 08:17:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8c8610be9ce2853f789f7bcc63278e0fb842afecaa1ee62ab08d55751f1c7c0820fcd1c7e7a2927dbed35c596d17625e108ab1fa328aa0b66bd8be57fe9132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fd03c6930f6af7bb2fff214b328f7d4a9eda299008802063ed39ee18f0f7c1afcd795b5b939c2e2630229aa2b8a5faebc70350f42bdd12de19e4da97076b0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1717cfcf6d6f462990e9c78a907bd6d3361587a2341a61a40def009f3f3617deeccd0e76a28ba0d7578ea1087e78b79edb859ff68eebfacf8ffca50f756384e3"} 08:17:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:46 INFO - Contents: 08:17:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8c8610be9ce2853f789f7bcc63278e0fb842afecaa1ee62ab08d55751f1c7c0820fcd1c7e7a2927dbed35c596d17625e108ab1fa328aa0b66bd8be57fe9132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fd03c6930f6af7bb2fff214b328f7d4a9eda299008802063ed39ee18f0f7c1afcd795b5b939c2e2630229aa2b8a5faebc70350f42bdd12de19e4da97076b0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1717cfcf6d6f462990e9c78a907bd6d3361587a2341a61a40def009f3f3617deeccd0e76a28ba0d7578ea1087e78b79edb859ff68eebfacf8ffca50f756384e3"} 08:17:46 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:46 INFO - Copying logs to upload dir... 08:17:46 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.835870 ========= master_lag: 0.87 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 08:17:47.658559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 08:17:47.662816) ========= 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.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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/fa8c8610be9ce2853f789f7bcc63278e0fb842afecaa1ee62ab08d55751f1c7c0820fcd1c7e7a2927dbed35c596d17625e108ab1fa328aa0b66bd8be57fe9132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fd03c6930f6af7bb2fff214b328f7d4a9eda299008802063ed39ee18f0f7c1afcd795b5b939c2e2630229aa2b8a5faebc70350f42bdd12de19e4da97076b0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1717cfcf6d6f462990e9c78a907bd6d3361587a2341a61a40def009f3f3617deeccd0e76a28ba0d7578ea1087e78b79edb859ff68eebfacf8ffca50f756384e3"} build_url:https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010890 build_url: 'https://queue.taskcluster.net/v1/task/UV7-aKVnT7ShYx5Lz4ahvQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa8c8610be9ce2853f789f7bcc63278e0fb842afecaa1ee62ab08d55751f1c7c0820fcd1c7e7a2927dbed35c596d17625e108ab1fa328aa0b66bd8be57fe9132", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3fd03c6930f6af7bb2fff214b328f7d4a9eda299008802063ed39ee18f0f7c1afcd795b5b939c2e2630229aa2b8a5faebc70350f42bdd12de19e4da97076b0f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1717cfcf6d6f462990e9c78a907bd6d3361587a2341a61a40def009f3f3617deeccd0e76a28ba0d7578ea1087e78b79edb859ff68eebfacf8ffca50f756384e3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 08:17:47.701295) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:17:47.704661) ========= 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.TSHtqO9j48/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.d5tf8jreBa/Listeners TMPDIR=/var/folders/87/tdvlw3rj6yb17xk_t0qxk6xw00000w/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.005040 ========= master_lag: 0.98 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 08:17:48.692439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 08:17:48.692859) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 08:17:48.693572) ========= ========= Total master_lag: 2.05 =========