builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0273 starttime: 1475901286.37 results: success (0) buildid: 20161007195722 builduid: 0b0c430461154a90bfed7b3b36f43c5f revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.372458) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.372942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.373261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.400633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.400966) ========= 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.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-07 21:34:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 140M=0s 2016-10-07 21:34:46 (140 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180709 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.608015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.608810) ========= 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.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.031746 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:46.664287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:34:46.665082) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-07 21:34:46,745 truncating revision to first 12 chars 2016-10-07 21:34:46,745 Setting DEBUG logging. 2016-10-07 21:34:46,745 attempt 1/10 2016-10-07 21:34:46,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efa3b654aa77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 21:34:48,021 unpacking tar archive at: mozilla-central-efa3b654aa77/testing/mozharness/ program finished with exit code 0 elapsedTime=1.537935 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 21:34:48.228249) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:48.229052) ========= script_repo_revision: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:48.229491) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:48.229968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 21:34:48.248720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-07 21:34:48.249051) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:34:48 INFO - MultiFileLogger online at 20161007 21:34:48 in /builds/slave/test 21:34:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:34:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:48 INFO - {'append_to_log': False, 21:34:48 INFO - 'base_work_dir': '/builds/slave/test', 21:34:48 INFO - 'blob_upload_branch': 'Firefox', 21:34:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:48 INFO - 'branch': 'Firefox', 21:34:48 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:48 INFO - 'config_files': ('talos/mac_config.py',), 21:34:48 INFO - 'default_actions': ('clobber', 21:34:48 INFO - 'read-buildbot-config', 21:34:48 INFO - 'download-and-extract', 21:34:48 INFO - 'populate-webroot', 21:34:48 INFO - 'create-virtualenv', 21:34:48 INFO - 'install', 21:34:48 INFO - 'run-tests'), 21:34:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:48 INFO - 'download_minidump_stackwalk': True, 21:34:48 INFO - 'download_symbols': 'ondemand', 21:34:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:48 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:48 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:48 INFO - 'installer_path': 'installer.exe', 21:34:48 INFO - 'log_level': 'info', 21:34:48 INFO - 'log_name': 'talos', 21:34:48 INFO - 'log_to_console': True, 21:34:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:34:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:34:48 INFO - 'opt_config_files': (), 21:34:48 INFO - 'pip_index': False, 21:34:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:34:48 INFO - 'cmd': ('bash', 21:34:48 INFO - '-c', 21:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:34:48 INFO - 'enabled': True, 21:34:48 INFO - 'halt_on_failure': False, 21:34:48 INFO - 'name': 'check_screen_resolution'},), 21:34:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:34:48 INFO - 'cmd': ('bash', 21:34:48 INFO - '-c', 21:34:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:34:48 INFO - 'enabled': True, 21:34:48 INFO - 'halt_on_failure': False, 21:34:48 INFO - 'name': 'check_screen_resolution'},), 21:34:48 INFO - 'run_cmd_checks_enabled': True, 21:34:48 INFO - 'sps_profile': False, 21:34:48 INFO - 'sps_profile_interval': 0, 21:34:48 INFO - 'suite': 'dromaeojs', 21:34:48 INFO - 'system_bits': '32', 21:34:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:48 INFO - 'title': 't-yosemite-r7-0273', 21:34:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:48 INFO - 'use_talos_json': True, 21:34:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:48 INFO - 'work_dir': 'build'} 21:34:48 INFO - [mozharness: 2016-10-08 04:34:48.447160Z] Running clobber step. 21:34:48 INFO - Running pre-action listener: _resource_record_pre_action 21:34:48 INFO - Running main action method: clobber 21:34:48 INFO - rmtree: /builds/slave/test/build 21:34:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:50 INFO - Running post-action listener: _resource_record_post_action 21:34:50 INFO - [mozharness: 2016-10-08 04:34:50.704107Z] Finished clobber step (success) 21:34:50 INFO - [mozharness: 2016-10-08 04:34:50.704283Z] Running read-buildbot-config step. 21:34:50 INFO - Running pre-action listener: _resource_record_pre_action 21:34:50 INFO - Running main action method: read_buildbot_config 21:34:50 INFO - Using buildbot properties: 21:34:50 INFO - { 21:34:50 INFO - "project": "", 21:34:50 INFO - "product": "firefox", 21:34:50 INFO - "script_repo_revision": "production", 21:34:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:34:50 INFO - "repository": "", 21:34:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:34:50 INFO - "buildid": "20161007195722", 21:34:50 INFO - "pgo_build": "False", 21:34:50 INFO - "basedir": "/builds/slave/test", 21:34:50 INFO - "buildnumber": 121, 21:34:50 INFO - "slavename": "t-yosemite-r7-0273", 21:34:50 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:34:50 INFO - "platform": "yosemite_r7", 21:34:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:34:50 INFO - "branch": "mozilla-central", 21:34:50 INFO - "repo_path": "mozilla-central", 21:34:50 INFO - "revision": "efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6", 21:34:50 INFO - "stage_platform": "macosx64", 21:34:50 INFO - "builduid": "0b0c430461154a90bfed7b3b36f43c5f", 21:34:50 INFO - "slavebuilddir": "test" 21:34:50 INFO - } 21:34:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 21:34:50 INFO - Running post-action listener: _resource_record_post_action 21:34:50 INFO - [mozharness: 2016-10-08 04:34:50.707610Z] Finished read-buildbot-config step (success) 21:34:50 INFO - [mozharness: 2016-10-08 04:34:50.707726Z] Running download-and-extract step. 21:34:50 INFO - Running pre-action listener: _resource_record_pre_action 21:34:50 INFO - Running main action method: download_and_extract 21:34:50 INFO - mkdir: /builds/slave/test/build/tests 21:34:50 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')]} 21:34:50 INFO - trying https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 21:34:50 INFO - Downloading https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/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 21:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/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 21:34:51 INFO - Downloaded 1199 bytes. 21:34:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 21:34:51 INFO - Using the following test package requirements: 21:34:51 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:34:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 21:34:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 21:34:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'jsshell-mac.zip'], 21:34:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 21:34:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 21:34:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 21:34:51 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 21:34:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 21:34:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 21:34:51 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 21:34:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:34:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:34:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:34:51 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:34:52 INFO - Http code: 200 21:34:52 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 21:34:52 INFO - x-amz-cf-id: chVKFQJReUEOhJkit8YzqSr2XF_Rc0EvmOtp4fS4nQzTNhDJWDHWdQ== 21:34:52 INFO - x-amz-version-id: Bs66FhjIm4hi_.9woYF5Lk1yW_uXq6pN 21:34:52 INFO - Expected file size: 16483145 21:34:52 INFO - Obtained file size: 16483145 21:34:59 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 21:34:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 21:34:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:34:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 21:34:59 INFO - Http code: 200 21:34:59 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 21:34:59 INFO - x-amz-cf-id: EeFpkwfoNkZ0Hae5GeeFt8_JDMoH2dZ4dez_ingWv0A5nVqDfX4lXg== 21:34:59 INFO - x-amz-version-id: Bs66FhjIm4hi_.9woYF5Lk1yW_uXq6pN 21:35:00 INFO - Expected file size: 16483145 21:35:00 INFO - Obtained file size: 16483145 21:35:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 21:35:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:35:06 INFO - Fetch https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 21:35:07 INFO - Http code: 200 21:35:07 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 21:35:07 INFO - x-amz-cf-id: cucGBebAU9a6GUuxfh26zPGPkEWsQnVeB49I68cf_Qxwd7ZVR_CuwQ== 21:35:07 INFO - x-amz-version-id: qMvNjkGUe0djLmp042lgZ_4N.m4Grecv 21:35:07 INFO - Expected file size: 14409006 21:35:07 INFO - Obtained file size: 14409006 21:35:07 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')]} 21:35:07 INFO - trying https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:07 INFO - Downloading https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 21:35:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/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 21:35:10 INFO - Downloaded 111651942 bytes. 21:35:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:10 INFO - mkdir: /builds/slave/test/properties 21:35:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:35:10 INFO - Writing to file /builds/slave/test/properties/build_url 21:35:10 INFO - Contents: 21:35:10 INFO - build_url:https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 21:35:11 INFO - Running post-action listener: _resource_record_post_action 21:35:11 INFO - Running post-action listener: set_extra_try_arguments 21:35:11 INFO - [mozharness: 2016-10-08 04:35:11.368269Z] Finished download-and-extract step (success) 21:35:11 INFO - [mozharness: 2016-10-08 04:35:11.368385Z] Running populate-webroot step. 21:35:11 INFO - Running pre-action listener: _resource_record_pre_action 21:35:11 INFO - Running main action method: populate_webroot 21:35:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:35:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:35:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:35:11 INFO - '--tppagecycles', 21:35:11 INFO - '7'], 21:35:11 INFO - 'tests': ['tsvgm']}}, 21:35:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:35:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:35:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:35:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:35:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:35:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['damp', 'tps']}, 21:35:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'tests': ['damp', 'tps']}, 21:35:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['dromaeo_dom']}, 21:35:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:35:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['basic_compositor_video']}, 21:35:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:35:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'other-e10s': {'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['a11yr', 21:35:11 INFO - 'ts_paint', 21:35:11 INFO - 'tpaint', 21:35:11 INFO - 'sessionrestore', 21:35:11 INFO - 'sessionrestore_no_auto_restore', 21:35:11 INFO - 'tabpaint']}, 21:35:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['tsvgx', 21:35:11 INFO - 'tsvgr_opacity', 21:35:11 INFO - 'tart', 21:35:11 INFO - 'tscrollx', 21:35:11 INFO - 'cart']}, 21:35:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:35:11 INFO - 'tsvgr_opacity', 21:35:11 INFO - 'tart', 21:35:11 INFO - 'tscrollx', 21:35:11 INFO - 'cart']}, 21:35:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'talos_options': ['--disable-e10s'], 21:35:11 INFO - 'tests': ['tp5o']}, 21:35:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'tests': ['tp5o']}, 21:35:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'talos_options': ['--disable-e10s', 21:35:11 INFO - '--xperf_path', 21:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:11 INFO - 'tests': ['tp5n']}, 21:35:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:35:11 INFO - 'talos_options': ['--xperf_path', 21:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:35:11 INFO - 'tests': ['tp5n']}}, 21:35:11 INFO - 'talos.zip': {'path': '', 21:35:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:35:11 INFO - Running post-action listener: _resource_record_post_action 21:35:11 INFO - [mozharness: 2016-10-08 04:35:11.387441Z] Finished populate-webroot step (success) 21:35:11 INFO - [mozharness: 2016-10-08 04:35:11.387578Z] Running create-virtualenv step. 21:35:11 INFO - Running pre-action listener: _resource_record_pre_action 21:35:11 INFO - Running main action method: create_virtualenv 21:35:11 INFO - Creating virtualenv /builds/slave/test/build/venv 21:35:11 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 21:35:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:35:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:35:11 INFO - Using real prefix '/tools/python27' 21:35:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:35:12 INFO - Installing distribute.............................................................................................................................................................................................done. 21:35:15 INFO - Installing pip.................done. 21:35:15 INFO - Return code: 0 21:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:35:15 INFO - Reading from file tmpfile_stdout 21:35:15 INFO - Output received: 21:35:15 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) 21:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:35:15 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')]} 21:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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')]} 21:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:15 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 21:35:15 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 21:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:15 INFO - 'HOME': '/Users/cltbld', 21:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:15 INFO - 'LOGNAME': 'cltbld', 21:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:15 INFO - 'MOZ_NO_REMOTE': '1', 21:35:15 INFO - 'NO_EM_RESTART': '1', 21:35:15 INFO - 'PAGER': '/bin/cat', 21:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:15 INFO - 'PWD': '/builds/slave/test', 21:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:15 INFO - 'SHELL': '/bin/bash', 21:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:15 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:15 INFO - 'USER': 'cltbld', 21:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:15 INFO - 'XPC_FLAGS': '0x0', 21:35:15 INFO - 'XPC_SERVICE_NAME': '0', 21:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:15 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 21:35:15 INFO - Cleaning up... 21:35:15 INFO - Return code: 0 21:35:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:35:15 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')]} 21:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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')]} 21:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:15 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:15 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 21:35:15 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 21:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:15 INFO - 'HOME': '/Users/cltbld', 21:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:15 INFO - 'LOGNAME': 'cltbld', 21:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:15 INFO - 'MOZ_NO_REMOTE': '1', 21:35:15 INFO - 'NO_EM_RESTART': '1', 21:35:15 INFO - 'PAGER': '/bin/cat', 21:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:15 INFO - 'PWD': '/builds/slave/test', 21:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:15 INFO - 'SHELL': '/bin/bash', 21:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:15 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:15 INFO - 'USER': 'cltbld', 21:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:15 INFO - 'XPC_FLAGS': '0x0', 21:35:15 INFO - 'XPC_SERVICE_NAME': '0', 21:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:15 INFO - Downloading/unpacking psutil>=3.1.1 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:15 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 21:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:19 INFO - Installing collected packages: psutil 21:35:19 INFO - Running setup.py install for psutil 21:35:19 INFO - building 'psutil._psutil_osx' extension 21:35:19 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 21:35:19 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 21:35:19 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 21:35:19 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 21:35:20 INFO - building 'psutil._psutil_posix' extension 21:35:20 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 21:35:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:35:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:35:20 INFO - ^ 21:35:20 INFO - 1 warning generated. 21:35:20 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 21:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:35:20 INFO - Successfully installed psutil 21:35:20 INFO - Cleaning up... 21:35:20 INFO - Return code: 0 21:35:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:20 INFO - 'HOME': '/Users/cltbld', 21:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:20 INFO - 'LOGNAME': 'cltbld', 21:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:20 INFO - 'MOZ_NO_REMOTE': '1', 21:35:20 INFO - 'NO_EM_RESTART': '1', 21:35:20 INFO - 'PAGER': '/bin/cat', 21:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:20 INFO - 'PWD': '/builds/slave/test', 21:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:20 INFO - 'SHELL': '/bin/bash', 21:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:20 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:20 INFO - 'USER': 'cltbld', 21:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:20 INFO - 'XPC_FLAGS': '0x0', 21:35:20 INFO - 'XPC_SERVICE_NAME': '0', 21:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:35:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:35:23 INFO - Installing collected packages: mozsystemmonitor 21:35:23 INFO - Running setup.py install for mozsystemmonitor 21:35:23 INFO - Successfully installed mozsystemmonitor 21:35:23 INFO - Cleaning up... 21:35:23 INFO - Return code: 0 21:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:23 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:23 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 21:35:23 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 21:35:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:23 INFO - 'HOME': '/Users/cltbld', 21:35:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:23 INFO - 'LOGNAME': 'cltbld', 21:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:23 INFO - 'MOZ_NO_REMOTE': '1', 21:35:23 INFO - 'NO_EM_RESTART': '1', 21:35:23 INFO - 'PAGER': '/bin/cat', 21:35:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:23 INFO - 'PWD': '/builds/slave/test', 21:35:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:23 INFO - 'SHELL': '/bin/bash', 21:35:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:23 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:23 INFO - 'USER': 'cltbld', 21:35:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:23 INFO - 'XPC_FLAGS': '0x0', 21:35:23 INFO - 'XPC_SERVICE_NAME': '0', 21:35:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 21:35:23 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 21:35:23 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 21:35:23 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 21:35:23 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 21:35:23 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 21:35:23 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 21:35:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:35:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:35:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:26 INFO - warning: no files found matching '*.txt' 21:35:26 INFO - no previously-included directories found matching 'build' 21:35:26 INFO - no previously-included directories found matching 'dist' 21:35:26 INFO - no previously-included directories found matching '.git*' 21:35:26 INFO - Installing collected packages: jsonschema, functools32 21:35:26 INFO - Running setup.py install for functools32 21:35:26 INFO - warning: no files found matching '*.txt' 21:35:26 INFO - no previously-included directories found matching 'build' 21:35:26 INFO - no previously-included directories found matching 'dist' 21:35:26 INFO - no previously-included directories found matching '.git*' 21:35:26 INFO - Successfully installed jsonschema functools32 21:35:26 INFO - Cleaning up... 21:35:26 INFO - Return code: 0 21:35:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:26 INFO - 'HOME': '/Users/cltbld', 21:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:26 INFO - 'LOGNAME': 'cltbld', 21:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:26 INFO - 'MOZ_NO_REMOTE': '1', 21:35:26 INFO - 'NO_EM_RESTART': '1', 21:35:26 INFO - 'PAGER': '/bin/cat', 21:35:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:26 INFO - 'PWD': '/builds/slave/test', 21:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:26 INFO - 'SHELL': '/bin/bash', 21:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:26 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:26 INFO - 'USER': 'cltbld', 21:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:26 INFO - 'XPC_FLAGS': '0x0', 21:35:26 INFO - 'XPC_SERVICE_NAME': '0', 21:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:27 INFO - Cleaning up... 21:35:27 INFO - Return code: 0 21:35:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:35:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:27 INFO - 'HOME': '/Users/cltbld', 21:35:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:27 INFO - 'LOGNAME': 'cltbld', 21:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:27 INFO - 'MOZ_NO_REMOTE': '1', 21:35:27 INFO - 'NO_EM_RESTART': '1', 21:35:27 INFO - 'PAGER': '/bin/cat', 21:35:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:27 INFO - 'PWD': '/builds/slave/test', 21:35:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:27 INFO - 'SHELL': '/bin/bash', 21:35:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:27 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:27 INFO - 'USER': 'cltbld', 21:35:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:27 INFO - 'XPC_FLAGS': '0x0', 21:35:27 INFO - 'XPC_SERVICE_NAME': '0', 21:35:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:27 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 21:35:27 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 21:35:27 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 21:35:27 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 21:35:27 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 21:35:27 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 21:35:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:31 INFO - Downloading docopt-0.6.1.tar.gz 21:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:31 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:31 INFO - Running setup.py install for blobuploader 21:35:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:31 INFO - Running setup.py install for requests 21:35:31 INFO - Running setup.py install for docopt 21:35:32 INFO - Successfully installed blobuploader requests docopt 21:35:32 INFO - Cleaning up... 21:35:32 INFO - Return code: 0 21:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:32 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:32 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 21:35:32 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 21:35:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:32 INFO - 'HOME': '/Users/cltbld', 21:35:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:32 INFO - 'LOGNAME': 'cltbld', 21:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:32 INFO - 'MOZ_NO_REMOTE': '1', 21:35:32 INFO - 'NO_EM_RESTART': '1', 21:35:32 INFO - 'PAGER': '/bin/cat', 21:35:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:32 INFO - 'PWD': '/builds/slave/test', 21:35:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:32 INFO - 'SHELL': '/bin/bash', 21:35:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:32 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:32 INFO - 'USER': 'cltbld', 21:35:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:32 INFO - 'XPC_FLAGS': '0x0', 21:35:32 INFO - 'XPC_SERVICE_NAME': '0', 21:35:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-6EwaZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zRLMFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-I96Xaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-OwUBil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-cG8rSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:32 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-rBl0Da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-gvNrPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bNHVFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2zogoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-UddWi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zujqX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2AExr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-xDAegd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DcnxRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:33 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vIatHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:34 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-AozGJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:34 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-J7VkRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:34 INFO - Running setup.py install for manifestparser 21:35:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozcrash 21:35:34 INFO - Running setup.py install for mozdebug 21:35:34 INFO - Running setup.py install for mozdevice 21:35:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:34 INFO - Running setup.py install for mozfile 21:35:34 INFO - Running setup.py install for mozhttpd 21:35:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for mozinfo 21:35:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for mozInstall 21:35:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for mozleak 21:35:35 INFO - Running setup.py install for mozlog 21:35:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for moznetwork 21:35:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:35 INFO - Running setup.py install for mozprocess 21:35:36 INFO - Running setup.py install for mozprofile 21:35:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:36 INFO - Running setup.py install for mozrunner 21:35:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:36 INFO - Running setup.py install for mozscreenshot 21:35:36 INFO - Running setup.py install for moztest 21:35:36 INFO - Running setup.py install for mozversion 21:35:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:36 INFO - Cleaning up... 21:35:36 INFO - Return code: 0 21:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:36 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:36 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 21:35:36 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 21:35:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:36 INFO - 'HOME': '/Users/cltbld', 21:35:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:36 INFO - 'LOGNAME': 'cltbld', 21:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:36 INFO - 'MOZ_NO_REMOTE': '1', 21:35:36 INFO - 'NO_EM_RESTART': '1', 21:35:36 INFO - 'PAGER': '/bin/cat', 21:35:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:36 INFO - 'PWD': '/builds/slave/test', 21:35:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:36 INFO - 'SHELL': '/bin/bash', 21:35:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:36 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:36 INFO - 'USER': 'cltbld', 21:35:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:36 INFO - 'XPC_FLAGS': '0x0', 21:35:36 INFO - 'XPC_SERVICE_NAME': '0', 21:35:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Cq7w_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-y8ge0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-5Try0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0TASql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zRUFdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hhk48X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-AUJTOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2BhpTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:37 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)) 21:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:37 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-RtdkML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-RltF03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-IUfCkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-dGVVw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Y5FErw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-EkpMGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-PBrcHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Bvxvea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:38 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)) 21:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:38 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-mzAmFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:38 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)) 21:35:38 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)) 21:35:38 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)) 21:35:38 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)) 21:35:38 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)) 21:35:38 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)) 21:35:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:38 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 21:35:38 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 21:35:38 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 21:35:38 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 21:35:38 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 21:35:38 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 21:35:41 INFO - Downloading blessings-1.6.tar.gz 21:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:41 INFO - Installing collected packages: blessings 21:35:41 INFO - Running setup.py install for blessings 21:35:41 INFO - Successfully installed blessings 21:35:41 INFO - Cleaning up... 21:35:41 INFO - Return code: 0 21:35:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:42 INFO - Reading from file tmpfile_stdout 21:35:42 INFO - Current package versions: 21:35:42 INFO - blessings == 1.6 21:35:42 INFO - blobuploader == 1.2.4 21:35:42 INFO - docopt == 0.6.1 21:35:42 INFO - functools32 == 3.2.3-2 21:35:42 INFO - jsonschema == 2.5.1 21:35:42 INFO - manifestparser == 1.1 21:35:42 INFO - mozInstall == 1.12 21:35:42 INFO - mozcrash == 0.17 21:35:42 INFO - mozdebug == 0.1 21:35:42 INFO - mozdevice == 0.48 21:35:42 INFO - mozfile == 1.2 21:35:42 INFO - mozhttpd == 0.7 21:35:42 INFO - mozinfo == 0.9 21:35:42 INFO - mozleak == 0.1 21:35:42 INFO - mozlog == 3.4 21:35:42 INFO - moznetwork == 0.27 21:35:42 INFO - mozprocess == 0.23 21:35:42 INFO - mozprofile == 0.28 21:35:42 INFO - mozrunner == 6.12 21:35:42 INFO - mozscreenshot == 0.1 21:35:42 INFO - mozsystemmonitor == 0.3 21:35:42 INFO - moztest == 0.7 21:35:42 INFO - mozversion == 1.4 21:35:42 INFO - psutil == 3.1.1 21:35:42 INFO - requests == 1.2.3 21:35:42 INFO - wsgiref == 0.1.2 21:35:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 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 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:42 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 21:35:42 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 21:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:42 INFO - 'HOME': '/Users/cltbld', 21:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:42 INFO - 'LOGNAME': 'cltbld', 21:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:42 INFO - 'MOZ_NO_REMOTE': '1', 21:35:42 INFO - 'NO_EM_RESTART': '1', 21:35:42 INFO - 'PAGER': '/bin/cat', 21:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:42 INFO - 'PWD': '/builds/slave/test', 21:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:42 INFO - 'SHELL': '/bin/bash', 21:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:42 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:42 INFO - 'USER': 'cltbld', 21:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:42 INFO - 'XPC_FLAGS': '0x0', 21:35:42 INFO - 'XPC_SERVICE_NAME': '0', 21:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 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)) 21:35:42 INFO - Cleaning up... 21:35:42 INFO - Return code: 0 21:35:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102623490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102599570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94114af650>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, '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.SCIwaYaive/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.MCSE6cUpEt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:35:42 INFO - 'HOME': '/Users/cltbld', 21:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:35:42 INFO - 'LOGNAME': 'cltbld', 21:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:42 INFO - 'MOZ_NO_REMOTE': '1', 21:35:42 INFO - 'NO_EM_RESTART': '1', 21:35:42 INFO - 'PAGER': '/bin/cat', 21:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:42 INFO - 'PWD': '/builds/slave/test', 21:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:35:42 INFO - 'SHELL': '/bin/bash', 21:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:35:42 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:35:42 INFO - 'USER': 'cltbld', 21:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:42 INFO - 'XPC_FLAGS': '0x0', 21:35:42 INFO - 'XPC_SERVICE_NAME': '0', 21:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:42 INFO - Cleaning up... 21:35:42 INFO - Return code: 0 21:35:42 INFO - Running post-action listener: _resource_record_post_action 21:35:42 INFO - Running post-action listener: _start_resource_monitoring 21:35:43 INFO - Starting resource monitoring. 21:35:43 INFO - [mozharness: 2016-10-08 04:35:43.008188Z] Finished create-virtualenv step (success) 21:35:43 INFO - [mozharness: 2016-10-08 04:35:43.009215Z] Running install step. 21:35:43 INFO - Running pre-action listener: _resource_record_pre_action 21:35:43 INFO - Running main action method: install 21:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:43 INFO - Reading from file tmpfile_stdout 21:35:43 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:43 INFO - Reading from file tmpfile_stdout 21:35:43 INFO - Output received: 21:35:43 INFO - Usage: mozinstall [options] installer 21:35:43 INFO - Options: 21:35:43 INFO - -h, --help show this help message and exit 21:35:43 INFO - -d DEST, --destination=DEST 21:35:43 INFO - Directory to install application into. [default: 21:35:43 INFO - "/builds/slave/test"] 21:35:43 INFO - --app=APP Application being installed. [default: firefox] 21:35:43 INFO - mkdir: /builds/slave/test/build/application 21:35:43 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'] 21:35:43 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 21:36:17 INFO - Reading from file tmpfile_stdout 21:36:17 INFO - Output received: 21:36:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:36:17 INFO - Running post-action listener: _resource_record_post_action 21:36:17 INFO - [mozharness: 2016-10-08 04:36:17.524893Z] Finished install step (success) 21:36:17 INFO - [mozharness: 2016-10-08 04:36:17.525042Z] Running run-tests step. 21:36:17 INFO - Running pre-action listener: _resource_record_pre_action 21:36:17 INFO - Running main action method: run_tests 21:36:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:36:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:36:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:36:17 INFO - 2016-10-07 21:36:17.539 screenresolution[1643:7420] starting screenresolution argv=screenresolution get 21:36:17 INFO - 2016-10-07 21:36:17.542 screenresolution[1643:7420] Display 0: 1600x1200x32@60 21:36:17 INFO - 2016-10-07 21:36:17.547 screenresolution[1644:7422] starting screenresolution argv=screenresolution list 21:36:17 INFO - Available Modes on Display 0 21:36:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:36:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:36:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:36:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:36:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:36:17 INFO - Intel Iris: 21:36:17 INFO - Chipset Model: Intel Iris 21:36:17 INFO - Type: GPU 21:36:17 INFO - Bus: Built-In 21:36:17 INFO - VRAM (Dynamic, Max): 1536 MB 21:36:17 INFO - Vendor: Intel (0x8086) 21:36:17 INFO - Device ID: 0x0a2e 21:36:17 INFO - Revision ID: 0x0009 21:36:17 INFO - Displays: 21:36:17 INFO - Display: 21:36:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:36:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:36:17 INFO - Display Serial Number: 1600x1200 60 21:36:17 INFO - Main Display: Yes 21:36:17 INFO - Mirror: Off 21:36:17 INFO - Online: Yes 21:36:17 INFO - Rotation: Supported 21:36:17 INFO - Return code: 0 21:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:36:17 INFO - Python 2.7.3 21:36:17 INFO - Return code: 0 21:36:17 INFO - grabbing minidump binary from tooltool 21:36:17 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')]} 21:36:17 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 0x102437d30>, '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 0x10225ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10242fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:36:17 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 21:36:17 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 21:36:17 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 21:36:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:36:17 INFO - Return code: 0 21:36:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:36:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:36:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:36:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:36:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --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 21:36:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SCIwaYaive/Render', 21:36:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:36:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:36:17 INFO - 'HOME': '/Users/cltbld', 21:36:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:36:17 INFO - 'LOGNAME': 'cltbld', 21:36:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:36:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:36:17 INFO - 'MOZ_NO_REMOTE': '1', 21:36:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:36:17 INFO - 'NO_EM_RESTART': '1', 21:36:17 INFO - 'PAGER': '/bin/cat', 21:36:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:36:17 INFO - 'PWD': '/builds/slave/test', 21:36:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:36:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:36:17 INFO - 'SHELL': '/bin/bash', 21:36:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MCSE6cUpEt/Listeners', 21:36:17 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:36:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:36:17 INFO - 'USER': 'cltbld', 21:36:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:36:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:36:17 INFO - 'XPC_FLAGS': '0x0', 21:36:17 INFO - 'XPC_SERVICE_NAME': '0', 21:36:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:36:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:36:18 INFO - mozversion application_buildid: 20161007195722 21:36:18 INFO - mozversion application_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:36:18 INFO - mozversion application_display_name: Nightly 21:36:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:36:18 INFO - mozversion application_name: Firefox 21:36:18 INFO - mozversion application_remotingname: firefox 21:36:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:36:18 INFO - mozversion application_vendor: Mozilla 21:36:18 INFO - mozversion application_version: 52.0a1 21:36:18 INFO - mozversion platform_buildid: 20161007195722 21:36:18 INFO - mozversion platform_changeset: efa3b654aa77bcb9b3dd7fc5a52efb6b5afc34d6 21:36:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:36:18 INFO - mozversion platform_version: 52.0a1 21:36:18 INFO - using testdate: 1475901378 21:36:18 INFO - actual date: 1475901378 21:36:18 INFO - starting webserver on 'localhost:49272' 21:36:18 INFO - SUITE-START | Running 2 tests 21:36:18 INFO - TEST-START | dromaeo_css 21:36:18 INFO - operating with platform_type : mac_ 21:36:18 INFO - Initialising browser for dromaeo_css test... 21:36:18 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpxjkeg1/profile http://localhost:49272/getInfo.html) 21:36:20 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 21:36:20 INFO - PROCESS | 1654 | colorDepth:24 21:36:20 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 21:36:20 INFO - PROCESS | 1654 | __metrics 21:36:20 INFO - PROCESS | 1654 | 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" 21:36:20 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:36:21 INFO - TEST-INFO | 1654: exit 0 21:36:21 INFO - Browser initialized. 21:36:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:36:21 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpxjkeg1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:36:33 INFO - PROCESS | 1656 | RSS: Main: 234950656 21:36:33 INFO - PROCESS | 1656 | 21:37:23 INFO - PROCESS | 1656 | 1475901443863 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] 21:39:35 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 21:39:38 INFO - PROCESS | 1656 | RSS: Main: 479182848 21:39:38 INFO - PROCESS | 1656 | 21:42:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 21:42:42 INFO - PROCESS | 1656 | RSS: Main: 375226368 21:42:42 INFO - PROCESS | 1656 | 21:45:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 21:45:45 INFO - PROCESS | 1656 | RSS: Main: 344875008 21:45:45 INFO - PROCESS | 1656 | 21:48:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 21:48:48 INFO - PROCESS | 1656 | RSS: Main: 348368896 21:48:48 INFO - PROCESS | 1656 | 21:51:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 21:51:52 INFO - PROCESS | 1656 | RSS: Main: 333459456 21:51:52 INFO - PROCESS | 1656 | 21:54:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 21:54:56 INFO - PROCESS | 1656 | RSS: Main: 492224512 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | __start_tp_report 21:54:56 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 21:54:56 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 21:54:56 INFO - PROCESS | 1656 | |i|pagename|runs| 21:54:56 INFO - PROCESS | 1656 | |0;dojo.html;3289.4407950648388;3301.5873015873017;3308.1398836302556;3332.1836150143217;3368.326334733054;5465.07093794055;5560.082586373249;5618.606697531174;5659.434056594333;5659.915101273479;5576.553875689945;5623.128415095656;5623.381428042922;5625.943740562593;5631.155326700997;5102.489751024896;5139.0749665060275;5156.432792392852;5170.069387510247;5189.247559103927;5138.126518491847;5142.228665700138;5186.948130518703;5219.45195754446;5237.397699264595;5217.426083130853;5224.399194092671;5229.607779416559;5253.816116435925;5285.2600635911;421.73041993748114;5212.869678258055;5229.973850130763;5240.056789777838;5291.841244762663;4382.189294980439;5098.668586541863;5137.12668846297;5150.922736158961;5181.1969144782615;5516.475934786229;5585.525230355424;5638.802641907555;5642.548596112301;5647.689377084259;6165.383461653843;6198.4731297839735;6199.101130336121;6204.224471941007;6205.7517699291975;6088.482478989247;6099.5104902048115;6113.174721412597;6121.086510293184;6255.906161407583;5662.8301150965535;5718.771249150071;5730.942690573124;5733.168690539848;5783.450572195635;6342.587731797418;6343.904841427382;6366.713497892606;6377.808665739943;6387.169667943138;5868.94131058684;5930.851728706817;5938.168656388109;6073.089036644538;6080.75676972925;6102.974033066861;6200.81397558074;6209.130721698965;6239.344868788802;6249.875002500015;6109.816705498843;6109.816705498843;6130.111133885651;6135.171751813537;6139.386061393914;5999.6400215986305;6127.862983403491;6167.013277875519;6179.938200617937;6190.597611155261;4823.107725070873;4857.149998750205;4860.3195552622665;4862.854114376574;4866.7079975201605;4305.612494875476;4370.934435983463;4377.890552736207;4383.320585309282;4384.649228061748;5660.2075709400715;5663.830085097454;5676.120201368794;5684.886302274014;5725.799597014085;6223.937760622336;6239.407256310734;6251.374862513803;6271.404216599416;6282.748690052438;5543.6396634218645;5599.076152434803;5623.943760562342;5647.745851436695;5653.717314134276;5313.973430132824;5356.678599284055;5357.919631205535;5359.169328754049;5405.70268635221;6321.1782468278825;6350.460210882126;6357.809265722036;6362.554621176473;6385.425311721968;6092.8781424372155;6256.311805701278;6258.155149054819;6260.780872669435;6261.499080073674;6291.182146320949;6298.779542715983;6326.177596912372;6328.462080723006;6338.207724034496;6109.602935473257;6111.804454079419;6113.202667687734;6120.416658368064;6130.47890929276;6143.324234334309;6175.876482470415;6207.875842483216;6216.813495595139;6238.812835614939;5854.795082172103;5896.145058966512;5942.078977758454;5946.375630558729;6007.969960150172;5944;5953.583249172516;5957.523398128053;5958;5963.373845746134;5823.213866128019;5835.241418615553;5838.591298609056;5843;5843.678597676999;5888.587798854039;5959.195508606456;5962.986292330227;5963.522918166623;5968.134620480093;5810.331811841692;5832.475077243069;5832.9708351457975;5846;5851.970740146272 21:54:56 INFO - PROCESS | 1656 | |1;ext.html;482.3897769321808;483.26302388857;507.64718520628156;525.5217751845821;561.7949448451317;29071.563926541094;38159.61840381599;39356.40965385522;39522.8023859881;42096;38877.611223887754;39504.80247598765;40010;40109.59890401102;40122.59877401225;8653.524056176908;9605.855912161323;9679;9684.22526197906;9687.806243875119;8635.69775057873;8821.206091451768;8823.95588022059;8836.955815220916;11657.94171029148;11719.648410547697;12055.457504412323;12069.215500992408;12078.51685932566;12085.395730213499;11805.23265987708;12015.038796896271;12015.279083254945;12150.33173175475;12173.20874143178;8585.356098292654;8843.425177363451;11305.830412543819;11333.603323883624;11419.657410277621;37345.06637334061;39181.60818391837;39217.60782392168;39263.41104883429;39306.60693393058;3239.5302681111107;3317.7511686623598;3332.333533293351;3433.4334834752235;3926.3521518949624;28906.566401503995;29787.70212297871;30457.847710761525;30761.538576921364;31180.376392472022;3217.324361883984;3223.2908760072746;3257.4788033914697;3291.5720956275773;3327.866885324608;475793;482046;483288;601618;601741;55329.89340213173;55642.721786391616;56221.43778562244;56320.71839640858;57236.71381643148;61951;61968.25396825397;62038;62204.75590488256;62344.68827655833;15409.768853467207;15575.610609734847;15608.985415947927;15783.316836137885;15790.447334343473;12223.69440763988;12275.631731048083;12307.93846030782;12311.569095081808;12313.50745970169;15779.974301670354;16096.436624718079;16147.273372698257;17875.910620446815;18277.817221827878;6391.808245752542;7612.8477430452185;7733.188015258317;7761.223877612194;7819.3744500439825;879.3185281406961;956.6460409648336;974.5906719177963;1031.560972443437;1051.1958351860833;27346.863265683543;27395.589066164022;27826;29530.55704164439;29755;976.9790568855562;991.8462638291077;994.2543092680489;1051.348164138239;1068.3216157739737;14756.704865902622;15035.699286014436;15066;15180.240987950558;15471;619945;623872;660012;661308;881655;48371.5162848367;49172.524824254615;49256.75371623119;52020;55238.17142742862;1231.8398608180878;1255.8869701726705;1323.6492329532682;1352.2765320553456;1374.9862501374857;24532;29538.409231815673;29870.551941720456;29940;30037.69962300349;46433.76783116063;47021;47118;47122.05755884795;47206.527934720216;507217;511663;512167;513791;608627.7411677657;39230.80384598173;40068.998275043356;41228.76313710593;41374.172516550105;41496.37755433731;44789;46330.536694632625;46371.76814116043;46402.30396544122;46744.766276169765;35450.64549354473;36749.81625091857;38370.42692752052;38610;39456;37485.81257093697;37981.62018379781;39108.60891391164;39190.41214381844;39366.606333936295;36691;36755.81622091872;37832.243355132196;37916.24167516579;38114.809425953805;29900.85049574738;30332;32684.019479415656;33949.49075763816;34350.65649343475;20811;22302.77697223007;24818.627720583845;24968.750312496642;24979.500409991335 21:54:56 INFO - PROCESS | 1656 | |2;jquery.html;294.543457640657;349.67130896956877;373.8803582853488;379.5274882770951;409.61700809742894;14767.630809229775;15259.313330900108;15876.126813025294;20335.084921178546;20851.791482085173;17343.39298124566;19361.419157425265;20164.798352016474;20878.06048727807;21159.365219043415;5888.852778680535;6198.78304259351;6273.749050038015;6274.215723034621;6294.2761582417925;4791.712497250176;6173.691315434233;6213.036979268198;6220.720067596969;6234.937650623504;5303.65526240795;5835.970820145893;6052.394760523956;6058.787942422016;6203.937960620404;5521.4478552144865;5886.616645088401;5979.671118088525;6141.539384546155;6147.354527774564;5064.164412871872;5291.391489978663;5328.706921119337;5332.066888294572;5359.866003349908;25161.24516264515;25445;25875.870620646776;25917.74082259172;26072.478550428885;2090.790920907912;2092.1422216891;2149.5485947950947;2319;2361.3506285771377;14797.33411996452;15052;15362.00146990442;15894;16414.917925410417;1851.3427733154672;1877.662020836249;1888.5373083594607;1910.6274276516085;1950.9219631214735;112679.43660281647;118008.40995795051;118146.81853181444;118219.40890295494;118552;11502.367369794742;11546.651471073463;11652.30086194831;11674;11892.108091893142;14560;14588.708225835424;14592.63518412027;14595.416183352547;14600;8133.511989280662;8453.154684531497;8478.618462169217;8582.485050896967;8637.309015278763;8352.498850069016;8357.12250213731;8376.371772117116;8509.191626795444;8517.61670724819;4429.53489883564;4534.569215924482;4547.522510136454;4567.177907976529;4626.259798432302;1880.8871467711708;1924.124523341876;1926.8362189214074;1939.4763413878175;1947.5910058887791;772.8261141243288;777.4790890103644;808.7775861638097;848.3340577646518;856.1438561438562;17512.474625761246;19971;20843.478913027295;20902.37292881216;21191.75627240125;870.8650159225331;881.0836729801064;887.5074333744834;906.895706993691;914.3188324698009;10272.99676563063;10492.73768155787;11063.22557420989;11080;11083.113350931906;318843;415100;416918;559470;565248;122375.38812306059;127600;131808;132776.33611831878;134195;959.3620242538773;986.0927946289431;1004.1113614451117;1007.7631756537207;1007.8992100789862;18705;19642.80357196467;19645.607087858447;19772.802271977096;19791.40625781229;48635.245655780884;49625.50374496209;55633.721831392206;55776.72111639416;56357.71821140868;76635.61682191554;77006;78321.21678783139;78416.60791696233;81315;6693.832654183684;8153.6330865112395;8236.588170591567;8265.380096492667;8309.875351869849;11840.585579504675;12516.624501264976;12734.172278801849;12956.935215323863;13029.609111726664;10917.890821092005;11082.944585277022;11107.222494425312;11220.438978051228;11220.887791121984;9625.71122866315;11013.669589912315;11224.94387528057;11236.55053797839;11280.379579122899;11135.777284454103;11180.496877640688;11237.662870113909;11401.657950261506;11772.70568235801;8041.718539851077;8085.272325490734;8114.06688230861;8192.75421737349;8225.917740822515;9745.902540974783;10882.727931801768;11130.332180069221;11192.272502287326;11364.261323013978 21:54:56 INFO - PROCESS | 1656 | |3;mootools.html;1348.0563605476168;1382.6266907934857;1488.9800486666632;1679.219163089164;1899.154876080144;7646.508930758498;8368.330533557317;8659.263962563175;8708.346873984445;8725.345599080063;8450.070492245863;8523.01985271694;8529.87205191921;8549.230569248766;8567.443116197459;2267.648514480254;2290.3815969688176;2293.690351802502;2295.483516208856;2301.6432452969734;2228.8551244169157;2245.65192395179;2290.232772021375;2299.5975704251773;2301.919432819852;2252.831037672173;2275.101334972685;2284.3375421127853;2289.6565515172692;2296.6555016747457;2245.9101635934544;2261.185973049701;2263.1173842201556;2266.6033444147374;2267.11582482831;2231.665250212465;2254.5378197469645;2255.954880902389;2256.684064231009;2257.6049191391603;8331.708390206375;8414.326853851739;8592.570371481463;8597.5701214939;8597.656093756243;4934.9753251233515;5089.083964886319;5090.643654944155;5092.79628814847;5110.948890511085;3152.2277042124824;3252.251982044143;3401.6598340166033;3464.9826750866087;3470.7049900758466;947.2280091725222;981.4160574458257;1028;1038.4859494550171;1040.547361897577;10811.243212975094;10906.400147991857;10932.781344373068;10975.560977560888;10988.066014388787;4169.624733773975;4259.829606815754;4374.912501749947;4397.164538737629;4401.295792673157;8596.527191004554;8630.78423039429;8636.0500344962;8637.611307491052;8641.703744438384;4981.750912454435;4987.226979818134;4989.12690279207;4989.3264409305;4989.875253118701;3814.2180852925085;4249.893752656209;4397.6042156206095;4676.55572720591;4727.527247275245;3529.4882242074755;3554.893353199408;3656.2504686539196;3672.687821535146;3674.375356189401;1082.9620963266248;1110.0453609895483;1110.5446766825562;1110.9777804443866;1130.0225305111019;796.8127490039836;900.3247564326755;911.8586619074055;937.9812403751887;940.8515352173649;5491.450854914477;5562.47156520138;5899.938011157947;5911.704414779329;5934.851628709231;428.84775904554056;437.18246878337715;441.5033087776252;449.5302408982621;451.41090876406605;3859.6526312632;3895.500232410542;3967.266055779632;3996.1208534122447;3997.540282867449;10147.71676372825;10392.37645741258;10495.475226238657;10498.422586757802;10502.842457363146;10016.949915250523;10460.476976151162;10470.214733894989;10472.005159509834;10508.789824203626;7723.884141737878;7957.403194760416;7971.242731940456;7977.60111994398;7980.401469889665;4865.854024379274;5601.551875849841;5690.203371528072;5712.942870571407;5808.186853840551;9387.765305867408;9569.521523923915;9651.324407291422;9687.225021998363;9756.317057805885;9558.761030974281;9757.80484390294;9831.606735730491;9839;9911.702648920544;5690.317161940594;5877.823665289877;6336.334684858208;6538.378854008862;6827.078344423439;7845.254700803414;8030.036395632562;8119.715809946623;8183.140770219041;8196.221358971126;7222.3860971817985;7338.412926965723;7348.52234604749;7397.149327827368;7504.699812007677;7202.747903823341;7250.60121693312;7258.3104605062435;7306.415486761152;7331.560106393634;6562.8359291018105;6772.830679233059;6865.725370985105;6890.827729306808;6898.482613804085;4910.9263361050325;4973.577245933991;4993.226049962116;5042.924356134734;5119.411267704113;3977.582353852804;5007.298978143136;5008.6744361616375;5083;5093.108705976513 21:54:56 INFO - PROCESS | 1656 | |4;prototype.html;302.8546297777068;302.9500132478141;311.67741387663773;317.0709820226735;319.51912371880314;4933.925991110127;4948.628852836034;5238.895222095556;5329.920051199235;5377.919331210035;4494.393256910316;4592.311153326994;4943.725886092393;5141.254518094884;5325.733713314328;3929.1945151244;3965.4646622705854;4015.2973229684835;4017.714331413934;4022.738521996061;3685.470529730159;3981.7212795104356;4000.439938408625;4017.678585713136;4019.2564375590464;3834.693224542044;3963.8414463421427;3976.1848820991772;4007.298722723526;4011.618896204856;4003.138540578616;4003.5996400360023;4023.295923213426;4041.838326466938;4070.1859628074358;3482.4253998090285;3483.3207524532727;3503.8248087595516;3506.9649303506894;3507.9649203508147;4471.4796969030685;4932.695094286836;5140.203268493389;5143.459936706629;5154.793808247666;3524.506569080331;3665.945010824813;3996.7002474814212;4522.919457049761;4566.246569316058;4753.500882407332;5069.315642388304;5504.64219825714;5524.364698059734;5554.638948468337;3845.5000849889334;3847.5190601174854;3854.383298672227;3883.611638836122;3894.3184942634925;5433.972830135824;5853.414658534155;5885.146653735184;5898.439648233411;5911.497522710575;3055.358374741285;3822;3837.731358804913;3847.4228865669816;3856.0501216569346;3379.9662003380145;3833.1375440525658;3915.8433662653174;3920.764754114762;3923.4105490376787;4040.4343391925154;4237.470316210473;4513.909721805546;4582.106489234634;4604.562566556172;5620.91568626471;5623.493885550321;5636.915446268227;5649.6327738696855;5661.80183693577;1320.6830360713552;1329.3751936589788;1331.474067743236;1338.8125662407272;1351.4864351546546;788.266911772046;828.6643909216776;844.3118858130604;854.841854256952;896.1083721696954;4643.976780116078;5206.557442617344;5219.869503262449;5255.842324730264;5273.31446911899;5427.267318911975;5730.656160630292;5735;5790.913136302959;5794.971025144847;4133.81397837098;4629.1436084324505;4909.2881532177635;5112;5210.036143313499;2988.5218365061487;3003.543281508467;3004.10104249396;3013.608230929965;3016.849157542158;4574.977125114353;4965.776540055706;5652.547796176296;5869.20765696634;5930.52555795544;5052.993468886007;5770.143778829506;5806.516090345759;5827.912581311284;5840.766369345179;5027.597792176617;5191.922121168261;5304.893902121936;5743.483086522233;5799.7960774906105;4884.729970207701;5374.4088150304215;5634.408387119457;5641.8589535261945;5675.716214189357;4841.03937905149;4961.7519124044375;5409.404965453718;5546.500814926676;5555.416681248573;5061.645684802176;5804.477597016289;5816.651000939957;5828.766849326149;5852.970735146297;3593.1915319053005;3743.3449146399817;3772.320982223226;3801.942970855495;3808.371618682997;4712.151812673752;5581.386047534849;5616.69108199053;5617.634853734494;5634.52106570946;4855.883146876167;4901.975490122527;5175.637705360739;5282.418933917343;5565.1095824667855;4460.553944605514;4568.840090596813;5368.516833485005;5493.7802487900035;5526.336839579116;5183.729986153417;5360.123956615309;5388.46428767815;5392.892142157057;5414.5668346532975;5034.2951986721155;5230.503102205284;5442;5450.155225939986;5580.469855363734;4506.954930450785;5102.056119617882;5507.091329930517;5539.8892022160135;5550.27846379968 21:54:56 INFO - PROCESS | 1656 | |5;yui.html;687.2337343861595;693.2097408953794;695.6035060015793;747.8093086263005;785.3560080733798;13717.519886803964;15246.847531524681;15471.45849895254;15878.920605396972;15940.920295398535;14499.637509062279;14545.854541454582;14548.927255363735;14562.854371456282;14771.113733175991;666.8599594085248;684.2815044203567;821.4660470694051;829.0548774397162;854.0008190417195;840.9747707568752;848.3171047306915;852.4544291653347;852.6631980367782;854.0264098927228;907.1790030022806;907.9546022698871;908.5593487158723;908.6229214875818;910.2354022620997;704.651197657163;726.0488759724725;900.450725057711;900.9234215091692;902.5757893789909;538.536858301864;540.4622400711318;540.6918056707678;644.4844124700221;661.5997321620447;15180.696386072326;15253.61865953349;15254.771178432333;15254.923725381414;15258.542243732705;13532.661683457894;13784.724305513833;14094.859051409458;14138.293085345691;14142.50501232452;10651.78696426075;12478.064145189148;12617.179883307555;12678.556250531186;12877;4483.708558943691;4506.143832671782;4506.842260520866;4520.660950428698;4676.368690226844;94381;94507.05492945052;110680.4465977665;110819.44590277078;111964;10853.186011049203;10967.396793176453;10997.890021099687;11017;11023.677158740842;21575;21721;21831.01760420785;21834.781652183592;21959.90200489969;8012;8042.879356809653;8059.274665280153;8073.959630201929;8075.838483230303;4286.37847512109;4340.565943405634;4412.6690498212765;4517.593416592523;4539.978504836386;3348.363810875926;3498.073010652179;3499.9650003500146;3500.2474467989505;3508.158042069936;638.9552731308763;664.5613894829389;664.9966750166315;665.3911670821144;666.4967949198324;499.6076639617032;557.6504858243062;613.8925688004581;620.3021600699213;650.4861159683892;7898.921010789819;8888.511131887679;8914.420562663407;8970.86543701845;8996.190342869173;558.2157069317615;608.8356143841138;616.8427051101941;616.9475594574511;649.1593386564316;4297.39836422901;4329.545397733255;4366.19225443294;4441.156180325728;4502.144592527475;147607;154310;157349;157519;160760.19619901825;105686;107716;107784;132766.33616831855;138067.30966345104;87794.85436019418;108102;109189;110433;111309.44345278383;9404.38871473352;9626.66306679263;9688.951555242178;9947.751306217113;10049.849252261076;47379.57861264168;56374;58129.12806307993;58344.70827645835;60472.69763651153;80069.59965200137;88369;90562.18875622582;92678;94595;12903.548375806802;12922.676933076747;13268.867311326763;13476.460941562227;14020.298985050502;14794.63013424673;15301.08193508393;15512.146831924352;15550.61123471877;15660.451884183998;10988.835167472655;13878.375473103533;13880.305984700926;14195;14496.855031449972;10300.124489418484;13145.474181032652;14062.296885155905;14066;14294.142351458946;13564.86435135636;13571.86428135706;13668.176614067243;13753.587392378246;14078.366473508922;11014.339139651647;11073.280236784583;11140.442977850913;11184.552617895193;11510.59712910044;9287.953560232156;10442.477876106317;11351.205415620827;11517.481713323088;11532 21:54:56 INFO - PROCESS | 1656 | __end_tp_report 21:54:56 INFO - PROCESS | 1656 | __start_cc_report 21:54:56 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2919 21:54:56 INFO - PROCESS | 1656 | __end_cc_report 21:54:56 INFO - PROCESS | 1656 | __startTimestamp1475902496120__endTimestamp 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | ------- Summary: start ------- 21:54:56 INFO - PROCESS | 1656 | Number of tests: 6 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5657.03 Median:5843.68 stddev:761.42 (13.0%) stddev-sans-first:740.75 21:54:56 INFO - PROCESS | 1656 | Values: 3289.4 3301.6 3308.1 3332.2 3368.3 5465.1 5560.1 5618.6 5659.4 5659.9 5576.6 5623.1 5623.4 5625.9 5631.2 5102.5 5139.1 5156.4 5170.1 5189.2 5138.1 5142.2 5186.9 5219.5 5237.4 5217.4 5224.4 5229.6 5253.8 5285.3 421.7 5212.9 5230.0 5240.1 5291.8 4382.2 5098.7 5137.1 5150.9 5181.2 5516.5 5585.5 5638.8 5642.5 5647.7 6165.4 6198.5 6199.1 6204.2 6205.8 6088.5 6099.5 6113.2 6121.1 6255.9 5662.8 5718.8 5730.9 5733.2 5783.5 6342.6 6343.9 6366.7 6377.8 6387.2 5868.9 5930.9 5938.2 6073.1 6080.8 6103.0 6200.8 6209.1 6239.3 6249.9 6109.8 6109.8 6130.1 6135.2 6139.4 5999.6 6127.9 6167.0 6179.9 6190.6 4823.1 4857.1 4860.3 4862.9 4866.7 4305.6 4370.9 4377.9 4383.3 4384.6 5660.2 5663.8 5676.1 5684.9 5725.8 6223.9 6239.4 6251.4 6271.4 6282.7 5543.6 5599.1 5623.9 5647.7 5653.7 5314.0 5356.7 5357.9 5359.2 5405.7 6321.2 6350.5 6357.8 6362.6 6385.4 6092.9 6256.3 6258.2 6260.8 6261.5 6291.2 6298.8 6326.2 6328.5 6338.2 6109.6 6111.8 6113.2 6120.4 6130.5 6143.3 6175.9 6207.9 6216.8 6238.8 5854.8 5896.1 5942.1 5946.4 6008.0 5944.0 5953.6 5957.5 5958.0 5963.4 5823.2 5835.2 5838.6 5843.0 5843.7 5888.6 5959.2 5963.0 5963.5 5968.1 5810.3 5832.5 5833.0 5846.0 5852.0 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:71000.99 Median:38743.81 stddev:158543.17 (409.2%) stddev-sans-first:158899.51 21:54:56 INFO - PROCESS | 1656 | Values: 482.4 483.3 507.6 525.5 561.8 29071.6 38159.6 39356.4 39522.8 42096.0 38877.6 39504.8 40010.0 40109.6 40122.6 8653.5 9605.9 9679.0 9684.2 9687.8 8635.7 8821.2 8824.0 8837.0 11657.9 11719.6 12055.5 12069.2 12078.5 12085.4 11805.2 12015.0 12015.3 12150.3 12173.2 8585.4 8843.4 11305.8 11333.6 11419.7 37345.1 39181.6 39217.6 39263.4 39306.6 3239.5 3317.8 3332.3 3433.4 3926.4 28906.6 29787.7 30457.8 30761.5 31180.4 3217.3 3223.3 3257.5 3291.6 3327.9 475793.0 482046.0 483288.0 601618.0 601741.0 55329.9 55642.7 56221.4 56320.7 57236.7 61951.0 61968.3 62038.0 62204.8 62344.7 15409.8 15575.6 15609.0 15783.3 15790.4 12223.7 12275.6 12307.9 12311.6 12313.5 15780.0 16096.4 16147.3 17875.9 18277.8 6391.8 7612.8 7733.2 7761.2 7819.4 879.3 956.6 974.6 1031.6 1051.2 27346.9 27395.6 27826.0 29530.6 29755.0 977.0 991.8 994.3 1051.3 1068.3 14756.7 15035.7 15066.0 15180.2 15471.0 619945.0 623872.0 660012.0 661308.0 881655.0 48371.5 49172.5 49256.8 52020.0 55238.2 1231.8 1255.9 1323.6 1352.3 1375.0 24532.0 29538.4 29870.6 29940.0 30037.7 46433.8 47021.0 47118.0 47122.1 47206.5 507217.0 511663.0 512167.0 513791.0 608627.7 39230.8 40069.0 41228.8 41374.2 41496.4 44789.0 46330.5 46371.8 46402.3 46744.8 35450.6 36749.8 38370.4 38610.0 39456.0 37485.8 37981.6 39108.6 39190.4 39366.6 36691.0 36755.8 37832.2 37916.2 38114.8 29900.9 30332.0 32684.0 33949.5 34350.7 20811.0 22302.8 24818.6 24968.8 24979.5 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:31143.23 Median:13761.30 stddev:79221.98 (575.7%) stddev-sans-first:79410.35 21:54:56 INFO - PROCESS | 1656 | Values: 294.5 349.7 373.9 379.5 409.6 14767.6 15259.3 15876.1 20335.1 20851.8 17343.4 19361.4 20164.8 20878.1 21159.4 5888.9 6198.8 6273.7 6274.2 6294.3 4791.7 6173.7 6213.0 6220.7 6234.9 5303.7 5836.0 6052.4 6058.8 6203.9 5521.4 5886.6 5979.7 6141.5 6147.4 5064.2 5291.4 5328.7 5332.1 5359.9 25161.2 25445.0 25875.9 25917.7 26072.5 2090.8 2092.1 2149.5 2319.0 2361.4 14797.3 15052.0 15362.0 15894.0 16414.9 1851.3 1877.7 1888.5 1910.6 1950.9 112679.4 118008.4 118146.8 118219.4 118552.0 11502.4 11546.7 11652.3 11674.0 11892.1 14560.0 14588.7 14592.6 14595.4 14600.0 8133.5 8453.2 8478.6 8582.5 8637.3 8352.5 8357.1 8376.4 8509.2 8517.6 4429.5 4534.6 4547.5 4567.2 4626.3 1880.9 1924.1 1926.8 1939.5 1947.6 772.8 777.5 808.8 848.3 856.1 17512.5 19971.0 20843.5 20902.4 21191.8 870.9 881.1 887.5 906.9 914.3 10273.0 10492.7 11063.2 11080.0 11083.1 318843.0 415100.0 416918.0 559470.0 565248.0 122375.4 127600.0 131808.0 132776.3 134195.0 959.4 986.1 1004.1 1007.8 1007.9 18705.0 19642.8 19645.6 19772.8 19791.4 48635.2 49625.5 55633.7 55776.7 56357.7 76635.6 77006.0 78321.2 78416.6 81315.0 6693.8 8153.6 8236.6 8265.4 8309.9 11840.6 12516.6 12734.2 12956.9 13029.6 10917.9 11082.9 11107.2 11220.4 11220.9 9625.7 11013.7 11224.9 11236.6 11280.4 11135.8 11180.5 11237.7 11401.7 11772.7 8041.7 8085.3 8114.1 8192.8 8225.9 9745.9 10882.7 11130.3 11192.3 11364.3 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5445.27 Median:4989.23 stddev:3080.47 (61.7%) stddev-sans-first:3073.72 21:54:56 INFO - PROCESS | 1656 | Values: 1348.1 1382.6 1489.0 1679.2 1899.2 7646.5 8368.3 8659.3 8708.3 8725.3 8450.1 8523.0 8529.9 8549.2 8567.4 2267.6 2290.4 2293.7 2295.5 2301.6 2228.9 2245.7 2290.2 2299.6 2301.9 2252.8 2275.1 2284.3 2289.7 2296.7 2245.9 2261.2 2263.1 2266.6 2267.1 2231.7 2254.5 2256.0 2256.7 2257.6 8331.7 8414.3 8592.6 8597.6 8597.7 4935.0 5089.1 5090.6 5092.8 5110.9 3152.2 3252.3 3401.7 3465.0 3470.7 947.2 981.4 1028.0 1038.5 1040.5 10811.2 10906.4 10932.8 10975.6 10988.1 4169.6 4259.8 4374.9 4397.2 4401.3 8596.5 8630.8 8636.1 8637.6 8641.7 4981.8 4987.2 4989.1 4989.3 4989.9 3814.2 4249.9 4397.6 4676.6 4727.5 3529.5 3554.9 3656.3 3672.7 3674.4 1083.0 1110.0 1110.5 1111.0 1130.0 796.8 900.3 911.9 938.0 940.9 5491.5 5562.5 5899.9 5911.7 5934.9 428.8 437.2 441.5 449.5 451.4 3859.7 3895.5 3967.3 3996.1 3997.5 10147.7 10392.4 10495.5 10498.4 10502.8 10016.9 10460.5 10470.2 10472.0 10508.8 7723.9 7957.4 7971.2 7977.6 7980.4 4865.9 5601.6 5690.2 5712.9 5808.2 9387.8 9569.5 9651.3 9687.2 9756.3 9558.8 9757.8 9831.6 9839.0 9911.7 5690.3 5877.8 6336.3 6538.4 6827.1 7845.3 8030.0 8119.7 8183.1 8196.2 7222.4 7338.4 7348.5 7397.1 7504.7 7202.7 7250.6 7258.3 7306.4 7331.6 6562.8 6772.8 6865.7 6890.8 6898.5 4910.9 4973.6 4993.2 5042.9 5119.4 3977.6 5007.3 5008.7 5083.0 5093.1 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4451.93 Median:4955.19 stddev:1354.25 (27.3%) stddev-sans-first:1321.76 21:54:56 INFO - PROCESS | 1656 | Values: 302.9 303.0 311.7 317.1 319.5 4933.9 4948.6 5238.9 5329.9 5377.9 4494.4 4592.3 4943.7 5141.3 5325.7 3929.2 3965.5 4015.3 4017.7 4022.7 3685.5 3981.7 4000.4 4017.7 4019.3 3834.7 3963.8 3976.2 4007.3 4011.6 4003.1 4003.6 4023.3 4041.8 4070.2 3482.4 3483.3 3503.8 3507.0 3508.0 4471.5 4932.7 5140.2 5143.5 5154.8 3524.5 3665.9 3996.7 4522.9 4566.2 4753.5 5069.3 5504.6 5524.4 5554.6 3845.5 3847.5 3854.4 3883.6 3894.3 5434.0 5853.4 5885.1 5898.4 5911.5 3055.4 3822.0 3837.7 3847.4 3856.1 3380.0 3833.1 3915.8 3920.8 3923.4 4040.4 4237.5 4513.9 4582.1 4604.6 5620.9 5623.5 5636.9 5649.6 5661.8 1320.7 1329.4 1331.5 1338.8 1351.5 788.3 828.7 844.3 854.8 896.1 4644.0 5206.6 5219.9 5255.8 5273.3 5427.3 5730.7 5735.0 5790.9 5795.0 4133.8 4629.1 4909.3 5112.0 5210.0 2988.5 3003.5 3004.1 3013.6 3016.8 4575.0 4965.8 5652.5 5869.2 5930.5 5053.0 5770.1 5806.5 5827.9 5840.8 5027.6 5191.9 5304.9 5743.5 5799.8 4884.7 5374.4 5634.4 5641.9 5675.7 4841.0 4961.8 5409.4 5546.5 5555.4 5061.6 5804.5 5816.7 5828.8 5853.0 3593.2 3743.3 3772.3 3801.9 3808.4 4712.2 5581.4 5616.7 5617.6 5634.5 4855.9 4902.0 5175.6 5282.4 5565.1 4460.6 4568.8 5368.5 5493.8 5526.3 5183.7 5360.1 5388.5 5392.9 5414.6 5034.3 5230.5 5442.0 5450.2 5580.5 4507.0 5102.1 5507.1 5539.9 5550.3 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24281.29 Median:3504.20 stddev:38713.77 (1104.8%) stddev-sans-first:38781.83 21:54:56 INFO - PROCESS | 1656 | Values: 687.2 693.2 695.6 747.8 785.4 13717.5 15246.8 15471.5 15878.9 15940.9 14499.6 14545.9 14548.9 14562.9 14771.1 666.9 684.3 821.5 829.1 854.0 841.0 848.3 852.5 852.7 854.0 907.2 908.0 908.6 908.6 910.2 704.7 726.0 900.5 900.9 902.6 538.5 540.5 540.7 644.5 661.6 15180.7 15253.6 15254.8 15254.9 15258.5 13532.7 13784.7 14094.9 14138.3 14142.5 10651.8 12478.1 12617.2 12678.6 12877.0 4483.7 4506.1 4506.8 4520.7 4676.4 94381.0 94507.1 110680.4 110819.4 111964.0 10853.2 10967.4 10997.9 11017.0 11023.7 21575.0 21721.0 21831.0 21834.8 21959.9 8012.0 8042.9 8059.3 8074.0 8075.8 4286.4 4340.6 4412.7 4517.6 4540.0 3348.4 3498.1 3500.0 3500.2 3508.2 639.0 664.6 665.0 665.4 666.5 499.6 557.7 613.9 620.3 650.5 7898.9 8888.5 8914.4 8970.9 8996.2 558.2 608.8 616.8 616.9 649.2 4297.4 4329.5 4366.2 4441.2 4502.1 147607.0 154310.0 157349.0 157519.0 160760.2 105686.0 107716.0 107784.0 132766.3 138067.3 87794.9 108102.0 109189.0 110433.0 111309.4 9404.4 9626.7 9689.0 9947.8 10049.8 47379.6 56374.0 58129.1 58344.7 60472.7 80069.6 88369.0 90562.2 92678.0 94595.0 12903.5 12922.7 13268.9 13476.5 14020.3 14794.6 15301.1 15512.1 15550.6 15660.5 10988.8 13878.4 13880.3 14195.0 14496.9 10300.1 13145.5 14062.3 14066.0 14294.1 13564.9 13571.9 13668.2 13753.6 14078.4 11014.3 11073.3 11140.4 11184.6 11510.6 9288.0 10442.5 11351.2 11517.5 11532.0 21:54:56 INFO - PROCESS | 1656 | -------- Summary: end -------- 21:54:56 INFO - PROCESS | 1656 | 21:54:56 INFO - TEST-INFO | 1656: exit 0 21:54:56 INFO - TEST-OK | dromaeo_css | took 1118622ms 21:54:56 INFO - TEST-START | kraken 21:54:56 INFO - operating with platform_type : mac_ 21:54:56 INFO - Initialising browser for kraken test... 21:54:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpni5juq/profile http://localhost:49272/getInfo.html) 21:54:58 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 21:54:58 INFO - PROCESS | 1665 | colorDepth:24 21:54:58 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 21:54:58 INFO - PROCESS | 1665 | __metrics 21:54:59 INFO - PROCESS | 1665 | 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" 21:54:59 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:59 INFO - TEST-INFO | 1665: exit 0 21:54:59 INFO - Browser initialized. 21:54:59 INFO - Running cycle 1/1 for kraken test... 21:54:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpni5juq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:55:11 INFO - PROCESS | 1666 | RSS: Main: 235208704 21:55:11 INFO - PROCESS | 1666 | 21:55:14 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 21:55:15 INFO - PROCESS | 1666 | RSS: Main: 293793792 21:55:15 INFO - PROCESS | 1666 | 21:55:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 21:55:18 INFO - PROCESS | 1666 | RSS: Main: 294416384 21:55:18 INFO - PROCESS | 1666 | 21:55:21 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 21:55:22 INFO - PROCESS | 1666 | RSS: Main: 382160896 21:55:22 INFO - PROCESS | 1666 | 21:55:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 21:55:25 INFO - PROCESS | 1666 | RSS: Main: 285388800 21:55:25 INFO - PROCESS | 1666 | 21:55:27 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:55:27 INFO - PROCESS | 1666 | RSS: Main: 289304576 21:55:27 INFO - PROCESS | 1666 | 21:55:30 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 21:55:31 INFO - PROCESS | 1666 | RSS: Main: 328155136 21:55:31 INFO - PROCESS | 1666 | 21:55:33 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 21:55:34 INFO - PROCESS | 1666 | RSS: Main: 327966720 21:55:34 INFO - PROCESS | 1666 | 21:55:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 21:55:38 INFO - PROCESS | 1666 | RSS: Main: 327045120 21:55:38 INFO - PROCESS | 1666 | 21:55:39 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:55:40 INFO - PROCESS | 1666 | RSS: Main: 302129152 21:55:40 INFO - PROCESS | 1666 | 21:55:42 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:55:42 INFO - PROCESS | 1666 | RSS: Main: 305246208 21:55:42 INFO - PROCESS | 1666 | 21:55:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:55:45 INFO - PROCESS | 1666 | RSS: Main: 312283136 21:55:45 INFO - PROCESS | 1666 | 21:55:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:55:49 INFO - PROCESS | 1666 | RSS: Main: 321585152 21:55:49 INFO - PROCESS | 1666 | 21:55:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:53 INFO - PROCESS | 1666 | RSS: Main: 321548288 21:55:53 INFO - PROCESS | 1666 | 21:55:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 21:55:55 INFO - PROCESS | 1666 | RSS: Main: 365314048 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | __start_tp_report 21:55:55 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 21:55:55 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 21:55:55 INFO - PROCESS | 1666 | |i|pagename|runs| 21:55:55 INFO - PROCESS | 1666 | |0;ai-astar;113;114;113;111;112;112;113;113;112;111 21:55:55 INFO - PROCESS | 1666 | |1;audio-beat-detection;148;113;111;151;113;113;113;111;142;113 21:55:55 INFO - PROCESS | 1666 | |2;audio-dft;182;183;181;183;184;184;186;185;182;182 21:55:55 INFO - PROCESS | 1666 | |3;audio-fft;78;60;59;87;60;58;57;58;82;58 21:55:55 INFO - PROCESS | 1666 | |4;audio-oscillator;83;70;88;70;67;69;91;68;69;90 21:55:55 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;87;85;87;84;87;83;87;84;87;84 21:55:55 INFO - PROCESS | 1666 | |6;imaging-darkroom;94;95;95;95;95;95;95;95;112;160 21:55:55 INFO - PROCESS | 1666 | |7;imaging-desaturate;85;79;95;88;84;85;84;86;85;83 21:55:55 INFO - PROCESS | 1666 | |8;json-parse-financial;57;55;55;55;55;55;54;55;54;54 21:55:55 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;71;65;68;69;74;75;67;65;68;70 21:55:55 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;84;88;89;86;88;83;86;86;92;91 21:55:55 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;146;143;160;168;142;153;160;161;179;150 21:55:55 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;170;169;172;196;238;214;171;237;183;171 21:55:55 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;69;68;71;82;88;90;85;68;70;80 21:55:55 INFO - PROCESS | 1666 | __end_tp_report 21:55:55 INFO - PROCESS | 1666 | __start_cc_report 21:55:55 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1971 21:55:55 INFO - PROCESS | 1666 | __end_cc_report 21:55:55 INFO - PROCESS | 1666 | __startTimestamp1475902555226__endTimestamp 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | ------- Summary: start ------- 21:55:55 INFO - PROCESS | 1666 | Number of tests: 14 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 21:55:55 INFO - PROCESS | 1666 | Values: 113.0 114.0 113.0 111.0 112.0 112.0 113.0 113.0 112.0 111.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:113.00 stddev:16.86 (14.9%) stddev-sans-first:15.22 21:55:55 INFO - PROCESS | 1666 | Values: 148.0 113.0 111.0 151.0 113.0 113.0 113.0 111.0 142.0 113.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.55 (0.8%) stddev-sans-first:1.58 21:55:55 INFO - PROCESS | 1666 | Values: 182.0 183.0 181.0 183.0 184.0 184.0 186.0 185.0 182.0 182.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:65.70 Median:60.00 stddev:11.71 (19.5%) stddev-sans-first:11.54 21:55:55 INFO - PROCESS | 1666 | Values: 78.0 60.0 59.0 87.0 60.0 58.0 57.0 58.0 82.0 58.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:76.50 stddev:10.15 (13.3%) stddev-sans-first:10.49 21:55:55 INFO - PROCESS | 1666 | Values: 83.0 70.0 88.0 70.0 67.0 69.0 91.0 68.0 69.0 90.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:87.00 stddev:1.65 (1.9%) stddev-sans-first:1.66 21:55:55 INFO - PROCESS | 1666 | Values: 87.0 85.0 87.0 84.0 87.0 83.0 87.0 84.0 87.0 84.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:95.00 stddev:20.71 (21.8%) stddev-sans-first:21.70 21:55:55 INFO - PROCESS | 1666 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 112.0 160.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:4.09 (4.8%) stddev-sans-first:4.33 21:55:55 INFO - PROCESS | 1666 | Values: 85.0 79.0 95.0 88.0 84.0 85.0 84.0 86.0 85.0 83.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.88 (1.6%) stddev-sans-first:0.50 21:55:55 INFO - PROCESS | 1666 | Values: 57.0 55.0 55.0 55.0 55.0 55.0 54.0 55.0 54.0 54.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:3.39 (4.9%) stddev-sans-first:3.54 21:55:55 INFO - PROCESS | 1666 | Values: 71.0 65.0 68.0 69.0 74.0 75.0 67.0 65.0 68.0 70.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:88.00 stddev:2.87 (3.3%) stddev-sans-first:2.78 21:55:55 INFO - PROCESS | 1666 | Values: 84.0 88.0 89.0 86.0 88.0 83.0 86.0 86.0 92.0 91.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:156.20 Median:160.00 stddev:11.74 (7.3%) stddev-sans-first:11.85 21:55:55 INFO - PROCESS | 1666 | Values: 146.0 143.0 160.0 168.0 142.0 153.0 160.0 161.0 179.0 150.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.10 Median:189.50 stddev:27.92 (14.7%) stddev-sans-first:28.45 21:55:55 INFO - PROCESS | 1666 | Values: 170.0 169.0 172.0 196.0 238.0 214.0 171.0 237.0 183.0 171.0 21:55:55 INFO - PROCESS | 1666 | 21:55:55 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.10 Median:81.00 stddev:8.81 (10.9%) stddev-sans-first:8.85 21:55:55 INFO - PROCESS | 1666 | Values: 69.0 68.0 71.0 82.0 88.0 90.0 85.0 68.0 70.0 80.0 21:55:55 INFO - PROCESS | 1666 | -------- Summary: end -------- 21:55:55 INFO - PROCESS | 1666 | 21:55:56 INFO - TEST-INFO | 1666: exit 0 21:55:56 INFO - TEST-OK | kraken | took 59541ms 21:55:56 INFO - SUITE-END | took 1178s 21:55:56 INFO - Completed test suite (00:19:38) 21:55:56 INFO - javascript benchmark 21:55:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3289.4407950648388, 3301.5873015873017, 3308.1398836302556, 3332.1836150143217, 3368.326334733054, 5465.07093794055, 5560.082586373249, 5618.606697531174, 5659.434056594333, 5659.915101273479, 5576.553875689945, 5623.128415095656, 5623.381428042922, 5625.943740562593, 5631.155326700997, 5102.489751024896, 5139.0749665060275, 5156.432792392852, 5170.069387510247, 5189.247559103927, 5138.126518491847, 5142.228665700138, 5186.948130518703, 5219.45195754446, 5237.397699264595, 5217.426083130853, 5224.399194092671, 5229.607779416559, 5253.816116435925, 5285.2600635911, 421.73041993748114, 5212.869678258055, 5229.973850130763, 5240.056789777838, 5291.841244762663, 4382.189294980439, 5098.668586541863, 5137.12668846297, 5150.922736158961, 5181.1969144782615, 5516.475934786229, 5585.525230355424, 5638.802641907555, 5642.548596112301, 5647.689377084259, 6165.383461653843, 6198.4731297839735, 6199.101130336121, 6204.224471941007, 6205.7517699291975, 6088.482478989247, 6099.5104902048115, 6113.174721412597, 6121.086510293184, 6255.906161407583, 5662.8301150965535, 5718.771249150071, 5730.942690573124, 5733.168690539848, 5783.450572195635, 6342.587731797418, 6343.904841427382, 6366.713497892606, 6377.808665739943, 6387.169667943138, 5868.94131058684, 5930.851728706817, 5938.168656388109, 6073.089036644538, 6080.75676972925, 6102.974033066861, 6200.81397558074, 6209.130721698965, 6239.344868788802, 6249.875002500015, 6109.816705498843, 6109.816705498843, 6130.111133885651, 6135.171751813537, 6139.386061393914, 5999.6400215986305, 6127.862983403491, 6167.013277875519, 6179.938200617937, 6190.597611155261, 4823.107725070873, 4857.149998750205, 4860.3195552622665, 4862.854114376574, 4866.7079975201605, 4305.612494875476, 4370.934435983463, 4377.890552736207, 4383.320585309282, 4384.649228061748, 5660.2075709400715, 5663.830085097454, 5676.120201368794, 5684.886302274014, 5725.799597014085, 6223.937760622336, 6239.407256310734, 6251.374862513803, 6271.404216599416, 6282.748690052438, 5543.6396634218645, 5599.076152434803, 5623.943760562342, 5647.745851436695, 5653.717314134276, 5313.973430132824, 5356.678599284055, 5357.919631205535, 5359.169328754049, 5405.70268635221, 6321.1782468278825, 6350.460210882126, 6357.809265722036, 6362.554621176473, 6385.425311721968, 6092.8781424372155, 6256.311805701278, 6258.155149054819, 6260.780872669435, 6261.499080073674, 6291.182146320949, 6298.779542715983, 6326.177596912372, 6328.462080723006, 6338.207724034496, 6109.602935473257, 6111.804454079419, 6113.202667687734, 6120.416658368064, 6130.47890929276, 6143.324234334309, 6175.876482470415, 6207.875842483216, 6216.813495595139, 6238.812835614939, 5854.795082172103, 5896.145058966512, 5942.078977758454, 5946.375630558729, 6007.969960150172, 5944.0, 5953.583249172516, 5957.523398128053, 5958.0, 5963.373845746134, 5823.213866128019, 5835.241418615553, 5838.591298609056, 5843.0, 5843.678597676999, 5888.587798854039, 5959.195508606456, 5962.986292330227, 5963.522918166623, 5968.134620480093, 5810.331811841692, 5832.475077243069, 5832.9708351457975, 5846.0, 5851.970740146272], "value": 5609.205684878444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.3897769321808, 483.26302388857, 507.64718520628156, 525.5217751845821, 561.7949448451317, 29071.563926541094, 38159.61840381599, 39356.40965385522, 39522.8023859881, 42096.0, 38877.611223887754, 39504.80247598765, 40010.0, 40109.59890401102, 40122.59877401225, 8653.524056176908, 9605.855912161323, 9679.0, 9684.22526197906, 9687.806243875119, 8635.69775057873, 8821.206091451768, 8823.95588022059, 8836.955815220916, 11657.94171029148, 11719.648410547697, 12055.457504412323, 12069.215500992408, 12078.51685932566, 12085.395730213499, 11805.23265987708, 12015.038796896271, 12015.279083254945, 12150.33173175475, 12173.20874143178, 8585.356098292654, 8843.425177363451, 11305.830412543819, 11333.603323883624, 11419.657410277621, 37345.06637334061, 39181.60818391837, 39217.60782392168, 39263.41104883429, 39306.60693393058, 3239.5302681111107, 3317.7511686623598, 3332.333533293351, 3433.4334834752235, 3926.3521518949624, 28906.566401503995, 29787.70212297871, 30457.847710761525, 30761.538576921364, 31180.376392472022, 3217.324361883984, 3223.2908760072746, 3257.4788033914697, 3291.5720956275773, 3327.866885324608, 475793.0, 482046.0, 483288.0, 601618.0, 601741.0, 55329.89340213173, 55642.721786391616, 56221.43778562244, 56320.71839640858, 57236.71381643148, 61951.0, 61968.25396825397, 62038.0, 62204.75590488256, 62344.68827655833, 15409.768853467207, 15575.610609734847, 15608.985415947927, 15783.316836137885, 15790.447334343473, 12223.69440763988, 12275.631731048083, 12307.93846030782, 12311.569095081808, 12313.50745970169, 15779.974301670354, 16096.436624718079, 16147.273372698257, 17875.910620446815, 18277.817221827878, 6391.808245752542, 7612.8477430452185, 7733.188015258317, 7761.223877612194, 7819.3744500439825, 879.3185281406961, 956.6460409648336, 974.5906719177963, 1031.560972443437, 1051.1958351860833, 27346.863265683543, 27395.589066164022, 27826.0, 29530.55704164439, 29755.0, 976.9790568855562, 991.8462638291077, 994.2543092680489, 1051.348164138239, 1068.3216157739737, 14756.704865902622, 15035.699286014436, 15066.0, 15180.240987950558, 15471.0, 619945.0, 623872.0, 660012.0, 661308.0, 881655.0, 48371.5162848367, 49172.524824254615, 49256.75371623119, 52020.0, 55238.17142742862, 1231.8398608180878, 1255.8869701726705, 1323.6492329532682, 1352.2765320553456, 1374.9862501374857, 24532.0, 29538.409231815673, 29870.551941720456, 29940.0, 30037.69962300349, 46433.76783116063, 47021.0, 47118.0, 47122.05755884795, 47206.527934720216, 507217.0, 511663.0, 512167.0, 513791.0, 608627.7411677657, 39230.80384598173, 40068.998275043356, 41228.76313710593, 41374.172516550105, 41496.37755433731, 44789.0, 46330.536694632625, 46371.76814116043, 46402.30396544122, 46744.766276169765, 35450.64549354473, 36749.81625091857, 38370.42692752052, 38610.0, 39456.0, 37485.81257093697, 37981.62018379781, 39108.60891391164, 39190.41214381844, 39366.606333936295, 36691.0, 36755.81622091872, 37832.243355132196, 37916.24167516579, 38114.809425953805, 29900.85049574738, 30332.0, 32684.019479415656, 33949.49075763816, 34350.65649343475, 20811.0, 22302.77697223007, 24818.627720583845, 24968.750312496642, 24979.500409991335], "value": 19969.517211314807, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.543457640657, 349.67130896956877, 373.8803582853488, 379.5274882770951, 409.61700809742894, 14767.630809229775, 15259.313330900108, 15876.126813025294, 20335.084921178546, 20851.791482085173, 17343.39298124566, 19361.419157425265, 20164.798352016474, 20878.06048727807, 21159.365219043415, 5888.852778680535, 6198.78304259351, 6273.749050038015, 6274.215723034621, 6294.2761582417925, 4791.712497250176, 6173.691315434233, 6213.036979268198, 6220.720067596969, 6234.937650623504, 5303.65526240795, 5835.970820145893, 6052.394760523956, 6058.787942422016, 6203.937960620404, 5521.4478552144865, 5886.616645088401, 5979.671118088525, 6141.539384546155, 6147.354527774564, 5064.164412871872, 5291.391489978663, 5328.706921119337, 5332.066888294572, 5359.866003349908, 25161.24516264515, 25445.0, 25875.870620646776, 25917.74082259172, 26072.478550428885, 2090.790920907912, 2092.1422216891, 2149.5485947950947, 2319.0, 2361.3506285771377, 14797.33411996452, 15052.0, 15362.00146990442, 15894.0, 16414.917925410417, 1851.3427733154672, 1877.662020836249, 1888.5373083594607, 1910.6274276516085, 1950.9219631214735, 112679.43660281647, 118008.40995795051, 118146.81853181444, 118219.40890295494, 118552.0, 11502.367369794742, 11546.651471073463, 11652.30086194831, 11674.0, 11892.108091893142, 14560.0, 14588.708225835424, 14592.63518412027, 14595.416183352547, 14600.0, 8133.511989280662, 8453.154684531497, 8478.618462169217, 8582.485050896967, 8637.309015278763, 8352.498850069016, 8357.12250213731, 8376.371772117116, 8509.191626795444, 8517.61670724819, 4429.53489883564, 4534.569215924482, 4547.522510136454, 4567.177907976529, 4626.259798432302, 1880.8871467711708, 1924.124523341876, 1926.8362189214074, 1939.4763413878175, 1947.5910058887791, 772.8261141243288, 777.4790890103644, 808.7775861638097, 848.3340577646518, 856.1438561438562, 17512.474625761246, 19971.0, 20843.478913027295, 20902.37292881216, 21191.75627240125, 870.8650159225331, 881.0836729801064, 887.5074333744834, 906.895706993691, 914.3188324698009, 10272.99676563063, 10492.73768155787, 11063.22557420989, 11080.0, 11083.113350931906, 318843.0, 415100.0, 416918.0, 559470.0, 565248.0, 122375.38812306059, 127600.0, 131808.0, 132776.33611831878, 134195.0, 959.3620242538773, 986.0927946289431, 1004.1113614451117, 1007.7631756537207, 1007.8992100789862, 18705.0, 19642.80357196467, 19645.607087858447, 19772.802271977096, 19791.40625781229, 48635.245655780884, 49625.50374496209, 55633.721831392206, 55776.72111639416, 56357.71821140868, 76635.61682191554, 77006.0, 78321.21678783139, 78416.60791696233, 81315.0, 6693.832654183684, 8153.6330865112395, 8236.588170591567, 8265.380096492667, 8309.875351869849, 11840.585579504675, 12516.624501264976, 12734.172278801849, 12956.935215323863, 13029.609111726664, 10917.890821092005, 11082.944585277022, 11107.222494425312, 11220.438978051228, 11220.887791121984, 9625.71122866315, 11013.669589912315, 11224.94387528057, 11236.55053797839, 11280.379579122899, 11135.777284454103, 11180.496877640688, 11237.662870113909, 11401.657950261506, 11772.70568235801, 8041.718539851077, 8085.272325490734, 8114.06688230861, 8192.75421737349, 8225.917740822515, 9745.902540974783, 10882.727931801768, 11130.332180069221, 11192.272502287326, 11364.261323013978], "value": 9501.617174664456, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.0563605476168, 1382.6266907934857, 1488.9800486666632, 1679.219163089164, 1899.154876080144, 7646.508930758498, 8368.330533557317, 8659.263962563175, 8708.346873984445, 8725.345599080063, 8450.070492245863, 8523.01985271694, 8529.87205191921, 8549.230569248766, 8567.443116197459, 2267.648514480254, 2290.3815969688176, 2293.690351802502, 2295.483516208856, 2301.6432452969734, 2228.8551244169157, 2245.65192395179, 2290.232772021375, 2299.5975704251773, 2301.919432819852, 2252.831037672173, 2275.101334972685, 2284.3375421127853, 2289.6565515172692, 2296.6555016747457, 2245.9101635934544, 2261.185973049701, 2263.1173842201556, 2266.6033444147374, 2267.11582482831, 2231.665250212465, 2254.5378197469645, 2255.954880902389, 2256.684064231009, 2257.6049191391603, 8331.708390206375, 8414.326853851739, 8592.570371481463, 8597.5701214939, 8597.656093756243, 4934.9753251233515, 5089.083964886319, 5090.643654944155, 5092.79628814847, 5110.948890511085, 3152.2277042124824, 3252.251982044143, 3401.6598340166033, 3464.9826750866087, 3470.7049900758466, 947.2280091725222, 981.4160574458257, 1028.0, 1038.4859494550171, 1040.547361897577, 10811.243212975094, 10906.400147991857, 10932.781344373068, 10975.560977560888, 10988.066014388787, 4169.624733773975, 4259.829606815754, 4374.912501749947, 4397.164538737629, 4401.295792673157, 8596.527191004554, 8630.78423039429, 8636.0500344962, 8637.611307491052, 8641.703744438384, 4981.750912454435, 4987.226979818134, 4989.12690279207, 4989.3264409305, 4989.875253118701, 3814.2180852925085, 4249.893752656209, 4397.6042156206095, 4676.55572720591, 4727.527247275245, 3529.4882242074755, 3554.893353199408, 3656.2504686539196, 3672.687821535146, 3674.375356189401, 1082.9620963266248, 1110.0453609895483, 1110.5446766825562, 1110.9777804443866, 1130.0225305111019, 796.8127490039836, 900.3247564326755, 911.8586619074055, 937.9812403751887, 940.8515352173649, 5491.450854914477, 5562.47156520138, 5899.938011157947, 5911.704414779329, 5934.851628709231, 428.84775904554056, 437.18246878337715, 441.5033087776252, 449.5302408982621, 451.41090876406605, 3859.6526312632, 3895.500232410542, 3967.266055779632, 3996.1208534122447, 3997.540282867449, 10147.71676372825, 10392.37645741258, 10495.475226238657, 10498.422586757802, 10502.842457363146, 10016.949915250523, 10460.476976151162, 10470.214733894989, 10472.005159509834, 10508.789824203626, 7723.884141737878, 7957.403194760416, 7971.242731940456, 7977.60111994398, 7980.401469889665, 4865.854024379274, 5601.551875849841, 5690.203371528072, 5712.942870571407, 5808.186853840551, 9387.765305867408, 9569.521523923915, 9651.324407291422, 9687.225021998363, 9756.317057805885, 9558.761030974281, 9757.80484390294, 9831.606735730491, 9839.0, 9911.702648920544, 5690.317161940594, 5877.823665289877, 6336.334684858208, 6538.378854008862, 6827.078344423439, 7845.254700803414, 8030.036395632562, 8119.715809946623, 8183.140770219041, 8196.221358971126, 7222.3860971817985, 7338.412926965723, 7348.52234604749, 7397.149327827368, 7504.699812007677, 7202.747903823341, 7250.60121693312, 7258.3104605062435, 7306.415486761152, 7331.560106393634, 6562.8359291018105, 6772.830679233059, 6865.725370985105, 6890.827729306808, 6898.482613804085, 4910.9263361050325, 4973.577245933991, 4993.226049962116, 5042.924356134734, 5119.411267704113, 3977.582353852804, 5007.298978143136, 5008.6744361616375, 5083.0, 5093.108705976513], "value": 4297.907522618909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8546297777068, 302.9500132478141, 311.67741387663773, 317.0709820226735, 319.51912371880314, 4933.925991110127, 4948.628852836034, 5238.895222095556, 5329.920051199235, 5377.919331210035, 4494.393256910316, 4592.311153326994, 4943.725886092393, 5141.254518094884, 5325.733713314328, 3929.1945151244, 3965.4646622705854, 4015.2973229684835, 4017.714331413934, 4022.738521996061, 3685.470529730159, 3981.7212795104356, 4000.439938408625, 4017.678585713136, 4019.2564375590464, 3834.693224542044, 3963.8414463421427, 3976.1848820991772, 4007.298722723526, 4011.618896204856, 4003.138540578616, 4003.5996400360023, 4023.295923213426, 4041.838326466938, 4070.1859628074358, 3482.4253998090285, 3483.3207524532727, 3503.8248087595516, 3506.9649303506894, 3507.9649203508147, 4471.4796969030685, 4932.695094286836, 5140.203268493389, 5143.459936706629, 5154.793808247666, 3524.506569080331, 3665.945010824813, 3996.7002474814212, 4522.919457049761, 4566.246569316058, 4753.500882407332, 5069.315642388304, 5504.64219825714, 5524.364698059734, 5554.638948468337, 3845.5000849889334, 3847.5190601174854, 3854.383298672227, 3883.611638836122, 3894.3184942634925, 5433.972830135824, 5853.414658534155, 5885.146653735184, 5898.439648233411, 5911.497522710575, 3055.358374741285, 3822.0, 3837.731358804913, 3847.4228865669816, 3856.0501216569346, 3379.9662003380145, 3833.1375440525658, 3915.8433662653174, 3920.764754114762, 3923.4105490376787, 4040.4343391925154, 4237.470316210473, 4513.909721805546, 4582.106489234634, 4604.562566556172, 5620.91568626471, 5623.493885550321, 5636.915446268227, 5649.6327738696855, 5661.80183693577, 1320.6830360713552, 1329.3751936589788, 1331.474067743236, 1338.8125662407272, 1351.4864351546546, 788.266911772046, 828.6643909216776, 844.3118858130604, 854.841854256952, 896.1083721696954, 4643.976780116078, 5206.557442617344, 5219.869503262449, 5255.842324730264, 5273.31446911899, 5427.267318911975, 5730.656160630292, 5735.0, 5790.913136302959, 5794.971025144847, 4133.81397837098, 4629.1436084324505, 4909.2881532177635, 5112.0, 5210.036143313499, 2988.5218365061487, 3003.543281508467, 3004.10104249396, 3013.608230929965, 3016.849157542158, 4574.977125114353, 4965.776540055706, 5652.547796176296, 5869.20765696634, 5930.52555795544, 5052.993468886007, 5770.143778829506, 5806.516090345759, 5827.912581311284, 5840.766369345179, 5027.597792176617, 5191.922121168261, 5304.893902121936, 5743.483086522233, 5799.7960774906105, 4884.729970207701, 5374.4088150304215, 5634.408387119457, 5641.8589535261945, 5675.716214189357, 4841.03937905149, 4961.7519124044375, 5409.404965453718, 5546.500814926676, 5555.416681248573, 5061.645684802176, 5804.477597016289, 5816.651000939957, 5828.766849326149, 5852.970735146297, 3593.1915319053005, 3743.3449146399817, 3772.320982223226, 3801.942970855495, 3808.371618682997, 4712.151812673752, 5581.386047534849, 5616.69108199053, 5617.634853734494, 5634.52106570946, 4855.883146876167, 4901.975490122527, 5175.637705360739, 5282.418933917343, 5565.1095824667855, 4460.553944605514, 4568.840090596813, 5368.516833485005, 5493.7802487900035, 5526.336839579116, 5183.729986153417, 5360.123956615309, 5388.46428767815, 5392.892142157057, 5414.5668346532975, 5034.2951986721155, 5230.503102205284, 5442.0, 5450.155225939986, 5580.469855363734, 4506.954930450785, 5102.056119617882, 5507.091329930517, 5539.8892022160135, 5550.27846379968], "value": 4022.985019564576, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.2337343861595, 693.2097408953794, 695.6035060015793, 747.8093086263005, 785.3560080733798, 13717.519886803964, 15246.847531524681, 15471.45849895254, 15878.920605396972, 15940.920295398535, 14499.637509062279, 14545.854541454582, 14548.927255363735, 14562.854371456282, 14771.113733175991, 666.8599594085248, 684.2815044203567, 821.4660470694051, 829.0548774397162, 854.0008190417195, 840.9747707568752, 848.3171047306915, 852.4544291653347, 852.6631980367782, 854.0264098927228, 907.1790030022806, 907.9546022698871, 908.5593487158723, 908.6229214875818, 910.2354022620997, 704.651197657163, 726.0488759724725, 900.450725057711, 900.9234215091692, 902.5757893789909, 538.536858301864, 540.4622400711318, 540.6918056707678, 644.4844124700221, 661.5997321620447, 15180.696386072326, 15253.61865953349, 15254.771178432333, 15254.923725381414, 15258.542243732705, 13532.661683457894, 13784.724305513833, 14094.859051409458, 14138.293085345691, 14142.50501232452, 10651.78696426075, 12478.064145189148, 12617.179883307555, 12678.556250531186, 12877.0, 4483.708558943691, 4506.143832671782, 4506.842260520866, 4520.660950428698, 4676.368690226844, 94381.0, 94507.05492945052, 110680.4465977665, 110819.44590277078, 111964.0, 10853.186011049203, 10967.396793176453, 10997.890021099687, 11017.0, 11023.677158740842, 21575.0, 21721.0, 21831.01760420785, 21834.781652183592, 21959.90200489969, 8012.0, 8042.879356809653, 8059.274665280153, 8073.959630201929, 8075.838483230303, 4286.37847512109, 4340.565943405634, 4412.6690498212765, 4517.593416592523, 4539.978504836386, 3348.363810875926, 3498.073010652179, 3499.9650003500146, 3500.2474467989505, 3508.158042069936, 638.9552731308763, 664.5613894829389, 664.9966750166315, 665.3911670821144, 666.4967949198324, 499.6076639617032, 557.6504858243062, 613.8925688004581, 620.3021600699213, 650.4861159683892, 7898.921010789819, 8888.511131887679, 8914.420562663407, 8970.86543701845, 8996.190342869173, 558.2157069317615, 608.8356143841138, 616.8427051101941, 616.9475594574511, 649.1593386564316, 4297.39836422901, 4329.545397733255, 4366.19225443294, 4441.156180325728, 4502.144592527475, 147607.0, 154310.0, 157349.0, 157519.0, 160760.19619901825, 105686.0, 107716.0, 107784.0, 132766.33616831855, 138067.30966345104, 87794.85436019418, 108102.0, 109189.0, 110433.0, 111309.44345278383, 9404.38871473352, 9626.66306679263, 9688.951555242178, 9947.751306217113, 10049.849252261076, 47379.57861264168, 56374.0, 58129.12806307993, 58344.70827645835, 60472.69763651153, 80069.59965200137, 88369.0, 90562.18875622582, 92678.0, 94595.0, 12903.548375806802, 12922.676933076747, 13268.867311326763, 13476.460941562227, 14020.298985050502, 14794.63013424673, 15301.08193508393, 15512.146831924352, 15550.61123471877, 15660.451884183998, 10988.835167472655, 13878.375473103533, 13880.305984700926, 14195.0, 14496.855031449972, 10300.124489418484, 13145.474181032652, 14062.296885155905, 14066.0, 14294.142351458946, 13564.86435135636, 13571.86428135706, 13668.176614067243, 13753.587392378246, 14078.366473508922, 11014.339139651647, 11073.280236784583, 11140.442977850913, 11184.552617895193, 11510.59712910044, 9287.953560232156, 10442.477876106317, 11351.205415620827, 11517.481713323088, 11532.0], "value": 7716.54695099499, "unit": "score"}], "name": "dromaeo_css", "value": 7223.107135603881, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 111.0, 112.0, 112.0, 113.0, 113.0, 112.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 111.0, 151.0, 113.0, 113.0, 113.0, 111.0, 142.0, 113.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 181.0, 183.0, 184.0, 184.0, 186.0, 185.0, 182.0, 182.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 59.0, 87.0, 60.0, 58.0, 57.0, 58.0, 82.0, 58.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 88.0, 70.0, 67.0, 69.0, 91.0, 68.0, 69.0, 90.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 112.0, 160.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 95.0, 88.0, 84.0, 85.0, 84.0, 86.0, 85.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 68.0, 69.0, 74.0, 75.0, 67.0, 65.0, 68.0, 70.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 89.0, 86.0, 88.0, 83.0, 86.0, 86.0, 92.0, 91.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 160.0, 168.0, 142.0, 153.0, 160.0, 161.0, 179.0, 150.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 172.0, 196.0, 238.0, 214.0, 171.0, 237.0, 183.0, 171.0], "value": 192.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 82.0, 88.0, 90.0, 85.0, 68.0, 70.0, 80.0], "value": 77.1, "unit": "score"}], "name": "kraken", "value": 1471.3999999999999, "alertThreshold": 2.0}]} 21:55:56 INFO - Return code: 0 21:55:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:56 INFO - # TBPL SUCCESS # 21:55:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:55:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:55:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:55:56 INFO - 2016-10-07 21:55:56.508 screenresolution[1670:9699] starting screenresolution argv=screenresolution get 21:55:56 INFO - 2016-10-07 21:55:56.512 screenresolution[1670:9699] Display 0: 1600x1200x32@60 21:55:56 INFO - 2016-10-07 21:55:56.518 screenresolution[1671:9702] starting screenresolution argv=screenresolution list 21:55:56 INFO - Available Modes on Display 0 21:55:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:55:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:55:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:55:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:55:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:55:56 INFO - Intel Iris: 21:55:56 INFO - Chipset Model: Intel Iris 21:55:56 INFO - Type: GPU 21:55:56 INFO - Bus: Built-In 21:55:56 INFO - VRAM (Dynamic, Max): 1536 MB 21:55:56 INFO - Vendor: Intel (0x8086) 21:55:56 INFO - Device ID: 0x0a2e 21:55:56 INFO - Revision ID: 0x0009 21:55:56 INFO - Displays: 21:55:56 INFO - Display: 21:55:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:55:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:55:56 INFO - Display Serial Number: 1600x1200 60 21:55:56 INFO - Main Display: Yes 21:55:56 INFO - Mirror: Off 21:55:56 INFO - Online: Yes 21:55:56 INFO - Rotation: Supported 21:55:56 INFO - Return code: 0 21:55:56 INFO - Running post-action listener: _resource_record_post_action 21:55:56 INFO - [mozharness: 2016-10-08 04:55:56.766143Z] Finished run-tests step (success) 21:55:56 INFO - Running post-run listener: _resource_record_post_run 21:55:56 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37426176; Write bytes: 707204608; Read time: 242; Write time: 1979 21:55:56 INFO - TinderboxPrint: CPU usage
53.5% 21:55:56 INFO - TinderboxPrint: I/O read bytes / time
37,426,176 / 242 21:55:56 INFO - TinderboxPrint: I/O write bytes / time
707,204,608 / 1,979 21:55:56 INFO - TinderboxPrint: CPU idle
2,259.1 (46.5%) 21:55:56 INFO - TinderboxPrint: CPU system
966.6 (19.9%) 21:55:56 INFO - TinderboxPrint: CPU user
1,628.0 (33.5%) 21:55:56 INFO - TinderboxPrint: Swap in / out
445,136,896 / 0 21:55:56 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398361088; Write bytes: 393271296; Read time: 29539; Write time: 823 21:55:56 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35386368; Write bytes: 294944256; Read time: 221; Write time: 1104 21:55:57 INFO - Running post-run listener: _upload_blobber_files 21:55:57 INFO - Blob upload gear active. 21:55:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:57 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 21:55:57 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:55:57 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:55:57 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:55:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:55:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:58 INFO - (blobuploader) - INFO - Done attempting. 21:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:59 INFO - (blobuploader) - INFO - Done attempting. 21:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:56:03 INFO - (blobuploader) - INFO - Done attempting. 21:56:03 INFO - (blobuploader) - INFO - Iteration through files over. 21:56:03 INFO - Return code: 0 21:56:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:56:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:56:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1a3c1c83d01f551cc69cea88adf5a54d64cdbc61047005d9b57121bdd241256f2fec18e8ac9bd7649830638fd14eadc9af93efcd7ffc685f0a3939d1251be79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbc6ab42a20a869c5eee0fee55b391055864cd0ba997cca137b10658be7623a4aac489211eb43455f9b0480aa4480286edeb4e332185cbd0fded2a81bf1699e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3c08932e5fd18ce0c5ab9323a4a53a3caf0f376c737c7f5b974e1af47938bffe5cd6148b958544f370b3537acbc55315665f0a6610f8a7cc0bad61b01a3f333"} 21:56:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:56:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:56:03 INFO - Contents: 21:56:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1a3c1c83d01f551cc69cea88adf5a54d64cdbc61047005d9b57121bdd241256f2fec18e8ac9bd7649830638fd14eadc9af93efcd7ffc685f0a3939d1251be79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbc6ab42a20a869c5eee0fee55b391055864cd0ba997cca137b10658be7623a4aac489211eb43455f9b0480aa4480286edeb4e332185cbd0fded2a81bf1699e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3c08932e5fd18ce0c5ab9323a4a53a3caf0f376c737c7f5b974e1af47938bffe5cd6148b958544f370b3537acbc55315665f0a6610f8a7cc0bad61b01a3f333"} 21:56:03 INFO - Running post-run listener: copy_logs_to_upload_dir 21:56:03 INFO - Copying logs to upload dir... 21:56:03 INFO - mkdir: /builds/slave/test/build/upload/logs 21:56:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.010873 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-07 21:56:03.297413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:03.300999) ========= 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.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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/Firefox/sha512/d1a3c1c83d01f551cc69cea88adf5a54d64cdbc61047005d9b57121bdd241256f2fec18e8ac9bd7649830638fd14eadc9af93efcd7ffc685f0a3939d1251be79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbc6ab42a20a869c5eee0fee55b391055864cd0ba997cca137b10658be7623a4aac489211eb43455f9b0480aa4480286edeb4e332185cbd0fded2a81bf1699e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3c08932e5fd18ce0c5ab9323a4a53a3caf0f376c737c7f5b974e1af47938bffe5cd6148b958544f370b3537acbc55315665f0a6610f8a7cc0bad61b01a3f333"} build_url:https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/JFpw5nIMRACrlkV1TW6hHQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1a3c1c83d01f551cc69cea88adf5a54d64cdbc61047005d9b57121bdd241256f2fec18e8ac9bd7649830638fd14eadc9af93efcd7ffc685f0a3939d1251be79", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bcbc6ab42a20a869c5eee0fee55b391055864cd0ba997cca137b10658be7623a4aac489211eb43455f9b0480aa4480286edeb4e332185cbd0fded2a81bf1699e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3c08932e5fd18ce0c5ab9323a4a53a3caf0f376c737c7f5b974e1af47938bffe5cd6148b958544f370b3537acbc55315665f0a6610f8a7cc0bad61b01a3f333"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:03.334033) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:03.334364) ========= 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.SCIwaYaive/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.MCSE6cUpEt/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005041 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 21:56:03.382783) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:03.383134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 21:56:03.383455) ========= ========= Total master_lag: 0.18 =========