builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1482428691.16 results: success (0) buildid: 20161222071552 builduid: 92dcb4cf6fcc4556b3d542ee40d91d55 revision: 3db270bec24587719cbbfb3a15f40609d9b8f330 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.163485) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.164053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.164394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.195287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.195991) ========= 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.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-12-22 09:44:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2016-12-22 09:44:51 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.212570 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.438715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.439460) ========= 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.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.026827 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:51.489299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:44:51.489689) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3db270bec24587719cbbfb3a15f40609d9b8f330 --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-beta --rev 3db270bec24587719cbbfb3a15f40609d9b8f330 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-12-22 09:44:51,587 truncating revision to first 12 chars 2016-12-22 09:44:51,587 Setting DEBUG logging. 2016-12-22 09:44:51,587 attempt 1/10 2016-12-22 09:44:51,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3db270bec245?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 09:44:53,153 unpacking tar archive at: mozilla-beta-3db270bec245/testing/mozharness/ program finished with exit code 0 elapsedTime=1.841603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 09:44:53.355418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:53.355803) ========= script_repo_revision: 3db270bec24587719cbbfb3a15f40609d9b8f330 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:53.356297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:53.356622) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 09:44:53.377548) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-22 09:44:53.378361) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:44:53 INFO - MultiFileLogger online at 20161222 09:44:53 in /builds/slave/test 09:44:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:44:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:53 INFO - {'append_to_log': False, 09:44:53 INFO - 'base_work_dir': '/builds/slave/test', 09:44:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:44:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:53 INFO - 'branch': 'Mozilla-Beta', 09:44:53 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:53 INFO - 'config_files': ('talos/mac_config.py',), 09:44:53 INFO - 'default_actions': ('clobber', 09:44:53 INFO - 'read-buildbot-config', 09:44:53 INFO - 'download-and-extract', 09:44:53 INFO - 'populate-webroot', 09:44:53 INFO - 'create-virtualenv', 09:44:53 INFO - 'install', 09:44:53 INFO - 'run-tests'), 09:44:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:53 INFO - 'download_minidump_stackwalk': True, 09:44:53 INFO - 'download_symbols': 'ondemand', 09:44:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:53 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:53 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:53 INFO - 'installer_path': 'installer.exe', 09:44:53 INFO - 'log_level': 'info', 09:44:53 INFO - 'log_name': 'talos', 09:44:53 INFO - 'log_to_console': True, 09:44:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:44:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:44:53 INFO - 'opt_config_files': (), 09:44:53 INFO - 'pip_index': False, 09:44:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:53 INFO - 'cmd': ('bash', 09:44:53 INFO - '-c', 09:44:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:53 INFO - 'enabled': True, 09:44:53 INFO - 'halt_on_failure': False, 09:44:53 INFO - 'name': 'check_screen_resolution'},), 09:44:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:44:53 INFO - 'cmd': ('bash', 09:44:53 INFO - '-c', 09:44:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:44:53 INFO - 'enabled': True, 09:44:53 INFO - 'halt_on_failure': False, 09:44:53 INFO - 'name': 'check_screen_resolution'},), 09:44:53 INFO - 'run_cmd_checks_enabled': True, 09:44:53 INFO - 'sps_profile': False, 09:44:53 INFO - 'sps_profile_interval': 0, 09:44:53 INFO - 'suite': 'dromaeojs', 09:44:53 INFO - 'system_bits': '32', 09:44:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:53 INFO - 'title': 't-yosemite-r7-0274', 09:44:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:53 INFO - 'use_talos_json': True, 09:44:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:53 INFO - 'work_dir': 'build'} 09:44:53 INFO - [mozharness: 2016-12-22 17:44:53.579555Z] Running clobber step. 09:44:53 INFO - Running pre-action listener: _resource_record_pre_action 09:44:53 INFO - Running main action method: clobber 09:44:53 INFO - rmtree: /builds/slave/test/build 09:44:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:55 INFO - Running post-action listener: _resource_record_post_action 09:44:55 INFO - [mozharness: 2016-12-22 17:44:55.775128Z] Finished clobber step (success) 09:44:55 INFO - [mozharness: 2016-12-22 17:44:55.775268Z] Running read-buildbot-config step. 09:44:55 INFO - Running pre-action listener: _resource_record_pre_action 09:44:55 INFO - Running main action method: read_buildbot_config 09:44:55 INFO - Using buildbot properties: 09:44:55 INFO - { 09:44:55 INFO - "project": "", 09:44:55 INFO - "product": "firefox", 09:44:55 INFO - "script_repo_revision": "production", 09:44:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:44:55 INFO - "repository": "", 09:44:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:44:55 INFO - "buildid": "20161222071552", 09:44:55 INFO - "pgo_build": "False", 09:44:55 INFO - "basedir": "/builds/slave/test", 09:44:55 INFO - "buildnumber": 101, 09:44:55 INFO - "slavename": "t-yosemite-r7-0274", 09:44:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 09:44:55 INFO - "platform": "yosemite_r7", 09:44:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:44:55 INFO - "branch": "mozilla-beta", 09:44:55 INFO - "repo_path": "releases/mozilla-beta", 09:44:55 INFO - "revision": "3db270bec24587719cbbfb3a15f40609d9b8f330", 09:44:55 INFO - "stage_platform": "macosx64", 09:44:55 INFO - "builduid": "92dcb4cf6fcc4556b3d542ee40d91d55", 09:44:55 INFO - "slavebuilddir": "test" 09:44:55 INFO - } 09:44:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 09:44:55 INFO - Running post-action listener: _resource_record_post_action 09:44:55 INFO - [mozharness: 2016-12-22 17:44:55.778415Z] Finished read-buildbot-config step (success) 09:44:55 INFO - [mozharness: 2016-12-22 17:44:55.778524Z] Running download-and-extract step. 09:44:55 INFO - Running pre-action listener: _resource_record_pre_action 09:44:55 INFO - Running main action method: download_and_extract 09:44:55 INFO - mkdir: /builds/slave/test/build/tests 09:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:44:55 INFO - trying https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 09:44:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:44:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 09:44:56 INFO - Downloaded 1165 bytes. 09:44:56 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 09:44:56 INFO - Using the following test package requirements: 09:44:56 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:44:56 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 09:44:56 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 09:44:56 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:44:56 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 09:44:56 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 09:44:56 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 09:44:56 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 09:44:56 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 09:44:56 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 09:44:56 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 09:44:56 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 09:44:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:44:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:44:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:44:57 INFO - Expected file size: 16232880 09:45:04 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 09:45:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 09:45:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 09:45:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 09:45:04 INFO - Expected file size: 16232880 09:45:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 09:45:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 09:45:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 09:45:12 INFO - Expected file size: 14414089 09:45:12 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')]} 09:45:12 INFO - trying https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:45:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 09:45:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 09:45:15 INFO - Downloaded 86034068 bytes. 09:45:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:45:15 INFO - mkdir: /builds/slave/test/properties 09:45:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:15 INFO - Contents: 09:45:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 09:45:16 INFO - Running post-action listener: _resource_record_post_action 09:45:16 INFO - Running post-action listener: set_extra_try_arguments 09:45:16 INFO - [mozharness: 2016-12-22 17:45:16.170399Z] Finished download-and-extract step (success) 09:45:16 INFO - [mozharness: 2016-12-22 17:45:16.170581Z] Running populate-webroot step. 09:45:16 INFO - Running pre-action listener: _resource_record_pre_action 09:45:16 INFO - Running main action method: populate_webroot 09:45:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:16 INFO - '--tppagecycles', 09:45:16 INFO - '7'], 09:45:16 INFO - 'tests': ['tsvgm']}}, 09:45:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['damp', 'tps']}, 09:45:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'tests': ['damp', 'tps']}, 09:45:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['dromaeo_dom']}, 09:45:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['basic_compositor_video']}, 09:45:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['a11yr', 09:45:16 INFO - 'ts_paint', 09:45:16 INFO - 'tpaint', 09:45:16 INFO - 'sessionrestore', 09:45:16 INFO - 'sessionrestore_no_auto_restore', 09:45:16 INFO - 'tabpaint']}, 09:45:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['tsvgx', 09:45:16 INFO - 'tsvgr_opacity', 09:45:16 INFO - 'tart', 09:45:16 INFO - 'tscrollx', 09:45:16 INFO - 'cart']}, 09:45:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:16 INFO - 'tsvgr_opacity', 09:45:16 INFO - 'tart', 09:45:16 INFO - 'tscrollx', 09:45:16 INFO - 'cart']}, 09:45:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'talos_options': ['--disable-e10s'], 09:45:16 INFO - 'tests': ['tp5o']}, 09:45:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'tests': ['tp5o']}, 09:45:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'talos_options': ['--disable-e10s', 09:45:16 INFO - '--xperf_path', 09:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:16 INFO - 'tests': ['tp5n']}, 09:45:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:16 INFO - 'talos_options': ['--xperf_path', 09:45:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:16 INFO - 'tests': ['tp5n']}}, 09:45:16 INFO - 'talos.zip': {'path': '', 09:45:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:16 INFO - Running post-action listener: _resource_record_post_action 09:45:16 INFO - [mozharness: 2016-12-22 17:45:16.192834Z] Finished populate-webroot step (success) 09:45:16 INFO - [mozharness: 2016-12-22 17:45:16.192968Z] Running create-virtualenv step. 09:45:16 INFO - Running pre-action listener: _resource_record_pre_action 09:45:16 INFO - Running main action method: create_virtualenv 09:45:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:16 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 09:45:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:16 INFO - Using real prefix '/tools/python27' 09:45:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:19 INFO - Installing pip.................done. 09:45:19 INFO - Return code: 0 09:45:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:19 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 09:45:19 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 09:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:19 INFO - 'HOME': '/Users/cltbld', 09:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:19 INFO - 'LOGNAME': 'cltbld', 09:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:19 INFO - 'MOZ_NO_REMOTE': '1', 09:45:19 INFO - 'NO_EM_RESTART': '1', 09:45:19 INFO - 'PAGER': '/bin/cat', 09:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:19 INFO - 'PWD': '/builds/slave/test', 09:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:19 INFO - 'SHELL': '/bin/bash', 09:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:19 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:19 INFO - 'USER': 'cltbld', 09:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:19 INFO - 'XPC_FLAGS': '0x0', 09:45:19 INFO - 'XPC_SERVICE_NAME': '0', 09:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:20 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 09:45:20 INFO - Cleaning up... 09:45:20 INFO - Return code: 0 09:45:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:45:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:20 INFO - 'HOME': '/Users/cltbld', 09:45:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:20 INFO - 'LOGNAME': 'cltbld', 09:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:20 INFO - 'MOZ_NO_REMOTE': '1', 09:45:20 INFO - 'NO_EM_RESTART': '1', 09:45:20 INFO - 'PAGER': '/bin/cat', 09:45:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:20 INFO - 'PWD': '/builds/slave/test', 09:45:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:20 INFO - 'SHELL': '/bin/bash', 09:45:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:20 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:20 INFO - 'USER': 'cltbld', 09:45:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:20 INFO - 'XPC_FLAGS': '0x0', 09:45:20 INFO - 'XPC_SERVICE_NAME': '0', 09:45:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:20 INFO - Downloading/unpacking psutil>=3.1.1 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:20 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 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:23 INFO - Installing collected packages: psutil 09:45:23 INFO - Running setup.py install for psutil 09:45:23 INFO - building 'psutil._psutil_osx' extension 09:45:23 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 09:45:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:45:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:45:24 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 09:45:24 INFO - building 'psutil._psutil_posix' extension 09:45:24 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 09:45:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:45:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:45:24 INFO - ^ 09:45:24 INFO - 1 warning generated. 09:45:24 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 09:45:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:24 INFO - Successfully installed psutil 09:45:24 INFO - Cleaning up... 09:45:24 INFO - Return code: 0 09:45:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:24 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:24 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 09:45:24 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 09:45:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:24 INFO - 'HOME': '/Users/cltbld', 09:45:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:24 INFO - 'LOGNAME': 'cltbld', 09:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:24 INFO - 'MOZ_NO_REMOTE': '1', 09:45:24 INFO - 'NO_EM_RESTART': '1', 09:45:24 INFO - 'PAGER': '/bin/cat', 09:45:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:24 INFO - 'PWD': '/builds/slave/test', 09:45:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:24 INFO - 'SHELL': '/bin/bash', 09:45:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:24 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:24 INFO - 'USER': 'cltbld', 09:45:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:24 INFO - 'XPC_FLAGS': '0x0', 09:45:24 INFO - 'XPC_SERVICE_NAME': '0', 09:45:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:24 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 09:45:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:45:27 INFO - Installing collected packages: mozsystemmonitor 09:45:27 INFO - Running setup.py install for mozsystemmonitor 09:45:27 INFO - Successfully installed mozsystemmonitor 09:45:27 INFO - Cleaning up... 09:45:27 INFO - Return code: 0 09:45:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:27 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:27 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 09:45:27 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 09:45:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:27 INFO - 'HOME': '/Users/cltbld', 09:45:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:27 INFO - 'LOGNAME': 'cltbld', 09:45:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:27 INFO - 'MOZ_NO_REMOTE': '1', 09:45:27 INFO - 'NO_EM_RESTART': '1', 09:45:27 INFO - 'PAGER': '/bin/cat', 09:45:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:27 INFO - 'PWD': '/builds/slave/test', 09:45:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:27 INFO - 'SHELL': '/bin/bash', 09:45:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:27 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:27 INFO - 'USER': 'cltbld', 09:45:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:27 INFO - 'XPC_FLAGS': '0x0', 09:45:27 INFO - 'XPC_SERVICE_NAME': '0', 09:45:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:31 INFO - warning: no files found matching '*.txt' 09:45:31 INFO - no previously-included directories found matching 'build' 09:45:31 INFO - no previously-included directories found matching 'dist' 09:45:31 INFO - no previously-included directories found matching '.git*' 09:45:31 INFO - Installing collected packages: jsonschema, functools32 09:45:31 INFO - Running setup.py install for functools32 09:45:31 INFO - warning: no files found matching '*.txt' 09:45:31 INFO - no previously-included directories found matching 'build' 09:45:31 INFO - no previously-included directories found matching 'dist' 09:45:31 INFO - no previously-included directories found matching '.git*' 09:45:31 INFO - Successfully installed jsonschema functools32 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:31 INFO - 'HOME': '/Users/cltbld', 09:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PAGER': '/bin/cat', 09:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:31 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - 'XPC_FLAGS': '0x0', 09:45:31 INFO - 'XPC_SERVICE_NAME': '0', 09:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:45:31 INFO - Cleaning up... 09:45:31 INFO - Return code: 0 09:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:31 INFO - 'HOME': '/Users/cltbld', 09:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:31 INFO - 'LOGNAME': 'cltbld', 09:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:31 INFO - 'MOZ_NO_REMOTE': '1', 09:45:31 INFO - 'NO_EM_RESTART': '1', 09:45:31 INFO - 'PAGER': '/bin/cat', 09:45:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:31 INFO - 'PWD': '/builds/slave/test', 09:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:31 INFO - 'SHELL': '/bin/bash', 09:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:31 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:31 INFO - 'USER': 'cltbld', 09:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:31 INFO - 'XPC_FLAGS': '0x0', 09:45:31 INFO - 'XPC_SERVICE_NAME': '0', 09:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:34 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 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 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 09:45:35 INFO - Downloading docopt-0.6.1.tar.gz 09:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:36 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:36 INFO - Running setup.py install for blobuploader 09:45:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:36 INFO - Running setup.py install for requests 09:45:36 INFO - Running setup.py install for docopt 09:45:36 INFO - Successfully installed blobuploader requests docopt 09:45:36 INFO - Cleaning up... 09:45:36 INFO - Return code: 0 09:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45: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')]} 09:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45: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')]} 09:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:36 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:36 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 09:45:36 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 09:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:36 INFO - 'HOME': '/Users/cltbld', 09:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:36 INFO - 'LOGNAME': 'cltbld', 09:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:36 INFO - 'MOZ_NO_REMOTE': '1', 09:45:36 INFO - 'NO_EM_RESTART': '1', 09:45:36 INFO - 'PAGER': '/bin/cat', 09:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:36 INFO - 'PWD': '/builds/slave/test', 09:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:36 INFO - 'SHELL': '/bin/bash', 09:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:36 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:36 INFO - 'USER': 'cltbld', 09:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:36 INFO - 'XPC_FLAGS': '0x0', 09:45:36 INFO - 'XPC_SERVICE_NAME': '0', 09:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-yMX6_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WnyJ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-6e9gtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-B5X9_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-idV8oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-nQD5B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-pvKHN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:37 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-vpHNUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-HgIDu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WwiFRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1bh1BN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-shBDgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-OsEA4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fEcQRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ywjJGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-XzFBXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:38 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MQgBuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:39 INFO - Running setup.py install for manifestparser 09:45:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozcrash 09:45:39 INFO - Running setup.py install for mozdebug 09:45:39 INFO - Running setup.py install for mozdevice 09:45:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozfile 09:45:39 INFO - Running setup.py install for mozhttpd 09:45:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:39 INFO - Running setup.py install for mozinfo 09:45:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozInstall 09:45:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozleak 09:45:40 INFO - Running setup.py install for mozlog 09:45:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for moznetwork 09:45:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozprocess 09:45:40 INFO - Running setup.py install for mozprofile 09:45:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:40 INFO - Running setup.py install for mozrunner 09:45:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:41 INFO - Running setup.py install for mozscreenshot 09:45:41 INFO - Running setup.py install for moztest 09:45:41 INFO - Running setup.py install for mozversion 09:45:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:41 INFO - Cleaning up... 09:45:41 INFO - Return code: 0 09:45:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:41 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:41 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 09:45:41 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 09:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:41 INFO - 'HOME': '/Users/cltbld', 09:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:41 INFO - 'LOGNAME': 'cltbld', 09:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:41 INFO - 'MOZ_NO_REMOTE': '1', 09:45:41 INFO - 'NO_EM_RESTART': '1', 09:45:41 INFO - 'PAGER': '/bin/cat', 09:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:41 INFO - 'PWD': '/builds/slave/test', 09:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:41 INFO - 'SHELL': '/bin/bash', 09:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:41 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:41 INFO - 'USER': 'cltbld', 09:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:41 INFO - 'XPC_FLAGS': '0x0', 09:45:41 INFO - 'XPC_SERVICE_NAME': '0', 09:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MWrszy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:41 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)) 09:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:41 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-y6wepA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-esOcl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-WxSZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ABv_WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-POUUJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-4ZY8lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-LLL0oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-4QqkCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-SBs0Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:42 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)) 09:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:42 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ZP1cKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9PgmgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-nU1bgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-PVWrgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-zCeXp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-M3CKRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:43 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)) 09:45:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:43 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-uHTNHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:43 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)) 09:45:43 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)) 09:45:43 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)) 09:45:43 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)) 09:45:43 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)) 09:45:43 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)) 09:45:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:46 INFO - Downloading blessings-1.6.tar.gz 09:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:46 INFO - Installing collected packages: blessings 09:45:46 INFO - Running setup.py install for blessings 09:45:46 INFO - Successfully installed blessings 09:45:46 INFO - Cleaning up... 09:45:46 INFO - Return code: 0 09:45:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:46 INFO - Reading from file tmpfile_stdout 09:45:46 INFO - Current package versions: 09:45:46 INFO - blessings == 1.6 09:45:46 INFO - blobuploader == 1.2.4 09:45:46 INFO - docopt == 0.6.1 09:45:46 INFO - functools32 == 3.2.3-2 09:45:46 INFO - jsonschema == 2.5.1 09:45:46 INFO - manifestparser == 1.1 09:45:46 INFO - mozInstall == 1.12 09:45:46 INFO - mozcrash == 0.17 09:45:46 INFO - mozdebug == 0.1 09:45:46 INFO - mozdevice == 0.48 09:45:46 INFO - mozfile == 1.2 09:45:46 INFO - mozhttpd == 0.7 09:45:46 INFO - mozinfo == 0.9 09:45:46 INFO - mozleak == 0.1 09:45:46 INFO - mozlog == 3.4 09:45:46 INFO - moznetwork == 0.27 09:45:46 INFO - mozprocess == 0.23 09:45:46 INFO - mozprofile == 0.28 09:45:46 INFO - mozrunner == 6.12 09:45:46 INFO - mozscreenshot == 0.1 09:45:46 INFO - mozsystemmonitor == 0.3 09:45:46 INFO - moztest == 0.7 09:45:46 INFO - mozversion == 1.4 09:45:46 INFO - psutil == 3.1.1 09:45:47 INFO - requests == 1.2.3 09:45:47 INFO - wsgiref == 0.1.2 09:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:47 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')]} 09:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 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')]} 09:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:47 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 09:45:47 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 09:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:47 INFO - 'HOME': '/Users/cltbld', 09:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:47 INFO - 'LOGNAME': 'cltbld', 09:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:47 INFO - 'MOZ_NO_REMOTE': '1', 09:45:47 INFO - 'NO_EM_RESTART': '1', 09:45:47 INFO - 'PAGER': '/bin/cat', 09:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:47 INFO - 'PWD': '/builds/slave/test', 09:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:47 INFO - 'SHELL': '/bin/bash', 09:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:47 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:47 INFO - 'USER': 'cltbld', 09:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:47 INFO - 'XPC_FLAGS': '0x0', 09:45:47 INFO - 'XPC_SERVICE_NAME': '0', 09:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 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)) 09:45:47 INFO - Cleaning up... 09:45:47 INFO - Return code: 0 09:45:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:47 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')]} 09:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 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')]} 09:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:47 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 0x100fc3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f39570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc583458cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, '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.juB8h18Gfu/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.Vvjjd29TAU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 09:45:47 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 09:45:47 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 09:45:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:45:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:45:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:45:47 INFO - 'HOME': '/Users/cltbld', 09:45:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:45:47 INFO - 'LOGNAME': 'cltbld', 09:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:47 INFO - 'MOZ_NO_REMOTE': '1', 09:45:47 INFO - 'NO_EM_RESTART': '1', 09:45:47 INFO - 'PAGER': '/bin/cat', 09:45:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:47 INFO - 'PWD': '/builds/slave/test', 09:45:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:45:47 INFO - 'SHELL': '/bin/bash', 09:45:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:45:47 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:45:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:45:47 INFO - 'USER': 'cltbld', 09:45:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:45:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:47 INFO - 'XPC_FLAGS': '0x0', 09:45:47 INFO - 'XPC_SERVICE_NAME': '0', 09:45:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:45:47 INFO - Cleaning up... 09:45:47 INFO - Return code: 0 09:45:47 INFO - Running post-action listener: _resource_record_post_action 09:45:47 INFO - Running post-action listener: _start_resource_monitoring 09:45:47 INFO - Starting resource monitoring. 09:45:47 INFO - [mozharness: 2016-12-22 17:45:47.905618Z] Finished create-virtualenv step (success) 09:45:47 INFO - [mozharness: 2016-12-22 17:45:47.906634Z] Running install step. 09:45:47 INFO - Running pre-action listener: _resource_record_pre_action 09:45:47 INFO - Running main action method: install 09:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:48 INFO - Reading from file tmpfile_stdout 09:45:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:48 INFO - Reading from file tmpfile_stdout 09:45:48 INFO - Output received: 09:45:48 INFO - Usage: mozinstall [options] installer 09:45:48 INFO - Options: 09:45:48 INFO - -h, --help show this help message and exit 09:45:48 INFO - -d DEST, --destination=DEST 09:45:48 INFO - Directory to install application into. [default: 09:45:48 INFO - "/builds/slave/test"] 09:45:48 INFO - --app=APP Application being installed. [default: firefox] 09:45:48 INFO - mkdir: /builds/slave/test/build/application 09:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 09:46:10 INFO - Reading from file tmpfile_stdout 09:46:10 INFO - Output received: 09:46:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:46:10 INFO - Running post-action listener: _resource_record_post_action 09:46:10 INFO - [mozharness: 2016-12-22 17:46:10.463007Z] Finished install step (success) 09:46:10 INFO - [mozharness: 2016-12-22 17:46:10.463153Z] Running run-tests step. 09:46:10 INFO - Running pre-action listener: _resource_record_pre_action 09:46:10 INFO - Running main action method: run_tests 09:46:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:10 INFO - 2016-12-22 09:46:10.477 screenresolution[1627:7236] starting screenresolution argv=screenresolution get 09:46:10 INFO - 2016-12-22 09:46:10.480 screenresolution[1627:7236] Display 0: 1600x1200x32@60 09:46:10 INFO - 2016-12-22 09:46:10.486 screenresolution[1628:7238] starting screenresolution argv=screenresolution list 09:46:10 INFO - Available Modes on Display 0 09:46:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:10 INFO - Intel Iris: 09:46:10 INFO - Chipset Model: Intel Iris 09:46:10 INFO - Type: GPU 09:46:10 INFO - Bus: Built-In 09:46:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:10 INFO - Vendor: Intel (0x8086) 09:46:10 INFO - Device ID: 0x0a2e 09:46:10 INFO - Revision ID: 0x0009 09:46:10 INFO - Displays: 09:46:10 INFO - Display: 09:46:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:10 INFO - Display Serial Number: 1600x1200 60 09:46:10 INFO - Main Display: Yes 09:46:10 INFO - Mirror: Off 09:46:10 INFO - Online: Yes 09:46:10 INFO - Rotation: Supported 09:46:10 INFO - Return code: 0 09:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:10 INFO - Python 2.7.3 09:46:10 INFO - Return code: 0 09:46:10 INFO - grabbing minidump binary from tooltool 09:46:10 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')]} 09:46:10 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 0x100dd7d30>, '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 0x100c3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dcfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:10 INFO - Return code: 0 09:46:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 09:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 09:46:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.juB8h18Gfu/Render', 09:46:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:10 INFO - 'HOME': '/Users/cltbld', 09:46:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:10 INFO - 'LOGNAME': 'cltbld', 09:46:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:10 INFO - 'MOZ_NO_REMOTE': '1', 09:46:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:10 INFO - 'NO_EM_RESTART': '1', 09:46:10 INFO - 'PAGER': '/bin/cat', 09:46:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:10 INFO - 'PWD': '/builds/slave/test', 09:46:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:10 INFO - 'SHELL': '/bin/bash', 09:46:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Vvjjd29TAU/Listeners', 09:46:10 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 09:46:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:10 INFO - 'USER': 'cltbld', 09:46:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:10 INFO - 'XPC_FLAGS': '0x0', 09:46:10 INFO - 'XPC_SERVICE_NAME': '0', 09:46:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 09:46:11 INFO - mozversion application_buildid: 20161222071552 09:46:11 INFO - mozversion application_changeset: 3db270bec24587719cbbfb3a15f40609d9b8f330 09:46:11 INFO - mozversion application_display_name: Firefox 09:46:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:11 INFO - mozversion application_name: Firefox 09:46:11 INFO - mozversion application_remotingname: firefox 09:46:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:46:11 INFO - mozversion application_vendor: Mozilla 09:46:11 INFO - mozversion application_version: 51.0 09:46:11 INFO - mozversion platform_buildid: 20161222071552 09:46:11 INFO - mozversion platform_changeset: 3db270bec24587719cbbfb3a15f40609d9b8f330 09:46:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:46:11 INFO - mozversion platform_version: 51.0 09:46:11 INFO - using testdate: 1482428771 09:46:11 INFO - actual date: 1482428771 09:46:11 INFO - starting webserver on 'localhost:49241' 09:46:11 INFO - SUITE-START | Running 2 tests 09:46:11 INFO - TEST-START | dromaeo_css 09:46:11 INFO - operating with platform_type : mac_ 09:46:11 INFO - Initialising browser for dromaeo_css test... 09:46:11 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFIJut2/profile http://localhost:49241/getInfo.html) 09:46:13 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 09:46:13 INFO - PROCESS | 1638 | colorDepth:24 09:46:13 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 09:46:13 INFO - PROCESS | 1638 | __metrics 09:46:13 INFO - PROCESS | 1638 | 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" 09:46:13 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:14 INFO - TEST-INFO | 1638: exit 0 09:46:14 INFO - Browser initialized. 09:46:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:14 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpFIJut2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:26 INFO - PROCESS | 1641 | RSS: Main: 168108032 09:46:26 INFO - PROCESS | 1641 | 09:47:16 INFO - PROCESS | 1641 | 1482428836841 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] 09:49:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:49:30 INFO - PROCESS | 1641 | RSS: Main: 315572224 09:49:30 INFO - PROCESS | 1641 | 09:52:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:52:33 INFO - PROCESS | 1641 | RSS: Main: 302817280 09:52:33 INFO - PROCESS | 1641 | 09:55:35 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:55:36 INFO - PROCESS | 1641 | RSS: Main: 268402688 09:55:36 INFO - PROCESS | 1641 | 09:58:38 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:58:39 INFO - PROCESS | 1641 | RSS: Main: 267509760 09:58:39 INFO - PROCESS | 1641 | 10:01:42 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:01:43 INFO - PROCESS | 1641 | RSS: Main: 261566464 10:01:43 INFO - PROCESS | 1641 | 10:04:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:04:46 INFO - PROCESS | 1641 | RSS: Main: 309788672 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | __start_tp_report 10:04:46 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 10:04:46 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 10:04:46 INFO - PROCESS | 1641 | |i|pagename|runs| 10:04:46 INFO - PROCESS | 1641 | |0;dojo.html;3456.6197718250996;3465.116395319193;3483.512308276842;3508.771929824563;3538.41616133338;5718.941995730783;5746.1668058131545;5789.450002249785;5791.652500849952;5812.970935145324;4365.934510982338;5685.204071429993;5761.683107429089;5830.737616807243;5843.065109582468;5243.239730239113;5268.8155914542995;5271.762770675309;5290.391604965421;5298.602604804655;5223.320968274119;5233.136532472137;5353.518183363496;5354.063038968185;5419.864503387407;5330.493603107699;5345.839624811262;5357.223202635615;5364.329458817648;5365.517103460687;5222.8694282642855;5280.155175171954;5289.973550132263;5291.788328466857;5308.885134121839;5207.531322181022;5217.008768334004;5287.814926477593;5302.867428314285;5303.098473259555;4986.4764199758865;5719.027765279912;5724.198612194296;5872.794452194195;5946.643201407929;6147.938520614782;6158.322584515699;6173.876522469525;6213.56505044647;6250.656213908233;6291;6294.150289710922;6319.241690997063;6349.777757778455;6370.267419246799;5768.942310576925;5840.123981402781;5846;5860.648361098305;5886.352501224862;6267.4045965633195;6271.529635277372;6304.495640348761;6305.274893387227;6324.367563243731;6181.227346581677;6195.101710251988;6202.34875338092;6205.627662340274;6210.223722034746;6175.876482470326;6317.873642527124;6345.17512723343;6348.333424990402;6351.364863513704;6110.492181593878;6148.508119350441;6214.564980451325;6221.4089661482085;6284.842878928063;6264.060390941395;6318.589291696025;6319;6324.71538780756;6326;4285.97857010713;4989.975050124726;5023.522765337287;5049.772760225798;5059.038782631288;4467.955320446819;4481.7983190756495;4485.663575231805;4504.25679762842;4563.361129441881;5780.132980052942;5792.420757924258;5849.385814489502;5864.120381942743;5885.735141918624;6312.684365781693;6325;6336.081268216175;6345.587536810092;6352.8411789704705;5662.03745363281;5757.971210143923;5805.564582656233;5806.2451881255165;5853.151293062568;5271.393789714155;5279.049771041249;5297.602679799031;5398.8920221595345;5469.4803993621335;6305.558610897193;6308.243010838729;6321.178246827791;6334.303226645157;6339.968300158562;6098.878022439615;6168.1056246844855;6182;6184.412480814315;6189.257289125154;6255.093011513214;6263.812085637438;6280.5289603279025;6296.6851657417865;6345.1116843641;6284.183056202664;6322.841928951813;6327.11420401135;6334.081558173947;6337.714802833976;5999.340072591924;6164.921138800782;6352.618842869442;6364.872702546016;6374.107624932606;6083.939160608337;6130.47890929276;6133.141360209664;6139.416755408229;6219.689015549114;6110.7861224856915;6131.682521312785;6138.51101655979;6205.627662340274;6229.345918678474;6072.05883088122;6088.147659327609;6092.75628974836;6106.297775755845;6127.295361033538;6158.414950579688;6177.829099307173;6194.690265486798;6227;6245.5628106032145;5903.114532820111;5961.940380596312;6030.788922387871;6072.1498990140535;6091.329953705001 10:04:46 INFO - PROCESS | 1641 | |1;ext.html;424.9150169966007;532.0449792622243;542.2002546244288;555.1921953557575;557.3089369182215;32280.354392912126;41798;43281;43484.56515434845;43570.12859742803;44943.55056449435;45366.546334536644;45389.546104539026;45427.31859022109;45604;9335.439873607571;10012.849807252896;10202;10217.48912554373;10226.590936362536;9192.632294708204;9543.570539325712;9551.235901127893;9561.139497445229;12291.139620226588;12316.630501084981;12579.308138052449;12600.558980435686;12602.306873121976;12605.11764176508;10757.193210509244;12411.069169812301;12518.56185033524;12601.369931503388;12610.621681349574;12365.31990740509;12427.75144497114;12436;12449.626511204679;12460.439280232411;41762.582374176476;42192.78903605493;42219.7889010553;42269.943251418656;42354.364684529755;3519.243362677011;3679.172186258097;3680.926381472382;3693.242885208526;3942.743721658083;30858.845705771328;32268.19329516781;32408;33063.3387332252;33130.50304245438;3102.2709663229125;3183.9522407163913;3322.371530489907;3328.234506063595;3332.383509050809;474971;484920.5753971243;486631;490622;491729;35549;65423.34576654172;66151;66206.66896665486;66252.33747662559;35997.82001089978;37021.62978370182;37150;37200.44199337012;37216.255674886896;15982.200889955688;16140.75788863168;16150.353985840435;16164.676706465805;16179.191040447931;13582.049256551947;13691.726165476635;13716.65708357299;13719.45122195101;13724.039317247696;7698.42261830365;7854.136045035041;8022.919770802334;8253.298469630028;8257.8348433031;3326.3014766899223;3367.2760356523463;3380.2056516718553;3381.5773028371455;3406.0633325835593;910.6113177404511;945.2579724916045;962.4177372689562;1028.1671845804772;1060.5174645536263;25125;30929.845350773103;31100.377992440026;31140.53289200664;31526.36947261042;1072.2065671403261;1077.9946100269449;1093.4532733633184;1160.042964554246;1208.4803534480081;15332.846671533365;15788.184358798655;15810.920945395199;15862.365505379656;16176.75734863978;632794;659951;661541.6922915354;664562;669214.6539267272;60371;60769.784604307664;60788;60808.695956520816;60843;1279.5969269680022;1327.323065236717;1395.6929475515574;1422.3599380278708;1428.357239242366;30716.232094197825;30757.384852303276;31731.682683173796;31864.044078677678;32448;51739.48260517346;52354.738226310146;52545.94908101893;52575.47424525706;52597.7370113147;526165;526369;527689;537446;538479;23506.647400288668;26630.7336926636;27366.452670946866;27371.178864634094;27834.721652783213;45494.77252613716;46850.76574617105;47642.761786190844;48345.54963351105;48466.78833029202;38654.6134538651;39271.607283926794;39987.00032499211;40880.38679419752;41374.75875723733;39279.60720392874;39356;39461.40807887827;40258.79870600745;40618.79690601528;37434.43848342331;39491.22289496922;39884.60115398925;39960;40016;32182;33877;34565.48151777675;34710;34748.47877281792;25797.191825906706;25956.35109122287;25957.870210648827;26162.607560886983;26460 10:04:46 INFO - PROCESS | 1641 | |2;jquery.html;333.2451996228542;386.53615661206544;393.60835968211626;401.9638232559069;413.8137837972911;19620.607587848233;21843.453913652167;22509;22675.319740407773;22786.88606556967;21373.893130534365;21887.452813679665;21991.670124948098;22098.33704988849;22124.564025909316;5632.436756324376;6109.81670549882;6166.969165154191;6170.81487555374;6181.320054793969;4209.915801683965;4229.090745489719;4339.783010849461;6029.939700603004;6135.987562052278;6399;6700.3969642732145;6741.730330786762;6818.795436136924;6826.317368263183;6508.153939987795;6742.595444273359;6787.287334829821;6793;6794.320567943216;5835.970820145914;5843.883122337529;5944.762209511614;5954.285485741695;5956.017257152608;26352.472950540883;26465.73534264652;26672.733272667414;26690.33274168142;26844.86577567119;2290.8625482471107;2336.229044415356;2378.6669866218745;2535.2014115553725;3052.722060189894;16306.83693163065;16427.83572164275;16568.254428550623;16701.91437556555;16759.329626814913;1850.9629807403912;1872.26981477224;1926.4991102313359;1933.0914470198984;1955.0908827395187;117875.99999999914;118002;124055.3797231008;125639;125973;11641.010514106396;11656.475458604213;11966.880331196751;11968.281903085843;12016.218945768496;15215.847841521443;15238;15253.237338133049;15267.007644503294;15276.46532371384;7401.8149546261775;8813.867791983126;8945.821083578292;9038.367314288069;9091.681791137411;8941.731748047569;8946.913314906347;8955.910440895637;8961.103889610988;9133.908660913306;4644.698094623838;4653.930191047137;4671.135839869635;4675.602573781267;4744.430668319824;1822.4441545328536;1844.4045900296146;1859.3585213101458;1936.845052395805;1968.8424926005885;912.5209265135857;914.766734482716;944.0889541592396;990.3315262198131;1028.5885645741764;19862.304819331253;20750.896245518677;21742.673859892115;22437.88781056117;22785.772142278696;940.4780346907395;942.6653537993914;945.9810803783886;974.449436068619;1042.7914417116608;11035.941647209002;11725.648230553097;11840.88159118415;11871.821922671166;11874;541194.2940285273;561541;569741;570530;576978;105045;127055;129802;135148;137199.6280037207;971.5385192033868;983.2674657380154;1008.5310330696261;1009.4296722351847;1010.3735683876043;16212;18935.33726319572;19657.508562286057;19711.901440492707;19724.60550789005;55479.445205547425;55861.16208256961;57164;57757;58090;78973.60513197628;80956.19043809487;82812;83118.16881831347;84333.36166510901;8148.144444833444;8171.101178870438;8194.262516373317;8467.449615774955;8606.870896936676;9336.06639336061;12842.67893302675;13385.598432047054;13585.592432226653;14311.713765724835;11764.764704705687;11785.528578856749;12084.093692972887;12200.267983920992;12325;9172.724818255463;9384.812303754023;11595.420228988349;11612;11901.464434100659;11999.820002699791;12082.214656047328;12106.576269830513;12281.38593070325;12285.017198624268;8207.876881846896;8432.5783710813;8493.10822363643;8688.174623410765;8754;9728.562214700214;11760.235584686969;11773.88226117728;11852.051835853283;12043.75912481728 10:04:46 INFO - PROCESS | 1641 | |3;mootools.html;1371.334902572253;1466.142306750551;1555.416718730476;1726.6891959447294;1893.1859300500787;8090.352771778258;8632.913670863289;8967.46195228286;9153.359264851446;9167.862482062774;8963.551822408886;9059.275257979361;9078.22835059019;9082.318826088036;9105;2171.8588291761066;2356.6229403295474;2427.9878600607017;2464.864432456214;2466.0135945621714;2386.6181410974245;2420.177139772477;2420.8668523231217;2422.1280339077916;2424.357545250501;2392.2464423706565;2406.1578447543393;2410.770976757205;2433.4038160650666;2437.122635851092;2383.320753585237;2403.9519209615796;2410.867402292882;2413.4328432818274;2425.211806163004;2379.9881000594887;2394.772496612819;2397.736249012607;2406.193925035098;2406.482606239649;8976.8653470198;9068.274538036942;9134.725958221265;9215.677451289239;9218.953905230497;5407.270018547485;5558.333000040021;5565.1374037024325;5653.010723123437;5653.745581448845;3123.8125712457327;3618.764780289273;3644.6902013328636;3716.0709822544363;3849.364854798983;995.66147509847;1092.2354351953663;1097.2483848563759;1113.2151832957745;1115.754534002518;12172.513099476011;12194.512219511209;12281.877181228252;12293.69265768354;12308.692282692915;4120.793960301973;4412.580804823537;4671.789769460314;4784.6889952153;4791.089692958327;9572.664956726481;9579.521023948775;9584.712458626253;9590.472524011246;9602;5431.375391829911;5438.592105592017;5439.945600544023;5442.945570544244;5449.809256675997;3773.6792372648633;4560.475545312265;4691.765411729468;4918.778654960535;5122.718250496184;3878.6703130234246;3881.5536213335827;4013.0368711509027;4017.13631569214;4023.657989070903;1166.6292106774506;1193.2601786892183;1195.0320240604965;1205.4394706461537;1206.6862615719976;876.8816209811721;882.4259268450072;889.3285569395065;891.7146513115871;893.097971049232;5480.123180291134;5562.137868630369;5675.1487276907965;5756.884862302731;5821.7380217890295;442.60165850733955;452.46834968912054;457.5287453922465;470.4378267969743;471.24365393543553;3728.7762734236035;3816.2749077675153;3831.3869780834934;3861.9034524137123;3918.7648741075627;10669.519871605797;10892.292001019909;11253.71865703364;11279.097672186206;11288.492017859217;10956.506957186946;11098.2786118902;11099.83350249747;11105.888941110647;11112.499937502831;8320.70877519284;8436.704715334934;8442.113578074213;8536.44513106646;8543.786405339917;5624.493795558419;5718.25662663851;5918.526517878473;5937.881242375042;6035.818925432244;10069.647562335284;10240.385576865412;10439.947800261254;10455.581776728846;10462.529186186488;8705.782355441164;10051.798964020532;10316.948415257875;10702.73243168927;10762.73093172677;7008.614526200904;7173.0316407284345;7522.3605993491165;7692;7703.614819258903;8436.156384361515;8609.87085193735;8738.563071846509;8740.650373984969;8903.19871211594;7875.173106823701;8009.719659811879;8123.309518690741;8133.715319963773;8220.383471239562;7234.457415693739;7269.672864721206;7717;7928.365730741411;8029.07665618438;7148.785536433916;7294.379977701955;7299.5255308404785;7305.634718264172;7306.853862922818;4971.875703107451;5035.773390197523;5064.366954130734;5151.25306830515;5292.153255479105;5076.162433198481;5106.63207345931;5231.084560202025;5317.20241963693;5343.4122246553625 10:04:46 INFO - PROCESS | 1641 | |4;prototype.html;278.4250522670685;304.4215989619721;311.19245557777566;316.94136584731825;321.1473537757254;5425.511703946644;5430.75561599728;5432.266644003058;5449.264349312842;5475.616706830523;4798.448178459478;5289.523942845143;5376.596755243353;5376.983631138323;5414.269073675053;3951.427043078752;4114.120115918869;4116.917661646765;4125.040605712293;4126.546079931205;3530.1593278576593;4104.363823607331;4154.563770804068;4159.105792254664;4182.247195504808;3523.925202813141;3985.6612187963915;4086.8773936781945;4088.4480595119726;4125;4083.612056854594;4096.283150448689;4109.424680544711;4121.567235440266;4129.224433493597;2936.8678409471413;3583.4803953426867;3594.077168714725;3598.9100272493133;3604.333198358312;5149.0474262261605;5191.610629202825;5192.324997750268;5289.677580604849;5293.100172970604;3902.4341470486906;3909.198614284065;4634.884127896796;4721.763911804396;4731.243001119804;4731.739754313511;4937.407511098691;5568.719194585227;5702.8289151325525;5723.370429252779;3862.5364956205153;3940.5074365704286;3942.7634341939574;3944.1914407546383;3953.8418463261437;4918.655694101414;5622.662640241599;5720.456556627156;5873.676947767828;5971.373005834368;3846.9615303847163;3943.7042221833476;3948.545917219499;3963.564007959122;3970.960290397059;3739.102615372291;3817.8854634361014;4038.7172897897453;4043.696722745747;4047.2714911316248;4503.842365517191;4601.953980460219;4647.6281897448125;4656.579743178296;4684.814326258109;4962.154330393973;5019.669787506314;5028.396592408934;5537.6954267515675;5700.800471983461;1135.4776802670865;1298.5455090718174;1369.3221855181748;1369.9589012329645;1375.9587212383644;663.8681048811861;822.6873787960536;837.969297763754;842.4103127810434;843.1989609870648;4258.936115958263;4335.934960975588;4343.978280108642;4498.5501449854755;4539.773011349419;3946.908138686501;4353.888364143388;4367.58507941745;4939.641598560424;4957.182064959314;3818.694504439638;4180.770057646798;4500.504944456173;4518.909621807546;4547.476150736307;2142.3144593729858;2352.5768458487787;2361.3860396297086;2456.385903524119;2589.741025897433;5086.54221120101;5096.889838675102;5097.6941383517105;5109.948900511022;5119.820806271762;3969.226000929849;4231.851885184004;4616.399868017136;4799.712017278975;4992.525710057539;4223.083329593036;4500.954990450054;4744.644151688637;5104.744762761773;5111.923321150186;4538.205813982474;4849.060375849547;4893.657443978887;4947.45577986414;4966.950330496648;4292.484901811803;4815.951840481691;4856.757162141949;4866.732329721899;4869.415670119467;5050.74746262678;5573.191887176417;5699.23060386859;5936.78295949338;6234.532410069353;3262.7552933530555;3414.300068485905;4007.318755811461;4035.858744943913;4052.5542190359624;5875.911861321998;5956.910646340221;5964.671943043174;5999.070144127667;6014.548908831943;4997.375328083989;5329.960657671717;5363.651362661414;5500.944990550043;5788.942110578841;5785.797497087582;5794.101914203306;5795.971410006464;5832.24180856486;5860.94139058621;4751.714897106184;5256.737163141751;5387.622866399314;5759.193712880116;5800.24596802413;5113.028524580318;5436.55931178246;5838.532917366516;5847.8245652630485;5851.473367396955;5288.550473209821;5738.254026976467;5738.704518192756;5750.30996280449;5767.250257466502 10:04:46 INFO - PROCESS | 1641 | |5;yui.html;692.8891377379621;745.2733584754865;790.7074382478484;820.2822530285999;826.3141592478244;15909.761353579692;16636.91681541592;16648.50054498364;16656.16719164043;16682.749758753627;15201.771973420407;15271;15293.311800968955;15304.923475382635;15313.846861531381;709.8757717399434;733.3070248615061;734.6730704836323;867.4751775176006;867.5662168915542;727.6434547071923;882.355880207449;895.5387975192781;896.1486587741639;897.2463130969984;805.9758207253792;953.0374321934861;958.8082383523289;958.9328746987713;959.0984474593894;944.9196818270456;945.4421891084259;948.5067764762354;949.188443880486;949.5252373813094;702.0907924238073;705.3123204875257;706.3254591864757;707.3068392974914;707.9044329015569;15893.523194304189;15981;16145.596360090974;16148.515544533682;16149.838501615068;12792.761266778369;14348.856511434857;15129.092254464767;15161.924428647984;15278.802256733301;10054.648087316982;11878.049756019498;12177.634670959796;12232.755344893052;12644.367781610974;3862.304785138674;3931.5871833457645;3944.3689009758587;4003;4028.67770578353;119671;119742;122535.38732306281;123163;125390;11516.712082198012;11602.129840262014;11752.58865939688;11760.000399965927;11960.58137965167;24284.757152428603;24700.752992470203;24741.87629061843;24755.504889902462;24796.876015619808;7943.364530837519;7966.920330796734;8044.557549334842;8237.711680091168;8323.750287491384;4347.130573885235;4515.9548404515535;4530.524294949048;4560.68075234737;4752.168370535212;3725.683316918038;3843.461915331856;3848.7690738555775;3853.9807300963316;3858.2476417098956;614.118739608663;641.7978336823885;655.8491546944134;670.276101810044;675.8546912413855;597.3876776304323;682.8804959132232;687.4259992905979;696.3210869402292;720.6828995242076;7830.804229894185;9241.260699144052;9377.531123443801;9480.857787133198;9749.415035097916;633.2559242889587;681.8227260912198;704.594857956677;706.8444942112727;716.9103862017248;4858.44127925286;4878.146324393217;4886.975565122223;4905.730184839868;4922.384701912261;124676;150101;150292.24853875878;154362.22818885834;158854;120837.18744218844;133470;137394.3130284342;142689;148860;122344.38827805805;122403;125808.37095814645;127001.3649931726;128478.35760821323;8933.776655583662;9441.669541566012;9445.716628501155;9554.904450955402;9587.808243835223;66728.33271667415;66896;67230.66384668241;68020.3197968014;69175.61648767097;48339.75830120827;59912;96067.51966240125;101963.98036019545;106281.02892283264;11467.311961282016;12433.12968092225;12464.376781160725;12495.25028498293;12651.114421990373;10638.14894808429;13207.735845283232;13277.867221327662;13401;14364;10243.795124097327;10779.353238805697;11304.717382065513;11587.073034157416;11729.589464368706;12324.50701971947;12698.839583644456;12943.676408089497;13090.607281781562;13214.207147571176;10545.36727796304;11244.606438774603;11364.261323013978;11666.300021998708;11923.523059077539;9300.581473833558;11022.944885275523;11233.66299011031;11367.147463940073;11609.941950290195;10918.399488028235;10942.562297508011;11121.610743623934;11157.442127893735;11189.328640281608 10:04:46 INFO - PROCESS | 1641 | __end_tp_report 10:04:46 INFO - PROCESS | 1641 | __start_cc_report 10:04:46 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1464 10:04:46 INFO - PROCESS | 1641 | __end_cc_report 10:04:46 INFO - PROCESS | 1641 | __startTimestamp1482429886026__endTimestamp 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | ------- Summary: start ------- 10:04:46 INFO - PROCESS | 1641 | Number of tests: 6 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5793.65 Median:6088.15 stddev:641.91 (10.5%) stddev-sans-first:617.14 10:04:46 INFO - PROCESS | 1641 | Values: 3456.6 3465.1 3483.5 3508.8 3538.4 5718.9 5746.2 5789.5 5791.7 5813.0 4365.9 5685.2 5761.7 5830.7 5843.1 5243.2 5268.8 5271.8 5290.4 5298.6 5223.3 5233.1 5353.5 5354.1 5419.9 5330.5 5345.8 5357.2 5364.3 5365.5 5222.9 5280.2 5290.0 5291.8 5308.9 5207.5 5217.0 5287.8 5302.9 5303.1 4986.5 5719.0 5724.2 5872.8 5946.6 6147.9 6158.3 6173.9 6213.6 6250.7 6291.0 6294.2 6319.2 6349.8 6370.3 5768.9 5840.1 5846.0 5860.6 5886.4 6267.4 6271.5 6304.5 6305.3 6324.4 6181.2 6195.1 6202.3 6205.6 6210.2 6175.9 6317.9 6345.2 6348.3 6351.4 6110.5 6148.5 6214.6 6221.4 6284.8 6264.1 6318.6 6319.0 6324.7 6326.0 4286.0 4990.0 5023.5 5049.8 5059.0 4468.0 4481.8 4485.7 4504.3 4563.4 5780.1 5792.4 5849.4 5864.1 5885.7 6312.7 6325.0 6336.1 6345.6 6352.8 5662.0 5758.0 5805.6 5806.2 5853.2 5271.4 5279.0 5297.6 5398.9 5469.5 6305.6 6308.2 6321.2 6334.3 6340.0 6098.9 6168.1 6182.0 6184.4 6189.3 6255.1 6263.8 6280.5 6296.7 6345.1 6284.2 6322.8 6327.1 6334.1 6337.7 5999.3 6164.9 6352.6 6364.9 6374.1 6083.9 6130.5 6133.1 6139.4 6219.7 6110.8 6131.7 6138.5 6205.6 6229.3 6072.1 6088.1 6092.8 6106.3 6127.3 6158.4 6177.8 6194.7 6227.0 6245.6 5903.1 5961.9 6030.8 6072.1 6091.3 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:69028.51 Median:19838.50 stddev:150447.80 (758.4%) stddev-sans-first:150781.67 10:04:46 INFO - PROCESS | 1641 | Values: 424.9 532.0 542.2 555.2 557.3 32280.4 41798.0 43281.0 43484.6 43570.1 44943.6 45366.5 45389.5 45427.3 45604.0 9335.4 10012.8 10202.0 10217.5 10226.6 9192.6 9543.6 9551.2 9561.1 12291.1 12316.6 12579.3 12600.6 12602.3 12605.1 10757.2 12411.1 12518.6 12601.4 12610.6 12365.3 12427.8 12436.0 12449.6 12460.4 41762.6 42192.8 42219.8 42269.9 42354.4 3519.2 3679.2 3680.9 3693.2 3942.7 30858.8 32268.2 32408.0 33063.3 33130.5 3102.3 3184.0 3322.4 3328.2 3332.4 474971.0 484920.6 486631.0 490622.0 491729.0 35549.0 65423.3 66151.0 66206.7 66252.3 35997.8 37021.6 37150.0 37200.4 37216.3 15982.2 16140.8 16150.4 16164.7 16179.2 13582.0 13691.7 13716.7 13719.5 13724.0 7698.4 7854.1 8022.9 8253.3 8257.8 3326.3 3367.3 3380.2 3381.6 3406.1 910.6 945.3 962.4 1028.2 1060.5 25125.0 30929.8 31100.4 31140.5 31526.4 1072.2 1078.0 1093.5 1160.0 1208.5 15332.8 15788.2 15810.9 15862.4 16176.8 632794.0 659951.0 661541.7 664562.0 669214.7 60371.0 60769.8 60788.0 60808.7 60843.0 1279.6 1327.3 1395.7 1422.4 1428.4 30716.2 30757.4 31731.7 31864.0 32448.0 51739.5 52354.7 52545.9 52575.5 52597.7 526165.0 526369.0 527689.0 537446.0 538479.0 23506.6 26630.7 27366.5 27371.2 27834.7 45494.8 46850.8 47642.8 48345.5 48466.8 38654.6 39271.6 39987.0 40880.4 41374.8 39279.6 39356.0 39461.4 40258.8 40618.8 37434.4 39491.2 39884.6 39960.0 40016.0 32182.0 33877.0 34565.5 34710.0 34748.5 25797.2 25956.4 25957.9 26162.6 26460.0 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34898.03 Median:26409.10 stddev:94554.02 (358.0%) stddev-sans-first:94783.66 10:04:46 INFO - PROCESS | 1641 | Values: 333.2 386.5 393.6 402.0 413.8 19620.6 21843.5 22509.0 22675.3 22786.9 21373.9 21887.5 21991.7 22098.3 22124.6 5632.4 6109.8 6167.0 6170.8 6181.3 4209.9 4229.1 4339.8 6029.9 6136.0 6399.0 6700.4 6741.7 6818.8 6826.3 6508.2 6742.6 6787.3 6793.0 6794.3 5836.0 5843.9 5944.8 5954.3 5956.0 26352.5 26465.7 26672.7 26690.3 26844.9 2290.9 2336.2 2378.7 2535.2 3052.7 16306.8 16427.8 16568.3 16701.9 16759.3 1851.0 1872.3 1926.5 1933.1 1955.1 117876.0 118002.0 124055.4 125639.0 125973.0 11641.0 11656.5 11966.9 11968.3 12016.2 15215.8 15238.0 15253.2 15267.0 15276.5 7401.8 8813.9 8945.8 9038.4 9091.7 8941.7 8946.9 8955.9 8961.1 9133.9 4644.7 4653.9 4671.1 4675.6 4744.4 1822.4 1844.4 1859.4 1936.8 1968.8 912.5 914.8 944.1 990.3 1028.6 19862.3 20750.9 21742.7 22437.9 22785.8 940.5 942.7 946.0 974.4 1042.8 11035.9 11725.6 11840.9 11871.8 11874.0 541194.3 561541.0 569741.0 570530.0 576978.0 105045.0 127055.0 129802.0 135148.0 137199.6 971.5 983.3 1008.5 1009.4 1010.4 16212.0 18935.3 19657.5 19711.9 19724.6 55479.4 55861.2 57164.0 57757.0 58090.0 78973.6 80956.2 82812.0 83118.2 84333.4 8148.1 8171.1 8194.3 8467.4 8606.9 9336.1 12842.7 13385.6 13585.6 14311.7 11764.8 11785.5 12084.1 12200.3 12325.0 9172.7 9384.8 11595.4 11612.0 11901.5 11999.8 12082.2 12106.6 12281.4 12285.0 8207.9 8432.6 8493.1 8688.2 8754.0 9728.6 11760.2 11773.9 11852.1 12043.8 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5821.56 Median:4854.93 stddev:3339.28 (68.8%) stddev-sans-first:3331.90 10:04:46 INFO - PROCESS | 1641 | Values: 1371.3 1466.1 1555.4 1726.7 1893.2 8090.4 8632.9 8967.5 9153.4 9167.9 8963.6 9059.3 9078.2 9082.3 9105.0 2171.9 2356.6 2428.0 2464.9 2466.0 2386.6 2420.2 2420.9 2422.1 2424.4 2392.2 2406.2 2410.8 2433.4 2437.1 2383.3 2404.0 2410.9 2413.4 2425.2 2380.0 2394.8 2397.7 2406.2 2406.5 8976.9 9068.3 9134.7 9215.7 9219.0 5407.3 5558.3 5565.1 5653.0 5653.7 3123.8 3618.8 3644.7 3716.1 3849.4 995.7 1092.2 1097.2 1113.2 1115.8 12172.5 12194.5 12281.9 12293.7 12308.7 4120.8 4412.6 4671.8 4784.7 4791.1 9572.7 9579.5 9584.7 9590.5 9602.0 5431.4 5438.6 5439.9 5442.9 5449.8 3773.7 4560.5 4691.8 4918.8 5122.7 3878.7 3881.6 4013.0 4017.1 4023.7 1166.6 1193.3 1195.0 1205.4 1206.7 876.9 882.4 889.3 891.7 893.1 5480.1 5562.1 5675.1 5756.9 5821.7 442.6 452.5 457.5 470.4 471.2 3728.8 3816.3 3831.4 3861.9 3918.8 10669.5 10892.3 11253.7 11279.1 11288.5 10956.5 11098.3 11099.8 11105.9 11112.5 8320.7 8436.7 8442.1 8536.4 8543.8 5624.5 5718.3 5918.5 5937.9 6035.8 10069.6 10240.4 10439.9 10455.6 10462.5 8705.8 10051.8 10316.9 10702.7 10762.7 7008.6 7173.0 7522.4 7692.0 7703.6 8436.2 8609.9 8738.6 8740.7 8903.2 7875.2 8009.7 8123.3 8133.7 8220.4 7234.5 7269.7 7717.0 7928.4 8029.1 7148.8 7294.4 7299.5 7305.6 7306.9 4971.9 5035.8 5064.4 5151.3 5292.2 5076.2 5106.6 5231.1 5317.2 5343.4 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4383.86 Median:4738.19 stddev:1353.24 (28.6%) stddev-sans-first:1321.49 10:04:46 INFO - PROCESS | 1641 | Values: 278.4 304.4 311.2 316.9 321.1 5425.5 5430.8 5432.3 5449.3 5475.6 4798.4 5289.5 5376.6 5377.0 5414.3 3951.4 4114.1 4116.9 4125.0 4126.5 3530.2 4104.4 4154.6 4159.1 4182.2 3523.9 3985.7 4086.9 4088.4 4125.0 4083.6 4096.3 4109.4 4121.6 4129.2 2936.9 3583.5 3594.1 3598.9 3604.3 5149.0 5191.6 5192.3 5289.7 5293.1 3902.4 3909.2 4634.9 4721.8 4731.2 4731.7 4937.4 5568.7 5702.8 5723.4 3862.5 3940.5 3942.8 3944.2 3953.8 4918.7 5622.7 5720.5 5873.7 5971.4 3847.0 3943.7 3948.5 3963.6 3971.0 3739.1 3817.9 4038.7 4043.7 4047.3 4503.8 4602.0 4647.6 4656.6 4684.8 4962.2 5019.7 5028.4 5537.7 5700.8 1135.5 1298.5 1369.3 1370.0 1376.0 663.9 822.7 838.0 842.4 843.2 4258.9 4335.9 4344.0 4498.6 4539.8 3946.9 4353.9 4367.6 4939.6 4957.2 3818.7 4180.8 4500.5 4518.9 4547.5 2142.3 2352.6 2361.4 2456.4 2589.7 5086.5 5096.9 5097.7 5109.9 5119.8 3969.2 4231.9 4616.4 4799.7 4992.5 4223.1 4501.0 4744.6 5104.7 5111.9 4538.2 4849.1 4893.7 4947.5 4967.0 4292.5 4816.0 4856.8 4866.7 4869.4 5050.7 5573.2 5699.2 5936.8 6234.5 3262.8 3414.3 4007.3 4035.9 4052.6 5875.9 5956.9 5964.7 5999.1 6014.5 4997.4 5330.0 5363.7 5500.9 5788.9 5785.8 5794.1 5796.0 5832.2 5860.9 4751.7 5256.7 5387.6 5759.2 5800.2 5113.0 5436.6 5838.5 5847.8 5851.5 5288.6 5738.3 5738.7 5750.3 5767.3 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:25715.08 Median:14261.28 stddev:41816.78 (293.2%) stddev-sans-first:41891.88 10:04:46 INFO - PROCESS | 1641 | Values: 692.9 745.3 790.7 820.3 826.3 15909.8 16636.9 16648.5 16656.2 16682.7 15201.8 15271.0 15293.3 15304.9 15313.8 709.9 733.3 734.7 867.5 867.6 727.6 882.4 895.5 896.1 897.2 806.0 953.0 958.8 958.9 959.1 944.9 945.4 948.5 949.2 949.5 702.1 705.3 706.3 707.3 707.9 15893.5 15981.0 16145.6 16148.5 16149.8 12792.8 14348.9 15129.1 15161.9 15278.8 10054.6 11878.0 12177.6 12232.8 12644.4 3862.3 3931.6 3944.4 4003.0 4028.7 119671.0 119742.0 122535.4 123163.0 125390.0 11516.7 11602.1 11752.6 11760.0 11960.6 24284.8 24700.8 24741.9 24755.5 24796.9 7943.4 7966.9 8044.6 8237.7 8323.8 4347.1 4516.0 4530.5 4560.7 4752.2 3725.7 3843.5 3848.8 3854.0 3858.2 614.1 641.8 655.8 670.3 675.9 597.4 682.9 687.4 696.3 720.7 7830.8 9241.3 9377.5 9480.9 9749.4 633.3 681.8 704.6 706.8 716.9 4858.4 4878.1 4887.0 4905.7 4922.4 124676.0 150101.0 150292.2 154362.2 158854.0 120837.2 133470.0 137394.3 142689.0 148860.0 122344.4 122403.0 125808.4 127001.4 128478.4 8933.8 9441.7 9445.7 9554.9 9587.8 66728.3 66896.0 67230.7 68020.3 69175.6 48339.8 59912.0 96067.5 101964.0 106281.0 11467.3 12433.1 12464.4 12495.3 12651.1 10638.1 13207.7 13277.9 13401.0 14364.0 10243.8 10779.4 11304.7 11587.1 11729.6 12324.5 12698.8 12943.7 13090.6 13214.2 10545.4 11244.6 11364.3 11666.3 11923.5 9300.6 11022.9 11233.7 11367.1 11609.9 10918.4 10942.6 11121.6 11157.4 11189.3 10:04:46 INFO - PROCESS | 1641 | -------- Summary: end -------- 10:04:46 INFO - PROCESS | 1641 | 10:04:46 INFO - TEST-INFO | 1641: exit 0 10:04:46 INFO - TEST-OK | dromaeo_css | took 1115640ms 10:04:46 INFO - TEST-START | kraken 10:04:46 INFO - operating with platform_type : mac_ 10:04:46 INFO - Initialising browser for kraken test... 10:04:46 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpxPtGcn/profile http://localhost:49241/getInfo.html) 10:04:48 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 10:04:48 INFO - PROCESS | 1650 | colorDepth:24 10:04:48 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 10:04:48 INFO - PROCESS | 1650 | __metrics 10:04:48 INFO - PROCESS | 1650 | 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" 10:04:48 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:49 INFO - TEST-INFO | 1650: exit 0 10:04:49 INFO - Browser initialized. 10:04:49 INFO - Running cycle 1/1 for kraken test... 10:04:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpxPtGcn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:01 INFO - PROCESS | 1652 | RSS: Main: 169041920 10:05:01 INFO - PROCESS | 1652 | 10:05:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:05 INFO - PROCESS | 1652 | RSS: Main: 219893760 10:05:05 INFO - PROCESS | 1652 | 10:05:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:05:08 INFO - PROCESS | 1652 | RSS: Main: 232927232 10:05:08 INFO - PROCESS | 1652 | 10:05:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:05:11 INFO - PROCESS | 1652 | RSS: Main: 329420800 10:05:12 INFO - PROCESS | 1652 | 10:05:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:05:14 INFO - PROCESS | 1652 | RSS: Main: 229220352 10:05:14 INFO - PROCESS | 1652 | 10:05:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:05:17 INFO - PROCESS | 1652 | RSS: Main: 229687296 10:05:17 INFO - PROCESS | 1652 | 10:05:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:05:20 INFO - PROCESS | 1652 | RSS: Main: 269475840 10:05:20 INFO - PROCESS | 1652 | 10:05:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:24 INFO - PROCESS | 1652 | RSS: Main: 267792384 10:05:24 INFO - PROCESS | 1652 | 10:05:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:05:27 INFO - PROCESS | 1652 | RSS: Main: 267214848 10:05:27 INFO - PROCESS | 1652 | 10:05:29 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:29 INFO - PROCESS | 1652 | RSS: Main: 240791552 10:05:29 INFO - PROCESS | 1652 | 10:05:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:32 INFO - PROCESS | 1652 | RSS: Main: 246669312 10:05:32 INFO - PROCESS | 1652 | 10:05:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:35 INFO - PROCESS | 1652 | RSS: Main: 251854848 10:05:35 INFO - PROCESS | 1652 | 10:05:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:38 INFO - PROCESS | 1652 | RSS: Main: 269631488 10:05:38 INFO - PROCESS | 1652 | 10:05:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:42 INFO - PROCESS | 1652 | RSS: Main: 262529024 10:05:42 INFO - PROCESS | 1652 | 10:05:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:05:44 INFO - PROCESS | 1652 | RSS: Main: 306618368 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | __start_tp_report 10:05:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 10:05:44 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 10:05:44 INFO - PROCESS | 1652 | |i|pagename|runs| 10:05:44 INFO - PROCESS | 1652 | |0;ai-astar;115;110;113;111;112;111;111;113;113;113 10:05:44 INFO - PROCESS | 1652 | |1;audio-beat-detection;142;108;105;140;116;138;140;110;139;131 10:05:44 INFO - PROCESS | 1652 | |2;audio-dft;184;182;182;183;181;181;183;181;180;183 10:05:44 INFO - PROCESS | 1652 | |3;audio-fft;80;59;58;87;62;58;58;61;99;82 10:05:44 INFO - PROCESS | 1652 | |4;audio-oscillator;85;71;94;69;68;68;94;67;68;90 10:05:44 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;90;86;88;85;89;116;132;128;92;86 10:05:44 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;119;95;94;95;94;94;94;109;150 10:05:44 INFO - PROCESS | 1652 | |7;imaging-desaturate;83;85;85;85;86;84;84;86;84;87 10:05:44 INFO - PROCESS | 1652 | |8;json-parse-financial;55;52;51;52;56;57;59;55;57;55 10:05:44 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;62;74;74;71;71;78;98;98;93;71 10:05:44 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;81;81;83;88;86;99;84;82;85;80 10:05:44 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;152;150;150;135;131;135;139;142;199;144 10:05:44 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;160;159;160;159;159;159;160;161;161;159 10:05:44 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;63;68;67;62;84;64;65;64;65;68 10:05:44 INFO - PROCESS | 1652 | __end_tp_report 10:05:44 INFO - PROCESS | 1652 | __start_cc_report 10:05:44 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1933 10:05:44 INFO - PROCESS | 1652 | __end_cc_report 10:05:44 INFO - PROCESS | 1652 | __startTimestamp1482429944079__endTimestamp 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | ------- Summary: start ------- 10:05:44 INFO - PROCESS | 1652 | Number of tests: 14 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:1.48 (1.3%) stddev-sans-first:1.17 10:05:44 INFO - PROCESS | 1652 | Values: 115.0 110.0 113.0 111.0 112.0 111.0 111.0 113.0 113.0 113.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:138.50 stddev:15.27 (11.0%) stddev-sans-first:15.19 10:05:44 INFO - PROCESS | 1652 | Values: 142.0 108.0 105.0 140.0 116.0 138.0 140.0 110.0 139.0 131.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.50 stddev:1.25 (0.7%) stddev-sans-first:1.09 10:05:44 INFO - PROCESS | 1652 | Values: 184.0 182.0 182.0 183.0 181.0 181.0 183.0 181.0 180.0 183.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:70.40 Median:71.00 stddev:15.17 (21.4%) stddev-sans-first:15.68 10:05:44 INFO - PROCESS | 1652 | Values: 80.0 59.0 58.0 87.0 62.0 58.0 58.0 61.0 99.0 82.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:11.80 (15.1%) stddev-sans-first:12.19 10:05:44 INFO - PROCESS | 1652 | Values: 85.0 71.0 94.0 69.0 68.0 68.0 94.0 67.0 68.0 90.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:99.20 Median:87.00 stddev:18.57 (21.3%) stddev-sans-first:19.40 10:05:44 INFO - PROCESS | 1652 | Values: 90.0 86.0 88.0 85.0 89.0 116.0 132.0 128.0 92.0 86.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:103.80 Median:94.00 stddev:18.34 (19.5%) stddev-sans-first:19.11 10:05:44 INFO - PROCESS | 1652 | Values: 94.0 119.0 95.0 94.0 95.0 94.0 94.0 94.0 109.0 150.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.20 (1.4%) stddev-sans-first:1.05 10:05:44 INFO - PROCESS | 1652 | Values: 83.0 85.0 85.0 85.0 86.0 84.0 84.0 86.0 84.0 87.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:2.56 (4.6%) stddev-sans-first:2.71 10:05:44 INFO - PROCESS | 1652 | Values: 55.0 52.0 51.0 52.0 56.0 57.0 59.0 55.0 57.0 55.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:79.00 Median:76.00 stddev:12.69 (16.7%) stddev-sans-first:11.88 10:05:44 INFO - PROCESS | 1652 | Values: 62.0 74.0 74.0 71.0 71.0 78.0 98.0 98.0 93.0 71.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:5.55 (6.6%) stddev-sans-first:5.70 10:05:44 INFO - PROCESS | 1652 | Values: 81.0 81.0 83.0 88.0 86.0 99.0 84.0 82.0 85.0 80.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:147.00 stddev:19.39 (13.2%) stddev-sans-first:20.50 10:05:44 INFO - PROCESS | 1652 | Values: 152.0 150.0 150.0 135.0 131.0 135.0 139.0 142.0 199.0 144.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 10:05:44 INFO - PROCESS | 1652 | Values: 160.0 159.0 160.0 159.0 159.0 159.0 160.0 161.0 161.0 159.0 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:66.00 stddev:6.31 (9.6%) stddev-sans-first:6.52 10:05:44 INFO - PROCESS | 1652 | Values: 63.0 68.0 67.0 62.0 84.0 64.0 65.0 64.0 65.0 68.0 10:05:44 INFO - PROCESS | 1652 | -------- Summary: end -------- 10:05:44 INFO - PROCESS | 1652 | 10:05:44 INFO - TEST-INFO | 1652: exit 0 10:05:44 INFO - TEST-OK | kraken | took 58237ms 10:05:44 INFO - SUITE-END | took 1173s 10:05:45 INFO - Completed test suite (00:19:34) 10:05:45 INFO - javascript benchmark 10:05:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3456.6197718250996, 3465.116395319193, 3483.512308276842, 3508.771929824563, 3538.41616133338, 5718.941995730783, 5746.1668058131545, 5789.450002249785, 5791.652500849952, 5812.970935145324, 4365.934510982338, 5685.204071429993, 5761.683107429089, 5830.737616807243, 5843.065109582468, 5243.239730239113, 5268.8155914542995, 5271.762770675309, 5290.391604965421, 5298.602604804655, 5223.320968274119, 5233.136532472137, 5353.518183363496, 5354.063038968185, 5419.864503387407, 5330.493603107699, 5345.839624811262, 5357.223202635615, 5364.329458817648, 5365.517103460687, 5222.8694282642855, 5280.155175171954, 5289.973550132263, 5291.788328466857, 5308.885134121839, 5207.531322181022, 5217.008768334004, 5287.814926477593, 5302.867428314285, 5303.098473259555, 4986.4764199758865, 5719.027765279912, 5724.198612194296, 5872.794452194195, 5946.643201407929, 6147.938520614782, 6158.322584515699, 6173.876522469525, 6213.56505044647, 6250.656213908233, 6291.0, 6294.150289710922, 6319.241690997063, 6349.777757778455, 6370.267419246799, 5768.942310576925, 5840.123981402781, 5846.0, 5860.648361098305, 5886.352501224862, 6267.4045965633195, 6271.529635277372, 6304.495640348761, 6305.274893387227, 6324.367563243731, 6181.227346581677, 6195.101710251988, 6202.34875338092, 6205.627662340274, 6210.223722034746, 6175.876482470326, 6317.873642527124, 6345.17512723343, 6348.333424990402, 6351.364863513704, 6110.492181593878, 6148.508119350441, 6214.564980451325, 6221.4089661482085, 6284.842878928063, 6264.060390941395, 6318.589291696025, 6319.0, 6324.71538780756, 6326.0, 4285.97857010713, 4989.975050124726, 5023.522765337287, 5049.772760225798, 5059.038782631288, 4467.955320446819, 4481.7983190756495, 4485.663575231805, 4504.25679762842, 4563.361129441881, 5780.132980052942, 5792.420757924258, 5849.385814489502, 5864.120381942743, 5885.735141918624, 6312.684365781693, 6325.0, 6336.081268216175, 6345.587536810092, 6352.8411789704705, 5662.03745363281, 5757.971210143923, 5805.564582656233, 5806.2451881255165, 5853.151293062568, 5271.393789714155, 5279.049771041249, 5297.602679799031, 5398.8920221595345, 5469.4803993621335, 6305.558610897193, 6308.243010838729, 6321.178246827791, 6334.303226645157, 6339.968300158562, 6098.878022439615, 6168.1056246844855, 6182.0, 6184.412480814315, 6189.257289125154, 6255.093011513214, 6263.812085637438, 6280.5289603279025, 6296.6851657417865, 6345.1116843641, 6284.183056202664, 6322.841928951813, 6327.11420401135, 6334.081558173947, 6337.714802833976, 5999.340072591924, 6164.921138800782, 6352.618842869442, 6364.872702546016, 6374.107624932606, 6083.939160608337, 6130.47890929276, 6133.141360209664, 6139.416755408229, 6219.689015549114, 6110.7861224856915, 6131.682521312785, 6138.51101655979, 6205.627662340274, 6229.345918678474, 6072.05883088122, 6088.147659327609, 6092.75628974836, 6106.297775755845, 6127.295361033538, 6158.414950579688, 6177.829099307173, 6194.690265486798, 6227.0, 6245.5628106032145, 5903.114532820111, 5961.940380596312, 6030.788922387871, 6072.1498990140535, 6091.329953705001], "value": 5753.920651415546, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.9150169966007, 532.0449792622243, 542.2002546244288, 555.1921953557575, 557.3089369182215, 32280.354392912126, 41798.0, 43281.0, 43484.56515434845, 43570.12859742803, 44943.55056449435, 45366.546334536644, 45389.546104539026, 45427.31859022109, 45604.0, 9335.439873607571, 10012.849807252896, 10202.0, 10217.48912554373, 10226.590936362536, 9192.632294708204, 9543.570539325712, 9551.235901127893, 9561.139497445229, 12291.139620226588, 12316.630501084981, 12579.308138052449, 12600.558980435686, 12602.306873121976, 12605.11764176508, 10757.193210509244, 12411.069169812301, 12518.56185033524, 12601.369931503388, 12610.621681349574, 12365.31990740509, 12427.75144497114, 12436.0, 12449.626511204679, 12460.439280232411, 41762.582374176476, 42192.78903605493, 42219.7889010553, 42269.943251418656, 42354.364684529755, 3519.243362677011, 3679.172186258097, 3680.926381472382, 3693.242885208526, 3942.743721658083, 30858.845705771328, 32268.19329516781, 32408.0, 33063.3387332252, 33130.50304245438, 3102.2709663229125, 3183.9522407163913, 3322.371530489907, 3328.234506063595, 3332.383509050809, 474971.0, 484920.5753971243, 486631.0, 490622.0, 491729.0, 35549.0, 65423.34576654172, 66151.0, 66206.66896665486, 66252.33747662559, 35997.82001089978, 37021.62978370182, 37150.0, 37200.44199337012, 37216.255674886896, 15982.200889955688, 16140.75788863168, 16150.353985840435, 16164.676706465805, 16179.191040447931, 13582.049256551947, 13691.726165476635, 13716.65708357299, 13719.45122195101, 13724.039317247696, 7698.42261830365, 7854.136045035041, 8022.919770802334, 8253.298469630028, 8257.8348433031, 3326.3014766899223, 3367.2760356523463, 3380.2056516718553, 3381.5773028371455, 3406.0633325835593, 910.6113177404511, 945.2579724916045, 962.4177372689562, 1028.1671845804772, 1060.5174645536263, 25125.0, 30929.845350773103, 31100.377992440026, 31140.53289200664, 31526.36947261042, 1072.2065671403261, 1077.9946100269449, 1093.4532733633184, 1160.042964554246, 1208.4803534480081, 15332.846671533365, 15788.184358798655, 15810.920945395199, 15862.365505379656, 16176.75734863978, 632794.0, 659951.0, 661541.6922915354, 664562.0, 669214.6539267272, 60371.0, 60769.784604307664, 60788.0, 60808.695956520816, 60843.0, 1279.5969269680022, 1327.323065236717, 1395.6929475515574, 1422.3599380278708, 1428.357239242366, 30716.232094197825, 30757.384852303276, 31731.682683173796, 31864.044078677678, 32448.0, 51739.48260517346, 52354.738226310146, 52545.94908101893, 52575.47424525706, 52597.7370113147, 526165.0, 526369.0, 527689.0, 537446.0, 538479.0, 23506.647400288668, 26630.7336926636, 27366.452670946866, 27371.178864634094, 27834.721652783213, 45494.77252613716, 46850.76574617105, 47642.761786190844, 48345.54963351105, 48466.78833029202, 38654.6134538651, 39271.607283926794, 39987.00032499211, 40880.38679419752, 41374.75875723733, 39279.60720392874, 39356.0, 39461.40807887827, 40258.79870600745, 40618.79690601528, 37434.43848342331, 39491.22289496922, 39884.60115398925, 39960.0, 40016.0, 32182.0, 33877.0, 34565.48151777675, 34710.0, 34748.47877281792, 25797.191825906706, 25956.35109122287, 25957.870210648827, 26162.607560886983, 26460.0], "value": 19614.292317774652, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2451996228542, 386.53615661206544, 393.60835968211626, 401.9638232559069, 413.8137837972911, 19620.607587848233, 21843.453913652167, 22509.0, 22675.319740407773, 22786.88606556967, 21373.893130534365, 21887.452813679665, 21991.670124948098, 22098.33704988849, 22124.564025909316, 5632.436756324376, 6109.81670549882, 6166.969165154191, 6170.81487555374, 6181.320054793969, 4209.915801683965, 4229.090745489719, 4339.783010849461, 6029.939700603004, 6135.987562052278, 6399.0, 6700.3969642732145, 6741.730330786762, 6818.795436136924, 6826.317368263183, 6508.153939987795, 6742.595444273359, 6787.287334829821, 6793.0, 6794.320567943216, 5835.970820145914, 5843.883122337529, 5944.762209511614, 5954.285485741695, 5956.017257152608, 26352.472950540883, 26465.73534264652, 26672.733272667414, 26690.33274168142, 26844.86577567119, 2290.8625482471107, 2336.229044415356, 2378.6669866218745, 2535.2014115553725, 3052.722060189894, 16306.83693163065, 16427.83572164275, 16568.254428550623, 16701.91437556555, 16759.329626814913, 1850.9629807403912, 1872.26981477224, 1926.4991102313359, 1933.0914470198984, 1955.0908827395187, 117875.99999999914, 118002.0, 124055.3797231008, 125639.0, 125973.0, 11641.010514106396, 11656.475458604213, 11966.880331196751, 11968.281903085843, 12016.218945768496, 15215.847841521443, 15238.0, 15253.237338133049, 15267.007644503294, 15276.46532371384, 7401.8149546261775, 8813.867791983126, 8945.821083578292, 9038.367314288069, 9091.681791137411, 8941.731748047569, 8946.913314906347, 8955.910440895637, 8961.103889610988, 9133.908660913306, 4644.698094623838, 4653.930191047137, 4671.135839869635, 4675.602573781267, 4744.430668319824, 1822.4441545328536, 1844.4045900296146, 1859.3585213101458, 1936.845052395805, 1968.8424926005885, 912.5209265135857, 914.766734482716, 944.0889541592396, 990.3315262198131, 1028.5885645741764, 19862.304819331253, 20750.896245518677, 21742.673859892115, 22437.88781056117, 22785.772142278696, 940.4780346907395, 942.6653537993914, 945.9810803783886, 974.449436068619, 1042.7914417116608, 11035.941647209002, 11725.648230553097, 11840.88159118415, 11871.821922671166, 11874.0, 541194.2940285273, 561541.0, 569741.0, 570530.0, 576978.0, 105045.0, 127055.0, 129802.0, 135148.0, 137199.6280037207, 971.5385192033868, 983.2674657380154, 1008.5310330696261, 1009.4296722351847, 1010.3735683876043, 16212.0, 18935.33726319572, 19657.508562286057, 19711.901440492707, 19724.60550789005, 55479.445205547425, 55861.16208256961, 57164.0, 57757.0, 58090.0, 78973.60513197628, 80956.19043809487, 82812.0, 83118.16881831347, 84333.36166510901, 8148.144444833444, 8171.101178870438, 8194.262516373317, 8467.449615774955, 8606.870896936676, 9336.06639336061, 12842.67893302675, 13385.598432047054, 13585.592432226653, 14311.713765724835, 11764.764704705687, 11785.528578856749, 12084.093692972887, 12200.267983920992, 12325.0, 9172.724818255463, 9384.812303754023, 11595.420228988349, 11612.0, 11901.464434100659, 11999.820002699791, 12082.214656047328, 12106.576269830513, 12281.38593070325, 12285.017198624268, 8207.876881846896, 8432.5783710813, 8493.10822363643, 8688.174623410765, 8754.0, 9728.562214700214, 11760.235584686969, 11773.88226117728, 11852.051835853283, 12043.75912481728], "value": 10034.35538098473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.334902572253, 1466.142306750551, 1555.416718730476, 1726.6891959447294, 1893.1859300500787, 8090.352771778258, 8632.913670863289, 8967.46195228286, 9153.359264851446, 9167.862482062774, 8963.551822408886, 9059.275257979361, 9078.22835059019, 9082.318826088036, 9105.0, 2171.8588291761066, 2356.6229403295474, 2427.9878600607017, 2464.864432456214, 2466.0135945621714, 2386.6181410974245, 2420.177139772477, 2420.8668523231217, 2422.1280339077916, 2424.357545250501, 2392.2464423706565, 2406.1578447543393, 2410.770976757205, 2433.4038160650666, 2437.122635851092, 2383.320753585237, 2403.9519209615796, 2410.867402292882, 2413.4328432818274, 2425.211806163004, 2379.9881000594887, 2394.772496612819, 2397.736249012607, 2406.193925035098, 2406.482606239649, 8976.8653470198, 9068.274538036942, 9134.725958221265, 9215.677451289239, 9218.953905230497, 5407.270018547485, 5558.333000040021, 5565.1374037024325, 5653.010723123437, 5653.745581448845, 3123.8125712457327, 3618.764780289273, 3644.6902013328636, 3716.0709822544363, 3849.364854798983, 995.66147509847, 1092.2354351953663, 1097.2483848563759, 1113.2151832957745, 1115.754534002518, 12172.513099476011, 12194.512219511209, 12281.877181228252, 12293.69265768354, 12308.692282692915, 4120.793960301973, 4412.580804823537, 4671.789769460314, 4784.6889952153, 4791.089692958327, 9572.664956726481, 9579.521023948775, 9584.712458626253, 9590.472524011246, 9602.0, 5431.375391829911, 5438.592105592017, 5439.945600544023, 5442.945570544244, 5449.809256675997, 3773.6792372648633, 4560.475545312265, 4691.765411729468, 4918.778654960535, 5122.718250496184, 3878.6703130234246, 3881.5536213335827, 4013.0368711509027, 4017.13631569214, 4023.657989070903, 1166.6292106774506, 1193.2601786892183, 1195.0320240604965, 1205.4394706461537, 1206.6862615719976, 876.8816209811721, 882.4259268450072, 889.3285569395065, 891.7146513115871, 893.097971049232, 5480.123180291134, 5562.137868630369, 5675.1487276907965, 5756.884862302731, 5821.7380217890295, 442.60165850733955, 452.46834968912054, 457.5287453922465, 470.4378267969743, 471.24365393543553, 3728.7762734236035, 3816.2749077675153, 3831.3869780834934, 3861.9034524137123, 3918.7648741075627, 10669.519871605797, 10892.292001019909, 11253.71865703364, 11279.097672186206, 11288.492017859217, 10956.506957186946, 11098.2786118902, 11099.83350249747, 11105.888941110647, 11112.499937502831, 8320.70877519284, 8436.704715334934, 8442.113578074213, 8536.44513106646, 8543.786405339917, 5624.493795558419, 5718.25662663851, 5918.526517878473, 5937.881242375042, 6035.818925432244, 10069.647562335284, 10240.385576865412, 10439.947800261254, 10455.581776728846, 10462.529186186488, 8705.782355441164, 10051.798964020532, 10316.948415257875, 10702.73243168927, 10762.73093172677, 7008.614526200904, 7173.0316407284345, 7522.3605993491165, 7692.0, 7703.614819258903, 8436.156384361515, 8609.87085193735, 8738.563071846509, 8740.650373984969, 8903.19871211594, 7875.173106823701, 8009.719659811879, 8123.309518690741, 8133.715319963773, 8220.383471239562, 7234.457415693739, 7269.672864721206, 7717.0, 7928.365730741411, 8029.07665618438, 7148.785536433916, 7294.379977701955, 7299.5255308404785, 7305.634718264172, 7306.853862922818, 4971.875703107451, 5035.773390197523, 5064.366954130734, 5151.25306830515, 5292.153255479105, 5076.162433198481, 5106.63207345931, 5231.084560202025, 5317.20241963693, 5343.4122246553625], "value": 4565.85934747564, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.4250522670685, 304.4215989619721, 311.19245557777566, 316.94136584731825, 321.1473537757254, 5425.511703946644, 5430.75561599728, 5432.266644003058, 5449.264349312842, 5475.616706830523, 4798.448178459478, 5289.523942845143, 5376.596755243353, 5376.983631138323, 5414.269073675053, 3951.427043078752, 4114.120115918869, 4116.917661646765, 4125.040605712293, 4126.546079931205, 3530.1593278576593, 4104.363823607331, 4154.563770804068, 4159.105792254664, 4182.247195504808, 3523.925202813141, 3985.6612187963915, 4086.8773936781945, 4088.4480595119726, 4125.0, 4083.612056854594, 4096.283150448689, 4109.424680544711, 4121.567235440266, 4129.224433493597, 2936.8678409471413, 3583.4803953426867, 3594.077168714725, 3598.9100272493133, 3604.333198358312, 5149.0474262261605, 5191.610629202825, 5192.324997750268, 5289.677580604849, 5293.100172970604, 3902.4341470486906, 3909.198614284065, 4634.884127896796, 4721.763911804396, 4731.243001119804, 4731.739754313511, 4937.407511098691, 5568.719194585227, 5702.8289151325525, 5723.370429252779, 3862.5364956205153, 3940.5074365704286, 3942.7634341939574, 3944.1914407546383, 3953.8418463261437, 4918.655694101414, 5622.662640241599, 5720.456556627156, 5873.676947767828, 5971.373005834368, 3846.9615303847163, 3943.7042221833476, 3948.545917219499, 3963.564007959122, 3970.960290397059, 3739.102615372291, 3817.8854634361014, 4038.7172897897453, 4043.696722745747, 4047.2714911316248, 4503.842365517191, 4601.953980460219, 4647.6281897448125, 4656.579743178296, 4684.814326258109, 4962.154330393973, 5019.669787506314, 5028.396592408934, 5537.6954267515675, 5700.800471983461, 1135.4776802670865, 1298.5455090718174, 1369.3221855181748, 1369.9589012329645, 1375.9587212383644, 663.8681048811861, 822.6873787960536, 837.969297763754, 842.4103127810434, 843.1989609870648, 4258.936115958263, 4335.934960975588, 4343.978280108642, 4498.5501449854755, 4539.773011349419, 3946.908138686501, 4353.888364143388, 4367.58507941745, 4939.641598560424, 4957.182064959314, 3818.694504439638, 4180.770057646798, 4500.504944456173, 4518.909621807546, 4547.476150736307, 2142.3144593729858, 2352.5768458487787, 2361.3860396297086, 2456.385903524119, 2589.741025897433, 5086.54221120101, 5096.889838675102, 5097.6941383517105, 5109.948900511022, 5119.820806271762, 3969.226000929849, 4231.851885184004, 4616.399868017136, 4799.712017278975, 4992.525710057539, 4223.083329593036, 4500.954990450054, 4744.644151688637, 5104.744762761773, 5111.923321150186, 4538.205813982474, 4849.060375849547, 4893.657443978887, 4947.45577986414, 4966.950330496648, 4292.484901811803, 4815.951840481691, 4856.757162141949, 4866.732329721899, 4869.415670119467, 5050.74746262678, 5573.191887176417, 5699.23060386859, 5936.78295949338, 6234.532410069353, 3262.7552933530555, 3414.300068485905, 4007.318755811461, 4035.858744943913, 4052.5542190359624, 5875.911861321998, 5956.910646340221, 5964.671943043174, 5999.070144127667, 6014.548908831943, 4997.375328083989, 5329.960657671717, 5363.651362661414, 5500.944990550043, 5788.942110578841, 5785.797497087582, 5794.101914203306, 5795.971410006464, 5832.24180856486, 5860.94139058621, 4751.714897106184, 5256.737163141751, 5387.622866399314, 5759.193712880116, 5800.24596802413, 5113.028524580318, 5436.55931178246, 5838.532917366516, 5847.8245652630485, 5851.473367396955, 5288.550473209821, 5738.254026976467, 5738.704518192756, 5750.30996280449, 5767.250257466502], "value": 3951.1517113561176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.8891377379621, 745.2733584754865, 790.7074382478484, 820.2822530285999, 826.3141592478244, 15909.761353579692, 16636.91681541592, 16648.50054498364, 16656.16719164043, 16682.749758753627, 15201.771973420407, 15271.0, 15293.311800968955, 15304.923475382635, 15313.846861531381, 709.8757717399434, 733.3070248615061, 734.6730704836323, 867.4751775176006, 867.5662168915542, 727.6434547071923, 882.355880207449, 895.5387975192781, 896.1486587741639, 897.2463130969984, 805.9758207253792, 953.0374321934861, 958.8082383523289, 958.9328746987713, 959.0984474593894, 944.9196818270456, 945.4421891084259, 948.5067764762354, 949.188443880486, 949.5252373813094, 702.0907924238073, 705.3123204875257, 706.3254591864757, 707.3068392974914, 707.9044329015569, 15893.523194304189, 15981.0, 16145.596360090974, 16148.515544533682, 16149.838501615068, 12792.761266778369, 14348.856511434857, 15129.092254464767, 15161.924428647984, 15278.802256733301, 10054.648087316982, 11878.049756019498, 12177.634670959796, 12232.755344893052, 12644.367781610974, 3862.304785138674, 3931.5871833457645, 3944.3689009758587, 4003.0, 4028.67770578353, 119671.0, 119742.0, 122535.38732306281, 123163.0, 125390.0, 11516.712082198012, 11602.129840262014, 11752.58865939688, 11760.000399965927, 11960.58137965167, 24284.757152428603, 24700.752992470203, 24741.87629061843, 24755.504889902462, 24796.876015619808, 7943.364530837519, 7966.920330796734, 8044.557549334842, 8237.711680091168, 8323.750287491384, 4347.130573885235, 4515.9548404515535, 4530.524294949048, 4560.68075234737, 4752.168370535212, 3725.683316918038, 3843.461915331856, 3848.7690738555775, 3853.9807300963316, 3858.2476417098956, 614.118739608663, 641.7978336823885, 655.8491546944134, 670.276101810044, 675.8546912413855, 597.3876776304323, 682.8804959132232, 687.4259992905979, 696.3210869402292, 720.6828995242076, 7830.804229894185, 9241.260699144052, 9377.531123443801, 9480.857787133198, 9749.415035097916, 633.2559242889587, 681.8227260912198, 704.594857956677, 706.8444942112727, 716.9103862017248, 4858.44127925286, 4878.146324393217, 4886.975565122223, 4905.730184839868, 4922.384701912261, 124676.0, 150101.0, 150292.24853875878, 154362.22818885834, 158854.0, 120837.18744218844, 133470.0, 137394.3130284342, 142689.0, 148860.0, 122344.38827805805, 122403.0, 125808.37095814645, 127001.3649931726, 128478.35760821323, 8933.776655583662, 9441.669541566012, 9445.716628501155, 9554.904450955402, 9587.808243835223, 66728.33271667415, 66896.0, 67230.66384668241, 68020.3197968014, 69175.61648767097, 48339.75830120827, 59912.0, 96067.51966240125, 101963.98036019545, 106281.02892283264, 11467.311961282016, 12433.12968092225, 12464.376781160725, 12495.25028498293, 12651.114421990373, 10638.14894808429, 13207.735845283232, 13277.867221327662, 13401.0, 14364.0, 10243.795124097327, 10779.353238805697, 11304.717382065513, 11587.073034157416, 11729.589464368706, 12324.50701971947, 12698.839583644456, 12943.676408089497, 13090.607281781562, 13214.207147571176, 10545.36727796304, 11244.606438774603, 11364.261323013978, 11666.300021998708, 11923.523059077539, 9300.581473833558, 11022.944885275523, 11233.66299011031, 11367.147463940073, 11609.941950290195, 10918.399488028235, 10942.562297508011, 11121.610743623934, 11157.442127893735, 11189.328640281608], "value": 7942.64123330691, "unit": "score"}], "name": "dromaeo_css", "value": 7385.515685595394, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 111.0, 112.0, 111.0, 111.0, 113.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 105.0, 140.0, 116.0, 138.0, 140.0, 110.0, 139.0, 131.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 182.0, 183.0, 181.0, 181.0, 183.0, 181.0, 180.0, 183.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 87.0, 62.0, 58.0, 58.0, 61.0, 99.0, 82.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 94.0, 69.0, 68.0, 68.0, 94.0, 67.0, 68.0, 90.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 85.0, 89.0, 116.0, 132.0, 128.0, 92.0, 86.0], "value": 99.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 119.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 109.0, 150.0], "value": 103.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 85.0, 86.0, 84.0, 84.0, 86.0, 84.0, 87.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 52.0, 56.0, 57.0, 59.0, 55.0, 57.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 74.0, 74.0, 71.0, 71.0, 78.0, 98.0, 98.0, 93.0, 71.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 83.0, 88.0, 86.0, 99.0, 84.0, 82.0, 85.0, 80.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 135.0, 131.0, 135.0, 139.0, 142.0, 199.0, 144.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 159.0, 159.0, 159.0, 160.0, 161.0, 161.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 67.0, 62.0, 84.0, 64.0, 65.0, 64.0, 65.0, 68.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1450.0, "alertThreshold": 2.0}]} 10:05:45 INFO - Return code: 0 10:05:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:05:45 INFO - # TBPL SUCCESS # 10:05:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:05:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:05:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:05:45 INFO - 2016-12-22 10:05:45.422 screenresolution[1656:9621] starting screenresolution argv=screenresolution get 10:05:45 INFO - 2016-12-22 10:05:45.425 screenresolution[1656:9621] Display 0: 1600x1200x32@60 10:05:45 INFO - 2016-12-22 10:05:45.431 screenresolution[1657:9624] starting screenresolution argv=screenresolution list 10:05:45 INFO - Available Modes on Display 0 10:05:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:05:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:05:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:05:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:05:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:05:45 INFO - Intel Iris: 10:05:45 INFO - Chipset Model: Intel Iris 10:05:45 INFO - Type: GPU 10:05:45 INFO - Bus: Built-In 10:05:45 INFO - VRAM (Dynamic, Max): 1536 MB 10:05:45 INFO - Vendor: Intel (0x8086) 10:05:45 INFO - Device ID: 0x0a2e 10:05:45 INFO - Revision ID: 0x0009 10:05:45 INFO - Displays: 10:05:45 INFO - Display: 10:05:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:05:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:05:45 INFO - Display Serial Number: 1600x1200 60 10:05:45 INFO - Main Display: Yes 10:05:45 INFO - Mirror: Off 10:05:45 INFO - Online: Yes 10:05:45 INFO - Rotation: Supported 10:05:45 INFO - Return code: 0 10:05:45 INFO - Running post-action listener: _resource_record_post_action 10:05:45 INFO - [mozharness: 2016-12-22 18:05:45.669353Z] Finished run-tests step (success) 10:05:45 INFO - Running post-run listener: _resource_record_post_run 10:05:45 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 37733376; Write bytes: 492499456; Read time: 246; Write time: 1532 10:05:45 INFO - TinderboxPrint: CPU usage
53.3% 10:05:45 INFO - TinderboxPrint: I/O read bytes / time
37,733,376 / 246 10:05:45 INFO - TinderboxPrint: I/O write bytes / time
492,499,456 / 1,532 10:05:45 INFO - TinderboxPrint: CPU idle
2,236.2 (46.7%) 10:05:45 INFO - TinderboxPrint: CPU system
957.5 (20.0%) 10:05:45 INFO - TinderboxPrint: CPU user
1,595.9 (33.3%) 10:05:45 INFO - TinderboxPrint: Swap in / out
232,902,656 / 0 10:05:45 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 190296576; Write bytes: 185761792; Read time: 17835; Write time: 390 10:05:45 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35841024; Write bytes: 295780864; Read time: 228; Write time: 1111 10:05:46 INFO - Running post-run listener: _upload_blobber_files 10:05:46 INFO - Blob upload gear active. 10:05:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:05:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:05:46 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:05:46 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:05:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:05:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:47 INFO - (blobuploader) - INFO - Done attempting. 10:05:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:05:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:48 INFO - (blobuploader) - INFO - Done attempting. 10:05:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:05:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:05:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:05:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:05:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:05:51 INFO - (blobuploader) - INFO - Done attempting. 10:05:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:05:51 INFO - Return code: 0 10:05:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:05:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:05:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b0cecf66a375e15da140d01b002220c6e2b15cf2cf5a496a54de1f9483274e8dcbd3458bcd1c77f84aca5d6dc25010d7a01f21500e43e0850cfc6deca3ff851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c5ab6905174bc2d94d29b66237dab5080307c4eca401c0d007899088dad3575a820a1747f30c3a195c262b0f08263b7de7cfe9227cc64d1f929454f5e2ec40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bd9f5b433d34004a189185cdfd4493896f7b4f0c08389e83564c6553936aa1fe99d9036c1f5c518667d27152b98b101a933c16d3cf984f2522ced6746519dc0"} 10:05:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:05:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:05:51 INFO - Contents: 10:05:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b0cecf66a375e15da140d01b002220c6e2b15cf2cf5a496a54de1f9483274e8dcbd3458bcd1c77f84aca5d6dc25010d7a01f21500e43e0850cfc6deca3ff851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c5ab6905174bc2d94d29b66237dab5080307c4eca401c0d007899088dad3575a820a1747f30c3a195c262b0f08263b7de7cfe9227cc64d1f929454f5e2ec40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bd9f5b433d34004a189185cdfd4493896f7b4f0c08389e83564c6553936aa1fe99d9036c1f5c518667d27152b98b101a933c16d3cf984f2522ced6746519dc0"} 10:05:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:05:51 INFO - Copying logs to upload dir... 10:05:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:05:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.522867 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-12-22 10:05:51.954410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:05:51.958652) ========= 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.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-Beta/sha512/4b0cecf66a375e15da140d01b002220c6e2b15cf2cf5a496a54de1f9483274e8dcbd3458bcd1c77f84aca5d6dc25010d7a01f21500e43e0850cfc6deca3ff851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c5ab6905174bc2d94d29b66237dab5080307c4eca401c0d007899088dad3575a820a1747f30c3a195c262b0f08263b7de7cfe9227cc64d1f929454f5e2ec40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bd9f5b433d34004a189185cdfd4493896f7b4f0c08389e83564c6553936aa1fe99d9036c1f5c518667d27152b98b101a933c16d3cf984f2522ced6746519dc0"} build_url:https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010985 build_url: 'https://queue.taskcluster.net/v1/task/Ar-Lrw8XQ76VwvJYJuTTFA/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b0cecf66a375e15da140d01b002220c6e2b15cf2cf5a496a54de1f9483274e8dcbd3458bcd1c77f84aca5d6dc25010d7a01f21500e43e0850cfc6deca3ff851", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/71c5ab6905174bc2d94d29b66237dab5080307c4eca401c0d007899088dad3575a820a1747f30c3a195c262b0f08263b7de7cfe9227cc64d1f929454f5e2ec40", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2bd9f5b433d34004a189185cdfd4493896f7b4f0c08389e83564c6553936aa1fe99d9036c1f5c518667d27152b98b101a933c16d3cf984f2522ced6746519dc0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 10:05:51.994432) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:05:51.994762) ========= 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.juB8h18Gfu/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.Vvjjd29TAU/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.004964 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 10:05:52.042717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:05:52.043009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 10:05:52.043325) ========= ========= Total master_lag: 0.20 =========