builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0207 starttime: 1477391625.89 results: success (0) buildid: 20161025012904 builduid: 4bf305d491394a0c81fc7e5003bbe50b revision: d127e99b446edf3e4cf3541d51abedaa08b9a3d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:45.887154) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:45.887603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:45.887899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:45.918099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:45.918483) ========= 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.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-25 03:33:45-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-10-25 03:33:46 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:46.064743) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:46.065066) ========= 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.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.026770 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:46.116467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:33:46.119917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d127e99b446edf3e4cf3541d51abedaa08b9a3d7 --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 d127e99b446edf3e4cf3541d51abedaa08b9a3d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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-25 03:33:46,199 truncating revision to first 12 chars 2016-10-25 03:33:46,199 Setting DEBUG logging. 2016-10-25 03:33:46,199 attempt 1/10 2016-10-25 03:33:46,199 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d127e99b446e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 03:33:47,698 unpacking tar archive at: mozilla-central-d127e99b446e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.767007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 03:33:47.907575) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:47.911012) ========= script_repo_revision: d127e99b446edf3e4cf3541d51abedaa08b9a3d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:47.911457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:47.911735) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 03:33:47.930571) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-25 03:33:47.930979) ========= /tools/buildbot/bin/python -u 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', '-u', '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:33:48 INFO - MultiFileLogger online at 20161025 03:33:48 in /builds/slave/test 03:33: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 03:33:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:48 INFO - {'append_to_log': False, 03:33:48 INFO - 'base_work_dir': '/builds/slave/test', 03:33:48 INFO - 'blob_upload_branch': 'Firefox', 03:33:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:48 INFO - 'branch': 'Firefox', 03:33:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:48 INFO - 'config_files': ('talos/mac_config.py',), 03:33:48 INFO - 'default_actions': ('clobber', 03:33:48 INFO - 'read-buildbot-config', 03:33:48 INFO - 'download-and-extract', 03:33:48 INFO - 'populate-webroot', 03:33:48 INFO - 'create-virtualenv', 03:33:48 INFO - 'install', 03:33:48 INFO - 'run-tests'), 03:33:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:48 INFO - 'download_minidump_stackwalk': True, 03:33:48 INFO - 'download_symbols': 'ondemand', 03:33:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:33:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:33:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:33:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:33:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:48 INFO - 'installer_path': 'installer.exe', 03:33:48 INFO - 'log_level': 'info', 03:33:48 INFO - 'log_name': 'talos', 03:33:48 INFO - 'log_to_console': True, 03:33:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:33:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:33:48 INFO - 'opt_config_files': (), 03:33:48 INFO - 'pip_index': False, 03:33:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:33:48 INFO - 'cmd': ('bash', 03:33:48 INFO - '-c', 03:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:33:48 INFO - 'enabled': True, 03:33:48 INFO - 'halt_on_failure': False, 03:33:48 INFO - 'name': 'check_screen_resolution'},), 03:33:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:33:48 INFO - 'cmd': ('bash', 03:33:48 INFO - '-c', 03:33:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:33:48 INFO - 'enabled': True, 03:33:48 INFO - 'halt_on_failure': False, 03:33:48 INFO - 'name': 'check_screen_resolution'},), 03:33:48 INFO - 'run_cmd_checks_enabled': True, 03:33:48 INFO - 'sps_profile': False, 03:33:48 INFO - 'sps_profile_interval': 0, 03:33:48 INFO - 'suite': 'dromaeojs', 03:33:48 INFO - 'system_bits': '32', 03:33:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:48 INFO - 'title': 't-yosemite-r7-0207', 03:33:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:48 INFO - 'use_talos_json': True, 03:33:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:48 INFO - 'work_dir': 'build'} 03:33:48 INFO - [mozharness: 2016-10-25 10:33:48.132730Z] Running clobber step. 03:33:48 INFO - Running pre-action listener: _resource_record_pre_action 03:33:48 INFO - Running main action method: clobber 03:33:48 INFO - rmtree: /builds/slave/test/build 03:33:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:49 INFO - Running post-action listener: _resource_record_post_action 03:33:49 INFO - [mozharness: 2016-10-25 10:33:49.488942Z] Finished clobber step (success) 03:33:49 INFO - [mozharness: 2016-10-25 10:33:49.489080Z] Running read-buildbot-config step. 03:33:49 INFO - Running pre-action listener: _resource_record_pre_action 03:33:49 INFO - Running main action method: read_buildbot_config 03:33:49 INFO - Using buildbot properties: 03:33:49 INFO - { 03:33:49 INFO - "project": "", 03:33:49 INFO - "product": "firefox", 03:33:49 INFO - "script_repo_revision": "production", 03:33:49 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:33:49 INFO - "repository": "", 03:33:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:33:49 INFO - "buildid": "20161025012904", 03:33:49 INFO - "pgo_build": "False", 03:33:49 INFO - "basedir": "/builds/slave/test", 03:33:49 INFO - "buildnumber": 11, 03:33:49 INFO - "slavename": "t-yosemite-r7-0207", 03:33:49 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:33:49 INFO - "platform": "yosemite_r7", 03:33:49 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:33:49 INFO - "branch": "mozilla-central", 03:33:49 INFO - "repo_path": "mozilla-central", 03:33:49 INFO - "revision": "d127e99b446edf3e4cf3541d51abedaa08b9a3d7", 03:33:49 INFO - "stage_platform": "macosx64", 03:33:49 INFO - "builduid": "4bf305d491394a0c81fc7e5003bbe50b", 03:33:49 INFO - "slavebuilddir": "test" 03:33:49 INFO - } 03:33:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:33:49 INFO - Running post-action listener: _resource_record_post_action 03:33:49 INFO - [mozharness: 2016-10-25 10:33:49.492403Z] Finished read-buildbot-config step (success) 03:33:49 INFO - [mozharness: 2016-10-25 10:33:49.492518Z] Running download-and-extract step. 03:33:49 INFO - Running pre-action listener: _resource_record_pre_action 03:33:49 INFO - Running main action method: download_and_extract 03:33:49 INFO - mkdir: /builds/slave/test/build/tests 03:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:49 INFO - trying https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/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 03:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/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 03:33:50 INFO - Downloaded 1199 bytes. 03:33:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:33:50 INFO - Using the following test package requirements: 03:33:50 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:33:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:33:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:33:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'jsshell-mac.zip'], 03:33:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:33:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:33:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:33:50 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:33:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:33:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:33:50 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:33:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:33:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:33:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:33:50 INFO - Fetch https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:33:51 INFO - Http code: 200 03:33:51 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 03:33:51 INFO - x-amz-cf-id: 0_UPYFQlooo_537C5XNj-6vk6Y8YnhtdBL23f2GXLveNVxyXW0VnIA== 03:33:51 INFO - x-amz-version-id: 5rAzRqzD3EM7Szc9X0LYyG1NxMQk8Nop 03:33:51 INFO - Expected file size: 16409406 03:33:51 INFO - Obtained file size: 16409406 03:33:57 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 03:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:33:58 INFO - Http code: 200 03:33:58 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 03:33:58 INFO - x-amz-cf-id: LH9l2hxbPFKf_EeqbW5MYcR5yMCJWp8-v1UBCg_YFMqni0S4Ofvm3g== 03:33:58 INFO - x-amz-version-id: 5rAzRqzD3EM7Szc9X0LYyG1NxMQk8Nop 03:33:58 INFO - Expected file size: 16409406 03:33:58 INFO - Obtained file size: 16409406 03:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:34:06 INFO - Http code: 200 03:34:06 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 03:34:06 INFO - x-amz-cf-id: HuPYiLOFMhaCfTiuSqf9KMtGUxLG2WqgXuY0SP37C_YJMxVGNM19DA== 03:34:06 INFO - x-amz-version-id: dvJD6UZ6hPqHRXKJld53nwq6TNcLNhQv 03:34:06 INFO - Expected file size: 14409028 03:34:06 INFO - Obtained file size: 14409028 03:34:06 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')]} 03:34:06 INFO - trying https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:34:06 INFO - Downloading https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:34:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/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 03:34:09 INFO - Downloaded 111261240 bytes. 03:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:34:09 INFO - mkdir: /builds/slave/test/properties 03:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:34:09 INFO - Contents: 03:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:34:10 INFO - Running post-action listener: _resource_record_post_action 03:34:10 INFO - Running post-action listener: set_extra_try_arguments 03:34:10 INFO - [mozharness: 2016-10-25 10:34:10.705967Z] Finished download-and-extract step (success) 03:34:10 INFO - [mozharness: 2016-10-25 10:34:10.706127Z] Running populate-webroot step. 03:34:10 INFO - Running pre-action listener: _resource_record_pre_action 03:34:10 INFO - Running main action method: populate_webroot 03:34:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:34:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:34:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:34:10 INFO - '--tppagecycles', 03:34:10 INFO - '7'], 03:34:10 INFO - 'tests': ['tsvgm']}}, 03:34:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:34:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:34:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:34:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:34:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:34:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['damp', 'tps']}, 03:34:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'tests': ['damp', 'tps']}, 03:34:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['dromaeo_dom']}, 03:34:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:34:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['basic_compositor_video']}, 03:34:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:34:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['a11yr', 03:34:10 INFO - 'ts_paint', 03:34:10 INFO - 'tpaint', 03:34:10 INFO - 'sessionrestore', 03:34:10 INFO - 'sessionrestore_no_auto_restore', 03:34:10 INFO - 'tabpaint']}, 03:34:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['tsvgx', 03:34:10 INFO - 'tsvgr_opacity', 03:34:10 INFO - 'tart', 03:34:10 INFO - 'tscrollx', 03:34:10 INFO - 'cart']}, 03:34:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:34:10 INFO - 'tsvgr_opacity', 03:34:10 INFO - 'tart', 03:34:10 INFO - 'tscrollx', 03:34:10 INFO - 'cart']}, 03:34:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'talos_options': ['--disable-e10s'], 03:34:10 INFO - 'tests': ['tp5o']}, 03:34:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'tests': ['tp5o']}, 03:34:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'talos_options': ['--disable-e10s', 03:34:10 INFO - '--xperf_path', 03:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:10 INFO - 'tests': ['tp5n']}, 03:34:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:34:10 INFO - 'talos_options': ['--xperf_path', 03:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:34:10 INFO - 'tests': ['tp5n']}}, 03:34:10 INFO - 'talos.zip': {'path': '', 03:34:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:34:10 INFO - Running post-action listener: _resource_record_post_action 03:34:10 INFO - [mozharness: 2016-10-25 10:34:10.725890Z] Finished populate-webroot step (success) 03:34:10 INFO - [mozharness: 2016-10-25 10:34:10.726019Z] Running create-virtualenv step. 03:34:10 INFO - Running pre-action listener: _resource_record_pre_action 03:34:10 INFO - Running main action method: create_virtualenv 03:34:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:34:10 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 03:34:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:34:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:34:10 INFO - Using real prefix '/tools/python27' 03:34:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:34:11 INFO - Installing distribute.............................................................................................................................................................................................done. 03:34:14 INFO - Installing pip.................done. 03:34:14 INFO - Return code: 0 03:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:34:14 INFO - Reading from file tmpfile_stdout 03:34:14 INFO - Output received: 03:34:14 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) 03:34:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:34:14 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')]} 03:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:14 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')]} 03:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:14 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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34:14 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 03:34:14 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 03:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:14 INFO - 'HOME': '/Users/cltbld', 03:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:14 INFO - 'LOGNAME': 'cltbld', 03:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:14 INFO - 'MOZ_NO_REMOTE': '1', 03:34:14 INFO - 'NO_EM_RESTART': '1', 03:34:14 INFO - 'PAGER': '/bin/cat', 03:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:14 INFO - 'PWD': '/builds/slave/test', 03:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:14 INFO - 'SHELL': '/bin/bash', 03:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:14 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:14 INFO - 'USER': 'cltbld', 03:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:14 INFO - 'XPC_FLAGS': '0x0', 03:34:14 INFO - 'XPC_SERVICE_NAME': '0', 03:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34: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 03:34:15 INFO - Cleaning up... 03:34:15 INFO - Return code: 0 03:34:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:15 INFO - 'HOME': '/Users/cltbld', 03:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:15 INFO - 'LOGNAME': 'cltbld', 03:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:15 INFO - 'MOZ_NO_REMOTE': '1', 03:34:15 INFO - 'NO_EM_RESTART': '1', 03:34:15 INFO - 'PAGER': '/bin/cat', 03:34:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:15 INFO - 'PWD': '/builds/slave/test', 03:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:15 INFO - 'SHELL': '/bin/bash', 03:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:15 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:15 INFO - 'USER': 'cltbld', 03:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:15 INFO - 'XPC_FLAGS': '0x0', 03:34:15 INFO - 'XPC_SERVICE_NAME': '0', 03:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:15 INFO - Downloading/unpacking psutil>=3.1.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:34:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:18 INFO - Installing collected packages: psutil 03:34:18 INFO - Running setup.py install for psutil 03:34:19 INFO - building 'psutil._psutil_osx' extension 03:34: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 03:34: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 03:34: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 03:34: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 03:34:19 INFO - building 'psutil._psutil_posix' extension 03:34:19 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 03:34:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:34:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:34:19 INFO - ^ 03:34:19 INFO - 1 warning generated. 03:34:19 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 03:34:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:34:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:34:20 INFO - Successfully installed psutil 03:34:20 INFO - Cleaning up... 03:34:20 INFO - Return code: 0 03:34:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:20 INFO - 'HOME': '/Users/cltbld', 03:34:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:20 INFO - 'LOGNAME': 'cltbld', 03:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:20 INFO - 'MOZ_NO_REMOTE': '1', 03:34:20 INFO - 'NO_EM_RESTART': '1', 03:34:20 INFO - 'PAGER': '/bin/cat', 03:34:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:20 INFO - 'PWD': '/builds/slave/test', 03:34:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:20 INFO - 'SHELL': '/bin/bash', 03:34:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:20 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:20 INFO - 'USER': 'cltbld', 03:34:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:20 INFO - 'XPC_FLAGS': '0x0', 03:34:20 INFO - 'XPC_SERVICE_NAME': '0', 03:34:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:34:23 INFO - Installing collected packages: mozsystemmonitor 03:34:23 INFO - Running setup.py install for mozsystemmonitor 03:34:23 INFO - Successfully installed mozsystemmonitor 03:34:23 INFO - Cleaning up... 03:34:23 INFO - Return code: 0 03:34:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:23 INFO - 'HOME': '/Users/cltbld', 03:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:23 INFO - 'LOGNAME': 'cltbld', 03:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:23 INFO - 'MOZ_NO_REMOTE': '1', 03:34:23 INFO - 'NO_EM_RESTART': '1', 03:34:23 INFO - 'PAGER': '/bin/cat', 03:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:23 INFO - 'PWD': '/builds/slave/test', 03:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:23 INFO - 'SHELL': '/bin/bash', 03:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:23 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:23 INFO - 'USER': 'cltbld', 03:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:23 INFO - 'XPC_FLAGS': '0x0', 03:34:23 INFO - 'XPC_SERVICE_NAME': '0', 03:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:23 INFO - Downloading/unpacking jsonschema==2.5.1 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:34:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:34:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:34:26 INFO - warning: no files found matching '*.txt' 03:34:26 INFO - no previously-included directories found matching 'build' 03:34:26 INFO - no previously-included directories found matching 'dist' 03:34:26 INFO - no previously-included directories found matching '.git*' 03:34:26 INFO - Installing collected packages: jsonschema, functools32 03:34:26 INFO - Running setup.py install for functools32 03:34:26 INFO - warning: no files found matching '*.txt' 03:34:26 INFO - no previously-included directories found matching 'build' 03:34:26 INFO - no previously-included directories found matching 'dist' 03:34:26 INFO - no previously-included directories found matching '.git*' 03:34:26 INFO - Successfully installed jsonschema functools32 03:34:26 INFO - Cleaning up... 03:34:26 INFO - Return code: 0 03:34:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:26 INFO - 'HOME': '/Users/cltbld', 03:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:26 INFO - 'LOGNAME': 'cltbld', 03:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:26 INFO - 'MOZ_NO_REMOTE': '1', 03:34:26 INFO - 'NO_EM_RESTART': '1', 03:34:26 INFO - 'PAGER': '/bin/cat', 03:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:26 INFO - 'PWD': '/builds/slave/test', 03:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:26 INFO - 'SHELL': '/bin/bash', 03:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:26 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:26 INFO - 'USER': 'cltbld', 03:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:26 INFO - 'XPC_FLAGS': '0x0', 03:34:26 INFO - 'XPC_SERVICE_NAME': '0', 03:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:34:27 INFO - Cleaning up... 03:34:27 INFO - Return code: 0 03:34:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:27 INFO - 'HOME': '/Users/cltbld', 03:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:27 INFO - 'LOGNAME': 'cltbld', 03:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:27 INFO - 'MOZ_NO_REMOTE': '1', 03:34:27 INFO - 'NO_EM_RESTART': '1', 03:34:27 INFO - 'PAGER': '/bin/cat', 03:34:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:27 INFO - 'PWD': '/builds/slave/test', 03:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:27 INFO - 'SHELL': '/bin/bash', 03:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:27 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:27 INFO - 'USER': 'cltbld', 03:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:27 INFO - 'XPC_FLAGS': '0x0', 03:34:27 INFO - 'XPC_SERVICE_NAME': '0', 03:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:27 INFO - Downloading/unpacking blobuploader==1.2.4 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:29 INFO - Downloading blobuploader-1.2.4.tar.gz 03:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:34:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:34:29 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 03:34:29 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 03:34:29 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 03:34:29 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 03:34:29 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 03:34:29 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 03:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:34:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:31 INFO - Downloading docopt-0.6.1.tar.gz 03:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:34:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:34:31 INFO - Running setup.py install for blobuploader 03:34:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:34:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:34:31 INFO - Running setup.py install for requests 03:34:31 INFO - Running setup.py install for docopt 03:34:31 INFO - Successfully installed blobuploader requests docopt 03:34:31 INFO - Cleaning up... 03:34:32 INFO - Return code: 0 03:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:32 INFO - 'HOME': '/Users/cltbld', 03:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:32 INFO - 'LOGNAME': 'cltbld', 03:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:32 INFO - 'MOZ_NO_REMOTE': '1', 03:34:32 INFO - 'NO_EM_RESTART': '1', 03:34:32 INFO - 'PAGER': '/bin/cat', 03:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:32 INFO - 'PWD': '/builds/slave/test', 03:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:32 INFO - 'SHELL': '/bin/bash', 03:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:32 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:32 INFO - 'USER': 'cltbld', 03:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:32 INFO - 'XPC_FLAGS': '0x0', 03:34:32 INFO - 'XPC_SERVICE_NAME': '0', 03:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_TUxEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-MxmlkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-F248EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-fWVbD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Uvb2N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-cyxIDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:32 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-righbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-CXhtDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-uI7Juc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-1VgXSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-RPn4ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-Mm1nQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wydjnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-kKloxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-gsQYLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:33 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-05Jask-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:34 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-1IAMmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:34:34 INFO - Running setup.py install for manifestparser 03:34:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:34:34 INFO - Running setup.py install for mozcrash 03:34:34 INFO - Running setup.py install for mozdebug 03:34:34 INFO - Running setup.py install for mozdevice 03:34:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:34:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:34:34 INFO - Running setup.py install for mozfile 03:34:34 INFO - Running setup.py install for mozhttpd 03:34:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:34:34 INFO - Running setup.py install for mozinfo 03:34:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Running setup.py install for mozInstall 03:34:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Running setup.py install for mozleak 03:34:35 INFO - Running setup.py install for mozlog 03:34:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Running setup.py install for moznetwork 03:34:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:34:35 INFO - Running setup.py install for mozprocess 03:34:35 INFO - Running setup.py install for mozprofile 03:34:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:34:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:34:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:34:36 INFO - Running setup.py install for mozrunner 03:34:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:34:36 INFO - Running setup.py install for mozscreenshot 03:34:36 INFO - Running setup.py install for moztest 03:34:36 INFO - Running setup.py install for mozversion 03:34:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:34:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:34:36 INFO - Cleaning up... 03:34:36 INFO - Return code: 0 03:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:36 INFO - 'HOME': '/Users/cltbld', 03:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:36 INFO - 'LOGNAME': 'cltbld', 03:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:36 INFO - 'MOZ_NO_REMOTE': '1', 03:34:36 INFO - 'NO_EM_RESTART': '1', 03:34:36 INFO - 'PAGER': '/bin/cat', 03:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:36 INFO - 'PWD': '/builds/slave/test', 03:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:36 INFO - 'SHELL': '/bin/bash', 03:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:36 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:36 INFO - 'USER': 'cltbld', 03:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:36 INFO - 'XPC_FLAGS': '0x0', 03:34:36 INFO - 'XPC_SERVICE_NAME': '0', 03:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:34:36 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-F89LHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-eK6cq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-CU74dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-n7fr1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-O0mcfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-OTHb4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-6UBCJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-DhrfNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:34: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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-_vRQQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:34:37 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)) 03:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:34:37 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-YfsBol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-rMcwIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-wb2LO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-gHGAcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-ky6mid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-AHpzPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-LOzgu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:34: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)) 03:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:34:38 INFO - Running setup.py (path:/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/pip-91UUIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34: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 03:34:41 INFO - Downloading blessings-1.6.tar.gz 03:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:34:41 INFO - Installing collected packages: blessings 03:34:41 INFO - Running setup.py install for blessings 03:34:41 INFO - Successfully installed blessings 03:34:41 INFO - Cleaning up... 03:34:41 INFO - Return code: 0 03:34:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:41 INFO - Reading from file tmpfile_stdout 03:34:41 INFO - Current package versions: 03:34:41 INFO - blessings == 1.6 03:34:41 INFO - blobuploader == 1.2.4 03:34:41 INFO - docopt == 0.6.1 03:34:41 INFO - functools32 == 3.2.3-2 03:34:41 INFO - jsonschema == 2.5.1 03:34:41 INFO - manifestparser == 1.1 03:34:41 INFO - mozInstall == 1.12 03:34:41 INFO - mozcrash == 0.17 03:34:41 INFO - mozdebug == 0.1 03:34:41 INFO - mozdevice == 0.48 03:34:41 INFO - mozfile == 1.2 03:34:41 INFO - mozhttpd == 0.7 03:34:41 INFO - mozinfo == 0.9 03:34:41 INFO - mozleak == 0.1 03:34:41 INFO - mozlog == 3.4 03:34:41 INFO - moznetwork == 0.27 03:34:41 INFO - mozprocess == 0.23 03:34:41 INFO - mozprofile == 0.28 03:34:41 INFO - mozrunner == 6.12 03:34:41 INFO - mozscreenshot == 0.1 03:34:41 INFO - mozsystemmonitor == 0.3 03:34:41 INFO - moztest == 0.7 03:34:41 INFO - mozversion == 1.4 03:34:41 INFO - psutil == 3.1.1 03:34:41 INFO - requests == 1.2.3 03:34:41 INFO - wsgiref == 0.1.2 03:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34: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 03:34: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 03:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:42 INFO - 'HOME': '/Users/cltbld', 03:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:42 INFO - 'LOGNAME': 'cltbld', 03:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:42 INFO - 'MOZ_NO_REMOTE': '1', 03:34:42 INFO - 'NO_EM_RESTART': '1', 03:34:42 INFO - 'PAGER': '/bin/cat', 03:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:42 INFO - 'PWD': '/builds/slave/test', 03:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:42 INFO - 'SHELL': '/bin/bash', 03:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:42 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:42 INFO - 'USER': 'cltbld', 03:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:42 INFO - 'XPC_FLAGS': '0x0', 03:34:42 INFO - 'XPC_SERVICE_NAME': '0', 03:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34: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)) 03:34:42 INFO - Cleaning up... 03:34:42 INFO - Return code: 0 03:34:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:34: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')]} 03:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34: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')]} 03:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:34:43 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 0x107c95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c0b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a98c5f3e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, '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.xVfDEXLOux/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.MX3dsJqdwI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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 03:34:43 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 03:34:43 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 03:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:34:43 INFO - 'HOME': '/Users/cltbld', 03:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:34:43 INFO - 'LOGNAME': 'cltbld', 03:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:43 INFO - 'MOZ_NO_REMOTE': '1', 03:34:43 INFO - 'NO_EM_RESTART': '1', 03:34:43 INFO - 'PAGER': '/bin/cat', 03:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:43 INFO - 'PWD': '/builds/slave/test', 03:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:34:43 INFO - 'SHELL': '/bin/bash', 03:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:34:43 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:34:43 INFO - 'USER': 'cltbld', 03:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:43 INFO - 'XPC_FLAGS': '0x0', 03:34:43 INFO - 'XPC_SERVICE_NAME': '0', 03:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:34:43 INFO - Cleaning up... 03:34:43 INFO - Return code: 0 03:34:43 INFO - Running post-action listener: _resource_record_post_action 03:34:43 INFO - Running post-action listener: _start_resource_monitoring 03:34:43 INFO - Starting resource monitoring. 03:34:43 INFO - [mozharness: 2016-10-25 10:34:43.657884Z] Finished create-virtualenv step (success) 03:34:43 INFO - [mozharness: 2016-10-25 10:34:43.658829Z] Running install step. 03:34:43 INFO - Running pre-action listener: _resource_record_pre_action 03:34:43 INFO - Running main action method: install 03:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:34:43 INFO - Reading from file tmpfile_stdout 03:34:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:34:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:34:44 INFO - Reading from file tmpfile_stdout 03:34:44 INFO - Output received: 03:34:44 INFO - Usage: mozinstall [options] installer 03:34:44 INFO - Options: 03:34:44 INFO - -h, --help show this help message and exit 03:34:44 INFO - -d DEST, --destination=DEST 03:34:44 INFO - Directory to install application into. [default: 03:34:44 INFO - "/builds/slave/test"] 03:34:44 INFO - --app=APP Application being installed. [default: firefox] 03:34:44 INFO - mkdir: /builds/slave/test/build/application 03:34:44 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'] 03:34:44 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 03:35:18 INFO - Reading from file tmpfile_stdout 03:35:18 INFO - Output received: 03:35:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:35:18 INFO - Running post-action listener: _resource_record_post_action 03:35:18 INFO - [mozharness: 2016-10-25 10:35:18.439442Z] Finished install step (success) 03:35:18 INFO - [mozharness: 2016-10-25 10:35:18.439576Z] Running run-tests step. 03:35:18 INFO - Running pre-action listener: _resource_record_pre_action 03:35:18 INFO - Running main action method: run_tests 03:35:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:35:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:35:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:35:18 INFO - 2016-10-25 03:35:18.454 screenresolution[1668:7600] starting screenresolution argv=screenresolution get 03:35:18 INFO - 2016-10-25 03:35:18.456 screenresolution[1668:7600] Display 0: 1600x1200x32@60 03:35:18 INFO - 2016-10-25 03:35:18.462 screenresolution[1669:7602] starting screenresolution argv=screenresolution list 03:35:18 INFO - Available Modes on Display 0 03:35:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:35:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:35:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:35:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:35:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:35:18 INFO - Intel Iris: 03:35:18 INFO - Chipset Model: Intel Iris 03:35:18 INFO - Type: GPU 03:35:18 INFO - Bus: Built-In 03:35:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:35:18 INFO - Vendor: Intel (0x8086) 03:35:18 INFO - Device ID: 0x0a2e 03:35:18 INFO - Revision ID: 0x0009 03:35:18 INFO - Displays: 03:35:18 INFO - Display: 03:35:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:35:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:35:18 INFO - Display Serial Number: 1600x1200 60 03:35:18 INFO - Main Display: Yes 03:35:18 INFO - Mirror: Off 03:35:18 INFO - Online: Yes 03:35:18 INFO - Rotation: Supported 03:35:18 INFO - Return code: 0 03:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:35:18 INFO - Python 2.7.3 03:35:18 INFO - Return code: 0 03:35:18 INFO - grabbing minidump binary from tooltool 03:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:18 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 0x107aa9d30>, '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 0x1078cfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107aa1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:35:18 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 03:35:18 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 03:35:18 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 03:35:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:35:18 INFO - Return code: 0 03:35:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:35:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:35:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:35:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:35:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:35:18 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/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 03:35:18 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/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0207 --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 03:35:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xVfDEXLOux/Render', 03:35:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:35:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:35:18 INFO - 'HOME': '/Users/cltbld', 03:35:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:35:18 INFO - 'LOGNAME': 'cltbld', 03:35:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:35:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:35:18 INFO - 'MOZ_NO_REMOTE': '1', 03:35:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:35:18 INFO - 'NO_EM_RESTART': '1', 03:35:18 INFO - 'PAGER': '/bin/cat', 03:35:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:35:18 INFO - 'PWD': '/builds/slave/test', 03:35:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:35:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:35:18 INFO - 'SHELL': '/bin/bash', 03:35:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MX3dsJqdwI/Listeners', 03:35:18 INFO - 'TMPDIR': '/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/', 03:35:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:35:18 INFO - 'USER': 'cltbld', 03:35:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:35:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:35:18 INFO - 'XPC_FLAGS': '0x0', 03:35:18 INFO - 'XPC_SERVICE_NAME': '0', 03:35:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:35:18 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/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0207', '--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 03:35:19 INFO - mozversion application_buildid: 20161025012904 03:35:19 INFO - mozversion application_changeset: d127e99b446edf3e4cf3541d51abedaa08b9a3d7 03:35:19 INFO - mozversion application_display_name: Nightly 03:35:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:35:19 INFO - mozversion application_name: Firefox 03:35:19 INFO - mozversion application_remotingname: firefox 03:35:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:35:19 INFO - mozversion application_vendor: Mozilla 03:35:19 INFO - mozversion application_version: 52.0a1 03:35:19 INFO - mozversion platform_buildid: 20161025012904 03:35:19 INFO - mozversion platform_changeset: d127e99b446edf3e4cf3541d51abedaa08b9a3d7 03:35:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:35:19 INFO - mozversion platform_version: 52.0a1 03:35:19 INFO - using testdate: 1477391719 03:35:19 INFO - actual date: 1477391719 03:35:19 INFO - starting webserver on 'localhost:49277' 03:35:19 INFO - SUITE-START | Running 2 tests 03:35:19 INFO - TEST-START | dromaeo_css 03:35:19 INFO - operating with platform_type : mac_ 03:35:19 INFO - Initialising browser for dromaeo_css test... 03:35:19 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpz2SJmj/profile http://localhost:49277/getInfo.html) 03:35:21 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 03:35:21 INFO - PROCESS | 1679 | colorDepth:24 03:35:21 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 03:35:21 INFO - PROCESS | 1679 | __metrics 03:35:21 INFO - PROCESS | 1679 | 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" 03:35:21 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:35:22 INFO - TEST-INFO | 1679: exit 0 03:35:22 INFO - Browser initialized. 03:35:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:35:22 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpz2SJmj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:35:34 INFO - PROCESS | 1681 | RSS: Main: 230334464 03:35:34 INFO - PROCESS | 1681 | 03:36:25 INFO - PROCESS | 1681 | 1477391785689 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] 03:38:37 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 03:38:41 INFO - PROCESS | 1681 | RSS: Main: 526311424 03:38:41 INFO - PROCESS | 1681 | 03:41:44 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 03:41:44 INFO - PROCESS | 1681 | RSS: Main: 374206464 03:41:44 INFO - PROCESS | 1681 | 03:44:47 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 03:44:47 INFO - PROCESS | 1681 | RSS: Main: 341708800 03:44:47 INFO - PROCESS | 1681 | 03:47:50 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 03:47:50 INFO - PROCESS | 1681 | RSS: Main: 342974464 03:47:50 INFO - PROCESS | 1681 | 03:50:54 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 03:50:54 INFO - PROCESS | 1681 | RSS: Main: 331272192 03:50:54 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 03:53:58 INFO - PROCESS | 1681 | RSS: Main: 404881408 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | __start_tp_report 03:53:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 03:53:58 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 03:53:58 INFO - PROCESS | 1681 | |i|pagename|runs| 03:53:58 INFO - PROCESS | 1681 | |0;dojo.html;2681.9597706034415;3287.1617737476954;3296.8846090386833;3325.36818004579;3349.313390754894;5491.2312276281355;5548.084566046603;5618.634788738735;5632.295963004624;5641.802536911209;5574.832755017346;5591.944080559193;5599.972000139994;5610.579206559514;5620.4098569650105;5073.949260507394;5118.795248190068;5123.2827404163445;5152.69083854968;5216.113260745682;5120.283160357553;5174.120399532088;5191.143461328895;5210.55710264626;5217.399999000126;5093.363329583802;5154.561862241714;5164;5170.405403378622;5180.481951804808;5183.818566350178;5209.270702101709;5213.843584692465;5216.165413533817;5274.129768588178;5025.924611130836;5028.949710502921;5120.231965205212;5128.9230661540105;5149.30484384607;5490.286262785852;5514.944850551524;5523.944760552383;5557.249771280906;5571.777128914879;6117.541184411142;6122.846928826815;6123.663198524079;6177.876442471171;6181.96909015452;6048.243969503812;6190.659513726743;6202.565820392574;6204;6217.502599792051;5589.301337332833;5618.747156377973;5622.718864056781;5627.071533197059;5671.489565939003;6212.571108645037;6235.127082208494;6241.438270555581;6254.280757712831;6269.216347956505;6007.489363404072;6020.157177995085;6026.728797204137;6028.246469191351;6072.757089716361;6048.395160484004;6091;6121.632702037892;6121.940772762995;6131.14164017038;5992.43071908168;6077.392260773976;6100.1270446244;6103.524360426982;6150.907736383958;6121.418465245794;6173.753049878044;6179.3820617937845;6191.226096737908;6191.318954914956;4862.292918417648;4872.6589138760655;4880.1215781159735;4883.194272944996;4886.951130488721;4275.593818587229;4305.268104422255;4337.024169561886;4398.164348773723;4402.823887044547;5083.796648134107;5561.972190139023;5567.944320556742;5575.303087114111;5576.996140694714;5716.628419152742;5965.642061476326;6098.855844323405;6117.694115294217;6141.355157708376;5490.752916118784;5529.4470552944385;5530.391656917735;5553.305836770403;5588.776448941997;5237.9476205238225;5250.107481728039;5252.579793616502;5253.264542963988;5323.653962492503;6215.844603884939;6225.470834978987;6232.376762323732;6275.090111933744;6295.874082518232;6092.603980741238;6144.78493252734;6147.262328520606;6156.076588511759;6177.073438984188;5462.661647896291;6128.601640893506;6261.78083767066;6273.592216505913;6275.278342990615;5944.762209511571;5981.551383646157;6014.518838492822;6027.698615069141;6038.849028774316;5316.6012549058205;6042.969785151222;6097.5731698780655;6111.938880611137;6117.357677443804;5665.801696940587;5983.252093488314;5985.191999080069;5990.700464976647;5993;5929.229200203946;5961.91057134152;5969.492593129633;5970.582059255984;5978.432048955342;5768.596198266081;5840;5852.970735146297;5866.090755932837;5871.588988770745;5956.5532585055425;5990.730417131327;5991.670458124845;5993.430624090704;6012.188354572252;4778.761061946958;5771.797987070432;5824;5832.854178645568;5833.387494313036 03:53:58 INFO - PROCESS | 1681 | |1;ext.html;442.8140181123928;490.99263511047343;500.0898364975743;537.4840153452685;553.0294333444804;30715.539266911015;40459.79770101149;41547.79226103869;41571;43398.56601433985;42855.78572107143;43041.139177216435;43063.78468107663;43092.78453607736;43223;8477.406581539295;8693.826123477527;9360.251179905608;9548.856767148498;9553.713388598353;8636.740897773077;8734.344924130715;8746.256568191711;11481.942590287037;11746.353950532717;11500.42497875107;11553.942230288836;11558.248713833575;11562.59530916418;11666;11423.885761142365;11505.424728763528;11509.366984815832;11513.712157196054;11518.366489843056;8453.873191902127;8662.913370866274;11197.832032519518;11422.657320280321;11516.193866429354;40387.78836634906;40578.18843623111;40647.59352406468;40725.59274407248;40757.38863917044;3425.9314813703836;3444.776089554171;3448.517207590939;3703;3977.54258260298;24685;24857.751422485726;24951.875240623864;30743.2314192147;31586;2856.87144078517;2924.4443555724342;2945.410917816424;3261.4671104580807;3267.1668724475344;381285;383727;434669;440025;440352;64969;65665.6716716423;65765.34234657687;65798.67100664465;65879;67136.328636713;68055.65972170107;68126;68277.65861170662;68322;16067.196640168178;16282.918585406996;16305.510834674978;16346.264418101215;16386.344546218257;12606.621801345975;12678.87321126777;12702;12721;12722.745545089047;16680.66638667244;17244.224009919584;17424.825751742574;17460.126993650265;18359.63280734378;6401.679916004275;6893.724251030003;6895.448364130857;7338.926610733824;7789.883151752728;851.9787005324916;891.0732837848565;953.4851180362665;980.5195454227377;981.9116279534876;29360;29874.850625747167;30125.246868828453;30856;30909.918152864993;908.7818923458323;1023.2785885950387;1066.7866426714688;1092.1153865369076;1112.554978008803;13361.53234636783;13582.45670173182;15747.270698860495;15956.601084972737;16121.838781612269;642858;648283;649729.0054198984;649762;650520;58242.70878645664;58734.82530349369;58793.412065878794;58863.70568147132;58919.70540147272;1332.2805684930029;1389.5206153877098;1391.9443222271198;1396.0716123777777;1397.5667543061684;29349.559756604096;29726.25684357908;30153.944611938477;30251.832643494916;30557.694423055484;51611.741941290056;51628;51632.22551661803;51780;51904;568984;572867;573991.1300443471;574517;575097;42627.57372426236;42808.5719142817;43365.91585210269;43508.56491435045;43711.56288437075;43973.90065248394;47866.52133478621;48985.265221021;49172.52482425533;49384.75307623439;39153.80423097866;39220.80389598034;39496.40755388729;40447.59552404438;40759;38353.04117397087;38719;38990.220195595364;40440.98897527585;40552.59447405488;37475;39054;39070.80464597659;39161.41257881077;40624.1875162501;29065;31225.53161702531;35431.645683543866;36001.27997440089;36036.91889243327;25274;25489.362765931;25648.487030259665;25669.871650641628;26449.735502644726 03:53:58 INFO - PROCESS | 1681 | |2;jquery.html;343.5739682793337;348.5468890442425;370.69232536994315;378.63650895140654;400.14568895408314;12553.811692824604;14725.864749611314;14832.6291842704;20000.000000000015;20533.589328213428;17981.100944952734;20365.083571239295;20382.796172038274;20564.691529627067;20567.38297851063;5708.743106560215;6082.330943596201;6082.513398928075;6096.939030609681;6101.054336577838;5026.899462010758;5113.411957624865;5912.260967379078;5979.431953964367;5989.371116032819;5654.37801841797;5888.823335299948;5919.940800591982;5927.081302398114;5948.583599148062;5841.269841269841;5959.225300710901;5960.791372301948;5963.612365196292;5978.073398623177;4905.190643543811;5137.48625137487;5179.326687530634;5179.482051794828;5183.559397451221;20628.896855515628;25369.365765855815;25641.35896602581;25839.35401614956;25923.481530369474;2156.4501052231735;2206.1396055538353;2418.7702168293986;2518.508890766301;2953.4683756923746;9983.251256155818;10488.632897848614;10526.315789473736;10565.577376904914;15655.68688626221;1772.911354432286;1789.6294536581868;1804.4225847728733;1804.8917064976145;1962.3229985655069;85964.57017714871;93821.53089234511;115001;116956;118627;9556.331056826095;11086.013020319717;11439.970402663634;11535.596254131066;11856;14393.64015899611;14618.195999220145;14623.634409139644;14667.266636668124;14683.898707596973;8309.792255193668;8438;8512.446690965067;8616.612252448655;8640.827183456297;6969.721211151598;8402.075771665111;8416.831663366698;8471.279941205066;8576;4396.868093957187;4520.367148599199;4524.615407690383;4619.792109355019;4628.305754136906;1855.9721604175948;1908.8377487913683;1918.6642337590865;1922.8750131241425;1968.2875897968859;786.4927122006274;827.8153931874433;886.8847049883603;963.5037955452947;1016.9491525423699;20111.39665810028;21681.281677601084;21827.17822868662;21989.340319790434;22186.77813221847;900.7567956651667;906.9863952040724;951.9666811661558;980.7352014956065;1014.7970405918699;10933.196022656331;11246.43767811606;11250.887491125148;11671.066314694805;11747.706307342214;502248;521025;570952;572838;603843;74500.13749656193;76820.23179768243;108502;136480;142554.74452554868;830.8368284401886;1007.3653598233067;1026.7638443157966;1026.8716410448694;1030.5929157982555;18714.438566843015;19536.120874560962;19539.902300488975;19576.412707618794;19651.11569979383;41882.95292617709;55327.44672553223;55595.44404555903;55957.16064259121;57391.71304143452;70032;72834.17914552179;76738;79928;81712.59143704243;7021.894671580033;7393.630318484162;7422.146453157956;7481.551106933602;7650.273224043707;7274.854502910018;9991;12519.624411267676;13236.801447978096;13466.663333416744;11352.602658906899;11567.305961642329;11740.530378785095;11777.998870096138;11914.463849126983;11054.668359949215;11357.886421135683;11716.23844450108;11867.228630139014;11977.760444790882;10049.13219756731;11565.074794016291;11767.823482647938;11829.704257393634;11941.283522988648;6960.269171736894;6979.4765392594745;7422;7435.8141046474275;8060.637271322687;9430.434173949585;11767.52929882795;11845.881541184823;11873.703157421134;11902.988245999188 03:53:58 INFO - PROCESS | 1681 | |3;mootools.html;1297.5782870567057;1468.478690065027;1514.1142431677467;1676;1853.508820162658;7425.18322984472;7889.802754931123;8146.144654811248;8357.958210208955;8380.120087390827;8239.176082391758;8304.418690691655;8306.584670766468;8307.086220515754;8327.084020757711;2234.7876951689605;2265.0939624150305;2265.399669087693;2265.8187345012443;2266.7733226677283;1887.3205645967441;2238.272561417538;2269.4099534121083;2274.8293877959136;2275.283285764987;2225.221172589597;2241.4060274027315;2255.6842042114117;2264.0377839418184;2269.5687819314276;1869.5513076861455;2231.6987206727044;2242.865428074321;2247.033775476553;2247.9775202248097;1827.4060930197738;2163.891805409739;2207.6357401028813;2208.326460429568;2215.8448908576406;7132.821679458003;8269.710560130427;8321.750347489586;8335.083140854502;8353.582320883932;4241.554636763126;5123.154679477919;5128.205128205134;5171.922421163648;5181.015607034651;3302.339532093567;3442.1566716154703;3511.10466830959;3514.736394770377;3524.735644826623;1000.7648202672366;1033.1424917318607;1035.6427032673716;1055.5724931402794;1057.3074636113358;10777.299475534066;10878.61924832635;10929;10932.672019839338;10942.617008404748;4163.604457576586;4232.724872883315;4367.694261401672;4396.560343965578;4409.536998615164;8608.139186081467;8624.956875215585;8630.956845215735;8638.17937295956;8641.222289993932;5022.196448568212;5024.748762561857;5029.7736601853;5035.420926593489;5049.6465247432325;4152.148809494047;4222.155568886235;4261.850835220753;4388.166248412791;4715.41057367829;3380.6281309055985;3659.9268014639556;3670.559532856021;3678.5585729712607;3680.1719613086843;999.1107913956585;1001.1890368801294;1010.4998025977188;1013.0679774607379;1016.8525563793208;834.1116710703081;838.4343907642633;887.7691800132012;898.3621628643606;923.1691477670016;4420.7126536775;5260.894782104337;5372.221027950925;5513.889722205534;5542.7782888684005;775.337086790797;895.1630225738955;907.4237858959608;929.9488528131018;991.5538007896475;3684.8341824617955;3690.55713314404;3720.2373513429684;3747.306748251582;3800.9429858552144;9834.852477212848;10057.748556286151;10158.441285729356;10164.440955747505;10171.135453486537;10114.241431892637;10120.98790120982;10122.797544049077;10134.949325253327;10139.391636501687;7687;7827;7843.490173138728;7851.371890248766;7853.41099417546;4148.937765933574;5122.257272695364;5307.9734601326745;5511.283533140827;5563.193336966036;9219.44683319003;9466;9494.85757713621;9502.239820814457;9528.094830991045;8759.474431534129;9277.118673725985;9392.577334020121;9560.187384072153;9579.568919398784;5348.465153484621;6323.525735569759;6681.966590167018;6737.663116844236;6798.252192258748;7699.307062364414;7786.338161256356;7858.29275365197;7874.976253087291;7886.645100970355;7088.291170883077;7090.893636595352;7104.04095447108;7139.643017848983;7147.928520714726;6918.135233095863;6991.685374158277;7029.5430796998035;7039.648017599202;7044.189918159273;6511;6655.101561289164;6656.869801663422;6660.766873159416;6671.066050752996;4612.677112602086;4772.355731976278;4778.737169455713;4800.831970881002;4885.926711099408;4720.575148236675;4775.403074615673;4780.928286075642;4856.490068542752;4867.58625516835 03:53:58 INFO - PROCESS | 1681 | |4;prototype.html;279.89162914857167;280.6141555361378;294.18804100682115;301.2183384118213;307.5095223119124;5066.392032956046;5202.713850738208;5203.245529398235;5253.500917412849;5286.973565132179;4487.080148569544;4872.68657313027;4909.828156014541;4929.876753081175;5168.9224661630105;4017.6785857131504;4019.919601607966;4022.45696830927;4023.1953609278116;4033.7176397652174;3512.2273099918107;3989.563757047475;4002.779847108408;4013.2776100301935;4016.2168377166463;3373.4265174920324;3628.7097032237357;3952.8023598819946;3988.12261302513;3991.8802435926823;3969.2260009298197;3986.5216174059296;3995.960040399617;4011.5587285398583;4015.317396042665;3057;3465.1337165708574;3476.461148521983;3494.405950988338;3506.701930335899;5041.521055499758;5077.847664570032;5097.5667068299235;5105.222135619651;5140.691558506464;3489;3782.2435512897255;3992.441058251847;4148.585141485857;4197.271773347318;4567.611753000999;5160.4713690291865;5202.453742357074;5485.917711234335;5493.450654934514;3746.737728359016;3749.981250093759;3752.2870654575545;3767.9449754068905;3773.151041015777;5140.922886156711;5365.466181076984;5737.496065588493;5745.150748998181;5846.561507886968;3271.018694391673;3558.2349794794245;3783.1109689223013;3786.8674596389546;3802.315583194996;3832.7125465590193;3854.710896682704;3858.3826587745825;3875.244327356195;3876.4960555127655;3803.923921521554;4208.410822484854;4505.819767209275;4516.954830451654;4520.739630184908;5219.112750832292;5431.614938190736;5539.224508568804;5586.329640443173;5638.436156384329;1213.2538488829307;1286.9163504372186;1312.9474821007052;1315.5658632651202;1320.5906169087614;725.3725527418745;835.8035861572525;836.7239959062479;857.2798848966897;889.2219308105408;3926.9018274542796;4074.103697186614;5056.443791182967;5139.897202055938;5174.068667639785;5138.820141295037;5443.918341224885;5594.244776955059;5690.886182276331;5736.971315143398;4140.979295103505;5036.769113944304;5085.338905942203;5193.324867767166;5264.684118952799;2562.974370256311;2698.9190324290303;2839.701831307683;2993.6108305920093;3005.430357044739;5301;5906.26171728534;5912.157097886408;5963.19496867926;5995.370486098896;5071.594272458195;5446.428125046892;5636.239107720406;5913.704314784243;5920.79277225295;5523.475269849358;5861.501772349313;5915.733791979371;5941.970290148522;5990.940090599038;5229.470107677226;5478.480253790718;5630.74661640219;5667.886642267049;5760.423957604206;4955.876103097451;5619.381867994435;5637.605367624227;5641.8589535261945;5696.658200507983;5388.329617818489;5823.79616713413;5943.465088142088;5955.791547295824;6023;3527.165873745689;3744.5319335083113;3775.8861135964407;3799.905002374963;3837.9808100960436;4680.812767489262;5653.434656534479;5664.235328230801;5666.433356664301;5778.27771528559;4684.6486513510945;5222.55608273301;5606.607537472338;5622.437756224344;5637.238972738792;5113.821016264562;5344.9732751336;5512.39363670004;5542.722863856871;5585.916211256753;5167.638265321391;5404.703260907667;5438.709580703618;5455.1544510600925;5455.536279416136;4326.913461730811;5407.918881216863;5462.6449280798215;5494.945050549603;5595.4748508439425;5444.428335024765;5455.918161227505;5498.092814685692;5498.642588231752;5565.693886836101 03:53:58 INFO - PROCESS | 1681 | |5;yui.html;724.4240828541309;748.4835463530163;749.763824395315;785.6150486261733;804.5333706450258;14933.402663893445;15521.844781552181;15533.301001454933;15550.300236489356;15555;13788.103773254732;13975.021748477611;13983;13986.580402587913;13999.300034998234;644.1883227133799;688.2360579756466;694.2710154337925;778.7897267737708;856.4561503445326;851.7572491839827;871.3943809052679;877.6138499060393;887.6227603268617;891.4651209274416;892.2638822971043;915.1763412928351;917.8944421391559;919.3380765848578;920.4063379120463;707.2185235314954;869.8086420987372;887.8002449448887;908.8545832666807;910.7723069232692;548.2187882267792;663.8473151175257;683.1528904158807;690.7409721354492;691.1809505735669;14766.409343626243;15015.924920375328;15145;15350.923245383814;15390.3074361654;11768.235064720766;13259.801102983367;14124.152550846879;14305.71388572233;14423.711525769426;12209.877901220963;12516.74966500665;12720.61838144848;12842.550510732079;13369;4518.88702782433;4565.931511027337;4584.816607335702;4783.880402989918;4785.377900872899;106259;108979.45510272398;110490.34264486039;113600;113872;11040.723981900517;11126.777464450666;11133.387663678575;11147.26368159204;11445.828312575319;22278.665820012713;22439.775602244095;22473;22489.662655060187;22635.773642263368;7657.1959944205055;7741.961290193625;7751.263629955145;7755.2244775521995;7933.404994625426;3623.7825730456257;4127.9587204128175;4171.791410429466;4179.770112643834;4306.332518459643;3481.721462283062;3578.1233597768714;3593.69453596442;3594.982025089858;3595.658412450813;651.5211319680031;655.924568674599;659.1266571792394;675.5507587454288;681.0125318288501;621.3724138620026;621.9937800622026;624.6096189881324;626.2485017978444;630.1430055125027;8391.874121888177;9057.501837399006;9069.41048831837;9081.182693557479;9167.49578773174;498.27003439960635;597.2593983460478;623.7660877171061;632.7975047984693;638.4158494977137;3717.7955212463576;3871.3612253977776;4888.462269150391;5051.51445502602;5147;145350.2732486352;146153;150647;150864;151585;109363;115904.42047789707;131962.34018829843;132660;137431.31284343515;96047.55928661076;101463.06542781022;106710;106964.88561830226;107209;9199.885174663365;9434.103760142776;9761.267904907018;9788.85316720264;9801.705948821547;60762.696186518784;61451.463713407524;61797;63723.3627663736;64511.032334515956;66746.66626666836;85740;89229.10770892208;90540.64189037301;90666.54666726888;13209.669758256121;13303.733925321632;13338.639076800868;13588.660283492993;13818.65453363674;14607;14787.630309242355;14804.7779283313;14835.723604903256;14951.252437378305;13274.93362533181;13405.66485837862;13438.731225375243;13822.723545529234;13954.651133721738;12181.781821817747;12833.550825721055;13548.254845983565;13804.17174969505;13889.166650001032;13422.731545368842;13463.932680336535;13550.254735989221;13567.932160339134;13888.003823482459;10116.747081323027;10886.29239099456;11187.832182517106;11412.429378530875;11615.245009074382;10126.8480972784;11304.830427543759;11339.489722962322;11495.712607184887;11586.246893951866 03:53:58 INFO - PROCESS | 1681 | __end_tp_report 03:53:58 INFO - PROCESS | 1681 | __start_cc_report 03:53:58 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,3320 03:53:58 INFO - PROCESS | 1681 | __end_cc_report 03:53:58 INFO - PROCESS | 1681 | __startTimestamp1477392838878__endTimestamp 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | ------- Summary: start ------- 03:53:58 INFO - PROCESS | 1681 | Number of tests: 6 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5621.28 Median:5824.00 stddev:640.36 (11.0%) stddev-sans-first:599.38 03:53:58 INFO - PROCESS | 1681 | Values: 2682.0 3287.2 3296.9 3325.4 3349.3 5491.2 5548.1 5618.6 5632.3 5641.8 5574.8 5591.9 5600.0 5610.6 5620.4 5073.9 5118.8 5123.3 5152.7 5216.1 5120.3 5174.1 5191.1 5210.6 5217.4 5093.4 5154.6 5164.0 5170.4 5180.5 5183.8 5209.3 5213.8 5216.2 5274.1 5025.9 5028.9 5120.2 5128.9 5149.3 5490.3 5514.9 5523.9 5557.2 5571.8 6117.5 6122.8 6123.7 6177.9 6182.0 6048.2 6190.7 6202.6 6204.0 6217.5 5589.3 5618.7 5622.7 5627.1 5671.5 6212.6 6235.1 6241.4 6254.3 6269.2 6007.5 6020.2 6026.7 6028.2 6072.8 6048.4 6091.0 6121.6 6121.9 6131.1 5992.4 6077.4 6100.1 6103.5 6150.9 6121.4 6173.8 6179.4 6191.2 6191.3 4862.3 4872.7 4880.1 4883.2 4887.0 4275.6 4305.3 4337.0 4398.2 4402.8 5083.8 5562.0 5567.9 5575.3 5577.0 5716.6 5965.6 6098.9 6117.7 6141.4 5490.8 5529.4 5530.4 5553.3 5588.8 5237.9 5250.1 5252.6 5253.3 5323.7 6215.8 6225.5 6232.4 6275.1 6295.9 6092.6 6144.8 6147.3 6156.1 6177.1 5462.7 6128.6 6261.8 6273.6 6275.3 5944.8 5981.6 6014.5 6027.7 6038.8 5316.6 6043.0 6097.6 6111.9 6117.4 5665.8 5983.3 5985.2 5990.7 5993.0 5929.2 5961.9 5969.5 5970.6 5978.4 5768.6 5840.0 5853.0 5866.1 5871.6 5956.6 5990.7 5991.7 5993.4 6012.2 4778.8 5771.8 5824.0 5832.9 5833.4 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:69223.42 Median:21736.98 stddev:148067.84 (681.2%) stddev-sans-first:148393.15 03:53:58 INFO - PROCESS | 1681 | Values: 442.8 491.0 500.1 537.5 553.0 30715.5 40459.8 41547.8 41571.0 43398.6 42855.8 43041.1 43063.8 43092.8 43223.0 8477.4 8693.8 9360.3 9548.9 9553.7 8636.7 8734.3 8746.3 11481.9 11746.4 11500.4 11553.9 11558.2 11562.6 11666.0 11423.9 11505.4 11509.4 11513.7 11518.4 8453.9 8662.9 11197.8 11422.7 11516.2 40387.8 40578.2 40647.6 40725.6 40757.4 3425.9 3444.8 3448.5 3703.0 3977.5 24685.0 24857.8 24951.9 30743.2 31586.0 2856.9 2924.4 2945.4 3261.5 3267.2 381285.0 383727.0 434669.0 440025.0 440352.0 64969.0 65665.7 65765.3 65798.7 65879.0 67136.3 68055.7 68126.0 68277.7 68322.0 16067.2 16282.9 16305.5 16346.3 16386.3 12606.6 12678.9 12702.0 12721.0 12722.7 16680.7 17244.2 17424.8 17460.1 18359.6 6401.7 6893.7 6895.4 7338.9 7789.9 852.0 891.1 953.5 980.5 981.9 29360.0 29874.9 30125.2 30856.0 30909.9 908.8 1023.3 1066.8 1092.1 1112.6 13361.5 13582.5 15747.3 15956.6 16121.8 642858.0 648283.0 649729.0 649762.0 650520.0 58242.7 58734.8 58793.4 58863.7 58919.7 1332.3 1389.5 1391.9 1396.1 1397.6 29349.6 29726.3 30153.9 30251.8 30557.7 51611.7 51628.0 51632.2 51780.0 51904.0 568984.0 572867.0 573991.1 574517.0 575097.0 42627.6 42808.6 43365.9 43508.6 43711.6 43973.9 47866.5 48985.3 49172.5 49384.8 39153.8 39220.8 39496.4 40447.6 40759.0 38353.0 38719.0 38990.2 40441.0 40552.6 37475.0 39054.0 39070.8 39161.4 40624.2 29065.0 31225.5 35431.6 36001.3 36036.9 25274.0 25489.4 25648.5 25669.9 26449.7 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:32761.83 Median:14438.47 stddev:92494.36 (640.6%) stddev-sans-first:92721.80 03:53:58 INFO - PROCESS | 1681 | Values: 343.6 348.5 370.7 378.6 400.1 12553.8 14725.9 14832.6 20000.0 20533.6 17981.1 20365.1 20382.8 20564.7 20567.4 5708.7 6082.3 6082.5 6096.9 6101.1 5026.9 5113.4 5912.3 5979.4 5989.4 5654.4 5888.8 5919.9 5927.1 5948.6 5841.3 5959.2 5960.8 5963.6 5978.1 4905.2 5137.5 5179.3 5179.5 5183.6 20628.9 25369.4 25641.4 25839.4 25923.5 2156.5 2206.1 2418.8 2518.5 2953.5 9983.3 10488.6 10526.3 10565.6 15655.7 1772.9 1789.6 1804.4 1804.9 1962.3 85964.6 93821.5 115001.0 116956.0 118627.0 9556.3 11086.0 11440.0 11535.6 11856.0 14393.6 14618.2 14623.6 14667.3 14683.9 8309.8 8438.0 8512.4 8616.6 8640.8 6969.7 8402.1 8416.8 8471.3 8576.0 4396.9 4520.4 4524.6 4619.8 4628.3 1856.0 1908.8 1918.7 1922.9 1968.3 786.5 827.8 886.9 963.5 1016.9 20111.4 21681.3 21827.2 21989.3 22186.8 900.8 907.0 952.0 980.7 1014.8 10933.2 11246.4 11250.9 11671.1 11747.7 502248.0 521025.0 570952.0 572838.0 603843.0 74500.1 76820.2 108502.0 136480.0 142554.7 830.8 1007.4 1026.8 1026.9 1030.6 18714.4 19536.1 19539.9 19576.4 19651.1 41883.0 55327.4 55595.4 55957.2 57391.7 70032.0 72834.2 76738.0 79928.0 81712.6 7021.9 7393.6 7422.1 7481.6 7650.3 7274.9 9991.0 12519.6 13236.8 13466.7 11352.6 11567.3 11740.5 11778.0 11914.5 11054.7 11357.9 11716.2 11867.2 11977.8 10049.1 11565.1 11767.8 11829.7 11941.3 6960.3 6979.5 7422.0 7435.8 8060.6 9430.4 11767.5 11845.9 11873.7 11903.0 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:5317.35 Median:4954.06 stddev:2981.50 (60.2%) stddev-sans-first:2974.55 03:53:58 INFO - PROCESS | 1681 | Values: 1297.6 1468.5 1514.1 1676.0 1853.5 7425.2 7889.8 8146.1 8358.0 8380.1 8239.2 8304.4 8306.6 8307.1 8327.1 2234.8 2265.1 2265.4 2265.8 2266.8 1887.3 2238.3 2269.4 2274.8 2275.3 2225.2 2241.4 2255.7 2264.0 2269.6 1869.6 2231.7 2242.9 2247.0 2248.0 1827.4 2163.9 2207.6 2208.3 2215.8 7132.8 8269.7 8321.8 8335.1 8353.6 4241.6 5123.2 5128.2 5171.9 5181.0 3302.3 3442.2 3511.1 3514.7 3524.7 1000.8 1033.1 1035.6 1055.6 1057.3 10777.3 10878.6 10929.0 10932.7 10942.6 4163.6 4232.7 4367.7 4396.6 4409.5 8608.1 8625.0 8631.0 8638.2 8641.2 5022.2 5024.7 5029.8 5035.4 5049.6 4152.1 4222.2 4261.9 4388.2 4715.4 3380.6 3659.9 3670.6 3678.6 3680.2 999.1 1001.2 1010.5 1013.1 1016.9 834.1 838.4 887.8 898.4 923.2 4420.7 5260.9 5372.2 5513.9 5542.8 775.3 895.2 907.4 929.9 991.6 3684.8 3690.6 3720.2 3747.3 3800.9 9834.9 10057.7 10158.4 10164.4 10171.1 10114.2 10121.0 10122.8 10134.9 10139.4 7687.0 7827.0 7843.5 7851.4 7853.4 4148.9 5122.3 5308.0 5511.3 5563.2 9219.4 9466.0 9494.9 9502.2 9528.1 8759.5 9277.1 9392.6 9560.2 9579.6 5348.5 6323.5 6682.0 6737.7 6798.3 7699.3 7786.3 7858.3 7875.0 7886.6 7088.3 7090.9 7104.0 7139.6 7147.9 6918.1 6991.7 7029.5 7039.6 7044.2 6511.0 6655.1 6656.9 6660.8 6671.1 4612.7 4772.4 4778.7 4800.8 4885.9 4720.6 4775.4 4780.9 4856.5 4867.6 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:4462.81 Median:5109.52 stddev:1397.26 (27.3%) stddev-sans-first:1365.46 03:53:58 INFO - PROCESS | 1681 | Values: 279.9 280.6 294.2 301.2 307.5 5066.4 5202.7 5203.2 5253.5 5287.0 4487.1 4872.7 4909.8 4929.9 5168.9 4017.7 4019.9 4022.5 4023.2 4033.7 3512.2 3989.6 4002.8 4013.3 4016.2 3373.4 3628.7 3952.8 3988.1 3991.9 3969.2 3986.5 3996.0 4011.6 4015.3 3057.0 3465.1 3476.5 3494.4 3506.7 5041.5 5077.8 5097.6 5105.2 5140.7 3489.0 3782.2 3992.4 4148.6 4197.3 4567.6 5160.5 5202.5 5485.9 5493.5 3746.7 3750.0 3752.3 3767.9 3773.2 5140.9 5365.5 5737.5 5745.2 5846.6 3271.0 3558.2 3783.1 3786.9 3802.3 3832.7 3854.7 3858.4 3875.2 3876.5 3803.9 4208.4 4505.8 4517.0 4520.7 5219.1 5431.6 5539.2 5586.3 5638.4 1213.3 1286.9 1312.9 1315.6 1320.6 725.4 835.8 836.7 857.3 889.2 3926.9 4074.1 5056.4 5139.9 5174.1 5138.8 5443.9 5594.2 5690.9 5737.0 4141.0 5036.8 5085.3 5193.3 5264.7 2563.0 2698.9 2839.7 2993.6 3005.4 5301.0 5906.3 5912.2 5963.2 5995.4 5071.6 5446.4 5636.2 5913.7 5920.8 5523.5 5861.5 5915.7 5942.0 5990.9 5229.5 5478.5 5630.7 5667.9 5760.4 4955.9 5619.4 5637.6 5641.9 5696.7 5388.3 5823.8 5943.5 5955.8 6023.0 3527.2 3744.5 3775.9 3799.9 3838.0 4680.8 5653.4 5664.2 5666.4 5778.3 4684.6 5222.6 5606.6 5622.4 5637.2 5113.8 5345.0 5512.4 5542.7 5585.9 5167.6 5404.7 5438.7 5455.2 5455.5 4326.9 5407.9 5462.6 5494.9 5595.5 5444.4 5455.9 5498.1 5498.6 5565.7 03:53:58 INFO - PROCESS | 1681 | 03:53:58 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:24469.30 Median:3585.91 stddev:38760.69 (1080.9%) stddev-sans-first:38828.42 03:53:58 INFO - PROCESS | 1681 | Values: 724.4 748.5 749.8 785.6 804.5 14933.4 15521.8 15533.3 15550.3 15555.0 13788.1 13975.0 13983.0 13986.6 13999.3 644.2 688.2 694.3 778.8 856.5 851.8 871.4 877.6 887.6 891.5 892.3 915.2 917.9 919.3 920.4 707.2 869.8 887.8 908.9 910.8 548.2 663.8 683.2 690.7 691.2 14766.4 15015.9 15145.0 15350.9 15390.3 11768.2 13259.8 14124.2 14305.7 14423.7 12209.9 12516.7 12720.6 12842.6 13369.0 4518.9 4565.9 4584.8 4783.9 4785.4 106259.0 108979.5 110490.3 113600.0 113872.0 11040.7 11126.8 11133.4 11147.3 11445.8 22278.7 22439.8 22473.0 22489.7 22635.8 7657.2 7742.0 7751.3 7755.2 7933.4 3623.8 4128.0 4171.8 4179.8 4306.3 3481.7 3578.1 3593.7 3595.0 3595.7 651.5 655.9 659.1 675.6 681.0 621.4 622.0 624.6 626.2 630.1 8391.9 9057.5 9069.4 9081.2 9167.5 498.3 597.3 623.8 632.8 638.4 3717.8 3871.4 4888.5 5051.5 5147.0 145350.3 146153.0 150647.0 150864.0 151585.0 109363.0 115904.4 131962.3 132660.0 137431.3 96047.6 101463.1 106710.0 106964.9 107209.0 9199.9 9434.1 9761.3 9788.9 9801.7 60762.7 61451.5 61797.0 63723.4 64511.0 66746.7 85740.0 89229.1 90540.6 90666.5 13209.7 13303.7 13338.6 13588.7 13818.7 14607.0 14787.6 14804.8 14835.7 14951.3 13274.9 13405.7 13438.7 13822.7 13954.7 12181.8 12833.6 13548.3 13804.2 13889.2 13422.7 13463.9 13550.3 13567.9 13888.0 10116.7 10886.3 11187.8 11412.4 11615.2 10126.8 11304.8 11339.5 11495.7 11586.2 03:53:58 INFO - PROCESS | 1681 | -------- Summary: end -------- 03:53:58 INFO - PROCESS | 1681 | 03:53:59 INFO - TEST-INFO | 1681: exit 0 03:53:59 INFO - TEST-OK | dromaeo_css | took 1120490ms 03:53:59 INFO - TEST-START | kraken 03:53:59 INFO - operating with platform_type : mac_ 03:53:59 INFO - Initialising browser for kraken test... 03:53:59 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpuJtGuN/profile http://localhost:49277/getInfo.html) 03:54:01 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 03:54:01 INFO - PROCESS | 1694 | colorDepth:24 03:54:01 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 03:54:01 INFO - PROCESS | 1694 | __metrics 03:54:02 INFO - PROCESS | 1694 | 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" 03:54:02 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:54:02 INFO - TEST-INFO | 1694: exit 0 03:54:02 INFO - Browser initialized. 03:54:02 INFO - Running cycle 1/1 for kraken test... 03:54:02 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/T/tmpuJtGuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:14 INFO - PROCESS | 1695 | RSS: Main: 230338560 03:54:14 INFO - PROCESS | 1695 | 03:54:17 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 03:54:18 INFO - PROCESS | 1695 | RSS: Main: 289775616 03:54:18 INFO - PROCESS | 1695 | 03:54:20 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 03:54:21 INFO - PROCESS | 1695 | RSS: Main: 291594240 03:54:21 INFO - PROCESS | 1695 | 03:54:25 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 03:54:25 INFO - PROCESS | 1695 | RSS: Main: 384028672 03:54:25 INFO - PROCESS | 1695 | 03:54:27 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 03:54:28 INFO - PROCESS | 1695 | RSS: Main: 284475392 03:54:28 INFO - PROCESS | 1695 | 03:54:30 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:54:30 INFO - PROCESS | 1695 | RSS: Main: 289705984 03:54:30 INFO - PROCESS | 1695 | 03:54:33 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 03:54:34 INFO - PROCESS | 1695 | RSS: Main: 327421952 03:54:34 INFO - PROCESS | 1695 | 03:54:37 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 03:54:37 INFO - PROCESS | 1695 | RSS: Main: 326729728 03:54:37 INFO - PROCESS | 1695 | 03:54:40 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 03:54:40 INFO - PROCESS | 1695 | RSS: Main: 326197248 03:54:40 INFO - PROCESS | 1695 | 03:54:42 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:54:43 INFO - PROCESS | 1695 | RSS: Main: 301953024 03:54:43 INFO - PROCESS | 1695 | 03:54:45 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:54:45 INFO - PROCESS | 1695 | RSS: Main: 306339840 03:54:45 INFO - PROCESS | 1695 | 03:54:47 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:54:48 INFO - PROCESS | 1695 | RSS: Main: 309084160 03:54:48 INFO - PROCESS | 1695 | 03:54:51 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:54:52 INFO - PROCESS | 1695 | RSS: Main: 317505536 03:54:52 INFO - PROCESS | 1695 | 03:54:55 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:54:55 INFO - PROCESS | 1695 | RSS: Main: 317341696 03:54:55 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 03:54:57 INFO - PROCESS | 1695 | RSS: Main: 361476096 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | __start_tp_report 03:54:57 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 03:54:57 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 03:54:57 INFO - PROCESS | 1695 | |i|pagename|runs| 03:54:57 INFO - PROCESS | 1695 | |0;ai-astar;111;114;113;113;113;114;113;112;113;113 03:54:57 INFO - PROCESS | 1695 | |1;audio-beat-detection;151;114;112;155;144;142;113;117;175;140 03:54:57 INFO - PROCESS | 1695 | |2;audio-dft;185;180;184;184;184;183;184;183;184;179 03:54:57 INFO - PROCESS | 1695 | |3;audio-fft;81;59;59;86;60;60;57;58;82;57 03:54:57 INFO - PROCESS | 1695 | |4;audio-oscillator;86;70;89;69;67;69;91;66;67;94 03:54:57 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;89;87;88;90;90;85;91;91;89;86 03:54:57 INFO - PROCESS | 1695 | |6;imaging-darkroom;98;95;99;98;97;98;98;98;98;98 03:54:57 INFO - PROCESS | 1695 | |7;imaging-desaturate;81;81;80;82;80;80;82;85;83;84 03:54:57 INFO - PROCESS | 1695 | |8;json-parse-financial;56;57;52;54;54;54;55;54;54;55 03:54:57 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;65;72;66;76;73;69;69;69;70;72 03:54:57 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;91;89;85;88;90;85;83;85;88;88 03:54:57 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;149;147;153;153;143;147;144;146;179;146 03:54:57 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;171;171;174;173;170;170;234;212;173;172 03:54:57 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;69;69;69;69;68;68;68;67;68;68 03:54:57 INFO - PROCESS | 1695 | __end_tp_report 03:54:57 INFO - PROCESS | 1695 | __start_cc_report 03:54:57 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,2005 03:54:57 INFO - PROCESS | 1695 | __end_cc_report 03:54:57 INFO - PROCESS | 1695 | __startTimestamp1477392897792__endTimestamp 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | ------- Summary: start ------- 03:54:57 INFO - PROCESS | 1695 | Number of tests: 14 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 03:54:57 INFO - PROCESS | 1695 | Values: 111.0 114.0 113.0 113.0 113.0 114.0 113.0 112.0 113.0 113.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:143.00 stddev:21.53 (15.1%) stddev-sans-first:22.17 03:54:57 INFO - PROCESS | 1695 | Values: 151.0 114.0 112.0 155.0 144.0 142.0 113.0 117.0 175.0 140.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:183.00 Median:184.00 stddev:1.94 (1.1%) stddev-sans-first:1.92 03:54:57 INFO - PROCESS | 1695 | Values: 185.0 180.0 184.0 184.0 184.0 183.0 184.0 183.0 184.0 179.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:65.90 Median:60.00 stddev:11.91 (19.9%) stddev-sans-first:11.31 03:54:57 INFO - PROCESS | 1695 | Values: 81.0 59.0 59.0 86.0 60.0 60.0 57.0 58.0 82.0 57.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.00 stddev:11.58 (14.9%) stddev-sans-first:11.80 03:54:57 INFO - PROCESS | 1695 | Values: 86.0 70.0 89.0 69.0 67.0 69.0 91.0 66.0 67.0 94.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.50 stddev:2.07 (2.3%) stddev-sans-first:2.19 03:54:57 INFO - PROCESS | 1695 | Values: 89.0 87.0 88.0 90.0 90.0 85.0 91.0 91.0 89.0 86.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:98.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 03:54:57 INFO - PROCESS | 1695 | Values: 98.0 95.0 99.0 98.0 97.0 98.0 98.0 98.0 98.0 98.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:82.00 stddev:1.75 (2.1%) stddev-sans-first:1.83 03:54:57 INFO - PROCESS | 1695 | Values: 81.0 81.0 80.0 82.0 80.0 80.0 82.0 85.0 83.0 84.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.35 (2.5%) stddev-sans-first:1.32 03:54:57 INFO - PROCESS | 1695 | Values: 56.0 57.0 52.0 54.0 54.0 54.0 55.0 54.0 54.0 55.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:3.28 (4.6%) stddev-sans-first:2.92 03:54:57 INFO - PROCESS | 1695 | Values: 65.0 72.0 66.0 76.0 73.0 69.0 69.0 69.0 70.0 72.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.00 stddev:2.57 (2.9%) stddev-sans-first:2.33 03:54:57 INFO - PROCESS | 1695 | Values: 91.0 89.0 85.0 88.0 90.0 85.0 83.0 85.0 88.0 88.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:148.00 stddev:10.49 (7.1%) stddev-sans-first:11.11 03:54:57 INFO - PROCESS | 1695 | Values: 149.0 147.0 153.0 153.0 143.0 147.0 144.0 146.0 179.0 146.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:173.00 stddev:22.26 (12.9%) stddev-sans-first:23.25 03:54:57 INFO - PROCESS | 1695 | Values: 171.0 171.0 174.0 173.0 170.0 170.0 234.0 212.0 173.0 172.0 03:54:57 INFO - PROCESS | 1695 | 03:54:57 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 03:54:57 INFO - PROCESS | 1695 | Values: 69.0 69.0 69.0 69.0 68.0 68.0 68.0 67.0 68.0 68.0 03:54:57 INFO - PROCESS | 1695 | -------- Summary: end -------- 03:54:57 INFO - PROCESS | 1695 | 03:54:58 INFO - TEST-INFO | 1695: exit 0 03:54:58 INFO - TEST-OK | kraken | took 59184ms 03:54:58 INFO - SUITE-END | took 1179s 03:54:58 INFO - Completed test suite (00:19:39) 03:54:58 INFO - javascript benchmark 03:54:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2681.9597706034415, 3287.1617737476954, 3296.8846090386833, 3325.36818004579, 3349.313390754894, 5491.2312276281355, 5548.084566046603, 5618.634788738735, 5632.295963004624, 5641.802536911209, 5574.832755017346, 5591.944080559193, 5599.972000139994, 5610.579206559514, 5620.4098569650105, 5073.949260507394, 5118.795248190068, 5123.2827404163445, 5152.69083854968, 5216.113260745682, 5120.283160357553, 5174.120399532088, 5191.143461328895, 5210.55710264626, 5217.399999000126, 5093.363329583802, 5154.561862241714, 5164.0, 5170.405403378622, 5180.481951804808, 5183.818566350178, 5209.270702101709, 5213.843584692465, 5216.165413533817, 5274.129768588178, 5025.924611130836, 5028.949710502921, 5120.231965205212, 5128.9230661540105, 5149.30484384607, 5490.286262785852, 5514.944850551524, 5523.944760552383, 5557.249771280906, 5571.777128914879, 6117.541184411142, 6122.846928826815, 6123.663198524079, 6177.876442471171, 6181.96909015452, 6048.243969503812, 6190.659513726743, 6202.565820392574, 6204.0, 6217.502599792051, 5589.301337332833, 5618.747156377973, 5622.718864056781, 5627.071533197059, 5671.489565939003, 6212.571108645037, 6235.127082208494, 6241.438270555581, 6254.280757712831, 6269.216347956505, 6007.489363404072, 6020.157177995085, 6026.728797204137, 6028.246469191351, 6072.757089716361, 6048.395160484004, 6091.0, 6121.632702037892, 6121.940772762995, 6131.14164017038, 5992.43071908168, 6077.392260773976, 6100.1270446244, 6103.524360426982, 6150.907736383958, 6121.418465245794, 6173.753049878044, 6179.3820617937845, 6191.226096737908, 6191.318954914956, 4862.292918417648, 4872.6589138760655, 4880.1215781159735, 4883.194272944996, 4886.951130488721, 4275.593818587229, 4305.268104422255, 4337.024169561886, 4398.164348773723, 4402.823887044547, 5083.796648134107, 5561.972190139023, 5567.944320556742, 5575.303087114111, 5576.996140694714, 5716.628419152742, 5965.642061476326, 6098.855844323405, 6117.694115294217, 6141.355157708376, 5490.752916118784, 5529.4470552944385, 5530.391656917735, 5553.305836770403, 5588.776448941997, 5237.9476205238225, 5250.107481728039, 5252.579793616502, 5253.264542963988, 5323.653962492503, 6215.844603884939, 6225.470834978987, 6232.376762323732, 6275.090111933744, 6295.874082518232, 6092.603980741238, 6144.78493252734, 6147.262328520606, 6156.076588511759, 6177.073438984188, 5462.661647896291, 6128.601640893506, 6261.78083767066, 6273.592216505913, 6275.278342990615, 5944.762209511571, 5981.551383646157, 6014.518838492822, 6027.698615069141, 6038.849028774316, 5316.6012549058205, 6042.969785151222, 6097.5731698780655, 6111.938880611137, 6117.357677443804, 5665.801696940587, 5983.252093488314, 5985.191999080069, 5990.700464976647, 5993.0, 5929.229200203946, 5961.91057134152, 5969.492593129633, 5970.582059255984, 5978.432048955342, 5768.596198266081, 5840.0, 5852.970735146297, 5866.090755932837, 5871.588988770745, 5956.5532585055425, 5990.730417131327, 5991.670458124845, 5993.430624090704, 6012.188354572252, 4778.761061946958, 5771.797987070432, 5824.0, 5832.854178645568, 5833.387494313036], "value": 5579.126775925115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.8140181123928, 490.99263511047343, 500.0898364975743, 537.4840153452685, 553.0294333444804, 30715.539266911015, 40459.79770101149, 41547.79226103869, 41571.0, 43398.56601433985, 42855.78572107143, 43041.139177216435, 43063.78468107663, 43092.78453607736, 43223.0, 8477.406581539295, 8693.826123477527, 9360.251179905608, 9548.856767148498, 9553.713388598353, 8636.740897773077, 8734.344924130715, 8746.256568191711, 11481.942590287037, 11746.353950532717, 11500.42497875107, 11553.942230288836, 11558.248713833575, 11562.59530916418, 11666.0, 11423.885761142365, 11505.424728763528, 11509.366984815832, 11513.712157196054, 11518.366489843056, 8453.873191902127, 8662.913370866274, 11197.832032519518, 11422.657320280321, 11516.193866429354, 40387.78836634906, 40578.18843623111, 40647.59352406468, 40725.59274407248, 40757.38863917044, 3425.9314813703836, 3444.776089554171, 3448.517207590939, 3703.0, 3977.54258260298, 24685.0, 24857.751422485726, 24951.875240623864, 30743.2314192147, 31586.0, 2856.87144078517, 2924.4443555724342, 2945.410917816424, 3261.4671104580807, 3267.1668724475344, 381285.0, 383727.0, 434669.0, 440025.0, 440352.0, 64969.0, 65665.6716716423, 65765.34234657687, 65798.67100664465, 65879.0, 67136.328636713, 68055.65972170107, 68126.0, 68277.65861170662, 68322.0, 16067.196640168178, 16282.918585406996, 16305.510834674978, 16346.264418101215, 16386.344546218257, 12606.621801345975, 12678.87321126777, 12702.0, 12721.0, 12722.745545089047, 16680.66638667244, 17244.224009919584, 17424.825751742574, 17460.126993650265, 18359.63280734378, 6401.679916004275, 6893.724251030003, 6895.448364130857, 7338.926610733824, 7789.883151752728, 851.9787005324916, 891.0732837848565, 953.4851180362665, 980.5195454227377, 981.9116279534876, 29360.0, 29874.850625747167, 30125.246868828453, 30856.0, 30909.918152864993, 908.7818923458323, 1023.2785885950387, 1066.7866426714688, 1092.1153865369076, 1112.554978008803, 13361.53234636783, 13582.45670173182, 15747.270698860495, 15956.601084972737, 16121.838781612269, 642858.0, 648283.0, 649729.0054198984, 649762.0, 650520.0, 58242.70878645664, 58734.82530349369, 58793.412065878794, 58863.70568147132, 58919.70540147272, 1332.2805684930029, 1389.5206153877098, 1391.9443222271198, 1396.0716123777777, 1397.5667543061684, 29349.559756604096, 29726.25684357908, 30153.944611938477, 30251.832643494916, 30557.694423055484, 51611.741941290056, 51628.0, 51632.22551661803, 51780.0, 51904.0, 568984.0, 572867.0, 573991.1300443471, 574517.0, 575097.0, 42627.57372426236, 42808.5719142817, 43365.91585210269, 43508.56491435045, 43711.56288437075, 43973.90065248394, 47866.52133478621, 48985.265221021, 49172.52482425533, 49384.75307623439, 39153.80423097866, 39220.80389598034, 39496.40755388729, 40447.59552404438, 40759.0, 38353.04117397087, 38719.0, 38990.220195595364, 40440.98897527585, 40552.59447405488, 37475.0, 39054.0, 39070.80464597659, 39161.41257881077, 40624.1875162501, 29065.0, 31225.53161702531, 35431.645683543866, 36001.27997440089, 36036.91889243327, 25274.0, 25489.362765931, 25648.487030259665, 25669.871650641628, 26449.735502644726], "value": 20386.87857516177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5739682793337, 348.5468890442425, 370.69232536994315, 378.63650895140654, 400.14568895408314, 12553.811692824604, 14725.864749611314, 14832.6291842704, 20000.000000000015, 20533.589328213428, 17981.100944952734, 20365.083571239295, 20382.796172038274, 20564.691529627067, 20567.38297851063, 5708.743106560215, 6082.330943596201, 6082.513398928075, 6096.939030609681, 6101.054336577838, 5026.899462010758, 5113.411957624865, 5912.260967379078, 5979.431953964367, 5989.371116032819, 5654.37801841797, 5888.823335299948, 5919.940800591982, 5927.081302398114, 5948.583599148062, 5841.269841269841, 5959.225300710901, 5960.791372301948, 5963.612365196292, 5978.073398623177, 4905.190643543811, 5137.48625137487, 5179.326687530634, 5179.482051794828, 5183.559397451221, 20628.896855515628, 25369.365765855815, 25641.35896602581, 25839.35401614956, 25923.481530369474, 2156.4501052231735, 2206.1396055538353, 2418.7702168293986, 2518.508890766301, 2953.4683756923746, 9983.251256155818, 10488.632897848614, 10526.315789473736, 10565.577376904914, 15655.68688626221, 1772.911354432286, 1789.6294536581868, 1804.4225847728733, 1804.8917064976145, 1962.3229985655069, 85964.57017714871, 93821.53089234511, 115001.0, 116956.0, 118627.0, 9556.331056826095, 11086.013020319717, 11439.970402663634, 11535.596254131066, 11856.0, 14393.64015899611, 14618.195999220145, 14623.634409139644, 14667.266636668124, 14683.898707596973, 8309.792255193668, 8438.0, 8512.446690965067, 8616.612252448655, 8640.827183456297, 6969.721211151598, 8402.075771665111, 8416.831663366698, 8471.279941205066, 8576.0, 4396.868093957187, 4520.367148599199, 4524.615407690383, 4619.792109355019, 4628.305754136906, 1855.9721604175948, 1908.8377487913683, 1918.6642337590865, 1922.8750131241425, 1968.2875897968859, 786.4927122006274, 827.8153931874433, 886.8847049883603, 963.5037955452947, 1016.9491525423699, 20111.39665810028, 21681.281677601084, 21827.17822868662, 21989.340319790434, 22186.77813221847, 900.7567956651667, 906.9863952040724, 951.9666811661558, 980.7352014956065, 1014.7970405918699, 10933.196022656331, 11246.43767811606, 11250.887491125148, 11671.066314694805, 11747.706307342214, 502248.0, 521025.0, 570952.0, 572838.0, 603843.0, 74500.13749656193, 76820.23179768243, 108502.0, 136480.0, 142554.74452554868, 830.8368284401886, 1007.3653598233067, 1026.7638443157966, 1026.8716410448694, 1030.5929157982555, 18714.438566843015, 19536.120874560962, 19539.902300488975, 19576.412707618794, 19651.11569979383, 41882.95292617709, 55327.44672553223, 55595.44404555903, 55957.16064259121, 57391.71304143452, 70032.0, 72834.17914552179, 76738.0, 79928.0, 81712.59143704243, 7021.894671580033, 7393.630318484162, 7422.146453157956, 7481.551106933602, 7650.273224043707, 7274.854502910018, 9991.0, 12519.624411267676, 13236.801447978096, 13466.663333416744, 11352.602658906899, 11567.305961642329, 11740.530378785095, 11777.998870096138, 11914.463849126983, 11054.668359949215, 11357.886421135683, 11716.23844450108, 11867.228630139014, 11977.760444790882, 10049.13219756731, 11565.074794016291, 11767.823482647938, 11829.704257393634, 11941.283522988648, 6960.269171736894, 6979.4765392594745, 7422.0, 7435.8141046474275, 8060.637271322687, 9430.434173949585, 11767.52929882795, 11845.881541184823, 11873.703157421134, 11902.988245999188], "value": 9383.009573427744, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.5782870567057, 1468.478690065027, 1514.1142431677467, 1676.0, 1853.508820162658, 7425.18322984472, 7889.802754931123, 8146.144654811248, 8357.958210208955, 8380.120087390827, 8239.176082391758, 8304.418690691655, 8306.584670766468, 8307.086220515754, 8327.084020757711, 2234.7876951689605, 2265.0939624150305, 2265.399669087693, 2265.8187345012443, 2266.7733226677283, 1887.3205645967441, 2238.272561417538, 2269.4099534121083, 2274.8293877959136, 2275.283285764987, 2225.221172589597, 2241.4060274027315, 2255.6842042114117, 2264.0377839418184, 2269.5687819314276, 1869.5513076861455, 2231.6987206727044, 2242.865428074321, 2247.033775476553, 2247.9775202248097, 1827.4060930197738, 2163.891805409739, 2207.6357401028813, 2208.326460429568, 2215.8448908576406, 7132.821679458003, 8269.710560130427, 8321.750347489586, 8335.083140854502, 8353.582320883932, 4241.554636763126, 5123.154679477919, 5128.205128205134, 5171.922421163648, 5181.015607034651, 3302.339532093567, 3442.1566716154703, 3511.10466830959, 3514.736394770377, 3524.735644826623, 1000.7648202672366, 1033.1424917318607, 1035.6427032673716, 1055.5724931402794, 1057.3074636113358, 10777.299475534066, 10878.61924832635, 10929.0, 10932.672019839338, 10942.617008404748, 4163.604457576586, 4232.724872883315, 4367.694261401672, 4396.560343965578, 4409.536998615164, 8608.139186081467, 8624.956875215585, 8630.956845215735, 8638.17937295956, 8641.222289993932, 5022.196448568212, 5024.748762561857, 5029.7736601853, 5035.420926593489, 5049.6465247432325, 4152.148809494047, 4222.155568886235, 4261.850835220753, 4388.166248412791, 4715.41057367829, 3380.6281309055985, 3659.9268014639556, 3670.559532856021, 3678.5585729712607, 3680.1719613086843, 999.1107913956585, 1001.1890368801294, 1010.4998025977188, 1013.0679774607379, 1016.8525563793208, 834.1116710703081, 838.4343907642633, 887.7691800132012, 898.3621628643606, 923.1691477670016, 4420.7126536775, 5260.894782104337, 5372.221027950925, 5513.889722205534, 5542.7782888684005, 775.337086790797, 895.1630225738955, 907.4237858959608, 929.9488528131018, 991.5538007896475, 3684.8341824617955, 3690.55713314404, 3720.2373513429684, 3747.306748251582, 3800.9429858552144, 9834.852477212848, 10057.748556286151, 10158.441285729356, 10164.440955747505, 10171.135453486537, 10114.241431892637, 10120.98790120982, 10122.797544049077, 10134.949325253327, 10139.391636501687, 7687.0, 7827.0, 7843.490173138728, 7851.371890248766, 7853.41099417546, 4148.937765933574, 5122.257272695364, 5307.9734601326745, 5511.283533140827, 5563.193336966036, 9219.44683319003, 9466.0, 9494.85757713621, 9502.239820814457, 9528.094830991045, 8759.474431534129, 9277.118673725985, 9392.577334020121, 9560.187384072153, 9579.568919398784, 5348.465153484621, 6323.525735569759, 6681.966590167018, 6737.663116844236, 6798.252192258748, 7699.307062364414, 7786.338161256356, 7858.29275365197, 7874.976253087291, 7886.645100970355, 7088.291170883077, 7090.893636595352, 7104.04095447108, 7139.643017848983, 7147.928520714726, 6918.135233095863, 6991.685374158277, 7029.5430796998035, 7039.648017599202, 7044.189918159273, 6511.0, 6655.101561289164, 6656.869801663422, 6660.766873159416, 6671.066050752996, 4612.677112602086, 4772.355731976278, 4778.737169455713, 4800.831970881002, 4885.926711099408, 4720.575148236675, 4775.403074615673, 4780.928286075642, 4856.490068542752, 4867.58625516835], "value": 4275.64623021696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.89162914857167, 280.6141555361378, 294.18804100682115, 301.2183384118213, 307.5095223119124, 5066.392032956046, 5202.713850738208, 5203.245529398235, 5253.500917412849, 5286.973565132179, 4487.080148569544, 4872.68657313027, 4909.828156014541, 4929.876753081175, 5168.9224661630105, 4017.6785857131504, 4019.919601607966, 4022.45696830927, 4023.1953609278116, 4033.7176397652174, 3512.2273099918107, 3989.563757047475, 4002.779847108408, 4013.2776100301935, 4016.2168377166463, 3373.4265174920324, 3628.7097032237357, 3952.8023598819946, 3988.12261302513, 3991.8802435926823, 3969.2260009298197, 3986.5216174059296, 3995.960040399617, 4011.5587285398583, 4015.317396042665, 3057.0, 3465.1337165708574, 3476.461148521983, 3494.405950988338, 3506.701930335899, 5041.521055499758, 5077.847664570032, 5097.5667068299235, 5105.222135619651, 5140.691558506464, 3489.0, 3782.2435512897255, 3992.441058251847, 4148.585141485857, 4197.271773347318, 4567.611753000999, 5160.4713690291865, 5202.453742357074, 5485.917711234335, 5493.450654934514, 3746.737728359016, 3749.981250093759, 3752.2870654575545, 3767.9449754068905, 3773.151041015777, 5140.922886156711, 5365.466181076984, 5737.496065588493, 5745.150748998181, 5846.561507886968, 3271.018694391673, 3558.2349794794245, 3783.1109689223013, 3786.8674596389546, 3802.315583194996, 3832.7125465590193, 3854.710896682704, 3858.3826587745825, 3875.244327356195, 3876.4960555127655, 3803.923921521554, 4208.410822484854, 4505.819767209275, 4516.954830451654, 4520.739630184908, 5219.112750832292, 5431.614938190736, 5539.224508568804, 5586.329640443173, 5638.436156384329, 1213.2538488829307, 1286.9163504372186, 1312.9474821007052, 1315.5658632651202, 1320.5906169087614, 725.3725527418745, 835.8035861572525, 836.7239959062479, 857.2798848966897, 889.2219308105408, 3926.9018274542796, 4074.103697186614, 5056.443791182967, 5139.897202055938, 5174.068667639785, 5138.820141295037, 5443.918341224885, 5594.244776955059, 5690.886182276331, 5736.971315143398, 4140.979295103505, 5036.769113944304, 5085.338905942203, 5193.324867767166, 5264.684118952799, 2562.974370256311, 2698.9190324290303, 2839.701831307683, 2993.6108305920093, 3005.430357044739, 5301.0, 5906.26171728534, 5912.157097886408, 5963.19496867926, 5995.370486098896, 5071.594272458195, 5446.428125046892, 5636.239107720406, 5913.704314784243, 5920.79277225295, 5523.475269849358, 5861.501772349313, 5915.733791979371, 5941.970290148522, 5990.940090599038, 5229.470107677226, 5478.480253790718, 5630.74661640219, 5667.886642267049, 5760.423957604206, 4955.876103097451, 5619.381867994435, 5637.605367624227, 5641.8589535261945, 5696.658200507983, 5388.329617818489, 5823.79616713413, 5943.465088142088, 5955.791547295824, 6023.0, 3527.165873745689, 3744.5319335083113, 3775.8861135964407, 3799.905002374963, 3837.9808100960436, 4680.812767489262, 5653.434656534479, 5664.235328230801, 5666.433356664301, 5778.27771528559, 4684.6486513510945, 5222.55608273301, 5606.607537472338, 5622.437756224344, 5637.238972738792, 5113.821016264562, 5344.9732751336, 5512.39363670004, 5542.722863856871, 5585.916211256753, 5167.638265321391, 5404.703260907667, 5438.709580703618, 5455.1544510600925, 5455.536279416136, 4326.913461730811, 5407.918881216863, 5462.6449280798215, 5494.945050549603, 5595.4748508439425, 5444.428335024765, 5455.918161227505, 5498.092814685692, 5498.642588231752, 5565.693886836101], "value": 4011.445572741609, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.4240828541309, 748.4835463530163, 749.763824395315, 785.6150486261733, 804.5333706450258, 14933.402663893445, 15521.844781552181, 15533.301001454933, 15550.300236489356, 15555.0, 13788.103773254732, 13975.021748477611, 13983.0, 13986.580402587913, 13999.300034998234, 644.1883227133799, 688.2360579756466, 694.2710154337925, 778.7897267737708, 856.4561503445326, 851.7572491839827, 871.3943809052679, 877.6138499060393, 887.6227603268617, 891.4651209274416, 892.2638822971043, 915.1763412928351, 917.8944421391559, 919.3380765848578, 920.4063379120463, 707.2185235314954, 869.8086420987372, 887.8002449448887, 908.8545832666807, 910.7723069232692, 548.2187882267792, 663.8473151175257, 683.1528904158807, 690.7409721354492, 691.1809505735669, 14766.409343626243, 15015.924920375328, 15145.0, 15350.923245383814, 15390.3074361654, 11768.235064720766, 13259.801102983367, 14124.152550846879, 14305.71388572233, 14423.711525769426, 12209.877901220963, 12516.74966500665, 12720.61838144848, 12842.550510732079, 13369.0, 4518.88702782433, 4565.931511027337, 4584.816607335702, 4783.880402989918, 4785.377900872899, 106259.0, 108979.45510272398, 110490.34264486039, 113600.0, 113872.0, 11040.723981900517, 11126.777464450666, 11133.387663678575, 11147.26368159204, 11445.828312575319, 22278.665820012713, 22439.775602244095, 22473.0, 22489.662655060187, 22635.773642263368, 7657.1959944205055, 7741.961290193625, 7751.263629955145, 7755.2244775521995, 7933.404994625426, 3623.7825730456257, 4127.9587204128175, 4171.791410429466, 4179.770112643834, 4306.332518459643, 3481.721462283062, 3578.1233597768714, 3593.69453596442, 3594.982025089858, 3595.658412450813, 651.5211319680031, 655.924568674599, 659.1266571792394, 675.5507587454288, 681.0125318288501, 621.3724138620026, 621.9937800622026, 624.6096189881324, 626.2485017978444, 630.1430055125027, 8391.874121888177, 9057.501837399006, 9069.41048831837, 9081.182693557479, 9167.49578773174, 498.27003439960635, 597.2593983460478, 623.7660877171061, 632.7975047984693, 638.4158494977137, 3717.7955212463576, 3871.3612253977776, 4888.462269150391, 5051.51445502602, 5147.0, 145350.2732486352, 146153.0, 150647.0, 150864.0, 151585.0, 109363.0, 115904.42047789707, 131962.34018829843, 132660.0, 137431.31284343515, 96047.55928661076, 101463.06542781022, 106710.0, 106964.88561830226, 107209.0, 9199.885174663365, 9434.103760142776, 9761.267904907018, 9788.85316720264, 9801.705948821547, 60762.696186518784, 61451.463713407524, 61797.0, 63723.3627663736, 64511.032334515956, 66746.66626666836, 85740.0, 89229.10770892208, 90540.64189037301, 90666.54666726888, 13209.669758256121, 13303.733925321632, 13338.639076800868, 13588.660283492993, 13818.65453363674, 14607.0, 14787.630309242355, 14804.7779283313, 14835.723604903256, 14951.252437378305, 13274.93362533181, 13405.66485837862, 13438.731225375243, 13822.723545529234, 13954.651133721738, 12181.781821817747, 12833.550825721055, 13548.254845983565, 13804.17174969505, 13889.166650001032, 13422.731545368842, 13463.932680336535, 13550.254735989221, 13567.932160339134, 13888.003823482459, 10116.747081323027, 10886.29239099456, 11187.832182517106, 11412.429378530875, 11615.245009074382, 10126.8480972784, 11304.830427543759, 11339.489722962322, 11495.712607184887, 11586.246893951866], "value": 7788.682049380047, "unit": "score"}], "name": "dromaeo_css", "value": 7227.90958883284, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 112.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 112.0, 155.0, 144.0, 142.0, 113.0, 117.0, 175.0, 140.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 180.0, 184.0, 184.0, 184.0, 183.0, 184.0, 183.0, 184.0, 179.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 86.0, 60.0, 60.0, 57.0, 58.0, 82.0, 57.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 89.0, 69.0, 67.0, 69.0, 91.0, 66.0, 67.0, 94.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 90.0, 90.0, 85.0, 91.0, 91.0, 89.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 99.0, 98.0, 97.0, 98.0, 98.0, 98.0, 98.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 80.0, 82.0, 80.0, 80.0, 82.0, 85.0, 83.0, 84.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 52.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 66.0, 76.0, 73.0, 69.0, 69.0, 69.0, 70.0, 72.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 85.0, 88.0, 90.0, 85.0, 83.0, 85.0, 88.0, 88.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 153.0, 153.0, 143.0, 147.0, 144.0, 146.0, 179.0, 146.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 174.0, 173.0, 170.0, 170.0, 234.0, 212.0, 173.0, 172.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1455.8, "alertThreshold": 2.0}]} 03:54:59 INFO - Return code: 0 03:54:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:54:59 INFO - # TBPL SUCCESS # 03:54:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:54:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:54:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:54:59 INFO - 2016-10-25 03:54:59.109 screenresolution[1699:9912] starting screenresolution argv=screenresolution get 03:54:59 INFO - 2016-10-25 03:54:59.112 screenresolution[1699:9912] Display 0: 1600x1200x32@60 03:54:59 INFO - 2016-10-25 03:54:59.118 screenresolution[1700:9915] starting screenresolution argv=screenresolution list 03:54:59 INFO - Available Modes on Display 0 03:54:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:54:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:54:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:54:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:54:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:54:59 INFO - Intel Iris: 03:54:59 INFO - Chipset Model: Intel Iris 03:54:59 INFO - Type: GPU 03:54:59 INFO - Bus: Built-In 03:54:59 INFO - VRAM (Dynamic, Max): 1536 MB 03:54:59 INFO - Vendor: Intel (0x8086) 03:54:59 INFO - Device ID: 0x0a2e 03:54:59 INFO - Revision ID: 0x0009 03:54:59 INFO - Displays: 03:54:59 INFO - Display: 03:54:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:54:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:54:59 INFO - Display Serial Number: 1600x1200 60 03:54:59 INFO - Main Display: Yes 03:54:59 INFO - Mirror: Off 03:54:59 INFO - Online: Yes 03:54:59 INFO - Rotation: Supported 03:54:59 INFO - Return code: 0 03:54:59 INFO - Running post-action listener: _resource_record_post_action 03:54:59 INFO - [mozharness: 2016-10-25 10:54:59.354247Z] Finished run-tests step (success) 03:54:59 INFO - Running post-run listener: _resource_record_post_run 03:54:59 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37684224; Write bytes: 707231232; Read time: 243; Write time: 1980 03:54:59 INFO - TinderboxPrint: CPU usage
53.5% 03:54:59 INFO - TinderboxPrint: I/O read bytes / time
37,684,224 / 243 03:54:59 INFO - TinderboxPrint: I/O write bytes / time
707,231,232 / 1,980 03:54:59 INFO - TinderboxPrint: CPU idle
2,258.6 (46.5%) 03:54:59 INFO - TinderboxPrint: CPU system
974.9 (20.1%) 03:54:59 INFO - TinderboxPrint: CPU user
1,628.2 (33.5%) 03:54:59 INFO - TinderboxPrint: Swap in / out
441,634,816 / 0 03:54:59 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389102080; Write bytes: 383960576; Read time: 29255; Write time: 825 03:54:59 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36717568; Write bytes: 299530240; Read time: 230; Write time: 1093 03:54:59 INFO - Running post-run listener: _upload_blobber_files 03:54:59 INFO - Blob upload gear active. 03:54:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:54:59 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 03:54:59 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'] 03:54:59 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 03:55:00 INFO - (blobuploader) - INFO - Open directory for files ... 03:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:00 INFO - (blobuploader) - INFO - Done attempting. 03:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:01 INFO - (blobuploader) - INFO - Done attempting. 03:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:55:04 INFO - (blobuploader) - INFO - Done attempting. 03:55:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:55:04 INFO - Return code: 0 03:55:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:55:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:55:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6f432bab2236cb13f20c6a87e08b49d76f17c8da3ae9410a5020c28464d0029b53b45d04b50d018db4a045add0b256509b741ff48751df5cc5d88b9eaf76f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce6653aae0dd5e119503205e9b0acffde5c9292c97a61bcadec454e3e91966f74e3d72a2e6c9f689dd5a38495f18d53878e00dd4278fd20fe064da1ee7149c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/456efc851279f49785cfb7ec9bb4f86a03cc670b92fa92db42febae5cfe1c61ad5a0163db828acc4763b0bffa05958b2382f4f3f2f8d0463dd4f8b37c813e010"} 03:55:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:55:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:55:04 INFO - Contents: 03:55:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6f432bab2236cb13f20c6a87e08b49d76f17c8da3ae9410a5020c28464d0029b53b45d04b50d018db4a045add0b256509b741ff48751df5cc5d88b9eaf76f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce6653aae0dd5e119503205e9b0acffde5c9292c97a61bcadec454e3e91966f74e3d72a2e6c9f689dd5a38495f18d53878e00dd4278fd20fe064da1ee7149c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/456efc851279f49785cfb7ec9bb4f86a03cc670b92fa92db42febae5cfe1c61ad5a0163db828acc4763b0bffa05958b2382f4f3f2f8d0463dd4f8b37c813e010"} 03:55:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:55:04 INFO - Copying logs to upload dir... 03:55:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:55:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.739358 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-25 03:55:04.734321) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:55:04.742056) ========= 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.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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/e6f432bab2236cb13f20c6a87e08b49d76f17c8da3ae9410a5020c28464d0029b53b45d04b50d018db4a045add0b256509b741ff48751df5cc5d88b9eaf76f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce6653aae0dd5e119503205e9b0acffde5c9292c97a61bcadec454e3e91966f74e3d72a2e6c9f689dd5a38495f18d53878e00dd4278fd20fe064da1ee7149c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/456efc851279f49785cfb7ec9bb4f86a03cc670b92fa92db42febae5cfe1c61ad5a0163db828acc4763b0bffa05958b2382f4f3f2f8d0463dd4f8b37c813e010"} build_url:https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011548 build_url: 'https://queue.taskcluster.net/v1/task/dZzFjO_kSDa5nBrpm87Awg/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/e6f432bab2236cb13f20c6a87e08b49d76f17c8da3ae9410a5020c28464d0029b53b45d04b50d018db4a045add0b256509b741ff48751df5cc5d88b9eaf76f6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce6653aae0dd5e119503205e9b0acffde5c9292c97a61bcadec454e3e91966f74e3d72a2e6c9f689dd5a38495f18d53878e00dd4278fd20fe064da1ee7149c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/456efc851279f49785cfb7ec9bb4f86a03cc670b92fa92db42febae5cfe1c61ad5a0163db828acc4763b0bffa05958b2382f4f3f2f8d0463dd4f8b37c813e010"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:55:05.318304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-10-25 03:55:05.318605) ========= 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.xVfDEXLOux/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.MX3dsJqdwI/Listeners TMPDIR=/var/folders/xs/dz060mwx3k394rmwvy72m0zr00000w/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.005098 ========= master_lag: 5.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-10-25 03:55:10.580462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:55:10.583842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:55:10.585611) ========= ========= Total master_lag: 5.95 =========