builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0092 starttime: 1474645512.24 results: success (0) buildid: 20160923065658 builduid: 86aebe46671744bcb08747382b71fcb1 revision: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.243937) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.244382) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.244672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.296801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.297065) ========= 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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-23 08:45:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-09-23 08:45:12 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.520535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.840677) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.840989) ========= 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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.027701 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.890490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:12.890850) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e26037d2a25382b8b8a70d6b0390dc1cbe370f5b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e26037d2a25382b8b8a70d6b0390dc1cbe370f5b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-23 08:45:12,967 truncating revision to first 12 chars 2016-09-23 08:45:12,967 Setting DEBUG logging. 2016-09-23 08:45:12,967 attempt 1/10 2016-09-23 08:45:12,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e26037d2a253?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 08:45:13,623 unpacking tar archive at: autoland-e26037d2a253/testing/mozharness/ program finished with exit code 0 elapsedTime=0.918088 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:13.831532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:13.831866) ========= script_repo_revision: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:13.832252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:13.832520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 08:45:13.855366) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-23 08:45:13.855780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:14 INFO - MultiFileLogger online at 20160923 08:45:14 in /builds/slave/test 08:45:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 08:45:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:45:14 INFO - {'append_to_log': False, 08:45:14 INFO - 'base_work_dir': '/builds/slave/test', 08:45:14 INFO - 'blob_upload_branch': 'Autoland', 08:45:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:45:14 INFO - 'branch': 'Autoland', 08:45:14 INFO - 'buildbot_json_path': 'buildprops.json', 08:45:14 INFO - 'config_files': ('talos/mac_config.py',), 08:45:14 INFO - 'default_actions': ('clobber', 08:45:14 INFO - 'read-buildbot-config', 08:45:14 INFO - 'download-and-extract', 08:45:14 INFO - 'populate-webroot', 08:45:14 INFO - 'create-virtualenv', 08:45:14 INFO - 'install', 08:45:14 INFO - 'run-tests'), 08:45:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:45:14 INFO - 'download_minidump_stackwalk': True, 08:45:14 INFO - 'download_symbols': 'ondemand', 08:45:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:45:14 INFO - 'tooltool.py': '/tools/tooltool.py', 08:45:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:45:14 INFO - '/tools/misc-python/virtualenv.py')}, 08:45:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:45:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:45:14 INFO - 'installer_path': 'installer.exe', 08:45:14 INFO - 'log_level': 'info', 08:45:14 INFO - 'log_name': 'talos', 08:45:14 INFO - 'log_to_console': True, 08:45:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:45:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:45:14 INFO - 'opt_config_files': (), 08:45:14 INFO - 'pip_index': False, 08:45:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:14 INFO - 'cmd': ('bash', 08:45:14 INFO - '-c', 08:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:14 INFO - 'enabled': True, 08:45:14 INFO - 'halt_on_failure': False, 08:45:14 INFO - 'name': 'check_screen_resolution'},), 08:45:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:45:14 INFO - 'cmd': ('bash', 08:45:14 INFO - '-c', 08:45:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:45:14 INFO - 'enabled': True, 08:45:14 INFO - 'halt_on_failure': False, 08:45:14 INFO - 'name': 'check_screen_resolution'},), 08:45:14 INFO - 'run_cmd_checks_enabled': True, 08:45:14 INFO - 'sps_profile': False, 08:45:14 INFO - 'sps_profile_interval': 0, 08:45:14 INFO - 'suite': 'dromaeojs-e10s', 08:45:14 INFO - 'system_bits': '32', 08:45:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:45:14 INFO - 'title': 't-yosemite-r7-0092', 08:45:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:45:14 INFO - 'use_talos_json': True, 08:45:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:45:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:45:14 INFO - 'work_dir': 'build'} 08:45:14 INFO - [mozharness: 2016-09-23 15:45:14.061289Z] Running clobber step. 08:45:14 INFO - Running pre-action listener: _resource_record_pre_action 08:45:14 INFO - Running main action method: clobber 08:45:14 INFO - rmtree: /builds/slave/test/build 08:45:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - [mozharness: 2016-09-23 15:45:16.122918Z] Finished clobber step (success) 08:45:16 INFO - [mozharness: 2016-09-23 15:45:16.123053Z] Running read-buildbot-config step. 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: read_buildbot_config 08:45:16 INFO - Using buildbot properties: 08:45:16 INFO - { 08:45:16 INFO - "project": "", 08:45:16 INFO - "product": "firefox", 08:45:16 INFO - "script_repo_revision": "production", 08:45:16 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 08:45:16 INFO - "repository": "", 08:45:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 08:45:16 INFO - "buildid": "20160923065658", 08:45:16 INFO - "pgo_build": "False", 08:45:16 INFO - "basedir": "/builds/slave/test", 08:45:16 INFO - "buildnumber": 196, 08:45:16 INFO - "slavename": "t-yosemite-r7-0092", 08:45:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:45:16 INFO - "platform": "yosemite_r7", 08:45:16 INFO - "scheduler": "tests-autoland-macosx64-talos-8-3600", 08:45:16 INFO - "branch": "autoland", 08:45:16 INFO - "repo_path": "integration/autoland", 08:45:16 INFO - "revision": "e26037d2a25382b8b8a70d6b0390dc1cbe370f5b", 08:45:16 INFO - "stage_platform": "macosx64", 08:45:16 INFO - "builduid": "86aebe46671744bcb08747382b71fcb1", 08:45:16 INFO - "slavebuilddir": "test" 08:45:16 INFO - } 08:45:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:45:16 INFO - Running post-action listener: _resource_record_post_action 08:45:16 INFO - [mozharness: 2016-09-23 15:45:16.126353Z] Finished read-buildbot-config step (success) 08:45:16 INFO - [mozharness: 2016-09-23 15:45:16.126461Z] Running download-and-extract step. 08:45:16 INFO - Running pre-action listener: _resource_record_pre_action 08:45:16 INFO - Running main action method: download_and_extract 08:45:16 INFO - mkdir: /builds/slave/test/build/tests 08:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:16 INFO - trying https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:45:16 INFO - Downloading https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/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 08:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/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 08:45:17 INFO - Downloaded 1199 bytes. 08:45:17 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:45:17 INFO - Using the following test package requirements: 08:45:17 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:45:17 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:45:17 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:45:17 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'jsshell-mac.zip'], 08:45:17 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:45:17 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:45:17 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:45:17 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:45:17 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:45:17 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:45:17 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:45:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:45:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:45:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:45:17 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:45:17 INFO - Expected file size: 16438806 08:45:24 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 08:45:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:45:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:45:24 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:45:25 INFO - Expected file size: 16438806 08:45:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:45:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:45:32 INFO - Fetch https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:45:33 INFO - Expected file size: 14414059 08:45:34 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')]} 08:45:34 INFO - trying https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:45:34 INFO - Downloading https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/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 08:45:36 INFO - Downloaded 111578700 bytes. 08:45:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:45:36 INFO - mkdir: /builds/slave/test/properties 08:45:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:36 INFO - Contents: 08:45:36 INFO - build_url:https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:45:37 INFO - Running post-action listener: _resource_record_post_action 08:45:37 INFO - Running post-action listener: set_extra_try_arguments 08:45:37 INFO - [mozharness: 2016-09-23 15:45:37.544317Z] Finished download-and-extract step (success) 08:45:37 INFO - [mozharness: 2016-09-23 15:45:37.544465Z] Running populate-webroot step. 08:45:37 INFO - Running pre-action listener: _resource_record_pre_action 08:45:37 INFO - Running main action method: populate_webroot 08:45:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:37 INFO - '--tppagecycles', 08:45:37 INFO - '7'], 08:45:37 INFO - 'tests': ['tsvgm']}}, 08:45:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['damp', 'tps']}, 08:45:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'tests': ['damp', 'tps']}, 08:45:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['dromaeo_dom']}, 08:45:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['basic_compositor_video']}, 08:45:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['a11yr', 08:45:37 INFO - 'ts_paint', 08:45:37 INFO - 'tpaint', 08:45:37 INFO - 'sessionrestore', 08:45:37 INFO - 'sessionrestore_no_auto_restore', 08:45:37 INFO - 'tabpaint']}, 08:45:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['tsvgx', 08:45:37 INFO - 'tsvgr_opacity', 08:45:37 INFO - 'tart', 08:45:37 INFO - 'tscrollx', 08:45:37 INFO - 'cart']}, 08:45:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:37 INFO - 'tsvgr_opacity', 08:45:37 INFO - 'tart', 08:45:37 INFO - 'tscrollx', 08:45:37 INFO - 'cart']}, 08:45:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'talos_options': ['--disable-e10s'], 08:45:37 INFO - 'tests': ['tp5o']}, 08:45:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'tests': ['tp5o']}, 08:45:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'talos_options': ['--disable-e10s', 08:45:37 INFO - '--xperf_path', 08:45:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:37 INFO - 'tests': ['tp5n']}, 08:45:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:37 INFO - 'talos_options': ['--xperf_path', 08:45:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:37 INFO - 'tests': ['tp5n']}}, 08:45:37 INFO - 'talos.zip': {'path': '', 08:45:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:37 INFO - Running post-action listener: _resource_record_post_action 08:45:37 INFO - [mozharness: 2016-09-23 15:45:37.563134Z] Finished populate-webroot step (success) 08:45:37 INFO - [mozharness: 2016-09-23 15:45:37.563264Z] Running create-virtualenv step. 08:45:37 INFO - Running pre-action listener: _resource_record_pre_action 08:45:37 INFO - Running main action method: create_virtualenv 08:45:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:37 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 08:45:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:37 INFO - Using real prefix '/tools/python27' 08:45:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:41 INFO - Installing pip.................done. 08:45:41 INFO - Return code: 0 08:45:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:41 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 08:45:41 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 08:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:41 INFO - 'HOME': '/Users/cltbld', 08:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:41 INFO - 'LOGNAME': 'cltbld', 08:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:41 INFO - 'MOZ_NO_REMOTE': '1', 08:45:41 INFO - 'NO_EM_RESTART': '1', 08:45:41 INFO - 'PAGER': '/bin/cat', 08:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:41 INFO - 'PWD': '/builds/slave/test', 08:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:41 INFO - 'SHELL': '/bin/bash', 08:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:41 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:41 INFO - 'USER': 'cltbld', 08:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:41 INFO - 'XPC_FLAGS': '0x0', 08:45:41 INFO - 'XPC_SERVICE_NAME': '0', 08:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:41 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 08:45:41 INFO - Cleaning up... 08:45:41 INFO - Return code: 0 08:45:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:41 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:41 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 08:45:41 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 08:45:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:41 INFO - 'HOME': '/Users/cltbld', 08:45:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:41 INFO - 'LOGNAME': 'cltbld', 08:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:41 INFO - 'MOZ_NO_REMOTE': '1', 08:45:41 INFO - 'NO_EM_RESTART': '1', 08:45:41 INFO - 'PAGER': '/bin/cat', 08:45:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:41 INFO - 'PWD': '/builds/slave/test', 08:45:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:41 INFO - 'SHELL': '/bin/bash', 08:45:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:41 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:41 INFO - 'USER': 'cltbld', 08:45:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:41 INFO - 'XPC_FLAGS': '0x0', 08:45:41 INFO - 'XPC_SERVICE_NAME': '0', 08:45:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:41 INFO - Downloading/unpacking psutil>=3.1.1 08:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:45 INFO - Installing collected packages: psutil 08:45:45 INFO - Running setup.py install for psutil 08:45:45 INFO - building 'psutil._psutil_osx' extension 08:45:45 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 08:45:46 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 08:45:46 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 08:45:46 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 08:45:46 INFO - building 'psutil._psutil_posix' extension 08:45:46 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 08:45:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:46 INFO - ^ 08:45:46 INFO - 1 warning generated. 08:45:46 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 08:45:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:46 INFO - Successfully installed psutil 08:45:46 INFO - Cleaning up... 08:45:46 INFO - Return code: 0 08:45:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:46 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')]} 08:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:46 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')]} 08:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:46 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:46 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 08:45:46 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 08:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:46 INFO - 'HOME': '/Users/cltbld', 08:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:46 INFO - 'LOGNAME': 'cltbld', 08:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:46 INFO - 'MOZ_NO_REMOTE': '1', 08:45:46 INFO - 'NO_EM_RESTART': '1', 08:45:46 INFO - 'PAGER': '/bin/cat', 08:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:46 INFO - 'PWD': '/builds/slave/test', 08:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:46 INFO - 'SHELL': '/bin/bash', 08:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:46 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:46 INFO - 'USER': 'cltbld', 08:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:46 INFO - 'XPC_FLAGS': '0x0', 08:45:46 INFO - 'XPC_SERVICE_NAME': '0', 08:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:47 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 08:45:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:49 INFO - Installing collected packages: mozsystemmonitor 08:45:49 INFO - Running setup.py install for mozsystemmonitor 08:45:49 INFO - Successfully installed mozsystemmonitor 08:45:49 INFO - Cleaning up... 08:45:49 INFO - Return code: 0 08:45:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:49 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:49 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 08:45:49 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 08:45:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:49 INFO - 'HOME': '/Users/cltbld', 08:45:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:49 INFO - 'LOGNAME': 'cltbld', 08:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:49 INFO - 'MOZ_NO_REMOTE': '1', 08:45:49 INFO - 'NO_EM_RESTART': '1', 08:45:49 INFO - 'PAGER': '/bin/cat', 08:45:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:49 INFO - 'PWD': '/builds/slave/test', 08:45:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:49 INFO - 'SHELL': '/bin/bash', 08:45:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:49 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:49 INFO - 'USER': 'cltbld', 08:45:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:49 INFO - 'XPC_FLAGS': '0x0', 08:45:49 INFO - 'XPC_SERVICE_NAME': '0', 08:45:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:50 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:50 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 08:45:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:52 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 08:45:52 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 08:45:52 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 08:45:52 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 08:45:52 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 08:45:52 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 08:45:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:53 INFO - warning: no files found matching '*.txt' 08:45:53 INFO - no previously-included directories found matching 'build' 08:45:53 INFO - no previously-included directories found matching 'dist' 08:45:53 INFO - no previously-included directories found matching '.git*' 08:45:53 INFO - Installing collected packages: jsonschema, functools32 08:45:53 INFO - Running setup.py install for functools32 08:45:53 INFO - warning: no files found matching '*.txt' 08:45:53 INFO - no previously-included directories found matching 'build' 08:45:53 INFO - no previously-included directories found matching 'dist' 08:45:53 INFO - no previously-included directories found matching '.git*' 08:45:53 INFO - Successfully installed jsonschema functools32 08:45:53 INFO - Cleaning up... 08:45:53 INFO - Return code: 0 08:45:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:53 INFO - 'HOME': '/Users/cltbld', 08:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:53 INFO - 'LOGNAME': 'cltbld', 08:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:53 INFO - 'MOZ_NO_REMOTE': '1', 08:45:53 INFO - 'NO_EM_RESTART': '1', 08:45:53 INFO - 'PAGER': '/bin/cat', 08:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:53 INFO - 'PWD': '/builds/slave/test', 08:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:53 INFO - 'SHELL': '/bin/bash', 08:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:53 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:53 INFO - 'USER': 'cltbld', 08:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:53 INFO - 'XPC_FLAGS': '0x0', 08:45:53 INFO - 'XPC_SERVICE_NAME': '0', 08:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:53 INFO - Cleaning up... 08:45:53 INFO - Return code: 0 08:45:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:53 INFO - 'HOME': '/Users/cltbld', 08:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:53 INFO - 'LOGNAME': 'cltbld', 08:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:53 INFO - 'MOZ_NO_REMOTE': '1', 08:45:53 INFO - 'NO_EM_RESTART': '1', 08:45:53 INFO - 'PAGER': '/bin/cat', 08:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:53 INFO - 'PWD': '/builds/slave/test', 08:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:53 INFO - 'SHELL': '/bin/bash', 08:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:53 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:53 INFO - 'USER': 'cltbld', 08:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:53 INFO - 'XPC_FLAGS': '0x0', 08:45:53 INFO - 'XPC_SERVICE_NAME': '0', 08:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:57 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 08:45:57 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 08:45:57 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 08:45:57 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 08:45:57 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 08:45:57 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 08:45:57 INFO - Downloading docopt-0.6.1.tar.gz 08:45:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:57 INFO - Running setup.py install for blobuploader 08:45:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:58 INFO - Running setup.py install for requests 08:45:58 INFO - Running setup.py install for docopt 08:45:58 INFO - Successfully installed blobuploader requests docopt 08:45:58 INFO - Cleaning up... 08:45:58 INFO - Return code: 0 08:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:58 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:45:58 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 08:45:58 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 08:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:58 INFO - 'HOME': '/Users/cltbld', 08:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:58 INFO - 'LOGNAME': 'cltbld', 08:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:58 INFO - 'MOZ_NO_REMOTE': '1', 08:45:58 INFO - 'NO_EM_RESTART': '1', 08:45:58 INFO - 'PAGER': '/bin/cat', 08:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:58 INFO - 'PWD': '/builds/slave/test', 08:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:58 INFO - 'SHELL': '/bin/bash', 08:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:45:58 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:58 INFO - 'USER': 'cltbld', 08:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:58 INFO - 'XPC_FLAGS': '0x0', 08:45:58 INFO - 'XPC_SERVICE_NAME': '0', 08:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-qfY6DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-j1b9RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-1KckJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-mY2doP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-r8pQY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-0ZgKv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-5iHILV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:59 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-xB8Raq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-RLjBxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-T1Ai58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-0cCoIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-Bo_d6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-MQbjQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-wDNR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-bVhmjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-DVs7xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:00 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-fivmKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:00 INFO - Running setup.py install for manifestparser 08:46:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:01 INFO - Running setup.py install for mozcrash 08:46:01 INFO - Running setup.py install for mozdebug 08:46:01 INFO - Running setup.py install for mozdevice 08:46:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:01 INFO - Running setup.py install for mozfile 08:46:01 INFO - Running setup.py install for mozhttpd 08:46:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:01 INFO - Running setup.py install for mozinfo 08:46:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:01 INFO - Running setup.py install for mozInstall 08:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Running setup.py install for mozleak 08:46:02 INFO - Running setup.py install for mozlog 08:46:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Running setup.py install for moznetwork 08:46:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Running setup.py install for mozprocess 08:46:02 INFO - Running setup.py install for mozprofile 08:46:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:02 INFO - Running setup.py install for mozrunner 08:46:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:03 INFO - Running setup.py install for mozscreenshot 08:46:03 INFO - Running setup.py install for moztest 08:46:03 INFO - Running setup.py install for mozversion 08:46:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:03 INFO - Cleaning up... 08:46:03 INFO - Return code: 0 08:46:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:03 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')]} 08:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:03 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')]} 08:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:03 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:46:03 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 08:46:03 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 08:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:03 INFO - 'HOME': '/Users/cltbld', 08:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:03 INFO - 'LOGNAME': 'cltbld', 08:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:03 INFO - 'MOZ_NO_REMOTE': '1', 08:46:03 INFO - 'NO_EM_RESTART': '1', 08:46:03 INFO - 'PAGER': '/bin/cat', 08:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:03 INFO - 'PWD': '/builds/slave/test', 08:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:03 INFO - 'SHELL': '/bin/bash', 08:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:46:03 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:03 INFO - 'USER': 'cltbld', 08:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:03 INFO - 'XPC_FLAGS': '0x0', 08:46:03 INFO - 'XPC_SERVICE_NAME': '0', 08:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:03 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-uDig2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:03 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)) 08:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:03 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-NvNTfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-iTynMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-OD2qqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-OBGd38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-xP0ItZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-_Ej3BJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-tX1khC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-RlAUbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-1SJPgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-b0Go8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:04 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)) 08:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:04 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-c2jFyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:05 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)) 08:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:05 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-bIRZE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:05 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)) 08:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:05 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-_64TUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:05 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)) 08:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:05 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-FJfX9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:05 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)) 08:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:05 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-2_2H2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:05 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)) 08:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:05 INFO - Running setup.py (path:/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/pip-TZJlFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:05 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)) 08:46:05 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)) 08:46:05 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)) 08:46:05 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)) 08:46:05 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)) 08:46:05 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)) 08:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:05 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 08:46:08 INFO - Downloading blessings-1.6.tar.gz 08:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:08 INFO - Installing collected packages: blessings 08:46:08 INFO - Running setup.py install for blessings 08:46:08 INFO - Successfully installed blessings 08:46:08 INFO - Cleaning up... 08:46:08 INFO - Return code: 0 08:46:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:08 INFO - Reading from file tmpfile_stdout 08:46:08 INFO - Current package versions: 08:46:08 INFO - blessings == 1.6 08:46:08 INFO - blobuploader == 1.2.4 08:46:08 INFO - docopt == 0.6.1 08:46:08 INFO - functools32 == 3.2.3-2 08:46:08 INFO - jsonschema == 2.5.1 08:46:08 INFO - manifestparser == 1.1 08:46:08 INFO - mozInstall == 1.12 08:46:08 INFO - mozcrash == 0.17 08:46:08 INFO - mozdebug == 0.1 08:46:08 INFO - mozdevice == 0.48 08:46:08 INFO - mozfile == 1.2 08:46:08 INFO - mozhttpd == 0.7 08:46:08 INFO - mozinfo == 0.9 08:46:08 INFO - mozleak == 0.1 08:46:08 INFO - mozlog == 3.4 08:46:08 INFO - moznetwork == 0.27 08:46:08 INFO - mozprocess == 0.23 08:46:08 INFO - mozprofile == 0.28 08:46:08 INFO - mozrunner == 6.12 08:46:08 INFO - mozscreenshot == 0.1 08:46:08 INFO - mozsystemmonitor == 0.3 08:46:08 INFO - moztest == 0.7 08:46:08 INFO - mozversion == 1.4 08:46:08 INFO - psutil == 3.1.1 08:46:08 INFO - requests == 1.2.3 08:46:08 INFO - wsgiref == 0.1.2 08:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:08 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')]} 08:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:08 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')]} 08:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:08 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:46:08 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 08:46:08 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 08:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:08 INFO - 'HOME': '/Users/cltbld', 08:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:08 INFO - 'LOGNAME': 'cltbld', 08:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:08 INFO - 'MOZ_NO_REMOTE': '1', 08:46:08 INFO - 'NO_EM_RESTART': '1', 08:46:08 INFO - 'PAGER': '/bin/cat', 08:46:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:08 INFO - 'PWD': '/builds/slave/test', 08:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:08 INFO - 'SHELL': '/bin/bash', 08:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:46:08 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:08 INFO - 'USER': 'cltbld', 08:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:08 INFO - 'XPC_FLAGS': '0x0', 08:46:08 INFO - 'XPC_SERVICE_NAME': '0', 08:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 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)) 08:46:09 INFO - Cleaning up... 08:46:09 INFO - Return code: 0 08:46:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:09 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 0x101eac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e22570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc73cc3ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, '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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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 08:46:09 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 08:46:09 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 08:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:09 INFO - 'HOME': '/Users/cltbld', 08:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:09 INFO - 'LOGNAME': 'cltbld', 08:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:09 INFO - 'MOZ_NO_REMOTE': '1', 08:46:09 INFO - 'NO_EM_RESTART': '1', 08:46:09 INFO - 'PAGER': '/bin/cat', 08:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:09 INFO - 'PWD': '/builds/slave/test', 08:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:09 INFO - 'SHELL': '/bin/bash', 08:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:46:09 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:09 INFO - 'USER': 'cltbld', 08:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:09 INFO - 'XPC_FLAGS': '0x0', 08:46:09 INFO - 'XPC_SERVICE_NAME': '0', 08:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:46:09 INFO - Cleaning up... 08:46:09 INFO - Return code: 0 08:46:09 INFO - Running post-action listener: _resource_record_post_action 08:46:09 INFO - Running post-action listener: _start_resource_monitoring 08:46:09 INFO - Starting resource monitoring. 08:46:09 INFO - [mozharness: 2016-09-23 15:46:09.321028Z] Finished create-virtualenv step (success) 08:46:09 INFO - [mozharness: 2016-09-23 15:46:09.322019Z] Running install step. 08:46:09 INFO - Running pre-action listener: _resource_record_pre_action 08:46:09 INFO - Running main action method: install 08:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:09 INFO - Reading from file tmpfile_stdout 08:46:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:09 INFO - Reading from file tmpfile_stdout 08:46:09 INFO - Output received: 08:46:09 INFO - Usage: mozinstall [options] installer 08:46:09 INFO - Options: 08:46:09 INFO - -h, --help show this help message and exit 08:46:09 INFO - -d DEST, --destination=DEST 08:46:09 INFO - Directory to install application into. [default: 08:46:09 INFO - "/builds/slave/test"] 08:46:09 INFO - --app=APP Application being installed. [default: firefox] 08:46:09 INFO - mkdir: /builds/slave/test/build/application 08:46:09 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'] 08:46:09 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 08:46:43 INFO - Reading from file tmpfile_stdout 08:46:43 INFO - Output received: 08:46:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:46:43 INFO - Running post-action listener: _resource_record_post_action 08:46:43 INFO - [mozharness: 2016-09-23 15:46:43.951744Z] Finished install step (success) 08:46:43 INFO - [mozharness: 2016-09-23 15:46:43.951881Z] Running run-tests step. 08:46:43 INFO - Running pre-action listener: _resource_record_pre_action 08:46:43 INFO - Running main action method: run_tests 08:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:43 INFO - 2016-09-23 08:46:43.966 screenresolution[1639:7735] starting screenresolution argv=screenresolution get 08:46:43 INFO - 2016-09-23 08:46:43.969 screenresolution[1639:7735] Display 0: 1600x1200x32@60 08:46:43 INFO - 2016-09-23 08:46:43.974 screenresolution[1640:7737] starting screenresolution argv=screenresolution list 08:46:43 INFO - Available Modes on Display 0 08:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:44 INFO - Intel Iris: 08:46:44 INFO - Chipset Model: Intel Iris 08:46:44 INFO - Type: GPU 08:46:44 INFO - Bus: Built-In 08:46:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:44 INFO - Vendor: Intel (0x8086) 08:46:44 INFO - Device ID: 0x0a2e 08:46:44 INFO - Revision ID: 0x0009 08:46:44 INFO - Displays: 08:46:44 INFO - Display: 08:46:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:44 INFO - Display Serial Number: 1600x1200 60 08:46:44 INFO - Main Display: Yes 08:46:44 INFO - Mirror: Off 08:46:44 INFO - Online: Yes 08:46:44 INFO - Rotation: Supported 08:46:44 INFO - Return code: 0 08:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:44 INFO - Python 2.7.3 08:46:44 INFO - Return code: 0 08:46:44 INFO - grabbing minidump binary from tooltool 08:46:44 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')]} 08:46:44 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 0x101cc0d30>, '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 0x101ae6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cb8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:44 INFO - Return code: 0 08:46:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0092 --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 08:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qw0N3uo9Eb/Render', 08:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:44 INFO - 'HOME': '/Users/cltbld', 08:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:44 INFO - 'LOGNAME': 'cltbld', 08:46:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:44 INFO - 'MOZ_NO_REMOTE': '1', 08:46:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:44 INFO - 'NO_EM_RESTART': '1', 08:46:44 INFO - 'PAGER': '/bin/cat', 08:46:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:44 INFO - 'PWD': '/builds/slave/test', 08:46:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:44 INFO - 'SHELL': '/bin/bash', 08:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YJYtykyOW6/Listeners', 08:46:44 INFO - 'TMPDIR': '/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/', 08:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:44 INFO - 'USER': 'cltbld', 08:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:44 INFO - 'XPC_FLAGS': '0x0', 08:46:44 INFO - 'XPC_SERVICE_NAME': '0', 08:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0092', '--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 08:46:44 INFO - mozversion application_buildid: 20160923065658 08:46:44 INFO - mozversion application_changeset: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b 08:46:44 INFO - mozversion application_display_name: Nightly 08:46:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:44 INFO - mozversion application_name: Firefox 08:46:44 INFO - mozversion application_remotingname: firefox 08:46:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 08:46:44 INFO - mozversion application_vendor: Mozilla 08:46:44 INFO - mozversion application_version: 52.0a1 08:46:44 INFO - mozversion platform_buildid: 20160923065658 08:46:44 INFO - mozversion platform_changeset: e26037d2a25382b8b8a70d6b0390dc1cbe370f5b 08:46:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 08:46:44 INFO - mozversion platform_version: 52.0a1 08:46:44 INFO - using testdate: 1474645604 08:46:44 INFO - actual date: 1474645604 08:46:44 INFO - starting webserver on 'localhost:49271' 08:46:44 INFO - SUITE-START | Running 2 tests 08:46:44 INFO - TEST-START | dromaeo_css 08:46:44 INFO - operating with platform_type : mac_ 08:46:44 INFO - Initialising browser for dromaeo_css test... 08:46:44 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpiBv1b0/profile http://localhost:49271/getInfo.html) 08:46:47 INFO - PROCESS | 1650 | 2016-09-23 08:46:47.187 plugin-container[1652:7900] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a47, name = 'com.apple.tsm.portname' 08:46:47 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:46:47 INFO - PROCESS | 1650 | 2016-09-23 08:46:47.190 plugin-container[1652:7900] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d0f, name = 'com.apple.CFPasteboardClient' 08:46:47 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:46:47 INFO - PROCESS | 1650 | 2016-09-23 08:46:47.190 plugin-container[1652:7900] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:46:47 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:46:47 INFO - PROCESS | 1650 | colorDepth:24 08:46:47 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:46:47 INFO - PROCESS | 1650 | __metrics 08:46:47 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 08:46:47 INFO - TEST-INFO | 1650: exit 0 08:46:47 INFO - Browser initialized. 08:46:47 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:47 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpiBv1b0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:50 INFO - PROCESS | 1653 | 2016-09-23 08:46:50.341 plugin-container[1654:8020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 08:46:50 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:46:50 INFO - PROCESS | 1653 | 2016-09-23 08:46:50.345 plugin-container[1654:8020] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 08:46:50 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:46:50 INFO - PROCESS | 1653 | 2016-09-23 08:46:50.345 plugin-container[1654:8020] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:46:59 INFO - PROCESS | 1653 | RSS: Main: 239935488 08:46:59 INFO - PROCESS | 1653 | 08:47:49 INFO - PROCESS | 1653 | 1474645669601 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] 08:50:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 08:50:02 INFO - PROCESS | 1653 | RSS: Main: 252776448 08:50:02 INFO - PROCESS | 1653 | 08:53:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 08:53:05 INFO - PROCESS | 1653 | RSS: Main: 265310208 08:53:05 INFO - PROCESS | 1653 | 08:56:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 08:56:08 INFO - PROCESS | 1653 | RSS: Main: 269877248 08:56:08 INFO - PROCESS | 1653 | 08:59:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 08:59:10 INFO - PROCESS | 1653 | RSS: Main: 269631488 08:59:10 INFO - PROCESS | 1653 | 09:02:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:02:14 INFO - PROCESS | 1653 | RSS: Main: 275095552 09:02:14 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:05:17 INFO - PROCESS | 1653 | RSS: Main: 277807104 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | __start_tp_report 09:05:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:05:17 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:05:17 INFO - PROCESS | 1653 | |i|pagename|runs| 09:05:17 INFO - PROCESS | 1653 | |0;dojo.html;2865.813722108063;3368.5452463917363;3400.28593995261;3429.6741809528085;3431.8627254909807;4977.552020318166;5241.659292146008;5699.629524080937;5744.597878148531;5766.567507436938;5556.416576259495;5696.145578163278;5733.197352370671;5737.426257374261;5773.134029895517;4361.563843615645;5179.663321884084;5266.605004624649;5274.55166310864;5275.208718692188;5214.817481388152;5221.034108689885;5269.235960785683;5300.231466437364;5329;5243.082460569385;5267.446918073604;5304.443033481487;5379.757910894;5379.9731001344935;5240.187770895517;5258.39528454225;5262.131748261532;5266.683998960056;5281.947180528184;4999.825041115335;5207.062728708831;5232.973835130838;5251.28061749228;5258.8159414420315;4585.174668559658;5538.944610553883;5736.8852622947725;5747.540196784247;5763.769449222026;6212.627242365473;6234.563580549363;6252.718627661766;6265.373462653743;6273.87452250957;6128.105930682418;6182.474489668383;6206.503479721611;6249.937500624981;6258.34287399821;5771.394003629643;5778.104393818965;5835;5879.265091863517;5939.10913362999;6190.51659172238;6231.719572619152;6239.656818875005;6246.562740608205;6280.152179455807;5972.85067873298;6180.598261113013;6199.318075011745;6200.255969283715;6210.099535567318;6124.74712746768;6152.8769424611255;6163.506919446433;6181.567290289637;6220.533459990519;6139.969300153471;6194.566380353423;6239.875202495925;6240.251169859555;6249.34381889895;6178.351273116348;6223.937760622426;6246.219222597176;6259.906101408483;6268.310485846644;4807.399075115611;4859.586935110485;4877.317175595419;4880.487548807395;4909.828156014522;4398.428204333416;4413.1394378095965;4416.293393057095;4441.777911104432;4451.488078870972;5658.603897727202;5741.081426971665;5788.102844059177;5848.941510584925;5867.647941123546;6151.800398922257;6169.84575385619;6212.223472065992;6215.564910456224;6262.5929314594405;5823.621464604787;5828.737706803204;5832.037713777264;5842.8539286517325;5863.618864773776;5310.548603368757;5427.294451721251;5429.131338985822;5442.455754424605;5444.373897001817;5292.629515933848;5292.814751483679;5538.670719027405;5835.0080486318275;6190.535709821781;5614.29821272341;6170.444659980623;6216.067589861557;6229.3770622939155;6234.657093859882;6291.905621415774;6296.433321001132;6303.779367722108;6308.053791931247;6327.17746692927;6174.603967817772;6180.227471566054;6200.937990620036;6225.62646241227;6228.688565571612;5595.580331475075;5831.883362332815;6148.692565371624;6153;6243.96878015607;6140.631562106288;6143.0206349921145;6175.228096487939;6199;6215.316315205414;6020.819375418744;6031.215941927697;6160.507159427325;6169.951108311508;6177.598456100339;5749.8562535936935;5762.1068734346245;5921.6743079131065;5964.463198312173;6014.548908831767;5347.9304139171545;6080.787172448943;6112.290716697506;6128.442013631005;6186.505079593711;6009.7896573621465;6022.849428764316;6033.5173186145885;6034.09488576717;6041.969790151021 09:05:17 INFO - PROCESS | 1653 | |1;ext.html;500.24213316825006;507.2923272035513;515.2863284351178;518.9931532826316;528.2841749429523;36497;39224.82325530231;39237.01907452308;39270.21459570807;39359;39904.800475997654;40205.396919046165;40488.78533643988;40573.362731422436;41078;9480.81038379232;9740.805183896318;9755.365901216433;9763.43784994401;9777.364471309378;9637.373570717917;9699.36954097985;9700.466474343908;9715.07706767856;9775.120239178472;9681.515924203797;9711.174550163245;9739.513024348755;9744.02559744027;9746.610135594568;9655.855162172573;9665.323427360088;9672.80654386912;9703.90296097037;9709.271804614611;9618.615255389775;9695.563699633534;9703.757406064835;9707.61169553217;9738.561764720605;37679.81160094209;37848.62151378506;38023.809880950415;38121.42817857734;38352;3259.1852036990754;3381.8816341427932;3829.5021647185968;4016.879493615196;4141.767054261635;29546.70453295461;30309.545356819664;30714.53928191079;30763.69236307653;30827.38345233105;3161.146490447566;3314.436545787222;3320.734341252694;3358.664133586646;3358.714509266715;353569;354501;357713;359970;360174.1991290053;57222.713886431135;57684;57685.711571441876;57698.13452798211;57763.422365775805;48148.5185148144;51203.743981279855;54418.45581544134;54496.3678087367;58859;15259.237038148049;15373;15670.962774839198;15711.528654140395;15728.842711572966;12313.44589493475;12319.260844349188;12436.129470936947;12437.253764774143;12443.813342799684;14782.92608536972;15218.16300103505;15337.309821057856;15422.768658470131;15518.767218491732;5596.397675081107;6171.84570385735;7033.507654464139;7110;7125.786226413215;812.3541784281392;874.7550685807984;1028.3624153025173;1048.6067724603274;1093.517714787444;23820.52358952811;29309.12072637824;29467;29873.551896721565;30049.098527044225;926.2124100486127;928.215657769184;1094.370736826328;1127.7011591928147;1127.887211278882;13600.795988060187;13913.513027044004;14192.64518387028;15441.0735355879;15696.450624228326;644257;658385;659687;661115;666638;54855;55099.449005510236;55243.72378138084;55255.89488210213;55278.72360638171;1352.4387379237505;1357.429879450633;1406.9085509441854;1418.2766788937715;1420.6022313752167;25813.838377273445;27604.44791104207;28296.009639662512;29905.252368690086;29976.100716978526;47210;47543.04913901634;47591.286130707376;47729;47739.76130119327;595527;598228;601626;603194;605387;37819.432708508844;39090.60909390869;39266.01834954149;39298.6070139295;39396.2120757589;44655.330170048124;44673.21307147678;45342.77328613336;46021.53978460172;46526.069478610916;33698.83150584231;38012.80993595014;38593.421098684106;38865.41701874418;39387.80306098451;36818.447723283636;37137;37238.77565176024;38312.233755325295;38449;37362.62637373591;40308.79073627796;41181.97045073897;41321.380179296735;41418.37872431976;37594.43608345932;38069.80965095157;40090.39864401978;40475;41633.58366416297;30333.090007299816;31616.841915790275;31776.682233178297;32003;32206.838965805022 09:05:17 INFO - PROCESS | 1653 | |2;jquery.html;357.5655578472156;368.7750472211949;371.22414154417265;381.8887038717333;393.2528196426789;19203.039848007615;19967.10148043338;20498.692519612217;20792.48018799531;21003.36989890302;11966.521339146446;11967.64097077089;18017.90991045043;19674.508137296576;20407.59184816303;5315.255864179018;5522.171674248874;5528.087865502187;5535.501804837564;5547.084731019397;5471.945280547184;5980.252468441445;6035.818925432244;6048.727807248684;6055.909161362583;5527.309086364205;5957.761689532414;6006.669633170174;6008.639481631094;6016.639001659914;4386.670999675021;4931.778069986841;5158.767855446514;5642.576806739511;5658.066419040853;4590.632749380042;4609.469910960249;5248.134057880445;5335.7865685372535;5488.835334939959;12706.174098683648;13355.065145439823;13355.666108347272;13407.262600556965;15033.774493382609;1948.581055073152;2154.450615093157;2176.9346919592435;2306.850054746436;2308.68832707584;9110.817783644356;9929.255305852017;10321.948390258076;12915.87084129156;15185.696286074328;1614.4268784581423;1893.0345523782833;1915.5689969756831;1938.8948299469166;2050.0672194151775;106250.46874765655;107130;109161;119440;130163.69836301706;10886.836697449544;11290.604828830952;11459.942700286612;11484.770304593862;11575.247608905394;13925.721485570231;13927;13943.790843137362;13944.790828137586;14021.29893505341;8147.429679922467;8390.496570205685;8460.619272132768;8577.699780507777;8583.39916205872;8404;8404.495730256203;8423.70517031901;8578.957105214435;8590.957045214735;4464.9107017860115;4535.591796738309;4585;4613.976930115328;4630.814767409266;1820.7359932809668;1941.951451213731;1961.499817546545;2000.4298774849099;2007.879527228371;819.4632515702225;835.7952301686004;852.5055467828645;925.2135684667978;975.1954637424153;20721.58556828885;21228.150873964867;21500.677489837664;21501.89249053776;21563.568728625338;934.3039435620507;942.4047259704206;977.5649835822991;980.2060331131806;1005.7837564923576;10509.789804203872;11047.502862371213;11118.499667514981;11120.277181983145;11189.608363707232;566505;570169;570968;579091;580332;106935.93064069415;127680;139184;139523;143682;921.8202450522084;936.6253498600614;953.9761505962407;962.4465932089076;966.2221911361421;16421.261043253322;18676.719849202545;18757.624847502702;18784.6243075135;18914.337998169998;55177;56260;56478.71760641171;57631.71184144053;58694.532636684424;80769;81788;81917.59041204756;82414;82501;7892.939915767301;7990.963433895083;8081.636326365446;8181.140980197231;8188.713395031145;9036.27709783229;11822.881771182178;12567.37163141821;13037.739245214852;13153.934230328787;9285.582148803454;9572.664956726481;10419.94790026045;11082.390468524309;11218.551257949917;8596.70798294197;8798.900137482815;11010.614628487965;11013.394263315595;11076.446177691245;11019.889801101886;11236;11397.08823294118;11454.885451145381;11572.189946703988;6855.971604259401;7833.334166595903;7988.640511177127;8181.386396020442;8230.012398512217;9208.861867071866;9218.9539052307;9343.953280233827;10547.103496202908;10893 09:05:17 INFO - PROCESS | 1653 | |3;mootools.html;1539.745941919583;1577.9822014800452;1800.216905646044;1891.7919028906808;1892.8201820827016;7953.244441778036;8232.053313868906;8460.28087612553;9005.054469280722;9006.639734410624;8409.70566030189;8711.477311361323;8720.215180633742;8832.823343533126;8838.91161088389;2374.2283757778705;2420.165043060141;2424.563578555868;2425.3507614821915;2438.9634155487684;2400.567897778399;2416.540857237128;2440.6827112475353;2443.0716327795412;2447.204658485999;2410.674558934548;2417.2989832948424;2421.769931856471;2429.259075981825;2433.6714543536664;2043.8978051097386;2046.2531176120758;2212.070930209316;2218.1127548980376;2226.265332440299;2370.3600027992347;2375.358653163636;2392.294273189396;2392.712874455059;2396.988015059931;8781.868271975925;8900.955495222548;8919.910800891972;8920;8977.012528621912;5239.397469291042;5360;5396.730163491809;5399.244105825188;5401.108817045183;3568.2685049564775;3599.9100022499383;3614.3855544557487;3675.117971686776;3675.117971686803;1093.5079214353573;1094.2231015978664;1096.1395304685864;1104.8895110488968;1114.9888501114965;11621.593244236496;11701.473433695419;11754.23597466162;11795.528178872835;11806.527738890434;4549.54504549549;4749.287606858929;4828.8792780180775;4847.079054979543;4875.829345972874;7913.841723165505;9728.562214700356;9852;9966.302358834957;9967.40195588267;4493.96638773084;5347.545458635982;5348.197770334481;5368.3826359968325;5379.54273886724;3985.8405663773706;4387.4954380246045;4544.091181763661;4633.976830115896;4902.191138462185;3894.1043559981363;3909.9413508797393;3970.4639873616693;4024.879253622396;4052.675785937118;1288.1884412819863;1306.8235788168477;1308.2019967819622;1308.3458270864567;1327.807467917166;812.2689579378607;917.1974522292994;924.7179610218814;928.9628414863465;946.8248374050822;4940.777665005084;5471.5896307777075;6017.916774980458;6020.963195299187;6069.605475644069;432.8160531773984;440.425245055206;445.888527868033;447.3446401022518;452.47964840433764;3958.346872766019;4132.938005929914;4153.899216707575;4296.334068219431;4311.461067366579;10519.26365154432;10562.366258024544;10653.414062226651;10770.138388929023;10869.83695244572;10505.054545090825;10678.786424271471;10727.517261723242;10750.301230420155;10777.622783202707;8045.839083218303;8159.061707903667;8191.918080819116;8211.21993410625;8229.835403291901;5247.606429517878;5549.9177660355845;6003.8198854034445;6033.909491357721;6097.4817140543555;9750.658726944523;9808.509574521388;9811.215102791617;9915.504224788587;10028.899711002796;9780.510974451106;9968.102870741668;10146.746331341776;10191.439470829175;10363.119134873621;6907.827304317432;7333.266673332624;7488.700451981859;7496.625168741432;7634.8091297718;8396.748097557083;8463.28062114727;8481.533515656698;8487.023992240971;8494.83010339802;7218.242084581043;7370.926290737239;7489.737859174903;7555.886661700189;7579.696812127674;7177.964110179416;7304.853902922018;7409.777706668809;7460.104787425544;7465.589392583242;6979.6859141337745;6988.965055174692;7051.43588512928;7056.788296351117;7065.964670176616;4710.340552322746;4779.498152693917;4940.802367905244;5009.499050094962;5109.821156259513;5025.422076461107;5032.345795046621;5078.238264260391;5114.693118412907;5264.394594621667 09:05:17 INFO - PROCESS | 1653 | |4;prototype.html;273.61147171017154;277.93550700815877;294.25259840006373;308.277090223426;312.14783640660994;4938.222259971125;5202.401723801764;5252.8161514347;5315.202719592063;5404.189371594258;4522.68341216115;4909.729964851932;5125.256837758523;5252.842414727555;5270.972160428709;4035.1929614077303;4078.9184216315657;4137.007118291604;4142.378643203529;4145.905518887246;3368.59576850777;3735.9726075329368;4025.8864096349503;4153.501579810412;4162.271602469571;3588.551431071116;3589.2642008388216;4077.4903137107863;4084.8978775530554;4089.5297040840237;3219.7442997231096;3783.754055986366;4098.815553300109;4100.856470023535;4112.321466957963;3006.729394354497;3344.4314466540745;3615.3130905128205;3624.4382120771324;3634.3821550336506;4897.118518666639;5147.922781158286;5183.326167598226;5209.817656382046;5241.737913104368;3936.960630393688;4543.750093744843;4687.437507499088;4721.457032441279;4769.35613692154;5592.804251851207;5600.103983362683;5631.9718401408145;5634.464725851038;5654.529822246245;3713.9071523211865;3911.8044097794996;3930.508686414198;3942.250972315251;3945.2504024235304;5388.380336261302;5609.102543593006;5871.354151043424;5875.412458754133;5892.322382925976;3514.68367846895;3729.384651532521;3751.362268414376;4033.4756481657782;4044.15072834708;3440.0539851541025;3719.1074142205675;3954.9802250989137;4068.2880495913096;4091.85678501251;4320.978395108004;4590;4594.19601569724;4608;4628.884277893079;4854.000379609009;5192.584593232608;5659.264295641623;5697.515711164598;5729.398413166641;1174.788538063157;1237.1216436330126;1266.9746605067846;1314.572763851752;1352.6618345413647;839.3327304792705;935.9844568642962;948.2082461145021;963.9277054220961;967.4485543240426;3911.5697273300484;3966.7024973126554;4090.6318431341324;4366.886443956771;4451.554844515523;4309.633681137076;4811.171754733249;4846.588040016568;4864.732439715779;4900.803967841318;4012.555480027188;4014.795561331589;4372.3878656988045;4393.384926110347;4398.978005109954;2174.717286752712;2657.7740892024394;3012.9755882999884;3075.5540446635114;3090.5982222311404;5585.3297604287745;5725.541956643458;5882.764689412461;6142.232220972379;6162.691865406712;4979.726115063634;5456.672599644034;5730.197772311796;6080.513558915276;6098.756049758049;5732.541396688255;5978.641281523122;6188.876222475616;6192.566520343623;6199.5040396767245;4653.790579424001;5852;5891.3224979126235;5967.045272756512;5971.462568368867;5501.3948465667945;5827.329857066322;5858.619189752652;5872.5301975842685;5875.588708790344;5047.772850221675;6089.451949324582;6150.661713605616;6155.84610384744;6164.4143806338325;3323.667633236657;3505.789652620851;3529.2412131391875;3704.388775851954;3940.468036815108;4821.783019764189;5111.923321150111;5303.124984377535;5576.013150597342;5896.882062358814;4403.867883963486;4853.781579828987;5689.971550142222;5697.259356283656;5737.196792449144;5123.154679477993;5313.628046036741;5468.808591699271;5733.9392212440835;5781.595288329945;4950;5336.866578335417;5361.410244873139;5399.487048730364;5528.695921724344;4573.81704731807;5599.412061733459;5810.186573879576;5812.302523697014;5812.854678633068;4869.634777391639;4956.355673762532;5299.947000529945;5604.99110160175;5673.432656734293 09:05:17 INFO - PROCESS | 1653 | |5;yui.html;707.9504434689574;767.715945100313;790.7785819970409;813.9267465928066;824.2869917521344;15851;16390.672186556276;16508.092054936973;16515;16577.502674919757;14737.778933316009;14744.33650485728;14954.62613434662;14971.47599834006;15029.398824047052;668.3850857211353;696.140266770538;833.4499230507836;843.6372359885247;863.8099618084011;856.8414843253987;870.5168631409565;874.7550685807952;875.0767939823484;877.7579724689557;880.5421180985884;898.6989358564889;926.1340646495514;930.6091441594547;932.4964519159646;915.5010519267015;924.9768755781092;926.0230456868002;926.1988380051274;926.9073092690744;657.4083325007483;678.7929681447157;680.3264767879813;681.9829504262384;684.6782012454139;15075.698486030218;15277.847221527754;15351.385944562204;15362.00146990442;15375.384984600714;14729.410823567045;14778.704425911421;14819.77770333446;14833.925830370887;14881.255937203205;11684.649460516199;11816.281442880181;11908.821367679491;11937.34344611046;12171.93914030433;3339.248669049469;3816.599257078022;3987.8404863805413;4034.415009823559;4044.170944956277;117397.41301293524;119063.61872762497;120290;120877.79122208753;121040.39479802633;11248.212625116326;11333.603323883624;11422.371769552588;11617.419129043514;11825.866145471457;23870.641940370908;23972.28083157508;24055.037798488214;24265;24381.878090609433;8062.596870156469;8092.271695547429;8172.305354044973;8270.338372930151;8316.625751841182;4396.729032322199;4434.078173227715;4467.687261891637;4520.728756274634;4583.679142459996;3265.314284000339;3424.6917777400154;3663.120850995795;3791.867284645024;3794.4498047782918;566.8323254096574;638.1831255992337;692.7367600311849;693.19935474527;724.0948813982521;592.3809618948123;604.9516038716893;627.7520379450092;670.8825955457776;690.8825499665069;8247.876281855777;8374.874376884352;8969.103089690978;9844.114029737359;10026.864807102718;526.8314139475331;610.7618028968706;621.6953692690639;656.5437021270171;657.7401926239108;4523.909521809611;4782.784774685148;4813.15769740294;4813.890829258599;4854.17479028566;153647;156870;161815;163411;163488;107814;130075.34962325128;132531;132963;133823;95497;112228.87771122511;113443;115581;116168.41915790367;7641.579713115832;7699.345555627834;8918.554072296489;9102.361574916578;9251.861222081809;48693;54918.450815491335;56122.71938640444;56200;57024.42975570191;82855;94844;96918.06163876824;100263.47760440444;102230;11859.703507412383;12030.09774266916;12068.215565988534;12149;12224.572139975058;12920.612381628565;13251.11558622618;13312.600621981355;13320;13950.511732089733;12245.816312755494;12324.014078873848;12363.93818030904;12690.682732931751;12788.680282993;12213.328266945047;12368;12395.814062789246;12749.93625031869;12805.295708736108;12234.37802619073;12263.632091037283;12451.75096498083;12520.686982825502;12652;9330.915756754786;10055;10343.224258180817;10533.4733263335;10564.577416903237;10291.279610427198;10606.257561970588;10622.84065738999;10706;10716.946415267874 09:05:17 INFO - PROCESS | 1653 | __end_tp_report 09:05:17 INFO - PROCESS | 1653 | __start_cc_report 09:05:17 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,361 09:05:17 INFO - PROCESS | 1653 | __end_cc_report 09:05:17 INFO - PROCESS | 1653 | __startTimestamp1474646717392__endTimestamp 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:05:17 INFO - PROCESS | 1653 | Number of tests: 6 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5705.51 Median:5867.65 stddev:651.52 (11.1%) stddev-sans-first:614.25 09:05:17 INFO - PROCESS | 1653 | Values: 2865.8 3368.5 3400.3 3429.7 3431.9 4977.6 5241.7 5699.6 5744.6 5766.6 5556.4 5696.1 5733.2 5737.4 5773.1 4361.6 5179.7 5266.6 5274.6 5275.2 5214.8 5221.0 5269.2 5300.2 5329.0 5243.1 5267.4 5304.4 5379.8 5380.0 5240.2 5258.4 5262.1 5266.7 5281.9 4999.8 5207.1 5233.0 5251.3 5258.8 4585.2 5538.9 5736.9 5747.5 5763.8 6212.6 6234.6 6252.7 6265.4 6273.9 6128.1 6182.5 6206.5 6249.9 6258.3 5771.4 5778.1 5835.0 5879.3 5939.1 6190.5 6231.7 6239.7 6246.6 6280.2 5972.9 6180.6 6199.3 6200.3 6210.1 6124.7 6152.9 6163.5 6181.6 6220.5 6140.0 6194.6 6239.9 6240.3 6249.3 6178.4 6223.9 6246.2 6259.9 6268.3 4807.4 4859.6 4877.3 4880.5 4909.8 4398.4 4413.1 4416.3 4441.8 4451.5 5658.6 5741.1 5788.1 5848.9 5867.6 6151.8 6169.8 6212.2 6215.6 6262.6 5823.6 5828.7 5832.0 5842.9 5863.6 5310.5 5427.3 5429.1 5442.5 5444.4 5292.6 5292.8 5538.7 5835.0 6190.5 5614.3 6170.4 6216.1 6229.4 6234.7 6291.9 6296.4 6303.8 6308.1 6327.2 6174.6 6180.2 6200.9 6225.6 6228.7 5595.6 5831.9 6148.7 6153.0 6244.0 6140.6 6143.0 6175.2 6199.0 6215.3 6020.8 6031.2 6160.5 6170.0 6177.6 5749.9 5762.1 5921.7 5964.5 6014.5 5347.9 6080.8 6112.3 6128.4 6186.5 6009.8 6022.8 6033.5 6034.1 6042.0 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:67477.55 Median:39392.01 stddev:148390.00 (376.7%) stddev-sans-first:148721.06 09:05:17 INFO - PROCESS | 1653 | Values: 500.2 507.3 515.3 519.0 528.3 36497.0 39224.8 39237.0 39270.2 39359.0 39904.8 40205.4 40488.8 40573.4 41078.0 9480.8 9740.8 9755.4 9763.4 9777.4 9637.4 9699.4 9700.5 9715.1 9775.1 9681.5 9711.2 9739.5 9744.0 9746.6 9655.9 9665.3 9672.8 9703.9 9709.3 9618.6 9695.6 9703.8 9707.6 9738.6 37679.8 37848.6 38023.8 38121.4 38352.0 3259.2 3381.9 3829.5 4016.9 4141.8 29546.7 30309.5 30714.5 30763.7 30827.4 3161.1 3314.4 3320.7 3358.7 3358.7 353569.0 354501.0 357713.0 359970.0 360174.2 57222.7 57684.0 57685.7 57698.1 57763.4 48148.5 51203.7 54418.5 54496.4 58859.0 15259.2 15373.0 15671.0 15711.5 15728.8 12313.4 12319.3 12436.1 12437.3 12443.8 14782.9 15218.2 15337.3 15422.8 15518.8 5596.4 6171.8 7033.5 7110.0 7125.8 812.4 874.8 1028.4 1048.6 1093.5 23820.5 29309.1 29467.0 29873.6 30049.1 926.2 928.2 1094.4 1127.7 1127.9 13600.8 13913.5 14192.6 15441.1 15696.5 644257.0 658385.0 659687.0 661115.0 666638.0 54855.0 55099.4 55243.7 55255.9 55278.7 1352.4 1357.4 1406.9 1418.3 1420.6 25813.8 27604.4 28296.0 29905.3 29976.1 47210.0 47543.0 47591.3 47729.0 47739.8 595527.0 598228.0 601626.0 603194.0 605387.0 37819.4 39090.6 39266.0 39298.6 39396.2 44655.3 44673.2 45342.8 46021.5 46526.1 33698.8 38012.8 38593.4 38865.4 39387.8 36818.4 37137.0 37238.8 38312.2 38449.0 37362.6 40308.8 41182.0 41321.4 41418.4 37594.4 38069.8 40090.4 40475.0 41633.6 30333.1 31616.8 31776.7 32003.0 32206.8 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:33978.31 Median:2389.96 stddev:96172.33 (4024.0%) stddev-sans-first:96408.98 09:05:17 INFO - PROCESS | 1653 | Values: 357.6 368.8 371.2 381.9 393.3 19203.0 19967.1 20498.7 20792.5 21003.4 11966.5 11967.6 18017.9 19674.5 20407.6 5315.3 5522.2 5528.1 5535.5 5547.1 5471.9 5980.3 6035.8 6048.7 6055.9 5527.3 5957.8 6006.7 6008.6 6016.6 4386.7 4931.8 5158.8 5642.6 5658.1 4590.6 4609.5 5248.1 5335.8 5488.8 12706.2 13355.1 13355.7 13407.3 15033.8 1948.6 2154.5 2176.9 2306.9 2308.7 9110.8 9929.3 10321.9 12915.9 15185.7 1614.4 1893.0 1915.6 1938.9 2050.1 106250.5 107130.0 109161.0 119440.0 130163.7 10886.8 11290.6 11459.9 11484.8 11575.2 13925.7 13927.0 13943.8 13944.8 14021.3 8147.4 8390.5 8460.6 8577.7 8583.4 8404.0 8404.5 8423.7 8579.0 8591.0 4464.9 4535.6 4585.0 4614.0 4630.8 1820.7 1942.0 1961.5 2000.4 2007.9 819.5 835.8 852.5 925.2 975.2 20721.6 21228.2 21500.7 21501.9 21563.6 934.3 942.4 977.6 980.2 1005.8 10509.8 11047.5 11118.5 11120.3 11189.6 566505.0 570169.0 570968.0 579091.0 580332.0 106935.9 127680.0 139184.0 139523.0 143682.0 921.8 936.6 954.0 962.4 966.2 16421.3 18676.7 18757.6 18784.6 18914.3 55177.0 56260.0 56478.7 57631.7 58694.5 80769.0 81788.0 81917.6 82414.0 82501.0 7892.9 7991.0 8081.6 8181.1 8188.7 9036.3 11822.9 12567.4 13037.7 13153.9 9285.6 9572.7 10419.9 11082.4 11218.6 8596.7 8798.9 11010.6 11013.4 11076.4 11019.9 11236.0 11397.1 11454.9 11572.2 6856.0 7833.3 7988.6 8181.4 8230.0 9208.9 9219.0 9344.0 10547.1 10893.0 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5691.46 Median:4889.01 stddev:3196.80 (65.4%) stddev-sans-first:3190.54 09:05:17 INFO - PROCESS | 1653 | Values: 1539.7 1578.0 1800.2 1891.8 1892.8 7953.2 8232.1 8460.3 9005.1 9006.6 8409.7 8711.5 8720.2 8832.8 8838.9 2374.2 2420.2 2424.6 2425.4 2439.0 2400.6 2416.5 2440.7 2443.1 2447.2 2410.7 2417.3 2421.8 2429.3 2433.7 2043.9 2046.3 2212.1 2218.1 2226.3 2370.4 2375.4 2392.3 2392.7 2397.0 8781.9 8901.0 8919.9 8920.0 8977.0 5239.4 5360.0 5396.7 5399.2 5401.1 3568.3 3599.9 3614.4 3675.1 3675.1 1093.5 1094.2 1096.1 1104.9 1115.0 11621.6 11701.5 11754.2 11795.5 11806.5 4549.5 4749.3 4828.9 4847.1 4875.8 7913.8 9728.6 9852.0 9966.3 9967.4 4494.0 5347.5 5348.2 5368.4 5379.5 3985.8 4387.5 4544.1 4634.0 4902.2 3894.1 3909.9 3970.5 4024.9 4052.7 1288.2 1306.8 1308.2 1308.3 1327.8 812.3 917.2 924.7 929.0 946.8 4940.8 5471.6 6017.9 6021.0 6069.6 432.8 440.4 445.9 447.3 452.5 3958.3 4132.9 4153.9 4296.3 4311.5 10519.3 10562.4 10653.4 10770.1 10869.8 10505.1 10678.8 10727.5 10750.3 10777.6 8045.8 8159.1 8191.9 8211.2 8229.8 5247.6 5549.9 6003.8 6033.9 6097.5 9750.7 9808.5 9811.2 9915.5 10028.9 9780.5 9968.1 10146.7 10191.4 10363.1 6907.8 7333.3 7488.7 7496.6 7634.8 8396.7 8463.3 8481.5 8487.0 8494.8 7218.2 7370.9 7489.7 7555.9 7579.7 7178.0 7304.9 7409.8 7460.1 7465.6 6979.7 6989.0 7051.4 7056.8 7066.0 4710.3 4779.5 4940.8 5009.5 5109.8 5025.4 5032.3 5078.2 5114.7 5264.4 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4478.99 Median:4867.18 stddev:1412.49 (29.0%) stddev-sans-first:1380.73 09:05:17 INFO - PROCESS | 1653 | Values: 273.6 277.9 294.3 308.3 312.1 4938.2 5202.4 5252.8 5315.2 5404.2 4522.7 4909.7 5125.3 5252.8 5271.0 4035.2 4078.9 4137.0 4142.4 4145.9 3368.6 3736.0 4025.9 4153.5 4162.3 3588.6 3589.3 4077.5 4084.9 4089.5 3219.7 3783.8 4098.8 4100.9 4112.3 3006.7 3344.4 3615.3 3624.4 3634.4 4897.1 5147.9 5183.3 5209.8 5241.7 3937.0 4543.8 4687.4 4721.5 4769.4 5592.8 5600.1 5632.0 5634.5 5654.5 3713.9 3911.8 3930.5 3942.3 3945.3 5388.4 5609.1 5871.4 5875.4 5892.3 3514.7 3729.4 3751.4 4033.5 4044.2 3440.1 3719.1 3955.0 4068.3 4091.9 4321.0 4590.0 4594.2 4608.0 4628.9 4854.0 5192.6 5659.3 5697.5 5729.4 1174.8 1237.1 1267.0 1314.6 1352.7 839.3 936.0 948.2 963.9 967.4 3911.6 3966.7 4090.6 4366.9 4451.6 4309.6 4811.2 4846.6 4864.7 4900.8 4012.6 4014.8 4372.4 4393.4 4399.0 2174.7 2657.8 3013.0 3075.6 3090.6 5585.3 5725.5 5882.8 6142.2 6162.7 4979.7 5456.7 5730.2 6080.5 6098.8 5732.5 5978.6 6188.9 6192.6 6199.5 4653.8 5852.0 5891.3 5967.0 5971.5 5501.4 5827.3 5858.6 5872.5 5875.6 5047.8 6089.5 6150.7 6155.8 6164.4 3323.7 3505.8 3529.2 3704.4 3940.5 4821.8 5111.9 5303.1 5576.0 5896.9 4403.9 4853.8 5690.0 5697.3 5737.2 5123.2 5313.6 5468.8 5733.9 5781.6 4950.0 5336.9 5361.4 5399.5 5528.7 4573.8 5599.4 5810.2 5812.3 5812.9 4869.6 4956.4 5299.9 5605.0 5673.4 09:05:17 INFO - PROCESS | 1653 | 09:05:17 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25260.84 Median:13823.60 stddev:41211.84 (298.1%) stddev-sans-first:41286.22 09:05:17 INFO - PROCESS | 1653 | Values: 708.0 767.7 790.8 813.9 824.3 15851.0 16390.7 16508.1 16515.0 16577.5 14737.8 14744.3 14954.6 14971.5 15029.4 668.4 696.1 833.4 843.6 863.8 856.8 870.5 874.8 875.1 877.8 880.5 898.7 926.1 930.6 932.5 915.5 925.0 926.0 926.2 926.9 657.4 678.8 680.3 682.0 684.7 15075.7 15277.8 15351.4 15362.0 15375.4 14729.4 14778.7 14819.8 14833.9 14881.3 11684.6 11816.3 11908.8 11937.3 12171.9 3339.2 3816.6 3987.8 4034.4 4044.2 117397.4 119063.6 120290.0 120877.8 121040.4 11248.2 11333.6 11422.4 11617.4 11825.9 23870.6 23972.3 24055.0 24265.0 24381.9 8062.6 8092.3 8172.3 8270.3 8316.6 4396.7 4434.1 4467.7 4520.7 4583.7 3265.3 3424.7 3663.1 3791.9 3794.4 566.8 638.2 692.7 693.2 724.1 592.4 605.0 627.8 670.9 690.9 8247.9 8374.9 8969.1 9844.1 10026.9 526.8 610.8 621.7 656.5 657.7 4523.9 4782.8 4813.2 4813.9 4854.2 153647.0 156870.0 161815.0 163411.0 163488.0 107814.0 130075.3 132531.0 132963.0 133823.0 95497.0 112228.9 113443.0 115581.0 116168.4 7641.6 7699.3 8918.6 9102.4 9251.9 48693.0 54918.5 56122.7 56200.0 57024.4 82855.0 94844.0 96918.1 100263.5 102230.0 11859.7 12030.1 12068.2 12149.0 12224.6 12920.6 13251.1 13312.6 13320.0 13950.5 12245.8 12324.0 12363.9 12690.7 12788.7 12213.3 12368.0 12395.8 12749.9 12805.3 12234.4 12263.6 12451.8 12520.7 12652.0 9330.9 10055.0 10343.2 10533.5 10564.6 10291.3 10606.3 10622.8 10706.0 10716.9 09:05:17 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:05:17 INFO - PROCESS | 1653 | 09:05:18 INFO - TEST-INFO | 1653: exit 0 09:05:18 INFO - TEST-OK | dromaeo_css | took 1113536ms 09:05:18 INFO - TEST-START | kraken 09:05:18 INFO - operating with platform_type : mac_ 09:05:18 INFO - Initialising browser for kraken test... 09:05:18 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpS8QkHq/profile http://localhost:49271/getInfo.html) 09:05:20 INFO - PROCESS | 1661 | 2016-09-23 09:05:20.816 plugin-container[1662:10325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4613, name = 'com.apple.tsm.portname' 09:05:20 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:05:20 INFO - PROCESS | 1661 | 2016-09-23 09:05:20.819 plugin-container[1662:10325] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 09:05:20 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:05:20 INFO - PROCESS | 1661 | 2016-09-23 09:05:20.819 plugin-container[1662:10325] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:05:20 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 09:05:20 INFO - PROCESS | 1661 | colorDepth:24 09:05:20 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 09:05:20 INFO - PROCESS | 1661 | __metrics 09:05:20 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 09:05:21 INFO - TEST-INFO | 1661: exit 0 09:05:21 INFO - Browser initialized. 09:05:21 INFO - Running cycle 1/1 for kraken test... 09:05:21 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/T/tmpS8QkHq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:24 INFO - PROCESS | 1663 | 2016-09-23 09:05:24.066 plugin-container[1664:10435] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891f, name = 'com.apple.tsm.portname' 09:05:24 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:05:24 INFO - PROCESS | 1663 | 2016-09-23 09:05:24.068 plugin-container[1664:10435] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 09:05:24 INFO - PROCESS | 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:05:24 INFO - PROCESS | 1663 | 2016-09-23 09:05:24.069 plugin-container[1664:10435] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:05:33 INFO - PROCESS | 1663 | RSS: Main: 239542272 09:05:33 INFO - PROCESS | 1663 | 09:05:36 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:37 INFO - PROCESS | 1663 | RSS: Main: 253054976 09:05:37 INFO - PROCESS | 1663 | 09:05:40 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:05:40 INFO - PROCESS | 1663 | RSS: Main: 261775360 09:05:40 INFO - PROCESS | 1663 | 09:05:44 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:05:45 INFO - PROCESS | 1663 | RSS: Main: 261832704 09:05:45 INFO - PROCESS | 1663 | 09:05:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:05:47 INFO - PROCESS | 1663 | RSS: Main: 262815744 09:05:47 INFO - PROCESS | 1663 | 09:05:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:50 INFO - PROCESS | 1663 | RSS: Main: 264396800 09:05:50 INFO - PROCESS | 1663 | 09:05:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:53 INFO - PROCESS | 1663 | RSS: Main: 265068544 09:05:53 INFO - PROCESS | 1663 | 09:05:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:57 INFO - PROCESS | 1663 | RSS: Main: 265318400 09:05:57 INFO - PROCESS | 1663 | 09:06:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:06:01 INFO - PROCESS | 1663 | RSS: Main: 265326592 09:06:01 INFO - PROCESS | 1663 | 09:06:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:03 INFO - PROCESS | 1663 | RSS: Main: 265195520 09:06:03 INFO - PROCESS | 1663 | 09:06:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:05 INFO - PROCESS | 1663 | RSS: Main: 265281536 09:06:05 INFO - PROCESS | 1663 | 09:06:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:08 INFO - PROCESS | 1663 | RSS: Main: 265355264 09:06:08 INFO - PROCESS | 1663 | 09:06:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:06:12 INFO - PROCESS | 1663 | RSS: Main: 265961472 09:06:12 INFO - PROCESS | 1663 | 09:06:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:06:16 INFO - PROCESS | 1663 | RSS: Main: 265478144 09:06:16 INFO - PROCESS | 1663 | 09:06:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:06:18 INFO - PROCESS | 1663 | RSS: Main: 266768384 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | __start_tp_report 09:06:18 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:06:18 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:06:18 INFO - PROCESS | 1663 | |i|pagename|runs| 09:06:18 INFO - PROCESS | 1663 | |0;ai-astar;108;117;117;118;113;117;118;117;117;118 09:06:18 INFO - PROCESS | 1663 | |1;audio-beat-detection;147;113;114;186;112;110;110;108;136;115 09:06:18 INFO - PROCESS | 1663 | |2;audio-dft;239;269;283;275;267;196;196;201;195;200 09:06:18 INFO - PROCESS | 1663 | |3;audio-fft;82;58;59;83;78;83;85;60;78;58 09:06:18 INFO - PROCESS | 1663 | |4;audio-oscillator;95;69;76;72;87;103;76;94;60;88 09:06:18 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;89;131;135;88;90;87;91;88;91;110 09:06:18 INFO - PROCESS | 1663 | |6;imaging-darkroom;99;101;100;99;99;130;175;175;99;100 09:06:18 INFO - PROCESS | 1663 | |7;imaging-desaturate;89;94;90;149;129;90;90;93;110;123 09:06:18 INFO - PROCESS | 1663 | |8;json-parse-financial;56;58;57;57;57;58;60;58;57;57 09:06:18 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;70;70;79;81;74;71;71;72;72;72 09:06:18 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;87;99;82;77;100;108;109;110;113;82 09:06:18 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;153;151;150;138;140;137;140;179;172;164 09:06:18 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;165;174;169;241;173;169;173;172;172;230 09:06:18 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;70;68;68;73;70;68;71;68;67 09:06:18 INFO - PROCESS | 1663 | __end_tp_report 09:06:18 INFO - PROCESS | 1663 | __start_cc_report 09:06:18 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,909 09:06:18 INFO - PROCESS | 1663 | __end_cc_report 09:06:18 INFO - PROCESS | 1663 | __startTimestamp1474646778120__endTimestamp 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:06:18 INFO - PROCESS | 1663 | Number of tests: 14 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:116.00 Median:117.00 stddev:3.16 (2.7%) stddev-sans-first:1.54 09:06:18 INFO - PROCESS | 1663 | Values: 108.0 117.0 117.0 118.0 113.0 117.0 118.0 117.0 117.0 118.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:125.10 Median:114.50 stddev:24.94 (21.8%) stddev-sans-first:25.16 09:06:18 INFO - PROCESS | 1663 | Values: 147.0 113.0 114.0 186.0 112.0 110.0 110.0 108.0 136.0 115.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:232.10 Median:253.00 stddev:38.06 (15.0%) stddev-sans-first:40.29 09:06:18 INFO - PROCESS | 1663 | Values: 239.0 269.0 283.0 275.0 267.0 196.0 196.0 201.0 195.0 200.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:72.40 Median:80.00 stddev:11.96 (14.9%) stddev-sans-first:12.17 09:06:18 INFO - PROCESS | 1663 | Values: 82.0 58.0 59.0 83.0 78.0 83.0 85.0 60.0 78.0 58.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:81.50 stddev:13.50 (16.6%) stddev-sans-first:13.47 09:06:18 INFO - PROCESS | 1663 | Values: 95.0 69.0 76.0 72.0 87.0 103.0 76.0 94.0 60.0 88.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:100.00 Median:88.50 stddev:18.64 (21.1%) stddev-sans-first:19.34 09:06:18 INFO - PROCESS | 1663 | Values: 89.0 131.0 135.0 88.0 90.0 87.0 91.0 88.0 91.0 110.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:117.70 Median:137.00 stddev:31.66 (23.1%) stddev-sans-first:32.85 09:06:18 INFO - PROCESS | 1663 | Values: 99.0 101.0 100.0 99.0 99.0 130.0 175.0 175.0 99.0 100.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:105.70 Median:90.00 stddev:21.22 (23.6%) stddev-sans-first:21.63 09:06:18 INFO - PROCESS | 1663 | Values: 89.0 94.0 90.0 149.0 129.0 90.0 90.0 93.0 110.0 123.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:1.08 (1.9%) stddev-sans-first:1.00 09:06:18 INFO - PROCESS | 1663 | Values: 56.0 58.0 57.0 57.0 57.0 58.0 60.0 58.0 57.0 57.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:72.00 stddev:3.79 (5.3%) stddev-sans-first:3.84 09:06:18 INFO - PROCESS | 1663 | Values: 70.0 70.0 79.0 81.0 74.0 71.0 71.0 72.0 72.0 72.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:96.70 Median:79.50 stddev:13.55 (17.0%) stddev-sans-first:13.91 09:06:18 INFO - PROCESS | 1663 | Values: 87.0 99.0 82.0 77.0 100.0 108.0 109.0 110.0 113.0 82.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:152.40 Median:152.00 stddev:14.86 (9.8%) stddev-sans-first:15.76 09:06:18 INFO - PROCESS | 1663 | Values: 153.0 151.0 150.0 138.0 140.0 137.0 140.0 179.0 172.0 164.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:173.00 stddev:27.50 (15.9%) stddev-sans-first:28.31 09:06:18 INFO - PROCESS | 1663 | Values: 165.0 174.0 169.0 241.0 173.0 169.0 173.0 172.0 172.0 230.0 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.94 (2.8%) stddev-sans-first:1.92 09:06:18 INFO - PROCESS | 1663 | Values: 67.0 70.0 68.0 68.0 73.0 70.0 68.0 71.0 68.0 67.0 09:06:18 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:06:18 INFO - PROCESS | 1663 | 09:06:18 INFO - TEST-INFO | 1663: exit 0 09:06:18 INFO - TEST-OK | kraken | took 60855ms 09:06:18 INFO - SUITE-END | took 1174s 09:06:19 INFO - Completed test suite (00:19:34) 09:06:19 INFO - javascript benchmark 09:06:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7257.3373654575535, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2865.813722108063, 3368.5452463917363, 3400.28593995261, 3429.6741809528085, 3431.8627254909807, 4977.552020318166, 5241.659292146008, 5699.629524080937, 5744.597878148531, 5766.567507436938, 5556.416576259495, 5696.145578163278, 5733.197352370671, 5737.426257374261, 5773.134029895517, 4361.563843615645, 5179.663321884084, 5266.605004624649, 5274.55166310864, 5275.208718692188, 5214.817481388152, 5221.034108689885, 5269.235960785683, 5300.231466437364, 5329.0, 5243.082460569385, 5267.446918073604, 5304.443033481487, 5379.757910894, 5379.9731001344935, 5240.187770895517, 5258.39528454225, 5262.131748261532, 5266.683998960056, 5281.947180528184, 4999.825041115335, 5207.062728708831, 5232.973835130838, 5251.28061749228, 5258.8159414420315, 4585.174668559658, 5538.944610553883, 5736.8852622947725, 5747.540196784247, 5763.769449222026, 6212.627242365473, 6234.563580549363, 6252.718627661766, 6265.373462653743, 6273.87452250957, 6128.105930682418, 6182.474489668383, 6206.503479721611, 6249.937500624981, 6258.34287399821, 5771.394003629643, 5778.104393818965, 5835.0, 5879.265091863517, 5939.10913362999, 6190.51659172238, 6231.719572619152, 6239.656818875005, 6246.562740608205, 6280.152179455807, 5972.85067873298, 6180.598261113013, 6199.318075011745, 6200.255969283715, 6210.099535567318, 6124.74712746768, 6152.8769424611255, 6163.506919446433, 6181.567290289637, 6220.533459990519, 6139.969300153471, 6194.566380353423, 6239.875202495925, 6240.251169859555, 6249.34381889895, 6178.351273116348, 6223.937760622426, 6246.219222597176, 6259.906101408483, 6268.310485846644, 4807.399075115611, 4859.586935110485, 4877.317175595419, 4880.487548807395, 4909.828156014522, 4398.428204333416, 4413.1394378095965, 4416.293393057095, 4441.777911104432, 4451.488078870972, 5658.603897727202, 5741.081426971665, 5788.102844059177, 5848.941510584925, 5867.647941123546, 6151.800398922257, 6169.84575385619, 6212.223472065992, 6215.564910456224, 6262.5929314594405, 5823.621464604787, 5828.737706803204, 5832.037713777264, 5842.8539286517325, 5863.618864773776, 5310.548603368757, 5427.294451721251, 5429.131338985822, 5442.455754424605, 5444.373897001817, 5292.629515933848, 5292.814751483679, 5538.670719027405, 5835.0080486318275, 6190.535709821781, 5614.29821272341, 6170.444659980623, 6216.067589861557, 6229.3770622939155, 6234.657093859882, 6291.905621415774, 6296.433321001132, 6303.779367722108, 6308.053791931247, 6327.17746692927, 6174.603967817772, 6180.227471566054, 6200.937990620036, 6225.62646241227, 6228.688565571612, 5595.580331475075, 5831.883362332815, 6148.692565371624, 6153.0, 6243.96878015607, 6140.631562106288, 6143.0206349921145, 6175.228096487939, 6199.0, 6215.316315205414, 6020.819375418744, 6031.215941927697, 6160.507159427325, 6169.951108311508, 6177.598456100339, 5749.8562535936935, 5762.1068734346245, 5921.6743079131065, 5964.463198312173, 6014.548908831767, 5347.9304139171545, 6080.787172448943, 6112.290716697506, 6128.442013631005, 6186.505079593711, 6009.7896573621465, 6022.849428764316, 6033.5173186145885, 6034.09488576717, 6041.969790151021], "value": 5663.916519674495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.24213316825006, 507.2923272035513, 515.2863284351178, 518.9931532826316, 528.2841749429523, 36497.0, 39224.82325530231, 39237.01907452308, 39270.21459570807, 39359.0, 39904.800475997654, 40205.396919046165, 40488.78533643988, 40573.362731422436, 41078.0, 9480.81038379232, 9740.805183896318, 9755.365901216433, 9763.43784994401, 9777.364471309378, 9637.373570717917, 9699.36954097985, 9700.466474343908, 9715.07706767856, 9775.120239178472, 9681.515924203797, 9711.174550163245, 9739.513024348755, 9744.02559744027, 9746.610135594568, 9655.855162172573, 9665.323427360088, 9672.80654386912, 9703.90296097037, 9709.271804614611, 9618.615255389775, 9695.563699633534, 9703.757406064835, 9707.61169553217, 9738.561764720605, 37679.81160094209, 37848.62151378506, 38023.809880950415, 38121.42817857734, 38352.0, 3259.1852036990754, 3381.8816341427932, 3829.5021647185968, 4016.879493615196, 4141.767054261635, 29546.70453295461, 30309.545356819664, 30714.53928191079, 30763.69236307653, 30827.38345233105, 3161.146490447566, 3314.436545787222, 3320.734341252694, 3358.664133586646, 3358.714509266715, 353569.0, 354501.0, 357713.0, 359970.0, 360174.1991290053, 57222.713886431135, 57684.0, 57685.711571441876, 57698.13452798211, 57763.422365775805, 48148.5185148144, 51203.743981279855, 54418.45581544134, 54496.3678087367, 58859.0, 15259.237038148049, 15373.0, 15670.962774839198, 15711.528654140395, 15728.842711572966, 12313.44589493475, 12319.260844349188, 12436.129470936947, 12437.253764774143, 12443.813342799684, 14782.92608536972, 15218.16300103505, 15337.309821057856, 15422.768658470131, 15518.767218491732, 5596.397675081107, 6171.84570385735, 7033.507654464139, 7110.0, 7125.786226413215, 812.3541784281392, 874.7550685807984, 1028.3624153025173, 1048.6067724603274, 1093.517714787444, 23820.52358952811, 29309.12072637824, 29467.0, 29873.551896721565, 30049.098527044225, 926.2124100486127, 928.215657769184, 1094.370736826328, 1127.7011591928147, 1127.887211278882, 13600.795988060187, 13913.513027044004, 14192.64518387028, 15441.0735355879, 15696.450624228326, 644257.0, 658385.0, 659687.0, 661115.0, 666638.0, 54855.0, 55099.449005510236, 55243.72378138084, 55255.89488210213, 55278.72360638171, 1352.4387379237505, 1357.429879450633, 1406.9085509441854, 1418.2766788937715, 1420.6022313752167, 25813.838377273445, 27604.44791104207, 28296.009639662512, 29905.252368690086, 29976.100716978526, 47210.0, 47543.04913901634, 47591.286130707376, 47729.0, 47739.76130119327, 595527.0, 598228.0, 601626.0, 603194.0, 605387.0, 37819.432708508844, 39090.60909390869, 39266.01834954149, 39298.6070139295, 39396.2120757589, 44655.330170048124, 44673.21307147678, 45342.77328613336, 46021.53978460172, 46526.069478610916, 33698.83150584231, 38012.80993595014, 38593.421098684106, 38865.41701874418, 39387.80306098451, 36818.447723283636, 37137.0, 37238.77565176024, 38312.233755325295, 38449.0, 37362.62637373591, 40308.79073627796, 41181.97045073897, 41321.380179296735, 41418.37872431976, 37594.43608345932, 38069.80965095157, 40090.39864401978, 40475.0, 41633.58366416297, 30333.090007299816, 31616.841915790275, 31776.682233178297, 32003.0, 32206.838965805022], "value": 19776.475792359495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.5655578472156, 368.7750472211949, 371.22414154417265, 381.8887038717333, 393.2528196426789, 19203.039848007615, 19967.10148043338, 20498.692519612217, 20792.48018799531, 21003.36989890302, 11966.521339146446, 11967.64097077089, 18017.90991045043, 19674.508137296576, 20407.59184816303, 5315.255864179018, 5522.171674248874, 5528.087865502187, 5535.501804837564, 5547.084731019397, 5471.945280547184, 5980.252468441445, 6035.818925432244, 6048.727807248684, 6055.909161362583, 5527.309086364205, 5957.761689532414, 6006.669633170174, 6008.639481631094, 6016.639001659914, 4386.670999675021, 4931.778069986841, 5158.767855446514, 5642.576806739511, 5658.066419040853, 4590.632749380042, 4609.469910960249, 5248.134057880445, 5335.7865685372535, 5488.835334939959, 12706.174098683648, 13355.065145439823, 13355.666108347272, 13407.262600556965, 15033.774493382609, 1948.581055073152, 2154.450615093157, 2176.9346919592435, 2306.850054746436, 2308.68832707584, 9110.817783644356, 9929.255305852017, 10321.948390258076, 12915.87084129156, 15185.696286074328, 1614.4268784581423, 1893.0345523782833, 1915.5689969756831, 1938.8948299469166, 2050.0672194151775, 106250.46874765655, 107130.0, 109161.0, 119440.0, 130163.69836301706, 10886.836697449544, 11290.604828830952, 11459.942700286612, 11484.770304593862, 11575.247608905394, 13925.721485570231, 13927.0, 13943.790843137362, 13944.790828137586, 14021.29893505341, 8147.429679922467, 8390.496570205685, 8460.619272132768, 8577.699780507777, 8583.39916205872, 8404.0, 8404.495730256203, 8423.70517031901, 8578.957105214435, 8590.957045214735, 4464.9107017860115, 4535.591796738309, 4585.0, 4613.976930115328, 4630.814767409266, 1820.7359932809668, 1941.951451213731, 1961.499817546545, 2000.4298774849099, 2007.879527228371, 819.4632515702225, 835.7952301686004, 852.5055467828645, 925.2135684667978, 975.1954637424153, 20721.58556828885, 21228.150873964867, 21500.677489837664, 21501.89249053776, 21563.568728625338, 934.3039435620507, 942.4047259704206, 977.5649835822991, 980.2060331131806, 1005.7837564923576, 10509.789804203872, 11047.502862371213, 11118.499667514981, 11120.277181983145, 11189.608363707232, 566505.0, 570169.0, 570968.0, 579091.0, 580332.0, 106935.93064069415, 127680.0, 139184.0, 139523.0, 143682.0, 921.8202450522084, 936.6253498600614, 953.9761505962407, 962.4465932089076, 966.2221911361421, 16421.261043253322, 18676.719849202545, 18757.624847502702, 18784.6243075135, 18914.337998169998, 55177.0, 56260.0, 56478.71760641171, 57631.71184144053, 58694.532636684424, 80769.0, 81788.0, 81917.59041204756, 82414.0, 82501.0, 7892.939915767301, 7990.963433895083, 8081.636326365446, 8181.140980197231, 8188.713395031145, 9036.27709783229, 11822.881771182178, 12567.37163141821, 13037.739245214852, 13153.934230328787, 9285.582148803454, 9572.664956726481, 10419.94790026045, 11082.390468524309, 11218.551257949917, 8596.70798294197, 8798.900137482815, 11010.614628487965, 11013.394263315595, 11076.446177691245, 11019.889801101886, 11236.0, 11397.08823294118, 11454.885451145381, 11572.189946703988, 6855.971604259401, 7833.334166595903, 7988.640511177127, 8181.386396020442, 8230.012398512217, 9208.861867071866, 9218.9539052307, 9343.953280233827, 10547.103496202908, 10893.0], "value": 9197.08576290886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.745941919583, 1577.9822014800452, 1800.216905646044, 1891.7919028906808, 1892.8201820827016, 7953.244441778036, 8232.053313868906, 8460.28087612553, 9005.054469280722, 9006.639734410624, 8409.70566030189, 8711.477311361323, 8720.215180633742, 8832.823343533126, 8838.91161088389, 2374.2283757778705, 2420.165043060141, 2424.563578555868, 2425.3507614821915, 2438.9634155487684, 2400.567897778399, 2416.540857237128, 2440.6827112475353, 2443.0716327795412, 2447.204658485999, 2410.674558934548, 2417.2989832948424, 2421.769931856471, 2429.259075981825, 2433.6714543536664, 2043.8978051097386, 2046.2531176120758, 2212.070930209316, 2218.1127548980376, 2226.265332440299, 2370.3600027992347, 2375.358653163636, 2392.294273189396, 2392.712874455059, 2396.988015059931, 8781.868271975925, 8900.955495222548, 8919.910800891972, 8920.0, 8977.012528621912, 5239.397469291042, 5360.0, 5396.730163491809, 5399.244105825188, 5401.108817045183, 3568.2685049564775, 3599.9100022499383, 3614.3855544557487, 3675.117971686776, 3675.117971686803, 1093.5079214353573, 1094.2231015978664, 1096.1395304685864, 1104.8895110488968, 1114.9888501114965, 11621.593244236496, 11701.473433695419, 11754.23597466162, 11795.528178872835, 11806.527738890434, 4549.54504549549, 4749.287606858929, 4828.8792780180775, 4847.079054979543, 4875.829345972874, 7913.841723165505, 9728.562214700356, 9852.0, 9966.302358834957, 9967.40195588267, 4493.96638773084, 5347.545458635982, 5348.197770334481, 5368.3826359968325, 5379.54273886724, 3985.8405663773706, 4387.4954380246045, 4544.091181763661, 4633.976830115896, 4902.191138462185, 3894.1043559981363, 3909.9413508797393, 3970.4639873616693, 4024.879253622396, 4052.675785937118, 1288.1884412819863, 1306.8235788168477, 1308.2019967819622, 1308.3458270864567, 1327.807467917166, 812.2689579378607, 917.1974522292994, 924.7179610218814, 928.9628414863465, 946.8248374050822, 4940.777665005084, 5471.5896307777075, 6017.916774980458, 6020.963195299187, 6069.605475644069, 432.8160531773984, 440.425245055206, 445.888527868033, 447.3446401022518, 452.47964840433764, 3958.346872766019, 4132.938005929914, 4153.899216707575, 4296.334068219431, 4311.461067366579, 10519.26365154432, 10562.366258024544, 10653.414062226651, 10770.138388929023, 10869.83695244572, 10505.054545090825, 10678.786424271471, 10727.517261723242, 10750.301230420155, 10777.622783202707, 8045.839083218303, 8159.061707903667, 8191.918080819116, 8211.21993410625, 8229.835403291901, 5247.606429517878, 5549.9177660355845, 6003.8198854034445, 6033.909491357721, 6097.4817140543555, 9750.658726944523, 9808.509574521388, 9811.215102791617, 9915.504224788587, 10028.899711002796, 9780.510974451106, 9968.102870741668, 10146.746331341776, 10191.439470829175, 10363.119134873621, 6907.827304317432, 7333.266673332624, 7488.700451981859, 7496.625168741432, 7634.8091297718, 8396.748097557083, 8463.28062114727, 8481.533515656698, 8487.023992240971, 8494.83010339802, 7218.242084581043, 7370.926290737239, 7489.737859174903, 7555.886661700189, 7579.696812127674, 7177.964110179416, 7304.853902922018, 7409.777706668809, 7460.104787425544, 7465.589392583242, 6979.6859141337745, 6988.965055174692, 7051.43588512928, 7056.788296351117, 7065.964670176616, 4710.340552322746, 4779.498152693917, 4940.802367905244, 5009.499050094962, 5109.821156259513, 5025.422076461107, 5032.345795046621, 5078.238264260391, 5114.693118412907, 5264.394594621667], "value": 4510.922751672174, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.61147171017154, 277.93550700815877, 294.25259840006373, 308.277090223426, 312.14783640660994, 4938.222259971125, 5202.401723801764, 5252.8161514347, 5315.202719592063, 5404.189371594258, 4522.68341216115, 4909.729964851932, 5125.256837758523, 5252.842414727555, 5270.972160428709, 4035.1929614077303, 4078.9184216315657, 4137.007118291604, 4142.378643203529, 4145.905518887246, 3368.59576850777, 3735.9726075329368, 4025.8864096349503, 4153.501579810412, 4162.271602469571, 3588.551431071116, 3589.2642008388216, 4077.4903137107863, 4084.8978775530554, 4089.5297040840237, 3219.7442997231096, 3783.754055986366, 4098.815553300109, 4100.856470023535, 4112.321466957963, 3006.729394354497, 3344.4314466540745, 3615.3130905128205, 3624.4382120771324, 3634.3821550336506, 4897.118518666639, 5147.922781158286, 5183.326167598226, 5209.817656382046, 5241.737913104368, 3936.960630393688, 4543.750093744843, 4687.437507499088, 4721.457032441279, 4769.35613692154, 5592.804251851207, 5600.103983362683, 5631.9718401408145, 5634.464725851038, 5654.529822246245, 3713.9071523211865, 3911.8044097794996, 3930.508686414198, 3942.250972315251, 3945.2504024235304, 5388.380336261302, 5609.102543593006, 5871.354151043424, 5875.412458754133, 5892.322382925976, 3514.68367846895, 3729.384651532521, 3751.362268414376, 4033.4756481657782, 4044.15072834708, 3440.0539851541025, 3719.1074142205675, 3954.9802250989137, 4068.2880495913096, 4091.85678501251, 4320.978395108004, 4590.0, 4594.19601569724, 4608.0, 4628.884277893079, 4854.000379609009, 5192.584593232608, 5659.264295641623, 5697.515711164598, 5729.398413166641, 1174.788538063157, 1237.1216436330126, 1266.9746605067846, 1314.572763851752, 1352.6618345413647, 839.3327304792705, 935.9844568642962, 948.2082461145021, 963.9277054220961, 967.4485543240426, 3911.5697273300484, 3966.7024973126554, 4090.6318431341324, 4366.886443956771, 4451.554844515523, 4309.633681137076, 4811.171754733249, 4846.588040016568, 4864.732439715779, 4900.803967841318, 4012.555480027188, 4014.795561331589, 4372.3878656988045, 4393.384926110347, 4398.978005109954, 2174.717286752712, 2657.7740892024394, 3012.9755882999884, 3075.5540446635114, 3090.5982222311404, 5585.3297604287745, 5725.541956643458, 5882.764689412461, 6142.232220972379, 6162.691865406712, 4979.726115063634, 5456.672599644034, 5730.197772311796, 6080.513558915276, 6098.756049758049, 5732.541396688255, 5978.641281523122, 6188.876222475616, 6192.566520343623, 6199.5040396767245, 4653.790579424001, 5852.0, 5891.3224979126235, 5967.045272756512, 5971.462568368867, 5501.3948465667945, 5827.329857066322, 5858.619189752652, 5872.5301975842685, 5875.588708790344, 5047.772850221675, 6089.451949324582, 6150.661713605616, 6155.84610384744, 6164.4143806338325, 3323.667633236657, 3505.789652620851, 3529.2412131391875, 3704.388775851954, 3940.468036815108, 4821.783019764189, 5111.923321150111, 5303.124984377535, 5576.013150597342, 5896.882062358814, 4403.867883963486, 4853.781579828987, 5689.971550142222, 5697.259356283656, 5737.196792449144, 5123.154679477993, 5313.628046036741, 5468.808591699271, 5733.9392212440835, 5781.595288329945, 4950.0, 5336.866578335417, 5361.410244873139, 5399.487048730364, 5528.695921724344, 4573.81704731807, 5599.412061733459, 5810.186573879576, 5812.302523697014, 5812.854678633068, 4869.634777391639, 4956.355673762532, 5299.947000529945, 5604.99110160175, 5673.432656734293], "value": 4032.7877436330696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.9504434689574, 767.715945100313, 790.7785819970409, 813.9267465928066, 824.2869917521344, 15851.0, 16390.672186556276, 16508.092054936973, 16515.0, 16577.502674919757, 14737.778933316009, 14744.33650485728, 14954.62613434662, 14971.47599834006, 15029.398824047052, 668.3850857211353, 696.140266770538, 833.4499230507836, 843.6372359885247, 863.8099618084011, 856.8414843253987, 870.5168631409565, 874.7550685807952, 875.0767939823484, 877.7579724689557, 880.5421180985884, 898.6989358564889, 926.1340646495514, 930.6091441594547, 932.4964519159646, 915.5010519267015, 924.9768755781092, 926.0230456868002, 926.1988380051274, 926.9073092690744, 657.4083325007483, 678.7929681447157, 680.3264767879813, 681.9829504262384, 684.6782012454139, 15075.698486030218, 15277.847221527754, 15351.385944562204, 15362.00146990442, 15375.384984600714, 14729.410823567045, 14778.704425911421, 14819.77770333446, 14833.925830370887, 14881.255937203205, 11684.649460516199, 11816.281442880181, 11908.821367679491, 11937.34344611046, 12171.93914030433, 3339.248669049469, 3816.599257078022, 3987.8404863805413, 4034.415009823559, 4044.170944956277, 117397.41301293524, 119063.61872762497, 120290.0, 120877.79122208753, 121040.39479802633, 11248.212625116326, 11333.603323883624, 11422.371769552588, 11617.419129043514, 11825.866145471457, 23870.641940370908, 23972.28083157508, 24055.037798488214, 24265.0, 24381.878090609433, 8062.596870156469, 8092.271695547429, 8172.305354044973, 8270.338372930151, 8316.625751841182, 4396.729032322199, 4434.078173227715, 4467.687261891637, 4520.728756274634, 4583.679142459996, 3265.314284000339, 3424.6917777400154, 3663.120850995795, 3791.867284645024, 3794.4498047782918, 566.8323254096574, 638.1831255992337, 692.7367600311849, 693.19935474527, 724.0948813982521, 592.3809618948123, 604.9516038716893, 627.7520379450092, 670.8825955457776, 690.8825499665069, 8247.876281855777, 8374.874376884352, 8969.103089690978, 9844.114029737359, 10026.864807102718, 526.8314139475331, 610.7618028968706, 621.6953692690639, 656.5437021270171, 657.7401926239108, 4523.909521809611, 4782.784774685148, 4813.15769740294, 4813.890829258599, 4854.17479028566, 153647.0, 156870.0, 161815.0, 163411.0, 163488.0, 107814.0, 130075.34962325128, 132531.0, 132963.0, 133823.0, 95497.0, 112228.87771122511, 113443.0, 115581.0, 116168.41915790367, 7641.579713115832, 7699.345555627834, 8918.554072296489, 9102.361574916578, 9251.861222081809, 48693.0, 54918.450815491335, 56122.71938640444, 56200.0, 57024.42975570191, 82855.0, 94844.0, 96918.06163876824, 100263.47760440444, 102230.0, 11859.703507412383, 12030.09774266916, 12068.215565988534, 12149.0, 12224.572139975058, 12920.612381628565, 13251.11558622618, 13312.600621981355, 13320.0, 13950.511732089733, 12245.816312755494, 12324.014078873848, 12363.93818030904, 12690.682732931751, 12788.680282993, 12213.328266945047, 12368.0, 12395.814062789246, 12749.93625031869, 12805.295708736108, 12234.37802619073, 12263.632091037283, 12451.75096498083, 12520.686982825502, 12652.0, 9330.915756754786, 10055.0, 10343.224258180817, 10533.4733263335, 10564.577416903237, 10291.279610427198, 10606.257561970588, 10622.84065738999, 10706.0, 10716.946415267874], "value": 7795.261060307821, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 117.0, 118.0, 113.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 113.0, 114.0, 186.0, 112.0, 110.0, 110.0, 108.0, 136.0, 115.0], "value": 125.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [239.0, 269.0, 283.0, 275.0, 267.0, 196.0, 196.0, 201.0, 195.0, 200.0], "value": 232.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 83.0, 78.0, 83.0, 85.0, 60.0, 78.0, 58.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 69.0, 76.0, 72.0, 87.0, 103.0, 76.0, 94.0, 60.0, 88.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 131.0, 135.0, 88.0, 90.0, 87.0, 91.0, 88.0, 91.0, 110.0], "value": 100.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 100.0, 99.0, 99.0, 130.0, 175.0, 175.0, 99.0, 100.0], "value": 117.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 90.0, 149.0, 129.0, 90.0, 90.0, 93.0, 110.0, 123.0], "value": 105.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 57.0, 57.0, 58.0, 60.0, 58.0, 57.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 79.0, 81.0, 74.0, 71.0, 71.0, 72.0, 72.0, 72.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 99.0, 82.0, 77.0, 100.0, 108.0, 109.0, 110.0, 113.0, 82.0], "value": 96.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 150.0, 138.0, 140.0, 137.0, 140.0, 179.0, 172.0, 164.0], "value": 152.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 174.0, 169.0, 241.0, 173.0, 169.0, 173.0, 172.0, 172.0, 230.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 68.0, 73.0, 70.0, 68.0, 71.0, 68.0, 67.0], "value": 69.0, "unit": "score"}]}]} 09:06:19 INFO - Return code: 0 09:06:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:06:19 ERROR - # TBPL SUCCESS # 09:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:19 INFO - 2016-09-23 09:06:19.430 screenresolution[1668:10812] starting screenresolution argv=screenresolution get 09:06:19 INFO - 2016-09-23 09:06:19.433 screenresolution[1668:10812] Display 0: 1600x1200x32@60 09:06:19 INFO - 2016-09-23 09:06:19.439 screenresolution[1669:10816] starting screenresolution argv=screenresolution list 09:06:19 INFO - Available Modes on Display 0 09:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:19 INFO - Intel Iris: 09:06:19 INFO - Chipset Model: Intel Iris 09:06:19 INFO - Type: GPU 09:06:19 INFO - Bus: Built-In 09:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:19 INFO - Vendor: Intel (0x8086) 09:06:19 INFO - Device ID: 0x0a2e 09:06:19 INFO - Revision ID: 0x0009 09:06:19 INFO - Displays: 09:06:19 INFO - Display: 09:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:19 INFO - Display Serial Number: 1600x1200 60 09:06:19 INFO - Main Display: Yes 09:06:19 INFO - Mirror: Off 09:06:19 INFO - Online: Yes 09:06:19 INFO - Rotation: Supported 09:06:19 INFO - Return code: 0 09:06:19 INFO - Running post-action listener: _resource_record_post_action 09:06:19 INFO - [mozharness: 2016-09-23 16:06:19.673512Z] Finished run-tests step (success) 09:06:19 INFO - Running post-run listener: _resource_record_post_run 09:06:19 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 33563136; Write bytes: 708101632; Read time: 316; Write time: 2034 09:06:19 INFO - TinderboxPrint: CPU usage
54.6% 09:06:19 INFO - TinderboxPrint: I/O read bytes / time
33,563,136 / 316 09:06:19 INFO - TinderboxPrint: I/O write bytes / time
708,101,632 / 2,034 09:06:19 INFO - TinderboxPrint: CPU idle
2,196.9 (45.4%) 09:06:19 INFO - TinderboxPrint: CPU system
980.8 (20.3%) 09:06:19 INFO - TinderboxPrint: CPU user
1,660.0 (34.3%) 09:06:19 INFO - TinderboxPrint: Swap in / out
436,129,792 / 0 09:06:19 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395053568; Write bytes: 390684160; Read time: 29364; Write time: 734 09:06:19 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31789568; Write bytes: 296437760; Read time: 298; Write time: 1256 09:06:20 INFO - Running post-run listener: _upload_blobber_files 09:06:20 INFO - Blob upload gear active. 09:06:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:06:20 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 09:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:06:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:06:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:06:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:06:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:21 INFO - (blobuploader) - INFO - Done attempting. 09:06:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:06:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:06:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:22 INFO - (blobuploader) - INFO - Done attempting. 09:06:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:06:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:06:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:06:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:06:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:06:24 INFO - (blobuploader) - INFO - Done attempting. 09:06:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:06:24 INFO - Return code: 0 09:06:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:06:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:06:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02860efd0d27323e9ad82c1287d5a820417fbb6527e11ee86df3d3936337413a01b9b5e74ecc650b98c5f0e00de14fdabb81ec1d24cda1436d535d270f938ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62f086e54d1936d863ed43e49bc25b7cb3ddfc87ac18ae823a4c40c4908c8ca7cdfc1001be4f58514ffa9d3b6486f822cc6e427d6f0b72a62c798cbc91ad144c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8772d106a6f781d9fe8b4fed9d0a55915e1923adafb05c725af9f2d1785c16124ee1e7bf11ba74dd8dac9482a7609d89110803ac3bdcd6c7a00dad81ffa336cf"} 09:06:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:06:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:06:24 INFO - Contents: 09:06:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02860efd0d27323e9ad82c1287d5a820417fbb6527e11ee86df3d3936337413a01b9b5e74ecc650b98c5f0e00de14fdabb81ec1d24cda1436d535d270f938ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62f086e54d1936d863ed43e49bc25b7cb3ddfc87ac18ae823a4c40c4908c8ca7cdfc1001be4f58514ffa9d3b6486f822cc6e427d6f0b72a62c798cbc91ad144c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8772d106a6f781d9fe8b4fed9d0a55915e1923adafb05c725af9f2d1785c16124ee1e7bf11ba74dd8dac9482a7609d89110803ac3bdcd6c7a00dad81ffa336cf"} 09:06:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:06:24 INFO - Copying logs to upload dir... 09:06:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:06:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.935651 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-23 09:06:24.828727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:06:24.832016) ========= 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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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/Autoland/sha512/02860efd0d27323e9ad82c1287d5a820417fbb6527e11ee86df3d3936337413a01b9b5e74ecc650b98c5f0e00de14fdabb81ec1d24cda1436d535d270f938ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62f086e54d1936d863ed43e49bc25b7cb3ddfc87ac18ae823a4c40c4908c8ca7cdfc1001be4f58514ffa9d3b6486f822cc6e427d6f0b72a62c798cbc91ad144c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8772d106a6f781d9fe8b4fed9d0a55915e1923adafb05c725af9f2d1785c16124ee1e7bf11ba74dd8dac9482a7609d89110803ac3bdcd6c7a00dad81ffa336cf"} build_url:https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010967 build_url: 'https://queue.taskcluster.net/v1/task/O0qTAEdFQDCpgJqGmIJgow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/02860efd0d27323e9ad82c1287d5a820417fbb6527e11ee86df3d3936337413a01b9b5e74ecc650b98c5f0e00de14fdabb81ec1d24cda1436d535d270f938ac3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/62f086e54d1936d863ed43e49bc25b7cb3ddfc87ac18ae823a4c40c4908c8ca7cdfc1001be4f58514ffa9d3b6486f822cc6e427d6f0b72a62c798cbc91ad144c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8772d106a6f781d9fe8b4fed9d0a55915e1923adafb05c725af9f2d1785c16124ee1e7bf11ba74dd8dac9482a7609d89110803ac3bdcd6c7a00dad81ffa336cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:06:24.865302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:06:24.865657) ========= 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.Qw0N3uo9Eb/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.YJYtykyOW6/Listeners TMPDIR=/var/folders/m7/_sns9kks7zdb5z2vgrvgs0wh00000w/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.004781 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:06:24.914711) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:06:24.915088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:06:24.915443) ========= ========= Total master_lag: 0.17 =========