builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0111 starttime: 1476267063.68 results: success (0) buildid: 20161012005247 builduid: d739623750ad4ba4b489649eee05a4dd revision: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.678712) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.679296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.679658) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.704691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.705140) ========= 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.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-12 03:11:03-- 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% 159M=0s 2016-10-12 03:11:03 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.819411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.819886) ========= 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.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.021380 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:03.871013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 03:11:03.871561) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 --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 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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-12 03:11:03,944 truncating revision to first 12 chars 2016-10-12 03:11:03,944 Setting DEBUG logging. 2016-10-12 03:11:03,944 attempt 1/10 2016-10-12 03:11:03,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2da62d29c6a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 03:11:05,151 unpacking tar archive at: mozilla-aurora-2da62d29c6a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.458269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 03:11:05.353358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:05.353765) ========= script_repo_revision: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:05.354158) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:05.354501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 03:11:05.373045) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-12 03:11:05.373400) ========= /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.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:05 INFO - MultiFileLogger online at 20161012 03:11:05 in /builds/slave/test 03:11:05 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 03:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:05 INFO - {'append_to_log': False, 03:11:05 INFO - 'base_work_dir': '/builds/slave/test', 03:11:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:05 INFO - 'branch': 'Mozilla-Aurora', 03:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:05 INFO - 'config_files': ('talos/mac_config.py',), 03:11:05 INFO - 'default_actions': ('clobber', 03:11:05 INFO - 'read-buildbot-config', 03:11:05 INFO - 'download-and-extract', 03:11:05 INFO - 'populate-webroot', 03:11:05 INFO - 'create-virtualenv', 03:11:05 INFO - 'install', 03:11:05 INFO - 'run-tests'), 03:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:05 INFO - 'download_minidump_stackwalk': True, 03:11:05 INFO - 'download_symbols': 'ondemand', 03:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:05 INFO - 'installer_path': 'installer.exe', 03:11:05 INFO - 'log_level': 'info', 03:11:05 INFO - 'log_name': 'talos', 03:11:05 INFO - 'log_to_console': True, 03:11:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:11:05 INFO - 'opt_config_files': (), 03:11:05 INFO - 'pip_index': False, 03:11:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:05 INFO - 'cmd': ('bash', 03:11:05 INFO - '-c', 03:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:05 INFO - 'enabled': True, 03:11:05 INFO - 'halt_on_failure': False, 03:11:05 INFO - 'name': 'check_screen_resolution'},), 03:11:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:05 INFO - 'cmd': ('bash', 03:11:05 INFO - '-c', 03:11:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:05 INFO - 'enabled': True, 03:11:05 INFO - 'halt_on_failure': False, 03:11:05 INFO - 'name': 'check_screen_resolution'},), 03:11:05 INFO - 'run_cmd_checks_enabled': True, 03:11:05 INFO - 'sps_profile': False, 03:11:05 INFO - 'sps_profile_interval': 0, 03:11:05 INFO - 'suite': 'dromaeojs', 03:11:05 INFO - 'system_bits': '32', 03:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:05 INFO - 'title': 't-yosemite-r7-0111', 03:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:05 INFO - 'use_talos_json': True, 03:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:05 INFO - 'work_dir': 'build'} 03:11:05 INFO - [mozharness: 2016-10-12 10:11:05.563104Z] Running clobber step. 03:11:05 INFO - Running pre-action listener: _resource_record_pre_action 03:11:05 INFO - Running main action method: clobber 03:11:05 INFO - rmtree: /builds/slave/test/build 03:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:06 INFO - Running post-action listener: _resource_record_post_action 03:11:06 INFO - [mozharness: 2016-10-12 10:11:06.454283Z] Finished clobber step (success) 03:11:06 INFO - [mozharness: 2016-10-12 10:11:06.454472Z] Running read-buildbot-config step. 03:11:06 INFO - Running pre-action listener: _resource_record_pre_action 03:11:06 INFO - Running main action method: read_buildbot_config 03:11:06 INFO - Using buildbot properties: 03:11:06 INFO - { 03:11:06 INFO - "project": "", 03:11:06 INFO - "product": "firefox", 03:11:06 INFO - "script_repo_revision": "production", 03:11:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 03:11:06 INFO - "repository": "", 03:11:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 03:11:06 INFO - "buildid": "20161012005247", 03:11:06 INFO - "pgo_build": "False", 03:11:06 INFO - "basedir": "/builds/slave/test", 03:11:06 INFO - "buildnumber": 48, 03:11:06 INFO - "slavename": "t-yosemite-r7-0111", 03:11:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:11:06 INFO - "platform": "yosemite_r7", 03:11:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:11:06 INFO - "branch": "mozilla-aurora", 03:11:06 INFO - "repo_path": "releases/mozilla-aurora", 03:11:06 INFO - "revision": "2da62d29c6a4826c874bc7f6b9e315b0293b2fc9", 03:11:06 INFO - "stage_platform": "macosx64", 03:11:06 INFO - "builduid": "d739623750ad4ba4b489649eee05a4dd", 03:11:06 INFO - "slavebuilddir": "test" 03:11:06 INFO - } 03:11:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:11:06 INFO - Running post-action listener: _resource_record_post_action 03:11:06 INFO - [mozharness: 2016-10-12 10:11:06.457912Z] Finished read-buildbot-config step (success) 03:11:06 INFO - [mozharness: 2016-10-12 10:11:06.458024Z] Running download-and-extract step. 03:11:06 INFO - Running pre-action listener: _resource_record_pre_action 03:11:06 INFO - Running main action method: download_and_extract 03:11:06 INFO - mkdir: /builds/slave/test/build/tests 03:11:06 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')]} 03:11:06 INFO - trying https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:11:06 INFO - Downloading https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/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 03:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/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 03:11:07 INFO - Downloaded 1199 bytes. 03:11:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:11:07 INFO - Using the following test package requirements: 03:11:07 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:11:07 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:11:07 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:11:07 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'jsshell-mac.zip'], 03:11:07 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:11:07 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:11:07 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:11:07 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:11:07 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:11:07 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:11:07 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:11:07 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:11:08 INFO - Expected file size: 16435027 03:11:15 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 03:11:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:11:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:11:15 INFO - Fetch https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:11:15 INFO - Expected file size: 16435027 03:11:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:11:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:11:22 INFO - Fetch https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:11:23 INFO - Expected file size: 14414059 03:11: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')]} 03:11:24 INFO - trying https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:24 INFO - Downloading https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/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 03:11:27 INFO - Downloaded 115367611 bytes. 03:11:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:27 INFO - mkdir: /builds/slave/test/properties 03:11:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:27 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:27 INFO - Contents: 03:11:27 INFO - build_url:https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:11:28 INFO - Running post-action listener: _resource_record_post_action 03:11:28 INFO - Running post-action listener: set_extra_try_arguments 03:11:28 INFO - [mozharness: 2016-10-12 10:11:28.060292Z] Finished download-and-extract step (success) 03:11:28 INFO - [mozharness: 2016-10-12 10:11:28.060452Z] Running populate-webroot step. 03:11:28 INFO - Running pre-action listener: _resource_record_pre_action 03:11:28 INFO - Running main action method: populate_webroot 03:11:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:28 INFO - '--tppagecycles', 03:11:28 INFO - '7'], 03:11:28 INFO - 'tests': ['tsvgm']}}, 03:11:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:11:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:11:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['damp', 'tps']}, 03:11:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'tests': ['damp', 'tps']}, 03:11:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['dromaeo_dom']}, 03:11:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['basic_compositor_video']}, 03:11:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:11:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'other-e10s': {'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['a11yr', 03:11:28 INFO - 'ts_paint', 03:11:28 INFO - 'tpaint', 03:11:28 INFO - 'sessionrestore', 03:11:28 INFO - 'sessionrestore_no_auto_restore', 03:11:28 INFO - 'tabpaint']}, 03:11:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['tsvgx', 03:11:28 INFO - 'tsvgr_opacity', 03:11:28 INFO - 'tart', 03:11:28 INFO - 'tscrollx', 03:11:28 INFO - 'cart']}, 03:11:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:11:28 INFO - 'tsvgr_opacity', 03:11:28 INFO - 'tart', 03:11:28 INFO - 'tscrollx', 03:11:28 INFO - 'cart']}, 03:11:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'talos_options': ['--disable-e10s'], 03:11:28 INFO - 'tests': ['tp5o']}, 03:11:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'tests': ['tp5o']}, 03:11:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'talos_options': ['--disable-e10s', 03:11:28 INFO - '--xperf_path', 03:11:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:28 INFO - 'tests': ['tp5n']}, 03:11:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:28 INFO - 'talos_options': ['--xperf_path', 03:11:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:28 INFO - 'tests': ['tp5n']}}, 03:11:28 INFO - 'talos.zip': {'path': '', 03:11:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:28 INFO - Running post-action listener: _resource_record_post_action 03:11:28 INFO - [mozharness: 2016-10-12 10:11:28.079348Z] Finished populate-webroot step (success) 03:11:28 INFO - [mozharness: 2016-10-12 10:11:28.079464Z] Running create-virtualenv step. 03:11:28 INFO - Running pre-action listener: _resource_record_pre_action 03:11:28 INFO - Running main action method: create_virtualenv 03:11:28 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:28 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 03:11:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:28 INFO - Using real prefix '/tools/python27' 03:11:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:31 INFO - Installing pip.................done. 03:11:31 INFO - Return code: 0 03:11:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:31 INFO - 'HOME': '/Users/cltbld', 03:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:31 INFO - 'LOGNAME': 'cltbld', 03:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:31 INFO - 'MOZ_NO_REMOTE': '1', 03:11:31 INFO - 'NO_EM_RESTART': '1', 03:11:31 INFO - 'PAGER': '/bin/cat', 03:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:31 INFO - 'PWD': '/builds/slave/test', 03:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:31 INFO - 'SHELL': '/bin/bash', 03:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:31 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:31 INFO - 'USER': 'cltbld', 03:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:31 INFO - 'XPC_FLAGS': '0x0', 03:11:31 INFO - 'XPC_SERVICE_NAME': '0', 03:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:32 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 03:11:32 INFO - Cleaning up... 03:11:32 INFO - Return code: 0 03:11:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:11:32 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')]} 03:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:32 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')]} 03:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:32 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:32 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 03:11:32 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 03:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:32 INFO - 'HOME': '/Users/cltbld', 03:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:32 INFO - 'LOGNAME': 'cltbld', 03:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:32 INFO - 'MOZ_NO_REMOTE': '1', 03:11:32 INFO - 'NO_EM_RESTART': '1', 03:11:32 INFO - 'PAGER': '/bin/cat', 03:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:32 INFO - 'PWD': '/builds/slave/test', 03:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:32 INFO - 'SHELL': '/bin/bash', 03:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:32 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:32 INFO - 'USER': 'cltbld', 03:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:32 INFO - 'XPC_FLAGS': '0x0', 03:11:32 INFO - 'XPC_SERVICE_NAME': '0', 03:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:32 INFO - Downloading/unpacking psutil>=3.1.1 03:11:32 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 03:11:32 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 03:11:32 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 03:11:32 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 03:11:32 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 03:11:32 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 03:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:35 INFO - Installing collected packages: psutil 03:11:35 INFO - Running setup.py install for psutil 03:11:35 INFO - building 'psutil._psutil_osx' extension 03:11:35 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 03:11:35 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 03:11:35 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 03:11:35 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 03:11:35 INFO - building 'psutil._psutil_posix' extension 03:11:35 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 03:11:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:11:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:11:35 INFO - ^ 03:11:35 INFO - 1 warning generated. 03:11:35 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 03:11:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:36 INFO - Successfully installed psutil 03:11:36 INFO - Cleaning up... 03:11:36 INFO - Return code: 0 03:11:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:36 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 03:11:36 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 03:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:36 INFO - 'HOME': '/Users/cltbld', 03:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:36 INFO - 'LOGNAME': 'cltbld', 03:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:36 INFO - 'MOZ_NO_REMOTE': '1', 03:11:36 INFO - 'NO_EM_RESTART': '1', 03:11:36 INFO - 'PAGER': '/bin/cat', 03:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:36 INFO - 'PWD': '/builds/slave/test', 03:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:36 INFO - 'SHELL': '/bin/bash', 03:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:36 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:36 INFO - 'USER': 'cltbld', 03:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:36 INFO - 'XPC_FLAGS': '0x0', 03:11:36 INFO - 'XPC_SERVICE_NAME': '0', 03:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:11:36 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 03:11:36 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 03:11:36 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 03:11:36 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 03:11:36 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 03:11:36 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 03:11:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:11:39 INFO - Installing collected packages: mozsystemmonitor 03:11:39 INFO - Running setup.py install for mozsystemmonitor 03:11:39 INFO - Successfully installed mozsystemmonitor 03:11:39 INFO - Cleaning up... 03:11:39 INFO - Return code: 0 03:11:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:39 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:39 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 03:11:39 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 03:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:39 INFO - 'HOME': '/Users/cltbld', 03:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:39 INFO - 'LOGNAME': 'cltbld', 03:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:39 INFO - 'MOZ_NO_REMOTE': '1', 03:11:39 INFO - 'NO_EM_RESTART': '1', 03:11:39 INFO - 'PAGER': '/bin/cat', 03:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:39 INFO - 'PWD': '/builds/slave/test', 03:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:39 INFO - 'SHELL': '/bin/bash', 03:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:39 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:39 INFO - 'USER': 'cltbld', 03:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:39 INFO - 'XPC_FLAGS': '0x0', 03:11:39 INFO - 'XPC_SERVICE_NAME': '0', 03:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:11:39 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 03:11:39 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 03:11:39 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 03:11:39 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 03:11:39 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 03:11:39 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 03:11:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:11:42 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 03:11:42 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 03:11:42 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 03:11:42 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 03:11:42 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 03:11:42 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 03:11:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:42 INFO - warning: no files found matching '*.txt' 03:11:42 INFO - no previously-included directories found matching 'build' 03:11:42 INFO - no previously-included directories found matching 'dist' 03:11:42 INFO - no previously-included directories found matching '.git*' 03:11:42 INFO - Installing collected packages: jsonschema, functools32 03:11:42 INFO - Running setup.py install for functools32 03:11:42 INFO - warning: no files found matching '*.txt' 03:11:42 INFO - no previously-included directories found matching 'build' 03:11:42 INFO - no previously-included directories found matching 'dist' 03:11:42 INFO - no previously-included directories found matching '.git*' 03:11:42 INFO - Successfully installed jsonschema functools32 03:11:42 INFO - Cleaning up... 03:11:42 INFO - Return code: 0 03:11:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:11:42 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')]} 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 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')]} 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:42 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:42 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 03:11:42 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 03:11:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:42 INFO - 'HOME': '/Users/cltbld', 03:11:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:42 INFO - 'LOGNAME': 'cltbld', 03:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:42 INFO - 'MOZ_NO_REMOTE': '1', 03:11:42 INFO - 'NO_EM_RESTART': '1', 03:11:42 INFO - 'PAGER': '/bin/cat', 03:11:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:42 INFO - 'PWD': '/builds/slave/test', 03:11:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:42 INFO - 'SHELL': '/bin/bash', 03:11:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:42 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:42 INFO - 'USER': 'cltbld', 03:11:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:42 INFO - 'XPC_FLAGS': '0x0', 03:11:42 INFO - 'XPC_SERVICE_NAME': '0', 03:11:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:11:43 INFO - Cleaning up... 03:11:43 INFO - Return code: 0 03:11:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:11:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:43 INFO - 'HOME': '/Users/cltbld', 03:11:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:43 INFO - 'LOGNAME': 'cltbld', 03:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:43 INFO - 'MOZ_NO_REMOTE': '1', 03:11:43 INFO - 'NO_EM_RESTART': '1', 03:11:43 INFO - 'PAGER': '/bin/cat', 03:11:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:43 INFO - 'PWD': '/builds/slave/test', 03:11:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:43 INFO - 'SHELL': '/bin/bash', 03:11:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:43 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:43 INFO - 'USER': 'cltbld', 03:11:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:43 INFO - 'XPC_FLAGS': '0x0', 03:11:43 INFO - 'XPC_SERVICE_NAME': '0', 03:11:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:43 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:43 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 03:11:43 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 03:11:43 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 03:11:43 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 03:11:43 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 03:11:43 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 03:11:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:46 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 03:11:47 INFO - Downloading docopt-0.6.1.tar.gz 03:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:47 INFO - Running setup.py install for blobuploader 03:11:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:47 INFO - Running setup.py install for requests 03:11:47 INFO - Running setup.py install for docopt 03:11:47 INFO - Successfully installed blobuploader requests docopt 03:11:47 INFO - Cleaning up... 03:11:48 INFO - Return code: 0 03:11:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:48 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:48 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 03:11:48 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 03:11:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:48 INFO - 'HOME': '/Users/cltbld', 03:11:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:48 INFO - 'LOGNAME': 'cltbld', 03:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:48 INFO - 'MOZ_NO_REMOTE': '1', 03:11:48 INFO - 'NO_EM_RESTART': '1', 03:11:48 INFO - 'PAGER': '/bin/cat', 03:11:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:48 INFO - 'PWD': '/builds/slave/test', 03:11:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:48 INFO - 'SHELL': '/bin/bash', 03:11:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:48 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:48 INFO - 'USER': 'cltbld', 03:11:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:48 INFO - 'XPC_FLAGS': '0x0', 03:11:48 INFO - 'XPC_SERVICE_NAME': '0', 03:11:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-H_qUzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-DryNWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-6mdZYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JAOG6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-e_ludZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-nphCr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:48 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-iytF4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-aQlCJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-bB_K0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-MPKOl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-8FZvwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-AWXu8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-VMVSfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-AKohpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-cFeNWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-xgjUz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:49 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-E_CDnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:50 INFO - Running setup.py install for manifestparser 03:11:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:50 INFO - Running setup.py install for mozcrash 03:11:50 INFO - Running setup.py install for mozdebug 03:11:50 INFO - Running setup.py install for mozdevice 03:11:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:50 INFO - Running setup.py install for mozfile 03:11:50 INFO - Running setup.py install for mozhttpd 03:11:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:50 INFO - Running setup.py install for mozinfo 03:11:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Running setup.py install for mozInstall 03:11:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Running setup.py install for mozleak 03:11:51 INFO - Running setup.py install for mozlog 03:11:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Running setup.py install for moznetwork 03:11:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Running setup.py install for mozprocess 03:11:51 INFO - Running setup.py install for mozprofile 03:11:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:51 INFO - Running setup.py install for mozrunner 03:11:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:52 INFO - Running setup.py install for mozscreenshot 03:11:52 INFO - Running setup.py install for moztest 03:11:52 INFO - Running setup.py install for mozversion 03:11:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:52 INFO - Cleaning up... 03:11:52 INFO - Return code: 0 03:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:52 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')]} 03:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:52 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')]} 03:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:52 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:52 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 03:11:52 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 03:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:52 INFO - 'HOME': '/Users/cltbld', 03:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:52 INFO - 'LOGNAME': 'cltbld', 03:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:52 INFO - 'MOZ_NO_REMOTE': '1', 03:11:52 INFO - 'NO_EM_RESTART': '1', 03:11:52 INFO - 'PAGER': '/bin/cat', 03:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:52 INFO - 'PWD': '/builds/slave/test', 03:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:52 INFO - 'SHELL': '/bin/bash', 03:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:52 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:52 INFO - 'USER': 'cltbld', 03:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:52 INFO - 'XPC_FLAGS': '0x0', 03:11:52 INFO - 'XPC_SERVICE_NAME': '0', 03:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:52 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ijlD0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-q_VPZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-r8Lwqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-JYVUkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-tFuqEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-QMImgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-eLrTT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-ToFbHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-t66i03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-le0BcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:53 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)) 03:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:53 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-2sMJJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-I85h6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-gX70D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-J3r0KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-5Y78op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-zLOwBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:54 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)) 03:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:54 INFO - Running setup.py (path:/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/pip-oUo_TJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:54 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)) 03:11:54 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)) 03:11:54 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)) 03:11:54 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)) 03:11:54 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)) 03:11:54 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)) 03:11:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:54 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 03:11:57 INFO - Downloading blessings-1.6.tar.gz 03:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:57 INFO - Installing collected packages: blessings 03:11:57 INFO - Running setup.py install for blessings 03:11:57 INFO - Successfully installed blessings 03:11:57 INFO - Cleaning up... 03:11:57 INFO - Return code: 0 03:11:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:57 INFO - Reading from file tmpfile_stdout 03:11:57 INFO - Current package versions: 03:11:57 INFO - blessings == 1.6 03:11:57 INFO - blobuploader == 1.2.4 03:11:57 INFO - docopt == 0.6.1 03:11:57 INFO - functools32 == 3.2.3-2 03:11:57 INFO - jsonschema == 2.5.1 03:11:57 INFO - manifestparser == 1.1 03:11:57 INFO - mozInstall == 1.12 03:11:57 INFO - mozcrash == 0.17 03:11:57 INFO - mozdebug == 0.1 03:11:57 INFO - mozdevice == 0.48 03:11:57 INFO - mozfile == 1.2 03:11:57 INFO - mozhttpd == 0.7 03:11:57 INFO - mozinfo == 0.9 03:11:57 INFO - mozleak == 0.1 03:11:57 INFO - mozlog == 3.4 03:11:57 INFO - moznetwork == 0.27 03:11:57 INFO - mozprocess == 0.23 03:11:57 INFO - mozprofile == 0.28 03:11:57 INFO - mozrunner == 6.12 03:11:57 INFO - mozscreenshot == 0.1 03:11:57 INFO - mozsystemmonitor == 0.3 03:11:57 INFO - moztest == 0.7 03:11:57 INFO - mozversion == 1.4 03:11:57 INFO - psutil == 3.1.1 03:11:57 INFO - requests == 1.2.3 03:11:57 INFO - wsgiref == 0.1.2 03:11:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:57 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')]} 03:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:57 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')]} 03:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:57 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 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:57 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 03:11:57 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 03:11:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:57 INFO - 'HOME': '/Users/cltbld', 03:11:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:57 INFO - 'LOGNAME': 'cltbld', 03:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:57 INFO - 'MOZ_NO_REMOTE': '1', 03:11:57 INFO - 'NO_EM_RESTART': '1', 03:11:57 INFO - 'PAGER': '/bin/cat', 03:11:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:57 INFO - 'PWD': '/builds/slave/test', 03:11:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:57 INFO - 'SHELL': '/bin/bash', 03:11:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:57 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:57 INFO - 'USER': 'cltbld', 03:11:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:57 INFO - 'XPC_FLAGS': '0x0', 03:11:57 INFO - 'XPC_SERVICE_NAME': '0', 03:11:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 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)) 03:11:58 INFO - Cleaning up... 03:11:58 INFO - Return code: 0 03:11:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10829c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11bd6bf00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, '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.QsxswNGFZ0/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.AIo4LezOYL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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 03:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:58 INFO - 'HOME': '/Users/cltbld', 03:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:58 INFO - 'LOGNAME': 'cltbld', 03:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:58 INFO - 'MOZ_NO_REMOTE': '1', 03:11:58 INFO - 'NO_EM_RESTART': '1', 03:11:58 INFO - 'PAGER': '/bin/cat', 03:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:58 INFO - 'PWD': '/builds/slave/test', 03:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:58 INFO - 'SHELL': '/bin/bash', 03:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:11:58 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:58 INFO - 'USER': 'cltbld', 03:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:58 INFO - 'XPC_FLAGS': '0x0', 03:11:58 INFO - 'XPC_SERVICE_NAME': '0', 03:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:11:58 INFO - Cleaning up... 03:11:58 INFO - Return code: 0 03:11:58 INFO - Running post-action listener: _resource_record_post_action 03:11:58 INFO - Running post-action listener: _start_resource_monitoring 03:11:58 INFO - Starting resource monitoring. 03:11:58 INFO - [mozharness: 2016-10-12 10:11:58.464455Z] Finished create-virtualenv step (success) 03:11:58 INFO - [mozharness: 2016-10-12 10:11:58.465540Z] Running install step. 03:11:58 INFO - Running pre-action listener: _resource_record_pre_action 03:11:58 INFO - Running main action method: install 03:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:58 INFO - Reading from file tmpfile_stdout 03:11:58 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:58 INFO - Reading from file tmpfile_stdout 03:11:58 INFO - Output received: 03:11:58 INFO - Usage: mozinstall [options] installer 03:11:58 INFO - Options: 03:11:58 INFO - -h, --help show this help message and exit 03:11:58 INFO - -d DEST, --destination=DEST 03:11:58 INFO - Directory to install application into. [default: 03:11:58 INFO - "/builds/slave/test"] 03:11:58 INFO - --app=APP Application being installed. [default: firefox] 03:11:58 INFO - mkdir: /builds/slave/test/build/application 03:11:58 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'] 03:11:58 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 03:12:30 INFO - Reading from file tmpfile_stdout 03:12:30 INFO - Output received: 03:12:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:12:30 INFO - Running post-action listener: _resource_record_post_action 03:12:30 INFO - [mozharness: 2016-10-12 10:12:30.577620Z] Finished install step (success) 03:12:30 INFO - [mozharness: 2016-10-12 10:12:30.577791Z] Running run-tests step. 03:12:30 INFO - Running pre-action listener: _resource_record_pre_action 03:12:30 INFO - Running main action method: run_tests 03:12:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:12:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:12:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:12:30 INFO - 2016-10-12 03:12:30.593 screenresolution[2268:24193] starting screenresolution argv=screenresolution get 03:12:30 INFO - 2016-10-12 03:12:30.595 screenresolution[2268:24193] Display 0: 1600x1200x32@60 03:12:30 INFO - 2016-10-12 03:12:30.602 screenresolution[2269:24196] starting screenresolution argv=screenresolution list 03:12:30 INFO - Available Modes on Display 0 03:12:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:12:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:12:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:12:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:12:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:12:30 INFO - Intel Iris: 03:12:30 INFO - Chipset Model: Intel Iris 03:12:30 INFO - Type: GPU 03:12:30 INFO - Bus: Built-In 03:12:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:12:30 INFO - Vendor: Intel (0x8086) 03:12:30 INFO - Device ID: 0x0a2e 03:12:30 INFO - Revision ID: 0x0009 03:12:30 INFO - Displays: 03:12:30 INFO - Display: 03:12:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:12:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:12:30 INFO - Display Serial Number: 1600x1200 60 03:12:30 INFO - Main Display: Yes 03:12:30 INFO - Mirror: Off 03:12:30 INFO - Online: Yes 03:12:30 INFO - Rotation: Supported 03:12:30 INFO - Return code: 0 03:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:30 INFO - Python 2.7.3 03:12:30 INFO - Return code: 0 03:12:30 INFO - grabbing minidump binary from tooltool 03:12: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')]} 03:12:30 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 0x10813ad30>, '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 0x107fa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108132b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:30 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 03:12:30 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 03:12:30 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 03:12:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:30 INFO - Return code: 0 03:12:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:12:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:12:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:30 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/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 03:12:30 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/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0111 --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 03:12:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QsxswNGFZ0/Render', 03:12:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:30 INFO - 'HOME': '/Users/cltbld', 03:12:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:30 INFO - 'LOGNAME': 'cltbld', 03:12:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:30 INFO - 'MOZ_NO_REMOTE': '1', 03:12:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:30 INFO - 'NO_EM_RESTART': '1', 03:12:30 INFO - 'PAGER': '/bin/cat', 03:12:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:30 INFO - 'PWD': '/builds/slave/test', 03:12:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:30 INFO - 'SHELL': '/bin/bash', 03:12:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AIo4LezOYL/Listeners', 03:12:30 INFO - 'TMPDIR': '/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/', 03:12:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:30 INFO - 'USER': 'cltbld', 03:12:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:30 INFO - 'XPC_FLAGS': '0x0', 03:12:30 INFO - 'XPC_SERVICE_NAME': '0', 03:12:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:30 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/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0111', '--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 03:12:31 INFO - mozversion application_buildid: 20161012005247 03:12:31 INFO - mozversion application_changeset: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 03:12:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:12:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:31 INFO - mozversion application_name: Firefox 03:12:31 INFO - mozversion application_remotingname: firefox-dev 03:12:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:31 INFO - mozversion application_vendor: Mozilla 03:12:31 INFO - mozversion application_version: 51.0a2 03:12:31 INFO - mozversion platform_buildid: 20161012005247 03:12:31 INFO - mozversion platform_changeset: 2da62d29c6a4826c874bc7f6b9e315b0293b2fc9 03:12:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:12:31 INFO - mozversion platform_version: 51.0a2 03:12:31 INFO - using testdate: 1476267151 03:12:31 INFO - actual date: 1476267151 03:12:31 INFO - starting webserver on 'localhost:58851' 03:12:31 INFO - SUITE-START | Running 2 tests 03:12:31 INFO - TEST-START | dromaeo_css 03:12:31 INFO - operating with platform_type : mac_ 03:12:31 INFO - Initialising browser for dromaeo_css test... 03:12:31 INFO - TEST-INFO | started process 2279 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpQ0uol1/profile http://localhost:58851/getInfo.html) 03:12:33 INFO - PROCESS | 2279 | __metrics Screen width/height:1600/1200 03:12:33 INFO - PROCESS | 2279 | colorDepth:24 03:12:33 INFO - PROCESS | 2279 | Browser inner width/height: 1024/689 03:12:33 INFO - PROCESS | 2279 | __metrics 03:12:33 INFO - PROCESS | 2279 | 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" 03:12:33 INFO - PROCESS | 2279 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:34 INFO - TEST-INFO | 2279: exit 0 03:12:34 INFO - Browser initialized. 03:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:34 INFO - TEST-INFO | started process 2281 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmpQ0uol1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:46 INFO - PROCESS | 2281 | RSS: Main: 220418048 03:12:46 INFO - PROCESS | 2281 | 03:13:37 INFO - PROCESS | 2281 | 1476267217261 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] 03:15:49 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58851/tests/dromaeo/cssquery-ext.html) 03:15:50 INFO - PROCESS | 2281 | RSS: Main: 372363264 03:15:50 INFO - PROCESS | 2281 | 03:18:53 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-ext.html (next: http://localhost:58851/tests/dromaeo/cssquery-jquery.html) 03:18:54 INFO - PROCESS | 2281 | RSS: Main: 353611776 03:18:54 INFO - PROCESS | 2281 | 03:21:56 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58851/tests/dromaeo/cssquery-mootools.html) 03:21:57 INFO - PROCESS | 2281 | RSS: Main: 349388800 03:21:57 INFO - PROCESS | 2281 | 03:24:59 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58851/tests/dromaeo/cssquery-prototype.html) 03:25:00 INFO - PROCESS | 2281 | RSS: Main: 323063808 03:25:00 INFO - PROCESS | 2281 | 03:28:03 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58851/tests/dromaeo/cssquery-yui.html) 03:28:04 INFO - PROCESS | 2281 | RSS: Main: 310558720 03:28:04 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | Cycle 1(1): loaded http://localhost:58851/tests/dromaeo/cssquery-yui.html (next: http://localhost:58851/tests/dromaeo/cssquery-dojo.html) 03:31:07 INFO - PROCESS | 2281 | RSS: Main: 455258112 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | __start_tp_report 03:31:07 INFO - PROCESS | 2281 | _x_x_mozilla_page_load 03:31:07 INFO - PROCESS | 2281 | _x_x_mozilla_page_load_details 03:31:07 INFO - PROCESS | 2281 | |i|pagename|runs| 03:31:07 INFO - PROCESS | 2281 | |0;dojo.html;3334.266461378496;3341.4486609709397;3382.8477718502663;3388.5086662433964;3421.5894092708877;5843.532517398608;5916.970415147929;5918.05311150216;5971.701414929253;6002.489788367994;5829.650220986744;5921.5262778977685;5931.555133364994;5943.732532036058;5965.612235204709;5290.285811415458;5305.920411193835;5359.785608575652;5376.838694839142;5406.864828379303;5280.498352656491;5298.7350632468415;5391.73041347933;5403.864903377427;5424.620276580641;5330.866728331804;5346.27825243593;5356.437574054727;5370.301860758096;5379.865503362408;5335.093034184179;5362.4637536246455;5364.624476286662;5407.161889907071;5432.483914028161;5259.421463638997;5365.114756065244;5373.355197376301;5375.16006397574;5407.270018547485;5725.742341594639;5784.19021337009;5797.710114494258;5823.068309070571;5946.494547963428;6186.597871138361;6220.160278362454;6244.344343843876;6247.031710084944;6259.499240060784;6308.337624549448;6320.051992201161;6329.525285603599;6329.905051424233;6342.556021078526;5802.912956305659;5887.11693246008;5903.881922361528;6017.63894166347;6035.547333949928;6305.369463053749;6343.619382836952;6410.903836442457;6423.293437721847;6430.549861509743;6145.508359331243;6215.96892015537;6217.378262173746;6233.75064997395;6243.43809057178;6286.057091436322;6294.307626161119;6300.464460520907;6309.905351419732;6314.400131987454;6126.181801870944;6147.0779383092895;6199.163112979781;6203.379662033851;6216.378362163838;6223.439890409885;6227.439530442282;6237.1891654084675;6238.625682459067;6242.719077641517;5014.924776128361;5017.197248440305;5041.722705251246;5077.339945807095;5093.923591146136;4423.800928958204;4449.777511124431;4463.888402789957;4482.686211965196;4556.863294101182;6020.127081573148;6040.607360521552;6042;6082.330943596201;6098.32918378978;6290.528210384239;6291.307956124822;6304.085907543381;6320.273168585672;6332.366763323723;5846.093855452412;5887.028640274307;5921.911171332434;6011.819645410645;6014.729337179838;4766;5445.346558413015;5541.667499950016;5585.1901474286005;5586.636868603528;6448.806535803933;6458.709358078898;6513.609183449008;6518.837029074216;6530.575512591667;6199.845003874759;6268.435840774352;6270.310265870842;6298.401651843067;6308.526860485574;6262.780802672067;6327.557071004985;6400.199975003125;6469.644169570719;6476.514261430506;6217.129601855834;6228.937710622836;6247.468965138014;6256.124142619946;6256.655883926245;6134.447899689049;6257.4681152102585;6265.49876009909;6276.560640755103;6293;6118.192813662006;6134.04922237054;6138.171346868295;6144.740328232612;6187.783427580013;6165.075238714049;6180.721867516063;6193.876122477615;6196.504279657706;6197.194364732556;6155.538334624832;6160.507159427325;6162.445379915829;6165.784197553064;6178.536609754196;6107.27984577779;6111.105587097545;6111.449969502766;6119.112728654231;6170.7223174958135;5881.3236477803885;6120.569035656853;6171.9691401542705;6174.6912654368;6190.721417536131 03:31:07 INFO - PROCESS | 2281 | |1;ext.html;450.86474057782664;505.40362372400574;529.2828217764926;532.7256462921596;547.384192783119;30629.69370306299;31126;32692.67307326926;32767.83616081922;40968.38547421791;41302.58697413025;43826.561734382645;43897;44004.77997610007;44103.89740256487;9873.308868379216;10042.297039207258;10074.093331600154;10090.445025523593;10105;8954.597043133042;9171.449713017208;9664;9771.26715496337;9786.26603004774;12145.453454594564;12396.81404778929;12404;12525.373731313444;12612.369381530887;12361.69095772604;12447.190932589352;12458.875411245952;12466.501339946437;12470.688232794162;8873.73378798637;9092.8636070459;9097.727068187965;12258.570950016796;12352.07359448036;32323;32749.672503274902;41589.58410415918;42454.787726061484;42651.36022959658;3354.647761985005;3364.49532570114;3393.7794043387103;3421.538092357525;3696.2237930034457;30388.8480557598;30578.235544111354;31102.37795244105;31882;32591;3252.1544398456335;3318.78427902188;3326.434506133963;3343.762807761144;3355.0605830367535;530872;531878;532620;532981;535766.9999999962;51965.48034519606;52348;60172.39827601668;61096.38903610907;61584.38415615876;60551.394486055455;63960;64105.35894641087;64132.67933660302;64288.678556606916;16402.671946561;16612.086335251435;16623.584410389594;16625.334986600643;16643.167841607872;12788.680282993;12867.485300587872;12870.420831062438;12875.742485150244;12889.226646401059;14960.102393856403;15314.770278445832;15371;16852.915735421244;17082.743758843626;6929.782469609677;7028.753993610199;7091.503594748318;7106.964465177641;7129.108861392326;850.753281548344;953.4851180362526;961.4375590279625;993.64228877604;1020.3010937507682;28849.27876803055;29810;29974.55038174429;30525.542116868266;30727.846360768053;869.3957699398984;982.7739619887323;1075.3709080188178;1084.7884662490897;1138.072470936201;15149.697006059818;15309.851761117961;15454.768178477332;15723.68552628941;15755.369785208693;656312;659809;660650;661150.6942465256;661627;50363.748181259594;50678.49321506738;50915.490845091816;58187.70906145442;58199.709001455565;1333.6599167212298;1361.795730640392;1380.2201756007823;1380.5996261084174;1381.7996390523317;25359;30114.397712046073;31438.68561314449;31549.52675709912;32009.8399508001;42301.57698422977;42884.78557607192;50861.491385085676;50972.725681858254;51060.23409648784;628438;632508;632857;634075;635222.8238858776;40014.99962500961;40462.39306410465;40817.79591102144;40871.386929196684;40914;46788.53211467842;47462;47839.282410764565;48198.51801482081;48515;38515;38651.806740966116;39325.80337098296;40514.79742601268;41003.1799364017;32763.576917115883;37711.434328484545;38045.619543804205;38905.02737431587;40039.39940900831;38716.80641596774;38784.6121538781;38882.2223555533;39355.6064439352;39418.40872386859;32924.67075329216;34819.477707833896;35031.47452788159;35452;35736;22623;23947.880260599282;24675.753242467345;25845.8318800144;26057.478850423264 03:31:07 INFO - PROCESS | 2281 | |2;jquery.html;358.19942428671897;373.74211793862236;375.50245924150505;387.06137616280523;406.9755814651121;14701.926490367547;15239.085654860715;16443;19561.315353962615;20073.498162545944;20477.078531466082;20501.794982050174;21057.684134737952;21108.788912110875;21273.893630531864;5970.43280888316;5979.312379076418;6249.468795152395;6252.34350393209;6265.780697675582;4965.255211718235;6310.621362718229;6313.084602732601;6323;6324.241091069078;3979.4030895365636;4202.243596152706;6007.669578173199;6239.750409983595;6279.937200627981;6313.1792866927235;6332.968335158294;6344.714487848058;6536.7712130075215;7063.89404158938;6178.07328900664;6191.0713392990965;6194.1018552310115;6198.132261483396;6202.689865506707;12306.523217213991;12595.3072581008;13209.273489958048;13217.603471895762;13363.997700172526;2218.73375194976;2220.489287463892;2228.2869481765842;2240.316703405461;2564.4230048239183;10080.193584513221;10193.388396696222;10311.84532232017;12315;15718.873984507867;1646.5718913082565;1836.834684878354;1839.5860931290485;1874.1566295167092;1941.5728539721238;122942;125633.37183314117;126687.09969350467;129833;130124.34937825345;11323.094152467947;11488.425578721031;11576.884231157748;11609.419529023515;11787.941060294643;14714.92642536802;14735.92632036833;14749.41002359915;14770;14773.92613036928;7080.681369338289;8709.172628600272;8728.865247517782;8746.518941458153;8843.69047083349;7270.709171633075;8729.345299102593;8734.65061397537;8755.255803256667;8874.955625221832;3791.981040094837;4479.865604031885;4481.3726078349055;4484.461864576272;4490.416245888014;1853.1105069566413;1909.7517322747954;1914.7362740591143;1922.2027404376952;1929.3633101076612;862.5299211929513;914.6112902016749;975.1321324021626;984.2372161574837;1026.0919086608255;18668.81331186698;19442.90278548598;21065.78934210669;21094.472638183863;21147.577048459254;931.2270815223349;962.9229661627053;964.9951750241204;969.2391472693902;984.227381505529;8763.956180219058;10660.946695266473;11202.775944481065;11203.271787333797;11216.83174752363;570046;593195;597448;617341;617877;111517.44241278904;135089.64910350967;136604;139104;139142;976.3848775271533;982.5529384130203;1035.8705161854768;1035.963741269052;1043.5877828257796;18709.25162993465;19758.604827903073;20396.184152633727;20416.489587760425;20423.59152816965;56263.25061960572;59739;60650.39349606448;61146;61256.38743612685;81910;87466.56266718626;88057.79855503664;88085.55957220173;89899;5598.496135347838;5816.156657284585;7358.871467756763;8190.221928916743;8402.159784021549;10619.522121504706;11195.44022798873;12716.554920577735;12799.744005119659;13267.270300133585;11235.775284494428;11327.943360283145;11635.127365447455;11677.532898684298;11735.882641173479;10843.67468975932;11261.887381126084;11278.041366483942;11709.882901170879;11737.823932641188;11518.654440366803;11601.535938562363;11634.70913227176;11775.705607359541;12079.154459187772;8208.425410221227;8222.424430289822;8346.916530834615;8458.365622578209;8632.352573556882;9638.518074096128;11129.833052504056;11597.420128993348;11772.52909883595;11835.940820295844 03:31:07 INFO - PROCESS | 2281 | |3;mootools.html;1309.5874799438182;1518.1877695432943;1534.340233699509;1714.1086634949827;1863.590010197756;7905.565193914333;8437.19846614572;8676.522791246487;9042.32182586307;9050.321225908066;8873.955630221855;8954.417962832411;8958.1489758473;8959.417637853552;8966.686165984192;2407.2296865003163;2433.488967316857;2436.5492383908945;2441;2443.425794938188;2395.2335252719135;2427.672264244331;2437.878106094697;2439.6462512935614;2442.120836498859;2409.5301416223756;2419.9879000604974;2430.2709187243845;2441.8412803167826;2443.816713746467;2379.1553998330514;2383.6543701163323;2386.832921695482;2394.4851856850773;2418.310781427285;2377.1917548033753;2387.8089752819733;2423.587990041697;2425.745296743834;2427.417419819248;8960.731178064669;9060.864087038699;9070.54647267634;9080.40977336471;9082.86375704365;5295.258663787073;5482.259894914216;5488.588355873326;5522.834314970557;5535.059039963216;3641.3809652359164;3681.5582130144285;3718.3307004739136;3754.3054534910857;3754.3805272130066;955.7419496735912;1072.624581396513;1073.313079629038;1092.159037541089;1093.704699731068;11911.702207444796;11947.880521194764;12034;12065;12073.698157546043;4529.54704529551;4566.634669226454;4745.1695953208055;4752.904941901143;4757.476677565465;8010.3191228745045;9255.490947997925;9268.351215414856;9273.72178834636;9278.67524636648;5344.706041167773;5347.705876176848;5347.839564813062;5353;5369.48989845964;4203.62167404935;4462.598366147063;4618.330342100377;4639.396878405786;5015.749212539431;3869.496965394481;3878.437626544135;3922.4508568800393;3948.624880636335;3965.7025723070883;1191.5650787462514;1192.4574318685152;1194.5460724924646;1206.221986818497;1207.5169932027259;850.4217132350061;891.790429249126;904.7195369435365;911.5214512381053;947.7204224753714;5747.4252574742195;5789.768409263666;5980.611260268069;6112.51099912006;6234.1583886175695;433.89586499240585;445.7704282294621;446.54006373435413;456.57766565926386;467.686649944538;3994.9001274967777;4022.3363145080734;4025.396190571379;4055.878323650295;4140.275451795924;10582.365058096539;11053.00522952938;11071.280366776135;11072.501737421835;11126.332420054823;10941.343519388862;10967.780644387067;10970.122390208764;10971.890281097087;10991;7944.6027698614835;8264.256216940505;8314.667413303521;8345.833083338299;8420.663173473115;5767.942320576741;5955.642661440327;5991.550633702403;6116.113163591165;6133.570650054632;10202.33684810485;10459.372437653765;10468.057874791306;10481.161507079263;10493.317934334244;10185.745356365855;10373.585056597953;10431.16550675929;10518.345491077003;10591.417472038804;7662.923370766221;7755.495892766952;7765.844683106419;7859.803504912423;7880.605969701606;7095.396891264094;8024.919750802417;8334.749957501284;8452.873206902024;8544.615492302737;7709.922900770921;7718.459707820399;7765.883511747441;7796.259355361231;7833.608319583884;7554.584497852671;7614.390848731978;7617.581033043014;7657.0811502620045;7681.539107653559;7150.96424517874;7156.248593897566;7159.355657990805;7253.202147763636;7255.782326530212;5072.213806859942;5091.1854103343285;5111.309973153577;5123.5644970177955;5147.356580427447;4998.3002379667605;5089.7709603067215;5123.410807757155;5231.42454330031;5313.973430132824 03:31:07 INFO - PROCESS | 2281 | |4;prototype.html;305.332847727715;308.3109250824407;314.51250561629473;318.70360564674843;321.3027729826277;4784.330193772875;5088.898222035557;5295.285136506571;5312.574994000481;5319.696674314793;5097.088591778083;5148.819791307295;5183.688978661283;5274.890043982409;5319.893602127955;4110.815013324393;4111.280525907954;4117.567655396185;4133.016152246923;4140.151268989857;3558.377283975307;3579.872340212825;3717.163638181401;4022.4948058174887;4104.610062044101;4014.4580481635044;4047.9797601011956;4057.7768222747736;4072.287349713803;4097.569755175708;3533.699635530983;4044.0496483326397;4051.9392209116886;4074.6943979201383;4075.286824805647;2987.925301867471;3494.5672274367644;3505.685367987005;3539.80531070791;3567.6432356764376;4849.078675051765;4962.6774259673;5192.480751924815;5193.896122077537;5205.973970130125;4355.344968911825;4663.347131401607;4679.368285281512;4707.223308154151;4713.740744259065;5334.199870019489;5544.805931792368;5579.804706835242;5600.327960644708;5663.433656634304;3288.4245257080156;3318.4026875162463;3786;3900.7854567998747;3920.666743326821;5016.795968967458;5377.220303056035;5410.594205434569;5671.971640141773;5854.18041474194;3484.52958850557;3868.8200098969523;3939.7589759225752;4007.6793856491413;4018.738781979162;3408.5909690837257;3592.8203589820405;3690.0036990012545;3696.8336424860945;4052.2908491014546;3466.445368740989;3765.849366025383;4232.492100947844;4414.80133393998;4660.951285960632;4729.4797572267025;5573.7770489179975;5620.57845661577;5640.464155905182;5643.604947653707;1084.8860869608736;1314.9408276627576;1318.5451019398292;1325.2578556008666;1331.1746717035307;779.1624004195512;782.8473447677649;843.6372359885308;857.8370109679266;863.6329559937002;3899.727019108692;4375.7966559196475;4377;4417.889552761207;4420.226460369422;4356.884827348461;4564.157877916273;4709.929351059737;4783.928241076386;4847.200211965057;4293.659955324356;4352.564743525685;4381.430414046154;4391.111821916543;4450.688451808407;2151.817095546865;2330.6620540021604;2497.937551561189;2502.912398066059;2507.761762632547;4378.255696531533;4582.88542786433;4677.22825733757;4680.906381872412;4911.551092427742;4839.128956787742;4862.763128960647;4873.19592267279;4881.412162060882;4924.532169443897;4504.932426013613;4587.472440669366;4856.247281671346;4892.657513974059;4943.3573635427165;4043.0903046815406;4122.525909520444;4291.4765258332845;4580.610648094949;4693.357324936245;4830.855074347775;5258.684478931276;5473.397926228191;5785.016547186904;5830.82507524775;5290.883646541414;5413.648112872651;5980.491658208927;6036.517078633611;6060;3686.79722615248;3930.665893399093;3957.9604203957592;3958.4260282258333;3960.32677942382;5102.76470529467;5483.643563168382;5745.942540574708;5752.165935939349;5766.65533990293;5601.523870470893;5639.8590035249445;5645.604807663424;5676.829695109153;5700.235385837783;4125.233141500621;5438;5529.474699903502;5577.888442231051;5607.719614019365;4358.738475691469;4533;4603.608693261111;4678.947236871677;5460.914583260445;5712.742926568231;5724.627899186539;5735.139729040678;5736.397678243891;5743.655380677173;4635.768211589339;5276.419593844597;5556.277683901067;5559.444055594408;5604 03:31:07 INFO - PROCESS | 2281 | |5;yui.html;677.4817264792434;698.807827847342;777.6150805351356;792.1405275276325;822.893023906892;12424.875751242485;16140.596485087879;16210.83789162108;16256.268467918942;16309;14451.78322325166;14641.780373294408;14667.779983300232;14669.899757518175;14675;672.2370109925246;692.9341712537326;835.2399316621876;859.2224037246302;869.5956380283167;848.520585868982;850.3494826457764;851.1871163039283;851.5742128935532;852.1521086518923;902.8645703144548;903.7379160043612;903.8553831386979;906.2795077913042;906.5376657904483;715.6350261366688;740.2227660955974;745.9104907411091;746.7349091072699;902.4720538484994;550.6998685716294;653.0824192010233;666.3070406776947;674.8515326628134;677.7831094049906;15033.624159395993;15060.698786024328;15071.321790519452;15096;15105.244737763178;13866.098703584235;14111.223882686449;14156.221407822566;14220.288985550682;14380.424783008668;12449.75100497985;12849.229046257162;12908.419121139572;13122;13483.932580337036;4380.036391993756;4424.358468022118;4504.79728412219;4523.70595911268;4619.676622636417;118364.81635183624;121471;121665;121785;121982;8841.823163536694;8916.821663566692;9011.729648110437;9251.213646839959;9402.90597094034;20750.06624701892;20770.48073798167;20826;20992.580148396948;21087;7857.607119644109;7886.960565197252;7934.484258523177;8070.636821343053;8158.877616835753;3755.530558680165;4274.812184601388;4448.488423831236;4481.991551900862;4500.729956202638;3466.930661386758;3576.660217279354;3584.8386822592524;3588.659077387644;3602.495650608917;600.2227115884939;635.4027214418431;654.7511945460694;655.6819942327967;680.6086500262369;537.5887446103734;560.8205374280273;630.8959021761358;631.2267472346431;642.1844257792577;7434.516756410816;9249.260059195383;9265.25877929764;9355.95322023399;9443.527823608792;505.70669011972967;577.4514211499009;621.6860485454816;632.0582332324894;636.3613694736073;4110.917781644351;4551.95448045522;4560.293154561048;4582.023073794513;4593.333966574828;82171.58914205391;113115.43442282735;149664.2516787409;172658;176568;124220.37889810493;132442;133156;135779;137045;104369.47815261027;108931;115141;122779.38610306891;123971;7703.632724968006;8988.86516702263;9037.593308301011;9111.726648200565;9203.76990575241;61382.69308653428;62118;62981.370186299384;64379.67810160919;66846;80761.59619201867;94838.52580737052;99743;100062;101221;13765.724685506435;13915.373808178858;14243.287835607971;14344.139351638934;14872.851271487147;15127.470538531099;15222.16278104715;15411.383544658089;15509.99185052968;16525;10626.8405973912;12389.62831115068;13908.582742517741;14415;14425.639359016108;13962.371693273624;14075.366608502847;14089.15465072099;14197.503087391891;14260.429582816987;13658.453661853415;13766.036377453482;13903.374348154559;14231.146131232159;14730.484433045222;10552.525136368728;10817.18871084656;11377.146713996648;11769.117316201147;11914.52341906314;10926.836097458703;11770.470328835394;11856.129645772371;11932.224405413968;12052.337121458404 03:31:07 INFO - PROCESS | 2281 | __end_tp_report 03:31:07 INFO - PROCESS | 2281 | __start_cc_report 03:31:07 INFO - PROCESS | 2281 | _x_x_mozilla_cycle_collect,1362 03:31:07 INFO - PROCESS | 2281 | __end_cc_report 03:31:07 INFO - PROCESS | 2281 | __startTimestamp1476268267457__endTimestamp 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | ------- Summary: start ------- 03:31:07 INFO - PROCESS | 2281 | Number of tests: 6 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#0] dojo.html Cycles:165 Average:5854.80 Median:6126.18 stddev:639.17 (10.4%) stddev-sans-first:609.78 03:31:07 INFO - PROCESS | 2281 | Values: 3334.3 3341.4 3382.8 3388.5 3421.6 5843.5 5917.0 5918.1 5971.7 6002.5 5829.7 5921.5 5931.6 5943.7 5965.6 5290.3 5305.9 5359.8 5376.8 5406.9 5280.5 5298.7 5391.7 5403.9 5424.6 5330.9 5346.3 5356.4 5370.3 5379.9 5335.1 5362.5 5364.6 5407.2 5432.5 5259.4 5365.1 5373.4 5375.2 5407.3 5725.7 5784.2 5797.7 5823.1 5946.5 6186.6 6220.2 6244.3 6247.0 6259.5 6308.3 6320.1 6329.5 6329.9 6342.6 5802.9 5887.1 5903.9 6017.6 6035.5 6305.4 6343.6 6410.9 6423.3 6430.5 6145.5 6216.0 6217.4 6233.8 6243.4 6286.1 6294.3 6300.5 6309.9 6314.4 6126.2 6147.1 6199.2 6203.4 6216.4 6223.4 6227.4 6237.2 6238.6 6242.7 5014.9 5017.2 5041.7 5077.3 5093.9 4423.8 4449.8 4463.9 4482.7 4556.9 6020.1 6040.6 6042.0 6082.3 6098.3 6290.5 6291.3 6304.1 6320.3 6332.4 5846.1 5887.0 5921.9 6011.8 6014.7 4766.0 5445.3 5541.7 5585.2 5586.6 6448.8 6458.7 6513.6 6518.8 6530.6 6199.8 6268.4 6270.3 6298.4 6308.5 6262.8 6327.6 6400.2 6469.6 6476.5 6217.1 6228.9 6247.5 6256.1 6256.7 6134.4 6257.5 6265.5 6276.6 6293.0 6118.2 6134.0 6138.2 6144.7 6187.8 6165.1 6180.7 6193.9 6196.5 6197.2 6155.5 6160.5 6162.4 6165.8 6178.5 6107.3 6111.1 6111.4 6119.1 6170.7 5881.3 6120.6 6172.0 6174.7 6190.7 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#1] ext.html Cycles:180 Average:73650.75 Median:38684.31 stddev:163416.21 (422.4%) stddev-sans-first:163782.21 03:31:07 INFO - PROCESS | 2281 | Values: 450.9 505.4 529.3 532.7 547.4 30629.7 31126.0 32692.7 32767.8 40968.4 41302.6 43826.6 43897.0 44004.8 44103.9 9873.3 10042.3 10074.1 10090.4 10105.0 8954.6 9171.4 9664.0 9771.3 9786.3 12145.5 12396.8 12404.0 12525.4 12612.4 12361.7 12447.2 12458.9 12466.5 12470.7 8873.7 9092.9 9097.7 12258.6 12352.1 32323.0 32749.7 41589.6 42454.8 42651.4 3354.6 3364.5 3393.8 3421.5 3696.2 30388.8 30578.2 31102.4 31882.0 32591.0 3252.2 3318.8 3326.4 3343.8 3355.1 530872.0 531878.0 532620.0 532981.0 535767.0 51965.5 52348.0 60172.4 61096.4 61584.4 60551.4 63960.0 64105.4 64132.7 64288.7 16402.7 16612.1 16623.6 16625.3 16643.2 12788.7 12867.5 12870.4 12875.7 12889.2 14960.1 15314.8 15371.0 16852.9 17082.7 6929.8 7028.8 7091.5 7107.0 7129.1 850.8 953.5 961.4 993.6 1020.3 28849.3 29810.0 29974.6 30525.5 30727.8 869.4 982.8 1075.4 1084.8 1138.1 15149.7 15309.9 15454.8 15723.7 15755.4 656312.0 659809.0 660650.0 661150.7 661627.0 50363.7 50678.5 50915.5 58187.7 58199.7 1333.7 1361.8 1380.2 1380.6 1381.8 25359.0 30114.4 31438.7 31549.5 32009.8 42301.6 42884.8 50861.5 50972.7 51060.2 628438.0 632508.0 632857.0 634075.0 635222.8 40015.0 40462.4 40817.8 40871.4 40914.0 46788.5 47462.0 47839.3 48198.5 48515.0 38515.0 38651.8 39325.8 40514.8 41003.2 32763.6 37711.4 38045.6 38905.0 40039.4 38716.8 38784.6 38882.2 39355.6 39418.4 32924.7 34819.5 35031.5 35452.0 35736.0 22623.0 23947.9 24675.8 25845.8 26057.5 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#2] jquery.html Cycles:180 Average:35541.56 Median:21210.74 stddev:100594.15 (474.3%) stddev-sans-first:100841.66 03:31:07 INFO - PROCESS | 2281 | Values: 358.2 373.7 375.5 387.1 407.0 14701.9 15239.1 16443.0 19561.3 20073.5 20477.1 20501.8 21057.7 21108.8 21273.9 5970.4 5979.3 6249.5 6252.3 6265.8 4965.3 6310.6 6313.1 6323.0 6324.2 3979.4 4202.2 6007.7 6239.8 6279.9 6313.2 6333.0 6344.7 6536.8 7063.9 6178.1 6191.1 6194.1 6198.1 6202.7 12306.5 12595.3 13209.3 13217.6 13364.0 2218.7 2220.5 2228.3 2240.3 2564.4 10080.2 10193.4 10311.8 12315.0 15718.9 1646.6 1836.8 1839.6 1874.2 1941.6 122942.0 125633.4 126687.1 129833.0 130124.3 11323.1 11488.4 11576.9 11609.4 11787.9 14714.9 14735.9 14749.4 14770.0 14773.9 7080.7 8709.2 8728.9 8746.5 8843.7 7270.7 8729.3 8734.7 8755.3 8875.0 3792.0 4479.9 4481.4 4484.5 4490.4 1853.1 1909.8 1914.7 1922.2 1929.4 862.5 914.6 975.1 984.2 1026.1 18668.8 19442.9 21065.8 21094.5 21147.6 931.2 962.9 965.0 969.2 984.2 8764.0 10660.9 11202.8 11203.3 11216.8 570046.0 593195.0 597448.0 617341.0 617877.0 111517.4 135089.6 136604.0 139104.0 139142.0 976.4 982.6 1035.9 1036.0 1043.6 18709.3 19758.6 20396.2 20416.5 20423.6 56263.3 59739.0 60650.4 61146.0 61256.4 81910.0 87466.6 88057.8 88085.6 89899.0 5598.5 5816.2 7358.9 8190.2 8402.2 10619.5 11195.4 12716.6 12799.7 13267.3 11235.8 11327.9 11635.1 11677.5 11735.9 10843.7 11261.9 11278.0 11709.9 11737.8 11518.7 11601.5 11634.7 11775.7 12079.2 8208.4 8222.4 8346.9 8458.4 8632.4 9638.5 11129.8 11597.4 11772.5 11835.9 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#3] mootools.html Cycles:180 Average:5789.20 Median:4749.04 stddev:3279.99 (69.1%) stddev-sans-first:3271.91 03:31:07 INFO - PROCESS | 2281 | Values: 1309.6 1518.2 1534.3 1714.1 1863.6 7905.6 8437.2 8676.5 9042.3 9050.3 8874.0 8954.4 8958.1 8959.4 8966.7 2407.2 2433.5 2436.5 2441.0 2443.4 2395.2 2427.7 2437.9 2439.6 2442.1 2409.5 2420.0 2430.3 2441.8 2443.8 2379.2 2383.7 2386.8 2394.5 2418.3 2377.2 2387.8 2423.6 2425.7 2427.4 8960.7 9060.9 9070.5 9080.4 9082.9 5295.3 5482.3 5488.6 5522.8 5535.1 3641.4 3681.6 3718.3 3754.3 3754.4 955.7 1072.6 1073.3 1092.2 1093.7 11911.7 11947.9 12034.0 12065.0 12073.7 4529.5 4566.6 4745.2 4752.9 4757.5 8010.3 9255.5 9268.4 9273.7 9278.7 5344.7 5347.7 5347.8 5353.0 5369.5 4203.6 4462.6 4618.3 4639.4 5015.7 3869.5 3878.4 3922.5 3948.6 3965.7 1191.6 1192.5 1194.5 1206.2 1207.5 850.4 891.8 904.7 911.5 947.7 5747.4 5789.8 5980.6 6112.5 6234.2 433.9 445.8 446.5 456.6 467.7 3994.9 4022.3 4025.4 4055.9 4140.3 10582.4 11053.0 11071.3 11072.5 11126.3 10941.3 10967.8 10970.1 10971.9 10991.0 7944.6 8264.3 8314.7 8345.8 8420.7 5767.9 5955.6 5991.6 6116.1 6133.6 10202.3 10459.4 10468.1 10481.2 10493.3 10185.7 10373.6 10431.2 10518.3 10591.4 7662.9 7755.5 7765.8 7859.8 7880.6 7095.4 8024.9 8334.7 8452.9 8544.6 7709.9 7718.5 7765.9 7796.3 7833.6 7554.6 7614.4 7617.6 7657.1 7681.5 7151.0 7156.2 7159.4 7253.2 7255.8 5072.2 5091.2 5111.3 5123.6 5147.4 4998.3 5089.8 5123.4 5231.4 5314.0 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#4] prototype.html Cycles:180 Average:4313.69 Median:4662.15 stddev:1331.24 (28.6%) stddev-sans-first:1300.53 03:31:07 INFO - PROCESS | 2281 | Values: 305.3 308.3 314.5 318.7 321.3 4784.3 5088.9 5295.3 5312.6 5319.7 5097.1 5148.8 5183.7 5274.9 5319.9 4110.8 4111.3 4117.6 4133.0 4140.2 3558.4 3579.9 3717.2 4022.5 4104.6 4014.5 4048.0 4057.8 4072.3 4097.6 3533.7 4044.0 4051.9 4074.7 4075.3 2987.9 3494.6 3505.7 3539.8 3567.6 4849.1 4962.7 5192.5 5193.9 5206.0 4355.3 4663.3 4679.4 4707.2 4713.7 5334.2 5544.8 5579.8 5600.3 5663.4 3288.4 3318.4 3786.0 3900.8 3920.7 5016.8 5377.2 5410.6 5672.0 5854.2 3484.5 3868.8 3939.8 4007.7 4018.7 3408.6 3592.8 3690.0 3696.8 4052.3 3466.4 3765.8 4232.5 4414.8 4661.0 4729.5 5573.8 5620.6 5640.5 5643.6 1084.9 1314.9 1318.5 1325.3 1331.2 779.2 782.8 843.6 857.8 863.6 3899.7 4375.8 4377.0 4417.9 4420.2 4356.9 4564.2 4709.9 4783.9 4847.2 4293.7 4352.6 4381.4 4391.1 4450.7 2151.8 2330.7 2497.9 2502.9 2507.8 4378.3 4582.9 4677.2 4680.9 4911.6 4839.1 4862.8 4873.2 4881.4 4924.5 4504.9 4587.5 4856.2 4892.7 4943.4 4043.1 4122.5 4291.5 4580.6 4693.4 4830.9 5258.7 5473.4 5785.0 5830.8 5290.9 5413.6 5980.5 6036.5 6060.0 3686.8 3930.7 3958.0 3958.4 3960.3 5102.8 5483.6 5745.9 5752.2 5766.7 5601.5 5639.9 5645.6 5676.8 5700.2 4125.2 5438.0 5529.5 5577.9 5607.7 4358.7 4533.0 4603.6 4678.9 5460.9 5712.7 5724.6 5735.1 5736.4 5743.7 4635.8 5276.4 5556.3 5559.4 5604.0 03:31:07 INFO - PROCESS | 2281 | 03:31:07 INFO - PROCESS | 2281 | [#5] yui.html Cycles:180 Average:25327.55 Median:3679.01 stddev:40720.24 (1106.8%) stddev-sans-first:40792.41 03:31:07 INFO - PROCESS | 2281 | Values: 677.5 698.8 777.6 792.1 822.9 12424.9 16140.6 16210.8 16256.3 16309.0 14451.8 14641.8 14667.8 14669.9 14675.0 672.2 692.9 835.2 859.2 869.6 848.5 850.3 851.2 851.6 852.2 902.9 903.7 903.9 906.3 906.5 715.6 740.2 745.9 746.7 902.5 550.7 653.1 666.3 674.9 677.8 15033.6 15060.7 15071.3 15096.0 15105.2 13866.1 14111.2 14156.2 14220.3 14380.4 12449.8 12849.2 12908.4 13122.0 13483.9 4380.0 4424.4 4504.8 4523.7 4619.7 118364.8 121471.0 121665.0 121785.0 121982.0 8841.8 8916.8 9011.7 9251.2 9402.9 20750.1 20770.5 20826.0 20992.6 21087.0 7857.6 7887.0 7934.5 8070.6 8158.9 3755.5 4274.8 4448.5 4482.0 4500.7 3466.9 3576.7 3584.8 3588.7 3602.5 600.2 635.4 654.8 655.7 680.6 537.6 560.8 630.9 631.2 642.2 7434.5 9249.3 9265.3 9356.0 9443.5 505.7 577.5 621.7 632.1 636.4 4110.9 4552.0 4560.3 4582.0 4593.3 82171.6 113115.4 149664.3 172658.0 176568.0 124220.4 132442.0 133156.0 135779.0 137045.0 104369.5 108931.0 115141.0 122779.4 123971.0 7703.6 8988.9 9037.6 9111.7 9203.8 61382.7 62118.0 62981.4 64379.7 66846.0 80761.6 94838.5 99743.0 100062.0 101221.0 13765.7 13915.4 14243.3 14344.1 14872.9 15127.5 15222.2 15411.4 15510.0 16525.0 10626.8 12389.6 13908.6 14415.0 14425.6 13962.4 14075.4 14089.2 14197.5 14260.4 13658.5 13766.0 13903.4 14231.1 14730.5 10552.5 10817.2 11377.1 11769.1 11914.5 10926.8 11770.5 11856.1 11932.2 12052.3 03:31:07 INFO - PROCESS | 2281 | -------- Summary: end -------- 03:31:07 INFO - PROCESS | 2281 | 03:31:08 INFO - TEST-INFO | 2281: exit 0 03:31:08 INFO - TEST-OK | dromaeo_css | took 1116909ms 03:31:08 INFO - TEST-START | kraken 03:31:08 INFO - operating with platform_type : mac_ 03:31:08 INFO - Initialising browser for kraken test... 03:31:08 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmplMY4b1/profile http://localhost:58851/getInfo.html) 03:31:10 INFO - PROCESS | 2284 | __metrics Screen width/height:1600/1200 03:31:10 INFO - PROCESS | 2284 | colorDepth:24 03:31:10 INFO - PROCESS | 2284 | Browser inner width/height: 1024/689 03:31:10 INFO - PROCESS | 2284 | __metrics 03:31:10 INFO - PROCESS | 2284 | 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" 03:31:10 INFO - PROCESS | 2284 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:11 INFO - TEST-INFO | 2284: exit 0 03:31:11 INFO - Browser initialized. 03:31:11 INFO - Running cycle 1/1 for kraken test... 03:31:11 INFO - TEST-INFO | started process 2285 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/T/tmplMY4b1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:23 INFO - PROCESS | 2285 | RSS: Main: 219594752 03:31:23 INFO - PROCESS | 2285 | 03:31:26 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:26 INFO - PROCESS | 2285 | RSS: Main: 270954496 03:31:26 INFO - PROCESS | 2285 | 03:31:29 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-dft) 03:31:30 INFO - PROCESS | 2285 | RSS: Main: 282234880 03:31:30 INFO - PROCESS | 2285 | 03:31:33 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-fft) 03:31:33 INFO - PROCESS | 2285 | RSS: Main: 379265024 03:31:33 INFO - PROCESS | 2285 | 03:31:35 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator) 03:31:36 INFO - PROCESS | 2285 | RSS: Main: 279252992 03:31:36 INFO - PROCESS | 2285 | 03:31:38 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:39 INFO - PROCESS | 2285 | RSS: Main: 279801856 03:31:39 INFO - PROCESS | 2285 | 03:31:41 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:42 INFO - PROCESS | 2285 | RSS: Main: 318418944 03:31:42 INFO - PROCESS | 2285 | 03:31:45 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:45 INFO - PROCESS | 2285 | RSS: Main: 321048576 03:31:45 INFO - PROCESS | 2285 | 03:31:48 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial) 03:31:49 INFO - PROCESS | 2285 | RSS: Main: 317030400 03:31:49 INFO - PROCESS | 2285 | 03:31:51 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:51 INFO - PROCESS | 2285 | RSS: Main: 290095104 03:31:51 INFO - PROCESS | 2285 | 03:31:53 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:54 INFO - PROCESS | 2285 | RSS: Main: 296132608 03:31:54 INFO - PROCESS | 2285 | 03:31:56 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:56 INFO - PROCESS | 2285 | RSS: Main: 297816064 03:31:56 INFO - PROCESS | 2285 | 03:31:59 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:00 INFO - PROCESS | 2285 | RSS: Main: 306475008 03:32:00 INFO - PROCESS | 2285 | 03:32:03 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:03 INFO - PROCESS | 2285 | RSS: Main: 305762304 03:32:03 INFO - PROCESS | 2285 | 03:32:05 INFO - PROCESS | 2285 | Cycle 1(1): loaded http://localhost:58851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58851/tests/kraken/driver.html?testName=ai-astar) 03:32:06 INFO - PROCESS | 2285 | RSS: Main: 349712384 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | __start_tp_report 03:32:06 INFO - PROCESS | 2285 | _x_x_mozilla_page_load 03:32:06 INFO - PROCESS | 2285 | _x_x_mozilla_page_load_details 03:32:06 INFO - PROCESS | 2285 | |i|pagename|runs| 03:32:06 INFO - PROCESS | 2285 | |0;ai-astar;113;114;115;114;112;114;113;115;164;165 03:32:06 INFO - PROCESS | 2285 | |1;audio-beat-detection;147;108;111;141;109;136;137;134;140;108 03:32:06 INFO - PROCESS | 2285 | |2;audio-dft;181;183;184;186;186;184;184;178;185;184 03:32:06 INFO - PROCESS | 2285 | |3;audio-fft;79;63;58;88;60;59;57;58;83;58 03:32:06 INFO - PROCESS | 2285 | |4;audio-oscillator;83;69;93;67;67;69;91;66;71;99 03:32:06 INFO - PROCESS | 2285 | |5;imaging-gaussian-blur;86;83;86;85;86;83;88;84;86;84 03:32:06 INFO - PROCESS | 2285 | |6;imaging-darkroom;94;95;95;96;95;95;96;95;95;96 03:32:06 INFO - PROCESS | 2285 | |7;imaging-desaturate;87;72;138;130;138;84;86;86;85;93 03:32:06 INFO - PROCESS | 2285 | |8;json-parse-financial;57;54;54;54;56;57;57;57;57;57 03:32:06 INFO - PROCESS | 2285 | |9;json-stringify-tinderbox;64;73;67;73;77;72;69;70;70;70 03:32:06 INFO - PROCESS | 2285 | |10;stanford-crypto-aes;84;84;81;81;82;80;82;81;86;84 03:32:06 INFO - PROCESS | 2285 | |11;stanford-crypto-ccm;141;148;126;144;147;157;134;142;167;127 03:32:06 INFO - PROCESS | 2285 | |12;stanford-crypto-pbkdf2;162;164;163;163;167;164;162;160;162;161 03:32:06 INFO - PROCESS | 2285 | |13;stanford-crypto-sha256-iterative;69;67;68;81;82;83;82;82;57;76 03:32:06 INFO - PROCESS | 2285 | __end_tp_report 03:32:06 INFO - PROCESS | 2285 | __start_cc_report 03:32:06 INFO - PROCESS | 2285 | _x_x_mozilla_cycle_collect,1932 03:32:06 INFO - PROCESS | 2285 | __end_cc_report 03:32:06 INFO - PROCESS | 2285 | __startTimestamp1476268326011__endTimestamp 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | ------- Summary: start ------- 03:32:06 INFO - PROCESS | 2285 | Number of tests: 14 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#0] ai-astar Cycles:10 Average:123.90 Median:114.50 stddev:21.42 (18.7%) stddev-sans-first:22.35 03:32:06 INFO - PROCESS | 2285 | Values: 113.0 114.0 115.0 114.0 112.0 114.0 113.0 115.0 164.0 165.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:136.50 stddev:15.98 (11.7%) stddev-sans-first:15.24 03:32:06 INFO - PROCESS | 2285 | Values: 147.0 108.0 111.0 141.0 109.0 136.0 137.0 134.0 140.0 108.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:2.42 (1.3%) stddev-sans-first:2.39 03:32:06 INFO - PROCESS | 2285 | Values: 181.0 183.0 184.0 186.0 186.0 184.0 184.0 178.0 185.0 184.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.50 stddev:12.06 (19.6%) stddev-sans-first:11.88 03:32:06 INFO - PROCESS | 2285 | Values: 79.0 63.0 58.0 88.0 60.0 59.0 57.0 58.0 83.0 58.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:77.00 stddev:12.71 (16.5%) stddev-sans-first:13.33 03:32:06 INFO - PROCESS | 2285 | Values: 83.0 69.0 93.0 67.0 67.0 69.0 91.0 66.0 71.0 99.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.60 (1.9%) stddev-sans-first:1.66 03:32:06 INFO - PROCESS | 2285 | Values: 86.0 83.0 86.0 85.0 86.0 83.0 88.0 84.0 86.0 84.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 03:32:06 INFO - PROCESS | 2285 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:85.50 stddev:25.08 (29.3%) stddev-sans-first:26.17 03:32:06 INFO - PROCESS | 2285 | Values: 87.0 72.0 138.0 130.0 138.0 84.0 86.0 86.0 85.0 93.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.41 (2.5%) stddev-sans-first:1.45 03:32:06 INFO - PROCESS | 2285 | Values: 57.0 54.0 54.0 54.0 56.0 57.0 57.0 57.0 57.0 57.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:3.57 (5.0%) stddev-sans-first:2.91 03:32:06 INFO - PROCESS | 2285 | Values: 64.0 73.0 67.0 73.0 77.0 72.0 69.0 70.0 70.0 70.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.90 (2.3%) stddev-sans-first:1.94 03:32:06 INFO - PROCESS | 2285 | Values: 84.0 84.0 81.0 81.0 82.0 80.0 82.0 81.0 86.0 84.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:145.50 stddev:12.67 (8.7%) stddev-sans-first:13.41 03:32:06 INFO - PROCESS | 2285 | Values: 141.0 148.0 126.0 144.0 147.0 157.0 134.0 142.0 167.0 127.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:1.93 (1.2%) stddev-sans-first:2.03 03:32:06 INFO - PROCESS | 2285 | Values: 162.0 164.0 163.0 163.0 167.0 164.0 162.0 160.0 162.0 161.0 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - PROCESS | 2285 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:81.50 stddev:8.94 (11.0%) stddev-sans-first:9.25 03:32:06 INFO - PROCESS | 2285 | Values: 69.0 67.0 68.0 81.0 82.0 83.0 82.0 82.0 57.0 76.0 03:32:06 INFO - PROCESS | 2285 | -------- Summary: end -------- 03:32:06 INFO - PROCESS | 2285 | 03:32:06 INFO - TEST-INFO | 2285: exit 0 03:32:06 INFO - TEST-OK | kraken | took 58802ms 03:32:06 INFO - SUITE-END | took 1175s 03:32:07 INFO - Completed test suite (00:19:35) 03:32:07 INFO - javascript benchmark 03:32:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.266461378496, 3341.4486609709397, 3382.8477718502663, 3388.5086662433964, 3421.5894092708877, 5843.532517398608, 5916.970415147929, 5918.05311150216, 5971.701414929253, 6002.489788367994, 5829.650220986744, 5921.5262778977685, 5931.555133364994, 5943.732532036058, 5965.612235204709, 5290.285811415458, 5305.920411193835, 5359.785608575652, 5376.838694839142, 5406.864828379303, 5280.498352656491, 5298.7350632468415, 5391.73041347933, 5403.864903377427, 5424.620276580641, 5330.866728331804, 5346.27825243593, 5356.437574054727, 5370.301860758096, 5379.865503362408, 5335.093034184179, 5362.4637536246455, 5364.624476286662, 5407.161889907071, 5432.483914028161, 5259.421463638997, 5365.114756065244, 5373.355197376301, 5375.16006397574, 5407.270018547485, 5725.742341594639, 5784.19021337009, 5797.710114494258, 5823.068309070571, 5946.494547963428, 6186.597871138361, 6220.160278362454, 6244.344343843876, 6247.031710084944, 6259.499240060784, 6308.337624549448, 6320.051992201161, 6329.525285603599, 6329.905051424233, 6342.556021078526, 5802.912956305659, 5887.11693246008, 5903.881922361528, 6017.63894166347, 6035.547333949928, 6305.369463053749, 6343.619382836952, 6410.903836442457, 6423.293437721847, 6430.549861509743, 6145.508359331243, 6215.96892015537, 6217.378262173746, 6233.75064997395, 6243.43809057178, 6286.057091436322, 6294.307626161119, 6300.464460520907, 6309.905351419732, 6314.400131987454, 6126.181801870944, 6147.0779383092895, 6199.163112979781, 6203.379662033851, 6216.378362163838, 6223.439890409885, 6227.439530442282, 6237.1891654084675, 6238.625682459067, 6242.719077641517, 5014.924776128361, 5017.197248440305, 5041.722705251246, 5077.339945807095, 5093.923591146136, 4423.800928958204, 4449.777511124431, 4463.888402789957, 4482.686211965196, 4556.863294101182, 6020.127081573148, 6040.607360521552, 6042.0, 6082.330943596201, 6098.32918378978, 6290.528210384239, 6291.307956124822, 6304.085907543381, 6320.273168585672, 6332.366763323723, 5846.093855452412, 5887.028640274307, 5921.911171332434, 6011.819645410645, 6014.729337179838, 4766.0, 5445.346558413015, 5541.667499950016, 5585.1901474286005, 5586.636868603528, 6448.806535803933, 6458.709358078898, 6513.609183449008, 6518.837029074216, 6530.575512591667, 6199.845003874759, 6268.435840774352, 6270.310265870842, 6298.401651843067, 6308.526860485574, 6262.780802672067, 6327.557071004985, 6400.199975003125, 6469.644169570719, 6476.514261430506, 6217.129601855834, 6228.937710622836, 6247.468965138014, 6256.124142619946, 6256.655883926245, 6134.447899689049, 6257.4681152102585, 6265.49876009909, 6276.560640755103, 6293.0, 6118.192813662006, 6134.04922237054, 6138.171346868295, 6144.740328232612, 6187.783427580013, 6165.075238714049, 6180.721867516063, 6193.876122477615, 6196.504279657706, 6197.194364732556, 6155.538334624832, 6160.507159427325, 6162.445379915829, 6165.784197553064, 6178.536609754196, 6107.27984577779, 6111.105587097545, 6111.449969502766, 6119.112728654231, 6170.7223174958135, 5881.3236477803885, 6120.569035656853, 6171.9691401542705, 6174.6912654368, 6190.721417536131], "value": 5813.070784483795, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.86474057782664, 505.40362372400574, 529.2828217764926, 532.7256462921596, 547.384192783119, 30629.69370306299, 31126.0, 32692.67307326926, 32767.83616081922, 40968.38547421791, 41302.58697413025, 43826.561734382645, 43897.0, 44004.77997610007, 44103.89740256487, 9873.308868379216, 10042.297039207258, 10074.093331600154, 10090.445025523593, 10105.0, 8954.597043133042, 9171.449713017208, 9664.0, 9771.26715496337, 9786.26603004774, 12145.453454594564, 12396.81404778929, 12404.0, 12525.373731313444, 12612.369381530887, 12361.69095772604, 12447.190932589352, 12458.875411245952, 12466.501339946437, 12470.688232794162, 8873.73378798637, 9092.8636070459, 9097.727068187965, 12258.570950016796, 12352.07359448036, 32323.0, 32749.672503274902, 41589.58410415918, 42454.787726061484, 42651.36022959658, 3354.647761985005, 3364.49532570114, 3393.7794043387103, 3421.538092357525, 3696.2237930034457, 30388.8480557598, 30578.235544111354, 31102.37795244105, 31882.0, 32591.0, 3252.1544398456335, 3318.78427902188, 3326.434506133963, 3343.762807761144, 3355.0605830367535, 530872.0, 531878.0, 532620.0, 532981.0, 535766.9999999962, 51965.48034519606, 52348.0, 60172.39827601668, 61096.38903610907, 61584.38415615876, 60551.394486055455, 63960.0, 64105.35894641087, 64132.67933660302, 64288.678556606916, 16402.671946561, 16612.086335251435, 16623.584410389594, 16625.334986600643, 16643.167841607872, 12788.680282993, 12867.485300587872, 12870.420831062438, 12875.742485150244, 12889.226646401059, 14960.102393856403, 15314.770278445832, 15371.0, 16852.915735421244, 17082.743758843626, 6929.782469609677, 7028.753993610199, 7091.503594748318, 7106.964465177641, 7129.108861392326, 850.753281548344, 953.4851180362526, 961.4375590279625, 993.64228877604, 1020.3010937507682, 28849.27876803055, 29810.0, 29974.55038174429, 30525.542116868266, 30727.846360768053, 869.3957699398984, 982.7739619887323, 1075.3709080188178, 1084.7884662490897, 1138.072470936201, 15149.697006059818, 15309.851761117961, 15454.768178477332, 15723.68552628941, 15755.369785208693, 656312.0, 659809.0, 660650.0, 661150.6942465256, 661627.0, 50363.748181259594, 50678.49321506738, 50915.490845091816, 58187.70906145442, 58199.709001455565, 1333.6599167212298, 1361.795730640392, 1380.2201756007823, 1380.5996261084174, 1381.7996390523317, 25359.0, 30114.397712046073, 31438.68561314449, 31549.52675709912, 32009.8399508001, 42301.57698422977, 42884.78557607192, 50861.491385085676, 50972.725681858254, 51060.23409648784, 628438.0, 632508.0, 632857.0, 634075.0, 635222.8238858776, 40014.99962500961, 40462.39306410465, 40817.79591102144, 40871.386929196684, 40914.0, 46788.53211467842, 47462.0, 47839.282410764565, 48198.51801482081, 48515.0, 38515.0, 38651.806740966116, 39325.80337098296, 40514.79742601268, 41003.1799364017, 32763.576917115883, 37711.434328484545, 38045.619543804205, 38905.02737431587, 40039.39940900831, 38716.80641596774, 38784.6121538781, 38882.2223555533, 39355.6064439352, 39418.40872386859, 32924.67075329216, 34819.477707833896, 35031.47452788159, 35452.0, 35736.0, 22623.0, 23947.880260599282, 24675.753242467345, 25845.8318800144, 26057.478850423264], "value": 20403.288181699536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.19942428671897, 373.74211793862236, 375.50245924150505, 387.06137616280523, 406.9755814651121, 14701.926490367547, 15239.085654860715, 16443.0, 19561.315353962615, 20073.498162545944, 20477.078531466082, 20501.794982050174, 21057.684134737952, 21108.788912110875, 21273.893630531864, 5970.43280888316, 5979.312379076418, 6249.468795152395, 6252.34350393209, 6265.780697675582, 4965.255211718235, 6310.621362718229, 6313.084602732601, 6323.0, 6324.241091069078, 3979.4030895365636, 4202.243596152706, 6007.669578173199, 6239.750409983595, 6279.937200627981, 6313.1792866927235, 6332.968335158294, 6344.714487848058, 6536.7712130075215, 7063.89404158938, 6178.07328900664, 6191.0713392990965, 6194.1018552310115, 6198.132261483396, 6202.689865506707, 12306.523217213991, 12595.3072581008, 13209.273489958048, 13217.603471895762, 13363.997700172526, 2218.73375194976, 2220.489287463892, 2228.2869481765842, 2240.316703405461, 2564.4230048239183, 10080.193584513221, 10193.388396696222, 10311.84532232017, 12315.0, 15718.873984507867, 1646.5718913082565, 1836.834684878354, 1839.5860931290485, 1874.1566295167092, 1941.5728539721238, 122942.0, 125633.37183314117, 126687.09969350467, 129833.0, 130124.34937825345, 11323.094152467947, 11488.425578721031, 11576.884231157748, 11609.419529023515, 11787.941060294643, 14714.92642536802, 14735.92632036833, 14749.41002359915, 14770.0, 14773.92613036928, 7080.681369338289, 8709.172628600272, 8728.865247517782, 8746.518941458153, 8843.69047083349, 7270.709171633075, 8729.345299102593, 8734.65061397537, 8755.255803256667, 8874.955625221832, 3791.981040094837, 4479.865604031885, 4481.3726078349055, 4484.461864576272, 4490.416245888014, 1853.1105069566413, 1909.7517322747954, 1914.7362740591143, 1922.2027404376952, 1929.3633101076612, 862.5299211929513, 914.6112902016749, 975.1321324021626, 984.2372161574837, 1026.0919086608255, 18668.81331186698, 19442.90278548598, 21065.78934210669, 21094.472638183863, 21147.577048459254, 931.2270815223349, 962.9229661627053, 964.9951750241204, 969.2391472693902, 984.227381505529, 8763.956180219058, 10660.946695266473, 11202.775944481065, 11203.271787333797, 11216.83174752363, 570046.0, 593195.0, 597448.0, 617341.0, 617877.0, 111517.44241278904, 135089.64910350967, 136604.0, 139104.0, 139142.0, 976.3848775271533, 982.5529384130203, 1035.8705161854768, 1035.963741269052, 1043.5877828257796, 18709.25162993465, 19758.604827903073, 20396.184152633727, 20416.489587760425, 20423.59152816965, 56263.25061960572, 59739.0, 60650.39349606448, 61146.0, 61256.38743612685, 81910.0, 87466.56266718626, 88057.79855503664, 88085.55957220173, 89899.0, 5598.496135347838, 5816.156657284585, 7358.871467756763, 8190.221928916743, 8402.159784021549, 10619.522121504706, 11195.44022798873, 12716.554920577735, 12799.744005119659, 13267.270300133585, 11235.775284494428, 11327.943360283145, 11635.127365447455, 11677.532898684298, 11735.882641173479, 10843.67468975932, 11261.887381126084, 11278.041366483942, 11709.882901170879, 11737.823932641188, 11518.654440366803, 11601.535938562363, 11634.70913227176, 11775.705607359541, 12079.154459187772, 8208.425410221227, 8222.424430289822, 8346.916530834615, 8458.365622578209, 8632.352573556882, 9638.518074096128, 11129.833052504056, 11597.420128993348, 11772.52909883595, 11835.940820295844], "value": 9538.248424483696, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.5874799438182, 1518.1877695432943, 1534.340233699509, 1714.1086634949827, 1863.590010197756, 7905.565193914333, 8437.19846614572, 8676.522791246487, 9042.32182586307, 9050.321225908066, 8873.955630221855, 8954.417962832411, 8958.1489758473, 8959.417637853552, 8966.686165984192, 2407.2296865003163, 2433.488967316857, 2436.5492383908945, 2441.0, 2443.425794938188, 2395.2335252719135, 2427.672264244331, 2437.878106094697, 2439.6462512935614, 2442.120836498859, 2409.5301416223756, 2419.9879000604974, 2430.2709187243845, 2441.8412803167826, 2443.816713746467, 2379.1553998330514, 2383.6543701163323, 2386.832921695482, 2394.4851856850773, 2418.310781427285, 2377.1917548033753, 2387.8089752819733, 2423.587990041697, 2425.745296743834, 2427.417419819248, 8960.731178064669, 9060.864087038699, 9070.54647267634, 9080.40977336471, 9082.86375704365, 5295.258663787073, 5482.259894914216, 5488.588355873326, 5522.834314970557, 5535.059039963216, 3641.3809652359164, 3681.5582130144285, 3718.3307004739136, 3754.3054534910857, 3754.3805272130066, 955.7419496735912, 1072.624581396513, 1073.313079629038, 1092.159037541089, 1093.704699731068, 11911.702207444796, 11947.880521194764, 12034.0, 12065.0, 12073.698157546043, 4529.54704529551, 4566.634669226454, 4745.1695953208055, 4752.904941901143, 4757.476677565465, 8010.3191228745045, 9255.490947997925, 9268.351215414856, 9273.72178834636, 9278.67524636648, 5344.706041167773, 5347.705876176848, 5347.839564813062, 5353.0, 5369.48989845964, 4203.62167404935, 4462.598366147063, 4618.330342100377, 4639.396878405786, 5015.749212539431, 3869.496965394481, 3878.437626544135, 3922.4508568800393, 3948.624880636335, 3965.7025723070883, 1191.5650787462514, 1192.4574318685152, 1194.5460724924646, 1206.221986818497, 1207.5169932027259, 850.4217132350061, 891.790429249126, 904.7195369435365, 911.5214512381053, 947.7204224753714, 5747.4252574742195, 5789.768409263666, 5980.611260268069, 6112.51099912006, 6234.1583886175695, 433.89586499240585, 445.7704282294621, 446.54006373435413, 456.57766565926386, 467.686649944538, 3994.9001274967777, 4022.3363145080734, 4025.396190571379, 4055.878323650295, 4140.275451795924, 10582.365058096539, 11053.00522952938, 11071.280366776135, 11072.501737421835, 11126.332420054823, 10941.343519388862, 10967.780644387067, 10970.122390208764, 10971.890281097087, 10991.0, 7944.6027698614835, 8264.256216940505, 8314.667413303521, 8345.833083338299, 8420.663173473115, 5767.942320576741, 5955.642661440327, 5991.550633702403, 6116.113163591165, 6133.570650054632, 10202.33684810485, 10459.372437653765, 10468.057874791306, 10481.161507079263, 10493.317934334244, 10185.745356365855, 10373.585056597953, 10431.16550675929, 10518.345491077003, 10591.417472038804, 7662.923370766221, 7755.495892766952, 7765.844683106419, 7859.803504912423, 7880.605969701606, 7095.396891264094, 8024.919750802417, 8334.749957501284, 8452.873206902024, 8544.615492302737, 7709.922900770921, 7718.459707820399, 7765.883511747441, 7796.259355361231, 7833.608319583884, 7554.584497852671, 7614.390848731978, 7617.581033043014, 7657.0811502620045, 7681.539107653559, 7150.96424517874, 7156.248593897566, 7159.355657990805, 7253.202147763636, 7255.782326530212, 5072.213806859942, 5091.1854103343285, 5111.309973153577, 5123.5644970177955, 5147.356580427447, 4998.3002379667605, 5089.7709603067215, 5123.410807757155, 5231.42454330031, 5313.973430132824], "value": 4556.883427774444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.332847727715, 308.3109250824407, 314.51250561629473, 318.70360564674843, 321.3027729826277, 4784.330193772875, 5088.898222035557, 5295.285136506571, 5312.574994000481, 5319.696674314793, 5097.088591778083, 5148.819791307295, 5183.688978661283, 5274.890043982409, 5319.893602127955, 4110.815013324393, 4111.280525907954, 4117.567655396185, 4133.016152246923, 4140.151268989857, 3558.377283975307, 3579.872340212825, 3717.163638181401, 4022.4948058174887, 4104.610062044101, 4014.4580481635044, 4047.9797601011956, 4057.7768222747736, 4072.287349713803, 4097.569755175708, 3533.699635530983, 4044.0496483326397, 4051.9392209116886, 4074.6943979201383, 4075.286824805647, 2987.925301867471, 3494.5672274367644, 3505.685367987005, 3539.80531070791, 3567.6432356764376, 4849.078675051765, 4962.6774259673, 5192.480751924815, 5193.896122077537, 5205.973970130125, 4355.344968911825, 4663.347131401607, 4679.368285281512, 4707.223308154151, 4713.740744259065, 5334.199870019489, 5544.805931792368, 5579.804706835242, 5600.327960644708, 5663.433656634304, 3288.4245257080156, 3318.4026875162463, 3786.0, 3900.7854567998747, 3920.666743326821, 5016.795968967458, 5377.220303056035, 5410.594205434569, 5671.971640141773, 5854.18041474194, 3484.52958850557, 3868.8200098969523, 3939.7589759225752, 4007.6793856491413, 4018.738781979162, 3408.5909690837257, 3592.8203589820405, 3690.0036990012545, 3696.8336424860945, 4052.2908491014546, 3466.445368740989, 3765.849366025383, 4232.492100947844, 4414.80133393998, 4660.951285960632, 4729.4797572267025, 5573.7770489179975, 5620.57845661577, 5640.464155905182, 5643.604947653707, 1084.8860869608736, 1314.9408276627576, 1318.5451019398292, 1325.2578556008666, 1331.1746717035307, 779.1624004195512, 782.8473447677649, 843.6372359885308, 857.8370109679266, 863.6329559937002, 3899.727019108692, 4375.7966559196475, 4377.0, 4417.889552761207, 4420.226460369422, 4356.884827348461, 4564.157877916273, 4709.929351059737, 4783.928241076386, 4847.200211965057, 4293.659955324356, 4352.564743525685, 4381.430414046154, 4391.111821916543, 4450.688451808407, 2151.817095546865, 2330.6620540021604, 2497.937551561189, 2502.912398066059, 2507.761762632547, 4378.255696531533, 4582.88542786433, 4677.22825733757, 4680.906381872412, 4911.551092427742, 4839.128956787742, 4862.763128960647, 4873.19592267279, 4881.412162060882, 4924.532169443897, 4504.932426013613, 4587.472440669366, 4856.247281671346, 4892.657513974059, 4943.3573635427165, 4043.0903046815406, 4122.525909520444, 4291.4765258332845, 4580.610648094949, 4693.357324936245, 4830.855074347775, 5258.684478931276, 5473.397926228191, 5785.016547186904, 5830.82507524775, 5290.883646541414, 5413.648112872651, 5980.491658208927, 6036.517078633611, 6060.0, 3686.79722615248, 3930.665893399093, 3957.9604203957592, 3958.4260282258333, 3960.32677942382, 5102.76470529467, 5483.643563168382, 5745.942540574708, 5752.165935939349, 5766.65533990293, 5601.523870470893, 5639.8590035249445, 5645.604807663424, 5676.829695109153, 5700.235385837783, 4125.233141500621, 5438.0, 5529.474699903502, 5577.888442231051, 5607.719614019365, 4358.738475691469, 4533.0, 4603.608693261111, 4678.947236871677, 5460.914583260445, 5712.742926568231, 5724.627899186539, 5735.139729040678, 5736.397678243891, 5743.655380677173, 4635.768211589339, 5276.419593844597, 5556.277683901067, 5559.444055594408, 5604.0], "value": 3894.6599929124304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.4817264792434, 698.807827847342, 777.6150805351356, 792.1405275276325, 822.893023906892, 12424.875751242485, 16140.596485087879, 16210.83789162108, 16256.268467918942, 16309.0, 14451.78322325166, 14641.780373294408, 14667.779983300232, 14669.899757518175, 14675.0, 672.2370109925246, 692.9341712537326, 835.2399316621876, 859.2224037246302, 869.5956380283167, 848.520585868982, 850.3494826457764, 851.1871163039283, 851.5742128935532, 852.1521086518923, 902.8645703144548, 903.7379160043612, 903.8553831386979, 906.2795077913042, 906.5376657904483, 715.6350261366688, 740.2227660955974, 745.9104907411091, 746.7349091072699, 902.4720538484994, 550.6998685716294, 653.0824192010233, 666.3070406776947, 674.8515326628134, 677.7831094049906, 15033.624159395993, 15060.698786024328, 15071.321790519452, 15096.0, 15105.244737763178, 13866.098703584235, 14111.223882686449, 14156.221407822566, 14220.288985550682, 14380.424783008668, 12449.75100497985, 12849.229046257162, 12908.419121139572, 13122.0, 13483.932580337036, 4380.036391993756, 4424.358468022118, 4504.79728412219, 4523.70595911268, 4619.676622636417, 118364.81635183624, 121471.0, 121665.0, 121785.0, 121982.0, 8841.823163536694, 8916.821663566692, 9011.729648110437, 9251.213646839959, 9402.90597094034, 20750.06624701892, 20770.48073798167, 20826.0, 20992.580148396948, 21087.0, 7857.607119644109, 7886.960565197252, 7934.484258523177, 8070.636821343053, 8158.877616835753, 3755.530558680165, 4274.812184601388, 4448.488423831236, 4481.991551900862, 4500.729956202638, 3466.930661386758, 3576.660217279354, 3584.8386822592524, 3588.659077387644, 3602.495650608917, 600.2227115884939, 635.4027214418431, 654.7511945460694, 655.6819942327967, 680.6086500262369, 537.5887446103734, 560.8205374280273, 630.8959021761358, 631.2267472346431, 642.1844257792577, 7434.516756410816, 9249.260059195383, 9265.25877929764, 9355.95322023399, 9443.527823608792, 505.70669011972967, 577.4514211499009, 621.6860485454816, 632.0582332324894, 636.3613694736073, 4110.917781644351, 4551.95448045522, 4560.293154561048, 4582.023073794513, 4593.333966574828, 82171.58914205391, 113115.43442282735, 149664.2516787409, 172658.0, 176568.0, 124220.37889810493, 132442.0, 133156.0, 135779.0, 137045.0, 104369.47815261027, 108931.0, 115141.0, 122779.38610306891, 123971.0, 7703.632724968006, 8988.86516702263, 9037.593308301011, 9111.726648200565, 9203.76990575241, 61382.69308653428, 62118.0, 62981.370186299384, 64379.67810160919, 66846.0, 80761.59619201867, 94838.52580737052, 99743.0, 100062.0, 101221.0, 13765.724685506435, 13915.373808178858, 14243.287835607971, 14344.139351638934, 14872.851271487147, 15127.470538531099, 15222.16278104715, 15411.383544658089, 15509.99185052968, 16525.0, 10626.8405973912, 12389.62831115068, 13908.582742517741, 14415.0, 14425.639359016108, 13962.371693273624, 14075.366608502847, 14089.15465072099, 14197.503087391891, 14260.429582816987, 13658.453661853415, 13766.036377453482, 13903.374348154559, 14231.146131232159, 14730.484433045222, 10552.525136368728, 10817.18871084656, 11377.146713996648, 11769.117316201147, 11914.52341906314, 10926.836097458703, 11770.470328835394, 11856.129645772371, 11932.224405413968, 12052.337121458404], "value": 7820.645696442747, "unit": "score"}], "name": "dromaeo_css", "value": 7345.148786164529, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 114.0, 112.0, 114.0, 113.0, 115.0, 164.0, 165.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 108.0, 111.0, 141.0, 109.0, 136.0, 137.0, 134.0, 140.0, 108.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 184.0, 186.0, 186.0, 184.0, 184.0, 178.0, 185.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 63.0, 58.0, 88.0, 60.0, 59.0, 57.0, 58.0, 83.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 93.0, 67.0, 67.0, 69.0, 91.0, 66.0, 71.0, 99.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 86.0, 85.0, 86.0, 83.0, 88.0, 84.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 138.0, 130.0, 138.0, 84.0, 86.0, 86.0, 85.0, 93.0], "value": 99.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 73.0, 67.0, 73.0, 77.0, 72.0, 69.0, 70.0, 70.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 81.0, 81.0, 82.0, 80.0, 82.0, 81.0, 86.0, 84.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 148.0, 126.0, 144.0, 147.0, 157.0, 134.0, 142.0, 167.0, 127.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 167.0, 164.0, 162.0, 160.0, 162.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 81.0, 82.0, 83.0, 82.0, 82.0, 57.0, 76.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1448.3, "alertThreshold": 2.0}]} 03:32:07 INFO - Return code: 0 03:32:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:32:07 INFO - # TBPL SUCCESS # 03:32:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:32:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:32:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:32:07 INFO - 2016-10-12 03:32:07.302 screenresolution[2289:26250] starting screenresolution argv=screenresolution get 03:32:07 INFO - 2016-10-12 03:32:07.304 screenresolution[2289:26250] Display 0: 1600x1200x32@60 03:32:07 INFO - 2016-10-12 03:32:07.310 screenresolution[2290:26253] starting screenresolution argv=screenresolution list 03:32:07 INFO - Available Modes on Display 0 03:32:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:32:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:32:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:32:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:32:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:32:07 INFO - Intel Iris: 03:32:07 INFO - Chipset Model: Intel Iris 03:32:07 INFO - Type: GPU 03:32:07 INFO - Bus: Built-In 03:32:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:32:07 INFO - Vendor: Intel (0x8086) 03:32:07 INFO - Device ID: 0x0a2e 03:32:07 INFO - Revision ID: 0x0009 03:32:07 INFO - Displays: 03:32:07 INFO - Display: 03:32:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:32:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:32:07 INFO - Display Serial Number: 1600x1200 60 03:32:07 INFO - Main Display: Yes 03:32:07 INFO - Mirror: Off 03:32:07 INFO - Online: Yes 03:32:07 INFO - Rotation: Supported 03:32:07 INFO - Return code: 0 03:32:07 INFO - Running post-action listener: _resource_record_post_action 03:32:07 INFO - [mozharness: 2016-10-12 10:32:07.546258Z] Finished run-tests step (success) 03:32:07 INFO - Running post-run listener: _resource_record_post_run 03:32:07 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 118784; Write bytes: 663070208; Read time: 1; Write time: 1955 03:32:07 INFO - TinderboxPrint: CPU usage
53.6% 03:32:07 INFO - TinderboxPrint: I/O read bytes / time
118,784 / 1 03:32:07 INFO - TinderboxPrint: I/O write bytes / time
663,070,208 / 1,955 03:32:07 INFO - TinderboxPrint: CPU idle
2,244.5 (46.4%) 03:32:07 INFO - TinderboxPrint: CPU system
964.6 (20.0%) 03:32:07 INFO - TinderboxPrint: CPU user
1,624.8 (33.6%) 03:32:07 INFO - TinderboxPrint: Swap in / out
362,573,824 / 0 03:32:07 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 363981312; Write bytes: 365665280; Read time: 27456; Write time: 701 03:32:07 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 0; Write bytes: 296151552; Read time: 0; Write time: 1249 03:32:08 INFO - Running post-run listener: _upload_blobber_files 03:32:08 INFO - Blob upload gear active. 03:32:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:08 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 03:32:08 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'] 03:32:08 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 03:32:08 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:32:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:09 INFO - (blobuploader) - INFO - Done attempting. 03:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:10 INFO - (blobuploader) - INFO - Done attempting. 03:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:32:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:12 INFO - (blobuploader) - INFO - Done attempting. 03:32:12 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:12 INFO - Return code: 0 03:32:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b243b1e41759c19bfdf5e1a622abf0cf46261fd0c24d3ac27fbef2ecb1be3a78a787b82ccaa02cf5cdc8aaea09e578ab5a98460813550858eb08c9219808ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f871e1e9e51cd48a86e7969a545ef285e3b340460a22049515d1c991da7529296fdafa362029fe862c8799d0acdd5e6ccdffa48365f24bb7bc3d7b17ee3c923", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d51960a1252abdd93940efb200c4a5511475e2ac9afec9eac53e38fca67dc12c42846b3e698015c7669fbf78cec6180d70349eef1b1e95ae27cd412660e72d"} 03:32:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:12 INFO - Contents: 03:32:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b243b1e41759c19bfdf5e1a622abf0cf46261fd0c24d3ac27fbef2ecb1be3a78a787b82ccaa02cf5cdc8aaea09e578ab5a98460813550858eb08c9219808ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f871e1e9e51cd48a86e7969a545ef285e3b340460a22049515d1c991da7529296fdafa362029fe862c8799d0acdd5e6ccdffa48365f24bb7bc3d7b17ee3c923", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d51960a1252abdd93940efb200c4a5511475e2ac9afec9eac53e38fca67dc12c42846b3e698015c7669fbf78cec6180d70349eef1b1e95ae27cd412660e72d"} 03:32:12 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:12 INFO - Copying logs to upload dir... 03:32:12 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.822189 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-12 03:32:12.232752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:12.236631) ========= 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.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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/b243b1e41759c19bfdf5e1a622abf0cf46261fd0c24d3ac27fbef2ecb1be3a78a787b82ccaa02cf5cdc8aaea09e578ab5a98460813550858eb08c9219808ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f871e1e9e51cd48a86e7969a545ef285e3b340460a22049515d1c991da7529296fdafa362029fe862c8799d0acdd5e6ccdffa48365f24bb7bc3d7b17ee3c923", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d51960a1252abdd93940efb200c4a5511475e2ac9afec9eac53e38fca67dc12c42846b3e698015c7669fbf78cec6180d70349eef1b1e95ae27cd412660e72d"} build_url:https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/LB7jB1B7T0m4karfI9-0WQ/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/b243b1e41759c19bfdf5e1a622abf0cf46261fd0c24d3ac27fbef2ecb1be3a78a787b82ccaa02cf5cdc8aaea09e578ab5a98460813550858eb08c9219808ceb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f871e1e9e51cd48a86e7969a545ef285e3b340460a22049515d1c991da7529296fdafa362029fe862c8799d0acdd5e6ccdffa48365f24bb7bc3d7b17ee3c923", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81d51960a1252abdd93940efb200c4a5511475e2ac9afec9eac53e38fca67dc12c42846b3e698015c7669fbf78cec6180d70349eef1b1e95ae27cd412660e72d"}' ========= master_lag: 0.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:12.380577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:12.380906) ========= 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.QsxswNGFZ0/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.AIo4LezOYL/Listeners TMPDIR=/var/folders/kr/nz0rmqgx4cz8g886_dmw_z7m00000w/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.005456 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 03:32:12.407681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 03:32:12.408073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 03:32:12.408498) ========= ========= Total master_lag: 0.27 =========