builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1488622363.9 results: success (0) buildid: 20170304004003 builduid: 908ec1f2444a41d5bf72d90feaa9a2d0 revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:43.897234) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:43.898091) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:43.898383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:43.925858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 02:12:43.926272) ========= 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.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-04 02:12:43-- 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% 18.0M=0.001s 2017-03-04 02:12:45 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.106392 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 02:12:45.113173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:45.113465) ========= 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.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.025669 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:45.177486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-04 02:12:45.177857) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e11b1a808700d7428c6ce94ca22921ae000424c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-04 02:12:45,283 truncating revision to first 12 chars 2017-03-04 02:12:45,283 Setting DEBUG logging. 2017-03-04 02:12:45,283 attempt 1/10 2017-03-04 02:12:45,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e11b1a808700?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-04 02:12:48,146 unpacking tar archive at: mozilla-aurora-e11b1a808700/testing/mozharness/ program finished with exit code 0 elapsedTime=3.142413 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-04 02:12:48.343767) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.344099) ========= script_repo_revision: e11b1a808700d7428c6ce94ca22921ae000424c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.344491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.344817) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 02:12:48.365488) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-03-04 02:12:48.366102) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:12:48 INFO - MultiFileLogger online at 20170304 02:12:48 in /builds/slave/test 02:12:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:12:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:12:48 INFO - {'append_to_log': False, 02:12:48 INFO - 'base_work_dir': '/builds/slave/test', 02:12:48 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:12:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:12:48 INFO - 'branch': 'Mozilla-Aurora', 02:12:48 INFO - 'buildbot_json_path': 'buildprops.json', 02:12:48 INFO - 'config_files': ('talos/mac_config.py',), 02:12:48 INFO - 'default_actions': ('clobber', 02:12:48 INFO - 'read-buildbot-config', 02:12:48 INFO - 'download-and-extract', 02:12:48 INFO - 'populate-webroot', 02:12:48 INFO - 'create-virtualenv', 02:12:48 INFO - 'install', 02:12:48 INFO - 'run-tests'), 02:12:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:12:48 INFO - 'download_minidump_stackwalk': True, 02:12:48 INFO - 'download_symbols': 'ondemand', 02:12:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:12:48 INFO - 'tooltool.py': '/tools/tooltool.py', 02:12:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:12:48 INFO - '/tools/misc-python/virtualenv.py')}, 02:12:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:12:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:12:48 INFO - 'installer_path': 'installer.exe', 02:12:48 INFO - 'log_level': 'info', 02:12:48 INFO - 'log_name': 'talos', 02:12:48 INFO - 'log_to_console': True, 02:12:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:12:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:12:48 INFO - 'opt_config_files': (), 02:12:48 INFO - 'pip_index': False, 02:12:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:48 INFO - 'cmd': ('bash', 02:12:48 INFO - '-c', 02:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:48 INFO - 'enabled': True, 02:12:48 INFO - 'halt_on_failure': False, 02:12:48 INFO - 'name': 'check_screen_resolution'},), 02:12:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:12:48 INFO - 'cmd': ('bash', 02:12:48 INFO - '-c', 02:12:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:12:48 INFO - 'enabled': True, 02:12:48 INFO - 'halt_on_failure': False, 02:12:48 INFO - 'name': 'check_screen_resolution'},), 02:12:48 INFO - 'run_cmd_checks_enabled': True, 02:12:48 INFO - 'sps_profile': False, 02:12:48 INFO - 'sps_profile_interval': 0, 02:12:48 INFO - 'suite': 'dromaeojs', 02:12:48 INFO - 'system_bits': '32', 02:12:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:12:48 INFO - 'title': 't-yosemite-r7-0286', 02:12:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:12:48 INFO - 'use_talos_json': True, 02:12:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:12:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:12:48 INFO - 'work_dir': 'build'} 02:12:48 INFO - [mozharness: 2017-03-04 10:12:48.575481Z] Running clobber step. 02:12:48 INFO - Running pre-action listener: _resource_record_pre_action 02:12:48 INFO - Running main action method: clobber 02:12:48 INFO - rmtree: /builds/slave/test/build 02:12:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:12:51 INFO - Running post-action listener: _resource_record_post_action 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.121585Z] Finished clobber step (success) 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.121707Z] Running read-buildbot-config step. 02:12:51 INFO - Running pre-action listener: _resource_record_pre_action 02:12:51 INFO - Running main action method: read_buildbot_config 02:12:51 INFO - Using buildbot properties: 02:12:51 INFO - { 02:12:51 INFO - "project": "", 02:12:51 INFO - "product": "firefox", 02:12:51 INFO - "script_repo_revision": "production", 02:12:51 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:12:51 INFO - "repository": "", 02:12:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:12:51 INFO - "buildid": "20170304004003", 02:12:51 INFO - "stage_platform": "macosx64", 02:12:51 INFO - "basedir": "/builds/slave/test", 02:12:51 INFO - "nightly_build": "True", 02:12:51 INFO - "buildnumber": 48, 02:12:51 INFO - "slavename": "t-yosemite-r7-0286", 02:12:51 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:12:51 INFO - "platform": "yosemite_r7", 02:12:51 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:12:51 INFO - "branch": "mozilla-aurora", 02:12:51 INFO - "repo_path": "releases/mozilla-aurora", 02:12:51 INFO - "revision": "e11b1a808700d7428c6ce94ca22921ae000424c1", 02:12:51 INFO - "pgo_build": "False", 02:12:51 INFO - "builduid": "908ec1f2444a41d5bf72d90feaa9a2d0", 02:12:51 INFO - "slavebuilddir": "test" 02:12:51 INFO - } 02:12:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:12:51 INFO - Running post-action listener: _resource_record_post_action 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.125282Z] Finished read-buildbot-config step (success) 02:12:51 INFO - [mozharness: 2017-03-04 10:12:51.125426Z] Running download-and-extract step. 02:12:51 INFO - Running pre-action listener: _resource_record_pre_action 02:12:51 INFO - Running main action method: download_and_extract 02:12:51 INFO - mkdir: /builds/slave/test/build/tests 02:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:51 INFO - trying https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:12:53 INFO - Downloaded 1199 bytes. 02:12:53 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:12:53 INFO - Using the following test package requirements: 02:12:53 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:12:53 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:12:53 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:12:53 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'jsshell-mac.zip'], 02:12:53 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:12:53 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:12:53 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:12:53 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:12:53 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:12:53 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:12:53 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:12:53 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:12:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:12:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:12:53 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:12:54 INFO - Expected file size: 16357897 02:12:54 INFO - Obtained file size: 16357897 02:13:01 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:13:02 INFO - Expected file size: 16357897 02:13:02 INFO - Obtained file size: 16357897 02:13:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:13:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:13:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:13:10 INFO - Expected file size: 14403650 02:13:10 INFO - Obtained file size: 14403650 02:13: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')]} 02:13:10 INFO - trying https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:13:10 INFO - Downloading https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:13:13 INFO - Downloaded 74004951 bytes. 02:13:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:13:13 INFO - mkdir: /builds/slave/test/properties 02:13:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:13:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:13:13 INFO - Contents: 02:13:13 INFO - build_url:https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:13:14 INFO - Running post-action listener: _resource_record_post_action 02:13:14 INFO - Running post-action listener: set_extra_try_arguments 02:13:14 INFO - [mozharness: 2017-03-04 10:13:14.585411Z] Finished download-and-extract step (success) 02:13:14 INFO - [mozharness: 2017-03-04 10:13:14.585553Z] Running populate-webroot step. 02:13:14 INFO - Running pre-action listener: _resource_record_pre_action 02:13:14 INFO - Running main action method: populate_webroot 02:13:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:13:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:13:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:13:14 INFO - '--tppagecycles', 02:13:14 INFO - '7'], 02:13:14 INFO - 'tests': ['tsvgm']}}, 02:13:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:13:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:13:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:13:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:13:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:13:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['damp', 'tps']}, 02:13:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'tests': ['damp', 'tps']}, 02:13:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['dromaeo_dom']}, 02:13:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:13:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['basic_compositor_video']}, 02:13:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:13:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['a11yr', 02:13:14 INFO - 'ts_paint', 02:13:14 INFO - 'tpaint', 02:13:14 INFO - 'sessionrestore', 02:13:14 INFO - 'sessionrestore_no_auto_restore', 02:13:14 INFO - 'tabpaint']}, 02:13:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['tsvgx', 02:13:14 INFO - 'tsvgr_opacity', 02:13:14 INFO - 'tart', 02:13:14 INFO - 'tscrollx', 02:13:14 INFO - 'cart', 02:13:14 INFO - 'tsvg_static']}, 02:13:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:13:14 INFO - 'tsvgr_opacity', 02:13:14 INFO - 'tart', 02:13:14 INFO - 'tscrollx', 02:13:14 INFO - 'cart', 02:13:14 INFO - 'tsvg_static']}, 02:13:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'talos_options': ['--disable-e10s'], 02:13:14 INFO - 'tests': ['tp5o']}, 02:13:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:13:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'talos_options': ['--disable-e10s', 02:13:14 INFO - '--xperf_path', 02:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:14 INFO - 'tests': ['tp5n']}, 02:13:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:13:14 INFO - 'talos_options': ['--xperf_path', 02:13:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:13:14 INFO - 'tests': ['tp5n']}}, 02:13:14 INFO - 'talos.zip': {'path': '', 02:13:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:13:14 INFO - Running post-action listener: _resource_record_post_action 02:13:14 INFO - [mozharness: 2017-03-04 10:13:14.603766Z] Finished populate-webroot step (success) 02:13:14 INFO - [mozharness: 2017-03-04 10:13:14.603902Z] Running create-virtualenv step. 02:13:14 INFO - Running pre-action listener: _resource_record_pre_action 02:13:14 INFO - Running main action method: create_virtualenv 02:13:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:13:14 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 02:13:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:13:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:13:14 INFO - Using real prefix '/tools/python27' 02:13:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:13:18 INFO - Installing pip.................done. 02:13:18 INFO - Return code: 0 02:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:13:18 INFO - Reading from file tmpfile_stdout 02:13:18 INFO - Output received: 02:13:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:13:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:13:18 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')]} 02:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:18 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')]} 02:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13: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 02:13: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 02:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:19 INFO - 'HOME': '/Users/cltbld', 02:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PAGER': '/bin/cat', 02:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test', 02:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:19 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - 'XPC_FLAGS': '0x0', 02:13:19 INFO - 'XPC_SERVICE_NAME': '0', 02:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:19 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 02:13:19 INFO - Cleaning up... 02:13:19 INFO - Return code: 0 02:13:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:13: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')]} 02:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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')]} 02:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13: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', '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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:13: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 psutil>=3.1.1 02:13:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:19 INFO - 'HOME': '/Users/cltbld', 02:13:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:19 INFO - 'LOGNAME': 'cltbld', 02:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:19 INFO - 'MOZ_NO_REMOTE': '1', 02:13:19 INFO - 'NO_EM_RESTART': '1', 02:13:19 INFO - 'PAGER': '/bin/cat', 02:13:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:19 INFO - 'PWD': '/builds/slave/test', 02:13:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:19 INFO - 'SHELL': '/bin/bash', 02:13:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:19 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:19 INFO - 'USER': 'cltbld', 02:13:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:19 INFO - 'XPC_FLAGS': '0x0', 02:13:19 INFO - 'XPC_SERVICE_NAME': '0', 02:13:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:19 INFO - Downloading/unpacking psutil>=3.1.1 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:19 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 02:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:25 INFO - Installing collected packages: psutil 02:13:25 INFO - Running setup.py install for psutil 02:13:25 INFO - building 'psutil._psutil_osx' extension 02:13:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:13:26 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 02:13:26 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 02:13:26 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 02:13:26 INFO - building 'psutil._psutil_posix' extension 02:13:26 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 02:13:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:13:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:13:26 INFO - ^ 02:13:26 INFO - 1 warning generated. 02:13:26 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 02:13:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:13:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:13:26 INFO - Successfully installed psutil 02:13:26 INFO - Cleaning up... 02:13:26 INFO - Return code: 0 02:13:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:13:26 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')]} 02:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:26 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')]} 02:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:26 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:26 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 02:13:26 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 02:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:26 INFO - 'HOME': '/Users/cltbld', 02:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:26 INFO - 'LOGNAME': 'cltbld', 02:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:26 INFO - 'MOZ_NO_REMOTE': '1', 02:13:26 INFO - 'NO_EM_RESTART': '1', 02:13:26 INFO - 'PAGER': '/bin/cat', 02:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:26 INFO - 'PWD': '/builds/slave/test', 02:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:26 INFO - 'SHELL': '/bin/bash', 02:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:26 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:26 INFO - 'USER': 'cltbld', 02:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:26 INFO - 'XPC_FLAGS': '0x0', 02:13:26 INFO - 'XPC_SERVICE_NAME': '0', 02:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:13:33 INFO - Installing collected packages: mozsystemmonitor 02:13:33 INFO - Running setup.py install for mozsystemmonitor 02:13:33 INFO - Successfully installed mozsystemmonitor 02:13:33 INFO - Cleaning up... 02:13:33 INFO - Return code: 0 02:13:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:13:33 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')]} 02:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:33 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')]} 02:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:33 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:33 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 02:13:33 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 02:13:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:33 INFO - 'HOME': '/Users/cltbld', 02:13:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:33 INFO - 'LOGNAME': 'cltbld', 02:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:33 INFO - 'MOZ_NO_REMOTE': '1', 02:13:33 INFO - 'NO_EM_RESTART': '1', 02:13:33 INFO - 'PAGER': '/bin/cat', 02:13:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:33 INFO - 'PWD': '/builds/slave/test', 02:13:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:33 INFO - 'SHELL': '/bin/bash', 02:13:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:33 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:33 INFO - 'USER': 'cltbld', 02:13:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:33 INFO - 'XPC_FLAGS': '0x0', 02:13:33 INFO - 'XPC_SERVICE_NAME': '0', 02:13:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:13:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:13:37 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 02:13:37 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 02:13:37 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 02:13:37 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 02:13:37 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 02:13:37 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 02:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:13:38 INFO - warning: no files found matching '*.txt' 02:13:38 INFO - no previously-included directories found matching 'build' 02:13:38 INFO - no previously-included directories found matching 'dist' 02:13:38 INFO - no previously-included directories found matching '.git*' 02:13:38 INFO - Installing collected packages: jsonschema, functools32 02:13:38 INFO - Running setup.py install for functools32 02:13:38 INFO - warning: no files found matching '*.txt' 02:13:38 INFO - no previously-included directories found matching 'build' 02:13:38 INFO - no previously-included directories found matching 'dist' 02:13:38 INFO - no previously-included directories found matching '.git*' 02:13:38 INFO - Successfully installed jsonschema functools32 02:13:38 INFO - Cleaning up... 02:13:38 INFO - Return code: 0 02:13:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:38 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 02:13:38 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 02:13:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:38 INFO - 'HOME': '/Users/cltbld', 02:13:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:38 INFO - 'LOGNAME': 'cltbld', 02:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:38 INFO - 'MOZ_NO_REMOTE': '1', 02:13:38 INFO - 'NO_EM_RESTART': '1', 02:13:38 INFO - 'PAGER': '/bin/cat', 02:13:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:38 INFO - 'PWD': '/builds/slave/test', 02:13:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:38 INFO - 'SHELL': '/bin/bash', 02:13:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:38 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:38 INFO - 'USER': 'cltbld', 02:13:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:38 INFO - 'XPC_FLAGS': '0x0', 02:13:38 INFO - 'XPC_SERVICE_NAME': '0', 02:13:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:13:38 INFO - Cleaning up... 02:13:38 INFO - Return code: 0 02:13:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:38 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:38 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 02:13:38 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 02:13:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:38 INFO - 'HOME': '/Users/cltbld', 02:13:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:38 INFO - 'LOGNAME': 'cltbld', 02:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:38 INFO - 'MOZ_NO_REMOTE': '1', 02:13:38 INFO - 'NO_EM_RESTART': '1', 02:13:38 INFO - 'PAGER': '/bin/cat', 02:13:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:38 INFO - 'PWD': '/builds/slave/test', 02:13:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:38 INFO - 'SHELL': '/bin/bash', 02:13:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:38 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:38 INFO - 'USER': 'cltbld', 02:13:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:38 INFO - 'XPC_FLAGS': '0x0', 02:13:38 INFO - 'XPC_SERVICE_NAME': '0', 02:13:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:42 INFO - Downloading blobuploader-1.2.4.tar.gz 02:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:13:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:13:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13: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 02:13:43 INFO - Downloading docopt-0.6.1.tar.gz 02:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:13:44 INFO - Installing collected packages: blobuploader, requests, docopt 02:13:44 INFO - Running setup.py install for blobuploader 02:13:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:13:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:13:44 INFO - Running setup.py install for requests 02:13:44 INFO - Running setup.py install for docopt 02:13:44 INFO - Successfully installed blobuploader requests docopt 02:13:44 INFO - Cleaning up... 02:13:44 INFO - Return code: 0 02:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:44 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:44 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 02:13:44 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 02:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:44 INFO - 'HOME': '/Users/cltbld', 02:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:44 INFO - 'LOGNAME': 'cltbld', 02:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:44 INFO - 'MOZ_NO_REMOTE': '1', 02:13:44 INFO - 'NO_EM_RESTART': '1', 02:13:44 INFO - 'PAGER': '/bin/cat', 02:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:44 INFO - 'PWD': '/builds/slave/test', 02:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:44 INFO - 'SHELL': '/bin/bash', 02:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:44 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:44 INFO - 'USER': 'cltbld', 02:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:44 INFO - 'XPC_FLAGS': '0x0', 02:13:44 INFO - 'XPC_SERVICE_NAME': '0', 02:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-bPP_wV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-OtewIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WAhOqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lgXtI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-7gVuns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-mIwvkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-bje4RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-FX4_BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ALn7WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-41F7aK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2fAGpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-4R54PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-L8NFxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ljTIY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-iTR0Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-AT84YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fc_pIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:13:46 INFO - Running setup.py install for manifestparser 02:13:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:13:47 INFO - Running setup.py install for mozcrash 02:13:47 INFO - Running setup.py install for mozdebug 02:13:47 INFO - Running setup.py install for mozdevice 02:13:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:13:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:13:47 INFO - Running setup.py install for mozfile 02:13:47 INFO - Running setup.py install for mozhttpd 02:13:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:13:47 INFO - Running setup.py install for mozinfo 02:13:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Running setup.py install for mozInstall 02:13:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Running setup.py install for mozleak 02:13:48 INFO - Running setup.py install for mozlog 02:13:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Running setup.py install for moznetwork 02:13:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Running setup.py install for mozprocess 02:13:48 INFO - Running setup.py install for mozprofile 02:13:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:13:48 INFO - Running setup.py install for mozrunner 02:13:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:13:49 INFO - Running setup.py install for mozscreenshot 02:13:49 INFO - Running setup.py install for moztest 02:13:49 INFO - Running setup.py install for mozversion 02:13:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:13:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:13:49 INFO - Cleaning up... 02:13:49 INFO - Return code: 0 02:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:13:49 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')]} 02:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:49 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')]} 02:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:13:49 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:13:49 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 02:13:49 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 02:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:13:49 INFO - 'HOME': '/Users/cltbld', 02:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:13:49 INFO - 'LOGNAME': 'cltbld', 02:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:49 INFO - 'MOZ_NO_REMOTE': '1', 02:13:49 INFO - 'NO_EM_RESTART': '1', 02:13:49 INFO - 'PAGER': '/bin/cat', 02:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:49 INFO - 'PWD': '/builds/slave/test', 02:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:13:49 INFO - 'SHELL': '/bin/bash', 02:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:13:49 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:13:49 INFO - 'USER': 'cltbld', 02:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:49 INFO - 'XPC_FLAGS': '0x0', 02:13:49 INFO - 'XPC_SERVICE_NAME': '0', 02:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:13:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fWXRWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:13:49 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)) 02:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:13:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-VKJhxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5qDPwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-hX6f9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CRDGmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-20laVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-LupSw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-AoB11N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-FAbV7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-MRfZzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:13:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-h3QZIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:13:50 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)) 02:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-7Rv4zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-uKnv_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:13:51 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)) 02:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-SHNQil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-dccSvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:13:51 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)) 02:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ninle6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:13:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EpIH_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:13:51 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)) 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:13:51 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)) 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:13:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:13:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:13:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:00 INFO - Downloading blessings-1.6.tar.gz 02:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:00 INFO - Installing collected packages: blessings 02:14:00 INFO - Running setup.py install for blessings 02:14:01 INFO - Successfully installed blessings 02:14:01 INFO - Cleaning up... 02:14:01 INFO - Return code: 0 02:14:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:01 INFO - Reading from file tmpfile_stdout 02:14:01 INFO - Current package versions: 02:14:01 INFO - blessings == 1.6 02:14:01 INFO - blobuploader == 1.2.4 02:14:01 INFO - docopt == 0.6.1 02:14:01 INFO - functools32 == 3.2.3-2 02:14:01 INFO - jsonschema == 2.5.1 02:14:01 INFO - manifestparser == 1.1 02:14:01 INFO - mozInstall == 1.12 02:14:01 INFO - mozcrash == 1.0 02:14:01 INFO - mozdebug == 0.1 02:14:01 INFO - mozdevice == 0.49 02:14:01 INFO - mozfile == 1.2 02:14:01 INFO - mozhttpd == 0.7 02:14:01 INFO - mozinfo == 0.9 02:14:01 INFO - mozleak == 0.1 02:14:01 INFO - mozlog == 3.4 02:14:01 INFO - moznetwork == 0.27 02:14:01 INFO - mozprocess == 0.24 02:14:01 INFO - mozprofile == 0.28 02:14:01 INFO - mozrunner == 6.13 02:14:01 INFO - mozscreenshot == 0.1 02:14:01 INFO - mozsystemmonitor == 0.3 02:14:01 INFO - moztest == 0.8 02:14:01 INFO - mozversion == 1.4 02:14:01 INFO - psutil == 3.1.1 02:14:01 INFO - requests == 1.2.3 02:14:01 INFO - wsgiref == 0.1.2 02:14:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:01 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')]} 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 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')]} 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:14:01 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 02:14:01 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 02:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:01 INFO - 'HOME': '/Users/cltbld', 02:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:01 INFO - 'LOGNAME': 'cltbld', 02:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:01 INFO - 'MOZ_NO_REMOTE': '1', 02:14:01 INFO - 'NO_EM_RESTART': '1', 02:14:01 INFO - 'PAGER': '/bin/cat', 02:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:01 INFO - 'PWD': '/builds/slave/test', 02:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:01 INFO - 'SHELL': '/bin/bash', 02:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:14:01 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:01 INFO - 'USER': 'cltbld', 02:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:01 INFO - 'XPC_FLAGS': '0x0', 02:14:01 INFO - 'XPC_SERVICE_NAME': '0', 02:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 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)) 02:14:01 INFO - Cleaning up... 02:14:01 INFO - Return code: 0 02:14:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:01 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')]} 02:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 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')]} 02:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:01 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 0x10c29bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c29e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb829588480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, '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.Rguniw8E1N/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.MEwYLDqs9G/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 02:14:01 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 02:14:01 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 02:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:01 INFO - 'HOME': '/Users/cltbld', 02:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:01 INFO - 'LOGNAME': 'cltbld', 02:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:01 INFO - 'MOZ_NO_REMOTE': '1', 02:14:01 INFO - 'NO_EM_RESTART': '1', 02:14:01 INFO - 'PAGER': '/bin/cat', 02:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:01 INFO - 'PWD': '/builds/slave/test', 02:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:01 INFO - 'SHELL': '/bin/bash', 02:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:14:01 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:01 INFO - 'USER': 'cltbld', 02:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:01 INFO - 'XPC_FLAGS': '0x0', 02:14:01 INFO - 'XPC_SERVICE_NAME': '0', 02:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:02 INFO - Cleaning up... 02:14:02 INFO - Return code: 0 02:14:02 INFO - Running post-action listener: _resource_record_post_action 02:14:02 INFO - Running post-action listener: _start_resource_monitoring 02:14:02 INFO - Starting resource monitoring. 02:14:02 INFO - [mozharness: 2017-03-04 10:14:02.061435Z] Finished create-virtualenv step (success) 02:14:02 INFO - [mozharness: 2017-03-04 10:14:02.062462Z] Running install step. 02:14:02 INFO - Running pre-action listener: _resource_record_pre_action 02:14:02 INFO - Running main action method: install 02:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:02 INFO - Reading from file tmpfile_stdout 02:14:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:02 INFO - Reading from file tmpfile_stdout 02:14:02 INFO - Output received: 02:14:02 INFO - Usage: mozinstall [options] installer 02:14:02 INFO - Options: 02:14:02 INFO - -h, --help show this help message and exit 02:14:02 INFO - -d DEST, --destination=DEST 02:14:02 INFO - Directory to install application into. [default: 02:14:02 INFO - "/builds/slave/test"] 02:14:02 INFO - --app=APP Application being installed. [default: firefox] 02:14:02 INFO - mkdir: /builds/slave/test/build/application 02:14:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:14:22 INFO - Reading from file tmpfile_stdout 02:14:22 INFO - Output received: 02:14:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:14:22 INFO - Running post-action listener: _resource_record_post_action 02:14:22 INFO - [mozharness: 2017-03-04 10:14:22.469836Z] Finished install step (success) 02:14:22 INFO - [mozharness: 2017-03-04 10:14:22.469962Z] Running run-tests step. 02:14:22 INFO - Running pre-action listener: _resource_record_pre_action 02:14:22 INFO - Running main action method: run_tests 02:14:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:14:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:14:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:14:22 INFO - 2017-03-04 02:14:22.484 screenresolution[1636:9131] starting screenresolution argv=screenresolution get 02:14:22 INFO - 2017-03-04 02:14:22.487 screenresolution[1636:9131] Display 0: 1600x1200x32@60 02:14:22 INFO - 2017-03-04 02:14:22.493 screenresolution[1637:9134] starting screenresolution argv=screenresolution list 02:14:22 INFO - Available Modes on Display 0 02:14:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:14:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:14:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:14:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:14:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:14:22 INFO - Intel Iris: 02:14:22 INFO - Chipset Model: Intel Iris 02:14:22 INFO - Type: GPU 02:14:22 INFO - Bus: Built-In 02:14:22 INFO - VRAM (Dynamic, Max): 1536 MB 02:14:22 INFO - Vendor: Intel (0x8086) 02:14:22 INFO - Device ID: 0x0a2e 02:14:22 INFO - Revision ID: 0x0009 02:14:22 INFO - Displays: 02:14:22 INFO - Display: 02:14:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:14:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:14:22 INFO - Display Serial Number: 1600x1200 60 02:14:22 INFO - Main Display: Yes 02:14:22 INFO - Mirror: Off 02:14:22 INFO - Online: Yes 02:14:22 INFO - Rotation: Supported 02:14:22 INFO - Return code: 0 02:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:22 INFO - Python 2.7.3 02:14:22 INFO - Return code: 0 02:14:22 INFO - grabbing minidump binary from tooltool 02:14:22 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')]} 02:14:22 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 0x10c079d30>, '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 0x10bfa0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:22 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 02:14:22 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 02:14:22 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 02:14:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:22 INFO - Return code: 0 02:14:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:14:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:14:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 02:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 02:14:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Rguniw8E1N/Render', 02:14:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:22 INFO - 'HOME': '/Users/cltbld', 02:14:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:22 INFO - 'LOGNAME': 'cltbld', 02:14:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:22 INFO - 'MOZ_NO_REMOTE': '1', 02:14:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:22 INFO - 'NO_EM_RESTART': '1', 02:14:22 INFO - 'PAGER': '/bin/cat', 02:14:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:22 INFO - 'PWD': '/builds/slave/test', 02:14:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:22 INFO - 'SHELL': '/bin/bash', 02:14:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MEwYLDqs9G/Listeners', 02:14:22 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:14:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:22 INFO - 'USER': 'cltbld', 02:14:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:22 INFO - 'XPC_FLAGS': '0x0', 02:14:22 INFO - 'XPC_SERVICE_NAME': '0', 02:14:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 02:14:23 INFO - mozversion application_buildid: 20170304004003 02:14:23 INFO - mozversion application_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 02:14:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:14:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:23 INFO - mozversion application_name: Firefox 02:14:23 INFO - mozversion application_remotingname: firefox-dev 02:14:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:23 INFO - mozversion application_vendor: Mozilla 02:14:23 INFO - mozversion application_version: 53.0a2 02:14:23 INFO - mozversion platform_buildid: 20170304004003 02:14:23 INFO - mozversion platform_changeset: e11b1a808700d7428c6ce94ca22921ae000424c1 02:14:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:23 INFO - mozversion platform_version: 53.0a2 02:14:23 INFO - using testdate: 1488622463 02:14:23 INFO - actual date: 1488622463 02:14:23 INFO - starting webserver on 'localhost:49244' 02:14:23 INFO - SUITE-START | Running 2 tests 02:14:23 INFO - TEST-START | dromaeo_css 02:14:23 INFO - operating with platform_type : mac_ 02:14:23 INFO - Initialising browser for dromaeo_css test... 02:14:23 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpN5mBz4/profile http://localhost:49244/getInfo.html) 02:14:25 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 02:14:25 INFO - PROCESS | 1647 | colorDepth:24 02:14:25 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 02:14:25 INFO - PROCESS | 1647 | __metrics 02:14:25 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:14:25 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:26 INFO - TEST-INFO | 1647: exit 0 02:14:26 INFO - Browser initialized. 02:14:26 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:26 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpN5mBz4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:38 INFO - PROCESS | 1651 | RSS: Main: 212525056 02:14:38 INFO - PROCESS | 1651 | 02:17:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 02:17:43 INFO - PROCESS | 1651 | RSS: Main: 352927744 02:17:43 INFO - PROCESS | 1651 | 02:19:28 INFO - PROCESS | 1651 | ************************* 02:19:28 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 02:19:28 INFO - PROCESS | 1651 | 02:19:28 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:19:28 INFO - PROCESS | 1651 | Full stack: 02:19:28 INFO - PROCESS | 1651 | ************************* 02:20:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 02:20:47 INFO - PROCESS | 1651 | RSS: Main: 356040704 02:20:47 INFO - PROCESS | 1651 | 02:23:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 02:23:50 INFO - PROCESS | 1651 | RSS: Main: 332779520 02:23:50 INFO - PROCESS | 1651 | 02:26:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 02:26:52 INFO - PROCESS | 1651 | RSS: Main: 325017600 02:26:52 INFO - PROCESS | 1651 | 02:29:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 02:29:57 INFO - PROCESS | 1651 | RSS: Main: 315052032 02:29:57 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 02:33:00 INFO - PROCESS | 1651 | RSS: Main: 369905664 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | __start_tp_report 02:33:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:33:00 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:33:00 INFO - PROCESS | 1651 | |i|pagename|runs| 02:33:00 INFO - PROCESS | 1651 | |0;dojo.html;3311.5694959655243;3335.0661814691894;3338.8497517611704;3344.2308269098094;3368.040108569057;5594.776208951637;5614.971925140374;5648.858778530539;5668.149777533372;5680.488756011958;5604.85987850304;5668.716564171796;5686.516646085078;5692.829215123553;5707.62900411474;5135.178371460567;5147.922781158286;5179.352580927384;5190.818321358754;5234.790608375661;4665.7200567965865;4958.404991401037;5139.7687104080405;5148.974255128719;5241.86895327616;5203.583713302926;5238;5239.79040838366;5245.973770131144;5261.684298942057;5193.948060519403;5258.316418865561;5258.447862974409;5260.947390526084;5263.236830659571;5101.795928162906;5202.635815492879;5207.453217412155;5219.530242278213;5249.212618107276;5736.942630573724;5751.252337196138;5760.74076666551;5768.077107662753;5771.365149833515;6096.708114891111;6141.4993453731395;6167.599106058092;6219.40915613016;6234.470070044052;6307.4954003679595;6311.842203944892;6316.2736285326855;6322.557420980534;6337.2395312562785;5673.744681489343;5779.335376431723;5782.277215348082;5826.271716035496;5831.422333468249;6210.068489726486;6249.6562689051625;6251.749930002749;6279.309275979638;6305.464035557029;6192.411720886508;6199.783007594803;6202.162708034358;6219.129321894939;6222.160008398899;6338.58799178052;6341.23905131378;6345.270293916259;6349.904751428732;6364.49084073273;6052.455279024909;6121.724522396503;6131.233595800525;6147.0779383092;6255.906161407492;6192.040233763774;6193.597416167935;6197.225346831646;6200.534959878028;6215.06773983906;4212.894677633084;4977.228529577921;4977.8257760978195;4994.775235114428;5041.369828771403;4407.537208593051;4420.204363214652;4426.004149066499;4435.489918659396;4440.622547083534;5648.378678345379;5849.385814489502;5857.092150716646;5863.618864773776;5909.556783241274;6162.876742465215;6178.104174894705;6213.813585592439;6227.968860155761;6265.96867015662;5854.004819180749;5854.824355269348;5859.121131830259;5865.560082993792;5884.440978107073;5412.621116521806;5463.69949652765;5481.123020316731;5481.698506582176;5491.588130890199;6217.875642487034;6274.6548939808745;6299.905501417391;6317.652529110851;6344.111824344688;6320.5575609706875;6335.429811317003;6337.96831015842;6346.365363463617;6350.650714210763;6328.272248691275;6334.904976425265;6342.23893132827;6345.587536810092;6355.586886852339;6041.24484439445;6113.786017489367;6119.418655227746;6206.782762603287;6234.812955611339;6179.28938172116;6203.844903877439;6215.875682486416;6276.058591211355;6338.461230795434;6177.413145751147;6191.133241346125;6191.721372538156;6195.876082478235;6211.596246243979;6036.215292012011;6146.262448506208;6164.845878853064;6165.352637972948;6177.505799535937;4920.384951881015;5746.712664366849;5814;5905.055191169392;5955.851103722442;6190.442860142609;6200.596961197508;6210.906836397367;6220.2535695715;6231.813045608639;5988.191594134911;6028.125921741235;6046.203436610954;6050.30421501533;6059.0608455689435 02:33:00 INFO - PROCESS | 1651 | |1;ext.html;492.8028788484606;494.7625139932832;499.6577344519007;500.2296463446293;512.9204973229148;30435.847820760893;39639.80180099103;42007.579924200785;42116.57883421172;44227.11545769083;42006.949826254284;42460.57539424605;43076;43450.044747986336;43663;9148.359614826948;9359.391639543443;9363.859542106873;9371.578278977462;9377.109174628433;8281;8506.617202225914;11076.335419874793;11331.490082946246;11365;11357.034652054585;11413.771724565504;11414.258073225214;11419.771604567904;11429.771404571904;11268.661940141808;11322.603708870232;11340.773184536263;11352.262102963323;11395.715107122389;8295.502269863768;8537.146285371413;10971.396573188471;11216.383098929555;11276;40175.59824401748;41488.792556037326;41813.79093104515;41927;41957;3218.855151518187;3896.6103389660807;3917.1186483041374;3928.64642182205;3932.0956180078456;29403.852980735173;29458.263543411373;30124.83689212645;30351.125555799325;31137.688623113707;3034.51447768356;3086.8302243376606;3220.259340351709;3314.801111933292;3332.350191712617;294248;370434;371384;371492;372833;53497.73251133797;63095.05357419643;63542.36457635457;63798.448062077;64283.07150785484;65965.67017164979;66348.66825665937;66544.66910661856;66554.66722666356;66665.66667166633;16270.349186032663;16547.84165108431;16553.503394898173;16661.50015499537;16666.16669166561;11550.191486596026;12712.42794074269;12721.55474558386;12766.234025958473;12807.871921280854;14930;15109.942304038612;16710.58223544421;17164.39924602633;17195;6352.284883081542;6929.861402771916;7004.23535026143;7009.859802804018;7060.740563019887;888.9422187557788;895.3732387328765;913.4884464699657;925.8379783537854;930.7719608695777;29807.254818629706;30502.084937451913;30576.54135187974;31249.375012500077;31321;1044.7649278912336;1059.2532264753331;1081.7403823082404;1096.17786660005;1182.9290242585473;15874.682506349809;15884.126373049363;15916.92041539808;15930.68138637244;16242.187890605423;615050;617505;618799;620021;621486;62311.688441558406;62656.686716566124;62668.05997910035;62771.686141569;62846.685766570874;1416.051245665386;1441.553118533237;1470.9190994495405;1473.344361759007;1476.6603681153395;27614.895404183608;28265;28878.278043049093;29927.55108673415;30428.847855761465;51411;51954.48045519648;52002.73998630134;52024.53742356998;52139;531002;534829;535404;536097;536340;40230.59769402268;40682.79658601688;40857.59142408538;41034.38448423336;41055.58944410518;46568.301475477216;46805.06389872116;47178.52821471879;47441.52558474509;47609;35514.65778676376;38306.80846595749;39141.41287880741;39636.20727585375;39782.403263951644;38003.61996380001;38583.89583416503;39036.414453783786;39077;39698.60301397065;31033.37933241368;37643;38180.427293590066;38431.231375371775;38537;33261.833690831394;33611.49582756212;34594;34675.826620866734;35443.29113417666;20358.59282814365;24411.145609903568;24584.385390365384;25552.361190970376;25558.23325300244 02:33:00 INFO - PROCESS | 1651 | |2;jquery.html;371.3093645818775;389.79730540119124;392.1216475095785;402.7643828360408;425.4852724301487;14564.271786410676;18262.817371826277;20527.281545145903;21350.35948921531;21570.56858862822;21021.579568408622;21874;22418;22535;22685;5621.550275977912;5689.061304884699;5921.467067963882;5945.791897283596;5964.910526342108;5683.261176047108;5712.11462223356;5757.251557297566;5769.221155144044;5774.07614781635;4786.712797232177;5480.931218412411;5721.5708821838525;5728.427157284259;5734.111212762028;5592.356878958931;5627.521660658849;5653.830385088454;5726.141078838207;5742.569307301948;1554.7434673278894;1583.0818125487306;4301.78491075445;4998.600391890276;5093.541581257705;26965.32586685329;27077;27134.86432567844;27261;27296.863515682493;2713.552263876478;2716.456708658276;2718.2660681615853;2719.864006799672;2744.684361298456;15278.923605382013;15285.465008724752;15693.450729224536;15798;16485.58786030347;1818.5362732503258;1825.8904465732098;1831.4414103698366;1846.4091490722974;1865.3657756362902;115283.27075093964;132702.33648831694;133176;134989;137367.6263237375;11454.484548195185;11551.364674942959;11772.293662380285;11973.461194246105;11994.340311282964;12194;13022.609321720363;14921.776173357408;15694;15706.057636541844;7056.153261608537;8703.608337624823;8802.339824513187;8817.603207855662;8895.555222238861;8542.145785421533;8560.315174786003;8564.700235491728;8695.478271303742;8727.519986400808;4815.2054910940005;4816.807327706852;4820.30105634681;4832.323474713543;4896.094222568765;1772.3708083630383;1784.3130394797836;1789.5883946692334;1953.1601411393237;1970.1331414177716;932.8460803967405;962.5283611030544;1023.3859684189426;1026.3021145621049;1071.2715353559654;18334.358297459527;20120.798792011894;21491.355259342246;21640.675389869164;22030.88984555067;1015.7866847961863;1020.9846852297221;1043.6034306963456;1056.3925742697825;1058.2803693488502;10628.724553053684;11335;11428.771424571461;11524.308541487537;11573.768524629628;733392.3330383314;735258;744397;757480.2125989445;762101;123285.38357308335;153678.46321536865;159671;161811.38188618197;162590;931.189864817613;957.7653474898555;998.940063596172;1030.258214085857;1035.6168217759478;18005;18867.811321886606;19228.230870765572;19231.807681923;19452.027398630296;59954;61745.69127154336;61906.452338691895;62582;62824.37175628185;65371.34628653653;89561.55219224123;92313.53843230741;92582.53708731414;93466.06533934573;8284.420090593601;8487.27858132041;8548.478198931454;8649.437786543855;8813.647454101763;13227.074104812571;13284.136531125447;13306.401211945293;13522;13570.321483925567;11462.484188211383;11501.309921404743;11728.354940478355;11811.645650630495;11860.288382697066;11218.83171752408;11232.213745037769;11318.377489238172;11576.01603863681;11605.6518304451;11652.766944661229;11711.414429278673;11936.343501107174;12013.939930300292;12071.39643017828;8412.957935210285;8460.450070745383;8498.235158835734;8612.18184272493;8699.608517616849;8754.562271886507;11150.052245559218;11267.830982535104;11301.660950171508;11742.471588778355 02:33:00 INFO - PROCESS | 1651 | |3;mootools.html;1426.1656930695542;1449.9275036248184;1458.8905832062594;1469.985300146999;1476.6603681153335;8042.075161356438;8454.788630284245;8458.87311690325;8468.153184681529;8481.575921203937;7407.962960185205;7652.617369131549;7657.54054756715;8007.359411247086;8261.173882611736;2328.4877326988035;2376.192094687806;2379.8572085674914;2381.1903952656094;2383.1658919378165;2355.34050465869;2385.821063420242;2386.474975505386;2395.317334559651;2399.7360290368047;2335.2293743064747;2343.437574982009;2345.4754409633706;2365.1603680693365;2372.1223147435385;2313.83803133779;2318.40880575453;2343.285297984114;2347.929562113131;2353.011735071274;2343.60158773009;2348.377679914824;2374.3707917401903;2376.061455724979;2377.037299893546;8312.501249925024;8402.579871006425;8407.159284071606;8410.158984101541;8416.074231834493;4945.802167913279;5100.668456550349;5114.872128196787;5122.974385128051;5126.538611524943;3248.675132486756;3320.2197483591335;3459.567554055743;3505.5618047744033;3523.6828685418177;1206.5837286136268;1224.9387530623433;1698.3461367373527;1748.3181559191798;1817.9909100454545;10721.14230861537;10813.08088812452;10840.078593319577;10844.728881777939;10871.130309575216;4351.238533256731;4543.909461729161;4571.428571428572;4577.267637178035;4593.563611456906;8749.825003499895;8762;8781.736547903573;8794.60424280909;8847.646094156291;5152.098382783073;5152.5362717354865;5156.278121063054;5157.252198431282;5161.096808058574;4589.839355622537;4721.5986641135205;4735.171345014609;4821.228603423436;4823.2282834746975;3226.9838650806596;3625.873094441682;3737;3772.1701225730294;3772.283266179472;1141.9543218271342;1162.604714397092;1169.818678104895;1172.8709841917553;1175.518037604595;894.5840184314325;907.7186072317603;925.5233554719325;926.5498652291147;951.543259235557;5647.350554686182;5704.258446402024;5795.681237531892;5834.737436815353;5983.760649573968;960.8606752020918;978.5303054533721;1010.7725761703558;1015.7105225010837;1039.9480025998669;3361.7478689098416;3474.4788281757938;3521.366154092288;3773.9433908491396;3820.7200587803395;9756.365836220622;10070.74823129413;10072.697819065439;10093.495325233856;10115.949420252851;10002.149817265468;10016.048475394826;10019.749506262402;10023.148032417326;10042.347247428894;7533.434992375484;7535.284148005931;7650.196729343339;7787.598232318124;7836.647350869224;5267.657602255841;5432.239486471818;5489.286392769074;5496.285482887199;5653.3216014076925;7747.612619369122;9002.279817614706;9181;9291.117343852324;9293.535323233677;8066.717664881701;8487.066422693622;8834.558272086499;9268.073192680678;9355.25157987373;6193.504519638508;6743.8988415172835;6776.457883369417;6864.141982252218;6905.792826215222;7912.36701063925;7985.441019128605;8081;8103.31121854649;8107.351411887153;7117.125645867725;7148.249433809375;7217.747378841926;7245.420366370783;7285.2714728528845;7070.575765454089;7100.076989991268;7111.466640001917;7138.321859423347;7150.284971502808;6402.87194256103;6418.234985378871;6433.13152724395;6535.477161827138;6541.378569035934;4968.552830245295;4976.402831660079;5016.54851063406;5074;5094.541491265803;4985.451600323889;5030.0191462664425;5049.116404629249;5138.12651849179;5141.177411614124 02:33:00 INFO - PROCESS | 1651 | |4;prototype.html;297.28136194501286;316.73552583592715;355.5395762487579;365.79698267461566;376.3075940269903;4366.345048242765;4542.182407166709;5019.6446959320965;5165.527824569998;5303.920441193381;4962.602991760659;5157.948420515794;5164.612654050942;5185.55922746566;5267.789288428467;3487.442009278516;3835.712321575879;4176.14389050244;4212.789360531977;4218.0720241546815;3629.3467175908327;4059.918801623966;4155.812988415529;4188.476440444944;4240.766757828318;4108.0140766216045;4115.609017143366;4125.876223713279;4148.274052040896;4193.853215137471;3325.883594074208;4126.277901367263;4147.605977432139;4150.792460376999;4169.812358443847;3683.907902302437;3705.277470893177;3709.573399059089;3718.4980027696183;3718.5537735471644;4191.455110835603;4494.955050449519;4628.199939036902;5098.949010509885;5158.664686795346;4035.3946907963746;4535.9546404536195;4808.942032752789;4825.975870120662;4850.175470170079;4776.785044672998;5383.703896285702;5499.450054994509;5608.5793565482345;5657.727011422438;3516.5780106387397;3612.945805812915;3840.9286156674016;3976.443297938291;4139.710220284582;4680.438347398334;5848.795292164754;5862.794802181946;5867.655436401295;5915.072039340511;3577;3997.2804895118575;4202.495700515958;4227.58375944056;4230.365445183247;3709.8684901104884;3941.3592892761917;4192.392103145027;4239.682023848224;4253.2769429197115;4034.778087205173;4274.268921086965;4641.350210970467;4650.255959046536;4672.509386514367;5292.814751483679;5760.884782304331;5793.217915581343;5794.217780599565;5798.9420105799245;1033.565902321027;1195.3303358688743;1245.6014075495755;1255.993720031394;1297.033709886141;661.163628010567;750.2984709296825;858.3133493205536;866.2333834556463;882.9316527002399;4208.705390622688;4781.856544303607;5088.92366614501;5123;5146.948530514722;4485.596296333346;5022.698638081727;5455.290812194468;5604.299462567179;5624.971875140598;5234.18870075139;5358.705271210121;5361.839144825662;5364.822945857267;5368.651037682538;2441.963370549443;2901.477734007899;2907.6220091387986;2921.816664250982;2924.8154497428577;5566.499015088581;5593.776248950077;5707.716913234739;5811.476967072984;6059.788312194544;5388.757505912244;5789.507891829157;6034.879302413927;6068.75724971005;6077.4834139098675;5759.164921086419;5772.729999400125;6110.938890611126;6120.969395153084;6135.7852475164045;5352.5985551084605;5792.913106303493;5834.854128646818;5842.269716285465;5877.500412464989;5572.721363931868;5775.7400916957995;5804.448577385142;5825.359210486928;5830.53355731532;5067.670601410897;5337.57299416038;5611.064182856908;5954.851128721816;5984.730687119003;3628.7822730636244;3905.902352441212;4008.4588580541254;4301.333293339538;4305.763183024838;5076.157351882957;5801.332846722681;5879.382664820132;5911.201987731602;5963.2844058713235;4817.470078291315;5050.924236136534;5092.618053645917;5428.45715428454;5629.6932846373375;5104.744762761921;5492.560595152298;5655.85860353478;5666.470053085726;5695.231143795535;4688.789004494738;5303.867403314948;5445;5449.291592093003;5627.718614069198;4285.528591854956;5559.2217089606675;5628.367773345848;5649.971750141223;5678.488935995781;4565.840195593139;4776.877433803123;4863.610911127172;5069.645124841226;5129.8717532062 02:33:00 INFO - PROCESS | 1651 | |5;yui.html;712.5760172697244;729.1942403643973;741.8367959049008;817.5462618246873;831.256025856858;14852.925735371322;14893.255337233122;15501;15544.378224870992;15677.529674109795;13975.161490310564;14156.858431415709;14207.71584568308;14450.277486125678;14466.710665786677;831.7546323834483;845.750503601439;847.2544161138189;848.1476116502906;849.9787505312355;670.4502308107354;686.3034020469228;695.9652017399135;843.4686147726954;845.8858054162702;868.2272777228272;894.029977474441;894.8970868350158;899.0110878034176;903.4218100415707;887.3566664168491;890.3322508118911;895.1630225738955;896.0278098263392;896.1844721303582;525.6346838946934;667.3560014585947;668.6122049211446;669.5614372585964;673.3300366135726;10659;14016.509422170277;14589.9787014909;14595.927020364936;14993.32530036151;14088.506902258372;14167.504137355247;14206.573802785933;14218.786718199131;14263.572092837128;9075.909240907573;10914.399708016055;11175.385353805537;11396.487158077907;11582;3574.1422058705984;3624.4925710400566;3729.3287208302495;3794.6964242860504;3844;81717.59141204316;87227.56386218092;87240;96980;97895.55261118458;10550.841737373945;10564.313319634199;11015.669529914116;11054.944725276322;11179.720506987227;21787.019584118752;22059.448513787283;22204.22285220042;22206.77793222047;22328.441788955406;7865.488743231672;7888.329491993245;7889.250521200477;7913.208679132041;8000.439969202216;4227.725197862129;4254.489461264668;4357.869263922087;4384.167008268419;4516.593506584423;3490.6334834842482;3549.219171782204;3588.7129029677562;3628.8004159771467;3628.983884512341;618.1315252070848;637.6970938804031;639.9456046236122;641.2625480697236;647.6211416321505;644.4940721533574;657.5462930577886;694.4270976444453;700.7757517594423;716.5306724095726;9283.396579222464;9631.036896310314;9812.116909478182;10009.749756256151;10166.949165254275;686.4062585863293;693.1924308180912;696.7247937064831;700.9649517524103;715.5241764226731;3834.0031591786337;4534.13851368239;4810.807567697323;4815.30178124177;4818.518148185153;103991;104389;105542.94457055331;106812;108893.91106088996;88957.66563501552;89326.55336723274;91167.08832911719;91363.77726004558;95702;78118;79487.01282467753;79513.80729289065;80258.5987070061;82600;8844.73465796027;9440.85838712406;10127.79744405093;10758.784824303626;11038.889611104107;50427.243591345425;51709.22436163536;51858;52832.037597179595;53978.73010634922;45602.859928502054;68258;68482.63034739377;69177.30822691708;70223;11547.249428787101;12135.635930922086;12355.75288494243;12797.616071517868;12858.871411286142;13567.86432135666;13667.86332136666;14589.27053647292;15078.396864125312;15107.39570417215;11847.215150698183;12444.253344799341;12467.563635273085;12874.871251287368;12950.417231224807;10776.407297598707;12554.246745195318;12615.233867258774;13041.282729449591;13482.52811151605;9532.809343812945;12088.436456179614;12268.570600028956;12440.440180191732;12578.30819304947;9679.467629280458;10338;10903.56385744593;11256.437178140897;11525.884741152817;10693.465326733787;10948.178886583379;10962.835557466804;10980.231383803057;11073 02:33:00 INFO - PROCESS | 1651 | __end_tp_report 02:33:00 INFO - PROCESS | 1651 | __start_cc_report 02:33:00 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1273 02:33:00 INFO - PROCESS | 1651 | __end_cc_report 02:33:00 INFO - PROCESS | 1651 | __startTimestamp1488623580853__endTimestamp 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:33:00 INFO - PROCESS | 1651 | Number of tests: 6 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5756.33 Median:6036.22 stddev:663.29 (11.0%) stddev-sans-first:636.99 02:33:00 INFO - PROCESS | 1651 | Values: 3311.6 3335.1 3338.8 3344.2 3368.0 5594.8 5615.0 5648.9 5668.1 5680.5 5604.9 5668.7 5686.5 5692.8 5707.6 5135.2 5147.9 5179.4 5190.8 5234.8 4665.7 4958.4 5139.8 5149.0 5241.9 5203.6 5238.0 5239.8 5246.0 5261.7 5193.9 5258.3 5258.4 5260.9 5263.2 5101.8 5202.6 5207.5 5219.5 5249.2 5736.9 5751.3 5760.7 5768.1 5771.4 6096.7 6141.5 6167.6 6219.4 6234.5 6307.5 6311.8 6316.3 6322.6 6337.2 5673.7 5779.3 5782.3 5826.3 5831.4 6210.1 6249.7 6251.7 6279.3 6305.5 6192.4 6199.8 6202.2 6219.1 6222.2 6338.6 6341.2 6345.3 6349.9 6364.5 6052.5 6121.7 6131.2 6147.1 6255.9 6192.0 6193.6 6197.2 6200.5 6215.1 4212.9 4977.2 4977.8 4994.8 5041.4 4407.5 4420.2 4426.0 4435.5 4440.6 5648.4 5849.4 5857.1 5863.6 5909.6 6162.9 6178.1 6213.8 6228.0 6266.0 5854.0 5854.8 5859.1 5865.6 5884.4 5412.6 5463.7 5481.1 5481.7 5491.6 6217.9 6274.7 6299.9 6317.7 6344.1 6320.6 6335.4 6338.0 6346.4 6350.7 6328.3 6334.9 6342.2 6345.6 6355.6 6041.2 6113.8 6119.4 6206.8 6234.8 6179.3 6203.8 6215.9 6276.1 6338.5 6177.4 6191.1 6191.7 6195.9 6211.6 6036.2 6146.3 6164.8 6165.4 6177.5 4920.4 5746.7 5814.0 5905.1 5955.9 6190.4 6200.6 6210.9 6220.3 6231.8 5988.2 6028.1 6046.2 6050.3 6059.1 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:65489.25 Median:38560.45 stddev:137435.72 (356.4%) stddev-sans-first:137734.62 02:33:00 INFO - PROCESS | 1651 | Values: 492.8 494.8 499.7 500.2 512.9 30435.8 39639.8 42007.6 42116.6 44227.1 42006.9 42460.6 43076.0 43450.0 43663.0 9148.4 9359.4 9363.9 9371.6 9377.1 8281.0 8506.6 11076.3 11331.5 11365.0 11357.0 11413.8 11414.3 11419.8 11429.8 11268.7 11322.6 11340.8 11352.3 11395.7 8295.5 8537.1 10971.4 11216.4 11276.0 40175.6 41488.8 41813.8 41927.0 41957.0 3218.9 3896.6 3917.1 3928.6 3932.1 29403.9 29458.3 30124.8 30351.1 31137.7 3034.5 3086.8 3220.3 3314.8 3332.4 294248.0 370434.0 371384.0 371492.0 372833.0 53497.7 63095.1 63542.4 63798.4 64283.1 65965.7 66348.7 66544.7 66554.7 66665.7 16270.3 16547.8 16553.5 16661.5 16666.2 11550.2 12712.4 12721.6 12766.2 12807.9 14930.0 15109.9 16710.6 17164.4 17195.0 6352.3 6929.9 7004.2 7009.9 7060.7 888.9 895.4 913.5 925.8 930.8 29807.3 30502.1 30576.5 31249.4 31321.0 1044.8 1059.3 1081.7 1096.2 1182.9 15874.7 15884.1 15916.9 15930.7 16242.2 615050.0 617505.0 618799.0 620021.0 621486.0 62311.7 62656.7 62668.1 62771.7 62846.7 1416.1 1441.6 1470.9 1473.3 1476.7 27614.9 28265.0 28878.3 29927.6 30428.8 51411.0 51954.5 52002.7 52024.5 52139.0 531002.0 534829.0 535404.0 536097.0 536340.0 40230.6 40682.8 40857.6 41034.4 41055.6 46568.3 46805.1 47178.5 47441.5 47609.0 35514.7 38306.8 39141.4 39636.2 39782.4 38003.6 38583.9 39036.4 39077.0 39698.6 31033.4 37643.0 38180.4 38431.2 38537.0 33261.8 33611.5 34594.0 34675.8 35443.3 20358.6 24411.1 24584.4 25552.4 25558.2 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:40927.64 Median:21757.34 stddev:124331.15 (571.4%) stddev-sans-first:124642.64 02:33:00 INFO - PROCESS | 1651 | Values: 371.3 389.8 392.1 402.8 425.5 14564.3 18262.8 20527.3 21350.4 21570.6 21021.6 21874.0 22418.0 22535.0 22685.0 5621.6 5689.1 5921.5 5945.8 5964.9 5683.3 5712.1 5757.3 5769.2 5774.1 4786.7 5480.9 5721.6 5728.4 5734.1 5592.4 5627.5 5653.8 5726.1 5742.6 1554.7 1583.1 4301.8 4998.6 5093.5 26965.3 27077.0 27134.9 27261.0 27296.9 2713.6 2716.5 2718.3 2719.9 2744.7 15278.9 15285.5 15693.5 15798.0 16485.6 1818.5 1825.9 1831.4 1846.4 1865.4 115283.3 132702.3 133176.0 134989.0 137367.6 11454.5 11551.4 11772.3 11973.5 11994.3 12194.0 13022.6 14921.8 15694.0 15706.1 7056.2 8703.6 8802.3 8817.6 8895.6 8542.1 8560.3 8564.7 8695.5 8727.5 4815.2 4816.8 4820.3 4832.3 4896.1 1772.4 1784.3 1789.6 1953.2 1970.1 932.8 962.5 1023.4 1026.3 1071.3 18334.4 20120.8 21491.4 21640.7 22030.9 1015.8 1021.0 1043.6 1056.4 1058.3 10628.7 11335.0 11428.8 11524.3 11573.8 733392.3 735258.0 744397.0 757480.2 762101.0 123285.4 153678.5 159671.0 161811.4 162590.0 931.2 957.8 998.9 1030.3 1035.6 18005.0 18867.8 19228.2 19231.8 19452.0 59954.0 61745.7 61906.5 62582.0 62824.4 65371.3 89561.6 92313.5 92582.5 93466.1 8284.4 8487.3 8548.5 8649.4 8813.6 13227.1 13284.1 13306.4 13522.0 13570.3 11462.5 11501.3 11728.4 11811.6 11860.3 11218.8 11232.2 11318.4 11576.0 11605.7 11652.8 11711.4 11936.3 12013.9 12071.4 8413.0 8460.5 8498.2 8612.2 8699.6 8754.6 11150.1 11267.8 11301.7 11742.5 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5402.34 Median:5097.60 stddev:2891.07 (56.7%) stddev-sans-first:2883.73 02:33:00 INFO - PROCESS | 1651 | Values: 1426.2 1449.9 1458.9 1470.0 1476.7 8042.1 8454.8 8458.9 8468.2 8481.6 7408.0 7652.6 7657.5 8007.4 8261.2 2328.5 2376.2 2379.9 2381.2 2383.2 2355.3 2385.8 2386.5 2395.3 2399.7 2335.2 2343.4 2345.5 2365.2 2372.1 2313.8 2318.4 2343.3 2347.9 2353.0 2343.6 2348.4 2374.4 2376.1 2377.0 8312.5 8402.6 8407.2 8410.2 8416.1 4945.8 5100.7 5114.9 5123.0 5126.5 3248.7 3320.2 3459.6 3505.6 3523.7 1206.6 1224.9 1698.3 1748.3 1818.0 10721.1 10813.1 10840.1 10844.7 10871.1 4351.2 4543.9 4571.4 4577.3 4593.6 8749.8 8762.0 8781.7 8794.6 8847.6 5152.1 5152.5 5156.3 5157.3 5161.1 4589.8 4721.6 4735.2 4821.2 4823.2 3227.0 3625.9 3737.0 3772.2 3772.3 1142.0 1162.6 1169.8 1172.9 1175.5 894.6 907.7 925.5 926.5 951.5 5647.4 5704.3 5795.7 5834.7 5983.8 960.9 978.5 1010.8 1015.7 1039.9 3361.7 3474.5 3521.4 3773.9 3820.7 9756.4 10070.7 10072.7 10093.5 10115.9 10002.1 10016.0 10019.7 10023.1 10042.3 7533.4 7535.3 7650.2 7787.6 7836.6 5267.7 5432.2 5489.3 5496.3 5653.3 7747.6 9002.3 9181.0 9291.1 9293.5 8066.7 8487.1 8834.6 9268.1 9355.3 6193.5 6743.9 6776.5 6864.1 6905.8 7912.4 7985.4 8081.0 8103.3 8107.4 7117.1 7148.2 7217.7 7245.4 7285.3 7070.6 7100.1 7111.5 7138.3 7150.3 6402.9 6418.2 6433.1 6535.5 6541.4 4968.6 4976.4 5016.5 5074.0 5094.5 4985.5 5030.0 5049.1 5138.1 5141.2 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4545.98 Median:5068.66 stddev:1395.92 (27.5%) stddev-sans-first:1362.92 02:33:00 INFO - PROCESS | 1651 | Values: 297.3 316.7 355.5 365.8 376.3 4366.3 4542.2 5019.6 5165.5 5303.9 4962.6 5157.9 5164.6 5185.6 5267.8 3487.4 3835.7 4176.1 4212.8 4218.1 3629.3 4059.9 4155.8 4188.5 4240.8 4108.0 4115.6 4125.9 4148.3 4193.9 3325.9 4126.3 4147.6 4150.8 4169.8 3683.9 3705.3 3709.6 3718.5 3718.6 4191.5 4495.0 4628.2 5098.9 5158.7 4035.4 4536.0 4808.9 4826.0 4850.2 4776.8 5383.7 5499.5 5608.6 5657.7 3516.6 3612.9 3840.9 3976.4 4139.7 4680.4 5848.8 5862.8 5867.7 5915.1 3577.0 3997.3 4202.5 4227.6 4230.4 3709.9 3941.4 4192.4 4239.7 4253.3 4034.8 4274.3 4641.4 4650.3 4672.5 5292.8 5760.9 5793.2 5794.2 5798.9 1033.6 1195.3 1245.6 1256.0 1297.0 661.2 750.3 858.3 866.2 882.9 4208.7 4781.9 5088.9 5123.0 5146.9 4485.6 5022.7 5455.3 5604.3 5625.0 5234.2 5358.7 5361.8 5364.8 5368.7 2442.0 2901.5 2907.6 2921.8 2924.8 5566.5 5593.8 5707.7 5811.5 6059.8 5388.8 5789.5 6034.9 6068.8 6077.5 5759.2 5772.7 6110.9 6121.0 6135.8 5352.6 5792.9 5834.9 5842.3 5877.5 5572.7 5775.7 5804.4 5825.4 5830.5 5067.7 5337.6 5611.1 5954.9 5984.7 3628.8 3905.9 4008.5 4301.3 4305.8 5076.2 5801.3 5879.4 5911.2 5963.3 4817.5 5050.9 5092.6 5428.5 5629.7 5104.7 5492.6 5655.9 5666.5 5695.2 4688.8 5303.9 5445.0 5449.3 5627.7 4285.5 5559.2 5628.4 5650.0 5678.5 4565.8 4776.9 4863.6 5069.6 5129.9 02:33:00 INFO - PROCESS | 1651 | 02:33:00 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20033.77 Median:4371.02 stddev:28746.66 (657.7%) stddev-sans-first:28790.70 02:33:00 INFO - PROCESS | 1651 | Values: 712.6 729.2 741.8 817.5 831.3 14852.9 14893.3 15501.0 15544.4 15677.5 13975.2 14156.9 14207.7 14450.3 14466.7 831.8 845.8 847.3 848.1 850.0 670.5 686.3 696.0 843.5 845.9 868.2 894.0 894.9 899.0 903.4 887.4 890.3 895.2 896.0 896.2 525.6 667.4 668.6 669.6 673.3 10659.0 14016.5 14590.0 14595.9 14993.3 14088.5 14167.5 14206.6 14218.8 14263.6 9075.9 10914.4 11175.4 11396.5 11582.0 3574.1 3624.5 3729.3 3794.7 3844.0 81717.6 87227.6 87240.0 96980.0 97895.6 10550.8 10564.3 11015.7 11054.9 11179.7 21787.0 22059.4 22204.2 22206.8 22328.4 7865.5 7888.3 7889.3 7913.2 8000.4 4227.7 4254.5 4357.9 4384.2 4516.6 3490.6 3549.2 3588.7 3628.8 3629.0 618.1 637.7 639.9 641.3 647.6 644.5 657.5 694.4 700.8 716.5 9283.4 9631.0 9812.1 10009.7 10166.9 686.4 693.2 696.7 701.0 715.5 3834.0 4534.1 4810.8 4815.3 4818.5 103991.0 104389.0 105542.9 106812.0 108893.9 88957.7 89326.6 91167.1 91363.8 95702.0 78118.0 79487.0 79513.8 80258.6 82600.0 8844.7 9440.9 10127.8 10758.8 11038.9 50427.2 51709.2 51858.0 52832.0 53978.7 45602.9 68258.0 68482.6 69177.3 70223.0 11547.2 12135.6 12355.8 12797.6 12858.9 13567.9 13667.9 14589.3 15078.4 15107.4 11847.2 12444.3 12467.6 12874.9 12950.4 10776.4 12554.2 12615.2 13041.3 13482.5 9532.8 12088.4 12268.6 12440.4 12578.3 9679.5 10338.0 10903.6 11256.4 11525.9 10693.5 10948.2 10962.8 10980.2 11073.0 02:33:00 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:33:00 INFO - PROCESS | 1651 | 02:33:01 INFO - TEST-INFO | 1651: exit 0 02:33:01 INFO - TEST-OK | dromaeo_css | took 1118425ms 02:33:01 INFO - TEST-START | kraken 02:33:01 INFO - operating with platform_type : mac_ 02:33:01 INFO - Initialising browser for kraken test... 02:33:01 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp3Dh4Ds/profile http://localhost:49244/getInfo.html) 02:33:03 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 02:33:03 INFO - PROCESS | 1657 | colorDepth:24 02:33:03 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 02:33:03 INFO - PROCESS | 1657 | __metrics 02:33:04 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:33:04 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:04 INFO - TEST-INFO | 1657: exit 0 02:33:04 INFO - Browser initialized. 02:33:04 INFO - Running cycle 1/1 for kraken test... 02:33:04 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp3Dh4Ds/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:16 INFO - PROCESS | 1659 | RSS: Main: 213397504 02:33:16 INFO - PROCESS | 1659 | 02:33:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:20 INFO - PROCESS | 1659 | RSS: Main: 266317824 02:33:20 INFO - PROCESS | 1659 | 02:33:23 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 02:33:23 INFO - PROCESS | 1659 | RSS: Main: 274931712 02:33:23 INFO - PROCESS | 1659 | 02:33:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 02:33:27 INFO - PROCESS | 1659 | RSS: Main: 371359744 02:33:27 INFO - PROCESS | 1659 | 02:33:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 02:33:30 INFO - PROCESS | 1659 | RSS: Main: 276963328 02:33:30 INFO - PROCESS | 1659 | 02:33:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:32 INFO - PROCESS | 1659 | RSS: Main: 278175744 02:33:32 INFO - PROCESS | 1659 | 02:33:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:36 INFO - PROCESS | 1659 | RSS: Main: 318308352 02:33:36 INFO - PROCESS | 1659 | 02:33:39 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:39 INFO - PROCESS | 1659 | RSS: Main: 318873600 02:33:39 INFO - PROCESS | 1659 | 02:33:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 02:33:43 INFO - PROCESS | 1659 | RSS: Main: 318287872 02:33:43 INFO - PROCESS | 1659 | 02:33:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:45 INFO - PROCESS | 1659 | RSS: Main: 293580800 02:33:45 INFO - PROCESS | 1659 | 02:33:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:47 INFO - PROCESS | 1659 | RSS: Main: 297631744 02:33:47 INFO - PROCESS | 1659 | 02:33:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:50 INFO - PROCESS | 1659 | RSS: Main: 300937216 02:33:50 INFO - PROCESS | 1659 | 02:33:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:54 INFO - PROCESS | 1659 | RSS: Main: 316637184 02:33:54 INFO - PROCESS | 1659 | 02:33:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:57 INFO - PROCESS | 1659 | RSS: Main: 310964224 02:33:57 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 02:33:59 INFO - PROCESS | 1659 | RSS: Main: 354725888 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | __start_tp_report 02:33:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 02:33:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 02:33:59 INFO - PROCESS | 1659 | |i|pagename|runs| 02:33:59 INFO - PROCESS | 1659 | |0;ai-astar;119;163;173;113;115;115;114;116;114;114 02:33:59 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;109;110;144;110;108;108;119;164;111 02:33:59 INFO - PROCESS | 1659 | |2;audio-dft;182;183;182;187;183;185;182;185;181;183 02:33:59 INFO - PROCESS | 1659 | |3;audio-fft;83;59;57;90;60;57;57;61;92;83 02:33:59 INFO - PROCESS | 1659 | |4;audio-oscillator;90;71;85;69;68;68;81;67;68;82 02:33:59 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;89;86;89;85;88;85;89;87;88;86 02:33:59 INFO - PROCESS | 1659 | |6;imaging-darkroom;94;95;95;97;109;151;120;97;95;104 02:33:59 INFO - PROCESS | 1659 | |7;imaging-desaturate;88;86;87;88;87;86;86;86;87;85 02:33:59 INFO - PROCESS | 1659 | |8;json-parse-financial;56;51;52;53;54;57;57;56;56;56 02:33:59 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;65;77;80;73;73;71;70;70;68;73 02:33:59 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;83;85;86;83;82;83;85;81;85;80 02:33:59 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;147;151;140;153;145;146;151;149;207;148 02:33:59 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;164;166;166;167;164;166;164;166;166;165 02:33:59 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;63;71;86;88;86;72;66;65;65;65 02:33:59 INFO - PROCESS | 1659 | __end_tp_report 02:33:59 INFO - PROCESS | 1659 | __start_cc_report 02:33:59 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2015 02:33:59 INFO - PROCESS | 1659 | __end_cc_report 02:33:59 INFO - PROCESS | 1659 | __startTimestamp1488623639957__endTimestamp 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | ------- Summary: start ------- 02:33:59 INFO - PROCESS | 1659 | Number of tests: 14 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:125.60 Median:115.50 stddev:22.53 (19.5%) stddev-sans-first:23.77 02:33:59 INFO - PROCESS | 1659 | Values: 119.0 163.0 173.0 113.0 115.0 115.0 114.0 116.0 114.0 114.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:115.00 stddev:20.18 (17.5%) stddev-sans-first:20.01 02:33:59 INFO - PROCESS | 1659 | Values: 143.0 109.0 110.0 144.0 110.0 108.0 108.0 119.0 164.0 111.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.00 stddev:1.83 (1.0%) stddev-sans-first:1.88 02:33:59 INFO - PROCESS | 1659 | Values: 182.0 183.0 182.0 187.0 183.0 185.0 182.0 185.0 181.0 183.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:69.90 Median:72.00 stddev:15.02 (20.9%) stddev-sans-first:15.17 02:33:59 INFO - PROCESS | 1659 | Values: 83.0 59.0 57.0 90.0 60.0 57.0 57.0 61.0 92.0 83.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:76.00 stddev:8.65 (11.4%) stddev-sans-first:7.24 02:33:59 INFO - PROCESS | 1659 | Values: 90.0 71.0 85.0 69.0 68.0 68.0 81.0 67.0 68.0 82.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.62 (1.8%) stddev-sans-first:1.58 02:33:59 INFO - PROCESS | 1659 | Values: 89.0 86.0 89.0 85.0 88.0 85.0 89.0 87.0 88.0 86.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:95.00 stddev:17.96 (18.9%) stddev-sans-first:18.54 02:33:59 INFO - PROCESS | 1659 | Values: 94.0 95.0 95.0 97.0 109.0 151.0 120.0 97.0 95.0 104.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:0.88 02:33:59 INFO - PROCESS | 1659 | Values: 88.0 86.0 87.0 88.0 87.0 86.0 86.0 86.0 87.0 85.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:2.15 (3.8%) stddev-sans-first:2.24 02:33:59 INFO - PROCESS | 1659 | Values: 56.0 51.0 52.0 53.0 54.0 57.0 57.0 56.0 56.0 56.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.00 stddev:4.29 (5.9%) stddev-sans-first:3.73 02:33:59 INFO - PROCESS | 1659 | Values: 65.0 77.0 80.0 73.0 73.0 71.0 70.0 70.0 68.0 73.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:1.95 (2.3%) stddev-sans-first:2.06 02:33:59 INFO - PROCESS | 1659 | Values: 83.0 85.0 86.0 83.0 82.0 83.0 85.0 81.0 85.0 80.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:150.00 stddev:19.08 (12.7%) stddev-sans-first:20.09 02:33:59 INFO - PROCESS | 1659 | Values: 147.0 151.0 140.0 153.0 145.0 146.0 151.0 149.0 207.0 148.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:166.00 stddev:1.07 (0.6%) stddev-sans-first:1.01 02:33:59 INFO - PROCESS | 1659 | Values: 164.0 166.0 166.0 167.0 164.0 166.0 164.0 166.0 166.0 165.0 02:33:59 INFO - PROCESS | 1659 | 02:33:59 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:71.50 stddev:10.04 (14.0%) stddev-sans-first:10.02 02:33:59 INFO - PROCESS | 1659 | Values: 63.0 71.0 86.0 88.0 86.0 72.0 66.0 65.0 65.0 65.0 02:33:59 INFO - PROCESS | 1659 | -------- Summary: end -------- 02:33:59 INFO - PROCESS | 1659 | 02:34:00 INFO - TEST-INFO | 1659: exit 0 02:34:00 INFO - TEST-OK | kraken | took 59320ms 02:34:00 INFO - SUITE-END | took 1177s 02:34:01 INFO - Completed test suite (00:19:38) 02:34:01 INFO - javascript benchmark 02:34:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.5694959655243, 3335.0661814691894, 3338.8497517611704, 3344.2308269098094, 3368.040108569057, 5594.776208951637, 5614.971925140374, 5648.858778530539, 5668.149777533372, 5680.488756011958, 5604.85987850304, 5668.716564171796, 5686.516646085078, 5692.829215123553, 5707.62900411474, 5135.178371460567, 5147.922781158286, 5179.352580927384, 5190.818321358754, 5234.790608375661, 4665.7200567965865, 4958.404991401037, 5139.7687104080405, 5148.974255128719, 5241.86895327616, 5203.583713302926, 5238.0, 5239.79040838366, 5245.973770131144, 5261.684298942057, 5193.948060519403, 5258.316418865561, 5258.447862974409, 5260.947390526084, 5263.236830659571, 5101.795928162906, 5202.635815492879, 5207.453217412155, 5219.530242278213, 5249.212618107276, 5736.942630573724, 5751.252337196138, 5760.74076666551, 5768.077107662753, 5771.365149833515, 6096.708114891111, 6141.4993453731395, 6167.599106058092, 6219.40915613016, 6234.470070044052, 6307.4954003679595, 6311.842203944892, 6316.2736285326855, 6322.557420980534, 6337.2395312562785, 5673.744681489343, 5779.335376431723, 5782.277215348082, 5826.271716035496, 5831.422333468249, 6210.068489726486, 6249.6562689051625, 6251.749930002749, 6279.309275979638, 6305.464035557029, 6192.411720886508, 6199.783007594803, 6202.162708034358, 6219.129321894939, 6222.160008398899, 6338.58799178052, 6341.23905131378, 6345.270293916259, 6349.904751428732, 6364.49084073273, 6052.455279024909, 6121.724522396503, 6131.233595800525, 6147.0779383092, 6255.906161407492, 6192.040233763774, 6193.597416167935, 6197.225346831646, 6200.534959878028, 6215.06773983906, 4212.894677633084, 4977.228529577921, 4977.8257760978195, 4994.775235114428, 5041.369828771403, 4407.537208593051, 4420.204363214652, 4426.004149066499, 4435.489918659396, 4440.622547083534, 5648.378678345379, 5849.385814489502, 5857.092150716646, 5863.618864773776, 5909.556783241274, 6162.876742465215, 6178.104174894705, 6213.813585592439, 6227.968860155761, 6265.96867015662, 5854.004819180749, 5854.824355269348, 5859.121131830259, 5865.560082993792, 5884.440978107073, 5412.621116521806, 5463.69949652765, 5481.123020316731, 5481.698506582176, 5491.588130890199, 6217.875642487034, 6274.6548939808745, 6299.905501417391, 6317.652529110851, 6344.111824344688, 6320.5575609706875, 6335.429811317003, 6337.96831015842, 6346.365363463617, 6350.650714210763, 6328.272248691275, 6334.904976425265, 6342.23893132827, 6345.587536810092, 6355.586886852339, 6041.24484439445, 6113.786017489367, 6119.418655227746, 6206.782762603287, 6234.812955611339, 6179.28938172116, 6203.844903877439, 6215.875682486416, 6276.058591211355, 6338.461230795434, 6177.413145751147, 6191.133241346125, 6191.721372538156, 6195.876082478235, 6211.596246243979, 6036.215292012011, 6146.262448506208, 6164.845878853064, 6165.352637972948, 6177.505799535937, 4920.384951881015, 5746.712664366849, 5814.0, 5905.055191169392, 5955.851103722442, 6190.442860142609, 6200.596961197508, 6210.906836397367, 6220.2535695715, 6231.813045608639, 5988.191594134911, 6028.125921741235, 6046.203436610954, 6050.30421501533, 6059.0608455689435], "value": 5712.087606617064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8028788484606, 494.7625139932832, 499.6577344519007, 500.2296463446293, 512.9204973229148, 30435.847820760893, 39639.80180099103, 42007.579924200785, 42116.57883421172, 44227.11545769083, 42006.949826254284, 42460.57539424605, 43076.0, 43450.044747986336, 43663.0, 9148.359614826948, 9359.391639543443, 9363.859542106873, 9371.578278977462, 9377.109174628433, 8281.0, 8506.617202225914, 11076.335419874793, 11331.490082946246, 11365.0, 11357.034652054585, 11413.771724565504, 11414.258073225214, 11419.771604567904, 11429.771404571904, 11268.661940141808, 11322.603708870232, 11340.773184536263, 11352.262102963323, 11395.715107122389, 8295.502269863768, 8537.146285371413, 10971.396573188471, 11216.383098929555, 11276.0, 40175.59824401748, 41488.792556037326, 41813.79093104515, 41927.0, 41957.0, 3218.855151518187, 3896.6103389660807, 3917.1186483041374, 3928.64642182205, 3932.0956180078456, 29403.852980735173, 29458.263543411373, 30124.83689212645, 30351.125555799325, 31137.688623113707, 3034.51447768356, 3086.8302243376606, 3220.259340351709, 3314.801111933292, 3332.350191712617, 294248.0, 370434.0, 371384.0, 371492.0, 372833.0, 53497.73251133797, 63095.05357419643, 63542.36457635457, 63798.448062077, 64283.07150785484, 65965.67017164979, 66348.66825665937, 66544.66910661856, 66554.66722666356, 66665.66667166633, 16270.349186032663, 16547.84165108431, 16553.503394898173, 16661.50015499537, 16666.16669166561, 11550.191486596026, 12712.42794074269, 12721.55474558386, 12766.234025958473, 12807.871921280854, 14930.0, 15109.942304038612, 16710.58223544421, 17164.39924602633, 17195.0, 6352.284883081542, 6929.861402771916, 7004.23535026143, 7009.859802804018, 7060.740563019887, 888.9422187557788, 895.3732387328765, 913.4884464699657, 925.8379783537854, 930.7719608695777, 29807.254818629706, 30502.084937451913, 30576.54135187974, 31249.375012500077, 31321.0, 1044.7649278912336, 1059.2532264753331, 1081.7403823082404, 1096.17786660005, 1182.9290242585473, 15874.682506349809, 15884.126373049363, 15916.92041539808, 15930.68138637244, 16242.187890605423, 615050.0, 617505.0, 618799.0, 620021.0, 621486.0, 62311.688441558406, 62656.686716566124, 62668.05997910035, 62771.686141569, 62846.685766570874, 1416.051245665386, 1441.553118533237, 1470.9190994495405, 1473.344361759007, 1476.6603681153395, 27614.895404183608, 28265.0, 28878.278043049093, 29927.55108673415, 30428.847855761465, 51411.0, 51954.48045519648, 52002.73998630134, 52024.53742356998, 52139.0, 531002.0, 534829.0, 535404.0, 536097.0, 536340.0, 40230.59769402268, 40682.79658601688, 40857.59142408538, 41034.38448423336, 41055.58944410518, 46568.301475477216, 46805.06389872116, 47178.52821471879, 47441.52558474509, 47609.0, 35514.65778676376, 38306.80846595749, 39141.41287880741, 39636.20727585375, 39782.403263951644, 38003.61996380001, 38583.89583416503, 39036.414453783786, 39077.0, 39698.60301397065, 31033.37933241368, 37643.0, 38180.427293590066, 38431.231375371775, 38537.0, 33261.833690831394, 33611.49582756212, 34594.0, 34675.826620866734, 35443.29113417666, 20358.59282814365, 24411.145609903568, 24584.385390365384, 25552.361190970376, 25558.23325300244], "value": 20226.983799575875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.3093645818775, 389.79730540119124, 392.1216475095785, 402.7643828360408, 425.4852724301487, 14564.271786410676, 18262.817371826277, 20527.281545145903, 21350.35948921531, 21570.56858862822, 21021.579568408622, 21874.0, 22418.0, 22535.0, 22685.0, 5621.550275977912, 5689.061304884699, 5921.467067963882, 5945.791897283596, 5964.910526342108, 5683.261176047108, 5712.11462223356, 5757.251557297566, 5769.221155144044, 5774.07614781635, 4786.712797232177, 5480.931218412411, 5721.5708821838525, 5728.427157284259, 5734.111212762028, 5592.356878958931, 5627.521660658849, 5653.830385088454, 5726.141078838207, 5742.569307301948, 1554.7434673278894, 1583.0818125487306, 4301.78491075445, 4998.600391890276, 5093.541581257705, 26965.32586685329, 27077.0, 27134.86432567844, 27261.0, 27296.863515682493, 2713.552263876478, 2716.456708658276, 2718.2660681615853, 2719.864006799672, 2744.684361298456, 15278.923605382013, 15285.465008724752, 15693.450729224536, 15798.0, 16485.58786030347, 1818.5362732503258, 1825.8904465732098, 1831.4414103698366, 1846.4091490722974, 1865.3657756362902, 115283.27075093964, 132702.33648831694, 133176.0, 134989.0, 137367.6263237375, 11454.484548195185, 11551.364674942959, 11772.293662380285, 11973.461194246105, 11994.340311282964, 12194.0, 13022.609321720363, 14921.776173357408, 15694.0, 15706.057636541844, 7056.153261608537, 8703.608337624823, 8802.339824513187, 8817.603207855662, 8895.555222238861, 8542.145785421533, 8560.315174786003, 8564.700235491728, 8695.478271303742, 8727.519986400808, 4815.2054910940005, 4816.807327706852, 4820.30105634681, 4832.323474713543, 4896.094222568765, 1772.3708083630383, 1784.3130394797836, 1789.5883946692334, 1953.1601411393237, 1970.1331414177716, 932.8460803967405, 962.5283611030544, 1023.3859684189426, 1026.3021145621049, 1071.2715353559654, 18334.358297459527, 20120.798792011894, 21491.355259342246, 21640.675389869164, 22030.88984555067, 1015.7866847961863, 1020.9846852297221, 1043.6034306963456, 1056.3925742697825, 1058.2803693488502, 10628.724553053684, 11335.0, 11428.771424571461, 11524.308541487537, 11573.768524629628, 733392.3330383314, 735258.0, 744397.0, 757480.2125989445, 762101.0, 123285.38357308335, 153678.46321536865, 159671.0, 161811.38188618197, 162590.0, 931.189864817613, 957.7653474898555, 998.940063596172, 1030.258214085857, 1035.6168217759478, 18005.0, 18867.811321886606, 19228.230870765572, 19231.807681923, 19452.027398630296, 59954.0, 61745.69127154336, 61906.452338691895, 62582.0, 62824.37175628185, 65371.34628653653, 89561.55219224123, 92313.53843230741, 92582.53708731414, 93466.06533934573, 8284.420090593601, 8487.27858132041, 8548.478198931454, 8649.437786543855, 8813.647454101763, 13227.074104812571, 13284.136531125447, 13306.401211945293, 13522.0, 13570.321483925567, 11462.484188211383, 11501.309921404743, 11728.354940478355, 11811.645650630495, 11860.288382697066, 11218.83171752408, 11232.213745037769, 11318.377489238172, 11576.01603863681, 11605.6518304451, 11652.766944661229, 11711.414429278673, 11936.343501107174, 12013.939930300292, 12071.39643017828, 8412.957935210285, 8460.450070745383, 8498.235158835734, 8612.18184272493, 8699.608517616849, 8754.562271886507, 11150.052245559218, 11267.830982535104, 11301.660950171508, 11742.471588778355], "value": 9966.354636443022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.1656930695542, 1449.9275036248184, 1458.8905832062594, 1469.985300146999, 1476.6603681153335, 8042.075161356438, 8454.788630284245, 8458.87311690325, 8468.153184681529, 8481.575921203937, 7407.962960185205, 7652.617369131549, 7657.54054756715, 8007.359411247086, 8261.173882611736, 2328.4877326988035, 2376.192094687806, 2379.8572085674914, 2381.1903952656094, 2383.1658919378165, 2355.34050465869, 2385.821063420242, 2386.474975505386, 2395.317334559651, 2399.7360290368047, 2335.2293743064747, 2343.437574982009, 2345.4754409633706, 2365.1603680693365, 2372.1223147435385, 2313.83803133779, 2318.40880575453, 2343.285297984114, 2347.929562113131, 2353.011735071274, 2343.60158773009, 2348.377679914824, 2374.3707917401903, 2376.061455724979, 2377.037299893546, 8312.501249925024, 8402.579871006425, 8407.159284071606, 8410.158984101541, 8416.074231834493, 4945.802167913279, 5100.668456550349, 5114.872128196787, 5122.974385128051, 5126.538611524943, 3248.675132486756, 3320.2197483591335, 3459.567554055743, 3505.5618047744033, 3523.6828685418177, 1206.5837286136268, 1224.9387530623433, 1698.3461367373527, 1748.3181559191798, 1817.9909100454545, 10721.14230861537, 10813.08088812452, 10840.078593319577, 10844.728881777939, 10871.130309575216, 4351.238533256731, 4543.909461729161, 4571.428571428572, 4577.267637178035, 4593.563611456906, 8749.825003499895, 8762.0, 8781.736547903573, 8794.60424280909, 8847.646094156291, 5152.098382783073, 5152.5362717354865, 5156.278121063054, 5157.252198431282, 5161.096808058574, 4589.839355622537, 4721.5986641135205, 4735.171345014609, 4821.228603423436, 4823.2282834746975, 3226.9838650806596, 3625.873094441682, 3737.0, 3772.1701225730294, 3772.283266179472, 1141.9543218271342, 1162.604714397092, 1169.818678104895, 1172.8709841917553, 1175.518037604595, 894.5840184314325, 907.7186072317603, 925.5233554719325, 926.5498652291147, 951.543259235557, 5647.350554686182, 5704.258446402024, 5795.681237531892, 5834.737436815353, 5983.760649573968, 960.8606752020918, 978.5303054533721, 1010.7725761703558, 1015.7105225010837, 1039.9480025998669, 3361.7478689098416, 3474.4788281757938, 3521.366154092288, 3773.9433908491396, 3820.7200587803395, 9756.365836220622, 10070.74823129413, 10072.697819065439, 10093.495325233856, 10115.949420252851, 10002.149817265468, 10016.048475394826, 10019.749506262402, 10023.148032417326, 10042.347247428894, 7533.434992375484, 7535.284148005931, 7650.196729343339, 7787.598232318124, 7836.647350869224, 5267.657602255841, 5432.239486471818, 5489.286392769074, 5496.285482887199, 5653.3216014076925, 7747.612619369122, 9002.279817614706, 9181.0, 9291.117343852324, 9293.535323233677, 8066.717664881701, 8487.066422693622, 8834.558272086499, 9268.073192680678, 9355.25157987373, 6193.504519638508, 6743.8988415172835, 6776.457883369417, 6864.141982252218, 6905.792826215222, 7912.36701063925, 7985.441019128605, 8081.0, 8103.31121854649, 8107.351411887153, 7117.125645867725, 7148.249433809375, 7217.747378841926, 7245.420366370783, 7285.2714728528845, 7070.575765454089, 7100.076989991268, 7111.466640001917, 7138.321859423347, 7150.284971502808, 6402.87194256103, 6418.234985378871, 6433.13152724395, 6535.477161827138, 6541.378569035934, 4968.552830245295, 4976.402831660079, 5016.54851063406, 5074.0, 5094.541491265803, 4985.451600323889, 5030.0191462664425, 5049.116404629249, 5138.12651849179, 5141.177411614124], "value": 4438.7898621733775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.28136194501286, 316.73552583592715, 355.5395762487579, 365.79698267461566, 376.3075940269903, 4366.345048242765, 4542.182407166709, 5019.6446959320965, 5165.527824569998, 5303.920441193381, 4962.602991760659, 5157.948420515794, 5164.612654050942, 5185.55922746566, 5267.789288428467, 3487.442009278516, 3835.712321575879, 4176.14389050244, 4212.789360531977, 4218.0720241546815, 3629.3467175908327, 4059.918801623966, 4155.812988415529, 4188.476440444944, 4240.766757828318, 4108.0140766216045, 4115.609017143366, 4125.876223713279, 4148.274052040896, 4193.853215137471, 3325.883594074208, 4126.277901367263, 4147.605977432139, 4150.792460376999, 4169.812358443847, 3683.907902302437, 3705.277470893177, 3709.573399059089, 3718.4980027696183, 3718.5537735471644, 4191.455110835603, 4494.955050449519, 4628.199939036902, 5098.949010509885, 5158.664686795346, 4035.3946907963746, 4535.9546404536195, 4808.942032752789, 4825.975870120662, 4850.175470170079, 4776.785044672998, 5383.703896285702, 5499.450054994509, 5608.5793565482345, 5657.727011422438, 3516.5780106387397, 3612.945805812915, 3840.9286156674016, 3976.443297938291, 4139.710220284582, 4680.438347398334, 5848.795292164754, 5862.794802181946, 5867.655436401295, 5915.072039340511, 3577.0, 3997.2804895118575, 4202.495700515958, 4227.58375944056, 4230.365445183247, 3709.8684901104884, 3941.3592892761917, 4192.392103145027, 4239.682023848224, 4253.2769429197115, 4034.778087205173, 4274.268921086965, 4641.350210970467, 4650.255959046536, 4672.509386514367, 5292.814751483679, 5760.884782304331, 5793.217915581343, 5794.217780599565, 5798.9420105799245, 1033.565902321027, 1195.3303358688743, 1245.6014075495755, 1255.993720031394, 1297.033709886141, 661.163628010567, 750.2984709296825, 858.3133493205536, 866.2333834556463, 882.9316527002399, 4208.705390622688, 4781.856544303607, 5088.92366614501, 5123.0, 5146.948530514722, 4485.596296333346, 5022.698638081727, 5455.290812194468, 5604.299462567179, 5624.971875140598, 5234.18870075139, 5358.705271210121, 5361.839144825662, 5364.822945857267, 5368.651037682538, 2441.963370549443, 2901.477734007899, 2907.6220091387986, 2921.816664250982, 2924.8154497428577, 5566.499015088581, 5593.776248950077, 5707.716913234739, 5811.476967072984, 6059.788312194544, 5388.757505912244, 5789.507891829157, 6034.879302413927, 6068.75724971005, 6077.4834139098675, 5759.164921086419, 5772.729999400125, 6110.938890611126, 6120.969395153084, 6135.7852475164045, 5352.5985551084605, 5792.913106303493, 5834.854128646818, 5842.269716285465, 5877.500412464989, 5572.721363931868, 5775.7400916957995, 5804.448577385142, 5825.359210486928, 5830.53355731532, 5067.670601410897, 5337.57299416038, 5611.064182856908, 5954.851128721816, 5984.730687119003, 3628.7822730636244, 3905.902352441212, 4008.4588580541254, 4301.333293339538, 4305.763183024838, 5076.157351882957, 5801.332846722681, 5879.382664820132, 5911.201987731602, 5963.2844058713235, 4817.470078291315, 5050.924236136534, 5092.618053645917, 5428.45715428454, 5629.6932846373375, 5104.744762761921, 5492.560595152298, 5655.85860353478, 5666.470053085726, 5695.231143795535, 4688.789004494738, 5303.867403314948, 5445.0, 5449.291592093003, 5627.718614069198, 4285.528591854956, 5559.2217089606675, 5628.367773345848, 5649.971750141223, 5678.488935995781, 4565.840195593139, 4776.877433803123, 4863.610911127172, 5069.645124841226, 5129.8717532062], "value": 4099.488701870068, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.5760172697244, 729.1942403643973, 741.8367959049008, 817.5462618246873, 831.256025856858, 14852.925735371322, 14893.255337233122, 15501.0, 15544.378224870992, 15677.529674109795, 13975.161490310564, 14156.858431415709, 14207.71584568308, 14450.277486125678, 14466.710665786677, 831.7546323834483, 845.750503601439, 847.2544161138189, 848.1476116502906, 849.9787505312355, 670.4502308107354, 686.3034020469228, 695.9652017399135, 843.4686147726954, 845.8858054162702, 868.2272777228272, 894.029977474441, 894.8970868350158, 899.0110878034176, 903.4218100415707, 887.3566664168491, 890.3322508118911, 895.1630225738955, 896.0278098263392, 896.1844721303582, 525.6346838946934, 667.3560014585947, 668.6122049211446, 669.5614372585964, 673.3300366135726, 10659.0, 14016.509422170277, 14589.9787014909, 14595.927020364936, 14993.32530036151, 14088.506902258372, 14167.504137355247, 14206.573802785933, 14218.786718199131, 14263.572092837128, 9075.909240907573, 10914.399708016055, 11175.385353805537, 11396.487158077907, 11582.0, 3574.1422058705984, 3624.4925710400566, 3729.3287208302495, 3794.6964242860504, 3844.0, 81717.59141204316, 87227.56386218092, 87240.0, 96980.0, 97895.55261118458, 10550.841737373945, 10564.313319634199, 11015.669529914116, 11054.944725276322, 11179.720506987227, 21787.019584118752, 22059.448513787283, 22204.22285220042, 22206.77793222047, 22328.441788955406, 7865.488743231672, 7888.329491993245, 7889.250521200477, 7913.208679132041, 8000.439969202216, 4227.725197862129, 4254.489461264668, 4357.869263922087, 4384.167008268419, 4516.593506584423, 3490.6334834842482, 3549.219171782204, 3588.7129029677562, 3628.8004159771467, 3628.983884512341, 618.1315252070848, 637.6970938804031, 639.9456046236122, 641.2625480697236, 647.6211416321505, 644.4940721533574, 657.5462930577886, 694.4270976444453, 700.7757517594423, 716.5306724095726, 9283.396579222464, 9631.036896310314, 9812.116909478182, 10009.749756256151, 10166.949165254275, 686.4062585863293, 693.1924308180912, 696.7247937064831, 700.9649517524103, 715.5241764226731, 3834.0031591786337, 4534.13851368239, 4810.807567697323, 4815.30178124177, 4818.518148185153, 103991.0, 104389.0, 105542.94457055331, 106812.0, 108893.91106088996, 88957.66563501552, 89326.55336723274, 91167.08832911719, 91363.77726004558, 95702.0, 78118.0, 79487.01282467753, 79513.80729289065, 80258.5987070061, 82600.0, 8844.73465796027, 9440.85838712406, 10127.79744405093, 10758.784824303626, 11038.889611104107, 50427.243591345425, 51709.22436163536, 51858.0, 52832.037597179595, 53978.73010634922, 45602.859928502054, 68258.0, 68482.63034739377, 69177.30822691708, 70223.0, 11547.249428787101, 12135.635930922086, 12355.75288494243, 12797.616071517868, 12858.871411286142, 13567.86432135666, 13667.86332136666, 14589.27053647292, 15078.396864125312, 15107.39570417215, 11847.215150698183, 12444.253344799341, 12467.563635273085, 12874.871251287368, 12950.417231224807, 10776.407297598707, 12554.246745195318, 12615.233867258774, 13041.282729449591, 13482.52811151605, 9532.809343812945, 12088.436456179614, 12268.570600028956, 12440.440180191732, 12578.30819304947, 9679.467629280458, 10338.0, 10903.56385744593, 11256.437178140897, 11525.884741152817, 10693.465326733787, 10948.178886583379, 10962.835557466804, 10980.231383803057, 11073.0], "value": 7352.086506759168, "unit": "score"}], "name": "dromaeo_css", "value": 7321.822663057678, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 163.0, 173.0, 113.0, 115.0, 115.0, 114.0, 116.0, 114.0, 114.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 110.0, 144.0, 110.0, 108.0, 108.0, 119.0, 164.0, 111.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 187.0, 183.0, 185.0, 182.0, 185.0, 181.0, 183.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 57.0, 90.0, 60.0, 57.0, 57.0, 61.0, 92.0, 83.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 69.0, 68.0, 68.0, 81.0, 67.0, 68.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 85.0, 89.0, 87.0, 88.0, 86.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 97.0, 109.0, 151.0, 120.0, 97.0, 95.0, 104.0], "value": 105.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 88.0, 87.0, 86.0, 86.0, 86.0, 87.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 52.0, 53.0, 54.0, 57.0, 57.0, 56.0, 56.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 77.0, 80.0, 73.0, 73.0, 71.0, 70.0, 70.0, 68.0, 73.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 83.0, 82.0, 83.0, 85.0, 81.0, 85.0, 80.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 140.0, 153.0, 145.0, 146.0, 151.0, 149.0, 207.0, 148.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 167.0, 164.0, 166.0, 164.0, 166.0, 166.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 86.0, 88.0, 86.0, 72.0, 66.0, 65.0, 65.0, 65.0], "value": 72.7, "unit": "score"}], "name": "kraken", "value": 1457.7000000000003, "alertThreshold": 2.0}]} 02:34:01 INFO - Return code: 0 02:34:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:01 ERROR - # TBPL SUCCESS # 02:34:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:01 INFO - 2017-03-04 02:34:01.277 screenresolution[1663:11265] starting screenresolution argv=screenresolution get 02:34:01 INFO - 2017-03-04 02:34:01.280 screenresolution[1663:11265] Display 0: 1600x1200x32@60 02:34:01 INFO - 2017-03-04 02:34:01.286 screenresolution[1664:11268] starting screenresolution argv=screenresolution list 02:34:01 INFO - Available Modes on Display 0 02:34:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:01 INFO - Intel Iris: 02:34:01 INFO - Chipset Model: Intel Iris 02:34:01 INFO - Type: GPU 02:34:01 INFO - Bus: Built-In 02:34:01 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:01 INFO - Vendor: Intel (0x8086) 02:34:01 INFO - Device ID: 0x0a2e 02:34:01 INFO - Revision ID: 0x0009 02:34:01 INFO - Displays: 02:34:01 INFO - Display: 02:34:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:01 INFO - Display Serial Number: 1600x1200 60 02:34:01 INFO - Main Display: Yes 02:34:01 INFO - Mirror: Off 02:34:01 INFO - Online: Yes 02:34:01 INFO - Rotation: Supported 02:34:01 INFO - Return code: 0 02:34:01 INFO - Running post-action listener: _resource_record_post_action 02:34:01 INFO - [mozharness: 2017-03-04 10:34:01.522145Z] Finished run-tests step (success) 02:34:01 INFO - Running post-run listener: _resource_record_post_run 02:34:01 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 32533504; Write bytes: 510635008; Read time: 190; Write time: 1574 02:34:01 INFO - TinderboxPrint: CPU usage
53.5% 02:34:01 INFO - TinderboxPrint: I/O read bytes / time
32,533,504 / 190 02:34:01 INFO - TinderboxPrint: I/O write bytes / time
510,635,008 / 1,574 02:34:01 INFO - TinderboxPrint: CPU idle
2,229.7 (46.5%) 02:34:01 INFO - TinderboxPrint: CPU system
957.6 (20.0%) 02:34:01 INFO - TinderboxPrint: CPU user
1,610.4 (33.6%) 02:34:01 INFO - TinderboxPrint: Swap in / out
236,027,904 / 0 02:34:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203590144; Write bytes: 201746432; Read time: 15442; Write time: 436 02:34:01 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30469120; Write bytes: 298005504; Read time: 172; Write time: 1102 02:34:01 INFO - Running post-run listener: _upload_blobber_files 02:34:01 INFO - Blob upload gear active. 02:34:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:01 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 02:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:34:02 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:03 INFO - (blobuploader) - INFO - Done attempting. 02:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:04 INFO - (blobuploader) - INFO - Done attempting. 02:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:34:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:34:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:05 INFO - (blobuploader) - INFO - Done attempting. 02:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:07 INFO - (blobuploader) - INFO - Done attempting. 02:34:07 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:07 INFO - Return code: 0 02:34:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35c54da9d5e07cf9be7192345fdbeb90ea5c7d490d39bfc24b8a56021302b6bf7aa3d7499672f09973fc56872c2125d8996b9b7775b478861dabedc95fc2cdb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c05882e2ff9a68fcaacfdbf917be028075b4693bb7e465c58155b1499c83595a12b598ae7a3fda2f2a9e61a6fa9cd4edf846ed3affdf779ee419790f66303224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18802ccda1cef380021682c68b81683e6b4ecc8eabf251dbad40b0e41d4f21e2e645fbfe0341cf4bb35e580bfa35ee1168c931cc55df0892b37320872142bf9d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05ea1e78c1b9f48e0bd7e9d197dccffd9666c90ca5f2becd1e1dd13bd76c9c99d6752ddfb5bd0d9bb2d60dcd0e6ddcd2fe6c4eec08cb510f6e344d068e969072"} 02:34:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:07 INFO - Contents: 02:34:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35c54da9d5e07cf9be7192345fdbeb90ea5c7d490d39bfc24b8a56021302b6bf7aa3d7499672f09973fc56872c2125d8996b9b7775b478861dabedc95fc2cdb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c05882e2ff9a68fcaacfdbf917be028075b4693bb7e465c58155b1499c83595a12b598ae7a3fda2f2a9e61a6fa9cd4edf846ed3affdf779ee419790f66303224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18802ccda1cef380021682c68b81683e6b4ecc8eabf251dbad40b0e41d4f21e2e645fbfe0341cf4bb35e580bfa35ee1168c931cc55df0892b37320872142bf9d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05ea1e78c1b9f48e0bd7e9d197dccffd9666c90ca5f2becd1e1dd13bd76c9c99d6752ddfb5bd0d9bb2d60dcd0e6ddcd2fe6c4eec08cb510f6e344d068e969072"} 02:34:07 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:07 INFO - Copying logs to upload dir... 02:34:07 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.606094 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-03-04 02:34:08.010322) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 02:34:08.015207) ========= 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.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35c54da9d5e07cf9be7192345fdbeb90ea5c7d490d39bfc24b8a56021302b6bf7aa3d7499672f09973fc56872c2125d8996b9b7775b478861dabedc95fc2cdb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c05882e2ff9a68fcaacfdbf917be028075b4693bb7e465c58155b1499c83595a12b598ae7a3fda2f2a9e61a6fa9cd4edf846ed3affdf779ee419790f66303224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18802ccda1cef380021682c68b81683e6b4ecc8eabf251dbad40b0e41d4f21e2e645fbfe0341cf4bb35e580bfa35ee1168c931cc55df0892b37320872142bf9d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05ea1e78c1b9f48e0bd7e9d197dccffd9666c90ca5f2becd1e1dd13bd76c9c99d6752ddfb5bd0d9bb2d60dcd0e6ddcd2fe6c4eec08cb510f6e344d068e969072"} build_url:https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/IQsVqrddSXegae6kDaHGFQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35c54da9d5e07cf9be7192345fdbeb90ea5c7d490d39bfc24b8a56021302b6bf7aa3d7499672f09973fc56872c2125d8996b9b7775b478861dabedc95fc2cdb7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c05882e2ff9a68fcaacfdbf917be028075b4693bb7e465c58155b1499c83595a12b598ae7a3fda2f2a9e61a6fa9cd4edf846ed3affdf779ee419790f66303224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18802ccda1cef380021682c68b81683e6b4ecc8eabf251dbad40b0e41d4f21e2e645fbfe0341cf4bb35e580bfa35ee1168c931cc55df0892b37320872142bf9d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05ea1e78c1b9f48e0bd7e9d197dccffd9666c90ca5f2becd1e1dd13bd76c9c99d6752ddfb5bd0d9bb2d60dcd0e6ddcd2fe6c4eec08cb510f6e344d068e969072"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 02:34:08.053715) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:34:08.054095) ========= 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.Rguniw8E1N/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.MEwYLDqs9G/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005046 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 02:34:08.103158) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 02:34:08.103478) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 02:34:08.103834) ========= ========= Total master_lag: 0.25 =========