builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1475616157.27 results: success (0) buildid: 20161004120300 builduid: 5a1324f03103486099d348d61298553a revision: 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.271724) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.272222) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.272509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.295179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.295600) ========= 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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-04 14:22:37-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.5M=0s 2016-10-04 14:22:37 (56.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086898 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.405193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.405530) ========= 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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.021562 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.454720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:37.455125) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-04 14:22:37,524 truncating revision to first 12 chars 2016-10-04 14:22:37,524 Setting DEBUG logging. 2016-10-04 14:22:37,524 attempt 1/10 2016-10-04 14:22:37,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2d4f6c10aacf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 14:22:38,186 unpacking tar archive at: autoland-2d4f6c10aacf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.919355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:38.396952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:38.397350) ========= script_repo_revision: 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:38.397826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:38.398281) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 14:22:38.416385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-10-04 14:22:38.416799) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:22:38 INFO - MultiFileLogger online at 20161004 14:22:38 in /builds/slave/test 14:22:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:22:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:38 INFO - {'append_to_log': False, 14:22:38 INFO - 'base_work_dir': '/builds/slave/test', 14:22:38 INFO - 'blob_upload_branch': 'Autoland', 14:22:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:38 INFO - 'branch': 'Autoland', 14:22:38 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:38 INFO - 'config_files': ('talos/mac_config.py',), 14:22:38 INFO - 'default_actions': ('clobber', 14:22:38 INFO - 'read-buildbot-config', 14:22:38 INFO - 'download-and-extract', 14:22:38 INFO - 'populate-webroot', 14:22:38 INFO - 'create-virtualenv', 14:22:38 INFO - 'install', 14:22:38 INFO - 'run-tests'), 14:22:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:38 INFO - 'download_minidump_stackwalk': True, 14:22:38 INFO - 'download_symbols': 'ondemand', 14:22:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:38 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:38 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:38 INFO - 'installer_path': 'installer.exe', 14:22:38 INFO - 'log_level': 'info', 14:22:38 INFO - 'log_name': 'talos', 14:22:38 INFO - 'log_to_console': True, 14:22:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:22:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:22:38 INFO - 'opt_config_files': (), 14:22:38 INFO - 'pip_index': False, 14:22:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:38 INFO - 'cmd': ('bash', 14:22:38 INFO - '-c', 14:22:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:38 INFO - 'enabled': True, 14:22:38 INFO - 'halt_on_failure': False, 14:22:38 INFO - 'name': 'check_screen_resolution'},), 14:22:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:38 INFO - 'cmd': ('bash', 14:22:38 INFO - '-c', 14:22:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:38 INFO - 'enabled': True, 14:22:38 INFO - 'halt_on_failure': False, 14:22:38 INFO - 'name': 'check_screen_resolution'},), 14:22:38 INFO - 'run_cmd_checks_enabled': True, 14:22:38 INFO - 'sps_profile': False, 14:22:38 INFO - 'sps_profile_interval': 0, 14:22:38 INFO - 'suite': 'dromaeojs', 14:22:38 INFO - 'system_bits': '32', 14:22:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:38 INFO - 'title': 't-yosemite-r7-0375', 14:22:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:38 INFO - 'use_talos_json': True, 14:22:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:38 INFO - 'work_dir': 'build'} 14:22:38 INFO - [mozharness: 2016-10-04 21:22:38.607878Z] Running clobber step. 14:22:38 INFO - Running pre-action listener: _resource_record_pre_action 14:22:38 INFO - Running main action method: clobber 14:22:38 INFO - rmtree: /builds/slave/test/build 14:22:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:40 INFO - Running post-action listener: _resource_record_post_action 14:22:40 INFO - [mozharness: 2016-10-04 21:22:40.986332Z] Finished clobber step (success) 14:22:40 INFO - [mozharness: 2016-10-04 21:22:40.986547Z] Running read-buildbot-config step. 14:22:40 INFO - Running pre-action listener: _resource_record_pre_action 14:22:40 INFO - Running main action method: read_buildbot_config 14:22:40 INFO - Using buildbot properties: 14:22:40 INFO - { 14:22:40 INFO - "project": "", 14:22:40 INFO - "product": "firefox", 14:22:40 INFO - "script_repo_revision": "production", 14:22:40 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:22:40 INFO - "repository": "", 14:22:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:22:40 INFO - "buildid": "20161004120300", 14:22:40 INFO - "pgo_build": "False", 14:22:40 INFO - "basedir": "/builds/slave/test", 14:22:40 INFO - "buildnumber": 360, 14:22:40 INFO - "slavename": "t-yosemite-r7-0375", 14:22:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:22:40 INFO - "platform": "yosemite_r7", 14:22:40 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:22:40 INFO - "branch": "autoland", 14:22:40 INFO - "repo_path": "integration/autoland", 14:22:40 INFO - "revision": "2d4f6c10aacfb9a319624a9df50d7b0769cfafa9", 14:22:40 INFO - "stage_platform": "macosx64", 14:22:40 INFO - "builduid": "5a1324f03103486099d348d61298553a", 14:22:40 INFO - "slavebuilddir": "test" 14:22:40 INFO - } 14:22:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:22:40 INFO - Running post-action listener: _resource_record_post_action 14:22:40 INFO - [mozharness: 2016-10-04 21:22:40.992447Z] Finished read-buildbot-config step (success) 14:22:40 INFO - [mozharness: 2016-10-04 21:22:40.992599Z] Running download-and-extract step. 14:22:40 INFO - Running pre-action listener: _resource_record_pre_action 14:22:40 INFO - Running main action method: download_and_extract 14:22:40 INFO - mkdir: /builds/slave/test/build/tests 14:22:40 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')]} 14:22:40 INFO - trying https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:22:40 INFO - Downloading https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:22:42 INFO - Downloaded 1057 bytes. 14:22:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:22:42 INFO - Using the following test package requirements: 14:22:42 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:22:42 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:22:42 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:22:42 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'jsshell-mac.zip'], 14:22:42 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:22:42 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:22:42 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:22:42 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:22:42 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:22:42 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:22:42 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:22:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:22:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:22:42 INFO - Fetch https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:22:43 INFO - Http code: 200 14:22:43 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 14:22:43 INFO - x-amz-cf-id: XRRLKluws6NdNZYF6ud6oBGTw5zM1Jo6ziRHjZKgfzJpypXMN24woA== 14:22:43 INFO - x-amz-version-id: mZIsACdx0PL4ZR_cV8MqloCnpdfwpnqK 14:22:44 INFO - Expected file size: 16477175 14:22:44 INFO - Obtained file size: 16477175 14:22:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:22:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:22:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:22:50 INFO - Fetch https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:22:51 INFO - Http code: 200 14:22:51 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 14:22:51 INFO - x-amz-cf-id: 28IlBHeQsU9q3Py802KXCFJ2c42xQZhDMDSIWcPhRsgFn7PZM0mF8Q== 14:22:51 INFO - x-amz-version-id: mZIsACdx0PL4ZR_cV8MqloCnpdfwpnqK 14:22:51 INFO - Expected file size: 16477175 14:22:51 INFO - Obtained file size: 16477175 14:22:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:22:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:22:58 INFO - Fetch https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:22:59 INFO - Http code: 200 14:22:59 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:22:59 INFO - x-amz-cf-id: 6UXBg6GH-S0eq3lvxdjOi5W_mu1CFX1VmNKupZvGanCTpdpLmQrGLA== 14:22:59 INFO - x-amz-version-id: gM0bj5oxod6fwGjnG8ltUnkAvwHCMY8S 14:23:00 INFO - Expected file size: 14409006 14:23:00 INFO - Obtained file size: 14409006 14:23: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')]} 14:23:01 INFO - trying https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:23:25 INFO - Downloaded 111672634 bytes. 14:23:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:23:25 INFO - mkdir: /builds/slave/test/properties 14:23:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:23:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:23:25 INFO - Contents: 14:23:25 INFO - build_url:https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:23:26 INFO - Running post-action listener: _resource_record_post_action 14:23:26 INFO - Running post-action listener: set_extra_try_arguments 14:23:26 INFO - [mozharness: 2016-10-04 21:23:26.127691Z] Finished download-and-extract step (success) 14:23:26 INFO - [mozharness: 2016-10-04 21:23:26.127816Z] Running populate-webroot step. 14:23:26 INFO - Running pre-action listener: _resource_record_pre_action 14:23:26 INFO - Running main action method: populate_webroot 14:23:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:23:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:23:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:23:26 INFO - '--tppagecycles', 14:23:26 INFO - '7'], 14:23:26 INFO - 'tests': ['tsvgm']}}, 14:23:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:23:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:23:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:23:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:23:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:23:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['damp', 'tps']}, 14:23:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'tests': ['damp', 'tps']}, 14:23:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['dromaeo_dom']}, 14:23:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:23:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['basic_compositor_video']}, 14:23:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:23:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['a11yr', 14:23:26 INFO - 'ts_paint', 14:23:26 INFO - 'tpaint', 14:23:26 INFO - 'sessionrestore', 14:23:26 INFO - 'sessionrestore_no_auto_restore', 14:23:26 INFO - 'tabpaint']}, 14:23:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['tsvgx', 14:23:26 INFO - 'tsvgr_opacity', 14:23:26 INFO - 'tart', 14:23:26 INFO - 'tscrollx', 14:23:26 INFO - 'cart']}, 14:23:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:23:26 INFO - 'tsvgr_opacity', 14:23:26 INFO - 'tart', 14:23:26 INFO - 'tscrollx', 14:23:26 INFO - 'cart']}, 14:23:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'talos_options': ['--disable-e10s'], 14:23:26 INFO - 'tests': ['tp5o']}, 14:23:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'tests': ['tp5o']}, 14:23:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'talos_options': ['--disable-e10s', 14:23:26 INFO - '--xperf_path', 14:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:26 INFO - 'tests': ['tp5n']}, 14:23:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:23:26 INFO - 'talos_options': ['--xperf_path', 14:23:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:23:26 INFO - 'tests': ['tp5n']}}, 14:23:26 INFO - 'talos.zip': {'path': '', 14:23:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:23:26 INFO - Running post-action listener: _resource_record_post_action 14:23:26 INFO - [mozharness: 2016-10-04 21:23:26.146439Z] Finished populate-webroot step (success) 14:23:26 INFO - [mozharness: 2016-10-04 21:23:26.146574Z] Running create-virtualenv step. 14:23:26 INFO - Running pre-action listener: _resource_record_pre_action 14:23:26 INFO - Running main action method: create_virtualenv 14:23:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:23:26 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 14:23:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:23:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:23:26 INFO - Using real prefix '/tools/python27' 14:23:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:23:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:23:29 INFO - Installing pip.................done. 14:23:29 INFO - Return code: 0 14:23:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:23:30 INFO - Reading from file tmpfile_stdout 14:23:30 INFO - Output received: 14:23:30 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) 14:23:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:30 INFO - 'HOME': '/Users/cltbld', 14:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:30 INFO - 'LOGNAME': 'cltbld', 14:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:30 INFO - 'MOZ_NO_REMOTE': '1', 14:23:30 INFO - 'NO_EM_RESTART': '1', 14:23:30 INFO - 'PAGER': '/bin/cat', 14:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:30 INFO - 'PWD': '/builds/slave/test', 14:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:30 INFO - 'SHELL': '/bin/bash', 14:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:30 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:30 INFO - 'USER': 'cltbld', 14:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:30 INFO - 'XPC_FLAGS': '0x0', 14:23:30 INFO - 'XPC_SERVICE_NAME': '0', 14:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:30 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 14:23:30 INFO - Cleaning up... 14:23:30 INFO - Return code: 0 14:23:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:23:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:23:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:30 INFO - 'HOME': '/Users/cltbld', 14:23:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:30 INFO - 'LOGNAME': 'cltbld', 14:23:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:30 INFO - 'MOZ_NO_REMOTE': '1', 14:23:30 INFO - 'NO_EM_RESTART': '1', 14:23:30 INFO - 'PAGER': '/bin/cat', 14:23:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:30 INFO - 'PWD': '/builds/slave/test', 14:23:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:30 INFO - 'SHELL': '/bin/bash', 14:23:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:30 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:30 INFO - 'USER': 'cltbld', 14:23:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:30 INFO - 'XPC_FLAGS': '0x0', 14:23:30 INFO - 'XPC_SERVICE_NAME': '0', 14:23:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:30 INFO - Downloading/unpacking psutil>=3.1.1 14:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:23:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:34 INFO - Installing collected packages: psutil 14:23:34 INFO - Running setup.py install for psutil 14:23:34 INFO - building 'psutil._psutil_osx' extension 14:23:34 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 14:23:34 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 14:23:34 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 14:23:34 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 14:23:34 INFO - building 'psutil._psutil_posix' extension 14:23:34 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 14:23:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:23:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:23:34 INFO - ^ 14:23:34 INFO - 1 warning generated. 14:23:34 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 14:23:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:23:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:23:34 INFO - Successfully installed psutil 14:23:34 INFO - Cleaning up... 14:23:35 INFO - Return code: 0 14:23:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:23:35 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')]} 14:23:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:35 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')]} 14:23:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:35 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 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:35 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 14:23:35 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 14:23:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:35 INFO - 'HOME': '/Users/cltbld', 14:23:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:35 INFO - 'LOGNAME': 'cltbld', 14:23:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:35 INFO - 'MOZ_NO_REMOTE': '1', 14:23:35 INFO - 'NO_EM_RESTART': '1', 14:23:35 INFO - 'PAGER': '/bin/cat', 14:23:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:35 INFO - 'PWD': '/builds/slave/test', 14:23:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:35 INFO - 'SHELL': '/bin/bash', 14:23:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:35 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:35 INFO - 'USER': 'cltbld', 14:23:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:35 INFO - 'XPC_FLAGS': '0x0', 14:23:35 INFO - 'XPC_SERVICE_NAME': '0', 14:23:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:23:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:23:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:23:38 INFO - Installing collected packages: mozsystemmonitor 14:23:38 INFO - Running setup.py install for mozsystemmonitor 14:23:39 INFO - Successfully installed mozsystemmonitor 14:23:39 INFO - Cleaning up... 14:23:39 INFO - Return code: 0 14:23:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:23:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:23:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:39 INFO - 'HOME': '/Users/cltbld', 14:23:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:39 INFO - 'LOGNAME': 'cltbld', 14:23:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:39 INFO - 'MOZ_NO_REMOTE': '1', 14:23:39 INFO - 'NO_EM_RESTART': '1', 14:23:39 INFO - 'PAGER': '/bin/cat', 14:23:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:39 INFO - 'PWD': '/builds/slave/test', 14:23:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:39 INFO - 'SHELL': '/bin/bash', 14:23:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:39 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:39 INFO - 'USER': 'cltbld', 14:23:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:39 INFO - 'XPC_FLAGS': '0x0', 14:23:39 INFO - 'XPC_SERVICE_NAME': '0', 14:23:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:23:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:23:41 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 14:23:41 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 14:23:41 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 14:23:41 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 14:23:41 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 14:23:41 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 14:23:42 INFO - Downloading functools32-3.2.3-2.tar.gz 14:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:23:42 INFO - warning: no files found matching '*.txt' 14:23:42 INFO - no previously-included directories found matching 'build' 14:23:42 INFO - no previously-included directories found matching 'dist' 14:23:42 INFO - no previously-included directories found matching '.git*' 14:23:42 INFO - Installing collected packages: jsonschema, functools32 14:23:42 INFO - Running setup.py install for functools32 14:23:42 INFO - warning: no files found matching '*.txt' 14:23:42 INFO - no previously-included directories found matching 'build' 14:23:42 INFO - no previously-included directories found matching 'dist' 14:23:42 INFO - no previously-included directories found matching '.git*' 14:23:42 INFO - Successfully installed jsonschema functools32 14:23:42 INFO - Cleaning up... 14:23:42 INFO - Return code: 0 14:23:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:42 INFO - 'HOME': '/Users/cltbld', 14:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:42 INFO - 'LOGNAME': 'cltbld', 14:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:42 INFO - 'MOZ_NO_REMOTE': '1', 14:23:42 INFO - 'NO_EM_RESTART': '1', 14:23:42 INFO - 'PAGER': '/bin/cat', 14:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:42 INFO - 'PWD': '/builds/slave/test', 14:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:42 INFO - 'SHELL': '/bin/bash', 14:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:42 INFO - 'USER': 'cltbld', 14:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:42 INFO - 'XPC_FLAGS': '0x0', 14:23:42 INFO - 'XPC_SERVICE_NAME': '0', 14:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:23:42 INFO - Cleaning up... 14:23:42 INFO - Return code: 0 14:23:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:23:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:42 INFO - 'HOME': '/Users/cltbld', 14:23:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:42 INFO - 'LOGNAME': 'cltbld', 14:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:42 INFO - 'MOZ_NO_REMOTE': '1', 14:23:42 INFO - 'NO_EM_RESTART': '1', 14:23:42 INFO - 'PAGER': '/bin/cat', 14:23:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:42 INFO - 'PWD': '/builds/slave/test', 14:23:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:42 INFO - 'SHELL': '/bin/bash', 14:23:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:42 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:42 INFO - 'USER': 'cltbld', 14:23:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:42 INFO - 'XPC_FLAGS': '0x0', 14:23:42 INFO - 'XPC_SERVICE_NAME': '0', 14:23:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23: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 14:23:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:23:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:23:45 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 14:23:45 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 14:23:45 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 14:23:45 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 14:23:45 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 14:23:45 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 14:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:23:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:46 INFO - Downloading docopt-0.6.1.tar.gz 14:23:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:23:47 INFO - Installing collected packages: blobuploader, requests, docopt 14:23:47 INFO - Running setup.py install for blobuploader 14:23:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:23:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:23:47 INFO - Running setup.py install for requests 14:23:47 INFO - Running setup.py install for docopt 14:23:47 INFO - Successfully installed blobuploader requests docopt 14:23:47 INFO - Cleaning up... 14:23:47 INFO - Return code: 0 14:23:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:47 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 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:47 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 14:23:47 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 14:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:47 INFO - 'HOME': '/Users/cltbld', 14:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:47 INFO - 'LOGNAME': 'cltbld', 14:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:47 INFO - 'MOZ_NO_REMOTE': '1', 14:23:47 INFO - 'NO_EM_RESTART': '1', 14:23:47 INFO - 'PAGER': '/bin/cat', 14:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:47 INFO - 'PWD': '/builds/slave/test', 14:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:47 INFO - 'SHELL': '/bin/bash', 14:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:47 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:47 INFO - 'USER': 'cltbld', 14:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:47 INFO - 'XPC_FLAGS': '0x0', 14:23:47 INFO - 'XPC_SERVICE_NAME': '0', 14:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-EIjT2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-RWjgsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-55mX2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SkXrrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-p6PGiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-YbuINk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MiaGyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-03auSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-QjVea6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8GiCXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-FH0dSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-iXdkiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-xQ3tRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-46uHZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ZR9Dx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-uoGM_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lCI2A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:23:49 INFO - Running setup.py install for manifestparser 14:23:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:23:50 INFO - Running setup.py install for mozcrash 14:23:50 INFO - Running setup.py install for mozdebug 14:23:50 INFO - Running setup.py install for mozdevice 14:23:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:23:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:23:50 INFO - Running setup.py install for mozfile 14:23:50 INFO - Running setup.py install for mozhttpd 14:23:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:23:50 INFO - Running setup.py install for mozinfo 14:23:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:23:50 INFO - Running setup.py install for mozInstall 14:23:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Running setup.py install for mozleak 14:23:51 INFO - Running setup.py install for mozlog 14:23:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Running setup.py install for moznetwork 14:23:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Running setup.py install for mozprocess 14:23:51 INFO - Running setup.py install for mozprofile 14:23:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:23:51 INFO - Running setup.py install for mozrunner 14:23:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:23:52 INFO - Running setup.py install for mozscreenshot 14:23:52 INFO - Running setup.py install for moztest 14:23:52 INFO - Running setup.py install for mozversion 14:23:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:23:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:23:52 INFO - Cleaning up... 14:23:52 INFO - Return code: 0 14:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:52 INFO - 'HOME': '/Users/cltbld', 14:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:52 INFO - 'LOGNAME': 'cltbld', 14:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:52 INFO - 'MOZ_NO_REMOTE': '1', 14:23:52 INFO - 'NO_EM_RESTART': '1', 14:23:52 INFO - 'PAGER': '/bin/cat', 14:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:52 INFO - 'PWD': '/builds/slave/test', 14:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:52 INFO - 'SHELL': '/bin/bash', 14:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:52 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:52 INFO - 'USER': 'cltbld', 14:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:52 INFO - 'XPC_FLAGS': '0x0', 14:23:52 INFO - 'XPC_SERVICE_NAME': '0', 14:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:23:52 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dKj6_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:23:52 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)) 14:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:23:52 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-QCnvXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-IieuFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8KiyZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Ox3F4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-MvYN_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-kTBKet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-StkYEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-D6NQvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-aR2XJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:23:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-6A0BnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:23:53 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)) 14:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:23:53 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-lASFC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:23:54 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-DXr1ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:23:54 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-e_Okdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:54 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-PQUdeg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:23:54 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-C1tRaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:23:54 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-owMJGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:23:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:23:57 INFO - Downloading blessings-1.6.tar.gz 14:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:23:57 INFO - Installing collected packages: blessings 14:23:57 INFO - Running setup.py install for blessings 14:23:57 INFO - Successfully installed blessings 14:23:57 INFO - Cleaning up... 14:23:57 INFO - Return code: 0 14:23:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:23:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:57 INFO - Reading from file tmpfile_stdout 14:23:57 INFO - Current package versions: 14:23:57 INFO - blessings == 1.6 14:23:57 INFO - blobuploader == 1.2.4 14:23:57 INFO - docopt == 0.6.1 14:23:57 INFO - functools32 == 3.2.3-2 14:23:57 INFO - jsonschema == 2.5.1 14:23:57 INFO - manifestparser == 1.1 14:23:57 INFO - mozInstall == 1.12 14:23:57 INFO - mozcrash == 0.17 14:23:57 INFO - mozdebug == 0.1 14:23:57 INFO - mozdevice == 0.48 14:23:57 INFO - mozfile == 1.2 14:23:57 INFO - mozhttpd == 0.7 14:23:57 INFO - mozinfo == 0.9 14:23:57 INFO - mozleak == 0.1 14:23:57 INFO - mozlog == 3.4 14:23:57 INFO - moznetwork == 0.27 14:23:57 INFO - mozprocess == 0.23 14:23:57 INFO - mozprofile == 0.28 14:23:57 INFO - mozrunner == 6.12 14:23:57 INFO - mozscreenshot == 0.1 14:23:57 INFO - mozsystemmonitor == 0.3 14:23:57 INFO - moztest == 0.7 14:23:57 INFO - mozversion == 1.4 14:23:57 INFO - psutil == 3.1.1 14:23:57 INFO - requests == 1.2.3 14:23:57 INFO - wsgiref == 0.1.2 14:23:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:23:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:57 INFO - 'HOME': '/Users/cltbld', 14:23:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:57 INFO - 'LOGNAME': 'cltbld', 14:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:57 INFO - 'MOZ_NO_REMOTE': '1', 14:23:57 INFO - 'NO_EM_RESTART': '1', 14:23:57 INFO - 'PAGER': '/bin/cat', 14:23:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:57 INFO - 'PWD': '/builds/slave/test', 14:23:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:57 INFO - 'SHELL': '/bin/bash', 14:23:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:57 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:57 INFO - 'USER': 'cltbld', 14:23:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:57 INFO - 'XPC_FLAGS': '0x0', 14:23:57 INFO - 'XPC_SERVICE_NAME': '0', 14:23:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 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)) 14:23:57 INFO - Cleaning up... 14:23:58 INFO - Return code: 0 14:23:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:23:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c258490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa60ac7da30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, '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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 14:23:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:58 INFO - 'HOME': '/Users/cltbld', 14:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:58 INFO - 'LOGNAME': 'cltbld', 14:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:58 INFO - 'MOZ_NO_REMOTE': '1', 14:23:58 INFO - 'NO_EM_RESTART': '1', 14:23:58 INFO - 'PAGER': '/bin/cat', 14:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:58 INFO - 'PWD': '/builds/slave/test', 14:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:58 INFO - 'SHELL': '/bin/bash', 14:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:23:58 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:58 INFO - 'USER': 'cltbld', 14:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:58 INFO - 'XPC_FLAGS': '0x0', 14:23:58 INFO - 'XPC_SERVICE_NAME': '0', 14:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:23:58 INFO - Cleaning up... 14:23:58 INFO - Return code: 0 14:23:58 INFO - Running post-action listener: _resource_record_post_action 14:23:58 INFO - Running post-action listener: _start_resource_monitoring 14:23:58 INFO - Starting resource monitoring. 14:23:58 INFO - [mozharness: 2016-10-04 21:23:58.302086Z] Finished create-virtualenv step (success) 14:23:58 INFO - [mozharness: 2016-10-04 21:23:58.303152Z] Running install step. 14:23:58 INFO - Running pre-action listener: _resource_record_pre_action 14:23:58 INFO - Running main action method: install 14:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:23:58 INFO - Reading from file tmpfile_stdout 14:23:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:23:58 INFO - Reading from file tmpfile_stdout 14:23:58 INFO - Output received: 14:23:58 INFO - Usage: mozinstall [options] installer 14:23:58 INFO - Options: 14:23:58 INFO - -h, --help show this help message and exit 14:23:58 INFO - -d DEST, --destination=DEST 14:23:58 INFO - Directory to install application into. [default: 14:23:58 INFO - "/builds/slave/test"] 14:23:58 INFO - --app=APP Application being installed. [default: firefox] 14:23:58 INFO - mkdir: /builds/slave/test/build/application 14:23:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:23:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:24:33 INFO - Reading from file tmpfile_stdout 14:24:33 INFO - Output received: 14:24:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:24:33 INFO - Running post-action listener: _resource_record_post_action 14:24:33 INFO - [mozharness: 2016-10-04 21:24:33.323750Z] Finished install step (success) 14:24:33 INFO - [mozharness: 2016-10-04 21:24:33.323901Z] Running run-tests step. 14:24:33 INFO - Running pre-action listener: _resource_record_pre_action 14:24:33 INFO - Running main action method: run_tests 14:24:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:24:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:24:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:24:33 INFO - 2016-10-04 14:24:33.337 screenresolution[1932:18496] starting screenresolution argv=screenresolution get 14:24:33 INFO - 2016-10-04 14:24:33.339 screenresolution[1932:18496] Display 0: 1600x1200x32@60 14:24:33 INFO - 2016-10-04 14:24:33.344 screenresolution[1933:18498] starting screenresolution argv=screenresolution list 14:24:33 INFO - Available Modes on Display 0 14:24:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:24:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:24:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:24:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:24:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:24:33 INFO - Intel Iris: 14:24:33 INFO - Chipset Model: Intel Iris 14:24:33 INFO - Type: GPU 14:24:33 INFO - Bus: Built-In 14:24:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:24:33 INFO - Vendor: Intel (0x8086) 14:24:33 INFO - Device ID: 0x0a2e 14:24:33 INFO - Revision ID: 0x0009 14:24:33 INFO - Displays: 14:24:33 INFO - Display: 14:24:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:24:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:24:33 INFO - Display Serial Number: 1600x1200 60 14:24:33 INFO - Main Display: Yes 14:24:33 INFO - Mirror: Off 14:24:33 INFO - Online: Yes 14:24:33 INFO - Rotation: Supported 14:24:33 INFO - Return code: 0 14:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:24:33 INFO - Python 2.7.3 14:24:33 INFO - Return code: 0 14:24:33 INFO - grabbing minidump binary from tooltool 14:24: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')]} 14:24:33 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 0x10c06cd30>, '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 0x10be92db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c064b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:24:33 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 14:24:33 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 14:24:33 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 14:24:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:24:33 INFO - Return code: 0 14:24:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:24:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:24:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:24:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:24:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 14:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 14:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kWDGRYFMnH/Render', 14:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:24:33 INFO - 'HOME': '/Users/cltbld', 14:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:24:33 INFO - 'LOGNAME': 'cltbld', 14:24:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:24:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:24:33 INFO - 'MOZ_NO_REMOTE': '1', 14:24:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:24:33 INFO - 'NO_EM_RESTART': '1', 14:24:33 INFO - 'PAGER': '/bin/cat', 14:24:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:24:33 INFO - 'PWD': '/builds/slave/test', 14:24:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:24:33 INFO - 'SHELL': '/bin/bash', 14:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Fy0FnTtzxR/Listeners', 14:24:33 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 14:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:24:33 INFO - 'USER': 'cltbld', 14:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:24:33 INFO - 'XPC_FLAGS': '0x0', 14:24:33 INFO - 'XPC_SERVICE_NAME': '0', 14:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:24:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 14:24:33 INFO - mozversion application_buildid: 20161004120300 14:24:33 INFO - mozversion application_changeset: 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 14:24:33 INFO - mozversion application_display_name: Nightly 14:24:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:24:33 INFO - mozversion application_name: Firefox 14:24:33 INFO - mozversion application_remotingname: firefox 14:24:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:24:33 INFO - mozversion application_vendor: Mozilla 14:24:33 INFO - mozversion application_version: 52.0a1 14:24:33 INFO - mozversion platform_buildid: 20161004120300 14:24:33 INFO - mozversion platform_changeset: 2d4f6c10aacfb9a319624a9df50d7b0769cfafa9 14:24:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:24:33 INFO - mozversion platform_version: 52.0a1 14:24:33 INFO - using testdate: 1475616273 14:24:33 INFO - actual date: 1475616273 14:24:33 INFO - starting webserver on 'localhost:56585' 14:24:33 INFO - SUITE-START | Running 2 tests 14:24:33 INFO - TEST-START | dromaeo_css 14:24:33 INFO - operating with platform_type : mac_ 14:24:33 INFO - Initialising browser for dromaeo_css test... 14:24:33 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpIhoGnu/profile http://localhost:56585/getInfo.html) 14:24:36 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 14:24:36 INFO - PROCESS | 1943 | colorDepth:24 14:24:36 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 14:24:36 INFO - PROCESS | 1943 | __metrics 14:24:36 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:24:36 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:37 INFO - TEST-INFO | 1943: exit 0 14:24:37 INFO - Browser initialized. 14:24:37 INFO - Running cycle 1/1 for dromaeo_css test... 14:24:37 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpIhoGnu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:24:49 INFO - PROCESS | 1945 | RSS: Main: 235806720 14:24:49 INFO - PROCESS | 1945 | 14:25:40 INFO - PROCESS | 1945 | 1475616340673 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:27:52 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56585/tests/dromaeo/cssquery-ext.html) 14:27:54 INFO - PROCESS | 1945 | RSS: Main: 356954112 14:27:54 INFO - PROCESS | 1945 | 14:30:57 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-ext.html (next: http://localhost:56585/tests/dromaeo/cssquery-jquery.html) 14:30:57 INFO - PROCESS | 1945 | RSS: Main: 370663424 14:30:57 INFO - PROCESS | 1945 | 14:34:00 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56585/tests/dromaeo/cssquery-mootools.html) 14:34:00 INFO - PROCESS | 1945 | RSS: Main: 330715136 14:34:00 INFO - PROCESS | 1945 | 14:37:03 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56585/tests/dromaeo/cssquery-prototype.html) 14:37:04 INFO - PROCESS | 1945 | RSS: Main: 350543872 14:37:04 INFO - PROCESS | 1945 | 14:40:07 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56585/tests/dromaeo/cssquery-yui.html) 14:40:08 INFO - PROCESS | 1945 | RSS: Main: 329199616 14:40:08 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:56585/tests/dromaeo/cssquery-yui.html (next: http://localhost:56585/tests/dromaeo/cssquery-dojo.html) 14:43:11 INFO - PROCESS | 1945 | RSS: Main: 378961920 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | __start_tp_report 14:43:11 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 14:43:11 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 14:43:11 INFO - PROCESS | 1945 | |i|pagename|runs| 14:43:11 INFO - PROCESS | 1945 | |0;dojo.html;3298.5876765404323;3300.7524435667324;3312.4203264428734;3316.403047451458;3371.1740623547234;5582.190582365564;5630.746616402262;5670.68811215383;5726.112452569853;5743.540516758665;5610.074337734279;5672.319321681404;5674.773009079632;5680.11958146488;5680.4319568043275;5091.032703786278;5129.563987061104;5131.640785145041;5133.409657889353;5177.119889618773;5114.43741188469;5189.091908915943;5218.947810521903;5221.5822734181365;5235.947640523603;5222.556082732972;5227.163653815391;5252.212168174766;5279.234510995903;5301.3373328333955;501.58846406892275;5223.791048358061;5231.319928409321;5240.816571419982;5280.788768449257;4346.76092814895;5060.84817455477;5101.464346243628;5109.3613298337705;5157.097507936133;5580.944190558123;5586.581006424534;5617.775288988436;5662.6036177467595;5666.631668941547;6206.131141640174;6206.34833342497;6207.658578778165;6214.782482613132;6233.87532249357;6104.389561043905;6110.572259941806;6116.548817443993;6154.692265386713;6167.044108163242;5651.773929042874;5697.9430205698245;5706.058500347479;5707.34365547959;5711.485966263056;6200.627962322275;6229.283632382334;6233.2208473940755;6237.500999919996;6240.563160578716;5879.911801322984;5962.195103661037;5965.3139888912465;6104.17593624855;6111.144439778434;6094.108664719914;6145.784897528565;6163.3528479509905;6236.6258024517765;6239.719212635442;6111.816645500642;6127.601705889192;6136.570440069152;6144.41628045335;6148.754049838046;6048.939510604926;6149.108379284979;6179.474744646755;6199.380061993765;6200.906986395207;4861.29511220871;4866.245731911559;4893.510648935078;4903.190973489405;4912;4375.1031038637;4382.276924307517;4411.580899814512;4421.447319085114;4490.528494508095;5645.9717701412055;5679.119736440858;5690.459406356389;5701.2018317435595;5710.543156547549;6076.453119219292;6161.876762464725;6163.414475624809;6171.352008039091;6250.531210159256;5634.267545219095;5687.715614219355;5700.144978253295;5709.8287051388525;5741.942580574141;5356.7857285708915;5367.382750983609;5369.3556773187465;5373.838784836461;5380.381256155592;6213.627182369072;6228.283747369111;6243.594166379171;6250.156228909039;6268.717907694074;6145.631262124108;6193.566450348432;6218.595791273553;6226.470749986302;6282.780102696383;6226.315105338319;6239.344868788712;6253.312135664983;6259.593126446766;6275.403836635513;5936.5844390892225;6141.570090093651;6176.320604733565;6180.536459765625;6190.845228869314;6117.462039585284;6127.281156068077;6142.621558143092;6176.073588961692;6256.593321434092;5942.821715348547;6088.756449742138;6096.908546371719;6104.938950610437;6107.938920610737;6022.90965635507;6061.696915154136;6070.3929607038945;6072.05883088122;6075.969620151871;5743.8564035899435;5807.767689292381;5850.765969361178;5878.735456904535;5921.6743079131065;6069.666168360606;6078.483328916915;6083.117947897618;6088.786892458743;6094.8171554853425;5723.484886360247;5860.882782344414;5865.442782935615;5881.911771323348;5884.47039766423 14:43:11 INFO - PROCESS | 1945 | |1;ext.html;440.26475785438316;474.8456751555745;478.2634742496554;498.5413419653918;502.61801031216277;30805.92179273726;31435.05694829153;40138.97915312701;41581.58418415822;41747.95630109249;42520.362194567104;42914.57085429152;42932.570674293245;42980;43029.481904400054;9690.612375504988;9888.258380621446;9891.802163956716;9892.604295828158;9896.90103098967;8887.911120888806;9097.818043639123;10084.546195421224;11859.288442693423;12168.53196838901;12066.818997715041;12133.878661213408;12164.635060948185;12175.878241217562;12205.389730513483;12115;12190.39048047603;12197.573084942072;12233.510659573607;12243.02055835531;7595.392368610498;8621.224089831945;11650.184487085908;11851.288922664668;11995.580154694544;40457.797711011255;40840.978975525555;40927.795361023;40936.590634093576;41075;3227.8386080695873;3427.9657203427896;3565.7682250653884;3788.22341420011;4037.6769858411258;30084.398312033856;30514.799423288932;31335.84332078348;32426.513602295985;32497.350052999045;3238.77328586999;3241.5137729340554;3354.4632858742484;3405.591329040506;3405.8126803025825;405089;407114;409679;410187.9490602558;410228;62023.6898815512;62551;62618;62646.0603090954;62664.68667656633;61135.694321528106;61243.693781530805;61275.69362153161;61279;61352.77294454175;16334.428295009619;16482.2582983766;16559.6688066238;16575.83424165767;16584.75122873158;12595.559155429515;12653.304068276333;12656.17734847232;12658.493660253487;12677.985761139087;16323.673526529403;16712;16781.496555103367;18751.24995000212;19353;6782.966085169543;7640.426967977424;8119.350451963829;8152.714654987047;8201.671933122727;950.7480517662825;972.1153750087386;984.5717113055844;1014.60937539048;1073.683263437288;24954;25897.88487175917;27499.900004000017;27853.860730696622;30153.396932061674;993.7764003099245;1054.752133248686;1067.5356220044305;1101.4712937789745;1136.5851464215502;15329.46346877854;15460;15475.226238688021;15760.187578428628;15885.761713574306;677383.6130819315;681455.5927220333;682244;682971;685761;49504.25743613848;50488.747556262715;56732;57065;57508;1336.411978729356;1363.3932899859467;1373.3339330424735;1374.1411617738913;1381.4957540497846;30316.393672126876;31046.91335803236;31552.053438396884;31582.210444739067;32178.67821321757;46455.070898581165;47653.761731192506;50837.729056773875;51343.48656513387;51356.74321628368;662625;673347;673734;738415;870483;41029.79485102555;42185.52350667712;42216.73349799511;42488.78755606202;42665.786671066446;46991.76504117458;47597.28604070872;47826.5217347836;47987.520124798306;48132;36546.634533655386;39114.4132838002;39151.41272880852;39467.605323946394;41342;39059.41410878782;39247;39450.60549394584;40591.79704101461;40763.592364077165;38059.809700951315;38830.72861985123;38900.221995560496;38975.80512097421;39176.020599485244;27898.16305510838;32656;33339.83330083334;33511.66488335085;33524.49713254352;20073.899630501754;25455.745442545336;25531.489370212865;25600.743992559837;25790 14:43:11 INFO - PROCESS | 1945 | |2;jquery.html;348.9249811290575;366.71762742688134;370.2354637673205;374.529964894058;398.0784483919726;15071.246437678114;15189.4683686071;16606.667866642674;20944.476388090305;20948;19984.400467985946;20032.998350082475;21101.366958991217;21182.682259766076;21408.357749267507;5814;5963;6246.750129994794;6270.937290627104;6277.058441233806;5284.63007589467;6094.360092190323;6272.6236425814595;6277.717502712366;6291;3935.3506671399186;4142.902130935305;5745.712714364286;5886.087656413263;6212.161358216651;5983;6174.969125154345;6216.37836216377;6234.3453937336835;6250.531210159256;6030.155778191057;6034.758609655609;6043.969780151071;6048.1834952281315;6051.485623721989;13276.73446531064;14481.927590362086;24712.752872471225;24854;25598;1896.0034635653774;2238.2949370948263;2264.2075273654254;2301.4936713923075;2351.494428697838;8081.191880811931;9905.554250058693;10065.748356291078;10497.370157790558;10603.363798172057;1797.2271923073074;1801.405536173073;1811.873168878179;1844.7509586205824;1887.7545919030576;114835.42582287035;120740.79259207383;121445.39277303556;130336.3483182578;132540;10967.83548246777;11329.660110196708;11419.771604567863;11458.828117578076;11644.76710465786;14367.994240403072;14380.496682616267;14382.35279412429;14392.064515806649;14392.424303027761;8052.718154864551;8370.411568409427;8407.621657025325;8505.489670619783;8543.017552981486;6826.897596536056;8329.458585192064;8360.205780450848;8488.787780305542;8538.231559159705;4374.846880359236;4413.933790993137;4497.437820272466;4581.2440947243995;4587.839425620154;1846.2153584726439;1901.1349835824667;1917.3193516301792;1938.8158124978104;1951.79506151852;813.9064007639197;822.4982760516081;901.5266984833015;911.129870973219;1015.5227043289642;20475.8976205121;21287.46781330448;21558.353249402542;21600.891995540234;21697.67453488199;900.2258058070055;900.2887718702283;930.2465003347311;946.5314669238771;978.1245785022508;10537.312985188728;10640;11033.889661103447;11085.445727713583;11176.720581985515;574022.0265858799;575330;583870;588950;589374;124345;124450.75549244572;128195;129186;131889;950.4344914775697;995.7958618483193;996.138340335619;996.3872218585518;997.9850302245472;16850.410235641695;18422.631547369245;18917.61858231955;19069.332573359865;19302.806971930102;52502.737486312326;53187.734061329444;54213.18680219879;54259.186112209136;56218.71890640521;72193;73004.90492642508;73126.63436682783;73710.63144684242;76040.23959760553;7811.336036436739;8031.718889838828;8119.391045671717;8144.511329320023;8368.623411946599;11002.394868282001;11175.49710263024;12699.357886483667;13199;13246.867531324564;9779.657711980331;10719.839202411815;11079.501422436171;11208.551657933918;11223.270487418291;11228.326300422;11316.547338106384;11336.886631133582;11407.657770266906;11686.298822070703;11265.831012534982;11456.484458199235;11544.538218471504;11572.305661660328;11852.348120853436;7992.320652744349;8226.588670566567;8238.134995825352;8369.790755231168;8414;10736.51685674131;11128.332300062022;11196.496157672762;11368.431578421212;11536.192466527262 14:43:11 INFO - PROCESS | 1945 | |3;mootools.html;1381.3990913952425;1420.3963315590872;1543.976840347395;1741.939032133875;1931.169597073258;7937.603119844006;8410.78973025674;8747.868781968276;9029.593668284926;9030.864537031934;8744.43161194522;8759.605817738202;8795.120487951217;8846.5576721164;8938.463692178457;2338.9532209355843;2375.3586531636447;2375.8455700379504;2375.881205939696;2376.6197408414655;2326.848754830939;2353.223436266028;2371.027878569787;2371.9288421347387;2376.4652953085506;2344.460774021976;2365.9290221293304;2372.7864492195786;2379.119725701493;2380.6905102336673;2324.372419446757;2344.8593084414906;2349.8590084594894;2353.8116950643907;2360.634101714237;2297.0811675329833;2326.8487548309477;2327.8486898351553;2328.895199716017;2331.5803155432013;8858.557072146432;9027.593758280893;9032.45805251687;9043.32175086871;9047.366684332099;5259.973700131475;5272.446393128743;5441.156620723794;5443.700596467193;5472.2338872557875;3525.6298088700573;3648.434492653643;3737.3187410400733;3740.4576336431337;3750.4186851038135;932.6828878181451;1081.4808891731934;1084.1976937066593;1107.3189988157226;1111.522045520426;9951.950240248825;11461.083113350913;11814.822777658343;11839.94080029603;12046.397680115959;4397.560243975577;4510.1656193604285;4573.170731707343;4641.721496710208;4642.86071417858;9270.258379329638;9293.628254869729;9302.581383837743;9303.116203960613;9310.53447327631;5218.921716174261;5252.317198764213;5252.474752524793;5263.868403289872;5265.078611243017;4169;4399.670024748157;4578.5421457853945;4582.9770851146195;4928.778204980785;3185.665505121975;3706.388445906395;3779.036345731876;3803.470691989796;3808.1241314497265;1129.4804389980536;1130.8021096308114;1132.92069555132;1142.0863309352485;1145.6333973128685;844.5979673741559;855.4909828651943;896.4128495835238;916.6562539047857;939.8392984663934;5304.787808487695;5732.3407808101765;5913.70431478433;5939.940600594025;6119.5104391648565;915.3455279475207;922.3543519536217;923.3121324613206;938.4510061613896;941.2328951904176;3440.6043305019743;3695.6304369562827;3882.2041481496226;3912.197999410114;4040.878773636796;10702.89297107019;11179.66461006171;11182.832257516144;11202;11231.606893758679;11145.108391328675;11145.442727863736;11148.163887708291;11161.553537858557;11172.553097876156;7830.8433831323055;8302.875456868273;8312;8461.450005749606;8476.703315384055;5974.761009559569;6053.535549938371;6068.817935461943;6169.753209871735;6190.50475961931;8613.48319100856;10150.187984961038;10330.948345258226;10347.741306467398;10348.27562070678;8945.73162805117;9386.108319709616;9813.803723925625;10318.380897146195;10464.581416743245;7110.893336599852;7346.11846578414;7518.812029699083;7592.202818704178;7606.201348858512;8369.372297077865;8377.748667539983;8382;8460.407771455939;8509.914900850912;7601.467897247139;7655.540667559741;7687.88468172989;7693.846123077619;7796.9220307796195;7498.925010749823;7539.660715267716;7566.621668916642;7581.50720203185;7648.694052237848;7103.573785572882;7104.254053324533;7117;7153.678084486315;7198.136223653195;4962.925556116589;4981.37732783402;4989.276554899447;5019.3976722793495;5145.665531740425;5056.974715126401;5124.56441202502;5134.9486505135965;5150.227465880148;5231.1107111790325 14:43:11 INFO - PROCESS | 1945 | |4;prototype.html;254.9222487141421;285.55168385634533;296.19287441721303;305.3039070918306;312.38772006866543;4966.701997880121;5151.459096794839;5226.947730522703;5263.578913686905;5270.20946857971;4487.439070116236;4489.663275254361;4675.8363457279;5075.593952483801;5098.796048158069;4001.9599804001878;4010.112718842429;4017.598240175974;4020.9396859047138;4034.5763694811917;4070.9389359159636;4072.470578824749;4075.1645912587846;4082.387641853716;4109.5548148851385;3364.747643926703;3756.8685096021645;3907.7655340679507;3992.580779018205;4065.5527891931865;3274.787138835968;3274.8198849063174;3274.819884906329;3971.5829837867186;4004.0990777075217;3224.2584205632834;3456.4642480415323;3494.8427320770625;3496.4755286706945;3497.163988905819;4196.538380778112;4624.497038462513;4912.238603016538;5119.795208191668;5170.146925757245;3828.5979972103087;4497.235469970113;4586.128635559233;4613.146567884952;4616.522712731927;5423.261253067215;5461.781528738846;5504.2294078829;5508.430097422215;5522.337319521643;3545.6986156176754;3757.2673328700916;3836.577976422619;3848.4804551385487;3899.025243689078;5457.918131228074;5643.40744221859;5783.421657834183;5809.7676092956235;5917.136102127816;3248.2529018325918;3677;3680.4847321375028;3699.648533389324;3783.129880127586;3309.23887505875;3401.183715908214;3867.361885288952;3878.6897048236074;3887.3974533947285;3947.388154836005;4529.433820772403;4536.319552067151;4550.772461376918;4583.495815460364;5303.833156705518;5502.761878577288;5513.751881165357;5526.58550608706;5567.387587365387;1215.604928398274;1294.9546765863338;1317.2425855133338;1317.3610798762593;1319.9836126182786;750.3996802557932;770.6455030685835;778.8598052350632;798.8122791144076;805.5770720371735;4232.809523571446;4257.340112282601;4274.572542745701;4296.570342965679;4365.541618130114;4201.474815648044;4655.231886738718;4724.385829842098;4743.786529606176;4751.59611433032;3787.1857550626746;3958.585262989574;3965.5836137205756;3999.34010888206;4328.052376430619;2376.809855211579;2460.5324988252173;2520.8613526255867;2525.343410713191;2991.491446454108;5233.685978841282;5858.2677165354335;5872;5879.911801322984;5922.7927022554;4926.014797040606;5038.395392552917;5177.0068523618675;5836.970815145897;5863;4887.7556122194455;5765.654060756368;5842.23176051436;5919.395465994949;5939.316978547522;5077.746112694276;5378.031954248273;5663.32040155184;5673.319201695823;5683.658980461186;4669.906601867876;5119.87200319995;5303.9392121575065;5649.5650914032285;5661.773529058792;4826.986332869996;4886.462489126265;5128.9487105129965;5794;5850.853728656818;3804.2962052020466;3947.7433966793214;3950.3284441645565;3956.723029387915;3975.9602403976746;5172.482751724798;5541.947030064275;5572.832815015556;5585.581081418829;5595.300587426572;4725.29120631908;5298.612008067536;5343.076492462633;5396.514313711785;5427.8330159016;5347.331583552056;5347.51872331492;5395.055865223491;5395.595330350161;5456.399796022355;5250.794666240265;5266.762995665281;5314.5216930476445;5329.946700532945;5365.651232669864;4814.916643755268;5133;5241.842744717665;5435.945640543544;5436.565074794086;4899.412070551557;5289.2330612061805;5323.334583177103;5331.626786125089;5336.199570064521 14:43:11 INFO - PROCESS | 1945 | |5;yui.html;623.8066199478161;756.9205233450488;791.322396519379;798.744401791427;824.8185399212172;12670.922971547418;13276.601701948957;14916.701665966673;15582.454614088509;15594.688106237869;14437.494687685934;14570.708585828304;14572.12567245966;14573.854261457382;14584.781228281558;717.3830505765038;876.6800117956964;877.6094637886143;877.7410663854179;880.4453194487464;690.3786592067155;711.5126138595053;845.6617353058764;874.5496069524169;876.3558784293539;915.6428992692855;915.8855143107112;916.3493919317293;916.8899732032132;917.1745429113818;908.9681861134861;909.5543183839937;911.7902882337099;911.977200569991;912.5209265135791;530.2417542913632;547.7370861986269;550.5953124453523;666.340323080152;677.3294438505893;15083.321250543751;15141.394344226217;15143.848561514355;15202.087874727551;15207.923960380238;12080.214786038967;12418.751624967541;13216.603501894959;13972.790408143886;14265.072770269899;12761.298128602923;12875.742485150244;12971.610851674464;13017.08880378374;13498.257595832225;4154.646855017327;4561.566651168134;4688.296755486705;4715.269133284346;4741.691790033637;110181.89818101797;113670.43164784205;117591;117650;118057;10701.892981070245;11057.391843448688;11149.721256968478;11204.607838725606;11323.773524529463;18459.261629534936;21557.78442215558;22572.322830315115;22635;22693.092276309093;7672.769816905502;7751.573663448452;7830.451868369273;7890.802729931797;7952.602369881482;4289.270823959871;4298.4197133387215;4324.308110702273;4345.90285336552;4403;3465.341585098823;3569.7322700797026;3572.2319701264355;3580.5524309461316;3584.0502266899293;538.3109619686808;636.9554131210864;646.318134368246;646.7283740828863;649.4187702006677;598.6856900127468;621.8538643418793;630.8239454809101;634.8254230086764;656.3836527799767;7685.42359323053;7933.761987140395;9041.81916361669;9059.229965452878;9132.46546755438;508.3061620887462;570.1846359705661;570.2842932120162;586.906095024794;644.3170239546096;4109.951169390871;4413.3821265022925;4418.668599855024;4474.888127796766;4504.887377815581;96857;99636;139445.30277348548;159284;164830.17584912;138391;138820;141171;141520;143335.2833235848;106811;109092;109654;109950.45024774985;112411.43794280976;8573.31413486932;8576.142385761374;8613.526256055977;8782.429142105742;8870;55666.72166639141;58009.70995144997;63230;64400;69244.3040379105;59429;63974.68012659907;71136.28863711297;87140.90013699234;92812.53593731989;12264.75470490603;13062.281574513492;13370.331483425594;13412.865871341162;13554.86445135536;15060.54818355451;15064.698706026038;15456.536303910902;15657.68684626324;15751.842481575495;13205.273709946045;13936.651583710083;13946.16323020622;14094.36575354132;14336.21150836714;13589.116707414381;13625.86374136246;13664.043516953718;14234.37802043147;14616.853831461549;12974;13384.19694818314;13404.061715679809;13912.721745565235;13940.860591393955;8811;9090.545472726206;9121.179093881583;9126.087391261086;9713.660021899199;8124.471909325875;9171.358004939857;10963.83554246671;11555.826662600235;11758.294502329887 14:43:11 INFO - PROCESS | 1945 | __end_tp_report 14:43:11 INFO - PROCESS | 1945 | __start_cc_report 14:43:11 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,1375 14:43:11 INFO - PROCESS | 1945 | __end_cc_report 14:43:11 INFO - PROCESS | 1945 | __startTimestamp1475617391573__endTimestamp 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | ------- Summary: start ------- 14:43:11 INFO - PROCESS | 1945 | Number of tests: 6 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5665.40 Median:5879.91 stddev:750.42 (12.8%) stddev-sans-first:729.39 14:43:11 INFO - PROCESS | 1945 | Values: 3298.6 3300.8 3312.4 3316.4 3371.2 5582.2 5630.7 5670.7 5726.1 5743.5 5610.1 5672.3 5674.8 5680.1 5680.4 5091.0 5129.6 5131.6 5133.4 5177.1 5114.4 5189.1 5218.9 5221.6 5235.9 5222.6 5227.2 5252.2 5279.2 5301.3 501.6 5223.8 5231.3 5240.8 5280.8 4346.8 5060.8 5101.5 5109.4 5157.1 5580.9 5586.6 5617.8 5662.6 5666.6 6206.1 6206.3 6207.7 6214.8 6233.9 6104.4 6110.6 6116.5 6154.7 6167.0 5651.8 5697.9 5706.1 5707.3 5711.5 6200.6 6229.3 6233.2 6237.5 6240.6 5879.9 5962.2 5965.3 6104.2 6111.1 6094.1 6145.8 6163.4 6236.6 6239.7 6111.8 6127.6 6136.6 6144.4 6148.8 6048.9 6149.1 6179.5 6199.4 6200.9 4861.3 4866.2 4893.5 4903.2 4912.0 4375.1 4382.3 4411.6 4421.4 4490.5 5646.0 5679.1 5690.5 5701.2 5710.5 6076.5 6161.9 6163.4 6171.4 6250.5 5634.3 5687.7 5700.1 5709.8 5741.9 5356.8 5367.4 5369.4 5373.8 5380.4 6213.6 6228.3 6243.6 6250.2 6268.7 6145.6 6193.6 6218.6 6226.5 6282.8 6226.3 6239.3 6253.3 6259.6 6275.4 5936.6 6141.6 6176.3 6180.5 6190.8 6117.5 6127.3 6142.6 6176.1 6256.6 5942.8 6088.8 6096.9 6104.9 6107.9 6022.9 6061.7 6070.4 6072.1 6076.0 5743.9 5807.8 5850.8 5878.7 5921.7 6069.7 6078.5 6083.1 6088.8 6094.8 5723.5 5860.9 5865.4 5881.9 5884.5 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:73685.69 Median:39163.72 stddev:167051.60 (426.5%) stddev-sans-first:167429.70 14:43:11 INFO - PROCESS | 1945 | Values: 440.3 474.8 478.3 498.5 502.6 30805.9 31435.1 40139.0 41581.6 41748.0 42520.4 42914.6 42932.6 42980.0 43029.5 9690.6 9888.3 9891.8 9892.6 9896.9 8887.9 9097.8 10084.5 11859.3 12168.5 12066.8 12133.9 12164.6 12175.9 12205.4 12115.0 12190.4 12197.6 12233.5 12243.0 7595.4 8621.2 11650.2 11851.3 11995.6 40457.8 40841.0 40927.8 40936.6 41075.0 3227.8 3428.0 3565.8 3788.2 4037.7 30084.4 30514.8 31335.8 32426.5 32497.4 3238.8 3241.5 3354.5 3405.6 3405.8 405089.0 407114.0 409679.0 410187.9 410228.0 62023.7 62551.0 62618.0 62646.1 62664.7 61135.7 61243.7 61275.7 61279.0 61352.8 16334.4 16482.3 16559.7 16575.8 16584.8 12595.6 12653.3 12656.2 12658.5 12678.0 16323.7 16712.0 16781.5 18751.2 19353.0 6783.0 7640.4 8119.4 8152.7 8201.7 950.7 972.1 984.6 1014.6 1073.7 24954.0 25897.9 27499.9 27853.9 30153.4 993.8 1054.8 1067.5 1101.5 1136.6 15329.5 15460.0 15475.2 15760.2 15885.8 677383.6 681455.6 682244.0 682971.0 685761.0 49504.3 50488.7 56732.0 57065.0 57508.0 1336.4 1363.4 1373.3 1374.1 1381.5 30316.4 31046.9 31552.1 31582.2 32178.7 46455.1 47653.8 50837.7 51343.5 51356.7 662625.0 673347.0 673734.0 738415.0 870483.0 41029.8 42185.5 42216.7 42488.8 42665.8 46991.8 47597.3 47826.5 47987.5 48132.0 36546.6 39114.4 39151.4 39467.6 41342.0 39059.4 39247.0 39450.6 40591.8 40763.6 38059.8 38830.7 38900.2 38975.8 39176.0 27898.2 32656.0 33339.8 33511.7 33524.5 20073.9 25455.7 25531.5 25600.7 25790.0 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:34449.52 Median:24783.38 stddev:97475.48 (393.3%) stddev-sans-first:97715.29 14:43:11 INFO - PROCESS | 1945 | Values: 348.9 366.7 370.2 374.5 398.1 15071.2 15189.5 16606.7 20944.5 20948.0 19984.4 20033.0 21101.4 21182.7 21408.4 5814.0 5963.0 6246.8 6270.9 6277.1 5284.6 6094.4 6272.6 6277.7 6291.0 3935.4 4142.9 5745.7 5886.1 6212.2 5983.0 6175.0 6216.4 6234.3 6250.5 6030.2 6034.8 6044.0 6048.2 6051.5 13276.7 14481.9 24712.8 24854.0 25598.0 1896.0 2238.3 2264.2 2301.5 2351.5 8081.2 9905.6 10065.7 10497.4 10603.4 1797.2 1801.4 1811.9 1844.8 1887.8 114835.4 120740.8 121445.4 130336.3 132540.0 10967.8 11329.7 11419.8 11458.8 11644.8 14368.0 14380.5 14382.4 14392.1 14392.4 8052.7 8370.4 8407.6 8505.5 8543.0 6826.9 8329.5 8360.2 8488.8 8538.2 4374.8 4413.9 4497.4 4581.2 4587.8 1846.2 1901.1 1917.3 1938.8 1951.8 813.9 822.5 901.5 911.1 1015.5 20475.9 21287.5 21558.4 21600.9 21697.7 900.2 900.3 930.2 946.5 978.1 10537.3 10640.0 11033.9 11085.4 11176.7 574022.0 575330.0 583870.0 588950.0 589374.0 124345.0 124450.8 128195.0 129186.0 131889.0 950.4 995.8 996.1 996.4 998.0 16850.4 18422.6 18917.6 19069.3 19302.8 52502.7 53187.7 54213.2 54259.2 56218.7 72193.0 73004.9 73126.6 73710.6 76040.2 7811.3 8031.7 8119.4 8144.5 8368.6 11002.4 11175.5 12699.4 13199.0 13246.9 9779.7 10719.8 11079.5 11208.6 11223.3 11228.3 11316.5 11336.9 11407.7 11686.3 11265.8 11456.5 11544.5 11572.3 11852.3 7992.3 8226.6 8238.1 8369.8 8414.0 10736.5 11128.3 11196.5 11368.4 11536.2 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5721.50 Median:5140.31 stddev:3232.10 (62.9%) stddev-sans-first:3224.70 14:43:11 INFO - PROCESS | 1945 | Values: 1381.4 1420.4 1544.0 1741.9 1931.2 7937.6 8410.8 8747.9 9029.6 9030.9 8744.4 8759.6 8795.1 8846.6 8938.5 2339.0 2375.4 2375.8 2375.9 2376.6 2326.8 2353.2 2371.0 2371.9 2376.5 2344.5 2365.9 2372.8 2379.1 2380.7 2324.4 2344.9 2349.9 2353.8 2360.6 2297.1 2326.8 2327.8 2328.9 2331.6 8858.6 9027.6 9032.5 9043.3 9047.4 5260.0 5272.4 5441.2 5443.7 5472.2 3525.6 3648.4 3737.3 3740.5 3750.4 932.7 1081.5 1084.2 1107.3 1111.5 9952.0 11461.1 11814.8 11839.9 12046.4 4397.6 4510.2 4573.2 4641.7 4642.9 9270.3 9293.6 9302.6 9303.1 9310.5 5218.9 5252.3 5252.5 5263.9 5265.1 4169.0 4399.7 4578.5 4583.0 4928.8 3185.7 3706.4 3779.0 3803.5 3808.1 1129.5 1130.8 1132.9 1142.1 1145.6 844.6 855.5 896.4 916.7 939.8 5304.8 5732.3 5913.7 5939.9 6119.5 915.3 922.4 923.3 938.5 941.2 3440.6 3695.6 3882.2 3912.2 4040.9 10702.9 11179.7 11182.8 11202.0 11231.6 11145.1 11145.4 11148.2 11161.6 11172.6 7830.8 8302.9 8312.0 8461.5 8476.7 5974.8 6053.5 6068.8 6169.8 6190.5 8613.5 10150.2 10330.9 10347.7 10348.3 8945.7 9386.1 9813.8 10318.4 10464.6 7110.9 7346.1 7518.8 7592.2 7606.2 8369.4 8377.7 8382.0 8460.4 8509.9 7601.5 7655.5 7687.9 7693.8 7796.9 7498.9 7539.7 7566.6 7581.5 7648.7 7103.6 7104.3 7117.0 7153.7 7198.1 4962.9 4981.4 4989.3 5019.4 5145.7 5057.0 5124.6 5134.9 5150.2 5231.1 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:4355.08 Median:4747.69 stddev:1358.86 (28.6%) stddev-sans-first:1327.36 14:43:11 INFO - PROCESS | 1945 | Values: 254.9 285.6 296.2 305.3 312.4 4966.7 5151.5 5226.9 5263.6 5270.2 4487.4 4489.7 4675.8 5075.6 5098.8 4002.0 4010.1 4017.6 4020.9 4034.6 4070.9 4072.5 4075.2 4082.4 4109.6 3364.7 3756.9 3907.8 3992.6 4065.6 3274.8 3274.8 3274.8 3971.6 4004.1 3224.3 3456.5 3494.8 3496.5 3497.2 4196.5 4624.5 4912.2 5119.8 5170.1 3828.6 4497.2 4586.1 4613.1 4616.5 5423.3 5461.8 5504.2 5508.4 5522.3 3545.7 3757.3 3836.6 3848.5 3899.0 5457.9 5643.4 5783.4 5809.8 5917.1 3248.3 3677.0 3680.5 3699.6 3783.1 3309.2 3401.2 3867.4 3878.7 3887.4 3947.4 4529.4 4536.3 4550.8 4583.5 5303.8 5502.8 5513.8 5526.6 5567.4 1215.6 1295.0 1317.2 1317.4 1320.0 750.4 770.6 778.9 798.8 805.6 4232.8 4257.3 4274.6 4296.6 4365.5 4201.5 4655.2 4724.4 4743.8 4751.6 3787.2 3958.6 3965.6 3999.3 4328.1 2376.8 2460.5 2520.9 2525.3 2991.5 5233.7 5858.3 5872.0 5879.9 5922.8 4926.0 5038.4 5177.0 5837.0 5863.0 4887.8 5765.7 5842.2 5919.4 5939.3 5077.7 5378.0 5663.3 5673.3 5683.7 4669.9 5119.9 5303.9 5649.6 5661.8 4827.0 4886.5 5128.9 5794.0 5850.9 3804.3 3947.7 3950.3 3956.7 3976.0 5172.5 5541.9 5572.8 5585.6 5595.3 4725.3 5298.6 5343.1 5396.5 5427.8 5347.3 5347.5 5395.1 5395.6 5456.4 5250.8 5266.8 5314.5 5329.9 5365.7 4814.9 5133.0 5241.8 5435.9 5436.6 4899.4 5289.2 5323.3 5331.6 5336.2 14:43:11 INFO - PROCESS | 1945 | 14:43:11 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:24323.37 Median:4335.11 stddev:39123.43 (902.5%) stddev-sans-first:39192.71 14:43:11 INFO - PROCESS | 1945 | Values: 623.8 756.9 791.3 798.7 824.8 12670.9 13276.6 14916.7 15582.5 15594.7 14437.5 14570.7 14572.1 14573.9 14584.8 717.4 876.7 877.6 877.7 880.4 690.4 711.5 845.7 874.5 876.4 915.6 915.9 916.3 916.9 917.2 909.0 909.6 911.8 912.0 912.5 530.2 547.7 550.6 666.3 677.3 15083.3 15141.4 15143.8 15202.1 15207.9 12080.2 12418.8 13216.6 13972.8 14265.1 12761.3 12875.7 12971.6 13017.1 13498.3 4154.6 4561.6 4688.3 4715.3 4741.7 110181.9 113670.4 117591.0 117650.0 118057.0 10701.9 11057.4 11149.7 11204.6 11323.8 18459.3 21557.8 22572.3 22635.0 22693.1 7672.8 7751.6 7830.5 7890.8 7952.6 4289.3 4298.4 4324.3 4345.9 4403.0 3465.3 3569.7 3572.2 3580.6 3584.1 538.3 637.0 646.3 646.7 649.4 598.7 621.9 630.8 634.8 656.4 7685.4 7933.8 9041.8 9059.2 9132.5 508.3 570.2 570.3 586.9 644.3 4110.0 4413.4 4418.7 4474.9 4504.9 96857.0 99636.0 139445.3 159284.0 164830.2 138391.0 138820.0 141171.0 141520.0 143335.3 106811.0 109092.0 109654.0 109950.5 112411.4 8573.3 8576.1 8613.5 8782.4 8870.0 55666.7 58009.7 63230.0 64400.0 69244.3 59429.0 63974.7 71136.3 87140.9 92812.5 12264.8 13062.3 13370.3 13412.9 13554.9 15060.5 15064.7 15456.5 15657.7 15751.8 13205.3 13936.7 13946.2 14094.4 14336.2 13589.1 13625.9 13664.0 14234.4 14616.9 12974.0 13384.2 13404.1 13912.7 13940.9 8811.0 9090.5 9121.2 9126.1 9713.7 8124.5 9171.4 10963.8 11555.8 11758.3 14:43:11 INFO - PROCESS | 1945 | -------- Summary: end -------- 14:43:11 INFO - PROCESS | 1945 | 14:43:12 INFO - TEST-INFO | 1945: exit 0 14:43:12 INFO - TEST-OK | dromaeo_css | took 1118268ms 14:43:12 INFO - TEST-START | kraken 14:43:12 INFO - operating with platform_type : mac_ 14:43:12 INFO - Initialising browser for kraken test... 14:43:12 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpfZQaf8/profile http://localhost:56585/getInfo.html) 14:43:14 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 14:43:14 INFO - PROCESS | 1948 | colorDepth:24 14:43:14 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 14:43:14 INFO - PROCESS | 1948 | __metrics 14:43:14 INFO - PROCESS | 1948 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:43:14 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:43:15 INFO - TEST-INFO | 1948: exit 0 14:43:15 INFO - Browser initialized. 14:43:15 INFO - Running cycle 1/1 for kraken test... 14:43:15 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpfZQaf8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:43:27 INFO - PROCESS | 1949 | RSS: Main: 244240384 14:43:27 INFO - PROCESS | 1949 | 14:43:30 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56585/tests/kraken/driver.html?testName=audio-beat-detection) 14:43:31 INFO - PROCESS | 1949 | RSS: Main: 294658048 14:43:31 INFO - PROCESS | 1949 | 14:43:33 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56585/tests/kraken/driver.html?testName=audio-dft) 14:43:34 INFO - PROCESS | 1949 | RSS: Main: 294535168 14:43:34 INFO - PROCESS | 1949 | 14:43:38 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56585/tests/kraken/driver.html?testName=audio-fft) 14:43:38 INFO - PROCESS | 1949 | RSS: Main: 384405504 14:43:38 INFO - PROCESS | 1949 | 14:43:40 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56585/tests/kraken/driver.html?testName=audio-oscillator) 14:43:41 INFO - PROCESS | 1949 | RSS: Main: 288747520 14:43:41 INFO - PROCESS | 1949 | 14:43:43 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56585/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:43:44 INFO - PROCESS | 1949 | RSS: Main: 290340864 14:43:44 INFO - PROCESS | 1949 | 14:43:46 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56585/tests/kraken/driver.html?testName=imaging-darkroom) 14:43:47 INFO - PROCESS | 1949 | RSS: Main: 329904128 14:43:47 INFO - PROCESS | 1949 | 14:43:50 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56585/tests/kraken/driver.html?testName=imaging-desaturate) 14:43:51 INFO - PROCESS | 1949 | RSS: Main: 328425472 14:43:51 INFO - PROCESS | 1949 | 14:43:53 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56585/tests/kraken/driver.html?testName=json-parse-financial) 14:43:54 INFO - PROCESS | 1949 | RSS: Main: 326725632 14:43:54 INFO - PROCESS | 1949 | 14:43:56 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56585/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:43:56 INFO - PROCESS | 1949 | RSS: Main: 301531136 14:43:56 INFO - PROCESS | 1949 | 14:43:58 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:43:59 INFO - PROCESS | 1949 | RSS: Main: 305934336 14:43:59 INFO - PROCESS | 1949 | 14:44:01 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:44:01 INFO - PROCESS | 1949 | RSS: Main: 313978880 14:44:01 INFO - PROCESS | 1949 | 14:44:04 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:44:05 INFO - PROCESS | 1949 | RSS: Main: 320131072 14:44:05 INFO - PROCESS | 1949 | 14:44:08 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:44:09 INFO - PROCESS | 1949 | RSS: Main: 320225280 14:44:09 INFO - PROCESS | 1949 | 14:44:10 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:56585/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56585/tests/kraken/driver.html?testName=ai-astar) 14:44:11 INFO - PROCESS | 1949 | RSS: Main: 364068864 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | __start_tp_report 14:44:11 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 14:44:11 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 14:44:11 INFO - PROCESS | 1949 | |i|pagename|runs| 14:44:11 INFO - PROCESS | 1949 | |0;ai-astar;114;114;115;114;113;114;114;114;113;112 14:44:11 INFO - PROCESS | 1949 | |1;audio-beat-detection;153;123;145;167;114;115;112;115;143;112 14:44:11 INFO - PROCESS | 1949 | |2;audio-dft;185;180;183;184;187;182;260;242;180;181 14:44:11 INFO - PROCESS | 1949 | |3;audio-fft;78;61;50;92;81;83;83;83;86;58 14:44:11 INFO - PROCESS | 1949 | |4;audio-oscillator;89;70;95;71;68;69;118;99;84;78 14:44:11 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;92;87;90;88;89;70;135;130;96;86 14:44:11 INFO - PROCESS | 1949 | |6;imaging-darkroom;95;96;95;95;95;95;97;95;96;95 14:44:11 INFO - PROCESS | 1949 | |7;imaging-desaturate;83;86;85;84;83;86;85;84;86;85 14:44:11 INFO - PROCESS | 1949 | |8;json-parse-financial;57;56;55;55;55;54;54;55;55;55 14:44:11 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;66;66;68;82;73;71;70;70;70;71 14:44:11 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;89;89;88;90;86;89;85;89;91;92 14:44:11 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;152;160;155;145;145;132;143;144;176;144 14:44:11 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;173;172;174;172;173;171;177;172;169;171 14:44:11 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;70;70;70;70;70;69;67;67;72;79 14:44:11 INFO - PROCESS | 1949 | __end_tp_report 14:44:11 INFO - PROCESS | 1949 | __start_cc_report 14:44:11 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,2003 14:44:11 INFO - PROCESS | 1949 | __end_cc_report 14:44:11 INFO - PROCESS | 1949 | __startTimestamp1475617451169__endTimestamp 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | ------- Summary: start ------- 14:44:11 INFO - PROCESS | 1949 | Number of tests: 14 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 14:44:11 INFO - PROCESS | 1949 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 114.0 113.0 112.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:129.90 Median:133.00 stddev:20.26 (15.2%) stddev-sans-first:19.69 14:44:11 INFO - PROCESS | 1949 | Values: 153.0 123.0 145.0 167.0 114.0 115.0 112.0 115.0 143.0 112.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:196.40 Median:184.50 stddev:29.17 (15.8%) stddev-sans-first:30.65 14:44:11 INFO - PROCESS | 1949 | Values: 185.0 180.0 183.0 184.0 187.0 182.0 260.0 242.0 180.0 181.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:75.50 Median:83.00 stddev:13.96 (16.8%) stddev-sans-first:14.78 14:44:11 INFO - PROCESS | 1949 | Values: 78.0 61.0 50.0 92.0 81.0 83.0 83.0 83.0 86.0 58.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:81.00 stddev:16.36 (20.2%) stddev-sans-first:17.26 14:44:11 INFO - PROCESS | 1949 | Values: 89.0 70.0 95.0 71.0 68.0 69.0 118.0 99.0 84.0 78.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:88.50 stddev:20.27 (22.9%) stddev-sans-first:21.44 14:44:11 INFO - PROCESS | 1949 | Values: 92.0 87.0 90.0 88.0 89.0 70.0 135.0 130.0 96.0 86.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 14:44:11 INFO - PROCESS | 1949 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 97.0 95.0 96.0 95.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.05 14:44:11 INFO - PROCESS | 1949 | Values: 83.0 86.0 85.0 84.0 83.0 86.0 85.0 84.0 86.0 85.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.60 14:44:11 INFO - PROCESS | 1949 | Values: 57.0 56.0 55.0 55.0 55.0 54.0 54.0 55.0 55.0 55.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:4.55 (6.5%) stddev-sans-first:4.49 14:44:11 INFO - PROCESS | 1949 | Values: 66.0 66.0 68.0 82.0 73.0 71.0 70.0 70.0 70.0 71.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:89.00 stddev:2.10 (2.4%) stddev-sans-first:2.22 14:44:11 INFO - PROCESS | 1949 | Values: 89.0 89.0 88.0 90.0 86.0 89.0 85.0 89.0 91.0 92.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:148.50 stddev:12.01 (8.1%) stddev-sans-first:12.71 14:44:11 INFO - PROCESS | 1949 | Values: 152.0 160.0 155.0 145.0 145.0 132.0 143.0 144.0 176.0 144.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.50 stddev:2.12 (1.2%) stddev-sans-first:2.24 14:44:11 INFO - PROCESS | 1949 | Values: 173.0 172.0 174.0 172.0 173.0 171.0 177.0 172.0 169.0 171.0 14:44:11 INFO - PROCESS | 1949 | 14:44:11 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:3.37 (4.8%) stddev-sans-first:3.57 14:44:11 INFO - PROCESS | 1949 | Values: 70.0 70.0 70.0 70.0 70.0 69.0 67.0 67.0 72.0 79.0 14:44:11 INFO - PROCESS | 1949 | -------- Summary: end -------- 14:44:11 INFO - PROCESS | 1949 | 14:44:12 INFO - TEST-INFO | 1949: exit 0 14:44:12 INFO - TEST-OK | kraken | took 59917ms 14:44:12 INFO - SUITE-END | took 1178s 14:44:12 INFO - Completed test suite (00:19:38) 14:44:12 INFO - javascript benchmark 14:44:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3298.5876765404323, 3300.7524435667324, 3312.4203264428734, 3316.403047451458, 3371.1740623547234, 5582.190582365564, 5630.746616402262, 5670.68811215383, 5726.112452569853, 5743.540516758665, 5610.074337734279, 5672.319321681404, 5674.773009079632, 5680.11958146488, 5680.4319568043275, 5091.032703786278, 5129.563987061104, 5131.640785145041, 5133.409657889353, 5177.119889618773, 5114.43741188469, 5189.091908915943, 5218.947810521903, 5221.5822734181365, 5235.947640523603, 5222.556082732972, 5227.163653815391, 5252.212168174766, 5279.234510995903, 5301.3373328333955, 501.58846406892275, 5223.791048358061, 5231.319928409321, 5240.816571419982, 5280.788768449257, 4346.76092814895, 5060.84817455477, 5101.464346243628, 5109.3613298337705, 5157.097507936133, 5580.944190558123, 5586.581006424534, 5617.775288988436, 5662.6036177467595, 5666.631668941547, 6206.131141640174, 6206.34833342497, 6207.658578778165, 6214.782482613132, 6233.87532249357, 6104.389561043905, 6110.572259941806, 6116.548817443993, 6154.692265386713, 6167.044108163242, 5651.773929042874, 5697.9430205698245, 5706.058500347479, 5707.34365547959, 5711.485966263056, 6200.627962322275, 6229.283632382334, 6233.2208473940755, 6237.500999919996, 6240.563160578716, 5879.911801322984, 5962.195103661037, 5965.3139888912465, 6104.17593624855, 6111.144439778434, 6094.108664719914, 6145.784897528565, 6163.3528479509905, 6236.6258024517765, 6239.719212635442, 6111.816645500642, 6127.601705889192, 6136.570440069152, 6144.41628045335, 6148.754049838046, 6048.939510604926, 6149.108379284979, 6179.474744646755, 6199.380061993765, 6200.906986395207, 4861.29511220871, 4866.245731911559, 4893.510648935078, 4903.190973489405, 4912.0, 4375.1031038637, 4382.276924307517, 4411.580899814512, 4421.447319085114, 4490.528494508095, 5645.9717701412055, 5679.119736440858, 5690.459406356389, 5701.2018317435595, 5710.543156547549, 6076.453119219292, 6161.876762464725, 6163.414475624809, 6171.352008039091, 6250.531210159256, 5634.267545219095, 5687.715614219355, 5700.144978253295, 5709.8287051388525, 5741.942580574141, 5356.7857285708915, 5367.382750983609, 5369.3556773187465, 5373.838784836461, 5380.381256155592, 6213.627182369072, 6228.283747369111, 6243.594166379171, 6250.156228909039, 6268.717907694074, 6145.631262124108, 6193.566450348432, 6218.595791273553, 6226.470749986302, 6282.780102696383, 6226.315105338319, 6239.344868788712, 6253.312135664983, 6259.593126446766, 6275.403836635513, 5936.5844390892225, 6141.570090093651, 6176.320604733565, 6180.536459765625, 6190.845228869314, 6117.462039585284, 6127.281156068077, 6142.621558143092, 6176.073588961692, 6256.593321434092, 5942.821715348547, 6088.756449742138, 6096.908546371719, 6104.938950610437, 6107.938920610737, 6022.90965635507, 6061.696915154136, 6070.3929607038945, 6072.05883088122, 6075.969620151871, 5743.8564035899435, 5807.767689292381, 5850.765969361178, 5878.735456904535, 5921.6743079131065, 6069.666168360606, 6078.483328916915, 6083.117947897618, 6088.786892458743, 6094.8171554853425, 5723.484886360247, 5860.882782344414, 5865.442782935615, 5881.911771323348, 5884.47039766423], "value": 5618.71056477752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.26475785438316, 474.8456751555745, 478.2634742496554, 498.5413419653918, 502.61801031216277, 30805.92179273726, 31435.05694829153, 40138.97915312701, 41581.58418415822, 41747.95630109249, 42520.362194567104, 42914.57085429152, 42932.570674293245, 42980.0, 43029.481904400054, 9690.612375504988, 9888.258380621446, 9891.802163956716, 9892.604295828158, 9896.90103098967, 8887.911120888806, 9097.818043639123, 10084.546195421224, 11859.288442693423, 12168.53196838901, 12066.818997715041, 12133.878661213408, 12164.635060948185, 12175.878241217562, 12205.389730513483, 12115.0, 12190.39048047603, 12197.573084942072, 12233.510659573607, 12243.02055835531, 7595.392368610498, 8621.224089831945, 11650.184487085908, 11851.288922664668, 11995.580154694544, 40457.797711011255, 40840.978975525555, 40927.795361023, 40936.590634093576, 41075.0, 3227.8386080695873, 3427.9657203427896, 3565.7682250653884, 3788.22341420011, 4037.6769858411258, 30084.398312033856, 30514.799423288932, 31335.84332078348, 32426.513602295985, 32497.350052999045, 3238.77328586999, 3241.5137729340554, 3354.4632858742484, 3405.591329040506, 3405.8126803025825, 405089.0, 407114.0, 409679.0, 410187.9490602558, 410228.0, 62023.6898815512, 62551.0, 62618.0, 62646.0603090954, 62664.68667656633, 61135.694321528106, 61243.693781530805, 61275.69362153161, 61279.0, 61352.77294454175, 16334.428295009619, 16482.2582983766, 16559.6688066238, 16575.83424165767, 16584.75122873158, 12595.559155429515, 12653.304068276333, 12656.17734847232, 12658.493660253487, 12677.985761139087, 16323.673526529403, 16712.0, 16781.496555103367, 18751.24995000212, 19353.0, 6782.966085169543, 7640.426967977424, 8119.350451963829, 8152.714654987047, 8201.671933122727, 950.7480517662825, 972.1153750087386, 984.5717113055844, 1014.60937539048, 1073.683263437288, 24954.0, 25897.88487175917, 27499.900004000017, 27853.860730696622, 30153.396932061674, 993.7764003099245, 1054.752133248686, 1067.5356220044305, 1101.4712937789745, 1136.5851464215502, 15329.46346877854, 15460.0, 15475.226238688021, 15760.187578428628, 15885.761713574306, 677383.6130819315, 681455.5927220333, 682244.0, 682971.0, 685761.0, 49504.25743613848, 50488.747556262715, 56732.0, 57065.0, 57508.0, 1336.411978729356, 1363.3932899859467, 1373.3339330424735, 1374.1411617738913, 1381.4957540497846, 30316.393672126876, 31046.91335803236, 31552.053438396884, 31582.210444739067, 32178.67821321757, 46455.070898581165, 47653.761731192506, 50837.729056773875, 51343.48656513387, 51356.74321628368, 662625.0, 673347.0, 673734.0, 738415.0, 870483.0, 41029.79485102555, 42185.52350667712, 42216.73349799511, 42488.78755606202, 42665.786671066446, 46991.76504117458, 47597.28604070872, 47826.5217347836, 47987.520124798306, 48132.0, 36546.634533655386, 39114.4132838002, 39151.41272880852, 39467.605323946394, 41342.0, 39059.41410878782, 39247.0, 39450.60549394584, 40591.79704101461, 40763.592364077165, 38059.809700951315, 38830.72861985123, 38900.221995560496, 38975.80512097421, 39176.020599485244, 27898.16305510838, 32656.0, 33339.83330083334, 33511.66488335085, 33524.49713254352, 20073.899630501754, 25455.745442545336, 25531.489370212865, 25600.743992559837, 25790.0], "value": 20616.108503152278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9249811290575, 366.71762742688134, 370.2354637673205, 374.529964894058, 398.0784483919726, 15071.246437678114, 15189.4683686071, 16606.667866642674, 20944.476388090305, 20948.0, 19984.400467985946, 20032.998350082475, 21101.366958991217, 21182.682259766076, 21408.357749267507, 5814.0, 5963.0, 6246.750129994794, 6270.937290627104, 6277.058441233806, 5284.63007589467, 6094.360092190323, 6272.6236425814595, 6277.717502712366, 6291.0, 3935.3506671399186, 4142.902130935305, 5745.712714364286, 5886.087656413263, 6212.161358216651, 5983.0, 6174.969125154345, 6216.37836216377, 6234.3453937336835, 6250.531210159256, 6030.155778191057, 6034.758609655609, 6043.969780151071, 6048.1834952281315, 6051.485623721989, 13276.73446531064, 14481.927590362086, 24712.752872471225, 24854.0, 25598.0, 1896.0034635653774, 2238.2949370948263, 2264.2075273654254, 2301.4936713923075, 2351.494428697838, 8081.191880811931, 9905.554250058693, 10065.748356291078, 10497.370157790558, 10603.363798172057, 1797.2271923073074, 1801.405536173073, 1811.873168878179, 1844.7509586205824, 1887.7545919030576, 114835.42582287035, 120740.79259207383, 121445.39277303556, 130336.3483182578, 132540.0, 10967.83548246777, 11329.660110196708, 11419.771604567863, 11458.828117578076, 11644.76710465786, 14367.994240403072, 14380.496682616267, 14382.35279412429, 14392.064515806649, 14392.424303027761, 8052.718154864551, 8370.411568409427, 8407.621657025325, 8505.489670619783, 8543.017552981486, 6826.897596536056, 8329.458585192064, 8360.205780450848, 8488.787780305542, 8538.231559159705, 4374.846880359236, 4413.933790993137, 4497.437820272466, 4581.2440947243995, 4587.839425620154, 1846.2153584726439, 1901.1349835824667, 1917.3193516301792, 1938.8158124978104, 1951.79506151852, 813.9064007639197, 822.4982760516081, 901.5266984833015, 911.129870973219, 1015.5227043289642, 20475.8976205121, 21287.46781330448, 21558.353249402542, 21600.891995540234, 21697.67453488199, 900.2258058070055, 900.2887718702283, 930.2465003347311, 946.5314669238771, 978.1245785022508, 10537.312985188728, 10640.0, 11033.889661103447, 11085.445727713583, 11176.720581985515, 574022.0265858799, 575330.0, 583870.0, 588950.0, 589374.0, 124345.0, 124450.75549244572, 128195.0, 129186.0, 131889.0, 950.4344914775697, 995.7958618483193, 996.138340335619, 996.3872218585518, 997.9850302245472, 16850.410235641695, 18422.631547369245, 18917.61858231955, 19069.332573359865, 19302.806971930102, 52502.737486312326, 53187.734061329444, 54213.18680219879, 54259.186112209136, 56218.71890640521, 72193.0, 73004.90492642508, 73126.63436682783, 73710.63144684242, 76040.23959760553, 7811.336036436739, 8031.718889838828, 8119.391045671717, 8144.511329320023, 8368.623411946599, 11002.394868282001, 11175.49710263024, 12699.357886483667, 13199.0, 13246.867531324564, 9779.657711980331, 10719.839202411815, 11079.501422436171, 11208.551657933918, 11223.270487418291, 11228.326300422, 11316.547338106384, 11336.886631133582, 11407.657770266906, 11686.298822070703, 11265.831012534982, 11456.484458199235, 11544.538218471504, 11572.305661660328, 11852.348120853436, 7992.320652744349, 8226.588670566567, 8238.134995825352, 8369.790755231168, 8414.0, 10736.51685674131, 11128.332300062022, 11196.496157672762, 11368.431578421212, 11536.192466527262], "value": 9447.496812683543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.3990913952425, 1420.3963315590872, 1543.976840347395, 1741.939032133875, 1931.169597073258, 7937.603119844006, 8410.78973025674, 8747.868781968276, 9029.593668284926, 9030.864537031934, 8744.43161194522, 8759.605817738202, 8795.120487951217, 8846.5576721164, 8938.463692178457, 2338.9532209355843, 2375.3586531636447, 2375.8455700379504, 2375.881205939696, 2376.6197408414655, 2326.848754830939, 2353.223436266028, 2371.027878569787, 2371.9288421347387, 2376.4652953085506, 2344.460774021976, 2365.9290221293304, 2372.7864492195786, 2379.119725701493, 2380.6905102336673, 2324.372419446757, 2344.8593084414906, 2349.8590084594894, 2353.8116950643907, 2360.634101714237, 2297.0811675329833, 2326.8487548309477, 2327.8486898351553, 2328.895199716017, 2331.5803155432013, 8858.557072146432, 9027.593758280893, 9032.45805251687, 9043.32175086871, 9047.366684332099, 5259.973700131475, 5272.446393128743, 5441.156620723794, 5443.700596467193, 5472.2338872557875, 3525.6298088700573, 3648.434492653643, 3737.3187410400733, 3740.4576336431337, 3750.4186851038135, 932.6828878181451, 1081.4808891731934, 1084.1976937066593, 1107.3189988157226, 1111.522045520426, 9951.950240248825, 11461.083113350913, 11814.822777658343, 11839.94080029603, 12046.397680115959, 4397.560243975577, 4510.1656193604285, 4573.170731707343, 4641.721496710208, 4642.86071417858, 9270.258379329638, 9293.628254869729, 9302.581383837743, 9303.116203960613, 9310.53447327631, 5218.921716174261, 5252.317198764213, 5252.474752524793, 5263.868403289872, 5265.078611243017, 4169.0, 4399.670024748157, 4578.5421457853945, 4582.9770851146195, 4928.778204980785, 3185.665505121975, 3706.388445906395, 3779.036345731876, 3803.470691989796, 3808.1241314497265, 1129.4804389980536, 1130.8021096308114, 1132.92069555132, 1142.0863309352485, 1145.6333973128685, 844.5979673741559, 855.4909828651943, 896.4128495835238, 916.6562539047857, 939.8392984663934, 5304.787808487695, 5732.3407808101765, 5913.70431478433, 5939.940600594025, 6119.5104391648565, 915.3455279475207, 922.3543519536217, 923.3121324613206, 938.4510061613896, 941.2328951904176, 3440.6043305019743, 3695.6304369562827, 3882.2041481496226, 3912.197999410114, 4040.878773636796, 10702.89297107019, 11179.66461006171, 11182.832257516144, 11202.0, 11231.606893758679, 11145.108391328675, 11145.442727863736, 11148.163887708291, 11161.553537858557, 11172.553097876156, 7830.8433831323055, 8302.875456868273, 8312.0, 8461.450005749606, 8476.703315384055, 5974.761009559569, 6053.535549938371, 6068.817935461943, 6169.753209871735, 6190.50475961931, 8613.48319100856, 10150.187984961038, 10330.948345258226, 10347.741306467398, 10348.27562070678, 8945.73162805117, 9386.108319709616, 9813.803723925625, 10318.380897146195, 10464.581416743245, 7110.893336599852, 7346.11846578414, 7518.812029699083, 7592.202818704178, 7606.201348858512, 8369.372297077865, 8377.748667539983, 8382.0, 8460.407771455939, 8509.914900850912, 7601.467897247139, 7655.540667559741, 7687.88468172989, 7693.846123077619, 7796.9220307796195, 7498.925010749823, 7539.660715267716, 7566.621668916642, 7581.50720203185, 7648.694052237848, 7103.573785572882, 7104.254053324533, 7117.0, 7153.678084486315, 7198.136223653195, 4962.925556116589, 4981.37732783402, 4989.276554899447, 5019.3976722793495, 5145.665531740425, 5056.974715126401, 5124.56441202502, 5134.9486505135965, 5150.227465880148, 5231.1107111790325], "value": 4574.812060383981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.9222487141421, 285.55168385634533, 296.19287441721303, 305.3039070918306, 312.38772006866543, 4966.701997880121, 5151.459096794839, 5226.947730522703, 5263.578913686905, 5270.20946857971, 4487.439070116236, 4489.663275254361, 4675.8363457279, 5075.593952483801, 5098.796048158069, 4001.9599804001878, 4010.112718842429, 4017.598240175974, 4020.9396859047138, 4034.5763694811917, 4070.9389359159636, 4072.470578824749, 4075.1645912587846, 4082.387641853716, 4109.5548148851385, 3364.747643926703, 3756.8685096021645, 3907.7655340679507, 3992.580779018205, 4065.5527891931865, 3274.787138835968, 3274.8198849063174, 3274.819884906329, 3971.5829837867186, 4004.0990777075217, 3224.2584205632834, 3456.4642480415323, 3494.8427320770625, 3496.4755286706945, 3497.163988905819, 4196.538380778112, 4624.497038462513, 4912.238603016538, 5119.795208191668, 5170.146925757245, 3828.5979972103087, 4497.235469970113, 4586.128635559233, 4613.146567884952, 4616.522712731927, 5423.261253067215, 5461.781528738846, 5504.2294078829, 5508.430097422215, 5522.337319521643, 3545.6986156176754, 3757.2673328700916, 3836.577976422619, 3848.4804551385487, 3899.025243689078, 5457.918131228074, 5643.40744221859, 5783.421657834183, 5809.7676092956235, 5917.136102127816, 3248.2529018325918, 3677.0, 3680.4847321375028, 3699.648533389324, 3783.129880127586, 3309.23887505875, 3401.183715908214, 3867.361885288952, 3878.6897048236074, 3887.3974533947285, 3947.388154836005, 4529.433820772403, 4536.319552067151, 4550.772461376918, 4583.495815460364, 5303.833156705518, 5502.761878577288, 5513.751881165357, 5526.58550608706, 5567.387587365387, 1215.604928398274, 1294.9546765863338, 1317.2425855133338, 1317.3610798762593, 1319.9836126182786, 750.3996802557932, 770.6455030685835, 778.8598052350632, 798.8122791144076, 805.5770720371735, 4232.809523571446, 4257.340112282601, 4274.572542745701, 4296.570342965679, 4365.541618130114, 4201.474815648044, 4655.231886738718, 4724.385829842098, 4743.786529606176, 4751.59611433032, 3787.1857550626746, 3958.585262989574, 3965.5836137205756, 3999.34010888206, 4328.052376430619, 2376.809855211579, 2460.5324988252173, 2520.8613526255867, 2525.343410713191, 2991.491446454108, 5233.685978841282, 5858.2677165354335, 5872.0, 5879.911801322984, 5922.7927022554, 4926.014797040606, 5038.395392552917, 5177.0068523618675, 5836.970815145897, 5863.0, 4887.7556122194455, 5765.654060756368, 5842.23176051436, 5919.395465994949, 5939.316978547522, 5077.746112694276, 5378.031954248273, 5663.32040155184, 5673.319201695823, 5683.658980461186, 4669.906601867876, 5119.87200319995, 5303.9392121575065, 5649.5650914032285, 5661.773529058792, 4826.986332869996, 4886.462489126265, 5128.9487105129965, 5794.0, 5850.853728656818, 3804.2962052020466, 3947.7433966793214, 3950.3284441645565, 3956.723029387915, 3975.9602403976746, 5172.482751724798, 5541.947030064275, 5572.832815015556, 5585.581081418829, 5595.300587426572, 4725.29120631908, 5298.612008067536, 5343.076492462633, 5396.514313711785, 5427.8330159016, 5347.331583552056, 5347.51872331492, 5395.055865223491, 5395.595330350161, 5456.399796022355, 5250.794666240265, 5266.762995665281, 5314.5216930476445, 5329.946700532945, 5365.651232669864, 4814.916643755268, 5133.0, 5241.842744717665, 5435.945640543544, 5436.565074794086, 4899.412070551557, 5289.2330612061805, 5323.334583177103, 5331.626786125089, 5336.199570064521], "value": 3915.6114980174766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.8066199478161, 756.9205233450488, 791.322396519379, 798.744401791427, 824.8185399212172, 12670.922971547418, 13276.601701948957, 14916.701665966673, 15582.454614088509, 15594.688106237869, 14437.494687685934, 14570.708585828304, 14572.12567245966, 14573.854261457382, 14584.781228281558, 717.3830505765038, 876.6800117956964, 877.6094637886143, 877.7410663854179, 880.4453194487464, 690.3786592067155, 711.5126138595053, 845.6617353058764, 874.5496069524169, 876.3558784293539, 915.6428992692855, 915.8855143107112, 916.3493919317293, 916.8899732032132, 917.1745429113818, 908.9681861134861, 909.5543183839937, 911.7902882337099, 911.977200569991, 912.5209265135791, 530.2417542913632, 547.7370861986269, 550.5953124453523, 666.340323080152, 677.3294438505893, 15083.321250543751, 15141.394344226217, 15143.848561514355, 15202.087874727551, 15207.923960380238, 12080.214786038967, 12418.751624967541, 13216.603501894959, 13972.790408143886, 14265.072770269899, 12761.298128602923, 12875.742485150244, 12971.610851674464, 13017.08880378374, 13498.257595832225, 4154.646855017327, 4561.566651168134, 4688.296755486705, 4715.269133284346, 4741.691790033637, 110181.89818101797, 113670.43164784205, 117591.0, 117650.0, 118057.0, 10701.892981070245, 11057.391843448688, 11149.721256968478, 11204.607838725606, 11323.773524529463, 18459.261629534936, 21557.78442215558, 22572.322830315115, 22635.0, 22693.092276309093, 7672.769816905502, 7751.573663448452, 7830.451868369273, 7890.802729931797, 7952.602369881482, 4289.270823959871, 4298.4197133387215, 4324.308110702273, 4345.90285336552, 4403.0, 3465.341585098823, 3569.7322700797026, 3572.2319701264355, 3580.5524309461316, 3584.0502266899293, 538.3109619686808, 636.9554131210864, 646.318134368246, 646.7283740828863, 649.4187702006677, 598.6856900127468, 621.8538643418793, 630.8239454809101, 634.8254230086764, 656.3836527799767, 7685.42359323053, 7933.761987140395, 9041.81916361669, 9059.229965452878, 9132.46546755438, 508.3061620887462, 570.1846359705661, 570.2842932120162, 586.906095024794, 644.3170239546096, 4109.951169390871, 4413.3821265022925, 4418.668599855024, 4474.888127796766, 4504.887377815581, 96857.0, 99636.0, 139445.30277348548, 159284.0, 164830.17584912, 138391.0, 138820.0, 141171.0, 141520.0, 143335.2833235848, 106811.0, 109092.0, 109654.0, 109950.45024774985, 112411.43794280976, 8573.31413486932, 8576.142385761374, 8613.526256055977, 8782.429142105742, 8870.0, 55666.72166639141, 58009.70995144997, 63230.0, 64400.0, 69244.3040379105, 59429.0, 63974.68012659907, 71136.28863711297, 87140.90013699234, 92812.53593731989, 12264.75470490603, 13062.281574513492, 13370.331483425594, 13412.865871341162, 13554.86445135536, 15060.54818355451, 15064.698706026038, 15456.536303910902, 15657.68684626324, 15751.842481575495, 13205.273709946045, 13936.651583710083, 13946.16323020622, 14094.36575354132, 14336.21150836714, 13589.116707414381, 13625.86374136246, 13664.043516953718, 14234.37802043147, 14616.853831461549, 12974.0, 13384.19694818314, 13404.061715679809, 13912.721745565235, 13940.860591393955, 8811.0, 9090.545472726206, 9121.179093881583, 9126.087391261086, 9713.660021899199, 8124.471909325875, 9171.358004939857, 10963.83554246671, 11555.826662600235, 11758.294502329887], "value": 7680.2956224244435, "unit": "score"}], "name": "dromaeo_css", "value": 7293.904259443873, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 112.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 145.0, 167.0, 114.0, 115.0, 112.0, 115.0, 143.0, 112.0], "value": 129.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 183.0, 184.0, 187.0, 182.0, 260.0, 242.0, 180.0, 181.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 61.0, 50.0, 92.0, 81.0, 83.0, 83.0, 83.0, 86.0, 58.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 95.0, 71.0, 68.0, 69.0, 118.0, 99.0, 84.0, 78.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 87.0, 90.0, 88.0, 89.0, 70.0, 135.0, 130.0, 96.0, 86.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 85.0, 84.0, 83.0, 86.0, 85.0, 84.0, 86.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 82.0, 73.0, 71.0, 70.0, 70.0, 70.0, 71.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 90.0, 86.0, 89.0, 85.0, 89.0, 91.0, 92.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 160.0, 155.0, 145.0, 145.0, 132.0, 143.0, 144.0, 176.0, 144.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 174.0, 172.0, 173.0, 171.0, 177.0, 172.0, 169.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 69.0, 67.0, 67.0, 72.0, 79.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1483.0000000000002, "alertThreshold": 2.0}]} 14:44:12 INFO - Return code: 0 14:44:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:44:12 INFO - # TBPL SUCCESS # 14:44:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:44:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:44:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:44:12 INFO - 2016-10-04 14:44:12.455 screenresolution[1953:20436] starting screenresolution argv=screenresolution get 14:44:12 INFO - 2016-10-04 14:44:12.458 screenresolution[1953:20436] Display 0: 1600x1200x32@60 14:44:12 INFO - 2016-10-04 14:44:12.464 screenresolution[1954:20439] starting screenresolution argv=screenresolution list 14:44:12 INFO - Available Modes on Display 0 14:44:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:44:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:44:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:44:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:44:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:44:12 INFO - Intel Iris: 14:44:12 INFO - Chipset Model: Intel Iris 14:44:12 INFO - Type: GPU 14:44:12 INFO - Bus: Built-In 14:44:12 INFO - VRAM (Dynamic, Max): 1536 MB 14:44:12 INFO - Vendor: Intel (0x8086) 14:44:12 INFO - Device ID: 0x0a2e 14:44:12 INFO - Revision ID: 0x0009 14:44:12 INFO - Displays: 14:44:12 INFO - Display: 14:44:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:44:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:44:12 INFO - Display Serial Number: 1600x1200 60 14:44:12 INFO - Main Display: Yes 14:44:12 INFO - Mirror: Off 14:44:12 INFO - Online: Yes 14:44:12 INFO - Rotation: Supported 14:44:12 INFO - Return code: 0 14:44:12 INFO - Running post-action listener: _resource_record_post_action 14:44:12 INFO - [mozharness: 2016-10-04 21:44:12.709687Z] Finished run-tests step (success) 14:44:12 INFO - Running post-run listener: _resource_record_post_run 14:44:12 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 45056; Write bytes: 703730176; Read time: 1; Write time: 1980 14:44:12 INFO - TinderboxPrint: CPU usage
53.5% 14:44:12 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 1 14:44:12 INFO - TinderboxPrint: I/O write bytes / time
703,730,176 / 1,980 14:44:12 INFO - TinderboxPrint: CPU idle
2,254.7 (46.5%) 14:44:12 INFO - TinderboxPrint: CPU system
974.2 (20.1%) 14:44:12 INFO - TinderboxPrint: CPU user
1,624.8 (33.5%) 14:44:12 INFO - TinderboxPrint: Swap in / out
406,593,536 / 0 14:44:12 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 0; Write bytes: 410093568; Read time: 0; Write time: 868 14:44:12 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 45056; Write bytes: 292112896; Read time: 1; Write time: 1101 14:44:13 INFO - Running post-run listener: _upload_blobber_files 14:44:13 INFO - Blob upload gear active. 14:44:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:44:13 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 14:44:13 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:44:13 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:44:13 INFO - (blobuploader) - INFO - Open directory for files ... 14:44:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:44:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:44:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:14 INFO - (blobuploader) - INFO - Done attempting. 14:44:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:44:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:44:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:15 INFO - (blobuploader) - INFO - Done attempting. 14:44:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:44:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:44:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:44:18 INFO - (blobuploader) - INFO - Done attempting. 14:44:18 INFO - (blobuploader) - INFO - Iteration through files over. 14:44:18 INFO - Return code: 0 14:44:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:44:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:44:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b222dece49f3a164a99edc51c9927286cced117d6e8f693c30c7d37c9e2263e8981d34a5b3325b279b3c16d222e6aa2438e81637fb57a7b53ddd423911e6d39a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/922e9a833b7c7295f50d7ddf74948bd7790f56b18822078d70138fbe7eba9fbe737198a07698c1c9ba2202f0b7613df0be0163b4f93d2ac9b148801f8b576434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55732bc330e0f702969734752200b3392a0ce6337d46e8e918cb6bf75787985fbd984eb83ca94b3969210c54200e1e5416aa5e864f5e3d5003b072b43357ee40"} 14:44:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:44:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:44:18 INFO - Contents: 14:44:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b222dece49f3a164a99edc51c9927286cced117d6e8f693c30c7d37c9e2263e8981d34a5b3325b279b3c16d222e6aa2438e81637fb57a7b53ddd423911e6d39a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/922e9a833b7c7295f50d7ddf74948bd7790f56b18822078d70138fbe7eba9fbe737198a07698c1c9ba2202f0b7613df0be0163b4f93d2ac9b148801f8b576434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55732bc330e0f702969734752200b3392a0ce6337d46e8e918cb6bf75787985fbd984eb83ca94b3969210c54200e1e5416aa5e864f5e3d5003b072b43357ee40"} 14:44:18 INFO - Running post-run listener: copy_logs_to_upload_dir 14:44:18 INFO - Copying logs to upload dir... 14:44:18 INFO - mkdir: /builds/slave/test/build/upload/logs 14:44:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.639613 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-10-04 14:44:18.097067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 14:44:18.100771) ========= 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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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/Autoland/sha512/b222dece49f3a164a99edc51c9927286cced117d6e8f693c30c7d37c9e2263e8981d34a5b3325b279b3c16d222e6aa2438e81637fb57a7b53ddd423911e6d39a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/922e9a833b7c7295f50d7ddf74948bd7790f56b18822078d70138fbe7eba9fbe737198a07698c1c9ba2202f0b7613df0be0163b4f93d2ac9b148801f8b576434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55732bc330e0f702969734752200b3392a0ce6337d46e8e918cb6bf75787985fbd984eb83ca94b3969210c54200e1e5416aa5e864f5e3d5003b072b43357ee40"} build_url:https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/LnOCx7ZaRuOT9ZnHKh0mxw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b222dece49f3a164a99edc51c9927286cced117d6e8f693c30c7d37c9e2263e8981d34a5b3325b279b3c16d222e6aa2438e81637fb57a7b53ddd423911e6d39a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/922e9a833b7c7295f50d7ddf74948bd7790f56b18822078d70138fbe7eba9fbe737198a07698c1c9ba2202f0b7613df0be0163b4f93d2ac9b148801f8b576434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/55732bc330e0f702969734752200b3392a0ce6337d46e8e918cb6bf75787985fbd984eb83ca94b3969210c54200e1e5416aa5e864f5e3d5003b072b43357ee40"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 14:44:18.138386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:44:18.138724) ========= 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.kWDGRYFMnH/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.Fy0FnTtzxR/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005231 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 14:44:18.187491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 14:44:18.187833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 14:44:18.188223) ========= ========= Total master_lag: 0.18 =========