builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0155 starttime: 1475104338.62 results: success (0) buildid: 20160928133120 builduid: 663d0e5f05d54cbaa5c90249c61bfab1 revision: afffe391d02640ed433ca5ca67ce7a35b9c45a66 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:18.620822) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:18.621296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:18.621583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:19.033389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:19.033739) ========= 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.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-09-28 16:12:19-- 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% 70.2M=0s 2016-09-28 16:12:19 (70.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:19.201772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:19.202175) ========= 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.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.027293 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:19.250796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 16:12:19.251153) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev afffe391d02640ed433ca5ca67ce7a35b9c45a66 --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 afffe391d02640ed433ca5ca67ce7a35b9c45a66 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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-09-28 16:12:19,322 truncating revision to first 12 chars 2016-09-28 16:12:19,322 Setting DEBUG logging. 2016-09-28 16:12:19,322 attempt 1/10 2016-09-28 16:12:19,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/afffe391d026?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 16:12:19,974 unpacking tar archive at: autoland-afffe391d026/testing/mozharness/ program finished with exit code 0 elapsedTime=0.932892 ========= master_lag: 0.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 16:12:20.659488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:20.659858) ========= script_repo_revision: afffe391d02640ed433ca5ca67ce7a35b9c45a66 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:20.660261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:20.660538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 16:12:20.679046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-28 16:12:20.679428) ========= /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.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:20 INFO - MultiFileLogger online at 20160928 16:12:20 in /builds/slave/test 16:12:20 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 16:12:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:20 INFO - {'append_to_log': False, 16:12:20 INFO - 'base_work_dir': '/builds/slave/test', 16:12:20 INFO - 'blob_upload_branch': 'Autoland', 16:12:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:20 INFO - 'branch': 'Autoland', 16:12:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:20 INFO - 'config_files': ('talos/mac_config.py',), 16:12:20 INFO - 'default_actions': ('clobber', 16:12:20 INFO - 'read-buildbot-config', 16:12:20 INFO - 'download-and-extract', 16:12:20 INFO - 'populate-webroot', 16:12:20 INFO - 'create-virtualenv', 16:12:20 INFO - 'install', 16:12:20 INFO - 'run-tests'), 16:12:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:20 INFO - 'download_minidump_stackwalk': True, 16:12:20 INFO - 'download_symbols': 'ondemand', 16:12:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:20 INFO - 'installer_path': 'installer.exe', 16:12:20 INFO - 'log_level': 'info', 16:12:20 INFO - 'log_name': 'talos', 16:12:20 INFO - 'log_to_console': True, 16:12:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:12:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:12:20 INFO - 'opt_config_files': (), 16:12:20 INFO - 'pip_index': False, 16:12:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:20 INFO - 'cmd': ('bash', 16:12:20 INFO - '-c', 16:12:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:20 INFO - 'enabled': True, 16:12:20 INFO - 'halt_on_failure': False, 16:12:20 INFO - 'name': 'check_screen_resolution'},), 16:12:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:20 INFO - 'cmd': ('bash', 16:12:20 INFO - '-c', 16:12:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:20 INFO - 'enabled': True, 16:12:20 INFO - 'halt_on_failure': False, 16:12:20 INFO - 'name': 'check_screen_resolution'},), 16:12:20 INFO - 'run_cmd_checks_enabled': True, 16:12:20 INFO - 'sps_profile': False, 16:12:20 INFO - 'sps_profile_interval': 0, 16:12:20 INFO - 'suite': 'dromaeojs', 16:12:20 INFO - 'system_bits': '32', 16:12:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:20 INFO - 'title': 't-yosemite-r7-0155', 16:12:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:20 INFO - 'use_talos_json': True, 16:12:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:20 INFO - 'work_dir': 'build'} 16:12:20 INFO - [mozharness: 2016-09-28 23:12:20.883890Z] Running clobber step. 16:12:20 INFO - Running pre-action listener: _resource_record_pre_action 16:12:20 INFO - Running main action method: clobber 16:12:20 INFO - rmtree: /builds/slave/test/build 16:12:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:23 INFO - Running post-action listener: _resource_record_post_action 16:12:23 INFO - [mozharness: 2016-09-28 23:12:23.077490Z] Finished clobber step (success) 16:12:23 INFO - [mozharness: 2016-09-28 23:12:23.077646Z] Running read-buildbot-config step. 16:12:23 INFO - Running pre-action listener: _resource_record_pre_action 16:12:23 INFO - Running main action method: read_buildbot_config 16:12:23 INFO - Using buildbot properties: 16:12:23 INFO - { 16:12:23 INFO - "project": "", 16:12:23 INFO - "product": "firefox", 16:12:23 INFO - "script_repo_revision": "production", 16:12:23 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 16:12:23 INFO - "repository": "", 16:12:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 16:12:23 INFO - "buildid": "20160928133120", 16:12:23 INFO - "pgo_build": "False", 16:12:23 INFO - "basedir": "/builds/slave/test", 16:12:23 INFO - "buildnumber": 198, 16:12:23 INFO - "slavename": "t-yosemite-r7-0155", 16:12:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:12:23 INFO - "platform": "yosemite_r7", 16:12:23 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:12:23 INFO - "branch": "autoland", 16:12:23 INFO - "repo_path": "integration/autoland", 16:12:23 INFO - "revision": "afffe391d02640ed433ca5ca67ce7a35b9c45a66", 16:12:23 INFO - "stage_platform": "macosx64", 16:12:23 INFO - "builduid": "663d0e5f05d54cbaa5c90249c61bfab1", 16:12:23 INFO - "slavebuilddir": "test" 16:12:23 INFO - } 16:12:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 16:12:23 INFO - Running post-action listener: _resource_record_post_action 16:12:23 INFO - [mozharness: 2016-09-28 23:12:23.081141Z] Finished read-buildbot-config step (success) 16:12:23 INFO - [mozharness: 2016-09-28 23:12:23.081264Z] Running download-and-extract step. 16:12:23 INFO - Running pre-action listener: _resource_record_pre_action 16:12:23 INFO - Running main action method: download_and_extract 16:12:23 INFO - mkdir: /builds/slave/test/build/tests 16:12:23 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')]} 16:12:23 INFO - trying https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 16:12:23 INFO - Downloading https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/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 16:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/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 16:12:24 INFO - Downloaded 1199 bytes. 16:12:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 16:12:24 INFO - Using the following test package requirements: 16:12:24 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:12:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 16:12:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 16:12:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'jsshell-mac.zip'], 16:12:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 16:12:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 16:12:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 16:12:24 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 16:12:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 16:12:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 16:12:24 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 16:12:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:12:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:12:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:12:24 INFO - Fetch https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:12:24 INFO - Http code: 200 16:12:24 INFO - Content-Encoding: None 16:12:24 INFO - Content-Type: application/zip 16:12:24 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 16:12:24 INFO - x-amz-cf-id: NbKdXYz6PSA8iIXvnOqhYJznEClN-Z4HL1yKlX8kLpd-louAZwKbjQ== 16:12:24 INFO - x-amz-version-id: Zj8lS7wzkFr94LGHEnnVs1CvyaAT0IqM 16:12:24 INFO - x-cache: Hit from cloudfront 16:12:24 INFO - Expected file size: 16473050 16:12:24 INFO - Obtained file size: 16473050 16:12:31 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 16:12:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 16:12:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:12:31 INFO - Fetch https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 16:12:32 INFO - Http code: 200 16:12:32 INFO - Content-Encoding: None 16:12:32 INFO - Content-Type: application/zip 16:12:32 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 16:12:32 INFO - x-amz-cf-id: 0quv-HY1qczHUzRvr_TefYiGC7DOMvV2uUR-P3RWh_P6-e03p7G7Cg== 16:12:32 INFO - x-amz-version-id: Zj8lS7wzkFr94LGHEnnVs1CvyaAT0IqM 16:12:32 INFO - x-cache: Hit from cloudfront 16:12:32 INFO - Expected file size: 16473050 16:12:32 INFO - Obtained file size: 16473050 16:12:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 16:12:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:12:39 INFO - Fetch https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 16:12:39 INFO - Http code: 200 16:12:39 INFO - Content-Encoding: None 16:12:39 INFO - Content-Type: application/zip 16:12:39 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 16:12:39 INFO - x-amz-cf-id: _37AiIEuS3gJxtDbRbU0CMytjgLpLDOdavGVan0rT0v6hU2iVCbgRw== 16:12:39 INFO - x-amz-version-id: ybbbZKMR5..XXTi_OgxQZSdF4no5lvwR 16:12:39 INFO - x-cache: Hit from cloudfront 16:12:40 INFO - Expected file size: 14414067 16:12:40 INFO - Obtained file size: 14414067 16:12: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')]} 16:12:40 INFO - trying https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:12:40 INFO - Downloading https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 16:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/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 16:12:43 INFO - Downloaded 111809165 bytes. 16:12:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:12:43 INFO - mkdir: /builds/slave/test/properties 16:12:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:43 INFO - Contents: 16:12:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 16:12:43 INFO - Running post-action listener: _resource_record_post_action 16:12:43 INFO - Running post-action listener: set_extra_try_arguments 16:12:43 INFO - [mozharness: 2016-09-28 23:12:43.959128Z] Finished download-and-extract step (success) 16:12:43 INFO - [mozharness: 2016-09-28 23:12:43.959280Z] Running populate-webroot step. 16:12:43 INFO - Running pre-action listener: _resource_record_pre_action 16:12:43 INFO - Running main action method: populate_webroot 16:12:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:43 INFO - '--tppagecycles', 16:12:43 INFO - '7'], 16:12:43 INFO - 'tests': ['tsvgm']}}, 16:12:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['damp', 'tps']}, 16:12:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['damp', 'tps']}, 16:12:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['dromaeo_dom']}, 16:12:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['basic_compositor_video']}, 16:12:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:12:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['a11yr', 16:12:43 INFO - 'ts_paint', 16:12:43 INFO - 'tpaint', 16:12:43 INFO - 'sessionrestore', 16:12:43 INFO - 'sessionrestore_no_auto_restore', 16:12:43 INFO - 'tabpaint']}, 16:12:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['tsvgx', 16:12:43 INFO - 'tsvgr_opacity', 16:12:43 INFO - 'tart', 16:12:43 INFO - 'tscrollx', 16:12:43 INFO - 'cart']}, 16:12:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:43 INFO - 'tsvgr_opacity', 16:12:43 INFO - 'tart', 16:12:43 INFO - 'tscrollx', 16:12:43 INFO - 'cart']}, 16:12:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--disable-e10s'], 16:12:43 INFO - 'tests': ['tp5o']}, 16:12:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'tests': ['tp5o']}, 16:12:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--disable-e10s', 16:12:43 INFO - '--xperf_path', 16:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:43 INFO - 'tests': ['tp5n']}, 16:12:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:43 INFO - 'talos_options': ['--xperf_path', 16:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:43 INFO - 'tests': ['tp5n']}}, 16:12:43 INFO - 'talos.zip': {'path': '', 16:12:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:43 INFO - Running post-action listener: _resource_record_post_action 16:12:43 INFO - [mozharness: 2016-09-28 23:12:43.978084Z] Finished populate-webroot step (success) 16:12:43 INFO - [mozharness: 2016-09-28 23:12:43.978187Z] Running create-virtualenv step. 16:12:43 INFO - Running pre-action listener: _resource_record_pre_action 16:12:43 INFO - Running main action method: create_virtualenv 16:12:43 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:43 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 16:12:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:44 INFO - Using real prefix '/tools/python27' 16:12:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:47 INFO - Installing pip.................done. 16:12:47 INFO - Return code: 0 16:12:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:47 INFO - Reading from file tmpfile_stdout 16:12:47 INFO - Output received: 16:12:47 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) 16:12:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12: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')]} 16:12:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:12:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:47 INFO - 'HOME': '/Users/cltbld', 16:12:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:47 INFO - 'LOGNAME': 'cltbld', 16:12:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:47 INFO - 'MOZ_NO_REMOTE': '1', 16:12:47 INFO - 'NO_EM_RESTART': '1', 16:12:47 INFO - 'PAGER': '/bin/cat', 16:12:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:47 INFO - 'PWD': '/builds/slave/test', 16:12:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:47 INFO - 'SHELL': '/bin/bash', 16:12:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:12:47 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:12:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:47 INFO - 'USER': 'cltbld', 16:12:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:47 INFO - 'XPC_FLAGS': '0x0', 16:12:47 INFO - 'XPC_SERVICE_NAME': '0', 16:12:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 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 16:12:48 INFO - Cleaning up... 16:12:48 INFO - Return code: 0 16:12:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:48 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:48 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 16:12:48 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 16:12:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:12:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:48 INFO - 'HOME': '/Users/cltbld', 16:12:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:48 INFO - 'LOGNAME': 'cltbld', 16:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:48 INFO - 'MOZ_NO_REMOTE': '1', 16:12:48 INFO - 'NO_EM_RESTART': '1', 16:12:48 INFO - 'PAGER': '/bin/cat', 16:12:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:48 INFO - 'PWD': '/builds/slave/test', 16:12:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:48 INFO - 'SHELL': '/bin/bash', 16:12:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:12:48 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:12:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:48 INFO - 'USER': 'cltbld', 16:12:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:48 INFO - 'XPC_FLAGS': '0x0', 16:12:48 INFO - 'XPC_SERVICE_NAME': '0', 16:12:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:48 INFO - Downloading/unpacking psutil>=3.1.1 16:12:48 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 16:12:48 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 16:12:48 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 16:12:48 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 16:12:48 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 16:12:48 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 16:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:51 INFO - Installing collected packages: psutil 16:12:51 INFO - Running setup.py install for psutil 16:12:52 INFO - building 'psutil._psutil_osx' extension 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 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 16:12:52 INFO - building 'psutil._psutil_posix' extension 16:12:52 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 16:12:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:12:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:12:52 INFO - ^ 16:12:52 INFO - 1 warning generated. 16:12:52 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 16:12:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:53 INFO - Successfully installed psutil 16:12:53 INFO - Cleaning up... 16:12:53 INFO - Return code: 0 16:12:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:53 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')]} 16:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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')]} 16:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:53 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:53 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 16:12:53 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 16:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:53 INFO - 'HOME': '/Users/cltbld', 16:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:53 INFO - 'LOGNAME': 'cltbld', 16:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:53 INFO - 'MOZ_NO_REMOTE': '1', 16:12:53 INFO - 'NO_EM_RESTART': '1', 16:12:53 INFO - 'PAGER': '/bin/cat', 16:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:53 INFO - 'PWD': '/builds/slave/test', 16:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:53 INFO - 'SHELL': '/bin/bash', 16:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:12:53 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:53 INFO - 'USER': 'cltbld', 16:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:53 INFO - 'XPC_FLAGS': '0x0', 16:12:53 INFO - 'XPC_SERVICE_NAME': '0', 16:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:53 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 16:12:53 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 16:12:53 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 16:12:53 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 16:12:53 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 16:12:53 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 16:12:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:56 INFO - Installing collected packages: mozsystemmonitor 16:12:56 INFO - Running setup.py install for mozsystemmonitor 16:12:56 INFO - Successfully installed mozsystemmonitor 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:56 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')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:56 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 16:12:56 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 16:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:56 INFO - 'HOME': '/Users/cltbld', 16:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PAGER': '/bin/cat', 16:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:12:56 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - 'XPC_FLAGS': '0x0', 16:12:56 INFO - 'XPC_SERVICE_NAME': '0', 16:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:56 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 16:12:56 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 16:12:56 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 16:12:56 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 16:12:56 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 16:12:56 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 16:12:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:58 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 16:12:58 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 16:12:58 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 16:12:58 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 16:12:58 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 16:12:58 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 16:12:59 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:59 INFO - warning: no files found matching '*.txt' 16:12:59 INFO - no previously-included directories found matching 'build' 16:12:59 INFO - no previously-included directories found matching 'dist' 16:12:59 INFO - no previously-included directories found matching '.git*' 16:12:59 INFO - Installing collected packages: jsonschema, functools32 16:12:59 INFO - Running setup.py install for functools32 16:12:59 INFO - warning: no files found matching '*.txt' 16:12:59 INFO - no previously-included directories found matching 'build' 16:12:59 INFO - no previously-included directories found matching 'dist' 16:12:59 INFO - no previously-included directories found matching '.git*' 16:12:59 INFO - Successfully installed jsonschema functools32 16:12:59 INFO - Cleaning up... 16:12:59 INFO - Return code: 0 16:12:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:59 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')]} 16:12:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:59 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')]} 16:12:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:59 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:12:59 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 16:12:59 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 16:12:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:12:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:59 INFO - 'HOME': '/Users/cltbld', 16:12:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:59 INFO - 'LOGNAME': 'cltbld', 16:12:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:59 INFO - 'MOZ_NO_REMOTE': '1', 16:12:59 INFO - 'NO_EM_RESTART': '1', 16:12:59 INFO - 'PAGER': '/bin/cat', 16:12:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:59 INFO - 'PWD': '/builds/slave/test', 16:12:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:59 INFO - 'SHELL': '/bin/bash', 16:12:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:12:59 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:12:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:59 INFO - 'USER': 'cltbld', 16:12:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:59 INFO - 'XPC_FLAGS': '0x0', 16:12:59 INFO - 'XPC_SERVICE_NAME': '0', 16:12:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:00 INFO - Cleaning up... 16:13:00 INFO - Return code: 0 16:13:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:00 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')]} 16:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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')]} 16:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:00 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:13:00 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 16:13:00 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 16:13:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:00 INFO - 'HOME': '/Users/cltbld', 16:13:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:00 INFO - 'LOGNAME': 'cltbld', 16:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:00 INFO - 'MOZ_NO_REMOTE': '1', 16:13:00 INFO - 'NO_EM_RESTART': '1', 16:13:00 INFO - 'PAGER': '/bin/cat', 16:13:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:00 INFO - 'PWD': '/builds/slave/test', 16:13:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:00 INFO - 'SHELL': '/bin/bash', 16:13:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:00 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:00 INFO - 'USER': 'cltbld', 16:13:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:00 INFO - 'XPC_FLAGS': '0x0', 16:13:00 INFO - 'XPC_SERVICE_NAME': '0', 16:13:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:00 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:00 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 16:13:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:02 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 16:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:03 INFO - Downloading docopt-0.6.1.tar.gz 16:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:04 INFO - Running setup.py install for blobuploader 16:13:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:04 INFO - Running setup.py install for requests 16:13:04 INFO - Running setup.py install for docopt 16:13:04 INFO - Successfully installed blobuploader requests docopt 16:13:04 INFO - Cleaning up... 16:13:04 INFO - Return code: 0 16:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:04 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')]} 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:05 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')]} 16:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:05 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:13:05 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 16:13:05 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 16:13:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:05 INFO - 'HOME': '/Users/cltbld', 16:13:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:05 INFO - 'LOGNAME': 'cltbld', 16:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:05 INFO - 'MOZ_NO_REMOTE': '1', 16:13:05 INFO - 'NO_EM_RESTART': '1', 16:13:05 INFO - 'PAGER': '/bin/cat', 16:13:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:05 INFO - 'PWD': '/builds/slave/test', 16:13:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:05 INFO - 'SHELL': '/bin/bash', 16:13:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:05 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:05 INFO - 'USER': 'cltbld', 16:13:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:05 INFO - 'XPC_FLAGS': '0x0', 16:13:05 INFO - 'XPC_SERVICE_NAME': '0', 16:13:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DssoHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-2LHD75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Q4bTFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-nfhLL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Srb0Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-l7z4Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-oMiTqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-ntiwDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-nUunHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:06 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-B88wiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-aQ_v4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-WEcL8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-GZi11s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-DeSY3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-pYrtVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-pbXz1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:07 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-zznyAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:07 INFO - Running setup.py install for manifestparser 16:13:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:07 INFO - Running setup.py install for mozcrash 16:13:08 INFO - Running setup.py install for mozdebug 16:13:08 INFO - Running setup.py install for mozdevice 16:13:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Running setup.py install for mozfile 16:13:08 INFO - Running setup.py install for mozhttpd 16:13:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Running setup.py install for mozinfo 16:13:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Running setup.py install for mozInstall 16:13:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:08 INFO - Running setup.py install for mozleak 16:13:09 INFO - Running setup.py install for mozlog 16:13:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Running setup.py install for moznetwork 16:13:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Running setup.py install for mozprocess 16:13:09 INFO - Running setup.py install for mozprofile 16:13:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Running setup.py install for mozrunner 16:13:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:09 INFO - Running setup.py install for mozscreenshot 16:13:10 INFO - Running setup.py install for moztest 16:13:10 INFO - Running setup.py install for mozversion 16:13:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:10 INFO - Cleaning up... 16:13:10 INFO - Return code: 0 16:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:10 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:13:10 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 16:13:10 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 16:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:10 INFO - 'HOME': '/Users/cltbld', 16:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:10 INFO - 'LOGNAME': 'cltbld', 16:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:10 INFO - 'MOZ_NO_REMOTE': '1', 16:13:10 INFO - 'NO_EM_RESTART': '1', 16:13:10 INFO - 'PAGER': '/bin/cat', 16:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:10 INFO - 'PWD': '/builds/slave/test', 16:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:10 INFO - 'SHELL': '/bin/bash', 16:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:10 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:10 INFO - 'USER': 'cltbld', 16:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:10 INFO - 'XPC_FLAGS': '0x0', 16:13:10 INFO - 'XPC_SERVICE_NAME': '0', 16:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Zb8PDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-aXbnX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-AQzFYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-m69qg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-0yt42K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-4LiDMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-Naa6da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-tve0_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-3jjNL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:11 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)) 16:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:11 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-1T2kRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-X4j4Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-kLknov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-bifhEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-kJtTpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-j0s785-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-NIPn2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:12 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)) 16:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:12 INFO - Running setup.py (path:/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/pip-6vOHth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:12 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)) 16:13:12 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)) 16:13:12 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)) 16:13:12 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)) 16:13:12 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)) 16:13:12 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)) 16:13:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:12 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 16:13:12 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 16:13:12 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 16:13:12 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 16:13:12 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 16:13:12 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 16:13:15 INFO - Downloading blessings-1.6.tar.gz 16:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:15 INFO - Installing collected packages: blessings 16:13:15 INFO - Running setup.py install for blessings 16:13:15 INFO - Successfully installed blessings 16:13:15 INFO - Cleaning up... 16:13:16 INFO - Return code: 0 16:13:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:16 INFO - Reading from file tmpfile_stdout 16:13:16 INFO - Current package versions: 16:13:16 INFO - blessings == 1.6 16:13:16 INFO - blobuploader == 1.2.4 16:13:16 INFO - docopt == 0.6.1 16:13:16 INFO - functools32 == 3.2.3-2 16:13:16 INFO - jsonschema == 2.5.1 16:13:16 INFO - manifestparser == 1.1 16:13:16 INFO - mozInstall == 1.12 16:13:16 INFO - mozcrash == 0.17 16:13:16 INFO - mozdebug == 0.1 16:13:16 INFO - mozdevice == 0.48 16:13:16 INFO - mozfile == 1.2 16:13:16 INFO - mozhttpd == 0.7 16:13:16 INFO - mozinfo == 0.9 16:13:16 INFO - mozleak == 0.1 16:13:16 INFO - mozlog == 3.4 16:13:16 INFO - moznetwork == 0.27 16:13:16 INFO - mozprocess == 0.23 16:13:16 INFO - mozprofile == 0.28 16:13:16 INFO - mozrunner == 6.12 16:13:16 INFO - mozscreenshot == 0.1 16:13:16 INFO - mozsystemmonitor == 0.3 16:13:16 INFO - moztest == 0.7 16:13:16 INFO - mozversion == 1.4 16:13:16 INFO - psutil == 3.1.1 16:13:16 INFO - requests == 1.2.3 16:13:16 INFO - wsgiref == 0.1.2 16:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:16 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')]} 16:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:16 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')]} 16:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:16 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:13:16 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 16:13:16 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 16:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:16 INFO - 'HOME': '/Users/cltbld', 16:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:16 INFO - 'LOGNAME': 'cltbld', 16:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:16 INFO - 'MOZ_NO_REMOTE': '1', 16:13:16 INFO - 'NO_EM_RESTART': '1', 16:13:16 INFO - 'PAGER': '/bin/cat', 16:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:16 INFO - 'PWD': '/builds/slave/test', 16:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:16 INFO - 'SHELL': '/bin/bash', 16:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:16 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:16 INFO - 'USER': 'cltbld', 16:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:16 INFO - 'XPC_FLAGS': '0x0', 16:13:16 INFO - 'XPC_SERVICE_NAME': '0', 16:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 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)) 16:13:16 INFO - Cleaning up... 16:13:16 INFO - Return code: 0 16:13:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:16 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')]} 16:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:16 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')]} 16:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:16 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 0x101767490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016dd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee98d56e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, '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.NKmgVlREHj/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.bogZpJjqvw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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 16:13:16 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 16:13:16 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 16:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:16 INFO - 'HOME': '/Users/cltbld', 16:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:16 INFO - 'LOGNAME': 'cltbld', 16:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:16 INFO - 'MOZ_NO_REMOTE': '1', 16:13:16 INFO - 'NO_EM_RESTART': '1', 16:13:16 INFO - 'PAGER': '/bin/cat', 16:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:16 INFO - 'PWD': '/builds/slave/test', 16:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:16 INFO - 'SHELL': '/bin/bash', 16:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:16 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:16 INFO - 'USER': 'cltbld', 16:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:16 INFO - 'XPC_FLAGS': '0x0', 16:13:16 INFO - 'XPC_SERVICE_NAME': '0', 16:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:16 INFO - Cleaning up... 16:13:16 INFO - Return code: 0 16:13:16 INFO - Running post-action listener: _resource_record_post_action 16:13:16 INFO - Running post-action listener: _start_resource_monitoring 16:13:16 INFO - Starting resource monitoring. 16:13:16 INFO - [mozharness: 2016-09-28 23:13:16.965205Z] Finished create-virtualenv step (success) 16:13:16 INFO - [mozharness: 2016-09-28 23:13:16.966203Z] Running install step. 16:13:16 INFO - Running pre-action listener: _resource_record_pre_action 16:13:16 INFO - Running main action method: install 16:13:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:17 INFO - Reading from file tmpfile_stdout 16:13:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:17 INFO - Reading from file tmpfile_stdout 16:13:17 INFO - Output received: 16:13:17 INFO - Usage: mozinstall [options] installer 16:13:17 INFO - Options: 16:13:17 INFO - -h, --help show this help message and exit 16:13:17 INFO - -d DEST, --destination=DEST 16:13:17 INFO - Directory to install application into. [default: 16:13:17 INFO - "/builds/slave/test"] 16:13:17 INFO - --app=APP Application being installed. [default: firefox] 16:13:17 INFO - mkdir: /builds/slave/test/build/application 16:13:17 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'] 16:13:17 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 16:13:51 INFO - Reading from file tmpfile_stdout 16:13:51 INFO - Output received: 16:13:51 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:13:51 INFO - Running post-action listener: _resource_record_post_action 16:13:51 INFO - [mozharness: 2016-09-28 23:13:51.548100Z] Finished install step (success) 16:13:51 INFO - [mozharness: 2016-09-28 23:13:51.548207Z] Running run-tests step. 16:13:51 INFO - Running pre-action listener: _resource_record_pre_action 16:13:51 INFO - Running main action method: run_tests 16:13:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:51 INFO - 2016-09-28 16:13:51.562 screenresolution[1637:7603] starting screenresolution argv=screenresolution get 16:13:51 INFO - 2016-09-28 16:13:51.565 screenresolution[1637:7603] Display 0: 1600x1200x32@60 16:13:51 INFO - 2016-09-28 16:13:51.571 screenresolution[1638:7605] starting screenresolution argv=screenresolution list 16:13:51 INFO - Available Modes on Display 0 16:13:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:51 INFO - Intel Iris: 16:13:51 INFO - Chipset Model: Intel Iris 16:13:51 INFO - Type: GPU 16:13:51 INFO - Bus: Built-In 16:13:51 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:51 INFO - Vendor: Intel (0x8086) 16:13:51 INFO - Device ID: 0x0a2e 16:13:51 INFO - Revision ID: 0x0009 16:13:51 INFO - Displays: 16:13:51 INFO - Display: 16:13:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:51 INFO - Display Serial Number: 1600x1200 60 16:13:51 INFO - Main Display: Yes 16:13:51 INFO - Mirror: Off 16:13:51 INFO - Online: Yes 16:13:51 INFO - Rotation: Supported 16:13:51 INFO - Return code: 0 16:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:51 INFO - Python 2.7.3 16:13:51 INFO - Return code: 0 16:13:51 INFO - grabbing minidump binary from tooltool 16:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:51 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 0x10157bd30>, '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 0x1013a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101573b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:51 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 16:13:51 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 16:13:51 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 16:13:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:51 INFO - Return code: 0 16:13:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:13:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:13:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:51 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/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 16:13:51 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/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0155 --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 16:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKmgVlREHj/Render', 16:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:51 INFO - 'HOME': '/Users/cltbld', 16:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:51 INFO - 'LOGNAME': 'cltbld', 16:13:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:51 INFO - 'MOZ_NO_REMOTE': '1', 16:13:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:51 INFO - 'NO_EM_RESTART': '1', 16:13:51 INFO - 'PAGER': '/bin/cat', 16:13:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:51 INFO - 'PWD': '/builds/slave/test', 16:13:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:51 INFO - 'SHELL': '/bin/bash', 16:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bogZpJjqvw/Listeners', 16:13:51 INFO - 'TMPDIR': '/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/', 16:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:51 INFO - 'USER': 'cltbld', 16:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:51 INFO - 'XPC_FLAGS': '0x0', 16:13:51 INFO - 'XPC_SERVICE_NAME': '0', 16:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:51 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/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0155', '--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 16:13:52 INFO - mozversion application_buildid: 20160928133120 16:13:52 INFO - mozversion application_changeset: afffe391d02640ed433ca5ca67ce7a35b9c45a66 16:13:52 INFO - mozversion application_display_name: Nightly 16:13:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:52 INFO - mozversion application_name: Firefox 16:13:52 INFO - mozversion application_remotingname: firefox 16:13:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:13:52 INFO - mozversion application_vendor: Mozilla 16:13:52 INFO - mozversion application_version: 52.0a1 16:13:52 INFO - mozversion platform_buildid: 20160928133120 16:13:52 INFO - mozversion platform_changeset: afffe391d02640ed433ca5ca67ce7a35b9c45a66 16:13:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:13:52 INFO - mozversion platform_version: 52.0a1 16:13:52 INFO - using testdate: 1475104432 16:13:52 INFO - actual date: 1475104432 16:13:52 INFO - starting webserver on 'localhost:49271' 16:13:52 INFO - SUITE-START | Running 2 tests 16:13:52 INFO - TEST-START | dromaeo_css 16:13:52 INFO - operating with platform_type : mac_ 16:13:52 INFO - Initialising browser for dromaeo_css test... 16:13:52 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp5xedob/profile http://localhost:49271/getInfo.html) 16:13:54 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 16:13:54 INFO - PROCESS | 1648 | colorDepth:24 16:13:54 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 16:13:54 INFO - PROCESS | 1648 | __metrics 16:13:54 INFO - PROCESS | 1648 | 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" 16:13:54 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:13:55 INFO - TEST-INFO | 1648: exit 0 16:13:55 INFO - Browser initialized. 16:13:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:55 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmp5xedob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:07 INFO - PROCESS | 1650 | RSS: Main: 235614208 16:14:07 INFO - PROCESS | 1650 | 16:14:59 INFO - PROCESS | 1650 | 1475104499263 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] 16:17:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 16:17:11 INFO - PROCESS | 1650 | RSS: Main: 365109248 16:17:11 INFO - PROCESS | 1650 | 16:20:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 16:20:15 INFO - PROCESS | 1650 | RSS: Main: 370831360 16:20:15 INFO - PROCESS | 1650 | 16:23:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 16:23:18 INFO - PROCESS | 1650 | RSS: Main: 366067712 16:23:18 INFO - PROCESS | 1650 | 16:26:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 16:26:21 INFO - PROCESS | 1650 | RSS: Main: 365780992 16:26:21 INFO - PROCESS | 1650 | 16:29:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 16:29:25 INFO - PROCESS | 1650 | RSS: Main: 335355904 16:29:25 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 16:32:28 INFO - PROCESS | 1650 | RSS: Main: 468893696 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | __start_tp_report 16:32:28 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:32:28 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:32:28 INFO - PROCESS | 1650 | |i|pagename|runs| 16:32:28 INFO - PROCESS | 1650 | |0;dojo.html;3032.969670303297;3323.368559973605;3338.0653417043236;3362.815045172518;3364.7812892162005;5536;5628.465295796897;5636.549076073915;5698.145278208271;5706.058500347448;5644.983902897477;5674.716264186794;5756.712164391784;5759.222504961829;5771.624844385112;5103.744812759366;5132.307138536287;5157.819476318329;5211.166213405856;5234.084035293828;5271.341082364705;5283.894322113575;5289.86775330616;5294.338207724035;5295.179247216687;5126.948730512684;5237.266782650432;5246.160614301693;5337.653052551572;5366.980273747995;4317.222899878021;5164.25118357836;5171.948280517222;5243.501867322599;5278.155495120801;5200.29795977542;5205.791768329263;5220.765065572058;5224.4775522447835;5231.424543300234;5600.439956004408;5717.571182161355;5730.426957304237;5733.856653583652;5792.507636850873;5654.321481422256;5765.423457654243;6134.2529056856065;6170.938290617081;6198.845028874269;6185.350538193515;6196.070589411579;6263.655498947556;6263.780767673155;6273.749050037993;5818.2145410369485;5821.255438160348;5823.767049317979;5826.766929322865;5867.266591676041;6172.783952561639;6206.968965155235;6239.625622462667;6256.624602523863;6289.528285378615;6117.327094019654;6124.601900876429;6134.044295328781;6191.473724733448;6195.473384762346;6227.221597300338;6232.626042437469;6246.500279977682;6251.218597675291;6256.906146407808;6104.603200791934;6115.544587952024;6148.200733904564;6220.315765265817;6220.968895155495;6074.179985701962;6145.262568491809;6156.507479401637;6188.721507532172;6201.503879689614;4173.895652608649;4763.404574428197;4918.458969513351;4935.975320123376;4951.331570238044;4113.259613269581;4442.955570444255;4448.866534003985;4453.821847126143;4460.420145381079;5664.943350566442;5688.971555142198;5740;5748.511376533042;5805.622634528827;6192.690365481708;6239.407256310734;6248.75004999804;6279.623222606567;6281.214848143982;5802.82591522255;5805.970970145207;5811.593188476851;5826.941730582725;5875.970620146872;5269.5257426831;5323.547498462674;5331.760070796823;5398;5400.83797486076;6170.413810687977;6236.251649801871;6243.719032643542;6284.528660350584;6299.464545513682;6237.345078766664;6238.563300569098;6239.532035097295;6243.8126856194385;6258.687065646791;6141.815745527641;6152.446279834837;6265.467435268053;6281.937180628135;6295.150154729053;6119.472088496418;6133.877322453615;6146.200993870768;6155.199824022849;6160.7535698571555;6087.4521293083835;6154.846128846814;6197.287311959182;6212.534059945612;6233.937660623335;6020.759169633166;6093.6039157454625;6099.695015249308;6103.908441373294;6116.908246376397;6116.418940200674;6126.479249263863;6126.908096378469;6139.508839292756;6154.753809847735;5824.5340372770925;5899.321578018411;5904.940950590439;5908.5568582357355;5980.730867110903;6124.295705993868;6147.754089836535;6150.015997440388;6156.322804491592;6157.0456579230295;5959.314678811818;6000.279966404059;6008.54935879802;6031.24609423822;6040.788572399945 16:32:28 INFO - PROCESS | 1650 | |1;ext.html;473.38223618178284;512.2444394518085;522.5871561466442;531.1793279383352;535.5849216856938;38577.42133867991;40250.39624405636;40297.798511007444;42580;42599.36100958488;40402.595974040254;40911.795441022754;40918.59081409185;41015.974600634996;41068.178636427256;8702.216800487955;9654.565544550494;9839;9840.16358609519;9846.064623860722;8716.694915677952;11897.583584574542;12145.635630931041;12220.633380998584;12384.19502732324;12148.878511214863;12157.331346775924;12170.756584868297;12174.756504869898;12217.266963982145;8758.430702004349;8977.910220897773;12161.08791840611;12247.448864801105;12253.57112501067;11635.011024062966;11987.160898737093;12078.456469458895;12175.0868684849;12206.816897746541;40116;40385.19229615421;40485.98785030368;40504.797476012725;40536;3291.243014106769;3305.5537502437346;3396.5075064115813;3510.9122271943406;3554.1921881713415;30337.544936825965;30965.535516967262;30979.380412391627;31005;31238.37523249545;3181.9363612727616;3263.494158405451;3300.7689461737687;3364.1925937775004;3374.156460884779;461818;463885;466604.6669766663;466761;468074.6596266997;46676;56873.43126568764;56955;57030.7148464255;57042.85914281691;58013.8397232053;58084;58124;58183.70908145432;58232.708836455546;15746.448874289345;15977.840221597868;15994.680106397807;16001.359945602278;16010.039397635946;11310.830337544943;11492.597759078559;11541.249818761753;12548.372581370895;12627;14692.559223223321;14917.776233356508;15092.16993065392;15280.617984550252;15369.155701315914;5513.035218836688;6357.442426605511;6465.127207826883;6499.5775274607;6539.705713242915;856.3448961544424;892.9553522323988;1010.2574607663508;1022.2384323678907;1091.6288461922984;26184.95260189571;29123;29235.56146657802;29608;29876.850615746782;1024.5287167902848;1053.1416895230363;1053.963111291101;1057.962971296001;1072.2708558180511;14054.508092216724;14248.501302454364;14459.421623134956;15471.5358539244;15485.922570387302;634606;638396;638525;638529;639132;56798.148027779614;56830;56881.71559142178;56885;57016.71491642515;1209.9153059285766;1249.5439164704999;1332.6535100873648;1358.341204515809;1374.7869080292571;27729.584056239575;29418.852905735333;29441;30332.696673032988;30409.391812164075;47567.52432475631;48018;48065.75967120142;48069.278960816315;48192;415641;416093;416570.91714541236;416833;417809;24070.39824004414;25133.371665708502;25704.74295257098;25804.870975645;26860.865695671397;46287;46401.30398043965;46572.30141547812;46734.298985515925;47809.52190478051;38347.424788627635;38469.03827404225;38836.41745373878;39636.60363396329;40550.39174412445;37630.62369376381;37634.8118259407;38845;39002.414963775;39235.41146882742;37071.62928370682;37440.15574405535;37742.43386349262;37763.81118094392;38386.232275354894;28281.727322270137;33470.832645836614;33496.33007339888;33672.49491257682;34164.14589635279;20413.48966275855;22753.203637872593;24016.639750403407;25486.23541293764;26076.8696156518 16:32:28 INFO - PROCESS | 1650 | |2;jquery.html;353.64635364635365;372.7558449215763;375.5530918207333;383.4286912500375;404.3227593780417;15023.24883755812;15417;15872;16705.997640141584;20931.953402329862;19867.60264794703;20483.692744608805;20806.583868322625;21162.57674846506;21472;5043.873903152432;5796.449337312959;6070.757169713206;6071.423214794588;6076.240469941257;5960.523158147338;6008.729607167688;6086.056661217496;6089.421504957022;6092.268927728656;5681.801136960207;5893.616914900539;6014.8195554133445;6024.1566180734735;6029.427204415595;5887.646741195521;5951.88096238075;5957.940420595782;5958.940410595882;5962.165296858443;5026.321446604698;5068.341115654941;5197.376314842205;5235.65968212065;5238.476152384769;26068.478630427475;26148.60777088326;26166.6075008875;26274.474510509874;26362;2297;2340.7776261255153;2375.6674065630827;2874.238326843388;2901.4777340078776;14795.112293262438;15525.689486210325;16198.27107780141;16258.943168694115;16315.10266935318;1808.9909550452296;1888.178642290608;1897.67739484288;1903.8762480438727;1936.6417212815534;108349.45825270824;109640;109814;111798;114438.42780786126;10435.895641043644;10516.474176291154;10681.679549613524;10902.018818306231;11129.220954533266;13508.32458377097;13540.322983850769;13563.796543051862;13569.52506662262;13597.796033059512;7929.20707929214;8185.467944583702;8220.958895205486;8357.874631880526;8362.498250105013;8089.02931648206;8099;8106.649071769121;8257.463264887883;8302.958485207535;5329.760160792774;6353.3329000455215;6471.708773105222;6494.157913371828;6578.703958321887;1756.6925787987052;1809.819018098206;1809.8914065156132;1810.791758947738;1810.9004004779863;885.2563846369081;918.8943271523726;972.7081875437341;1005.1154983614373;1020.0972139656458;20924;21973.67039494409;22231.66652500214;22294;22360;766.7661363284141;889.6708217959397;954.5942974235921;960.2989817433313;968.719071469266;10116.696499105039;11693.824592631117;11701.707457313465;11799;11815.527378904919;528588;529501;584395;608406.7898302578;609905;114993;116699;118295.81704182849;118499.40750296193;120321.39839300922;981.2444417798256;993.3741742702051;1020.9387436753818;1024.800163968034;1025.9692209233735;18993.810061899756;19261;19272.614547709247;19338.709919351502;19350.4194874154;50472.747636261585;50829.237561437345;51199;52292.47707523028;52552;55757.442425576846;72437;73493;73923;77496;5832;7510.173880873209;7927.326177274997;8001.679932802623;8136.959315203623;11398.772024559297;12355;12936.482540698267;12955.5465558705;13272.80090798658;11022.50398732043;11128.777424451304;11359.48882300315;11515.25150865191;11555.191136620691;10726.946365268124;10811.297265677706;11024.724381890517;11037.392943388191;11131.387773672526;8730.301575873787;10934.289271197347;11189.104871610414;11572.421378931189;11581.536738530365;5783.529882070724;7708.344790692854;7876.330511906552;8084.514929104273;8141.51150930946;10298;11165.90296025565;11336.94331528337;11365.318080914842;11423.143264255048 16:32:28 INFO - PROCESS | 1650 | |3;mootools.html;1310.397217280051;1351.0812647399764;1517.4537166620019;1663.417803768681;1892.9905350473246;7751.999999999993;8232.094469608346;8334.20825021622;8711.128887111301;8764.474131552111;8577.614007369668;8676.826463470727;8682.86975695365;8695.739127826175;8726.214640682338;2350.189184731265;2379.167291447997;2379.6311571706415;2381.4879800842814;2381.6784734060852;2320.7331156916916;2362.7755363240462;2369.5497855407502;2373.750756170603;2387.6060450025725;2326.7905888470036;2349.5535848188874;2360.079568968104;2365.396823809926;2368.12379419615;2270.421042634118;2294.621387471074;2304.80409165222;2311.2257393773107;2338.1348900906605;2310.1683393978155;2316.860988340688;2318.93043208704;2319.1071437496516;2328.1851352026656;7010.474214433938;8551.486910785372;8602.397832151752;8619.913800861974;8724.214820666108;5123.718195499246;5292.206169074631;5299.390570084451;5305.363356397218;5330.893382132335;3582.17609949713;3594.6944509716704;3665.083729067733;3666.7799932004164;3673.1368128489785;1066.4934156275706;1074.6292529077455;1076.8923107689247;1092.7213560542011;1099.6810924831789;11402.144839137014;11439.542418303257;11496.482658280398;11533.942330288379;11589.710257243552;4266.4240327556;4329.307310830252;4496.4154659894;4513.097380523843;4514.7291162530355;8992.8651070234;9000.774980625405;9004.054574269607;9015.27877769777;9031.63873445068;5031.471695471996;5126.974365128151;5134.306868572769;5134.845954621367;5137.537621614073;4167.979160104241;4292.313229883203;4334.068175342317;4492.326151077365;4726.692764970266;3611.6749492545796;3641.708663306929;3749.9875033740736;3751.7936513491472;3773.4528493368307;1121.545773961547;1135.1316243074054;1143.2911594811271;1146.4726225935997;1146.478352349679;816.3428440105772;839.261449924063;860.4665107633182;870.4255191573658;953.3993584042009;5603.691796951207;5650;5718.971405142947;5971.402859713994;6072.848178795477;410.68172166571145;415.59479507479966;427.7476288989511;428.60568277185064;428.976890117073;3822.063594419385;3892.0464486201063;3989.7207195496035;4023.6177563131455;4048.554658987509;10061.094501494901;10251.948740256252;10496.527656255486;10636.893631063745;10664.946675266729;10597.470126493645;10601.992810682972;10605;10640.25518213733;10645.627403040857;7929.246721561442;8026.558539280396;8072.757817265491;8152.714654987166;8155.551444670481;5645.209670646195;5656.1798539212405;5717.456841600041;5805.564582656233;5810.535157187331;9513.619455221713;9688.32181747271;9818.950905245429;9858.901410986085;9965.601375944882;8193.262606365455;10083.899161008589;10086.142677872464;10141.935096814728;10162.560985363607;5862.94137058624;6321.49428045746;6946.062281592122;6999.12510936133;7003.089598352181;8190.180981901762;8384.916150838413;8393.202645748644;8396.328293736364;8408.53753043564;7292.34368906801;7367.484276100836;7381.926180738124;7449.14334851499;7518.097828260425;7255.782326530212;7269.273072692688;7280.963595182202;7285.162206346126;7367.926320736724;6864.1762988439705;6960.686769095504;6967.79096627102;7016.719331226694;7052.471064670068;4881.219004959189;4937.17324589904;4960.528749768766;4984.37695288089;5073.036123136592;4895.7062576245535;4955.479674634255;5010.398752149766;5063.594912407072;5162.380514338303 16:32:28 INFO - PROCESS | 1650 | |4;prototype.html;271.70655691852795;291.31831514256635;296.21650733809076;312.09959267513216;317.00618560811847;5005.724685142316;5223;5242.898991211845;5327.6803391796475;5331.3069300990865;4347.391365208865;4551.749653769041;5117.692938423697;5118.897622047557;5169.457206993258;3310.867565297385;3418.350513402458;3949.8545421827635;3979.9801000994953;4057.16828050249;3970.6029397060206;4052.5947405259535;4055.986003499125;4059.776712280823;4060.20825938942;3140.8429578521095;3188.5854838870914;3292.1769557610596;3383.796972181665;4001.6198461146146;3380.2056516718553;3944.8027598619956;3969.7816620085882;3998.960010399888;4005.2590270799997;2917.226934862263;2942.955855662167;3469.3581687387914;3471;3471.114865709253;4599.781058019627;4806.831760888387;4830.420349558076;5064.696118232918;5171.612129090296;4466.709663871838;4548.499665036843;4556;4575.58819706228;4642.234031384817;4562;5450.5367043801325;5463.590230732671;5474.014677358074;5509.311336082989;3227.01576019314;3321.4021476134285;3567.375709250871;3624.6194149614175;3782.3569993101237;4723.1970565003685;5453.481919217668;5462.344518657746;5685.346185188673;5752.705641230731;3647.963520364762;3722.8324725387424;3829.3681542545723;3833.290841194388;3867.7099217558234;3869.6130386961077;3902.239063382613;3910.198409326081;3916.3538016227003;3931.488906442144;3578.9442114576264;4561.68068235227;4563.383943167696;4566.178087944136;4582.21293695459;4334.544872788312;5199.584033277329;5495.725213739297;5569.582281328835;5595.496405323541;1130.1298000539703;1266.8859802617808;1304.480280473257;1319.8284223051135;1327.3408239700375;687.4672129099988;795.3041089047084;810.5866008335792;813.6655884349672;827.7020272701823;3808.763349635659;3829.789361585084;4235.407043013981;4358.455193100863;4363.7744750177635;4281.972326641584;4375.409319741794;4442.844500442469;4805.327254184417;4832.782524786393;3626.9093272668392;3872.361060425055;4002.618442026989;4242.766647834399;4372.213001659668;2119.629064913634;2373.8457000294925;2432.8053755699502;2465.654808326836;2485.4714350674567;4022.718409711292;4852.51474852519;4874.2444921037295;4905.48492408292;4915.287283343967;4292.291771857608;4854.805807767721;4885.706857588556;4899.657024008286;4901.387326584177;4253.2769429197115;4475.933754609211;4755.956188039589;4786.976065119652;4920.532549407801;3949.466821978996;4079.7960101994186;4625.606823420047;4633.536646335339;4663.510331415288;4071.7760523170323;4503.748125937032;4714.9764251179895;4719.126961512131;4724.472407262098;4270.807813648331;4563.361129441947;4698.318743782064;4880.536349046835;5401.432849550741;3324.4375143682432;3755.943660845144;3795.772253664789;3810.9809450952566;3813.199228162117;4817.542333478314;5638.436156384493;5669.262995810518;5695.373508914099;5713.628614140068;4722.7484716550825;5206.661566998133;5514.228008078792;5532.972335138298;5579.581531385081;5556.91664625039;5563.885723425073;5575.609707320448;5579.721013949367;5602;5045.722485263345;5424.15578703227;5470.522958801022;5505.146702261156;5525.668459892419;4635.466921304093;5259.526642602184;5482.972585137049;5541.3904470507405;5545.669039430427;4509.954900450954;4512.495564961478;5448.972755136199;5479.369872464558;5482.588805839658 16:32:28 INFO - PROCESS | 1650 | |5;yui.html;687.4019602945438;767.7197822794678;783.0212234706617;798.5408390175651;809.668036105197;15223.923880380597;15911.602209944756;15913.204339783008;15920;16321.83678163218;14276.571702848905;14415.92792036041;14431.567052988401;14440.855591444082;14469.20419376934;666.070831190489;687.9724811007553;832.2010869565224;842.9704960326405;870.8214815962745;820.9179082091803;854.5684429363193;861.2808305065278;865.2385900407633;867.2628265973904;872.6204101215959;898.2858627391207;912.4434095201922;913.2237598041678;920.2132176988679;702.4591064880065;722.5411863466684;724.8004552465678;724.9130104387507;908.9500077495768;546.0880329849161;662.0466528199426;676.7462201674372;681.7068660475993;682.7951614515675;15250.38998440061;15252.923735381362;15283;15285.235738213045;15288.082715037133;13937.512187073404;14136.92931535346;14183.929080354636;14356;14451.205183714892;10501.842472362921;12909.031822613342;13075.476980920752;13191.604251872459;13550.390232439564;4214.452121224252;4274.230638485072;4538.931916021263;4656.022235330551;4734.360861283752;119321.40339298335;119442.4027879855;121864;121933.17100243503;121950.17074743885;11098.833517497244;11132.554697812158;11212.887871121347;11305.378204198683;11500.660843295744;18854.90572547156;18865.717014244798;21835.90820458971;22742.431439213822;22782.65826012611;7989;8019.478733882279;8020.679172833022;8077.151899050633;8200.630971606291;4472.753998530112;4487.506374298824;4549.340345649928;4655.883602909955;4669.4630117536235;3460.325236578843;3581.4420726983844;3582.5880023797595;3583.552055993001;3587.443946188345;633.1768700689086;633.7845132654919;641;659.5745743995192;668.7559040950116;469.3007418945746;492.8841722195281;538.6875612144946;616.6269407008696;630.580663858529;9040.8643870342;9202.539873006323;9207.769805754775;9232.552214723588;9281.30390220736;447.73136118328745;516.702895834889;626.7586979013113;634.8920683483819;644.2076246217179;4068.7151899367354;4252.553481884358;4255.97872010638;4287.592678695519;4458.353538736865;160377;164535;165964;166695.16395942366;176880.11559942376;133502.03992168946;136585;136830;139297.6070239305;144350;118829.40585297019;119541.40229298797;120525.39737301257;121555.99999999822;121936;8202.26179643835;8219.589020548829;8220.465669731448;8263;8530.914690853013;64257;65671;66353.33646663472;67084.65830683456;67591.98612020921;97583.51208243913;99557.51106222402;99863.50068249903;102359.48820255851;104475;11343.262687925258;11743.530258789553;11751.412429378668;12150.635480935585;12258;10121.493925303852;11993;12049.156559040783;12360.196587221802;12767.74464510686;9948.55231514598;11348.432578370883;11761.294322340687;11951.10366722482;12063.095267855122;13543.525976590772;13664.93167534156;13753.587392378246;14100.576982690536;14103.435862565382;12615.116941813985;12929.54746583865;13123.343832808512;13142.948564115039;13296.135751176143;10241.975802419996;10914.945425272823;10917.23579349438;11312.547498099984;11622.18644694897;7348;10720.73198170052;10832.783344333227;11265.435167326084;11350.489227984926 16:32:28 INFO - PROCESS | 1650 | __end_tp_report 16:32:28 INFO - PROCESS | 1650 | __start_cc_report 16:32:28 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1952 16:32:28 INFO - PROCESS | 1650 | __end_cc_report 16:32:28 INFO - PROCESS | 1650 | __startTimestamp1475105548641__endTimestamp 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:32:28 INFO - PROCESS | 1650 | Number of tests: 6 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5724.97 Median:5980.73 stddev:656.42 (11.0%) stddev-sans-first:623.54 16:32:28 INFO - PROCESS | 1650 | Values: 3033.0 3323.4 3338.1 3362.8 3364.8 5536.0 5628.5 5636.5 5698.1 5706.1 5645.0 5674.7 5756.7 5759.2 5771.6 5103.7 5132.3 5157.8 5211.2 5234.1 5271.3 5283.9 5289.9 5294.3 5295.2 5126.9 5237.3 5246.2 5337.7 5367.0 4317.2 5164.3 5171.9 5243.5 5278.2 5200.3 5205.8 5220.8 5224.5 5231.4 5600.4 5717.6 5730.4 5733.9 5792.5 5654.3 5765.4 6134.3 6170.9 6198.8 6185.4 6196.1 6263.7 6263.8 6273.7 5818.2 5821.3 5823.8 5826.8 5867.3 6172.8 6207.0 6239.6 6256.6 6289.5 6117.3 6124.6 6134.0 6191.5 6195.5 6227.2 6232.6 6246.5 6251.2 6256.9 6104.6 6115.5 6148.2 6220.3 6221.0 6074.2 6145.3 6156.5 6188.7 6201.5 4173.9 4763.4 4918.5 4936.0 4951.3 4113.3 4443.0 4448.9 4453.8 4460.4 5664.9 5689.0 5740.0 5748.5 5805.6 6192.7 6239.4 6248.8 6279.6 6281.2 5802.8 5806.0 5811.6 5826.9 5876.0 5269.5 5323.5 5331.8 5398.0 5400.8 6170.4 6236.3 6243.7 6284.5 6299.5 6237.3 6238.6 6239.5 6243.8 6258.7 6141.8 6152.4 6265.5 6281.9 6295.2 6119.5 6133.9 6146.2 6155.2 6160.8 6087.5 6154.8 6197.3 6212.5 6233.9 6020.8 6093.6 6099.7 6103.9 6116.9 6116.4 6126.5 6126.9 6139.5 6154.8 5824.5 5899.3 5904.9 5908.6 5980.7 6124.3 6147.8 6150.0 6156.3 6157.0 5959.3 6000.3 6008.5 6031.2 6040.8 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:64545.72 Median:37255.89 stddev:137523.13 (369.1%) stddev-sans-first:137824.78 16:32:28 INFO - PROCESS | 1650 | Values: 473.4 512.2 522.6 531.2 535.6 38577.4 40250.4 40297.8 42580.0 42599.4 40402.6 40911.8 40918.6 41016.0 41068.2 8702.2 9654.6 9839.0 9840.2 9846.1 8716.7 11897.6 12145.6 12220.6 12384.2 12148.9 12157.3 12170.8 12174.8 12217.3 8758.4 8977.9 12161.1 12247.4 12253.6 11635.0 11987.2 12078.5 12175.1 12206.8 40116.0 40385.2 40486.0 40504.8 40536.0 3291.2 3305.6 3396.5 3510.9 3554.2 30337.5 30965.5 30979.4 31005.0 31238.4 3181.9 3263.5 3300.8 3364.2 3374.2 461818.0 463885.0 466604.7 466761.0 468074.7 46676.0 56873.4 56955.0 57030.7 57042.9 58013.8 58084.0 58124.0 58183.7 58232.7 15746.4 15977.8 15994.7 16001.4 16010.0 11310.8 11492.6 11541.2 12548.4 12627.0 14692.6 14917.8 15092.2 15280.6 15369.2 5513.0 6357.4 6465.1 6499.6 6539.7 856.3 893.0 1010.3 1022.2 1091.6 26185.0 29123.0 29235.6 29608.0 29876.9 1024.5 1053.1 1054.0 1058.0 1072.3 14054.5 14248.5 14459.4 15471.5 15485.9 634606.0 638396.0 638525.0 638529.0 639132.0 56798.1 56830.0 56881.7 56885.0 57016.7 1209.9 1249.5 1332.7 1358.3 1374.8 27729.6 29418.9 29441.0 30332.7 30409.4 47567.5 48018.0 48065.8 48069.3 48192.0 415641.0 416093.0 416570.9 416833.0 417809.0 24070.4 25133.4 25704.7 25804.9 26860.9 46287.0 46401.3 46572.3 46734.3 47809.5 38347.4 38469.0 38836.4 39636.6 40550.4 37630.6 37634.8 38845.0 39002.4 39235.4 37071.6 37440.2 37742.4 37763.8 38386.2 28281.7 33470.8 33496.3 33672.5 34164.1 20413.5 22753.2 24016.6 25486.2 26076.9 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33668.99 Median:2358.22 stddev:95394.55 (4045.2%) stddev-sans-first:95629.36 16:32:28 INFO - PROCESS | 1650 | Values: 353.6 372.8 375.6 383.4 404.3 15023.2 15417.0 15872.0 16706.0 20932.0 19867.6 20483.7 20806.6 21162.6 21472.0 5043.9 5796.4 6070.8 6071.4 6076.2 5960.5 6008.7 6086.1 6089.4 6092.3 5681.8 5893.6 6014.8 6024.2 6029.4 5887.6 5951.9 5957.9 5958.9 5962.2 5026.3 5068.3 5197.4 5235.7 5238.5 26068.5 26148.6 26166.6 26274.5 26362.0 2297.0 2340.8 2375.7 2874.2 2901.5 14795.1 15525.7 16198.3 16258.9 16315.1 1809.0 1888.2 1897.7 1903.9 1936.6 108349.5 109640.0 109814.0 111798.0 114438.4 10435.9 10516.5 10681.7 10902.0 11129.2 13508.3 13540.3 13563.8 13569.5 13597.8 7929.2 8185.5 8221.0 8357.9 8362.5 8089.0 8099.0 8106.6 8257.5 8303.0 5329.8 6353.3 6471.7 6494.2 6578.7 1756.7 1809.8 1809.9 1810.8 1810.9 885.3 918.9 972.7 1005.1 1020.1 20924.0 21973.7 22231.7 22294.0 22360.0 766.8 889.7 954.6 960.3 968.7 10116.7 11693.8 11701.7 11799.0 11815.5 528588.0 529501.0 584395.0 608406.8 609905.0 114993.0 116699.0 118295.8 118499.4 120321.4 981.2 993.4 1020.9 1024.8 1026.0 18993.8 19261.0 19272.6 19338.7 19350.4 50472.7 50829.2 51199.0 52292.5 52552.0 55757.4 72437.0 73493.0 73923.0 77496.0 5832.0 7510.2 7927.3 8001.7 8137.0 11398.8 12355.0 12936.5 12955.5 13272.8 11022.5 11128.8 11359.5 11515.3 11555.2 10726.9 10811.3 11024.7 11037.4 11131.4 8730.3 10934.3 11189.1 11572.4 11581.5 5783.5 7708.3 7876.3 8084.5 8141.5 10298.0 11165.9 11336.9 11365.3 11423.1 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5552.37 Median:4916.44 stddev:3131.10 (63.7%) stddev-sans-first:3123.65 16:32:28 INFO - PROCESS | 1650 | Values: 1310.4 1351.1 1517.5 1663.4 1893.0 7752.0 8232.1 8334.2 8711.1 8764.5 8577.6 8676.8 8682.9 8695.7 8726.2 2350.2 2379.2 2379.6 2381.5 2381.7 2320.7 2362.8 2369.5 2373.8 2387.6 2326.8 2349.6 2360.1 2365.4 2368.1 2270.4 2294.6 2304.8 2311.2 2338.1 2310.2 2316.9 2318.9 2319.1 2328.2 7010.5 8551.5 8602.4 8619.9 8724.2 5123.7 5292.2 5299.4 5305.4 5330.9 3582.2 3594.7 3665.1 3666.8 3673.1 1066.5 1074.6 1076.9 1092.7 1099.7 11402.1 11439.5 11496.5 11533.9 11589.7 4266.4 4329.3 4496.4 4513.1 4514.7 8992.9 9000.8 9004.1 9015.3 9031.6 5031.5 5127.0 5134.3 5134.8 5137.5 4168.0 4292.3 4334.1 4492.3 4726.7 3611.7 3641.7 3750.0 3751.8 3773.5 1121.5 1135.1 1143.3 1146.5 1146.5 816.3 839.3 860.5 870.4 953.4 5603.7 5650.0 5719.0 5971.4 6072.8 410.7 415.6 427.7 428.6 429.0 3822.1 3892.0 3989.7 4023.6 4048.6 10061.1 10251.9 10496.5 10636.9 10664.9 10597.5 10602.0 10605.0 10640.3 10645.6 7929.2 8026.6 8072.8 8152.7 8155.6 5645.2 5656.2 5717.5 5805.6 5810.5 9513.6 9688.3 9819.0 9858.9 9965.6 8193.3 10083.9 10086.1 10141.9 10162.6 5862.9 6321.5 6946.1 6999.1 7003.1 8190.2 8384.9 8393.2 8396.3 8408.5 7292.3 7367.5 7381.9 7449.1 7518.1 7255.8 7269.3 7281.0 7285.2 7367.9 6864.2 6960.7 6967.8 7016.7 7052.5 4881.2 4937.2 4960.5 4984.4 5073.0 4895.7 4955.5 5010.4 5063.6 5162.4 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4179.25 Median:4558.84 stddev:1291.99 (28.3%) stddev-sans-first:1261.89 16:32:28 INFO - PROCESS | 1650 | Values: 271.7 291.3 296.2 312.1 317.0 5005.7 5223.0 5242.9 5327.7 5331.3 4347.4 4551.7 5117.7 5118.9 5169.5 3310.9 3418.4 3949.9 3980.0 4057.2 3970.6 4052.6 4056.0 4059.8 4060.2 3140.8 3188.6 3292.2 3383.8 4001.6 3380.2 3944.8 3969.8 3999.0 4005.3 2917.2 2943.0 3469.4 3471.0 3471.1 4599.8 4806.8 4830.4 5064.7 5171.6 4466.7 4548.5 4556.0 4575.6 4642.2 4562.0 5450.5 5463.6 5474.0 5509.3 3227.0 3321.4 3567.4 3624.6 3782.4 4723.2 5453.5 5462.3 5685.3 5752.7 3648.0 3722.8 3829.4 3833.3 3867.7 3869.6 3902.2 3910.2 3916.4 3931.5 3578.9 4561.7 4563.4 4566.2 4582.2 4334.5 5199.6 5495.7 5569.6 5595.5 1130.1 1266.9 1304.5 1319.8 1327.3 687.5 795.3 810.6 813.7 827.7 3808.8 3829.8 4235.4 4358.5 4363.8 4282.0 4375.4 4442.8 4805.3 4832.8 3626.9 3872.4 4002.6 4242.8 4372.2 2119.6 2373.8 2432.8 2465.7 2485.5 4022.7 4852.5 4874.2 4905.5 4915.3 4292.3 4854.8 4885.7 4899.7 4901.4 4253.3 4475.9 4756.0 4787.0 4920.5 3949.5 4079.8 4625.6 4633.5 4663.5 4071.8 4503.7 4715.0 4719.1 4724.5 4270.8 4563.4 4698.3 4880.5 5401.4 3324.4 3755.9 3795.8 3811.0 3813.2 4817.5 5638.4 5669.3 5695.4 5713.6 4722.7 5206.7 5514.2 5533.0 5579.6 5556.9 5563.9 5575.6 5579.7 5602.0 5045.7 5424.2 5470.5 5505.1 5525.7 4635.5 5259.5 5483.0 5541.4 5545.7 4510.0 4512.5 5449.0 5479.4 5482.6 16:32:28 INFO - PROCESS | 1650 | 16:32:28 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:26394.07 Median:3520.88 stddev:43740.69 (1242.3%) stddev-sans-first:43820.81 16:32:28 INFO - PROCESS | 1650 | Values: 687.4 767.7 783.0 798.5 809.7 15223.9 15911.6 15913.2 15920.0 16321.8 14276.6 14415.9 14431.6 14440.9 14469.2 666.1 688.0 832.2 843.0 870.8 820.9 854.6 861.3 865.2 867.3 872.6 898.3 912.4 913.2 920.2 702.5 722.5 724.8 724.9 909.0 546.1 662.0 676.7 681.7 682.8 15250.4 15252.9 15283.0 15285.2 15288.1 13937.5 14136.9 14183.9 14356.0 14451.2 10501.8 12909.0 13075.5 13191.6 13550.4 4214.5 4274.2 4538.9 4656.0 4734.4 119321.4 119442.4 121864.0 121933.2 121950.2 11098.8 11132.6 11212.9 11305.4 11500.7 18854.9 18865.7 21835.9 22742.4 22782.7 7989.0 8019.5 8020.7 8077.2 8200.6 4472.8 4487.5 4549.3 4655.9 4669.5 3460.3 3581.4 3582.6 3583.6 3587.4 633.2 633.8 641.0 659.6 668.8 469.3 492.9 538.7 616.6 630.6 9040.9 9202.5 9207.8 9232.6 9281.3 447.7 516.7 626.8 634.9 644.2 4068.7 4252.6 4256.0 4287.6 4458.4 160377.0 164535.0 165964.0 166695.2 176880.1 133502.0 136585.0 136830.0 139297.6 144350.0 118829.4 119541.4 120525.4 121556.0 121936.0 8202.3 8219.6 8220.5 8263.0 8530.9 64257.0 65671.0 66353.3 67084.7 67592.0 97583.5 99557.5 99863.5 102359.5 104475.0 11343.3 11743.5 11751.4 12150.6 12258.0 10121.5 11993.0 12049.2 12360.2 12767.7 9948.6 11348.4 11761.3 11951.1 12063.1 13543.5 13664.9 13753.6 14100.6 14103.4 12615.1 12929.5 13123.3 13142.9 13296.1 10242.0 10914.9 10917.2 11312.5 11622.2 7348.0 10720.7 10832.8 11265.4 11350.5 16:32:28 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:32:28 INFO - PROCESS | 1650 | 16:32:29 INFO - TEST-INFO | 1650: exit 0 16:32:29 INFO - TEST-OK | dromaeo_css | took 1117176ms 16:32:29 INFO - TEST-START | kraken 16:32:29 INFO - operating with platform_type : mac_ 16:32:29 INFO - Initialising browser for kraken test... 16:32:29 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpMfaKCF/profile http://localhost:49271/getInfo.html) 16:32:31 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 16:32:31 INFO - PROCESS | 1658 | colorDepth:24 16:32:31 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 16:32:31 INFO - PROCESS | 1658 | __metrics 16:32:31 INFO - PROCESS | 1658 | 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" 16:32:31 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:32 INFO - TEST-INFO | 1658: exit 0 16:32:32 INFO - Browser initialized. 16:32:32 INFO - Running cycle 1/1 for kraken test... 16:32:32 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/T/tmpMfaKCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:44 INFO - PROCESS | 1659 | RSS: Main: 235991040 16:32:44 INFO - PROCESS | 1659 | 16:32:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:47 INFO - PROCESS | 1659 | RSS: Main: 294318080 16:32:47 INFO - PROCESS | 1659 | 16:32:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 16:32:51 INFO - PROCESS | 1659 | RSS: Main: 292782080 16:32:51 INFO - PROCESS | 1659 | 16:32:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 16:32:55 INFO - PROCESS | 1659 | RSS: Main: 384921600 16:32:55 INFO - PROCESS | 1659 | 16:32:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 16:32:58 INFO - PROCESS | 1659 | RSS: Main: 284696576 16:32:58 INFO - PROCESS | 1659 | 16:33:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:00 INFO - PROCESS | 1659 | RSS: Main: 288768000 16:33:00 INFO - PROCESS | 1659 | 16:33:03 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:04 INFO - PROCESS | 1659 | RSS: Main: 325869568 16:33:04 INFO - PROCESS | 1659 | 16:33:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:07 INFO - PROCESS | 1659 | RSS: Main: 327159808 16:33:07 INFO - PROCESS | 1659 | 16:33:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 16:33:11 INFO - PROCESS | 1659 | RSS: Main: 325488640 16:33:11 INFO - PROCESS | 1659 | 16:33:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:13 INFO - PROCESS | 1659 | RSS: Main: 300457984 16:33:13 INFO - PROCESS | 1659 | 16:33:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:15 INFO - PROCESS | 1659 | RSS: Main: 305606656 16:33:15 INFO - PROCESS | 1659 | 16:33:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:18 INFO - PROCESS | 1659 | RSS: Main: 308453376 16:33:18 INFO - PROCESS | 1659 | 16:33:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:22 INFO - PROCESS | 1659 | RSS: Main: 316575744 16:33:22 INFO - PROCESS | 1659 | 16:33:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:26 INFO - PROCESS | 1659 | RSS: Main: 318652416 16:33:26 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 16:33:28 INFO - PROCESS | 1659 | RSS: Main: 362422272 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | __start_tp_report 16:33:28 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 16:33:28 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 16:33:28 INFO - PROCESS | 1659 | |i|pagename|runs| 16:33:28 INFO - PROCESS | 1659 | |0;ai-astar;113;115;114;113;113;114;119;112;114;114 16:33:28 INFO - PROCESS | 1659 | |1;audio-beat-detection;152;109;105;147;97;127;141;132;141;108 16:33:28 INFO - PROCESS | 1659 | |2;audio-dft;184;187;184;186;185;183;184;181;181;183 16:33:28 INFO - PROCESS | 1659 | |3;audio-fft;81;59;60;88;61;61;59;57;83;59 16:33:28 INFO - PROCESS | 1659 | |4;audio-oscillator;85;71;93;69;68;70;92;69;70;89 16:33:28 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;85;94;130;115;85;88;85;88;84 16:33:28 INFO - PROCESS | 1659 | |6;imaging-darkroom;141;108;92;94;93;93;103;149;148;91 16:33:28 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;85;84;84;89;85;86;84;84;85 16:33:28 INFO - PROCESS | 1659 | |8;json-parse-financial;54;53;53;53;53;53;57;53;52;56 16:33:28 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;64;71;75;77;71;71;70;71;70;73 16:33:28 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;89;84;86;87;86;87;88;84;84;88 16:33:28 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;143;151;153;147;150;149;132;198;152 16:33:28 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;169;170;169;168;173;169;169;170;167;172 16:33:28 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;68;68;68;71;85;89;87;67;67 16:33:28 INFO - PROCESS | 1659 | __end_tp_report 16:33:28 INFO - PROCESS | 1659 | __start_cc_report 16:33:28 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2050 16:33:28 INFO - PROCESS | 1659 | __end_cc_report 16:33:28 INFO - PROCESS | 1659 | __startTimestamp1475105608309__endTimestamp 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | ------- Summary: start ------- 16:33:28 INFO - PROCESS | 1659 | Number of tests: 14 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:1.91 (1.7%) stddev-sans-first:1.99 16:33:28 INFO - PROCESS | 1659 | Values: 113.0 115.0 114.0 113.0 113.0 114.0 119.0 112.0 114.0 114.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:141.00 stddev:19.72 (14.0%) stddev-sans-first:18.51 16:33:28 INFO - PROCESS | 1659 | Values: 152.0 109.0 105.0 147.0 97.0 127.0 141.0 132.0 141.0 108.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.93 (1.1%) stddev-sans-first:2.05 16:33:28 INFO - PROCESS | 1659 | Values: 184.0 187.0 184.0 186.0 185.0 183.0 184.0 181.0 181.0 183.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:66.80 Median:61.00 stddev:12.04 (19.7%) stddev-sans-first:11.63 16:33:28 INFO - PROCESS | 1659 | Values: 81.0 59.0 60.0 88.0 61.0 61.0 59.0 57.0 83.0 59.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.00 stddev:10.69 (13.7%) stddev-sans-first:11.00 16:33:28 INFO - PROCESS | 1659 | Values: 85.0 71.0 93.0 69.0 68.0 70.0 92.0 69.0 70.0 89.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:94.10 Median:86.00 stddev:15.64 (18.2%) stddev-sans-first:16.37 16:33:28 INFO - PROCESS | 1659 | Values: 87.0 85.0 94.0 130.0 115.0 85.0 88.0 85.0 88.0 84.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:91.50 stddev:24.68 (27.0%) stddev-sans-first:23.71 16:33:28 INFO - PROCESS | 1659 | Values: 141.0 108.0 92.0 94.0 93.0 93.0 103.0 149.0 148.0 91.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 16:33:28 INFO - PROCESS | 1659 | Values: 84.0 85.0 84.0 84.0 89.0 85.0 86.0 84.0 84.0 85.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:1.57 (3.0%) stddev-sans-first:1.66 16:33:28 INFO - PROCESS | 1659 | Values: 54.0 53.0 53.0 53.0 53.0 53.0 57.0 53.0 52.0 56.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:3.43 (4.8%) stddev-sans-first:2.42 16:33:28 INFO - PROCESS | 1659 | Values: 64.0 71.0 75.0 77.0 71.0 71.0 70.0 71.0 70.0 73.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.66 16:33:28 INFO - PROCESS | 1659 | Values: 89.0 84.0 86.0 87.0 86.0 87.0 88.0 84.0 84.0 88.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:150.50 stddev:17.65 (11.7%) stddev-sans-first:18.14 16:33:28 INFO - PROCESS | 1659 | Values: 139.0 143.0 151.0 153.0 147.0 150.0 149.0 132.0 198.0 152.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:1.78 (1.0%) stddev-sans-first:1.87 16:33:28 INFO - PROCESS | 1659 | Values: 169.0 170.0 169.0 168.0 173.0 169.0 169.0 170.0 167.0 172.0 16:33:28 INFO - PROCESS | 1659 | 16:33:28 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:69.50 stddev:9.30 (13.4%) stddev-sans-first:9.54 16:33:28 INFO - PROCESS | 1659 | Values: 67.0 68.0 68.0 68.0 71.0 85.0 89.0 87.0 67.0 67.0 16:33:28 INFO - PROCESS | 1659 | -------- Summary: end -------- 16:33:28 INFO - PROCESS | 1659 | 16:33:29 INFO - TEST-INFO | 1659: exit 0 16:33:29 INFO - TEST-OK | kraken | took 60035ms 16:33:29 INFO - SUITE-END | took 1177s 16:33:29 INFO - Completed test suite (00:19:37) 16:33:29 INFO - javascript benchmark 16:33:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3032.969670303297, 3323.368559973605, 3338.0653417043236, 3362.815045172518, 3364.7812892162005, 5536.0, 5628.465295796897, 5636.549076073915, 5698.145278208271, 5706.058500347448, 5644.983902897477, 5674.716264186794, 5756.712164391784, 5759.222504961829, 5771.624844385112, 5103.744812759366, 5132.307138536287, 5157.819476318329, 5211.166213405856, 5234.084035293828, 5271.341082364705, 5283.894322113575, 5289.86775330616, 5294.338207724035, 5295.179247216687, 5126.948730512684, 5237.266782650432, 5246.160614301693, 5337.653052551572, 5366.980273747995, 4317.222899878021, 5164.25118357836, 5171.948280517222, 5243.501867322599, 5278.155495120801, 5200.29795977542, 5205.791768329263, 5220.765065572058, 5224.4775522447835, 5231.424543300234, 5600.439956004408, 5717.571182161355, 5730.426957304237, 5733.856653583652, 5792.507636850873, 5654.321481422256, 5765.423457654243, 6134.2529056856065, 6170.938290617081, 6198.845028874269, 6185.350538193515, 6196.070589411579, 6263.655498947556, 6263.780767673155, 6273.749050037993, 5818.2145410369485, 5821.255438160348, 5823.767049317979, 5826.766929322865, 5867.266591676041, 6172.783952561639, 6206.968965155235, 6239.625622462667, 6256.624602523863, 6289.528285378615, 6117.327094019654, 6124.601900876429, 6134.044295328781, 6191.473724733448, 6195.473384762346, 6227.221597300338, 6232.626042437469, 6246.500279977682, 6251.218597675291, 6256.906146407808, 6104.603200791934, 6115.544587952024, 6148.200733904564, 6220.315765265817, 6220.968895155495, 6074.179985701962, 6145.262568491809, 6156.507479401637, 6188.721507532172, 6201.503879689614, 4173.895652608649, 4763.404574428197, 4918.458969513351, 4935.975320123376, 4951.331570238044, 4113.259613269581, 4442.955570444255, 4448.866534003985, 4453.821847126143, 4460.420145381079, 5664.943350566442, 5688.971555142198, 5740.0, 5748.511376533042, 5805.622634528827, 6192.690365481708, 6239.407256310734, 6248.75004999804, 6279.623222606567, 6281.214848143982, 5802.82591522255, 5805.970970145207, 5811.593188476851, 5826.941730582725, 5875.970620146872, 5269.5257426831, 5323.547498462674, 5331.760070796823, 5398.0, 5400.83797486076, 6170.413810687977, 6236.251649801871, 6243.719032643542, 6284.528660350584, 6299.464545513682, 6237.345078766664, 6238.563300569098, 6239.532035097295, 6243.8126856194385, 6258.687065646791, 6141.815745527641, 6152.446279834837, 6265.467435268053, 6281.937180628135, 6295.150154729053, 6119.472088496418, 6133.877322453615, 6146.200993870768, 6155.199824022849, 6160.7535698571555, 6087.4521293083835, 6154.846128846814, 6197.287311959182, 6212.534059945612, 6233.937660623335, 6020.759169633166, 6093.6039157454625, 6099.695015249308, 6103.908441373294, 6116.908246376397, 6116.418940200674, 6126.479249263863, 6126.908096378469, 6139.508839292756, 6154.753809847735, 5824.5340372770925, 5899.321578018411, 5904.940950590439, 5908.5568582357355, 5980.730867110903, 6124.295705993868, 6147.754089836535, 6150.015997440388, 6156.322804491592, 6157.0456579230295, 5959.314678811818, 6000.279966404059, 6008.54935879802, 6031.24609423822, 6040.788572399945], "value": 5680.951095211706, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.38223618178284, 512.2444394518085, 522.5871561466442, 531.1793279383352, 535.5849216856938, 38577.42133867991, 40250.39624405636, 40297.798511007444, 42580.0, 42599.36100958488, 40402.595974040254, 40911.795441022754, 40918.59081409185, 41015.974600634996, 41068.178636427256, 8702.216800487955, 9654.565544550494, 9839.0, 9840.16358609519, 9846.064623860722, 8716.694915677952, 11897.583584574542, 12145.635630931041, 12220.633380998584, 12384.19502732324, 12148.878511214863, 12157.331346775924, 12170.756584868297, 12174.756504869898, 12217.266963982145, 8758.430702004349, 8977.910220897773, 12161.08791840611, 12247.448864801105, 12253.57112501067, 11635.011024062966, 11987.160898737093, 12078.456469458895, 12175.0868684849, 12206.816897746541, 40116.0, 40385.19229615421, 40485.98785030368, 40504.797476012725, 40536.0, 3291.243014106769, 3305.5537502437346, 3396.5075064115813, 3510.9122271943406, 3554.1921881713415, 30337.544936825965, 30965.535516967262, 30979.380412391627, 31005.0, 31238.37523249545, 3181.9363612727616, 3263.494158405451, 3300.7689461737687, 3364.1925937775004, 3374.156460884779, 461818.0, 463885.0, 466604.6669766663, 466761.0, 468074.6596266997, 46676.0, 56873.43126568764, 56955.0, 57030.7148464255, 57042.85914281691, 58013.8397232053, 58084.0, 58124.0, 58183.70908145432, 58232.708836455546, 15746.448874289345, 15977.840221597868, 15994.680106397807, 16001.359945602278, 16010.039397635946, 11310.830337544943, 11492.597759078559, 11541.249818761753, 12548.372581370895, 12627.0, 14692.559223223321, 14917.776233356508, 15092.16993065392, 15280.617984550252, 15369.155701315914, 5513.035218836688, 6357.442426605511, 6465.127207826883, 6499.5775274607, 6539.705713242915, 856.3448961544424, 892.9553522323988, 1010.2574607663508, 1022.2384323678907, 1091.6288461922984, 26184.95260189571, 29123.0, 29235.56146657802, 29608.0, 29876.850615746782, 1024.5287167902848, 1053.1416895230363, 1053.963111291101, 1057.962971296001, 1072.2708558180511, 14054.508092216724, 14248.501302454364, 14459.421623134956, 15471.5358539244, 15485.922570387302, 634606.0, 638396.0, 638525.0, 638529.0, 639132.0, 56798.148027779614, 56830.0, 56881.71559142178, 56885.0, 57016.71491642515, 1209.9153059285766, 1249.5439164704999, 1332.6535100873648, 1358.341204515809, 1374.7869080292571, 27729.584056239575, 29418.852905735333, 29441.0, 30332.696673032988, 30409.391812164075, 47567.52432475631, 48018.0, 48065.75967120142, 48069.278960816315, 48192.0, 415641.0, 416093.0, 416570.91714541236, 416833.0, 417809.0, 24070.39824004414, 25133.371665708502, 25704.74295257098, 25804.870975645, 26860.865695671397, 46287.0, 46401.30398043965, 46572.30141547812, 46734.298985515925, 47809.52190478051, 38347.424788627635, 38469.03827404225, 38836.41745373878, 39636.60363396329, 40550.39174412445, 37630.62369376381, 37634.8118259407, 38845.0, 39002.414963775, 39235.41146882742, 37071.62928370682, 37440.15574405535, 37742.43386349262, 37763.81118094392, 38386.232275354894, 28281.727322270137, 33470.832645836614, 33496.33007339888, 33672.49491257682, 34164.14589635279, 20413.48966275855, 22753.203637872593, 24016.639750403407, 25486.23541293764, 26076.8696156518], "value": 19645.278852008672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.64635364635365, 372.7558449215763, 375.5530918207333, 383.4286912500375, 404.3227593780417, 15023.24883755812, 15417.0, 15872.0, 16705.997640141584, 20931.953402329862, 19867.60264794703, 20483.692744608805, 20806.583868322625, 21162.57674846506, 21472.0, 5043.873903152432, 5796.449337312959, 6070.757169713206, 6071.423214794588, 6076.240469941257, 5960.523158147338, 6008.729607167688, 6086.056661217496, 6089.421504957022, 6092.268927728656, 5681.801136960207, 5893.616914900539, 6014.8195554133445, 6024.1566180734735, 6029.427204415595, 5887.646741195521, 5951.88096238075, 5957.940420595782, 5958.940410595882, 5962.165296858443, 5026.321446604698, 5068.341115654941, 5197.376314842205, 5235.65968212065, 5238.476152384769, 26068.478630427475, 26148.60777088326, 26166.6075008875, 26274.474510509874, 26362.0, 2297.0, 2340.7776261255153, 2375.6674065630827, 2874.238326843388, 2901.4777340078776, 14795.112293262438, 15525.689486210325, 16198.27107780141, 16258.943168694115, 16315.10266935318, 1808.9909550452296, 1888.178642290608, 1897.67739484288, 1903.8762480438727, 1936.6417212815534, 108349.45825270824, 109640.0, 109814.0, 111798.0, 114438.42780786126, 10435.895641043644, 10516.474176291154, 10681.679549613524, 10902.018818306231, 11129.220954533266, 13508.32458377097, 13540.322983850769, 13563.796543051862, 13569.52506662262, 13597.796033059512, 7929.20707929214, 8185.467944583702, 8220.958895205486, 8357.874631880526, 8362.498250105013, 8089.02931648206, 8099.0, 8106.649071769121, 8257.463264887883, 8302.958485207535, 5329.760160792774, 6353.3329000455215, 6471.708773105222, 6494.157913371828, 6578.703958321887, 1756.6925787987052, 1809.819018098206, 1809.8914065156132, 1810.791758947738, 1810.9004004779863, 885.2563846369081, 918.8943271523726, 972.7081875437341, 1005.1154983614373, 1020.0972139656458, 20924.0, 21973.67039494409, 22231.66652500214, 22294.0, 22360.0, 766.7661363284141, 889.6708217959397, 954.5942974235921, 960.2989817433313, 968.719071469266, 10116.696499105039, 11693.824592631117, 11701.707457313465, 11799.0, 11815.527378904919, 528588.0, 529501.0, 584395.0, 608406.7898302578, 609905.0, 114993.0, 116699.0, 118295.81704182849, 118499.40750296193, 120321.39839300922, 981.2444417798256, 993.3741742702051, 1020.9387436753818, 1024.800163968034, 1025.9692209233735, 18993.810061899756, 19261.0, 19272.614547709247, 19338.709919351502, 19350.4194874154, 50472.747636261585, 50829.237561437345, 51199.0, 52292.47707523028, 52552.0, 55757.442425576846, 72437.0, 73493.0, 73923.0, 77496.0, 5832.0, 7510.173880873209, 7927.326177274997, 8001.679932802623, 8136.959315203623, 11398.772024559297, 12355.0, 12936.482540698267, 12955.5465558705, 13272.80090798658, 11022.50398732043, 11128.777424451304, 11359.48882300315, 11515.25150865191, 11555.191136620691, 10726.946365268124, 10811.297265677706, 11024.724381890517, 11037.392943388191, 11131.387773672526, 8730.301575873787, 10934.289271197347, 11189.104871610414, 11572.421378931189, 11581.536738530365, 5783.529882070724, 7708.344790692854, 7876.330511906552, 8084.514929104273, 8141.51150930946, 10298.0, 11165.90296025565, 11336.94331528337, 11365.318080914842, 11423.143264255048], "value": 9594.656175946338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.397217280051, 1351.0812647399764, 1517.4537166620019, 1663.417803768681, 1892.9905350473246, 7751.999999999993, 8232.094469608346, 8334.20825021622, 8711.128887111301, 8764.474131552111, 8577.614007369668, 8676.826463470727, 8682.86975695365, 8695.739127826175, 8726.214640682338, 2350.189184731265, 2379.167291447997, 2379.6311571706415, 2381.4879800842814, 2381.6784734060852, 2320.7331156916916, 2362.7755363240462, 2369.5497855407502, 2373.750756170603, 2387.6060450025725, 2326.7905888470036, 2349.5535848188874, 2360.079568968104, 2365.396823809926, 2368.12379419615, 2270.421042634118, 2294.621387471074, 2304.80409165222, 2311.2257393773107, 2338.1348900906605, 2310.1683393978155, 2316.860988340688, 2318.93043208704, 2319.1071437496516, 2328.1851352026656, 7010.474214433938, 8551.486910785372, 8602.397832151752, 8619.913800861974, 8724.214820666108, 5123.718195499246, 5292.206169074631, 5299.390570084451, 5305.363356397218, 5330.893382132335, 3582.17609949713, 3594.6944509716704, 3665.083729067733, 3666.7799932004164, 3673.1368128489785, 1066.4934156275706, 1074.6292529077455, 1076.8923107689247, 1092.7213560542011, 1099.6810924831789, 11402.144839137014, 11439.542418303257, 11496.482658280398, 11533.942330288379, 11589.710257243552, 4266.4240327556, 4329.307310830252, 4496.4154659894, 4513.097380523843, 4514.7291162530355, 8992.8651070234, 9000.774980625405, 9004.054574269607, 9015.27877769777, 9031.63873445068, 5031.471695471996, 5126.974365128151, 5134.306868572769, 5134.845954621367, 5137.537621614073, 4167.979160104241, 4292.313229883203, 4334.068175342317, 4492.326151077365, 4726.692764970266, 3611.6749492545796, 3641.708663306929, 3749.9875033740736, 3751.7936513491472, 3773.4528493368307, 1121.545773961547, 1135.1316243074054, 1143.2911594811271, 1146.4726225935997, 1146.478352349679, 816.3428440105772, 839.261449924063, 860.4665107633182, 870.4255191573658, 953.3993584042009, 5603.691796951207, 5650.0, 5718.971405142947, 5971.402859713994, 6072.848178795477, 410.68172166571145, 415.59479507479966, 427.7476288989511, 428.60568277185064, 428.976890117073, 3822.063594419385, 3892.0464486201063, 3989.7207195496035, 4023.6177563131455, 4048.554658987509, 10061.094501494901, 10251.948740256252, 10496.527656255486, 10636.893631063745, 10664.946675266729, 10597.470126493645, 10601.992810682972, 10605.0, 10640.25518213733, 10645.627403040857, 7929.246721561442, 8026.558539280396, 8072.757817265491, 8152.714654987166, 8155.551444670481, 5645.209670646195, 5656.1798539212405, 5717.456841600041, 5805.564582656233, 5810.535157187331, 9513.619455221713, 9688.32181747271, 9818.950905245429, 9858.901410986085, 9965.601375944882, 8193.262606365455, 10083.899161008589, 10086.142677872464, 10141.935096814728, 10162.560985363607, 5862.94137058624, 6321.49428045746, 6946.062281592122, 6999.12510936133, 7003.089598352181, 8190.180981901762, 8384.916150838413, 8393.202645748644, 8396.328293736364, 8408.53753043564, 7292.34368906801, 7367.484276100836, 7381.926180738124, 7449.14334851499, 7518.097828260425, 7255.782326530212, 7269.273072692688, 7280.963595182202, 7285.162206346126, 7367.926320736724, 6864.1762988439705, 6960.686769095504, 6967.79096627102, 7016.719331226694, 7052.471064670068, 4881.219004959189, 4937.17324589904, 4960.528749768766, 4984.37695288089, 5073.036123136592, 4895.7062576245535, 4955.479674634255, 5010.398752149766, 5063.594912407072, 5162.380514338303], "value": 4382.401380338657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.70655691852795, 291.31831514256635, 296.21650733809076, 312.09959267513216, 317.00618560811847, 5005.724685142316, 5223.0, 5242.898991211845, 5327.6803391796475, 5331.3069300990865, 4347.391365208865, 4551.749653769041, 5117.692938423697, 5118.897622047557, 5169.457206993258, 3310.867565297385, 3418.350513402458, 3949.8545421827635, 3979.9801000994953, 4057.16828050249, 3970.6029397060206, 4052.5947405259535, 4055.986003499125, 4059.776712280823, 4060.20825938942, 3140.8429578521095, 3188.5854838870914, 3292.1769557610596, 3383.796972181665, 4001.6198461146146, 3380.2056516718553, 3944.8027598619956, 3969.7816620085882, 3998.960010399888, 4005.2590270799997, 2917.226934862263, 2942.955855662167, 3469.3581687387914, 3471.0, 3471.114865709253, 4599.781058019627, 4806.831760888387, 4830.420349558076, 5064.696118232918, 5171.612129090296, 4466.709663871838, 4548.499665036843, 4556.0, 4575.58819706228, 4642.234031384817, 4562.0, 5450.5367043801325, 5463.590230732671, 5474.014677358074, 5509.311336082989, 3227.01576019314, 3321.4021476134285, 3567.375709250871, 3624.6194149614175, 3782.3569993101237, 4723.1970565003685, 5453.481919217668, 5462.344518657746, 5685.346185188673, 5752.705641230731, 3647.963520364762, 3722.8324725387424, 3829.3681542545723, 3833.290841194388, 3867.7099217558234, 3869.6130386961077, 3902.239063382613, 3910.198409326081, 3916.3538016227003, 3931.488906442144, 3578.9442114576264, 4561.68068235227, 4563.383943167696, 4566.178087944136, 4582.21293695459, 4334.544872788312, 5199.584033277329, 5495.725213739297, 5569.582281328835, 5595.496405323541, 1130.1298000539703, 1266.8859802617808, 1304.480280473257, 1319.8284223051135, 1327.3408239700375, 687.4672129099988, 795.3041089047084, 810.5866008335792, 813.6655884349672, 827.7020272701823, 3808.763349635659, 3829.789361585084, 4235.407043013981, 4358.455193100863, 4363.7744750177635, 4281.972326641584, 4375.409319741794, 4442.844500442469, 4805.327254184417, 4832.782524786393, 3626.9093272668392, 3872.361060425055, 4002.618442026989, 4242.766647834399, 4372.213001659668, 2119.629064913634, 2373.8457000294925, 2432.8053755699502, 2465.654808326836, 2485.4714350674567, 4022.718409711292, 4852.51474852519, 4874.2444921037295, 4905.48492408292, 4915.287283343967, 4292.291771857608, 4854.805807767721, 4885.706857588556, 4899.657024008286, 4901.387326584177, 4253.2769429197115, 4475.933754609211, 4755.956188039589, 4786.976065119652, 4920.532549407801, 3949.466821978996, 4079.7960101994186, 4625.606823420047, 4633.536646335339, 4663.510331415288, 4071.7760523170323, 4503.748125937032, 4714.9764251179895, 4719.126961512131, 4724.472407262098, 4270.807813648331, 4563.361129441947, 4698.318743782064, 4880.536349046835, 5401.432849550741, 3324.4375143682432, 3755.943660845144, 3795.772253664789, 3810.9809450952566, 3813.199228162117, 4817.542333478314, 5638.436156384493, 5669.262995810518, 5695.373508914099, 5713.628614140068, 4722.7484716550825, 5206.661566998133, 5514.228008078792, 5532.972335138298, 5579.581531385081, 5556.91664625039, 5563.885723425073, 5575.609707320448, 5579.721013949367, 5602.0, 5045.722485263345, 5424.15578703227, 5470.522958801022, 5505.146702261156, 5525.668459892419, 4635.466921304093, 5259.526642602184, 5482.972585137049, 5541.3904470507405, 5545.669039430427, 4509.954900450954, 4512.495564961478, 5448.972755136199, 5479.369872464558, 5482.588805839658], "value": 3773.1110191007874, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.4019602945438, 767.7197822794678, 783.0212234706617, 798.5408390175651, 809.668036105197, 15223.923880380597, 15911.602209944756, 15913.204339783008, 15920.0, 16321.83678163218, 14276.571702848905, 14415.92792036041, 14431.567052988401, 14440.855591444082, 14469.20419376934, 666.070831190489, 687.9724811007553, 832.2010869565224, 842.9704960326405, 870.8214815962745, 820.9179082091803, 854.5684429363193, 861.2808305065278, 865.2385900407633, 867.2628265973904, 872.6204101215959, 898.2858627391207, 912.4434095201922, 913.2237598041678, 920.2132176988679, 702.4591064880065, 722.5411863466684, 724.8004552465678, 724.9130104387507, 908.9500077495768, 546.0880329849161, 662.0466528199426, 676.7462201674372, 681.7068660475993, 682.7951614515675, 15250.38998440061, 15252.923735381362, 15283.0, 15285.235738213045, 15288.082715037133, 13937.512187073404, 14136.92931535346, 14183.929080354636, 14356.0, 14451.205183714892, 10501.842472362921, 12909.031822613342, 13075.476980920752, 13191.604251872459, 13550.390232439564, 4214.452121224252, 4274.230638485072, 4538.931916021263, 4656.022235330551, 4734.360861283752, 119321.40339298335, 119442.4027879855, 121864.0, 121933.17100243503, 121950.17074743885, 11098.833517497244, 11132.554697812158, 11212.887871121347, 11305.378204198683, 11500.660843295744, 18854.90572547156, 18865.717014244798, 21835.90820458971, 22742.431439213822, 22782.65826012611, 7989.0, 8019.478733882279, 8020.679172833022, 8077.151899050633, 8200.630971606291, 4472.753998530112, 4487.506374298824, 4549.340345649928, 4655.883602909955, 4669.4630117536235, 3460.325236578843, 3581.4420726983844, 3582.5880023797595, 3583.552055993001, 3587.443946188345, 633.1768700689086, 633.7845132654919, 641.0, 659.5745743995192, 668.7559040950116, 469.3007418945746, 492.8841722195281, 538.6875612144946, 616.6269407008696, 630.580663858529, 9040.8643870342, 9202.539873006323, 9207.769805754775, 9232.552214723588, 9281.30390220736, 447.73136118328745, 516.702895834889, 626.7586979013113, 634.8920683483819, 644.2076246217179, 4068.7151899367354, 4252.553481884358, 4255.97872010638, 4287.592678695519, 4458.353538736865, 160377.0, 164535.0, 165964.0, 166695.16395942366, 176880.11559942376, 133502.03992168946, 136585.0, 136830.0, 139297.6070239305, 144350.0, 118829.40585297019, 119541.40229298797, 120525.39737301257, 121555.99999999822, 121936.0, 8202.26179643835, 8219.589020548829, 8220.465669731448, 8263.0, 8530.914690853013, 64257.0, 65671.0, 66353.33646663472, 67084.65830683456, 67591.98612020921, 97583.51208243913, 99557.51106222402, 99863.50068249903, 102359.48820255851, 104475.0, 11343.262687925258, 11743.530258789553, 11751.412429378668, 12150.635480935585, 12258.0, 10121.493925303852, 11993.0, 12049.156559040783, 12360.196587221802, 12767.74464510686, 9948.55231514598, 11348.432578370883, 11761.294322340687, 11951.10366722482, 12063.095267855122, 13543.525976590772, 13664.93167534156, 13753.587392378246, 14100.576982690536, 14103.435862565382, 12615.116941813985, 12929.54746583865, 13123.343832808512, 13142.948564115039, 13296.135751176143, 10241.975802419996, 10914.945425272823, 10917.23579349438, 11312.547498099984, 11622.18644694897, 7348.0, 10720.73198170052, 10832.783344333227, 11265.435167326084, 11350.489227984926], "value": 7737.210138069976, "unit": "score"}], "name": "dromaeo_css", "value": 7180.025749672566, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 119.0, 112.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 109.0, 105.0, 147.0, 97.0, 127.0, 141.0, 132.0, 141.0, 108.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 184.0, 186.0, 185.0, 183.0, 184.0, 181.0, 181.0, 183.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 88.0, 61.0, 61.0, 59.0, 57.0, 83.0, 59.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 93.0, 69.0, 68.0, 70.0, 92.0, 69.0, 70.0, 89.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 94.0, 130.0, 115.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 94.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 92.0, 94.0, 93.0, 93.0, 103.0, 149.0, 148.0, 91.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 89.0, 85.0, 86.0, 84.0, 84.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 57.0, 53.0, 52.0, 56.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 75.0, 77.0, 71.0, 71.0, 70.0, 71.0, 70.0, 73.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 86.0, 87.0, 86.0, 87.0, 88.0, 84.0, 84.0, 88.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 143.0, 151.0, 153.0, 147.0, 150.0, 149.0, 132.0, 198.0, 152.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 169.0, 168.0, 173.0, 169.0, 169.0, 170.0, 167.0, 172.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 71.0, 85.0, 89.0, 87.0, 67.0, 67.0], "value": 73.7, "unit": "score"}], "name": "kraken", "value": 1464.5000000000002, "alertThreshold": 2.0}]} 16:33:29 INFO - Return code: 0 16:33:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:29 INFO - # TBPL SUCCESS # 16:33:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:33:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:33:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:33:29 INFO - 2016-09-28 16:33:29.635 screenresolution[1663:9877] starting screenresolution argv=screenresolution get 16:33:29 INFO - 2016-09-28 16:33:29.638 screenresolution[1663:9877] Display 0: 1600x1200x32@60 16:33:29 INFO - 2016-09-28 16:33:29.645 screenresolution[1664:9880] starting screenresolution argv=screenresolution list 16:33:29 INFO - Available Modes on Display 0 16:33:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:33:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:33:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:33:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:33:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:33:29 INFO - Intel Iris: 16:33:29 INFO - Chipset Model: Intel Iris 16:33:29 INFO - Type: GPU 16:33:29 INFO - Bus: Built-In 16:33:29 INFO - VRAM (Dynamic, Max): 1536 MB 16:33:29 INFO - Vendor: Intel (0x8086) 16:33:29 INFO - Device ID: 0x0a2e 16:33:29 INFO - Revision ID: 0x0009 16:33:29 INFO - Displays: 16:33:29 INFO - Display: 16:33:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:33:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:33:29 INFO - Display Serial Number: 1600x1200 60 16:33:29 INFO - Main Display: Yes 16:33:29 INFO - Mirror: Off 16:33:29 INFO - Online: Yes 16:33:29 INFO - Rotation: Supported 16:33:29 INFO - Return code: 0 16:33:29 INFO - Running post-action listener: _resource_record_post_action 16:33:29 INFO - [mozharness: 2016-09-28 23:33:29.887476Z] Finished run-tests step (success) 16:33:29 INFO - Running post-run listener: _resource_record_post_run 16:33:29 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 38089728; Write bytes: 706360832; Read time: 382; Write time: 1876 16:33:29 INFO - TinderboxPrint: CPU usage
53.5% 16:33:29 INFO - TinderboxPrint: I/O read bytes / time
38,089,728 / 382 16:33:29 INFO - TinderboxPrint: I/O write bytes / time
706,360,832 / 1,876 16:33:29 INFO - TinderboxPrint: CPU idle
2,254.1 (46.5%) 16:33:29 INFO - TinderboxPrint: CPU system
967.8 (20.0%) 16:33:29 INFO - TinderboxPrint: CPU user
1,627.8 (33.6%) 16:33:29 INFO - TinderboxPrint: Swap in / out
445,378,560 / 0 16:33:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 403180032; Write bytes: 392247296; Read time: 29617; Write time: 704 16:33:29 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 30809088; Write bytes: 295284224; Read time: 292; Write time: 1120 16:33:30 INFO - Running post-run listener: _upload_blobber_files 16:33:30 INFO - Blob upload gear active. 16:33:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:30 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 16:33:30 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'] 16:33:30 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 16:33:30 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:31 INFO - (blobuploader) - INFO - Done attempting. 16:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:32 INFO - (blobuploader) - INFO - Done attempting. 16:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:35 INFO - (blobuploader) - INFO - Done attempting. 16:33:35 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:35 INFO - Return code: 0 16:33:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/85ed57a9d509a1cfaa80377b482d4f2c0761ef121db327831bee727846a12b50b7b0c1999e9a47f496cce1d1d89ff4f53fd8f47c95d603fcdbe6a61b599f90f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8a48eeeb72158cd85a4389b979467bc50aa58dff408784c6abb7b3ff989c119c6d42e36139779395d5358df0b75811b36e3691d11b6ebb28e57b6a23bc2fa0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/368a1a2b91c4e902add4ae70130475459fc6503b42d294775b48dfef0791cdd8c41b38b0213f939a0d97dfb549700a2a3e701da440adbd98ff8008274c48fecd"} 16:33:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:35 INFO - Contents: 16:33:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/85ed57a9d509a1cfaa80377b482d4f2c0761ef121db327831bee727846a12b50b7b0c1999e9a47f496cce1d1d89ff4f53fd8f47c95d603fcdbe6a61b599f90f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8a48eeeb72158cd85a4389b979467bc50aa58dff408784c6abb7b3ff989c119c6d42e36139779395d5358df0b75811b36e3691d11b6ebb28e57b6a23bc2fa0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/368a1a2b91c4e902add4ae70130475459fc6503b42d294775b48dfef0791cdd8c41b38b0213f939a0d97dfb549700a2a3e701da440adbd98ff8008274c48fecd"} 16:33:35 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:35 INFO - Copying logs to upload dir... 16:33:35 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.546283 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-28 16:33:35.264624) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:33:35.268443) ========= 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.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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/85ed57a9d509a1cfaa80377b482d4f2c0761ef121db327831bee727846a12b50b7b0c1999e9a47f496cce1d1d89ff4f53fd8f47c95d603fcdbe6a61b599f90f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8a48eeeb72158cd85a4389b979467bc50aa58dff408784c6abb7b3ff989c119c6d42e36139779395d5358df0b75811b36e3691d11b6ebb28e57b6a23bc2fa0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/368a1a2b91c4e902add4ae70130475459fc6503b42d294775b48dfef0791cdd8c41b38b0213f939a0d97dfb549700a2a3e701da440adbd98ff8008274c48fecd"} build_url:https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011102 build_url: 'https://queue.taskcluster.net/v1/task/RA0oTCHySu25vW77lbhirw/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/85ed57a9d509a1cfaa80377b482d4f2c0761ef121db327831bee727846a12b50b7b0c1999e9a47f496cce1d1d89ff4f53fd8f47c95d603fcdbe6a61b599f90f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c8a48eeeb72158cd85a4389b979467bc50aa58dff408784c6abb7b3ff989c119c6d42e36139779395d5358df0b75811b36e3691d11b6ebb28e57b6a23bc2fa0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/368a1a2b91c4e902add4ae70130475459fc6503b42d294775b48dfef0791cdd8c41b38b0213f939a0d97dfb549700a2a3e701da440adbd98ff8008274c48fecd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 16:33:35.302698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:33:35.303043) ========= 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.NKmgVlREHj/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.bogZpJjqvw/Listeners TMPDIR=/var/folders/ds/nncns7yd2ll46rh0x60cww8m00000w/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 16:33:35.352153) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:33:35.352465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 16:33:35.352782) ========= ========= Total master_lag: 0.63 =========