builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0107 starttime: 1475313036.67 results: success (0) buildid: 20160930232556 builduid: 06250708edb248db926db7f4505e316d revision: fcc62bbf09eecabf27c8d198d5d3719e16b296ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.675286) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.675677) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.676649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.808397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.808668) ========= 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.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-01 02:10:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.10M=0.001s 2016-10-01 02:10:36 (8.10 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.966032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:36.966315) ========= 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.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.021156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:37.014371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 02:10:37.014671) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fcc62bbf09eecabf27c8d198d5d3719e16b296ea --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 fcc62bbf09eecabf27c8d198d5d3719e16b296ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-01 02:10:37,085 truncating revision to first 12 chars 2016-10-01 02:10:37,085 Setting DEBUG logging. 2016-10-01 02:10:37,085 attempt 1/10 2016-10-01 02:10:37,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fcc62bbf09ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-01 02:10:37,848 unpacking tar archive at: mozilla-central-fcc62bbf09ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.035988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-01 02:10:38.072084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:38.072409) ========= script_repo_revision: fcc62bbf09eecabf27c8d198d5d3719e16b296ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:38.072792) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:38.073071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 02:10:38.091051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-01 02:10:38.091322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--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.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:10:38 INFO - MultiFileLogger online at 20161001 02:10:38 in /builds/slave/test 02:10:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:10:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:38 INFO - {'append_to_log': False, 02:10:38 INFO - 'base_work_dir': '/builds/slave/test', 02:10:38 INFO - 'blob_upload_branch': 'Firefox', 02:10:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:38 INFO - 'branch': 'Firefox', 02:10:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:38 INFO - 'config_files': ('talos/mac_config.py',), 02:10:38 INFO - 'default_actions': ('clobber', 02:10:38 INFO - 'read-buildbot-config', 02:10:38 INFO - 'download-and-extract', 02:10:38 INFO - 'populate-webroot', 02:10:38 INFO - 'create-virtualenv', 02:10:38 INFO - 'install', 02:10:38 INFO - 'run-tests'), 02:10:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:38 INFO - 'download_minidump_stackwalk': True, 02:10:38 INFO - 'download_symbols': 'ondemand', 02:10:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:38 INFO - 'installer_path': 'installer.exe', 02:10:38 INFO - 'log_level': 'info', 02:10:38 INFO - 'log_name': 'talos', 02:10:38 INFO - 'log_to_console': True, 02:10:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:10:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:10:38 INFO - 'opt_config_files': (), 02:10:38 INFO - 'pip_index': False, 02:10:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:38 INFO - 'cmd': ('bash', 02:10:38 INFO - '-c', 02:10:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:38 INFO - 'enabled': True, 02:10:38 INFO - 'halt_on_failure': False, 02:10:38 INFO - 'name': 'check_screen_resolution'},), 02:10:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:10:38 INFO - 'cmd': ('bash', 02:10:38 INFO - '-c', 02:10:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:10:38 INFO - 'enabled': True, 02:10:38 INFO - 'halt_on_failure': False, 02:10:38 INFO - 'name': 'check_screen_resolution'},), 02:10:38 INFO - 'run_cmd_checks_enabled': True, 02:10:38 INFO - 'sps_profile': False, 02:10:38 INFO - 'sps_profile_interval': 0, 02:10:38 INFO - 'suite': 'dromaeojs-e10s', 02:10:38 INFO - 'system_bits': '32', 02:10:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:38 INFO - 'title': 't-yosemite-r7-0107', 02:10:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:38 INFO - 'use_talos_json': True, 02:10:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:38 INFO - 'work_dir': 'build'} 02:10:38 INFO - [mozharness: 2016-10-01 09:10:38.303806Z] Running clobber step. 02:10:38 INFO - Running pre-action listener: _resource_record_pre_action 02:10:38 INFO - Running main action method: clobber 02:10:38 INFO - rmtree: /builds/slave/test/build 02:10:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:40 INFO - Running post-action listener: _resource_record_post_action 02:10:40 INFO - [mozharness: 2016-10-01 09:10:40.487500Z] Finished clobber step (success) 02:10:40 INFO - [mozharness: 2016-10-01 09:10:40.487719Z] Running read-buildbot-config step. 02:10:40 INFO - Running pre-action listener: _resource_record_pre_action 02:10:40 INFO - Running main action method: read_buildbot_config 02:10:40 INFO - Using buildbot properties: 02:10:40 INFO - { 02:10:40 INFO - "project": "", 02:10:40 INFO - "product": "firefox", 02:10:40 INFO - "script_repo_revision": "production", 02:10:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:10:40 INFO - "repository": "", 02:10:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:10:40 INFO - "buildid": "20160930232556", 02:10:40 INFO - "pgo_build": "False", 02:10:40 INFO - "basedir": "/builds/slave/test", 02:10:40 INFO - "buildnumber": 302, 02:10:40 INFO - "slavename": "t-yosemite-r7-0107", 02:10:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:10:40 INFO - "platform": "yosemite_r7", 02:10:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:10:40 INFO - "branch": "mozilla-central", 02:10:40 INFO - "repo_path": "mozilla-central", 02:10:40 INFO - "revision": "fcc62bbf09eecabf27c8d198d5d3719e16b296ea", 02:10:40 INFO - "stage_platform": "macosx64", 02:10:40 INFO - "builduid": "06250708edb248db926db7f4505e316d", 02:10:40 INFO - "slavebuilddir": "test" 02:10:40 INFO - } 02:10:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 02:10:40 INFO - Running post-action listener: _resource_record_post_action 02:10:40 INFO - [mozharness: 2016-10-01 09:10:40.491842Z] Finished read-buildbot-config step (success) 02:10:40 INFO - [mozharness: 2016-10-01 09:10:40.491984Z] Running download-and-extract step. 02:10:40 INFO - Running pre-action listener: _resource_record_pre_action 02:10:40 INFO - Running main action method: download_and_extract 02:10:40 INFO - mkdir: /builds/slave/test/build/tests 02:10:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:40 INFO - trying https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 02:10:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/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 02:10:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/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 02:10:41 INFO - Downloaded 1199 bytes. 02:10:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 02:10:41 INFO - Using the following test package requirements: 02:10:41 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 02:10:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 02:10:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 02:10:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'jsshell-mac.zip'], 02:10:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 02:10:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 02:10:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 02:10:41 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 02:10:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 02:10:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 02:10:41 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 02:10:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:10:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 02:10:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:10:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 02:10:42 INFO - Http code: 200 02:10:42 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 02:10:42 INFO - x-amz-cf-id: GUvheDesBrK0Hq8cLYi2wHXugTnujJYMJoBBQQLnZD4bF9tUchLudA== 02:10:42 INFO - x-amz-version-id: C6L0_yAISQyr3Vcpu9GUtsBn5TPuRGl1 02:10:42 INFO - Expected file size: 16475339 02:10:42 INFO - Obtained file size: 16475339 02:10:49 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 02:10:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 02:10:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:10:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 02:10:50 INFO - Http code: 200 02:10:50 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 02:10:50 INFO - x-amz-cf-id: a1n-SeMuzOStjEG247SNrAU1ZX_DwJliFJxKSqfAVzoXXWCnKCSfAA== 02:10:50 INFO - x-amz-version-id: C6L0_yAISQyr3Vcpu9GUtsBn5TPuRGl1 02:10:50 INFO - Expected file size: 16475339 02:10:50 INFO - Obtained file size: 16475339 02:10:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 02:10:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:10:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 02:10:57 INFO - Http code: 200 02:10:57 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 02:10:57 INFO - x-amz-cf-id: qUmYLdGc4pgWDLJJjSKoKQbCowijAvxwTrQ4GaA5dx4cV82cn8hMXA== 02:10:57 INFO - x-amz-version-id: .N1w5I9nOwPLgXrcH2q3397lWlybi3mJ 02:10:58 INFO - Expected file size: 14408522 02:10:58 INFO - Obtained file size: 14408522 02:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:10:58 INFO - trying https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:10:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 02:10:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/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 02:11:01 INFO - Downloaded 111786306 bytes. 02:11:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:11:01 INFO - mkdir: /builds/slave/test/properties 02:11:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:11:01 INFO - Writing to file /builds/slave/test/properties/build_url 02:11:01 INFO - Contents: 02:11:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 02:11:02 INFO - Running post-action listener: _resource_record_post_action 02:11:02 INFO - Running post-action listener: set_extra_try_arguments 02:11:02 INFO - [mozharness: 2016-10-01 09:11:02.321915Z] Finished download-and-extract step (success) 02:11:02 INFO - [mozharness: 2016-10-01 09:11:02.322027Z] Running populate-webroot step. 02:11:02 INFO - Running pre-action listener: _resource_record_pre_action 02:11:02 INFO - Running main action method: populate_webroot 02:11:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:11:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:11:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:11:02 INFO - '--tppagecycles', 02:11:02 INFO - '7'], 02:11:02 INFO - 'tests': ['tsvgm']}}, 02:11:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:11:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:11:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:11:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:11:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:11:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['damp', 'tps']}, 02:11:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'tests': ['damp', 'tps']}, 02:11:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['dromaeo_dom']}, 02:11:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:11:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['basic_compositor_video']}, 02:11:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:11:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'other-e10s': {'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['a11yr', 02:11:02 INFO - 'ts_paint', 02:11:02 INFO - 'tpaint', 02:11:02 INFO - 'sessionrestore', 02:11:02 INFO - 'sessionrestore_no_auto_restore', 02:11:02 INFO - 'tabpaint']}, 02:11:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['tsvgx', 02:11:02 INFO - 'tsvgr_opacity', 02:11:02 INFO - 'tart', 02:11:02 INFO - 'tscrollx', 02:11:02 INFO - 'cart']}, 02:11:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:11:02 INFO - 'tsvgr_opacity', 02:11:02 INFO - 'tart', 02:11:02 INFO - 'tscrollx', 02:11:02 INFO - 'cart']}, 02:11:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'talos_options': ['--disable-e10s'], 02:11:02 INFO - 'tests': ['tp5o']}, 02:11:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'tests': ['tp5o']}, 02:11:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'talos_options': ['--disable-e10s', 02:11:02 INFO - '--xperf_path', 02:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:02 INFO - 'tests': ['tp5n']}, 02:11:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:11:02 INFO - 'talos_options': ['--xperf_path', 02:11:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:11:02 INFO - 'tests': ['tp5n']}}, 02:11:02 INFO - 'talos.zip': {'path': '', 02:11:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:11:02 INFO - Running post-action listener: _resource_record_post_action 02:11:02 INFO - [mozharness: 2016-10-01 09:11:02.341076Z] Finished populate-webroot step (success) 02:11:02 INFO - [mozharness: 2016-10-01 09:11:02.341187Z] Running create-virtualenv step. 02:11:02 INFO - Running pre-action listener: _resource_record_pre_action 02:11:02 INFO - Running main action method: create_virtualenv 02:11:02 INFO - Creating virtualenv /builds/slave/test/build/venv 02:11:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:11:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:11:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:11:02 INFO - Using real prefix '/tools/python27' 02:11:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:11:03 INFO - Installing distribute.............................................................................................................................................................................................done. 02:11:06 INFO - Installing pip.................done. 02:11:06 INFO - Return code: 0 02:11:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:11:06 INFO - Reading from file tmpfile_stdout 02:11:06 INFO - Output received: 02:11:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:11:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:06 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:06 INFO - 'HOME': '/Users/cltbld', 02:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:06 INFO - 'LOGNAME': 'cltbld', 02:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:06 INFO - 'MOZ_NO_REMOTE': '1', 02:11:06 INFO - 'NO_EM_RESTART': '1', 02:11:06 INFO - 'PAGER': '/bin/cat', 02:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:06 INFO - 'PWD': '/builds/slave/test', 02:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:06 INFO - 'SHELL': '/bin/bash', 02:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:06 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:06 INFO - 'USER': 'cltbld', 02:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:06 INFO - 'XPC_FLAGS': '0x0', 02:11:06 INFO - 'XPC_SERVICE_NAME': '0', 02:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:11:06 INFO - Cleaning up... 02:11:06 INFO - Return code: 0 02:11:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:06 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:11:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:06 INFO - 'HOME': '/Users/cltbld', 02:11:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:06 INFO - 'LOGNAME': 'cltbld', 02:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:06 INFO - 'MOZ_NO_REMOTE': '1', 02:11:06 INFO - 'NO_EM_RESTART': '1', 02:11:06 INFO - 'PAGER': '/bin/cat', 02:11:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:06 INFO - 'PWD': '/builds/slave/test', 02:11:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:06 INFO - 'SHELL': '/bin/bash', 02:11:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:06 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:06 INFO - 'USER': 'cltbld', 02:11:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:06 INFO - 'XPC_FLAGS': '0x0', 02:11:06 INFO - 'XPC_SERVICE_NAME': '0', 02:11:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:07 INFO - Downloading/unpacking psutil>=3.1.1 02:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:10 INFO - Installing collected packages: psutil 02:11:10 INFO - Running setup.py install for psutil 02:11:10 INFO - building 'psutil._psutil_osx' extension 02:11:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:11:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:11:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:11:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:11:11 INFO - building 'psutil._psutil_posix' extension 02:11:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:11:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:11:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:11:11 INFO - ^ 02:11:11 INFO - 1 warning generated. 02:11:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:11:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:11:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:11:11 INFO - Successfully installed psutil 02:11:11 INFO - Cleaning up... 02:11:11 INFO - Return code: 0 02:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:11 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:11:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:11 INFO - 'HOME': '/Users/cltbld', 02:11:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:11 INFO - 'LOGNAME': 'cltbld', 02:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:11 INFO - 'MOZ_NO_REMOTE': '1', 02:11:11 INFO - 'NO_EM_RESTART': '1', 02:11:11 INFO - 'PAGER': '/bin/cat', 02:11:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:11 INFO - 'PWD': '/builds/slave/test', 02:11:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:11 INFO - 'SHELL': '/bin/bash', 02:11:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:11 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:11 INFO - 'USER': 'cltbld', 02:11:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:11 INFO - 'XPC_FLAGS': '0x0', 02:11:11 INFO - 'XPC_SERVICE_NAME': '0', 02:11:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:11:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:11:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:11:14 INFO - Installing collected packages: mozsystemmonitor 02:11:14 INFO - Running setup.py install for mozsystemmonitor 02:11:14 INFO - Successfully installed mozsystemmonitor 02:11:14 INFO - Cleaning up... 02:11:14 INFO - Return code: 0 02:11:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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', '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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:11: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 jsonschema==2.5.1 02:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:14 INFO - 'HOME': '/Users/cltbld', 02:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:14 INFO - 'LOGNAME': 'cltbld', 02:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:14 INFO - 'MOZ_NO_REMOTE': '1', 02:11:14 INFO - 'NO_EM_RESTART': '1', 02:11:14 INFO - 'PAGER': '/bin/cat', 02:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:14 INFO - 'PWD': '/builds/slave/test', 02:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:14 INFO - 'SHELL': '/bin/bash', 02:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:14 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:14 INFO - 'USER': 'cltbld', 02:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:14 INFO - 'XPC_FLAGS': '0x0', 02:11:14 INFO - 'XPC_SERVICE_NAME': '0', 02:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:15 INFO - Downloading/unpacking jsonschema==2.5.1 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:11:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:18 INFO - Downloading functools32-3.2.3-2.tar.gz 02:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:11:18 INFO - warning: no files found matching '*.txt' 02:11:18 INFO - no previously-included directories found matching 'build' 02:11:18 INFO - no previously-included directories found matching 'dist' 02:11:18 INFO - no previously-included directories found matching '.git*' 02:11:18 INFO - Installing collected packages: jsonschema, functools32 02:11:18 INFO - Running setup.py install for functools32 02:11:18 INFO - warning: no files found matching '*.txt' 02:11:18 INFO - no previously-included directories found matching 'build' 02:11:18 INFO - no previously-included directories found matching 'dist' 02:11:18 INFO - no previously-included directories found matching '.git*' 02:11:18 INFO - Successfully installed jsonschema functools32 02:11:18 INFO - Cleaning up... 02:11:18 INFO - Return code: 0 02:11:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:18 INFO - 'HOME': '/Users/cltbld', 02:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:18 INFO - 'LOGNAME': 'cltbld', 02:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:18 INFO - 'MOZ_NO_REMOTE': '1', 02:11:18 INFO - 'NO_EM_RESTART': '1', 02:11:18 INFO - 'PAGER': '/bin/cat', 02:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:18 INFO - 'PWD': '/builds/slave/test', 02:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:18 INFO - 'SHELL': '/bin/bash', 02:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:18 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:18 INFO - 'USER': 'cltbld', 02:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:18 INFO - 'XPC_FLAGS': '0x0', 02:11:18 INFO - 'XPC_SERVICE_NAME': '0', 02:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:11:18 INFO - Cleaning up... 02:11:18 INFO - Return code: 0 02:11:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:18 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:18 INFO - 'HOME': '/Users/cltbld', 02:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:18 INFO - 'LOGNAME': 'cltbld', 02:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:18 INFO - 'MOZ_NO_REMOTE': '1', 02:11:18 INFO - 'NO_EM_RESTART': '1', 02:11:18 INFO - 'PAGER': '/bin/cat', 02:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:18 INFO - 'PWD': '/builds/slave/test', 02:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:18 INFO - 'SHELL': '/bin/bash', 02:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:18 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:18 INFO - 'USER': 'cltbld', 02:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:18 INFO - 'XPC_FLAGS': '0x0', 02:11:18 INFO - 'XPC_SERVICE_NAME': '0', 02:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:21 INFO - Downloading blobuploader-1.2.4.tar.gz 02:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:11:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:11:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:11:22 INFO - Downloading docopt-0.6.1.tar.gz 02:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:11:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:11:22 INFO - Running setup.py install for blobuploader 02:11:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:11:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:11:22 INFO - Running setup.py install for requests 02:11:23 INFO - Running setup.py install for docopt 02:11:23 INFO - Successfully installed blobuploader requests docopt 02:11:23 INFO - Cleaning up... 02:11:23 INFO - Return code: 0 02:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11: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')]} 02:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11: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')]} 02:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:23 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:23 INFO - 'HOME': '/Users/cltbld', 02:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:23 INFO - 'LOGNAME': 'cltbld', 02:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:23 INFO - 'MOZ_NO_REMOTE': '1', 02:11:23 INFO - 'NO_EM_RESTART': '1', 02:11:23 INFO - 'PAGER': '/bin/cat', 02:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:23 INFO - 'PWD': '/builds/slave/test', 02:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:23 INFO - 'SHELL': '/bin/bash', 02:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:23 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:23 INFO - 'USER': 'cltbld', 02:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:23 INFO - 'XPC_FLAGS': '0x0', 02:11:23 INFO - 'XPC_SERVICE_NAME': '0', 02:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:23 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-PF1KTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:23 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-X67Mgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-UqEHjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-3UZiI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-pgA094-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4iLiKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-rL_ZeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-iYXZBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4g765B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Vp8but-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-SDIWmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:24 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-AnVFQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-ONHdp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-lhhLCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-BRelE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-kJTWsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:25 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zv90kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:11:25 INFO - Running setup.py install for manifestparser 02:11:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:11:25 INFO - Running setup.py install for mozcrash 02:11:25 INFO - Running setup.py install for mozdebug 02:11:26 INFO - Running setup.py install for mozdevice 02:11:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Running setup.py install for mozfile 02:11:26 INFO - Running setup.py install for mozhttpd 02:11:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Running setup.py install for mozinfo 02:11:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Running setup.py install for mozInstall 02:11:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:11:26 INFO - Running setup.py install for mozleak 02:11:26 INFO - Running setup.py install for mozlog 02:11:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Running setup.py install for moznetwork 02:11:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Running setup.py install for mozprocess 02:11:27 INFO - Running setup.py install for mozprofile 02:11:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Running setup.py install for mozrunner 02:11:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:11:27 INFO - Running setup.py install for mozscreenshot 02:11:27 INFO - Running setup.py install for moztest 02:11:28 INFO - Running setup.py install for mozversion 02:11:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:11:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:11:28 INFO - Cleaning up... 02:11:28 INFO - Return code: 0 02:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:28 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:28 INFO - 'HOME': '/Users/cltbld', 02:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:28 INFO - 'LOGNAME': 'cltbld', 02:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:28 INFO - 'MOZ_NO_REMOTE': '1', 02:11:28 INFO - 'NO_EM_RESTART': '1', 02:11:28 INFO - 'PAGER': '/bin/cat', 02:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:28 INFO - 'PWD': '/builds/slave/test', 02:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:28 INFO - 'SHELL': '/bin/bash', 02:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:28 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:28 INFO - 'USER': 'cltbld', 02:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:28 INFO - 'XPC_FLAGS': '0x0', 02:11:28 INFO - 'XPC_SERVICE_NAME': '0', 02:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:11:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-YflCwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:11:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-2en8oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:11:28 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)) 02:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:11:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-nSlbom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:11:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-Y4yPNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:11:28 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)) 02:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:11:28 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-YB9pR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-PV_F0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-gz74Nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-zfs8ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-1Od2jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-YcQ12L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-i9XIKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-_rWoUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:11:29 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)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-fnhRUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:11:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:11:29 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-eM4UPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:11:30 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)) 02:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-D4BdXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:11:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-4aeCgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:11:30 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)) 02:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:11:30 INFO - Running setup.py (path:/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/pip-d4qxMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:11:30 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)) 02:11:30 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)) 02:11:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:11:30 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)) 02:11:30 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)) 02:11:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11: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 02:11:32 INFO - Downloading blessings-1.6.tar.gz 02:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:11:32 INFO - Installing collected packages: blessings 02:11:32 INFO - Running setup.py install for blessings 02:11:33 INFO - Successfully installed blessings 02:11:33 INFO - Cleaning up... 02:11:33 INFO - Return code: 0 02:11:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:11:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:33 INFO - Reading from file tmpfile_stdout 02:11:33 INFO - Current package versions: 02:11:33 INFO - blessings == 1.6 02:11:33 INFO - blobuploader == 1.2.4 02:11:33 INFO - docopt == 0.6.1 02:11:33 INFO - functools32 == 3.2.3-2 02:11:33 INFO - jsonschema == 2.5.1 02:11:33 INFO - manifestparser == 1.1 02:11:33 INFO - mozInstall == 1.12 02:11:33 INFO - mozcrash == 0.17 02:11:33 INFO - mozdebug == 0.1 02:11:33 INFO - mozdevice == 0.48 02:11:33 INFO - mozfile == 1.2 02:11:33 INFO - mozhttpd == 0.7 02:11:33 INFO - mozinfo == 0.9 02:11:33 INFO - mozleak == 0.1 02:11:33 INFO - mozlog == 3.4 02:11:33 INFO - moznetwork == 0.27 02:11:33 INFO - mozprocess == 0.23 02:11:33 INFO - mozprofile == 0.28 02:11:33 INFO - mozrunner == 6.12 02:11:33 INFO - mozscreenshot == 0.1 02:11:33 INFO - mozsystemmonitor == 0.3 02:11:33 INFO - moztest == 0.7 02:11:33 INFO - mozversion == 1.4 02:11:33 INFO - psutil == 3.1.1 02:11:33 INFO - requests == 1.2.3 02:11:33 INFO - wsgiref == 0.1.2 02:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:33 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 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:33 INFO - 'HOME': '/Users/cltbld', 02:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:33 INFO - 'LOGNAME': 'cltbld', 02:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:33 INFO - 'MOZ_NO_REMOTE': '1', 02:11:33 INFO - 'NO_EM_RESTART': '1', 02:11:33 INFO - 'PAGER': '/bin/cat', 02:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:33 INFO - 'PWD': '/builds/slave/test', 02:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:33 INFO - 'SHELL': '/bin/bash', 02:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:33 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:33 INFO - 'USER': 'cltbld', 02:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:33 INFO - 'XPC_FLAGS': '0x0', 02:11:33 INFO - 'XPC_SERVICE_NAME': '0', 02:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:11:33 INFO - Cleaning up... 02:11:33 INFO - Return code: 0 02:11:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:11:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bb50490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bac6570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe8cb58d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, '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.3KlfbHg0GP/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.ppe0u43W6U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:11:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:11:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:11:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:11:33 INFO - 'HOME': '/Users/cltbld', 02:11:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:11:33 INFO - 'LOGNAME': 'cltbld', 02:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:11:33 INFO - 'MOZ_NO_REMOTE': '1', 02:11:33 INFO - 'NO_EM_RESTART': '1', 02:11:33 INFO - 'PAGER': '/bin/cat', 02:11:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:11:33 INFO - 'PWD': '/builds/slave/test', 02:11:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:11:33 INFO - 'SHELL': '/bin/bash', 02:11:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:11:33 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:11:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:11:33 INFO - 'USER': 'cltbld', 02:11:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:11:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:11:33 INFO - 'XPC_FLAGS': '0x0', 02:11:33 INFO - 'XPC_SERVICE_NAME': '0', 02:11:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:11:34 INFO - Cleaning up... 02:11:34 INFO - Return code: 0 02:11:34 INFO - Running post-action listener: _resource_record_post_action 02:11:34 INFO - Running post-action listener: _start_resource_monitoring 02:11:34 INFO - Starting resource monitoring. 02:11:34 INFO - [mozharness: 2016-10-01 09:11:34.062882Z] Finished create-virtualenv step (success) 02:11:34 INFO - [mozharness: 2016-10-01 09:11:34.063912Z] Running install step. 02:11:34 INFO - Running pre-action listener: _resource_record_pre_action 02:11:34 INFO - Running main action method: install 02:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:11:34 INFO - Reading from file tmpfile_stdout 02:11:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:11:34 INFO - Reading from file tmpfile_stdout 02:11:34 INFO - Output received: 02:11:34 INFO - Usage: mozinstall [options] installer 02:11:34 INFO - Options: 02:11:34 INFO - -h, --help show this help message and exit 02:11:34 INFO - -d DEST, --destination=DEST 02:11:34 INFO - Directory to install application into. [default: 02:11:34 INFO - "/builds/slave/test"] 02:11:34 INFO - --app=APP Application being installed. [default: firefox] 02:11:34 INFO - mkdir: /builds/slave/test/build/application 02:11:34 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'] 02:11:34 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 02:12:08 INFO - Reading from file tmpfile_stdout 02:12:08 INFO - Output received: 02:12:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:12:08 INFO - Running post-action listener: _resource_record_post_action 02:12:08 INFO - [mozharness: 2016-10-01 09:12:08.834481Z] Finished install step (success) 02:12:08 INFO - [mozharness: 2016-10-01 09:12:08.834625Z] Running run-tests step. 02:12:08 INFO - Running pre-action listener: _resource_record_pre_action 02:12:08 INFO - Running main action method: run_tests 02:12:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:12:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:12:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:12:08 INFO - 2016-10-01 02:12:08.849 screenresolution[1939:66492] starting screenresolution argv=screenresolution get 02:12:08 INFO - 2016-10-01 02:12:08.852 screenresolution[1939:66492] Display 0: 1600x1200x32@60 02:12:08 INFO - 2016-10-01 02:12:08.858 screenresolution[1940:66495] starting screenresolution argv=screenresolution list 02:12:08 INFO - Available Modes on Display 0 02:12:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:12:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:12:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:12:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:12:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:12:09 INFO - Intel Iris: 02:12:09 INFO - Chipset Model: Intel Iris 02:12:09 INFO - Type: GPU 02:12:09 INFO - Bus: Built-In 02:12:09 INFO - VRAM (Dynamic, Max): 1536 MB 02:12:09 INFO - Vendor: Intel (0x8086) 02:12:09 INFO - Device ID: 0x0a2e 02:12:09 INFO - Revision ID: 0x0009 02:12:09 INFO - Displays: 02:12:09 INFO - Display: 02:12:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:12:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:12:09 INFO - Display Serial Number: 1600x1200 60 02:12:09 INFO - Main Display: Yes 02:12:09 INFO - Mirror: Off 02:12:09 INFO - Online: Yes 02:12:09 INFO - Rotation: Supported 02:12:09 INFO - Return code: 0 02:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:12:09 INFO - Python 2.7.3 02:12:09 INFO - Return code: 0 02:12:09 INFO - grabbing minidump binary from tooltool 02:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:09 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 0x10b964d30>, '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 0x10b78adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b95cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:12:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:12:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:12:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:12:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:12:09 INFO - Return code: 0 02:12:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:12:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:12:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:12:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:12:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0107 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3KlfbHg0GP/Render', 02:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:12:09 INFO - 'HOME': '/Users/cltbld', 02:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:12:09 INFO - 'LOGNAME': 'cltbld', 02:12:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:12:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:09 INFO - 'MOZ_NO_REMOTE': '1', 02:12:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:12:09 INFO - 'NO_EM_RESTART': '1', 02:12:09 INFO - 'PAGER': '/bin/cat', 02:12:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:09 INFO - 'PWD': '/builds/slave/test', 02:12:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:12:09 INFO - 'SHELL': '/bin/bash', 02:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ppe0u43W6U/Listeners', 02:12:09 INFO - 'TMPDIR': '/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/', 02:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:12:09 INFO - 'USER': 'cltbld', 02:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:09 INFO - 'XPC_FLAGS': '0x0', 02:12:09 INFO - 'XPC_SERVICE_NAME': '0', 02:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:12:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0107', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:12:09 INFO - mozversion application_buildid: 20160930232556 02:12:09 INFO - mozversion application_changeset: fcc62bbf09eecabf27c8d198d5d3719e16b296ea 02:12:09 INFO - mozversion application_display_name: Nightly 02:12:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:12:09 INFO - mozversion application_name: Firefox 02:12:09 INFO - mozversion application_remotingname: firefox 02:12:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:12:09 INFO - mozversion application_vendor: Mozilla 02:12:09 INFO - mozversion application_version: 52.0a1 02:12:09 INFO - mozversion platform_buildid: 20160930232556 02:12:09 INFO - mozversion platform_changeset: fcc62bbf09eecabf27c8d198d5d3719e16b296ea 02:12:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:12:09 INFO - mozversion platform_version: 52.0a1 02:12:09 INFO - using testdate: 1475313129 02:12:09 INFO - actual date: 1475313129 02:12:09 INFO - starting webserver on 'localhost:54335' 02:12:09 INFO - SUITE-START | Running 2 tests 02:12:09 INFO - TEST-START | dromaeo_css 02:12:09 INFO - operating with platform_type : mac_ 02:12:09 INFO - Initialising browser for dromaeo_css test... 02:12:09 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpAQLt1l/profile http://localhost:54335/getInfo.html) 02:12:12 INFO - PROCESS | 1950 | 2016-10-01 02:12:12.110 plugin-container[1952:66653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903f, name = 'com.apple.tsm.portname' 02:12:12 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:12 INFO - PROCESS | 1950 | 2016-10-01 02:12:12.113 plugin-container[1952:66653] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a17, name = 'com.apple.CFPasteboardClient' 02:12:12 INFO - PROCESS | 1950 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:12 INFO - PROCESS | 1950 | 2016-10-01 02:12:12.113 plugin-container[1952:66653] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:12:12 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 02:12:12 INFO - PROCESS | 1950 | colorDepth:24 02:12:12 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 02:12:12 INFO - PROCESS | 1950 | __metrics 02:12:12 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 02:12:12 INFO - TEST-INFO | 1950: exit 0 02:12:12 INFO - Browser initialized. 02:12:12 INFO - Running cycle 1/1 for dromaeo_css test... 02:12:12 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmpAQLt1l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:12:15 INFO - PROCESS | 1953 | 2016-10-01 02:12:15.473 plugin-container[1954:66770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1f, name = 'com.apple.tsm.portname' 02:12:15 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:15 INFO - PROCESS | 1953 | 2016-10-01 02:12:15.477 plugin-container[1954:66770] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9403, name = 'com.apple.CFPasteboardClient' 02:12:15 INFO - PROCESS | 1953 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:12:15 INFO - PROCESS | 1953 | 2016-10-01 02:12:15.477 plugin-container[1954:66770] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:12:25 INFO - PROCESS | 1953 | RSS: Main: 240033792 02:12:25 INFO - PROCESS | 1953 | 02:13:14 INFO - PROCESS | 1953 | 1475313194672 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] 02:15:28 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54335/tests/dromaeo/cssquery-ext.html) 02:15:29 INFO - PROCESS | 1953 | RSS: Main: 252661760 02:15:29 INFO - PROCESS | 1953 | 02:18:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-ext.html (next: http://localhost:54335/tests/dromaeo/cssquery-jquery.html) 02:18:32 INFO - PROCESS | 1953 | RSS: Main: 266719232 02:18:32 INFO - PROCESS | 1953 | 02:21:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54335/tests/dromaeo/cssquery-mootools.html) 02:21:34 INFO - PROCESS | 1953 | RSS: Main: 270479360 02:21:34 INFO - PROCESS | 1953 | 02:24:36 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54335/tests/dromaeo/cssquery-prototype.html) 02:24:37 INFO - PROCESS | 1953 | RSS: Main: 270114816 02:24:37 INFO - PROCESS | 1953 | 02:27:40 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54335/tests/dromaeo/cssquery-yui.html) 02:27:40 INFO - PROCESS | 1953 | RSS: Main: 275439616 02:27:40 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:54335/tests/dromaeo/cssquery-yui.html (next: http://localhost:54335/tests/dromaeo/cssquery-dojo.html) 02:30:43 INFO - PROCESS | 1953 | RSS: Main: 278130688 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | __start_tp_report 02:30:43 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 02:30:43 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 02:30:43 INFO - PROCESS | 1953 | |i|pagename|runs| 02:30:43 INFO - PROCESS | 1953 | |0;dojo.html;3275;3295.8299803569735;3335.2328964338203;3344.398008358496;3353.195233144043;5381.354237491507;5464.426235245297;5533.1147016477325;5545.445455454453;5587.916181257274;5508.944910550893;5557.305336832896;5602.663840169593;5608.551315894729;5614.550835933115;4978.029284289565;5023.598112151019;5053.570446512051;5065.721385323805;5072.644914855961;5062;5072.9746351268195;5167.431582525919;5181.533661970422;5206.088934436478;5022.673526220784;5161.896762064775;5189.610779191576;5221.765020574065;5264.499872512105;5040.143175660147;5111.7699703513435;5126.615503837227;5153.639245252796;5173;4768.165571025057;5005.47442518534;5068.771905264235;5095.439501654815;5110.361204849394;4335.869923902288;5298.708571028592;5423.240746295522;5511.724413779295;5554.527865131468;5961.986462301419;5974.910376344358;6007.309159446676;6086.878262434727;6137.048757442603;6093.421124993163;6127.045207093565;6164.137020817089;6177.351378105279;6199.8530271899845;5493.752781124859;5628.662280263197;5629.211910332557;5631.859203519863;5674.886502269931;6132.661461321608;6146.985747351637;6184.226971628546;6192.411720886508;6220.471259942956;5961.642301461839;5974;5975.282966044103;5985.820425387245;6026.367231440723;5989.431004054608;6089.512838972872;6090.969545152335;6146.969265153645;6152.569320147547;5550.888982220333;5957.046872500379;5965.254343207099;5993;6066.4540191382985;4122.134351786159;5012.7994880205115;5790.855228619234;6137.070562331796;6140.539459540552;3981.980090099589;4819.469858315582;4821.445533763592;4826.444958829709;4829.420469543677;3937.8621748239248;4128.525219599725;4202.894927626834;4285.935710964338;4293.892652683708;5151.639385242997;5192.896142077213;5728.79949201776;5734.655920644775;5779.739911703983;4763.618910487153;6001.579889407787;6083.057126145454;6105.236845394325;6134.9693251534345;5515.806946756844;5560;5628.268325117709;5669.149627555899;5672.149177623307;5259.05337039329;5298.576113910878;5332.146856502941;5343.893122137535;5361.544268737123;6248.031555108965;6260.154879091356;6267.2479302484;6270.467010304175;6281.403266689657;5933.902228087818;6033.78881739137;6140.078988151813;6176.166217560572;6195.628262304276;6170.413810688157;6177;6183.96908015457;6227.314995350598;6288.748450061947;5959.314678811992;5960.254968128984;5971.940280597139;5981.790637327673;5987.341392446914;5683.948469533149;5689.914651280317;6085.9695701521205;6109.236345456818;6134.141220229082;5679.829605111853;5737.48362647347;5816.0694288915265;5841.737121829443;5845.09401042839;5846.766129354778;5912.940870591239;5922.496587790086;5936.703164841827;5950.256217972754;5376.623636345418;5607.607467477237;5699.629524080921;5753.597248192586;5775.451332123442;5825;5926.318473375617;5944.375840536682;5947.405259474018;5950.404959504015;5649.180868773922;5671.8865622688145;5680.11958146488;5700.800471983461;5720.227769251098 02:30:43 INFO - PROCESS | 1953 | |1;ext.html;443.2420560840962;495.4599486559654;502.0561344672016;507.53814029233394;540.8512659018769;39623.603763962354;41917.532886348985;41942;41966.79016604916;42000.78999605005;34390;43091.35362969558;43710.56289437105;43756.90607734808;43929.12141757163;9774;9953.701388958307;9972.3517971332;9973.50132493376;9999.400035997864;9697.612095516171;9747.75630609237;9789.118979291863;9803.558839852189;9841.507924603777;9829.311948163631;9854.06386393295;9861.605535778595;9864.358816676893;9883.456409897453;9801.460919649417;9831.311808173396;9869.259805514615;9875.753106172331;9883.357581757235;9777.266704997082;9789.363691360039;9839.163671087967;9891.950540247324;9896.455694936847;41189;41494.58505414937;41603.58396416027;41743.37384939229;41748.582514175076;2668.346255167477;3120.736101878743;3427.246005878728;3481.0427132538503;3611.3319035978166;22961.54076918452;26418.86790566054;29142;31547.526787098213;31767.84116079428;2721.972780272192;3187.4900015997328;3229.8708051677904;3241.6434192238835;3263.396271689745;389874;406602;459336;460253;460292;50238.74880625573;61317.69341153266;61573.38426615676;61930;61991.690041550406;64401;64740.352596474375;64920.35079649238;64996.35003649998;65008.67495662491;16126.03243805352;16387.42644007454;16439.67120657604;16441.342346306013;16459.341626335052;12557.748845023048;12595.496180152875;12641.87358126407;12659.367031648564;12677.936610316889;17852.46442606724;18037.10610385917;18180.818191818176;18191.45425637233;18237.90881045586;7102.609356485443;7150;7206.963965180141;7262.547490501815;7264.891026634605;854.7606670132373;946.966856160031;950.0736781637986;953.1564565359706;1045.17953406577;24936.75316234181;30042.849785750932;30519.389612207633;30691.846540767154;30859.691403085682;844.4933040175845;1051.8895515970867;1074.3929679730927;1103.85098011769;1163.1625229834506;13923.651908702364;14009.739123478732;14929.776053359208;15545.844541554667;16039.839601603835;610376;612090;618657;618881;621384.6792298119;58602.70698646479;58679.82640347169;58946;59092.81814363688;59211.703941480875;1305.7192703568778;1362.1826903857607;1377.793331000358;1379.4206433298039;1380.8688174623394;29394.853025734734;30855.38289234158;30878.691213087583;31348.059558213292;32538.511922321657;56481.58796030132;56938;56948;57014.714926425106;57104;573546;575977;578000;578443;578733;21575.35273941784;23434.17980370679;25384.746152538977;25450.618240726035;26382.340441489116;35372;38609.876456795144;40603.1879362417;42063.3690494649;47470;40351.59648403478;40411.59588404196;41032;41354;41818;31066;37682.8115859419;39133.23900424545;39254.2149157021;39399.01502462461;35783.82108089443;37987.62012379951;38499.807500963434;38537.80731096327;38679.80660096682;34474.96575102751;35294.94115176549;36012.27975440529;36298.63701362952;36318;25732.742672573033;26095.73904260933;26119.216423507325;26213.344666383495;26641.600375994763 02:30:43 INFO - PROCESS | 1953 | |2;jquery.html;321.6718946674391;367.5424096999236;369.76335145506874;381.71180758527305;394.55415380619894;19725.802741972577;20573.38279851605;20809.167633294688;21351.825649589286;21531.815750133737;20128;20336.898315508402;20626.89686551569;20635;20873.895630521863;5590.413006634306;5796.8260952171395;5838.854028649296;6094.817155485321;6119.908201376983;5919.644821310713;6037.366076561963;6041.1844401005965;6052.273727152748;6094.878102437949;5712.200291959129;5919.526437884981;5989.760409583611;6001.309849367313;6003.1895694081395;5703.230063941356;5929.911051334234;5977.641341519523;5979.970100149493;5996.310424301196;5189.403218629868;5239.580833533309;5245.26566280721;5248.973755131238;5252.6323157379;22091.005904734324;23121.884390578107;25240.242792716246;25541.23376298714;26028;1474.9926250368787;1992.2031187525106;2163.621366260914;2315.351701523576;2447.130359617877;9873.950630246803;10091.848622270672;10262.384256944608;10265;11317.547298108066;1820.0242404975231;1874.5407375193165;1888.9527761805928;1905.3426567834076;1926.4413320137144;66045.66977165132;75953;100524.49737751337;108869.10089045933;115242.96649617307;9460.716178514656;10741.40922249268;10882.836757448644;11274.267172633752;11361.909712503491;14217.928910355382;14235.217063061424;14250.786238206436;14255.144691318554;14257.21585312797;8310.54292013945;8470.449420787629;8487.787805304917;8508.361872859561;8639.827203456021;6902.344277293649;8328.417010809186;8335.124811894784;8360.372972027122;8511.531865747444;3650.634936506381;4390.319500477431;4490.236659767847;4515.75163366018;4558.407407037064;1577.826439091699;1606.9752112338538;1861.1345724238295;1898.9810101899081;1909.5703466720154;929.2890938432105;958.1376760915093;973.3964941736169;985.2659768472533;1055.37205362809;17839.929604223787;19710.310139145062;19790.70313945292;20110.39668809938;21220.36338909835;778.2645400096967;846.2637505370367;902.4134312696799;956.5647630328184;977.5161295158941;10943.945280273547;11350.3757293348;11394.088472922313;11403.543858245743;11422.543098275975;528957;563372;564793;574474;576456;107070;124008;126186.10720839194;129449;141579.2921035388;1005.6329439754437;1018.8471729240525;1035.6737627647267;1055.767731099157;1056.8731752189633;14681.92659036698;19066.7139992903;19145.904270478557;19399.90300048491;19402.70895936534;47129.528704713885;52076.739616301675;54488.45511544834;55555.444445555026;55647.16529252145;67194.66402667956;81121;81746.59126704329;82057;82723.5863820677;6516.902246466401;7932.36541076724;8131.512109273463;8190.344772418312;8317.293030092509;10655.413952232391;12805.295708736108;13177.143485673401;13221.206727596375;13293.468261269441;9856.802863942537;9971;10941.507632156412;11374;11397.031252343644;10985.285956413127;11061.446927653746;11115.610953616584;11168.274062185932;11603.01374383153;9182.265418766616;11007.61473348429;11277.830832537682;11429.142814289127;11827.940860295643;7980;7984.281414672707;8055.275025247756;8072.152423995396;8110.635021423932;8030.357571394391;8413.70552030676;9103.044180361232;9534.570944307385;10946.781064378827 02:30:43 INFO - PROCESS | 1953 | |3;mootools.html;1523.664793745376;1568.2002178888768;1770.876038677293;1792.2114269721321;1902.4863286912534;7740.612969351531;8019.438639295252;8298.25315721585;9090.545472726362;9108.40795348302;8486.405951583392;8799.868001979976;8813.603387847546;8893.288536917047;8907.599158037887;2358.9764102358927;2399.0643648976825;2400.9159679411223;2401.6877805885297;2403.110848985869;2088.164734106362;2360.7639236076425;2388.5819981503255;2394.9281521554294;2396.8082553395775;2298.6322188449853;2367.621180611103;2393.652920326552;2396.065534441569;2402.747711490286;2332.96500552491;2352.8235382346393;2373.905043798246;2378.6669866218745;2384.499255156419;2354.152505098163;2361.031976889484;2372.608519594265;2377.1798729438315;2377.2749311459997;8909;8976.23701985332;8979.416337938079;9000.279977601842;9025.368224224307;5277.894442111175;5405.567554595623;5438.809641662523;5442.9727851360885;5445.700486473243;3618.6019537850816;3653.214558869829;3678.70570354371;3703.777773333609;3729.1236559408517;1081.232325049216;1082.2316155529584;1085.4247248958065;1096.2600244834784;1103.773726386097;11640.476178571984;11710.707232319175;11805.996490298336;11806.940965295204;11869.050475961989;4248.830046798155;4566.45202575693;4684.4378674559275;4774.331593576902;4834.250691142878;10000.649977250761;10100.393976361442;10113.747156321151;10113.898861011296;10143.34068285559;5374.516293533601;5383.246345511631;5398.838034858961;5399.163129714901;5420.512153906167;4399.142167277414;4554.4990051094355;4755.5719985201495;4882.438519570223;4929.580985616191;3899.1421887185343;3966.861159859391;4026.516817981861;4076.673866090706;4090.529589097292;1236.2829558856022;1241.3110723548518;1249.4252643783962;1255.8869701726887;1257.9056570757048;759.9354054905396;871.3682580129356;894.5482531321641;916.9128932751378;943.3490891284991;5576.1356989666665;5612.971935140298;5801.448862358069;5870.295564532284;5932.40675932412;890.6303883888244;949.781550243434;955.7419496735843;974.9951250243703;1004.0561871840447;4002.3596224603925;4015.24193830312;4027.24635662078;4113.773742444194;4147.917041659211;9650.469224192737;10405.531751071068;10749.462526873625;10885.23803333775;10903.945480272549;10801.191690160615;10843.457827108614;10857.402842843561;10859.18556108295;10864.293820901616;8194.385421093322;8261.586920653943;8319.126491718403;8327.875081873777;8331.083580806227;5029.918567508003;5347.732613369239;5354.11657076578;5716.171155182558;5973.313068997121;9559.713208603753;9988.550515226687;10096.394216347042;10192.949035254776;10211.97880211973;9971.102600765676;10181.84727229107;10289.816671082623;10323;10335.638252661121;6550.329665935156;6756.8648627026205;6998.545094568837;7015.754448594274;7088.468364872759;8388.70639527638;8465.238128568459;8574.31405487572;8588.141185881363;8601.35489838252;7412.555246685216;7557.924420755722;7568.205338439385;7649.694012239448;7674.040744906887;7343.265673432614;7414.258574142543;7417.851642967218;7578.621068946641;7598.810029749079;6966.303369662993;7136.9286307138345;7137.357637812622;7138.85722285541;7162.677679504331;4930.260460930889;4994.450610432777;5074.543291103819;5118.283440318284;5131.79472821083;4767.4517430495935;4867.58625516835;4902.730349830651;4903.239997800347;4985.401751789808 02:30:43 INFO - PROCESS | 1953 | |4;prototype.html;261.8023392338784;300.0608096657461;300.14309147384216;310.35136564580023;312.411105066949;5187.455317191697;5283.709395983219;5386.542143917762;5474.507294343513;5476.616636835418;4231.4922209334845;4553.544645535453;5120.923186152201;5142.485751424856;5154.871128221796;3726.4782930389633;4069.5726948670335;4075.9592404076025;4136.27615167346;4146.087860670647;4035.0114222015645;4104.753714777108;4147.377893316012;4152.0935345258285;4167.562405947378;3313.933721325572;3960.643542081212;4093.69297302702;4107.630313271805;4114.457078595527;3367.6463971282906;3824.541055073395;3850.6522717048947;3881.378979363288;4141.337386018253;2968.40631873624;3282.7373810095137;3559.2238054317672;3579;3609;4358.6730995175485;4467.977660111711;5198.896022079537;5206.661566998133;5293.788248470057;3598.9100272493397;3951.328274193394;4315.877871753335;4666.766661666903;4695.718256904596;4807.759612019385;5214.843554693365;5598.1602759586385;5613.691246981414;5651.604387692863;3338.132085657722;3767.1147280389087;3895.9480940146286;3924.9803750981346;3933.4689816874643;5370.677759334452;5891.381404952461;5915.556333274979;5927.873703996227;5996.760129594811;3512.1921957949817;3915.789052976532;3918.49059622253;3949.2299001694396;3995.9600403995587;3594.047577391941;3667.2482141161;4030.6775457963295;4049.311617025113;4051.6150965658217;4632.031386660656;4650.651201159926;4660.883477913011;4683.297505374221;4705.09443675312;4417.3815665806815;4989.276554899519;5243.370795504564;5681.488666019995;5683.772649094072;1298.4416700818738;1327.4756471193825;1332.427735272388;1344.536135033412;1356.2066191278016;800.4596897094438;866.9219770220584;930.8829404714235;943.5940448731341;954.6372378496127;4371.409859668967;5302.863766262321;5324.840254792362;5331.134103063974;5332.893342133213;5664.405237450091;5769;5785.305763308345;5806.82579522615;5830.795922142789;4437.378766972626;4767.451743049524;5128.410232823198;5281.35932033983;5285.735713214401;2101.726775519173;2321.106374045971;2588.6893572771387;2611.9869400653256;2614.542455070355;4909.509049095133;5048.1730231070715;5071.41678706946;5073.188289873602;5092.439831618519;4964;5003.74981250936;5013.24801279811;5662.971685141548;5977.641341519523;5528.889422211614;5611.194402798601;6071.2714474263375;6114.847128821726;6126.181956300063;4943.480934501826;5224.477552244897;5335.733213339395;5910.586258961831;5961.880762384815;5275.472452754694;5479.931413374354;5630.324361076697;5794.884102317846;5839.270091238595;5843.912341314799;6173.444390004921;6189.7833575826435;6245.594036387621;6249.562530622813;3751.793651349202;3933.1543718100747;3953.9011524712114;3967.1867267209577;3970.861019864291;5510.476504732044;5802.274715660543;5803.883922321445;5864.853378665567;5869;4680.882977925579;5470.53500452466;5633.324171018733;5685.60200785941;5720.942790572041;5628.212050313042;5681.687507187145;5737.8565535861935;5754.3382511010095;5757.65454072757;5237.659552129099;5555.388907220122;5601.439856014529;5655.830325090254;5661.801836935688;5650.63270887391;5727.656340619576;5747.942520574908;5757.5393968481585;5819.243498345188;4456.821727130879;5092.923606145837;5655.377908430151;5691.77232910679;5694 02:30:43 INFO - PROCESS | 1953 | |5;yui.html;701.4178232067383;705.77768003079;708.2351060854278;721.5237942957646;737.6717360774458;14722.337494812733;15426.691466170683;15687.215639218022;15692.921535392321;16687.249073791678;15588.142652154127;15599.064056156638;15662.216889155554;15674.843251567481;15697.45058922938;834.9332053435711;861.3668953319306;861.5347712235385;863.1196179896533;864.5504337744369;647.685872351909;666.0874601795547;842.6966292134827;869.9260562852133;874.152072489684;893.3121496447732;902.1159263921361;906.2161230535572;907.5779762410477;907.7095329494564;899;900.7522931193909;901.2564634176798;902.8690839828221;903.1600611431367;650.7494614573376;669.0399277037467;671.0873212431138;672.6771149848051;673.0375562944987;15137.621559460991;15389.692206155925;15679.843201568066;15844.683106337923;15853.048817070898;14070.788938165935;14117.505887293895;14126.22305773182;14200.715985680228;14336.641583960485;11738.413079346084;11756.647300580997;11766.058715302755;12011.879881201163;12067.517299308018;3657.817109144559;3709.888703338904;3727.366347720894;3748.11919198988;3855.0169706724605;107947.46026269818;111030.44484777605;111256;113645.4317728406;114091;10831.127527952625;10839.13286937043;10899.29154604948;10922.836157457645;11037.779244415067;21541.892290538446;21893;21905;21928.89035554812;21978;7551.73568925096;7837.490563113493;7889.605519724106;7894.368450523944;7913.525188488709;4286.057067445219;4416.6025057744955;4464.508904020555;4498.977505112453;4517.593416592523;3144.779865409445;3203.9839800801315;3234.9838250808593;3240.773145879813;3251.1872031992;626.6459450410504;634.330781026022;636.5830381100386;656.7077650445601;663.4625952978104;539.7031632602132;555.084111216496;583.7985894866264;610.0696437932189;627.1269560565273;8442.915570844336;9267.841519810023;9439.292053096045;9541.379810312308;9584.189064499911;481.62255947988723;518.636954132109;594.6016169166669;626.4643729611117;661.355178700763;3969.8809035728973;4635.1656701794;4644.164050470948;4976.477469865685;5050;128321.71678283284;148497;152035;154012;157397;105288;106326.1520616358;115670;135725.96411053842;140862.2956885209;92915;113599.43200283946;117246.8275317253;118076.40961795136;119554.40222799004;8642.308615310885;10036.19710423179;10081.395116293046;10124.898751012395;10173.491325433552;51918;63330.733385332955;63382.68308658612;64339.71320573656;65172;84833.15166848252;90414;94415.52792235995;98690;98790.5060474693;11575.536978520764;11847.407629618658;12390.81413778776;12657.88712877177;12912.483500660244;10583.576656933945;14645.48740794067;14682.55952321432;14885.479008234659;15370.462033828762;12930.935345323212;13642.113262637897;13922.164670119826;14090.929545352208;14256.144631322153;11942.940285298519;13659.590212293648;13850.030497865053;13922.150462559153;13967.231802250973;13437.798433023709;13467.86532134666;13741.793873091712;13744.65638359049;13978.930105349407;9769.413835169913;11188.384638844616;11221.495032723384;11337.773244535229;11446.65660030167;7944.415050264113;10550.788984220118;10798.946005269923;11627.651170464562;11708.238964467622 02:30:43 INFO - PROCESS | 1953 | __end_tp_report 02:30:43 INFO - PROCESS | 1953 | __start_cc_report 02:30:43 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,368 02:30:43 INFO - PROCESS | 1953 | __end_cc_report 02:30:43 INFO - PROCESS | 1953 | __startTimestamp1475314243802__endTimestamp 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | ------- Summary: start ------- 02:30:43 INFO - PROCESS | 1953 | Number of tests: 6 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5546.08 Median:5683.95 stddev:652.78 (11.5%) stddev-sans-first:630.00 02:30:43 INFO - PROCESS | 1953 | Values: 3275.0 3295.8 3335.2 3344.4 3353.2 5381.4 5464.4 5533.1 5545.4 5587.9 5508.9 5557.3 5602.7 5608.6 5614.6 4978.0 5023.6 5053.6 5065.7 5072.6 5062.0 5073.0 5167.4 5181.5 5206.1 5022.7 5161.9 5189.6 5221.8 5264.5 5040.1 5111.8 5126.6 5153.6 5173.0 4768.2 5005.5 5068.8 5095.4 5110.4 4335.9 5298.7 5423.2 5511.7 5554.5 5962.0 5974.9 6007.3 6086.9 6137.0 6093.4 6127.0 6164.1 6177.4 6199.9 5493.8 5628.7 5629.2 5631.9 5674.9 6132.7 6147.0 6184.2 6192.4 6220.5 5961.6 5974.0 5975.3 5985.8 6026.4 5989.4 6089.5 6091.0 6147.0 6152.6 5550.9 5957.0 5965.3 5993.0 6066.5 4122.1 5012.8 5790.9 6137.1 6140.5 3982.0 4819.5 4821.4 4826.4 4829.4 3937.9 4128.5 4202.9 4285.9 4293.9 5151.6 5192.9 5728.8 5734.7 5779.7 4763.6 6001.6 6083.1 6105.2 6135.0 5515.8 5560.0 5628.3 5669.1 5672.1 5259.1 5298.6 5332.1 5343.9 5361.5 6248.0 6260.2 6267.2 6270.5 6281.4 5933.9 6033.8 6140.1 6176.2 6195.6 6170.4 6177.0 6184.0 6227.3 6288.7 5959.3 5960.3 5971.9 5981.8 5987.3 5683.9 5689.9 6086.0 6109.2 6134.1 5679.8 5737.5 5816.1 5841.7 5845.1 5846.8 5912.9 5922.5 5936.7 5950.3 5376.6 5607.6 5699.6 5753.6 5775.5 5825.0 5926.3 5944.4 5947.4 5950.4 5649.2 5671.9 5680.1 5700.8 5720.2 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:68169.95 Median:41271.50 stddev:146505.09 (355.0%) stddev-sans-first:146827.83 02:30:43 INFO - PROCESS | 1953 | Values: 443.2 495.5 502.1 507.5 540.9 39623.6 41917.5 41942.0 41966.8 42000.8 34390.0 43091.4 43710.6 43756.9 43929.1 9774.0 9953.7 9972.4 9973.5 9999.4 9697.6 9747.8 9789.1 9803.6 9841.5 9829.3 9854.1 9861.6 9864.4 9883.5 9801.5 9831.3 9869.3 9875.8 9883.4 9777.3 9789.4 9839.2 9892.0 9896.5 41189.0 41494.6 41603.6 41743.4 41748.6 2668.3 3120.7 3427.2 3481.0 3611.3 22961.5 26418.9 29142.0 31547.5 31767.8 2722.0 3187.5 3229.9 3241.6 3263.4 389874.0 406602.0 459336.0 460253.0 460292.0 50238.7 61317.7 61573.4 61930.0 61991.7 64401.0 64740.4 64920.4 64996.4 65008.7 16126.0 16387.4 16439.7 16441.3 16459.3 12557.7 12595.5 12641.9 12659.4 12677.9 17852.5 18037.1 18180.8 18191.5 18237.9 7102.6 7150.0 7207.0 7262.5 7264.9 854.8 947.0 950.1 953.2 1045.2 24936.8 30042.8 30519.4 30691.8 30859.7 844.5 1051.9 1074.4 1103.9 1163.2 13923.7 14009.7 14929.8 15545.8 16039.8 610376.0 612090.0 618657.0 618881.0 621384.7 58602.7 58679.8 58946.0 59092.8 59211.7 1305.7 1362.2 1377.8 1379.4 1380.9 29394.9 30855.4 30878.7 31348.1 32538.5 56481.6 56938.0 56948.0 57014.7 57104.0 573546.0 575977.0 578000.0 578443.0 578733.0 21575.4 23434.2 25384.7 25450.6 26382.3 35372.0 38609.9 40603.2 42063.4 47470.0 40351.6 40411.6 41032.0 41354.0 41818.0 31066.0 37682.8 39133.2 39254.2 39399.0 35783.8 37987.6 38499.8 38537.8 38679.8 34475.0 35294.9 36012.3 36298.6 36318.0 25732.7 26095.7 26119.2 26213.3 26641.6 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:33122.81 Median:1986.15 stddev:93666.39 (4716.0%) stddev-sans-first:93896.77 02:30:43 INFO - PROCESS | 1953 | Values: 321.7 367.5 369.8 381.7 394.6 19725.8 20573.4 20809.2 21351.8 21531.8 20128.0 20336.9 20626.9 20635.0 20873.9 5590.4 5796.8 5838.9 6094.8 6119.9 5919.6 6037.4 6041.2 6052.3 6094.9 5712.2 5919.5 5989.8 6001.3 6003.2 5703.2 5929.9 5977.6 5980.0 5996.3 5189.4 5239.6 5245.3 5249.0 5252.6 22091.0 23121.9 25240.2 25541.2 26028.0 1475.0 1992.2 2163.6 2315.4 2447.1 9874.0 10091.8 10262.4 10265.0 11317.5 1820.0 1874.5 1889.0 1905.3 1926.4 66045.7 75953.0 100524.5 108869.1 115243.0 9460.7 10741.4 10882.8 11274.3 11361.9 14217.9 14235.2 14250.8 14255.1 14257.2 8310.5 8470.4 8487.8 8508.4 8639.8 6902.3 8328.4 8335.1 8360.4 8511.5 3650.6 4390.3 4490.2 4515.8 4558.4 1577.8 1607.0 1861.1 1899.0 1909.6 929.3 958.1 973.4 985.3 1055.4 17839.9 19710.3 19790.7 20110.4 21220.4 778.3 846.3 902.4 956.6 977.5 10943.9 11350.4 11394.1 11403.5 11422.5 528957.0 563372.0 564793.0 574474.0 576456.0 107070.0 124008.0 126186.1 129449.0 141579.3 1005.6 1018.8 1035.7 1055.8 1056.9 14681.9 19066.7 19145.9 19399.9 19402.7 47129.5 52076.7 54488.5 55555.4 55647.2 67194.7 81121.0 81746.6 82057.0 82723.6 6516.9 7932.4 8131.5 8190.3 8317.3 10655.4 12805.3 13177.1 13221.2 13293.5 9856.8 9971.0 10941.5 11374.0 11397.0 10985.3 11061.4 11115.6 11168.3 11603.0 9182.3 11007.6 11277.8 11429.1 11827.9 7980.0 7984.3 8055.3 8072.2 8110.6 8030.4 8413.7 9103.0 9534.6 10946.8 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5729.59 Median:4850.92 stddev:3213.74 (66.3%) stddev-sans-first:3207.22 02:30:43 INFO - PROCESS | 1953 | Values: 1523.7 1568.2 1770.9 1792.2 1902.5 7740.6 8019.4 8298.3 9090.5 9108.4 8486.4 8799.9 8813.6 8893.3 8907.6 2359.0 2399.1 2400.9 2401.7 2403.1 2088.2 2360.8 2388.6 2394.9 2396.8 2298.6 2367.6 2393.7 2396.1 2402.7 2333.0 2352.8 2373.9 2378.7 2384.5 2354.2 2361.0 2372.6 2377.2 2377.3 8909.0 8976.2 8979.4 9000.3 9025.4 5277.9 5405.6 5438.8 5443.0 5445.7 3618.6 3653.2 3678.7 3703.8 3729.1 1081.2 1082.2 1085.4 1096.3 1103.8 11640.5 11710.7 11806.0 11806.9 11869.1 4248.8 4566.5 4684.4 4774.3 4834.3 10000.6 10100.4 10113.7 10113.9 10143.3 5374.5 5383.2 5398.8 5399.2 5420.5 4399.1 4554.5 4755.6 4882.4 4929.6 3899.1 3966.9 4026.5 4076.7 4090.5 1236.3 1241.3 1249.4 1255.9 1257.9 759.9 871.4 894.5 916.9 943.3 5576.1 5613.0 5801.4 5870.3 5932.4 890.6 949.8 955.7 975.0 1004.1 4002.4 4015.2 4027.2 4113.8 4147.9 9650.5 10405.5 10749.5 10885.2 10903.9 10801.2 10843.5 10857.4 10859.2 10864.3 8194.4 8261.6 8319.1 8327.9 8331.1 5029.9 5347.7 5354.1 5716.2 5973.3 9559.7 9988.6 10096.4 10192.9 10212.0 9971.1 10181.8 10289.8 10323.0 10335.6 6550.3 6756.9 6998.5 7015.8 7088.5 8388.7 8465.2 8574.3 8588.1 8601.4 7412.6 7557.9 7568.2 7649.7 7674.0 7343.3 7414.3 7417.9 7578.6 7598.8 6966.3 7136.9 7137.4 7138.9 7162.7 4930.3 4994.5 5074.5 5118.3 5131.8 4767.5 4867.6 4902.7 4903.2 4985.4 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4527.29 Median:5092.68 stddev:1425.69 (28.0%) stddev-sans-first:1393.28 02:30:43 INFO - PROCESS | 1953 | Values: 261.8 300.1 300.1 310.4 312.4 5187.5 5283.7 5386.5 5474.5 5476.6 4231.5 4553.5 5120.9 5142.5 5154.9 3726.5 4069.6 4076.0 4136.3 4146.1 4035.0 4104.8 4147.4 4152.1 4167.6 3313.9 3960.6 4093.7 4107.6 4114.5 3367.6 3824.5 3850.7 3881.4 4141.3 2968.4 3282.7 3559.2 3579.0 3609.0 4358.7 4468.0 5198.9 5206.7 5293.8 3598.9 3951.3 4315.9 4666.8 4695.7 4807.8 5214.8 5598.2 5613.7 5651.6 3338.1 3767.1 3895.9 3925.0 3933.5 5370.7 5891.4 5915.6 5927.9 5996.8 3512.2 3915.8 3918.5 3949.2 3996.0 3594.0 3667.2 4030.7 4049.3 4051.6 4632.0 4650.7 4660.9 4683.3 4705.1 4417.4 4989.3 5243.4 5681.5 5683.8 1298.4 1327.5 1332.4 1344.5 1356.2 800.5 866.9 930.9 943.6 954.6 4371.4 5302.9 5324.8 5331.1 5332.9 5664.4 5769.0 5785.3 5806.8 5830.8 4437.4 4767.5 5128.4 5281.4 5285.7 2101.7 2321.1 2588.7 2612.0 2614.5 4909.5 5048.2 5071.4 5073.2 5092.4 4964.0 5003.7 5013.2 5663.0 5977.6 5528.9 5611.2 6071.3 6114.8 6126.2 4943.5 5224.5 5335.7 5910.6 5961.9 5275.5 5479.9 5630.3 5794.9 5839.3 5843.9 6173.4 6189.8 6245.6 6249.6 3751.8 3933.2 3953.9 3967.2 3970.9 5510.5 5802.3 5803.9 5864.9 5869.0 4680.9 5470.5 5633.3 5685.6 5720.9 5628.2 5681.7 5737.9 5754.3 5757.7 5237.7 5555.4 5601.4 5655.8 5661.8 5650.6 5727.7 5747.9 5757.5 5819.2 4456.8 5092.9 5655.4 5691.8 5694.0 02:30:43 INFO - PROCESS | 1953 | 02:30:43 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:24769.94 Median:12561.39 stddev:39414.10 (313.8%) stddev-sans-first:39483.23 02:30:43 INFO - PROCESS | 1953 | Values: 701.4 705.8 708.2 721.5 737.7 14722.3 15426.7 15687.2 15692.9 16687.2 15588.1 15599.1 15662.2 15674.8 15697.5 834.9 861.4 861.5 863.1 864.6 647.7 666.1 842.7 869.9 874.2 893.3 902.1 906.2 907.6 907.7 899.0 900.8 901.3 902.9 903.2 650.7 669.0 671.1 672.7 673.0 15137.6 15389.7 15679.8 15844.7 15853.0 14070.8 14117.5 14126.2 14200.7 14336.6 11738.4 11756.6 11766.1 12011.9 12067.5 3657.8 3709.9 3727.4 3748.1 3855.0 107947.5 111030.4 111256.0 113645.4 114091.0 10831.1 10839.1 10899.3 10922.8 11037.8 21541.9 21893.0 21905.0 21928.9 21978.0 7551.7 7837.5 7889.6 7894.4 7913.5 4286.1 4416.6 4464.5 4499.0 4517.6 3144.8 3204.0 3235.0 3240.8 3251.2 626.6 634.3 636.6 656.7 663.5 539.7 555.1 583.8 610.1 627.1 8442.9 9267.8 9439.3 9541.4 9584.2 481.6 518.6 594.6 626.5 661.4 3969.9 4635.2 4644.2 4976.5 5050.0 128321.7 148497.0 152035.0 154012.0 157397.0 105288.0 106326.2 115670.0 135726.0 140862.3 92915.0 113599.4 117246.8 118076.4 119554.4 8642.3 10036.2 10081.4 10124.9 10173.5 51918.0 63330.7 63382.7 64339.7 65172.0 84833.2 90414.0 94415.5 98690.0 98790.5 11575.5 11847.4 12390.8 12657.9 12912.5 10583.6 14645.5 14682.6 14885.5 15370.5 12930.9 13642.1 13922.2 14090.9 14256.1 11942.9 13659.6 13850.0 13922.2 13967.2 13437.8 13467.9 13741.8 13744.7 13978.9 9769.4 11188.4 11221.5 11337.8 11446.7 7944.4 10550.8 10798.9 11627.7 11708.2 02:30:43 INFO - PROCESS | 1953 | -------- Summary: end -------- 02:30:43 INFO - PROCESS | 1953 | 02:30:44 INFO - TEST-INFO | 1953: exit 0 02:30:44 INFO - TEST-OK | dromaeo_css | took 1114992ms 02:30:44 INFO - TEST-START | kraken 02:30:44 INFO - operating with platform_type : mac_ 02:30:44 INFO - Initialising browser for kraken test... 02:30:44 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmppAVn2R/profile http://localhost:54335/getInfo.html) 02:30:47 INFO - PROCESS | 1958 | 2016-10-01 02:30:46.996 plugin-container[1959:68787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e27, name = 'com.apple.tsm.portname' 02:30:47 INFO - PROCESS | 1958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:47 INFO - PROCESS | 1958 | 2016-10-01 02:30:46.999 plugin-container[1959:68787] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 02:30:47 INFO - PROCESS | 1958 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:47 INFO - PROCESS | 1958 | 2016-10-01 02:30:46.999 plugin-container[1959:68787] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:30:47 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 02:30:47 INFO - PROCESS | 1958 | colorDepth:24 02:30:47 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 02:30:47 INFO - PROCESS | 1958 | __metrics 02:30:47 ERROR - PROCESS | 1958 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 02:30:47 INFO - TEST-INFO | 1958: exit 0 02:30:47 INFO - Browser initialized. 02:30:47 INFO - Running cycle 1/1 for kraken test... 02:30:47 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zw/k_htx6850ms3t4396777xgwh00000w/T/tmppAVn2R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:50 INFO - PROCESS | 1960 | 2016-10-01 02:30:50.089 plugin-container[1961:68902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a13, name = 'com.apple.tsm.portname' 02:30:50 INFO - PROCESS | 1960 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:50 INFO - PROCESS | 1960 | 2016-10-01 02:30:50.091 plugin-container[1961:68902] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 02:30:50 INFO - PROCESS | 1960 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:30:50 INFO - PROCESS | 1960 | 2016-10-01 02:30:50.091 plugin-container[1961:68902] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:30:59 INFO - PROCESS | 1960 | RSS: Main: 240349184 02:30:59 INFO - PROCESS | 1960 | 02:31:02 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54335/tests/kraken/driver.html?testName=audio-beat-detection) 02:31:03 INFO - PROCESS | 1960 | RSS: Main: 254152704 02:31:03 INFO - PROCESS | 1960 | 02:31:06 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54335/tests/kraken/driver.html?testName=audio-dft) 02:31:07 INFO - PROCESS | 1960 | RSS: Main: 262348800 02:31:07 INFO - PROCESS | 1960 | 02:31:10 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54335/tests/kraken/driver.html?testName=audio-fft) 02:31:11 INFO - PROCESS | 1960 | RSS: Main: 262733824 02:31:11 INFO - PROCESS | 1960 | 02:31:13 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54335/tests/kraken/driver.html?testName=audio-oscillator) 02:31:14 INFO - PROCESS | 1960 | RSS: Main: 264810496 02:31:14 INFO - PROCESS | 1960 | 02:31:15 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:31:16 INFO - PROCESS | 1960 | RSS: Main: 265146368 02:31:16 INFO - PROCESS | 1960 | 02:31:19 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54335/tests/kraken/driver.html?testName=imaging-darkroom) 02:31:20 INFO - PROCESS | 1960 | RSS: Main: 265256960 02:31:20 INFO - PROCESS | 1960 | 02:31:23 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54335/tests/kraken/driver.html?testName=imaging-desaturate) 02:31:24 INFO - PROCESS | 1960 | RSS: Main: 265576448 02:31:24 INFO - PROCESS | 1960 | 02:31:27 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54335/tests/kraken/driver.html?testName=json-parse-financial) 02:31:27 INFO - PROCESS | 1960 | RSS: Main: 265482240 02:31:27 INFO - PROCESS | 1960 | 02:31:29 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:31:30 INFO - PROCESS | 1960 | RSS: Main: 265449472 02:31:30 INFO - PROCESS | 1960 | 02:31:32 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:31:32 INFO - PROCESS | 1960 | RSS: Main: 265461760 02:31:32 INFO - PROCESS | 1960 | 02:31:35 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:31:35 INFO - PROCESS | 1960 | RSS: Main: 265568256 02:31:35 INFO - PROCESS | 1960 | 02:31:38 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:31:39 INFO - PROCESS | 1960 | RSS: Main: 265891840 02:31:39 INFO - PROCESS | 1960 | 02:31:42 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:31:43 INFO - PROCESS | 1960 | RSS: Main: 266162176 02:31:43 INFO - PROCESS | 1960 | 02:31:44 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:54335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54335/tests/kraken/driver.html?testName=ai-astar) 02:31:45 INFO - PROCESS | 1960 | RSS: Main: 268853248 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | __start_tp_report 02:31:45 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 02:31:45 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 02:31:45 INFO - PROCESS | 1960 | |i|pagename|runs| 02:31:45 INFO - PROCESS | 1960 | |0;ai-astar;104;116;117;118;116;116;117;116;116;127 02:31:45 INFO - PROCESS | 1960 | |1;audio-beat-detection;143;118;118;155;121;151;103;142;185;141 02:31:45 INFO - PROCESS | 1960 | |2;audio-dft;274;293;199;254;214;198;193;182;273;277 02:31:45 INFO - PROCESS | 1960 | |3;audio-fft;86;58;59;88;60;61;62;60;83;63 02:31:45 INFO - PROCESS | 1960 | |4;audio-oscillator;93;73;87;74;69;72;90;73;73;98 02:31:45 INFO - PROCESS | 1960 | |5;imaging-gaussian-blur;136;86;91;87;108;76;138;133;124;87 02:31:45 INFO - PROCESS | 1960 | |6;imaging-darkroom;102;96;153;135;153;154;133;150;151;95 02:31:45 INFO - PROCESS | 1960 | |7;imaging-desaturate;92;93;115;149;116;91;94;95;92;93 02:31:45 INFO - PROCESS | 1960 | |8;json-parse-financial;59;58;58;60;58;59;59;60;59;59 02:31:45 INFO - PROCESS | 1960 | |9;json-stringify-tinderbox;75;67;68;78;76;69;68;70;70;72 02:31:45 INFO - PROCESS | 1960 | |10;stanford-crypto-aes;93;99;97;92;90;105;115;112;109;81 02:31:45 INFO - PROCESS | 1960 | |11;stanford-crypto-ccm;150;149;147;146;151;146;149;160;219;150 02:31:45 INFO - PROCESS | 1960 | |12;stanford-crypto-pbkdf2;177;178;214;180;176;177;177;179;175;187 02:31:45 INFO - PROCESS | 1960 | |13;stanford-crypto-sha256-iterative;63;91;63;77;73;60;73;62;73;71 02:31:45 INFO - PROCESS | 1960 | __end_tp_report 02:31:45 INFO - PROCESS | 1960 | __start_cc_report 02:31:45 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,938 02:31:45 INFO - PROCESS | 1960 | __end_cc_report 02:31:45 INFO - PROCESS | 1960 | __startTimestamp1475314305226__endTimestamp 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | ------- Summary: start ------- 02:31:45 INFO - PROCESS | 1960 | Number of tests: 14 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.50 stddev:5.48 (4.7%) stddev-sans-first:3.57 02:31:45 INFO - PROCESS | 1960 | Values: 104.0 116.0 117.0 118.0 116.0 116.0 117.0 116.0 116.0 127.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:142.50 stddev:23.64 (16.6%) stddev-sans-first:25.00 02:31:45 INFO - PROCESS | 1960 | Values: 143.0 118.0 118.0 155.0 121.0 151.0 103.0 142.0 185.0 141.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#2] audio-dft Cycles:10 Average:235.70 Median:263.50 stddev:42.33 (16.1%) stddev-sans-first:42.57 02:31:45 INFO - PROCESS | 1960 | Values: 274.0 293.0 199.0 254.0 214.0 198.0 193.0 182.0 273.0 277.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#3] audio-fft Cycles:10 Average:68.00 Median:62.50 stddev:12.33 (19.7%) stddev-sans-first:11.22 02:31:45 INFO - PROCESS | 1960 | Values: 86.0 58.0 59.0 88.0 60.0 61.0 62.0 60.0 83.0 63.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:80.50 stddev:10.59 (13.2%) stddev-sans-first:10.17 02:31:45 INFO - PROCESS | 1960 | Values: 93.0 73.0 87.0 74.0 69.0 72.0 90.0 73.0 73.0 98.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#5] imaging-gaussian-blur Cycles:10 Average:106.60 Median:81.00 stddev:24.09 (29.7%) stddev-sans-first:23.09 02:31:45 INFO - PROCESS | 1960 | Values: 136.0 86.0 91.0 87.0 108.0 76.0 138.0 133.0 124.0 87.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#6] imaging-darkroom Cycles:10 Average:132.20 Median:153.00 stddev:25.00 (16.3%) stddev-sans-first:24.01 02:31:45 INFO - PROCESS | 1960 | Values: 102.0 96.0 153.0 135.0 153.0 154.0 133.0 150.0 151.0 95.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#7] imaging-desaturate Cycles:10 Average:103.00 Median:92.50 stddev:18.74 (20.3%) stddev-sans-first:19.45 02:31:45 INFO - PROCESS | 1960 | Values: 92.0 93.0 115.0 149.0 116.0 91.0 94.0 95.0 92.0 93.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 02:31:45 INFO - PROCESS | 1960 | Values: 59.0 58.0 58.0 60.0 58.0 59.0 59.0 60.0 59.0 59.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:3.80 (5.4%) stddev-sans-first:3.79 02:31:45 INFO - PROCESS | 1960 | Values: 75.0 67.0 68.0 78.0 76.0 69.0 68.0 70.0 70.0 72.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#10] stanford-crypto-aes Cycles:10 Average:99.30 Median:91.00 stddev:10.82 (11.9%) stddev-sans-first:11.24 02:31:45 INFO - PROCESS | 1960 | Values: 93.0 99.0 97.0 92.0 90.0 105.0 115.0 112.0 109.0 81.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:150.00 stddev:22.25 (14.8%) stddev-sans-first:23.47 02:31:45 INFO - PROCESS | 1960 | Values: 150.0 149.0 147.0 146.0 151.0 146.0 149.0 160.0 219.0 150.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:178.50 stddev:11.73 (6.6%) stddev-sans-first:12.30 02:31:45 INFO - PROCESS | 1960 | Values: 177.0 178.0 214.0 180.0 176.0 177.0 177.0 179.0 175.0 187.0 02:31:45 INFO - PROCESS | 1960 | 02:31:45 INFO - PROCESS | 1960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:73.00 stddev:9.29 (12.7%) stddev-sans-first:9.44 02:31:45 INFO - PROCESS | 1960 | Values: 63.0 91.0 63.0 77.0 73.0 60.0 73.0 62.0 73.0 71.0 02:31:45 INFO - PROCESS | 1960 | -------- Summary: end -------- 02:31:45 INFO - PROCESS | 1960 | 02:31:46 INFO - TEST-INFO | 1960: exit 0 02:31:46 INFO - TEST-OK | kraken | took 61667ms 02:31:46 INFO - SUITE-END | took 1176s 02:31:46 INFO - Completed test suite (00:19:36) 02:31:46 INFO - javascript benchmark 02:31:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7272.519946602744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.0, 3295.8299803569735, 3335.2328964338203, 3344.398008358496, 3353.195233144043, 5381.354237491507, 5464.426235245297, 5533.1147016477325, 5545.445455454453, 5587.916181257274, 5508.944910550893, 5557.305336832896, 5602.663840169593, 5608.551315894729, 5614.550835933115, 4978.029284289565, 5023.598112151019, 5053.570446512051, 5065.721385323805, 5072.644914855961, 5062.0, 5072.9746351268195, 5167.431582525919, 5181.533661970422, 5206.088934436478, 5022.673526220784, 5161.896762064775, 5189.610779191576, 5221.765020574065, 5264.499872512105, 5040.143175660147, 5111.7699703513435, 5126.615503837227, 5153.639245252796, 5173.0, 4768.165571025057, 5005.47442518534, 5068.771905264235, 5095.439501654815, 5110.361204849394, 4335.869923902288, 5298.708571028592, 5423.240746295522, 5511.724413779295, 5554.527865131468, 5961.986462301419, 5974.910376344358, 6007.309159446676, 6086.878262434727, 6137.048757442603, 6093.421124993163, 6127.045207093565, 6164.137020817089, 6177.351378105279, 6199.8530271899845, 5493.752781124859, 5628.662280263197, 5629.211910332557, 5631.859203519863, 5674.886502269931, 6132.661461321608, 6146.985747351637, 6184.226971628546, 6192.411720886508, 6220.471259942956, 5961.642301461839, 5974.0, 5975.282966044103, 5985.820425387245, 6026.367231440723, 5989.431004054608, 6089.512838972872, 6090.969545152335, 6146.969265153645, 6152.569320147547, 5550.888982220333, 5957.046872500379, 5965.254343207099, 5993.0, 6066.4540191382985, 4122.134351786159, 5012.7994880205115, 5790.855228619234, 6137.070562331796, 6140.539459540552, 3981.980090099589, 4819.469858315582, 4821.445533763592, 4826.444958829709, 4829.420469543677, 3937.8621748239248, 4128.525219599725, 4202.894927626834, 4285.935710964338, 4293.892652683708, 5151.639385242997, 5192.896142077213, 5728.79949201776, 5734.655920644775, 5779.739911703983, 4763.618910487153, 6001.579889407787, 6083.057126145454, 6105.236845394325, 6134.9693251534345, 5515.806946756844, 5560.0, 5628.268325117709, 5669.149627555899, 5672.149177623307, 5259.05337039329, 5298.576113910878, 5332.146856502941, 5343.893122137535, 5361.544268737123, 6248.031555108965, 6260.154879091356, 6267.2479302484, 6270.467010304175, 6281.403266689657, 5933.902228087818, 6033.78881739137, 6140.078988151813, 6176.166217560572, 6195.628262304276, 6170.413810688157, 6177.0, 6183.96908015457, 6227.314995350598, 6288.748450061947, 5959.314678811992, 5960.254968128984, 5971.940280597139, 5981.790637327673, 5987.341392446914, 5683.948469533149, 5689.914651280317, 6085.9695701521205, 6109.236345456818, 6134.141220229082, 5679.829605111853, 5737.48362647347, 5816.0694288915265, 5841.737121829443, 5845.09401042839, 5846.766129354778, 5912.940870591239, 5922.496587790086, 5936.703164841827, 5950.256217972754, 5376.623636345418, 5607.607467477237, 5699.629524080921, 5753.597248192586, 5775.451332123442, 5825.0, 5926.318473375617, 5944.375840536682, 5947.405259474018, 5950.404959504015, 5649.180868773922, 5671.8865622688145, 5680.11958146488, 5700.800471983461, 5720.227769251098], "value": 5505.948645092363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.2420560840962, 495.4599486559654, 502.0561344672016, 507.53814029233394, 540.8512659018769, 39623.603763962354, 41917.532886348985, 41942.0, 41966.79016604916, 42000.78999605005, 34390.0, 43091.35362969558, 43710.56289437105, 43756.90607734808, 43929.12141757163, 9774.0, 9953.701388958307, 9972.3517971332, 9973.50132493376, 9999.400035997864, 9697.612095516171, 9747.75630609237, 9789.118979291863, 9803.558839852189, 9841.507924603777, 9829.311948163631, 9854.06386393295, 9861.605535778595, 9864.358816676893, 9883.456409897453, 9801.460919649417, 9831.311808173396, 9869.259805514615, 9875.753106172331, 9883.357581757235, 9777.266704997082, 9789.363691360039, 9839.163671087967, 9891.950540247324, 9896.455694936847, 41189.0, 41494.58505414937, 41603.58396416027, 41743.37384939229, 41748.582514175076, 2668.346255167477, 3120.736101878743, 3427.246005878728, 3481.0427132538503, 3611.3319035978166, 22961.54076918452, 26418.86790566054, 29142.0, 31547.526787098213, 31767.84116079428, 2721.972780272192, 3187.4900015997328, 3229.8708051677904, 3241.6434192238835, 3263.396271689745, 389874.0, 406602.0, 459336.0, 460253.0, 460292.0, 50238.74880625573, 61317.69341153266, 61573.38426615676, 61930.0, 61991.690041550406, 64401.0, 64740.352596474375, 64920.35079649238, 64996.35003649998, 65008.67495662491, 16126.03243805352, 16387.42644007454, 16439.67120657604, 16441.342346306013, 16459.341626335052, 12557.748845023048, 12595.496180152875, 12641.87358126407, 12659.367031648564, 12677.936610316889, 17852.46442606724, 18037.10610385917, 18180.818191818176, 18191.45425637233, 18237.90881045586, 7102.609356485443, 7150.0, 7206.963965180141, 7262.547490501815, 7264.891026634605, 854.7606670132373, 946.966856160031, 950.0736781637986, 953.1564565359706, 1045.17953406577, 24936.75316234181, 30042.849785750932, 30519.389612207633, 30691.846540767154, 30859.691403085682, 844.4933040175845, 1051.8895515970867, 1074.3929679730927, 1103.85098011769, 1163.1625229834506, 13923.651908702364, 14009.739123478732, 14929.776053359208, 15545.844541554667, 16039.839601603835, 610376.0, 612090.0, 618657.0, 618881.0, 621384.6792298119, 58602.70698646479, 58679.82640347169, 58946.0, 59092.81814363688, 59211.703941480875, 1305.7192703568778, 1362.1826903857607, 1377.793331000358, 1379.4206433298039, 1380.8688174623394, 29394.853025734734, 30855.38289234158, 30878.691213087583, 31348.059558213292, 32538.511922321657, 56481.58796030132, 56938.0, 56948.0, 57014.714926425106, 57104.0, 573546.0, 575977.0, 578000.0, 578443.0, 578733.0, 21575.35273941784, 23434.17980370679, 25384.746152538977, 25450.618240726035, 26382.340441489116, 35372.0, 38609.876456795144, 40603.1879362417, 42063.3690494649, 47470.0, 40351.59648403478, 40411.59588404196, 41032.0, 41354.0, 41818.0, 31066.0, 37682.8115859419, 39133.23900424545, 39254.2149157021, 39399.01502462461, 35783.82108089443, 37987.62012379951, 38499.807500963434, 38537.80731096327, 38679.80660096682, 34474.96575102751, 35294.94115176549, 36012.27975440529, 36298.63701362952, 36318.0, 25732.742672573033, 26095.73904260933, 26119.216423507325, 26213.344666383495, 26641.600375994763], "value": 19842.604953355847, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.6718946674391, 367.5424096999236, 369.76335145506874, 381.71180758527305, 394.55415380619894, 19725.802741972577, 20573.38279851605, 20809.167633294688, 21351.825649589286, 21531.815750133737, 20128.0, 20336.898315508402, 20626.89686551569, 20635.0, 20873.895630521863, 5590.413006634306, 5796.8260952171395, 5838.854028649296, 6094.817155485321, 6119.908201376983, 5919.644821310713, 6037.366076561963, 6041.1844401005965, 6052.273727152748, 6094.878102437949, 5712.200291959129, 5919.526437884981, 5989.760409583611, 6001.309849367313, 6003.1895694081395, 5703.230063941356, 5929.911051334234, 5977.641341519523, 5979.970100149493, 5996.310424301196, 5189.403218629868, 5239.580833533309, 5245.26566280721, 5248.973755131238, 5252.6323157379, 22091.005904734324, 23121.884390578107, 25240.242792716246, 25541.23376298714, 26028.0, 1474.9926250368787, 1992.2031187525106, 2163.621366260914, 2315.351701523576, 2447.130359617877, 9873.950630246803, 10091.848622270672, 10262.384256944608, 10265.0, 11317.547298108066, 1820.0242404975231, 1874.5407375193165, 1888.9527761805928, 1905.3426567834076, 1926.4413320137144, 66045.66977165132, 75953.0, 100524.49737751337, 108869.10089045933, 115242.96649617307, 9460.716178514656, 10741.40922249268, 10882.836757448644, 11274.267172633752, 11361.909712503491, 14217.928910355382, 14235.217063061424, 14250.786238206436, 14255.144691318554, 14257.21585312797, 8310.54292013945, 8470.449420787629, 8487.787805304917, 8508.361872859561, 8639.827203456021, 6902.344277293649, 8328.417010809186, 8335.124811894784, 8360.372972027122, 8511.531865747444, 3650.634936506381, 4390.319500477431, 4490.236659767847, 4515.75163366018, 4558.407407037064, 1577.826439091699, 1606.9752112338538, 1861.1345724238295, 1898.9810101899081, 1909.5703466720154, 929.2890938432105, 958.1376760915093, 973.3964941736169, 985.2659768472533, 1055.37205362809, 17839.929604223787, 19710.310139145062, 19790.70313945292, 20110.39668809938, 21220.36338909835, 778.2645400096967, 846.2637505370367, 902.4134312696799, 956.5647630328184, 977.5161295158941, 10943.945280273547, 11350.3757293348, 11394.088472922313, 11403.543858245743, 11422.543098275975, 528957.0, 563372.0, 564793.0, 574474.0, 576456.0, 107070.0, 124008.0, 126186.10720839194, 129449.0, 141579.2921035388, 1005.6329439754437, 1018.8471729240525, 1035.6737627647267, 1055.767731099157, 1056.8731752189633, 14681.92659036698, 19066.7139992903, 19145.904270478557, 19399.90300048491, 19402.70895936534, 47129.528704713885, 52076.739616301675, 54488.45511544834, 55555.444445555026, 55647.16529252145, 67194.66402667956, 81121.0, 81746.59126704329, 82057.0, 82723.5863820677, 6516.902246466401, 7932.36541076724, 8131.512109273463, 8190.344772418312, 8317.293030092509, 10655.413952232391, 12805.295708736108, 13177.143485673401, 13221.206727596375, 13293.468261269441, 9856.802863942537, 9971.0, 10941.507632156412, 11374.0, 11397.031252343644, 10985.285956413127, 11061.446927653746, 11115.610953616584, 11168.274062185932, 11603.01374383153, 9182.265418766616, 11007.61473348429, 11277.830832537682, 11429.142814289127, 11827.940860295643, 7980.0, 7984.281414672707, 8055.275025247756, 8072.152423995396, 8110.635021423932, 8030.357571394391, 8413.70552030676, 9103.044180361232, 9534.570944307385, 10946.781064378827], "value": 9321.921498696007, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.664793745376, 1568.2002178888768, 1770.876038677293, 1792.2114269721321, 1902.4863286912534, 7740.612969351531, 8019.438639295252, 8298.25315721585, 9090.545472726362, 9108.40795348302, 8486.405951583392, 8799.868001979976, 8813.603387847546, 8893.288536917047, 8907.599158037887, 2358.9764102358927, 2399.0643648976825, 2400.9159679411223, 2401.6877805885297, 2403.110848985869, 2088.164734106362, 2360.7639236076425, 2388.5819981503255, 2394.9281521554294, 2396.8082553395775, 2298.6322188449853, 2367.621180611103, 2393.652920326552, 2396.065534441569, 2402.747711490286, 2332.96500552491, 2352.8235382346393, 2373.905043798246, 2378.6669866218745, 2384.499255156419, 2354.152505098163, 2361.031976889484, 2372.608519594265, 2377.1798729438315, 2377.2749311459997, 8909.0, 8976.23701985332, 8979.416337938079, 9000.279977601842, 9025.368224224307, 5277.894442111175, 5405.567554595623, 5438.809641662523, 5442.9727851360885, 5445.700486473243, 3618.6019537850816, 3653.214558869829, 3678.70570354371, 3703.777773333609, 3729.1236559408517, 1081.232325049216, 1082.2316155529584, 1085.4247248958065, 1096.2600244834784, 1103.773726386097, 11640.476178571984, 11710.707232319175, 11805.996490298336, 11806.940965295204, 11869.050475961989, 4248.830046798155, 4566.45202575693, 4684.4378674559275, 4774.331593576902, 4834.250691142878, 10000.649977250761, 10100.393976361442, 10113.747156321151, 10113.898861011296, 10143.34068285559, 5374.516293533601, 5383.246345511631, 5398.838034858961, 5399.163129714901, 5420.512153906167, 4399.142167277414, 4554.4990051094355, 4755.5719985201495, 4882.438519570223, 4929.580985616191, 3899.1421887185343, 3966.861159859391, 4026.516817981861, 4076.673866090706, 4090.529589097292, 1236.2829558856022, 1241.3110723548518, 1249.4252643783962, 1255.8869701726887, 1257.9056570757048, 759.9354054905396, 871.3682580129356, 894.5482531321641, 916.9128932751378, 943.3490891284991, 5576.1356989666665, 5612.971935140298, 5801.448862358069, 5870.295564532284, 5932.40675932412, 890.6303883888244, 949.781550243434, 955.7419496735843, 974.9951250243703, 1004.0561871840447, 4002.3596224603925, 4015.24193830312, 4027.24635662078, 4113.773742444194, 4147.917041659211, 9650.469224192737, 10405.531751071068, 10749.462526873625, 10885.23803333775, 10903.945480272549, 10801.191690160615, 10843.457827108614, 10857.402842843561, 10859.18556108295, 10864.293820901616, 8194.385421093322, 8261.586920653943, 8319.126491718403, 8327.875081873777, 8331.083580806227, 5029.918567508003, 5347.732613369239, 5354.11657076578, 5716.171155182558, 5973.313068997121, 9559.713208603753, 9988.550515226687, 10096.394216347042, 10192.949035254776, 10211.97880211973, 9971.102600765676, 10181.84727229107, 10289.816671082623, 10323.0, 10335.638252661121, 6550.329665935156, 6756.8648627026205, 6998.545094568837, 7015.754448594274, 7088.468364872759, 8388.70639527638, 8465.238128568459, 8574.31405487572, 8588.141185881363, 8601.35489838252, 7412.555246685216, 7557.924420755722, 7568.205338439385, 7649.694012239448, 7674.040744906887, 7343.265673432614, 7414.258574142543, 7417.851642967218, 7578.621068946641, 7598.810029749079, 6966.303369662993, 7136.9286307138345, 7137.357637812622, 7138.85722285541, 7162.677679504331, 4930.260460930889, 4994.450610432777, 5074.543291103819, 5118.283440318284, 5131.79472821083, 4767.4517430495935, 4867.58625516835, 4902.730349830651, 4903.239997800347, 4985.401751789808], "value": 4608.337737418813, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.8023392338784, 300.0608096657461, 300.14309147384216, 310.35136564580023, 312.411105066949, 5187.455317191697, 5283.709395983219, 5386.542143917762, 5474.507294343513, 5476.616636835418, 4231.4922209334845, 4553.544645535453, 5120.923186152201, 5142.485751424856, 5154.871128221796, 3726.4782930389633, 4069.5726948670335, 4075.9592404076025, 4136.27615167346, 4146.087860670647, 4035.0114222015645, 4104.753714777108, 4147.377893316012, 4152.0935345258285, 4167.562405947378, 3313.933721325572, 3960.643542081212, 4093.69297302702, 4107.630313271805, 4114.457078595527, 3367.6463971282906, 3824.541055073395, 3850.6522717048947, 3881.378979363288, 4141.337386018253, 2968.40631873624, 3282.7373810095137, 3559.2238054317672, 3579.0, 3609.0, 4358.6730995175485, 4467.977660111711, 5198.896022079537, 5206.661566998133, 5293.788248470057, 3598.9100272493397, 3951.328274193394, 4315.877871753335, 4666.766661666903, 4695.718256904596, 4807.759612019385, 5214.843554693365, 5598.1602759586385, 5613.691246981414, 5651.604387692863, 3338.132085657722, 3767.1147280389087, 3895.9480940146286, 3924.9803750981346, 3933.4689816874643, 5370.677759334452, 5891.381404952461, 5915.556333274979, 5927.873703996227, 5996.760129594811, 3512.1921957949817, 3915.789052976532, 3918.49059622253, 3949.2299001694396, 3995.9600403995587, 3594.047577391941, 3667.2482141161, 4030.6775457963295, 4049.311617025113, 4051.6150965658217, 4632.031386660656, 4650.651201159926, 4660.883477913011, 4683.297505374221, 4705.09443675312, 4417.3815665806815, 4989.276554899519, 5243.370795504564, 5681.488666019995, 5683.772649094072, 1298.4416700818738, 1327.4756471193825, 1332.427735272388, 1344.536135033412, 1356.2066191278016, 800.4596897094438, 866.9219770220584, 930.8829404714235, 943.5940448731341, 954.6372378496127, 4371.409859668967, 5302.863766262321, 5324.840254792362, 5331.134103063974, 5332.893342133213, 5664.405237450091, 5769.0, 5785.305763308345, 5806.82579522615, 5830.795922142789, 4437.378766972626, 4767.451743049524, 5128.410232823198, 5281.35932033983, 5285.735713214401, 2101.726775519173, 2321.106374045971, 2588.6893572771387, 2611.9869400653256, 2614.542455070355, 4909.509049095133, 5048.1730231070715, 5071.41678706946, 5073.188289873602, 5092.439831618519, 4964.0, 5003.74981250936, 5013.24801279811, 5662.971685141548, 5977.641341519523, 5528.889422211614, 5611.194402798601, 6071.2714474263375, 6114.847128821726, 6126.181956300063, 4943.480934501826, 5224.477552244897, 5335.733213339395, 5910.586258961831, 5961.880762384815, 5275.472452754694, 5479.931413374354, 5630.324361076697, 5794.884102317846, 5839.270091238595, 5843.912341314799, 6173.444390004921, 6189.7833575826435, 6245.594036387621, 6249.562530622813, 3751.793651349202, 3933.1543718100747, 3953.9011524712114, 3967.1867267209577, 3970.861019864291, 5510.476504732044, 5802.274715660543, 5803.883922321445, 5864.853378665567, 5869.0, 4680.882977925579, 5470.53500452466, 5633.324171018733, 5685.60200785941, 5720.942790572041, 5628.212050313042, 5681.687507187145, 5737.8565535861935, 5754.3382511010095, 5757.65454072757, 5237.659552129099, 5555.388907220122, 5601.439856014529, 5655.830325090254, 5661.801836935688, 5650.63270887391, 5727.656340619576, 5747.942520574908, 5757.5393968481585, 5819.243498345188, 4456.821727130879, 5092.923606145837, 5655.377908430151, 5691.77232910679, 5694.0], "value": 4071.208207129718, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [701.4178232067383, 705.77768003079, 708.2351060854278, 721.5237942957646, 737.6717360774458, 14722.337494812733, 15426.691466170683, 15687.215639218022, 15692.921535392321, 16687.249073791678, 15588.142652154127, 15599.064056156638, 15662.216889155554, 15674.843251567481, 15697.45058922938, 834.9332053435711, 861.3668953319306, 861.5347712235385, 863.1196179896533, 864.5504337744369, 647.685872351909, 666.0874601795547, 842.6966292134827, 869.9260562852133, 874.152072489684, 893.3121496447732, 902.1159263921361, 906.2161230535572, 907.5779762410477, 907.7095329494564, 899.0, 900.7522931193909, 901.2564634176798, 902.8690839828221, 903.1600611431367, 650.7494614573376, 669.0399277037467, 671.0873212431138, 672.6771149848051, 673.0375562944987, 15137.621559460991, 15389.692206155925, 15679.843201568066, 15844.683106337923, 15853.048817070898, 14070.788938165935, 14117.505887293895, 14126.22305773182, 14200.715985680228, 14336.641583960485, 11738.413079346084, 11756.647300580997, 11766.058715302755, 12011.879881201163, 12067.517299308018, 3657.817109144559, 3709.888703338904, 3727.366347720894, 3748.11919198988, 3855.0169706724605, 107947.46026269818, 111030.44484777605, 111256.0, 113645.4317728406, 114091.0, 10831.127527952625, 10839.13286937043, 10899.29154604948, 10922.836157457645, 11037.779244415067, 21541.892290538446, 21893.0, 21905.0, 21928.89035554812, 21978.0, 7551.73568925096, 7837.490563113493, 7889.605519724106, 7894.368450523944, 7913.525188488709, 4286.057067445219, 4416.6025057744955, 4464.508904020555, 4498.977505112453, 4517.593416592523, 3144.779865409445, 3203.9839800801315, 3234.9838250808593, 3240.773145879813, 3251.1872031992, 626.6459450410504, 634.330781026022, 636.5830381100386, 656.7077650445601, 663.4625952978104, 539.7031632602132, 555.084111216496, 583.7985894866264, 610.0696437932189, 627.1269560565273, 8442.915570844336, 9267.841519810023, 9439.292053096045, 9541.379810312308, 9584.189064499911, 481.62255947988723, 518.636954132109, 594.6016169166669, 626.4643729611117, 661.355178700763, 3969.8809035728973, 4635.1656701794, 4644.164050470948, 4976.477469865685, 5050.0, 128321.71678283284, 148497.0, 152035.0, 154012.0, 157397.0, 105288.0, 106326.1520616358, 115670.0, 135725.96411053842, 140862.2956885209, 92915.0, 113599.43200283946, 117246.8275317253, 118076.40961795136, 119554.40222799004, 8642.308615310885, 10036.19710423179, 10081.395116293046, 10124.898751012395, 10173.491325433552, 51918.0, 63330.733385332955, 63382.68308658612, 64339.71320573656, 65172.0, 84833.15166848252, 90414.0, 94415.52792235995, 98690.0, 98790.5060474693, 11575.536978520764, 11847.407629618658, 12390.81413778776, 12657.88712877177, 12912.483500660244, 10583.576656933945, 14645.48740794067, 14682.55952321432, 14885.479008234659, 15370.462033828762, 12930.935345323212, 13642.113262637897, 13922.164670119826, 14090.929545352208, 14256.144631322153, 11942.940285298519, 13659.590212293648, 13850.030497865053, 13922.150462559153, 13967.231802250973, 13437.798433023709, 13467.86532134666, 13741.793873091712, 13744.65638359049, 13978.930105349407, 9769.413835169913, 11188.384638844616, 11221.495032723384, 11337.773244535229, 11446.65660030167, 7944.415050264113, 10550.788984220118, 10798.946005269923, 11627.651170464562, 11708.238964467622], "value": 7742.114344502345, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1618.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 117.0, 118.0, 116.0, 116.0, 117.0, 116.0, 116.0, 127.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 118.0, 155.0, 121.0, 151.0, 103.0, 142.0, 185.0, 141.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [274.0, 293.0, 199.0, 254.0, 214.0, 198.0, 193.0, 182.0, 273.0, 277.0], "value": 235.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 59.0, 88.0, 60.0, 61.0, 62.0, 60.0, 83.0, 63.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 73.0, 87.0, 74.0, 69.0, 72.0, 90.0, 73.0, 73.0, 98.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 86.0, 91.0, 87.0, 108.0, 76.0, 138.0, 133.0, 124.0, 87.0], "value": 106.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 96.0, 153.0, 135.0, 153.0, 154.0, 133.0, 150.0, 151.0, 95.0], "value": 132.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 115.0, 149.0, 116.0, 91.0, 94.0, 95.0, 92.0, 93.0], "value": 103.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 60.0, 58.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 67.0, 68.0, 78.0, 76.0, 69.0, 68.0, 70.0, 70.0, 72.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 97.0, 92.0, 90.0, 105.0, 115.0, 112.0, 109.0, 81.0], "value": 99.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 147.0, 146.0, 151.0, 146.0, 149.0, 160.0, 219.0, 150.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 214.0, 180.0, 176.0, 177.0, 177.0, 179.0, 175.0, 187.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 91.0, 63.0, 77.0, 73.0, 60.0, 73.0, 62.0, 73.0, 71.0], "value": 70.6, "unit": "score"}]}]} 02:31:46 INFO - Return code: 0 02:31:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:31:46 ERROR - # TBPL SUCCESS # 02:31:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:31:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:31:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:31:46 INFO - 2016-10-01 02:31:46.538 screenresolution[1965:69300] starting screenresolution argv=screenresolution get 02:31:46 INFO - 2016-10-01 02:31:46.541 screenresolution[1965:69300] Display 0: 1600x1200x32@60 02:31:46 INFO - 2016-10-01 02:31:46.547 screenresolution[1966:69303] starting screenresolution argv=screenresolution list 02:31:46 INFO - Available Modes on Display 0 02:31:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:31:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:31:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:31:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:31:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:31:46 INFO - Intel Iris: 02:31:46 INFO - Chipset Model: Intel Iris 02:31:46 INFO - Type: GPU 02:31:46 INFO - Bus: Built-In 02:31:46 INFO - VRAM (Dynamic, Max): 1536 MB 02:31:46 INFO - Vendor: Intel (0x8086) 02:31:46 INFO - Device ID: 0x0a2e 02:31:46 INFO - Revision ID: 0x0009 02:31:46 INFO - Displays: 02:31:46 INFO - Display: 02:31:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:31:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:31:46 INFO - Display Serial Number: 1600x1200 60 02:31:46 INFO - Main Display: Yes 02:31:46 INFO - Mirror: Off 02:31:46 INFO - Online: Yes 02:31:46 INFO - Rotation: Supported 02:31:46 INFO - Return code: 0 02:31:46 INFO - Running post-action listener: _resource_record_post_action 02:31:46 INFO - [mozharness: 2016-10-01 09:31:46.782679Z] Finished run-tests step (success) 02:31:46 INFO - Running post-run listener: _resource_record_post_run 02:31:46 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 718336; Write bytes: 711649280; Read time: 8; Write time: 1869 02:31:46 INFO - TinderboxPrint: CPU usage
54.4% 02:31:46 INFO - TinderboxPrint: I/O read bytes / time
718,336 / 8 02:31:46 INFO - TinderboxPrint: I/O write bytes / time
711,649,280 / 1,869 02:31:46 INFO - TinderboxPrint: CPU idle
2,210.7 (45.6%) 02:31:46 INFO - TinderboxPrint: CPU system
985.7 (20.3%) 02:31:46 INFO - TinderboxPrint: CPU user
1,653.3 (34.1%) 02:31:46 INFO - TinderboxPrint: Swap in / out
407,633,920 / 0 02:31:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391287296; Write bytes: 387060224; Read time: 29252; Write time: 681 02:31:46 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 718336; Write bytes: 300291584; Read time: 8; Write time: 1134 02:31:47 INFO - Running post-run listener: _upload_blobber_files 02:31:47 INFO - Blob upload gear active. 02:31:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:31:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:31:47 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'] 02:31:47 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 02:31:47 INFO - (blobuploader) - INFO - Open directory for files ... 02:31:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:31:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:31:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:48 INFO - (blobuploader) - INFO - Done attempting. 02:31:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:31:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:50 INFO - (blobuploader) - INFO - Done attempting. 02:31:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:31:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:31:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:31:52 INFO - (blobuploader) - INFO - Done attempting. 02:31:52 INFO - (blobuploader) - INFO - Iteration through files over. 02:31:52 INFO - Return code: 0 02:31:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:31:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:31:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931d86ae4c147e25870252b30ea8724155d3a0fa0a2589c595af9561136354c2265b9d76d7dda659f1eed458fbba01b874a269a6e1de697a8272450a7b2d9f58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b43a6349a9269bcf6476e0ce0ce63c9de83d8998704870ecf639f529ca7bb1b080f27ae511d5a7865cd650633ed55bc2a684860efc16bf4d00c133a44b18e6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9172d766bb4eb2b37fc85aca77b78947a416e209dbcfabe2f245b3d8c03e8abbb5fc57130666c7e2a4aad923fda6e0dab8ee626e5f821ee721b943978e5043"} 02:31:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:31:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:31:52 INFO - Contents: 02:31:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931d86ae4c147e25870252b30ea8724155d3a0fa0a2589c595af9561136354c2265b9d76d7dda659f1eed458fbba01b874a269a6e1de697a8272450a7b2d9f58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b43a6349a9269bcf6476e0ce0ce63c9de83d8998704870ecf639f529ca7bb1b080f27ae511d5a7865cd650633ed55bc2a684860efc16bf4d00c133a44b18e6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9172d766bb4eb2b37fc85aca77b78947a416e209dbcfabe2f245b3d8c03e8abbb5fc57130666c7e2a4aad923fda6e0dab8ee626e5f821ee721b943978e5043"} 02:31:52 INFO - Running post-run listener: copy_logs_to_upload_dir 02:31:52 INFO - Copying logs to upload dir... 02:31:52 INFO - mkdir: /builds/slave/test/build/upload/logs 02:31:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.610032 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-01 02:31:52.738771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 02:31:52.742329) ========= 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.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931d86ae4c147e25870252b30ea8724155d3a0fa0a2589c595af9561136354c2265b9d76d7dda659f1eed458fbba01b874a269a6e1de697a8272450a7b2d9f58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b43a6349a9269bcf6476e0ce0ce63c9de83d8998704870ecf639f529ca7bb1b080f27ae511d5a7865cd650633ed55bc2a684860efc16bf4d00c133a44b18e6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9172d766bb4eb2b37fc85aca77b78947a416e209dbcfabe2f245b3d8c03e8abbb5fc57130666c7e2a4aad923fda6e0dab8ee626e5f821ee721b943978e5043"} build_url:https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/Ssl4QaVpTleEf3Lt0VrFZQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/931d86ae4c147e25870252b30ea8724155d3a0fa0a2589c595af9561136354c2265b9d76d7dda659f1eed458fbba01b874a269a6e1de697a8272450a7b2d9f58", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b43a6349a9269bcf6476e0ce0ce63c9de83d8998704870ecf639f529ca7bb1b080f27ae511d5a7865cd650633ed55bc2a684860efc16bf4d00c133a44b18e6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9172d766bb4eb2b37fc85aca77b78947a416e209dbcfabe2f245b3d8c03e8abbb5fc57130666c7e2a4aad923fda6e0dab8ee626e5f821ee721b943978e5043"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 02:31:52.774650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:31:52.774942) ========= 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.3KlfbHg0GP/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.ppe0u43W6U/Listeners TMPDIR=/var/folders/zw/k_htx6850ms3t4396777xgwh00000w/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.005298 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 02:31:52.824032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 02:31:52.824331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 02:31:52.824647) ========= ========= Total master_lag: 0.17 =========