builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0050 starttime: 1489164950.09 results: success (0) buildid: 20170310074622 builduid: 8b41791e04f946589fdefed9890e2068 revision: f6e923a823271e69eaf8c316dc765fe0a63c15c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.089183) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.089608) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.089896) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.114498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.114847) ========= 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.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 --2017-03-10 08:55:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 64.2M=0s 2017-03-10 08:55:50 (64.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.263795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.264104) ========= 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.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.021121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:50.312354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:55:50.312681) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6e923a823271e69eaf8c316dc765fe0a63c15c0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f6e923a823271e69eaf8c316dc765fe0a63c15c0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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 2017-03-10 08:55:50,403 truncating revision to first 12 chars 2017-03-10 08:55:50,404 Setting DEBUG logging. 2017-03-10 08:55:50,404 attempt 1/10 2017-03-10 08:55:50,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6e923a82327?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 08:55:51,607 unpacking tar archive at: mozilla-central-f6e923a82327/testing/mozharness/ program finished with exit code 0 elapsedTime=1.458329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:55:51.794216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:51.794550) ========= script_repo_revision: f6e923a823271e69eaf8c316dc765fe0a63c15c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:51.794934) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:51.795195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:55:51.814704) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-10 08:55:51.814983) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:55:52 INFO - MultiFileLogger online at 20170310 08:55:52 in /builds/slave/test 08:55:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:55:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:52 INFO - {'append_to_log': False, 08:55:52 INFO - 'base_work_dir': '/builds/slave/test', 08:55:52 INFO - 'blob_upload_branch': 'Firefox', 08:55:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:52 INFO - 'branch': 'Firefox', 08:55:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:52 INFO - 'config_files': ('talos/mac_config.py',), 08:55:52 INFO - 'default_actions': ('clobber', 08:55:52 INFO - 'read-buildbot-config', 08:55:52 INFO - 'download-and-extract', 08:55:52 INFO - 'populate-webroot', 08:55:52 INFO - 'create-virtualenv', 08:55:52 INFO - 'install', 08:55:52 INFO - 'run-tests'), 08:55:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:52 INFO - 'download_minidump_stackwalk': True, 08:55:52 INFO - 'download_symbols': 'ondemand', 08:55:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:52 INFO - 'gecko_profile': False, 08:55:52 INFO - 'gecko_profile_interval': 0, 08:55:52 INFO - 'installer_path': 'installer.exe', 08:55:52 INFO - 'log_level': 'info', 08:55:52 INFO - 'log_name': 'talos', 08:55:52 INFO - 'log_to_console': True, 08:55:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:52 INFO - 'opt_config_files': (), 08:55:52 INFO - 'pip_index': False, 08:55:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:52 INFO - 'cmd': ('bash', 08:55:52 INFO - '-c', 08:55:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:52 INFO - 'enabled': True, 08:55:52 INFO - 'halt_on_failure': False, 08:55:52 INFO - 'name': 'check_screen_resolution'},), 08:55:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:52 INFO - 'cmd': ('bash', 08:55:52 INFO - '-c', 08:55:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:52 INFO - 'enabled': True, 08:55:52 INFO - 'halt_on_failure': False, 08:55:52 INFO - 'name': 'check_screen_resolution'},), 08:55:52 INFO - 'run_cmd_checks_enabled': True, 08:55:52 INFO - 'suite': 'dromaeojs-e10s', 08:55:52 INFO - 'system_bits': '32', 08:55:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:52 INFO - 'title': 't-yosemite-r7-0050', 08:55:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:52 INFO - 'use_talos_json': True, 08:55:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:52 INFO - 'work_dir': 'build'} 08:55:52 INFO - [mozharness: 2017-03-10 16:55:52.025771Z] Running clobber step. 08:55:52 INFO - Running pre-action listener: _resource_record_pre_action 08:55:52 INFO - Running main action method: clobber 08:55:52 INFO - rmtree: /builds/slave/test/build 08:55:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:54 INFO - Running post-action listener: _resource_record_post_action 08:55:54 INFO - [mozharness: 2017-03-10 16:55:54.095832Z] Finished clobber step (success) 08:55:54 INFO - [mozharness: 2017-03-10 16:55:54.096091Z] Running read-buildbot-config step. 08:55:54 INFO - Running pre-action listener: _resource_record_pre_action 08:55:54 INFO - Running main action method: read_buildbot_config 08:55:54 INFO - Using buildbot properties: 08:55:54 INFO - { 08:55:54 INFO - "project": "", 08:55:54 INFO - "product": "firefox", 08:55:54 INFO - "script_repo_revision": "production", 08:55:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:55:54 INFO - "repository": "", 08:55:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:55:54 INFO - "buildid": "20170310074622", 08:55:54 INFO - "pgo_build": "False", 08:55:54 INFO - "basedir": "/builds/slave/test", 08:55:54 INFO - "buildnumber": 96, 08:55:54 INFO - "slavename": "t-yosemite-r7-0050", 08:55:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:55:54 INFO - "platform": "yosemite_r7", 08:55:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:55:54 INFO - "branch": "mozilla-central", 08:55:54 INFO - "repo_path": "mozilla-central", 08:55:54 INFO - "revision": "f6e923a823271e69eaf8c316dc765fe0a63c15c0", 08:55:54 INFO - "stage_platform": "macosx64", 08:55:54 INFO - "builduid": "8b41791e04f946589fdefed9890e2068", 08:55:54 INFO - "slavebuilddir": "test" 08:55:54 INFO - } 08:55:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:55:54 INFO - Running post-action listener: _resource_record_post_action 08:55:54 INFO - [mozharness: 2017-03-10 16:55:54.100858Z] Finished read-buildbot-config step (success) 08:55:54 INFO - [mozharness: 2017-03-10 16:55:54.101058Z] Running download-and-extract step. 08:55:54 INFO - Running pre-action listener: _resource_record_pre_action 08:55:54 INFO - Running main action method: download_and_extract 08:55:54 INFO - mkdir: /builds/slave/test/build/tests 08:55:54 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:55:54 INFO - trying https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:54 INFO - Downloading https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:55:55 INFO - Downloaded 1199 bytes. 08:55:55 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:55:55 INFO - Using the following test package requirements: 08:55:55 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:55 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:55:55 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:55:55 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'jsshell-mac.zip'], 08:55:55 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:55:55 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:55:55 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:55:55 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:55:55 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:55:55 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:55:55 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:55:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:55:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:55:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:55:55 INFO - Fetch https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:55:56 INFO - Expected file size: 51786266 08:55:56 INFO - Obtained file size: 51786266 08:56:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:56:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:12 INFO - Fetch https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:56:15 INFO - Expected file size: 51786266 08:56:15 INFO - Obtained file size: 51786266 08:56:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:56:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:56:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:56:31 INFO - Expected file size: 14404424 08:56:31 INFO - Obtained file size: 14404424 08:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:32 INFO - trying https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:56:34 INFO - Downloaded 74939444 bytes. 08:56:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:34 INFO - mkdir: /builds/slave/test/properties 08:56:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:34 INFO - Contents: 08:56:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - Running post-action listener: set_extra_try_arguments 08:56:34 INFO - [mozharness: 2017-03-10 16:56:34.943924Z] Finished download-and-extract step (success) 08:56:34 INFO - [mozharness: 2017-03-10 16:56:34.944068Z] Running populate-webroot step. 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: populate_webroot 08:56:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:34 INFO - '--tppagecycles', 08:56:34 INFO - '7'], 08:56:34 INFO - 'tests': ['tsvgm']}}, 08:56:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['damp', 'tps']}, 08:56:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'tests': ['damp', 'tps']}, 08:56:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['dromaeo_dom']}, 08:56:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['basic_compositor_video']}, 08:56:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['a11yr', 08:56:34 INFO - 'ts_paint', 08:56:34 INFO - 'tpaint', 08:56:34 INFO - 'sessionrestore', 08:56:34 INFO - 'sessionrestore_no_auto_restore', 08:56:34 INFO - 'tabpaint']}, 08:56:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tsvgx', 08:56:34 INFO - 'tsvgr_opacity', 08:56:34 INFO - 'tart', 08:56:34 INFO - 'tscrollx', 08:56:34 INFO - 'cart', 08:56:34 INFO - 'tsvg_static']}, 08:56:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:34 INFO - 'tsvgr_opacity', 08:56:34 INFO - 'tart', 08:56:34 INFO - 'tscrollx', 08:56:34 INFO - 'cart', 08:56:34 INFO - 'tsvg_static']}, 08:56:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s'], 08:56:34 INFO - 'tests': ['tp5o']}, 08:56:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:56:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'talos_options': ['--disable-e10s', 08:56:34 INFO - '--xperf_path', 08:56:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:34 INFO - 'tests': ['tp5n']}, 08:56:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:56:34 INFO - 'talos_options': ['--xperf_path', 08:56:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:34 INFO - 'tests': ['tp5n']}}, 08:56:34 INFO - 'talos.zip': {'path': '', 08:56:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:34 INFO - Running post-action listener: _resource_record_post_action 08:56:34 INFO - [mozharness: 2017-03-10 16:56:34.963000Z] Finished populate-webroot step (success) 08:56:34 INFO - [mozharness: 2017-03-10 16:56:34.963093Z] Running create-virtualenv step. 08:56:34 INFO - Running pre-action listener: _resource_record_pre_action 08:56:34 INFO - Running main action method: create_virtualenv 08:56:34 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:34 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:56:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:35 INFO - Using real prefix '/tools/python27' 08:56:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:35 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:38 INFO - Installing pip.................done. 08:56:38 INFO - Return code: 0 08:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:38 INFO - Reading from file tmpfile_stdout 08:56:38 INFO - Output received: 08:56:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:56:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:38 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:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 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:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:38 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:56:38 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:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:38 INFO - 'HOME': '/Users/cltbld', 08:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PAGER': '/bin/cat', 08:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:38 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - 'XPC_FLAGS': '0x0', 08:56:38 INFO - 'XPC_SERVICE_NAME': '0', 08:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:39 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:56:39 INFO - Cleaning up... 08:56:39 INFO - Return code: 0 08:56:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:39 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:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:39 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:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:39 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:39 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:56:39 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:56:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:39 INFO - 'HOME': '/Users/cltbld', 08:56:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:39 INFO - 'LOGNAME': 'cltbld', 08:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:39 INFO - 'MOZ_NO_REMOTE': '1', 08:56:39 INFO - 'NO_EM_RESTART': '1', 08:56:39 INFO - 'PAGER': '/bin/cat', 08:56:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:39 INFO - 'PWD': '/builds/slave/test', 08:56:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:39 INFO - 'SHELL': '/bin/bash', 08:56:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:39 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:39 INFO - 'USER': 'cltbld', 08:56:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:39 INFO - 'XPC_FLAGS': '0x0', 08:56:39 INFO - 'XPC_SERVICE_NAME': '0', 08:56:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:39 INFO - Downloading/unpacking psutil>=3.1.1 08:56:39 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:56:39 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:56:39 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:56:39 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:56:39 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:56:39 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:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:42 INFO - Installing collected packages: psutil 08:56:42 INFO - Running setup.py install for psutil 08:56:43 INFO - building 'psutil._psutil_osx' extension 08:56:43 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:56:43 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:56:43 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:56:43 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:56:43 INFO - building 'psutil._psutil_posix' extension 08:56:43 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:56:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:43 INFO - ^ 08:56:43 INFO - 1 warning generated. 08:56:43 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:56:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:43 INFO - Successfully installed psutil 08:56:43 INFO - Cleaning up... 08:56:43 INFO - Return code: 0 08:56:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:43 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:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 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:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:43 INFO - 'HOME': '/Users/cltbld', 08:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:43 INFO - 'LOGNAME': 'cltbld', 08:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:43 INFO - 'MOZ_NO_REMOTE': '1', 08:56:43 INFO - 'NO_EM_RESTART': '1', 08:56:43 INFO - 'PAGER': '/bin/cat', 08:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:43 INFO - 'PWD': '/builds/slave/test', 08:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:43 INFO - 'SHELL': '/bin/bash', 08:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:43 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:43 INFO - 'USER': 'cltbld', 08:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:43 INFO - 'XPC_FLAGS': '0x0', 08:56:43 INFO - 'XPC_SERVICE_NAME': '0', 08:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:44 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:56:44 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:56:44 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:56:44 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:56:44 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:56:44 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:56:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:46 INFO - Installing collected packages: mozsystemmonitor 08:56:46 INFO - Running setup.py install for mozsystemmonitor 08:56:47 INFO - Successfully installed mozsystemmonitor 08:56:47 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:48 INFO - 'HOME': '/Users/cltbld', 08:56:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:48 INFO - 'LOGNAME': 'cltbld', 08:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:48 INFO - 'MOZ_NO_REMOTE': '1', 08:56:48 INFO - 'NO_EM_RESTART': '1', 08:56:48 INFO - 'PAGER': '/bin/cat', 08:56:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:48 INFO - 'PWD': '/builds/slave/test', 08:56:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:48 INFO - 'SHELL': '/bin/bash', 08:56:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:48 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:48 INFO - 'USER': 'cltbld', 08:56:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:48 INFO - 'XPC_FLAGS': '0x0', 08:56:48 INFO - 'XPC_SERVICE_NAME': '0', 08:56:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:51 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:56:51 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:56:51 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:56:51 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:56:51 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:56:51 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:56:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:51 INFO - warning: no files found matching '*.txt' 08:56:51 INFO - no previously-included directories found matching 'build' 08:56:51 INFO - no previously-included directories found matching 'dist' 08:56:51 INFO - no previously-included directories found matching '.git*' 08:56:51 INFO - Installing collected packages: jsonschema, functools32 08:56:51 INFO - Running setup.py install for functools32 08:56:51 INFO - warning: no files found matching '*.txt' 08:56:51 INFO - no previously-included directories found matching 'build' 08:56:51 INFO - no previously-included directories found matching 'dist' 08:56:51 INFO - no previously-included directories found matching '.git*' 08:56:51 INFO - Successfully installed jsonschema functools32 08:56:51 INFO - Cleaning up... 08:56:52 INFO - Return code: 0 08:56:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:52 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:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 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:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:52 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:56:52 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:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:52 INFO - 'HOME': '/Users/cltbld', 08:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:52 INFO - 'LOGNAME': 'cltbld', 08:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:52 INFO - 'MOZ_NO_REMOTE': '1', 08:56:52 INFO - 'NO_EM_RESTART': '1', 08:56:52 INFO - 'PAGER': '/bin/cat', 08:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:52 INFO - 'PWD': '/builds/slave/test', 08:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:52 INFO - 'SHELL': '/bin/bash', 08:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:52 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:52 INFO - 'USER': 'cltbld', 08:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:52 INFO - 'XPC_FLAGS': '0x0', 08:56:52 INFO - 'XPC_SERVICE_NAME': '0', 08:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:52 INFO - Cleaning up... 08:56:52 INFO - Return code: 0 08:56:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:52 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:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 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:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:52 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:52 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:56:52 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:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:52 INFO - 'HOME': '/Users/cltbld', 08:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:52 INFO - 'LOGNAME': 'cltbld', 08:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:52 INFO - 'MOZ_NO_REMOTE': '1', 08:56:52 INFO - 'NO_EM_RESTART': '1', 08:56:52 INFO - 'PAGER': '/bin/cat', 08:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:52 INFO - 'PWD': '/builds/slave/test', 08:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:52 INFO - 'SHELL': '/bin/bash', 08:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:52 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:52 INFO - 'USER': 'cltbld', 08:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:52 INFO - 'XPC_FLAGS': '0x0', 08:56:52 INFO - 'XPC_SERVICE_NAME': '0', 08:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:52 INFO - Downloading/unpacking blobuploader==1.2.4 08:56: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:56: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:56: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:56: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:56: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:56: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:56:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:55 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:56:56 INFO - Downloading docopt-0.6.1.tar.gz 08:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:56 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:56 INFO - Running setup.py install for blobuploader 08:56:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:56 INFO - Running setup.py install for requests 08:56:57 INFO - Running setup.py install for docopt 08:56:57 INFO - Successfully installed blobuploader requests docopt 08:56:57 INFO - Cleaning up... 08:56:57 INFO - Return code: 0 08:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:57 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:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:57 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:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:57 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:56:57 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:56:57 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:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:57 INFO - 'HOME': '/Users/cltbld', 08:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:57 INFO - 'LOGNAME': 'cltbld', 08:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:57 INFO - 'MOZ_NO_REMOTE': '1', 08:56:57 INFO - 'NO_EM_RESTART': '1', 08:56:57 INFO - 'PAGER': '/bin/cat', 08:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:57 INFO - 'PWD': '/builds/slave/test', 08:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:57 INFO - 'SHELL': '/bin/bash', 08:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:56:57 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:57 INFO - 'USER': 'cltbld', 08:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:57 INFO - 'XPC_FLAGS': '0x0', 08:56:57 INFO - 'XPC_SERVICE_NAME': '0', 08:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:57 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-ykTF_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:57 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-frNEQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:57 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-AuIyCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:57 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Z4g0Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:57 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-q7Xupw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-twbU2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-16TGNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-HE_tLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-185JJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-CHT0N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-kYwB4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-o4Rsk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-33UWri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:58 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-KGYoO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:59 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-wyE929-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:59 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-ZmqkCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:59 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-9W722Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:59 INFO - Running setup.py install for manifestparser 08:56:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Running setup.py install for mozcrash 08:56:59 INFO - Running setup.py install for mozdebug 08:56:59 INFO - Running setup.py install for mozdevice 08:56:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:59 INFO - Running setup.py install for mozfile 08:57:00 INFO - Running setup.py install for mozhttpd 08:57:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for mozinfo 08:57:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for mozInstall 08:57:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for mozleak 08:57:00 INFO - Running setup.py install for mozlog 08:57:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for moznetwork 08:57:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:00 INFO - Running setup.py install for mozprocess 08:57:01 INFO - Running setup.py install for mozprofile 08:57:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozrunner 08:57:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Running setup.py install for mozscreenshot 08:57:01 INFO - Running setup.py install for moztest 08:57:01 INFO - Running setup.py install for mozversion 08:57:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:01 INFO - Cleaning up... 08:57:01 INFO - Return code: 0 08:57:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:01 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:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:01 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:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:01 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:57:01 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:57:01 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:57:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:57:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:01 INFO - 'HOME': '/Users/cltbld', 08:57:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:01 INFO - 'LOGNAME': 'cltbld', 08:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:01 INFO - 'MOZ_NO_REMOTE': '1', 08:57:01 INFO - 'NO_EM_RESTART': '1', 08:57:01 INFO - 'PAGER': '/bin/cat', 08:57:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:01 INFO - 'PWD': '/builds/slave/test', 08:57:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:01 INFO - 'SHELL': '/bin/bash', 08:57:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:57:01 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:57:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:01 INFO - 'USER': 'cltbld', 08:57:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:01 INFO - 'XPC_FLAGS': '0x0', 08:57:01 INFO - 'XPC_SERVICE_NAME': '0', 08:57:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-G8wrK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:02 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-LgT48k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-CvJRtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:02 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-FFnA0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Ba7_VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:02 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-cIHAnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:02 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-xD_RIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:02 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:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:02 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-viPmt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-vDoYR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-ouL9aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-G62jwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-GtJEDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-6UV89j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-rKyCRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-4_vgKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:03 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-Ro_9iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:03 INFO - Running setup.py (path:/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/pip-hod7X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:04 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:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:04 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:57:04 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:04 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:04 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:57:04 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:57:04 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:57:04 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:57:04 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:57:04 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:57:06 INFO - Downloading blessings-1.6.tar.gz 08:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:06 INFO - Installing collected packages: blessings 08:57:06 INFO - Running setup.py install for blessings 08:57:06 INFO - Successfully installed blessings 08:57:06 INFO - Cleaning up... 08:57:07 INFO - Return code: 0 08:57:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:07 INFO - Reading from file tmpfile_stdout 08:57:07 INFO - Current package versions: 08:57:07 INFO - blessings == 1.6 08:57:07 INFO - blobuploader == 1.2.4 08:57:07 INFO - docopt == 0.6.1 08:57:07 INFO - functools32 == 3.2.3-2 08:57:07 INFO - jsonschema == 2.5.1 08:57:07 INFO - manifestparser == 1.1 08:57:07 INFO - mozInstall == 1.12 08:57:07 INFO - mozcrash == 1.0 08:57:07 INFO - mozdebug == 0.1 08:57:07 INFO - mozdevice == 0.49 08:57:07 INFO - mozfile == 1.2 08:57:07 INFO - mozhttpd == 0.7 08:57:07 INFO - mozinfo == 0.9 08:57:07 INFO - mozleak == 0.1 08:57:07 INFO - mozlog == 3.4 08:57:07 INFO - moznetwork == 0.27 08:57:07 INFO - mozprocess == 0.25 08:57:07 INFO - mozprofile == 0.28 08:57:07 INFO - mozrunner == 6.13 08:57:07 INFO - mozscreenshot == 0.1 08:57:07 INFO - mozsystemmonitor == 0.3 08:57:07 INFO - moztest == 0.8 08:57:07 INFO - mozversion == 1.4 08:57:07 INFO - psutil == 3.1.1 08:57:07 INFO - requests == 1.2.3 08:57:07 INFO - wsgiref == 0.1.2 08:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:57:07 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:57:07 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:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:07 INFO - 'HOME': '/Users/cltbld', 08:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:07 INFO - 'LOGNAME': 'cltbld', 08:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:07 INFO - 'MOZ_NO_REMOTE': '1', 08:57:07 INFO - 'NO_EM_RESTART': '1', 08:57:07 INFO - 'PAGER': '/bin/cat', 08:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:07 INFO - 'PWD': '/builds/slave/test', 08:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:07 INFO - 'SHELL': '/bin/bash', 08:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:57:07 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:07 INFO - 'USER': 'cltbld', 08:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:07 INFO - 'XPC_FLAGS': '0x0', 08:57:07 INFO - 'XPC_SERVICE_NAME': '0', 08:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 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:57:07 INFO - Cleaning up... 08:57:07 INFO - Return code: 0 08:57:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:07 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 0x10f0c1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0c4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb6159a110>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, '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.E904Oh9hf4/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.0QaYEV3SHG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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:57:07 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:57:07 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:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:07 INFO - 'HOME': '/Users/cltbld', 08:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:07 INFO - 'LOGNAME': 'cltbld', 08:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:07 INFO - 'MOZ_NO_REMOTE': '1', 08:57:07 INFO - 'NO_EM_RESTART': '1', 08:57:07 INFO - 'PAGER': '/bin/cat', 08:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:07 INFO - 'PWD': '/builds/slave/test', 08:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:07 INFO - 'SHELL': '/bin/bash', 08:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:57:07 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:07 INFO - 'USER': 'cltbld', 08:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:07 INFO - 'XPC_FLAGS': '0x0', 08:57:07 INFO - 'XPC_SERVICE_NAME': '0', 08:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:57:07 INFO - Cleaning up... 08:57:07 INFO - Return code: 0 08:57:07 INFO - Running post-action listener: _resource_record_post_action 08:57:07 INFO - Running post-action listener: _start_resource_monitoring 08:57:07 INFO - Starting resource monitoring. 08:57:07 INFO - [mozharness: 2017-03-10 16:57:07.878357Z] Finished create-virtualenv step (success) 08:57:07 INFO - [mozharness: 2017-03-10 16:57:07.879369Z] Running install step. 08:57:07 INFO - Running pre-action listener: _resource_record_pre_action 08:57:07 INFO - Running main action method: install 08:57:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:08 INFO - Reading from file tmpfile_stdout 08:57:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:08 INFO - Reading from file tmpfile_stdout 08:57:08 INFO - Output received: 08:57:08 INFO - Usage: mozinstall [options] installer 08:57:08 INFO - Options: 08:57:08 INFO - -h, --help show this help message and exit 08:57:08 INFO - -d DEST, --destination=DEST 08:57:08 INFO - Directory to install application into. [default: 08:57:08 INFO - "/builds/slave/test"] 08:57:08 INFO - --app=APP Application being installed. [default: firefox] 08:57:08 INFO - mkdir: /builds/slave/test/build/application 08:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:28 INFO - Reading from file tmpfile_stdout 08:57:28 INFO - Output received: 08:57:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:57:28 INFO - Running post-action listener: _resource_record_post_action 08:57:28 INFO - [mozharness: 2017-03-10 16:57:28.505860Z] Finished install step (success) 08:57:28 INFO - [mozharness: 2017-03-10 16:57:28.505990Z] Running run-tests step. 08:57:28 INFO - Running pre-action listener: _resource_record_pre_action 08:57:28 INFO - Running main action method: run_tests 08:57:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:28 INFO - 2017-03-10 08:57:28.518 screenresolution[1892:13944] starting screenresolution argv=screenresolution get 08:57:28 INFO - 2017-03-10 08:57:28.521 screenresolution[1892:13944] Display 0: 1600x1200x32@60 08:57:28 INFO - 2017-03-10 08:57:28.526 screenresolution[1893:13947] starting screenresolution argv=screenresolution list 08:57:28 INFO - Available Modes on Display 0 08:57:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:28 INFO - Intel Iris: 08:57:28 INFO - Chipset Model: Intel Iris 08:57:28 INFO - Type: GPU 08:57:28 INFO - Bus: Built-In 08:57:28 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:28 INFO - Vendor: Intel (0x8086) 08:57:28 INFO - Device ID: 0x0a2e 08:57:28 INFO - Revision ID: 0x0009 08:57:28 INFO - Displays: 08:57:28 INFO - Display: 08:57:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:28 INFO - Display Serial Number: 1600x1200 60 08:57:28 INFO - Main Display: Yes 08:57:28 INFO - Mirror: Off 08:57:28 INFO - Online: Yes 08:57:28 INFO - Rotation: Supported 08:57:28 INFO - Return code: 0 08:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:28 INFO - Python 2.7.3 08:57:28 INFO - Return code: 0 08:57:28 INFO - grabbing minidump binary from tooltool 08:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:28 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 0x10ee9fd30>, '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 0x10edc6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee94be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:28 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:57:28 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:57:28 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:57:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:28 INFO - Return code: 0 08:57:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:28 INFO - ENV: RUST_BACKTRACE is now 1 08:57:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --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:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.E904Oh9hf4/Render', 08:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:28 INFO - 'HOME': '/Users/cltbld', 08:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:28 INFO - 'LOGNAME': 'cltbld', 08:57:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:28 INFO - 'MOZ_NO_REMOTE': '1', 08:57:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:28 INFO - 'NO_EM_RESTART': '1', 08:57:28 INFO - 'PAGER': '/bin/cat', 08:57:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:28 INFO - 'PWD': '/builds/slave/test', 08:57:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:28 INFO - 'RUST_BACKTRACE': '1', 08:57:28 INFO - 'SHELL': '/bin/bash', 08:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0QaYEV3SHG/Listeners', 08:57:28 INFO - 'TMPDIR': '/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/', 08:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:28 INFO - 'USER': 'cltbld', 08:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:28 INFO - 'XPC_FLAGS': '0x0', 08:57:28 INFO - 'XPC_SERVICE_NAME': '0', 08:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--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:57:29 INFO - mozversion application_buildid: 20170310074622 08:57:29 INFO - mozversion application_changeset: f6e923a823271e69eaf8c316dc765fe0a63c15c0 08:57:29 INFO - mozversion application_display_name: Nightly 08:57:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:29 INFO - mozversion application_name: Firefox 08:57:29 INFO - mozversion application_remotingname: firefox 08:57:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:57:29 INFO - mozversion application_vendor: Mozilla 08:57:29 INFO - mozversion application_version: 55.0a1 08:57:29 INFO - mozversion platform_buildid: 20170310074622 08:57:29 INFO - mozversion platform_changeset: f6e923a823271e69eaf8c316dc765fe0a63c15c0 08:57:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:57:29 INFO - mozversion platform_version: 55.0a1 08:57:29 INFO - using testdate: 1489165049 08:57:29 INFO - actual date: 1489165049 08:57:29 INFO - starting webserver on 'localhost:49368' 08:57:29 INFO - SUITE-START | Running 2 tests 08:57:29 INFO - TEST-START | dromaeo_css 08:57:29 INFO - operating with platform_type : mac_ 08:57:29 INFO - Initialising browser for dromaeo_css test... 08:57:29 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp1zAyI9/profile http://localhost:49368/getInfo.html) 08:57:32 INFO - PROCESS | 1903 | 2017-03-10 08:57:32.108 plugin-container[1905:14113] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x904f, name = 'com.apple.tsm.portname' 08:57:32 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:57:32 INFO - PROCESS | 1903 | 2017-03-10 08:57:32.111 plugin-container[1905:14113] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b0b, name = 'com.apple.CFPasteboardClient' 08:57:32 INFO - PROCESS | 1903 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:57:32 INFO - PROCESS | 1903 | 2017-03-10 08:57:32.111 plugin-container[1905:14113] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:57:32 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 08:57:32 INFO - PROCESS | 1903 | colorDepth:24 08:57:32 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 08:57:32 INFO - PROCESS | 1903 | __metrics 08:57:32 ERROR - PROCESS | 1903 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:57:32 INFO - TEST-INFO | 1903: exit 0 08:57:32 INFO - Browser initialized. 08:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:32 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp1zAyI9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:35 INFO - PROCESS | 1906 | 2017-03-10 08:57:35.392 plugin-container[1907:14243] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 08:57:35 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:57:35 INFO - PROCESS | 1906 | 2017-03-10 08:57:35.392 plugin-container[1907:14243] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:57:35 INFO - PROCESS | 1906 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:57:35 INFO - PROCESS | 1906 | 2017-03-10 08:57:35.392 plugin-container[1907:14243] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:57:45 INFO - PROCESS | 1906 | RSS: Main: 227291136 08:57:45 INFO - PROCESS | 1906 | 09:00:48 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49368/tests/dromaeo/cssquery-ext.html) 09:00:50 INFO - PROCESS | 1906 | RSS: Main: 250257408 09:00:50 INFO - PROCESS | 1906 | 09:02:33 INFO - PROCESS | 1906 | ************************* 09:02:33 INFO - PROCESS | 1906 | A coding exception was thrown and uncaught in a Task. 09:02:33 INFO - PROCESS | 1906 | 09:02:33 ERROR - PROCESS | 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:02:33 INFO - PROCESS | 1906 | Full stack: 09:02:33 INFO - PROCESS | 1906 | ************************* 09:03:53 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-ext.html (next: http://localhost:49368/tests/dromaeo/cssquery-jquery.html) 09:03:53 INFO - PROCESS | 1906 | RSS: Main: 258973696 09:03:53 INFO - PROCESS | 1906 | 09:06:55 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49368/tests/dromaeo/cssquery-mootools.html) 09:06:56 INFO - PROCESS | 1906 | RSS: Main: 271593472 09:06:56 INFO - PROCESS | 1906 | 09:09:58 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49368/tests/dromaeo/cssquery-prototype.html) 09:09:59 INFO - PROCESS | 1906 | RSS: Main: 264032256 09:09:59 INFO - PROCESS | 1906 | 09:13:02 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49368/tests/dromaeo/cssquery-yui.html) 09:13:02 INFO - PROCESS | 1906 | RSS: Main: 273596416 09:13:02 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49368/tests/dromaeo/cssquery-yui.html (next: http://localhost:49368/tests/dromaeo/cssquery-dojo.html) 09:16:05 INFO - PROCESS | 1906 | RSS: Main: 268541952 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | __start_tp_report 09:16:05 INFO - PROCESS | 1906 | _x_x_mozilla_page_load 09:16:05 INFO - PROCESS | 1906 | _x_x_mozilla_page_load_details 09:16:05 INFO - PROCESS | 1906 | |i|pagename|runs| 09:16:05 INFO - PROCESS | 1906 | |0;dojo.html;3438.968309507148;3459.360018396595;3483.4426491761324;3486.2504561519268;3534.4344904815234;5808.854778630536;5947.375525569818;5962.552808539361;5975.9402405975925;6054.757809687607;5887.558433117522;5968.1346204800275;5976.611520251181;6073.7874174403905;6085.361037091097;5403.864903377427;5409.783608655669;5421.593380496479;5430.972845135769;5531.25328080708;5307.893842123155;5427.158790387496;5499.092649712793;5511.090670039459;5560.86097847553;5305.495977882095;5327.573794096463;5366.731663416814;5433.864153396157;5461.481159289861;5375.059364611177;5382.946170538284;5383.703896285702;5389.9191512127345;5425.484578964992;5351.732413379315;5363;5368.677879327252;5371.328583927009;5396.082665946798;5661.037623603997;5801.7099145043;5810.622309549865;5847.678377689225;5906.822795316148;6270.937290627081;6319.210098737658;6336.271328797201;6336.556441049129;6346.11154438379;6392.3927226913365;6412.583182093149;6412.67936603168;6412.903806442907;6425.036244563353;5148.459411761786;5726.3700992890745;6130.601510901777;6158.291796443422;6163.322034576193;5651.378348381675;6004.739004808952;6294.874102517924;6349;6485.351464853571;6098.855844323405;6194.721237544321;6216.564840461125;6247.125402443661;6337.271213810471;5495.873345964068;6316.8420789479715;6325.367463253638;6356.396142366468;6414.294427613052;6332.588381755171;6344.695553328588;6380.138681278061;6390.169277993924;6396.392342727433;5326.6537675050995;6135.508280839814;6208.596441231396;6295.842603934938;6389.552731308857;4500.617447516932;5110.616703747234;5155.381354237516;5178.948210517847;5236.842894713165;3922.3135951208424;4595.149897269016;4602.171609110393;4611.976940115278;4626;5922.703864806743;6168.660723660242;6184.443400094013;6186.350433204539;6192.752289908443;5864.296284445893;5955.106733989849;6272.5922815016875;6342.080398342215;6374.808755737336;6119.685352982159;6149.046897730859;6184.938150618526;6196.442320191204;6200.162977997912;5690.260266165372;5690.459406356389;5695.487406133385;5698.971505142447;5725.570582206351;6049.727762250797;6331.810045698637;6331.841703957253;6372.745090196526;6615.966920165464;6351.618902865843;6351.650659213788;6383.425491705769;6388.8083357499345;6398.840028999312;6536.0522724205675;6597.736090556324;6599.175103112111;6611.471082313499;6620.90068648961;6204.875902482016;6253.812385628438;6285.088662144055;6298.7480500781285;6367;4981.825636102864;6350.206224221973;6402.263739669997;6407.487401008001;6414.069959855888;6128.319797384666;6260;6294.874102518015;6307.369263073656;6312.968435157978;6182.412670796267;6257.68711564429;6277.089821975696;6286.559940804283;6295.307516173126;6106.053561697944;6165.136880836776;6199.132121503083;6237.064440333987;6241.906371404341;6250.562460627712;6294.622322660655;6301.054841773771;6311.179546658905;6313.779017734358;6054.182685337423;6096.329403765671;6097.603655762361;6112.602680825732;6113.29697084841 09:16:05 INFO - PROCESS | 1906 | |1;ext.html;693.8863124684881;778.3656320099119;792.2354927494968;921.8340698674236;940.5532372123238;38284;39225.82322530325;41021;41076;41186.17627647445;38525.80737096318;38687.226255474874;38718;38763.837084887426;38814.417783733195;7768.456208065438;7917.366610671133;10945;11118.944405278004;11157.2747771395;10856.674299771019;10987.39569323687;10997.065249453806;11000.119990400748;11000.889991100106;9057.50183739894;9627.277954153431;10579.100776434012;10988.450577471134;11041.061509771638;8663;9332.160105590461;10940.960608742156;10988.175886808522;10992.450377481095;9183.632654693803;10918.399488028155;10982.06652434544;10997.890021099767;11005.009549140615;38596.22807543833;39005.41491877624;39168.608313917066;39178;39272.60727392747;3799.4300854871713;3808.390657494815;3809.7904615246152;3822.808859557011;3837.9616203838164;28100.297492562848;28472.715272847214;28519;28815.9914402997;29430.558541621893;2880.4527139843362;3136.200268931431;3154.9684503155136;3160.0993716790604;3265.689759472846;305588.3602909923;359913;368528.9999999973;397501;405832;49804;49841.75079124581;49885.750571247634;50020.49815516621;50090;51673;51749.741251293504;52089.739551302;52168.739156304735;52314;14362.425502979764;14414.207218602867;14438.927805360907;14480.710385792225;14540.927295363666;11896.821547676791;11908.106891983136;11934.28394296345;11935.925766680866;11940;13600.455981760817;13621.318934053257;13670.589882303548;13694.246816425193;13782.724345513034;5094.592432605456;5856.180134781134;5881.647101173943;5921.96365636012;5952.523798096142;1083.2958576925062;1093.748437859297;1100.625787232345;1116.5087361560886;1179.0449735714099;24345.63481547778;25990.74009259921;26015.9593616257;26288.662370709;26395.868020659775;987.9259055570717;1193.9044876409866;1198.7782260281876;1246.2086575024925;1253.4422182129047;12482.251064936132;13338.866611333762;13490.392932317873;13636.931815341059;13726.794098088536;338672;400096;402307;403070;404996;53510;53772;53777.655558611346;53833;53904.46095539073;1321.200673592482;1395.1071314358614;1395.8255218097738;1403.8736513713816;1406.0579411794122;24125.396865078514;24673.753262467864;25541.61687574725;25571;25872;46171.61485155451;46277.30584041309;46333;46333.30500042435;46426.76786616045;358339;358448;358503;358817;359729.201354002;33737.10811932305;35698.8215058923;36163.915082547566;37701.24597507979;37707.43438848365;46364.536354636024;46698.76650616725;47349.05301894012;47732.52267477281;47958.28062578994;37952.810235948644;38619.911070618335;38693.806530967166;39368.40947385849;39595;33832.49251261184;33968;37787;37967.7730037781;39037.219255615295;31252.218694532818;37624.43563346497;38197.80901095477;38355.616443835206;38394.61605384022;32422;33476.83261583774;33585.25327363897;33910.321793564486;33968;25001.749982499943;25009.249722508353;25145;25195.622065668664;25420 09:16:05 INFO - PROCESS | 1906 | |2;jquery.html;355.7349774418057;359.54517535317825;393.2547821877542;412.5503201510353;429.83666206841394;20141.899290503545;21720.3483895483;22200.444988875286;22394.44013899653;22406.775932240693;21693;21825.781742182575;22374.66438003431;22673.54652906945;22778.31665050047;6462.4506916912005;6714.227863795677;6752.864942701168;6769.796906092825;6779.457643388541;6545.607263564178;7254.58535585561;7630.923690763077;7736.922630773704;7749.457537972344;7164.283571642846;7345.22875098115;7713.5757533335645;7745.1093124290865;7774;7468.58922759248;7535.472516923817;7580.9620951894885;7581.962090189541;7584.696612135508;6560.311167327457;7221.783346499614;7390.667419966115;7457.888131678029;7492.850142997164;26936.59595106075;27156;27261.591076133875;27976.860115699496;27985.720142798516;2515.5472015037285;2662.56221640314;2757.352022274764;2838.70193629668;2892.392597554516;15352.462663806826;16101.677966440722;16427.83572164275;16532.552304601217;16824.32702691891;1744.476657002894;2013.1846602126163;2026.4022113476412;2031.3296612117965;2039.4391542325832;168034;169194;170306;171327;174297;18656.34702785396;22806.543869122524;22867.885660571923;23047.308580742603;23069.769302306762;29410.411791764473;35912.281754365285;36009.27981440356;36039.4594081089;36255.81872090622;9226.446413215228;9314.673986410444;10267.691969240936;10908.290961087503;10915.672529824118;8565.52889591066;8568.871466928002;8614.655413783505;8741.213290803858;8762.693305734269;10480.528376223088;10765.793012432432;10811.459427028618;10954.56181752721;10955.068819150301;3694.4827724118645;4290.721103128287;4352.73883566987;4365.628921541705;4383.9342409863875;863.3093525179831;875.8248350329832;877.429670714041;889.8843150390408;907.8002839375326;20361.694574581394;21489.247876324567;21507.892460537598;23208.18771342995;23683.7631623685;896.3814967672286;905.8912930448388;916.2532535983153;926.4580220571041;934.6168071090956;9726.811467419773;9736.513174341255;10017.549210285555;11840.76318473643;12265.69335766613;578925;693403;696414;701091;730712;116371.41814290875;119185;135798;137815;159352.0323983796;974.91713204377;1083.4907593431076;1169.082270417718;1217.0446199733167;1219.7621463814648;16882.409115681385;20908.268210613165;21231.575368492853;21233.57532849365;21256.681149783075;58182.54543636443;60715.78568428695;62162.37837621566;62499.6875015622;62687;85029.57485212534;85673.57163214144;86385.13614863771;86494.13505865113;87523;7859.263880224579;8311.792205194919;10828.404437755999;10849.860764619601;12240.938795305967;12007.859253370916;13627.795583066063;13701.657458563615;13922.651933701738;14046.367913443715;9954.751131221778;10200.846987295048;10767.923207679169;11354.26197297173;11636.88363116358;10303.742406439898;11506;11611.709707257387;11716.472758726048;11816.70458238551;11757.588484403004;11951.402429878644;12083.51665933388;12186.695332616755;12212.69468263265;10856.45717714127;12078.18101360835;12453.439595218055;12631.621051368473;12736.426860791102;11290.7741845161;11649.708757281136;11811.232269902428;11858.525658973544;11858.703532411759 09:16:05 INFO - PROCESS | 1906 | |3;mootools.html;1432.7850822376643;1538.3692685998742;1566.4517418903379;1583.3112596020733;1600.2558810153275;8658.783530411743;11091.112710983121;11376.71558211044;11420.143489238299;11426.200165988384;9564.85652715208;11147.777044459106;11276.548938042468;11333.716657083576;11366.033887119584;2341.683872677184;2371.2530552875787;2376.4296568823443;2377.738448770634;2387.8089752819733;2036.4094412620323;2310.503241803012;2345.1791872844537;2348.236823032513;2353.1881500882255;2325.732540757809;2331.533693261346;2340.087365927281;2344.882755862209;2345.2846881701075;2280.1791355112146;2304.9884750576225;2305.14709557464;2306.9307920762403;2314.710661167354;2297.9425514362106;2346.8474549154253;2353.0470159585393;2355.4346956730433;2358.893849776764;11149.331040137618;11222;11240.325580465198;11243.775124497546;11248.156388270912;5780.450857168562;5936.7328470218945;5944.821655350346;5948.226730525047;5961.016432288668;3132.295233572451;3269.7874638148683;3277.4508285581455;3420.0081976226866;3439.466882633171;1125.7988095001065;1153.6250718516433;1154.6478324111142;1173.9141294302735;1203.6449247472017;15240.618984525365;15296.235188240544;15296.311665975058;15461.613459663486;15463.226838658135;4274.4870615525715;4552.157850797546;4669.4396672399525;4749.715017098985;4766.95233047672;9192.540372981324;10219.693409197736;10364.689059328231;10429.582816687247;10484.370937743759;5387.138057910715;5390.865228369322;5398.73006349681;5422.945770542323;5425.9186112208345;5048.3184770056305;5151.381834179922;5178.585713142939;5249.055170069424;5295.152775555893;3815.1797363566966;3871.4192871069563;3872.7095467840027;3943.11279962012;3960.861369852041;902.4855832175597;989.5101924547395;1011.8886922438526;1043.5929987304958;1045.0281238448315;890.4078787606298;912.8995810460844;929.5909799688116;937.3516848600035;970.3838062830013;6505.544611877218;6512.185976752906;6766.898496522556;6845.212800528003;6873.278305777922;772.6831998880432;843.9704610338731;906.4680689634497;964.3346091197052;978.882534095913;3529.2764983178386;3557.6620221078956;4262.722923010057;4400.713953593006;4432.512423633398;13511.391987360592;13847.515336963157;13961.162330260217;13980.58058258254;14026.789598156036;12885.033622478164;13303.933480332536;13845.930770346084;13878.375473103735;13879.653008674662;9022.233110185576;9871.457069861226;9903.900960990442;10152.847707284396;10180.338278011906;5737.713114344183;6541.430056786242;6798.082258894986;6940.861182776417;7044.119485064367;11752.177347585586;11834.644960651194;11855.288682679067;12023.879761202275;12130.514779408724;11595.478203480694;11881.524739010343;11965.641030769091;12148.757024859276;12310.630681079581;9192;9286.257099432165;9466.195373393339;9469;9503.002184770776;10080.445575493124;10308.536115874653;10382.584696612052;10384.273100882865;10412.531436085243;9061;9211.815763684823;9260.953695231481;9329.253659707343;9374.765630859283;9095.408798428081;9133.725988220363;9154.496502692416;9174.036726143659;9273.72178834636;7912.643931023003;7957.124716281089;8071.677132914618;8072.798180045545;8093.87859182101;5815.185873977562;5948.851278717893;5960.5231581474245;5985.311689155628;6017.157597936205;5274.813167037386;5673.404292549223;5727;5897.823065308047;6056.06131049688 09:16:05 INFO - PROCESS | 1906 | |4;prototype.html;366.5729425219619;375.51370974587905;379.24530184931984;386.9822367174333;388.1770646229993;4765.809367625295;4789.353437285965;5087.160618497953;5103.081445339837;5171.767270472828;4673.43918729752;4858.109424892184;4964.751762411883;5076.314697515834;5103.464136265694;3669.5963444021136;3723.3670276053067;4130.896727581804;4141.047559061418;4302.849400270976;4135.855245066423;4150.875473735793;4293.484781826185;4321.589449002356;4334.45819272591;4284.014676624378;4300.913981720364;4302.290122129845;4352.651787856979;4366.607005369516;3492.4412094065083;3727.5154229949935;3784.2620688965662;4264.637505812009;4389.188000219953;3228.9677103229137;3761.774293542369;3861.594532574067;3910.648041676263;3930.6265904739003;4928.10268046801;4955.281484184809;4957.82647607332;4987.276844857512;5018.172001619729;4024.9195016099807;4447.02107562135;4483.959798291769;4964.177583260869;4991.450940396553;4748.691335063209;5160.638755287131;5259.737013149327;5360.571154307646;5443.2107344434835;3793.7534060285993;4112.670986321087;4341.088371442001;4345.739255644671;4461.709988850715;4537.455505339381;5015.498450154955;5330.253764472977;5479.150841562405;5647.548196144298;3738.738288319846;4371.475422949203;4456.75487848165;4536.206163921301;4541.886452838706;4137.855175068858;4170.562090980464;4648.7443190624845;4650.604698600657;4651.302304654261;4641.86074417768;4822.818409489698;4951.257311403318;4961.950380496221;5035.420926593489;4587.52273772166;5289.841304760864;5403.459654034644;5519.751611177507;5594.440555944454;1552.6196081959993;1561.3910574875808;1563.9599666222061;1565.5616427400346;1566.537871327961;994.3983889746744;1164.817710024326;1169.6783384569312;1173.4426147580002;1195.730960533873;4548.658850586219;4688.968426946067;5079;5166.741662916839;5167.638265321467;5571.9442805571425;5667.9595345675525;5677.467083887327;5682.7213876878195;5811.651300921958;4140.523839758466;4839.395075615548;4888.413390393175;5175.887184255328;5237.240600112962;2777.8888844445996;2874.7125287471085;2996.5505174223604;3025.8184508929535;3058.2965917839024;5693.430656934356;5835.912461313083;6066.272047354258;6070.7875224366935;6088.452039316483;4565.954340456619;5297.894042119136;5650.29371328584;5770.384292398051;5864.970675146597;5423.728813559385;5601.943980560305;5660.33964036902;5661.179129026351;5764.798232061941;5415.128183348767;5783.94216057834;5801.361850196559;5844.6785426801935;5871.238628411374;4615.14619795339;5150.690958542499;5293.655912365684;5402.973435047328;5511.724413779375;6035.366286540026;6043.697815109139;6048.455638992512;6055.364186760326;6070.3929607038945;4572.908541829078;4580.702254353457;4619.815207391666;4634.675572709878;4643.233866412139;4817.855464336076;5035.471275516018;5382.989672693868;5781.843631273846;5789.971050144891;5540.390557038803;5561.8609534760335;5585;5623.341114371188;5631.26883461529;4617.238155704271;4732.716037037789;5220.451852555427;5524.33707955048;5608.831735047955;4514.796834142406;4811.975940120277;5355.464453554613;5407.999520088796;5465.754041068082;4486.932696009628;4655.255159174516;4837.637177211794;5201.552672464988;5206.349206349207;4065.654419374386;5136.922946155885;5357.303550538405;5376.973115134399;5418.647787893774 09:16:05 INFO - PROCESS | 1906 | |5;yui.html;700.9474289428294;726.1286456252499;730.6127752291286;759.123212689344;863.2360361080443;14781.26093695315;15338.616534586641;15751.763723544156;15830.050196988175;15838.524844254676;14783.408663653468;14830.406783728638;15010.774838377432;15020.324085416156;15027.624309392271;898.7977705016368;947.6114792934898;963.8216929867962;963.9180669643089;964.5948701545333;918.6371383303591;954.3939598355059;955.6464108279946;957.6456711016933;970.1462712812715;991.0485933503845;1000.3997601439152;1000.824855650262;1001.7645853224523;1002.6139936124572;878.5826732302137;980.6861804222651;993.4734590666958;994.462989985407;995.8107959487675;737.4800765460337;738.1879932074728;739.2016622048175;742.1094686376316;742.9777106686809;15595;16058.839411605852;16133.354665813471;16545.420910268203;16829;14605.70788584233;14911.254437278092;14913.552593422106;14943.626409339744;14952.654261116442;11747.765044699057;11783.410829458579;11947.282072633376;12049.518019279218;12293.938530307381;3641.599424063351;3668.3396988542054;3704.9629503704887;3810.5617853946874;3812.8284227209565;112444;118945.40527297395;119361.64194584003;121983.78016219902;122605.38697306546;10981.286216396069;11316.660500185008;11531.619276677508;11642.24325418845;11717.707057323634;21168.576628467345;24568.385790355027;24701;25016.37459063538;25061.24816255515;7785.688572457151;7966.920330796734;8019.599020048974;8041.356691464669;8120.75637730869;4053.331200351909;4131;4274.294741367702;4430.069685366045;4434.7560884151035;3397.8131202784084;3481.2515309208643;3490.7905525668543;3491.738119641037;3495.702865256431;629.2543336146681;643.5559463969846;668.1347654787062;679.9354061364163;693.2616763147232;595.7855172138027;658.9439897608661;664.1996394344803;684.8424862281703;699.4579201119174;8717.825643487095;9946.651867184613;10322.329048611817;10381.377117372982;10491.68524944253;683.8734834055715;689.5793565924782;708.8121647763347;711.6123559059854;721.0986267166043;4513.413256276729;4881.4630390657;4896.290037944478;4903.607711383081;4933.703977761345;85869;88438;109942.45028774806;109966;111123.44438277757;72830.79366506413;80820;81597.2170157888;83941.99999999878;88013;60967.69516152391;62529.74940501255;71640;73451;74385.62807186038;10775.92240775916;10791.56833726642;10796;10813.567457301935;11009.2843965142;47939.561813145665;48259.793505161244;48397.09617422966;49786;50029.49911502661;59390;62000.68999654973;63387;63625.68187159034;63871.6806415965;13376.24750499002;13687.726245475234;13718.382672779948;14026;14106.858931410554;14911.85088149148;14914.552563423114;15018.324175411914;15235.923820380827;15276.236188190323;13742.587722368346;13889.412348127944;13939.303034848419;14261.928690356483;14730.852691472948;9790.951045245014;12790.61628151157;13886.611338866032;14208.28958552089;14328.211948342525;13373.197608143542;13439.395227214603;13501.662458438224;13874.098183618033;14073.296335182995;8167.014447029252;9968.700938971842;10054.572022146804;11174.832377514182;11357.04927144944;8939.51452447264;9253.58358873839;9977.551010204414;11335.489902954221;11419.200655954335 09:16:05 INFO - PROCESS | 1906 | __end_tp_report 09:16:05 INFO - PROCESS | 1906 | __start_cc_report 09:16:05 INFO - PROCESS | 1906 | _x_x_mozilla_cycle_collect,422 09:16:05 INFO - PROCESS | 1906 | __end_cc_report 09:16:05 INFO - PROCESS | 1906 | __startTimestamp1489166165906__endTimestamp 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | ------- Summary: start ------- 09:16:05 INFO - PROCESS | 1906 | Number of tests: 6 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#0] dojo.html Cycles:165 Average:5889.20 Median:6149.05 stddev:648.45 (10.5%) stddev-sans-first:621.30 09:16:05 INFO - PROCESS | 1906 | Values: 3439.0 3459.4 3483.4 3486.3 3534.4 5808.9 5947.4 5962.6 5975.9 6054.8 5887.6 5968.1 5976.6 6073.8 6085.4 5403.9 5409.8 5421.6 5431.0 5531.3 5307.9 5427.2 5499.1 5511.1 5560.9 5305.5 5327.6 5366.7 5433.9 5461.5 5375.1 5382.9 5383.7 5389.9 5425.5 5351.7 5363.0 5368.7 5371.3 5396.1 5661.0 5801.7 5810.6 5847.7 5906.8 6270.9 6319.2 6336.3 6336.6 6346.1 6392.4 6412.6 6412.7 6412.9 6425.0 5148.5 5726.4 6130.6 6158.3 6163.3 5651.4 6004.7 6294.9 6349.0 6485.4 6098.9 6194.7 6216.6 6247.1 6337.3 5495.9 6316.8 6325.4 6356.4 6414.3 6332.6 6344.7 6380.1 6390.2 6396.4 5326.7 6135.5 6208.6 6295.8 6389.6 4500.6 5110.6 5155.4 5178.9 5236.8 3922.3 4595.1 4602.2 4612.0 4626.0 5922.7 6168.7 6184.4 6186.4 6192.8 5864.3 5955.1 6272.6 6342.1 6374.8 6119.7 6149.0 6184.9 6196.4 6200.2 5690.3 5690.5 5695.5 5699.0 5725.6 6049.7 6331.8 6331.8 6372.7 6616.0 6351.6 6351.7 6383.4 6388.8 6398.8 6536.1 6597.7 6599.2 6611.5 6620.9 6204.9 6253.8 6285.1 6298.7 6367.0 4981.8 6350.2 6402.3 6407.5 6414.1 6128.3 6260.0 6294.9 6307.4 6313.0 6182.4 6257.7 6277.1 6286.6 6295.3 6106.1 6165.1 6199.1 6237.1 6241.9 6250.6 6294.6 6301.1 6311.2 6313.8 6054.2 6096.3 6097.6 6112.6 6113.3 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#1] ext.html Cycles:180 Average:52559.56 Median:358475.50 stddev:98308.17 (27.4%) stddev-sans-first:98506.83 09:16:05 INFO - PROCESS | 1906 | Values: 693.9 778.4 792.2 921.8 940.6 38284.0 39225.8 41021.0 41076.0 41186.2 38525.8 38687.2 38718.0 38763.8 38814.4 7768.5 7917.4 10945.0 11118.9 11157.3 10856.7 10987.4 10997.1 11000.1 11000.9 9057.5 9627.3 10579.1 10988.5 11041.1 8663.0 9332.2 10941.0 10988.2 10992.5 9183.6 10918.4 10982.1 10997.9 11005.0 38596.2 39005.4 39168.6 39178.0 39272.6 3799.4 3808.4 3809.8 3822.8 3838.0 28100.3 28472.7 28519.0 28816.0 29430.6 2880.5 3136.2 3155.0 3160.1 3265.7 305588.4 359913.0 368529.0 397501.0 405832.0 49804.0 49841.8 49885.8 50020.5 50090.0 51673.0 51749.7 52089.7 52168.7 52314.0 14362.4 14414.2 14438.9 14480.7 14540.9 11896.8 11908.1 11934.3 11935.9 11940.0 13600.5 13621.3 13670.6 13694.2 13782.7 5094.6 5856.2 5881.6 5922.0 5952.5 1083.3 1093.7 1100.6 1116.5 1179.0 24345.6 25990.7 26016.0 26288.7 26395.9 987.9 1193.9 1198.8 1246.2 1253.4 12482.3 13338.9 13490.4 13636.9 13726.8 338672.0 400096.0 402307.0 403070.0 404996.0 53510.0 53772.0 53777.7 53833.0 53904.5 1321.2 1395.1 1395.8 1403.9 1406.1 24125.4 24673.8 25541.6 25571.0 25872.0 46171.6 46277.3 46333.0 46333.3 46426.8 358339.0 358448.0 358503.0 358817.0 359729.2 33737.1 35698.8 36163.9 37701.2 37707.4 46364.5 46698.8 47349.1 47732.5 47958.3 37952.8 38619.9 38693.8 39368.4 39595.0 33832.5 33968.0 37787.0 37967.8 39037.2 31252.2 37624.4 38197.8 38355.6 38394.6 32422.0 33476.8 33585.3 33910.3 33968.0 25001.7 25009.2 25145.0 25195.6 25420.0 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#2] jquery.html Cycles:180 Average:41369.64 Median:23445.98 stddev:114379.88 (487.8%) stddev-sans-first:114659.29 09:16:05 INFO - PROCESS | 1906 | Values: 355.7 359.5 393.3 412.6 429.8 20141.9 21720.3 22200.4 22394.4 22406.8 21693.0 21825.8 22374.7 22673.5 22778.3 6462.5 6714.2 6752.9 6769.8 6779.5 6545.6 7254.6 7630.9 7736.9 7749.5 7164.3 7345.2 7713.6 7745.1 7774.0 7468.6 7535.5 7581.0 7582.0 7584.7 6560.3 7221.8 7390.7 7457.9 7492.9 26936.6 27156.0 27261.6 27976.9 27985.7 2515.5 2662.6 2757.4 2838.7 2892.4 15352.5 16101.7 16427.8 16532.6 16824.3 1744.5 2013.2 2026.4 2031.3 2039.4 168034.0 169194.0 170306.0 171327.0 174297.0 18656.3 22806.5 22867.9 23047.3 23069.8 29410.4 35912.3 36009.3 36039.5 36255.8 9226.4 9314.7 10267.7 10908.3 10915.7 8565.5 8568.9 8614.7 8741.2 8762.7 10480.5 10765.8 10811.5 10954.6 10955.1 3694.5 4290.7 4352.7 4365.6 4383.9 863.3 875.8 877.4 889.9 907.8 20361.7 21489.2 21507.9 23208.2 23683.8 896.4 905.9 916.3 926.5 934.6 9726.8 9736.5 10017.5 11840.8 12265.7 578925.0 693403.0 696414.0 701091.0 730712.0 116371.4 119185.0 135798.0 137815.0 159352.0 974.9 1083.5 1169.1 1217.0 1219.8 16882.4 20908.3 21231.6 21233.6 21256.7 58182.5 60715.8 62162.4 62499.7 62687.0 85029.6 85673.6 86385.1 86494.1 87523.0 7859.3 8311.8 10828.4 10849.9 12240.9 12007.9 13627.8 13701.7 13922.7 14046.4 9954.8 10200.8 10767.9 11354.3 11636.9 10303.7 11506.0 11611.7 11716.5 11816.7 11757.6 11951.4 12083.5 12186.7 12212.7 10856.5 12078.2 12453.4 12631.6 12736.4 11290.8 11649.7 11811.2 11858.5 11858.7 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#3] mootools.html Cycles:180 Average:6672.54 Median:3429.74 stddev:4201.78 (122.5%) stddev-sans-first:4195.12 09:16:05 INFO - PROCESS | 1906 | Values: 1432.8 1538.4 1566.5 1583.3 1600.3 8658.8 11091.1 11376.7 11420.1 11426.2 9564.9 11147.8 11276.5 11333.7 11366.0 2341.7 2371.3 2376.4 2377.7 2387.8 2036.4 2310.5 2345.2 2348.2 2353.2 2325.7 2331.5 2340.1 2344.9 2345.3 2280.2 2305.0 2305.1 2306.9 2314.7 2297.9 2346.8 2353.0 2355.4 2358.9 11149.3 11222.0 11240.3 11243.8 11248.2 5780.5 5936.7 5944.8 5948.2 5961.0 3132.3 3269.8 3277.5 3420.0 3439.5 1125.8 1153.6 1154.6 1173.9 1203.6 15240.6 15296.2 15296.3 15461.6 15463.2 4274.5 4552.2 4669.4 4749.7 4767.0 9192.5 10219.7 10364.7 10429.6 10484.4 5387.1 5390.9 5398.7 5422.9 5425.9 5048.3 5151.4 5178.6 5249.1 5295.2 3815.2 3871.4 3872.7 3943.1 3960.9 902.5 989.5 1011.9 1043.6 1045.0 890.4 912.9 929.6 937.4 970.4 6505.5 6512.2 6766.9 6845.2 6873.3 772.7 844.0 906.5 964.3 978.9 3529.3 3557.7 4262.7 4400.7 4432.5 13511.4 13847.5 13961.2 13980.6 14026.8 12885.0 13303.9 13845.9 13878.4 13879.7 9022.2 9871.5 9903.9 10152.8 10180.3 5737.7 6541.4 6798.1 6940.9 7044.1 11752.2 11834.6 11855.3 12023.9 12130.5 11595.5 11881.5 11965.6 12148.8 12310.6 9192.0 9286.3 9466.2 9469.0 9503.0 10080.4 10308.5 10382.6 10384.3 10412.5 9061.0 9211.8 9261.0 9329.3 9374.8 9095.4 9133.7 9154.5 9174.0 9273.7 7912.6 7957.1 8071.7 8072.8 8093.9 5815.2 5948.9 5960.5 5985.3 6017.2 5274.8 5673.4 5727.0 5897.8 6056.1 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#4] prototype.html Cycles:180 Average:4569.50 Median:4873.26 stddev:1282.69 (26.3%) stddev-sans-first:1246.89 09:16:05 INFO - PROCESS | 1906 | Values: 366.6 375.5 379.2 387.0 388.2 4765.8 4789.4 5087.2 5103.1 5171.8 4673.4 4858.1 4964.8 5076.3 5103.5 3669.6 3723.4 4130.9 4141.0 4302.8 4135.9 4150.9 4293.5 4321.6 4334.5 4284.0 4300.9 4302.3 4352.7 4366.6 3492.4 3727.5 3784.3 4264.6 4389.2 3229.0 3761.8 3861.6 3910.6 3930.6 4928.1 4955.3 4957.8 4987.3 5018.2 4024.9 4447.0 4484.0 4964.2 4991.5 4748.7 5160.6 5259.7 5360.6 5443.2 3793.8 4112.7 4341.1 4345.7 4461.7 4537.5 5015.5 5330.3 5479.2 5647.5 3738.7 4371.5 4456.8 4536.2 4541.9 4137.9 4170.6 4648.7 4650.6 4651.3 4641.9 4822.8 4951.3 4962.0 5035.4 4587.5 5289.8 5403.5 5519.8 5594.4 1552.6 1561.4 1564.0 1565.6 1566.5 994.4 1164.8 1169.7 1173.4 1195.7 4548.7 4689.0 5079.0 5166.7 5167.6 5571.9 5668.0 5677.5 5682.7 5811.7 4140.5 4839.4 4888.4 5175.9 5237.2 2777.9 2874.7 2996.6 3025.8 3058.3 5693.4 5835.9 6066.3 6070.8 6088.5 4566.0 5297.9 5650.3 5770.4 5865.0 5423.7 5601.9 5660.3 5661.2 5764.8 5415.1 5783.9 5801.4 5844.7 5871.2 4615.1 5150.7 5293.7 5403.0 5511.7 6035.4 6043.7 6048.5 6055.4 6070.4 4572.9 4580.7 4619.8 4634.7 4643.2 4817.9 5035.5 5383.0 5781.8 5790.0 5540.4 5561.9 5585.0 5623.3 5631.3 4617.2 4732.7 5220.5 5524.3 5608.8 4514.8 4812.0 5355.5 5408.0 5465.8 4486.9 4655.3 4837.6 5201.6 5206.3 4065.7 5136.9 5357.3 5377.0 5418.6 09:16:05 INFO - PROCESS | 1906 | 09:16:05 INFO - PROCESS | 1906 | [#5] yui.html Cycles:180 Average:20360.54 Median:3686.65 stddev:29256.99 (793.6%) stddev-sans-first:29301.82 09:16:05 INFO - PROCESS | 1906 | Values: 700.9 726.1 730.6 759.1 863.2 14781.3 15338.6 15751.8 15830.1 15838.5 14783.4 14830.4 15010.8 15020.3 15027.6 898.8 947.6 963.8 963.9 964.6 918.6 954.4 955.6 957.6 970.1 991.0 1000.4 1000.8 1001.8 1002.6 878.6 980.7 993.5 994.5 995.8 737.5 738.2 739.2 742.1 743.0 15595.0 16058.8 16133.4 16545.4 16829.0 14605.7 14911.3 14913.6 14943.6 14952.7 11747.8 11783.4 11947.3 12049.5 12293.9 3641.6 3668.3 3705.0 3810.6 3812.8 112444.0 118945.4 119361.6 121983.8 122605.4 10981.3 11316.7 11531.6 11642.2 11717.7 21168.6 24568.4 24701.0 25016.4 25061.2 7785.7 7966.9 8019.6 8041.4 8120.8 4053.3 4131.0 4274.3 4430.1 4434.8 3397.8 3481.3 3490.8 3491.7 3495.7 629.3 643.6 668.1 679.9 693.3 595.8 658.9 664.2 684.8 699.5 8717.8 9946.7 10322.3 10381.4 10491.7 683.9 689.6 708.8 711.6 721.1 4513.4 4881.5 4896.3 4903.6 4933.7 85869.0 88438.0 109942.5 109966.0 111123.4 72830.8 80820.0 81597.2 83942.0 88013.0 60967.7 62529.7 71640.0 73451.0 74385.6 10775.9 10791.6 10796.0 10813.6 11009.3 47939.6 48259.8 48397.1 49786.0 50029.5 59390.0 62000.7 63387.0 63625.7 63871.7 13376.2 13687.7 13718.4 14026.0 14106.9 14911.9 14914.6 15018.3 15235.9 15276.2 13742.6 13889.4 13939.3 14261.9 14730.9 9791.0 12790.6 13886.6 14208.3 14328.2 13373.2 13439.4 13501.7 13874.1 14073.3 8167.0 9968.7 10054.6 11174.8 11357.0 8939.5 9253.6 9977.6 11335.5 11419.2 09:16:05 INFO - PROCESS | 1906 | -------- Summary: end -------- 09:16:05 INFO - PROCESS | 1906 | 09:16:06 INFO - TEST-INFO | 1906: exit 0 09:16:06 INFO - TEST-OK | dromaeo_css | took 1117474ms 09:16:06 INFO - TEST-START | kraken 09:16:06 INFO - operating with platform_type : mac_ 09:16:06 INFO - Initialising browser for kraken test... 09:16:06 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp52PEWC/profile http://localhost:49368/getInfo.html) 09:16:09 INFO - PROCESS | 1911 | 2017-03-10 09:16:09.609 plugin-container[1912:16411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 09:16:09 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:16:09 INFO - PROCESS | 1911 | 2017-03-10 09:16:09.612 plugin-container[1912:16411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x490f, name = 'com.apple.CFPasteboardClient' 09:16:09 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:16:09 INFO - PROCESS | 1911 | 2017-03-10 09:16:09.612 plugin-container[1912:16411] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:16:09 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 09:16:09 INFO - PROCESS | 1911 | colorDepth:24 09:16:09 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 09:16:09 INFO - PROCESS | 1911 | __metrics 09:16:09 ERROR - PROCESS | 1911 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 09:16:10 INFO - TEST-INFO | 1911: exit 0 09:16:10 INFO - Browser initialized. 09:16:10 INFO - Running cycle 1/1 for kraken test... 09:16:10 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/tmp52PEWC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:12 INFO - PROCESS | 1913 | 2017-03-10 09:16:12.897 plugin-container[1914:16543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:16:12 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:16:12 INFO - PROCESS | 1913 | 2017-03-10 09:16:12.897 plugin-container[1914:16543] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460f, name = 'com.apple.CFPasteboardClient' 09:16:12 INFO - PROCESS | 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:16:12 INFO - PROCESS | 1913 | 2017-03-10 09:16:12.898 plugin-container[1914:16543] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:16:22 INFO - PROCESS | 1913 | RSS: Main: 227225600 09:16:22 INFO - PROCESS | 1913 | 09:16:25 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:26 INFO - PROCESS | 1913 | RSS: Main: 241381376 09:16:26 INFO - PROCESS | 1913 | 09:16:29 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-dft) 09:16:29 INFO - PROCESS | 1913 | RSS: Main: 249905152 09:16:29 INFO - PROCESS | 1913 | 09:16:33 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-fft) 09:16:33 INFO - PROCESS | 1913 | RSS: Main: 252518400 09:16:33 INFO - PROCESS | 1913 | 09:16:35 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator) 09:16:36 INFO - PROCESS | 1913 | RSS: Main: 255295488 09:16:36 INFO - PROCESS | 1913 | 09:16:38 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:39 INFO - PROCESS | 1913 | RSS: Main: 255455232 09:16:39 INFO - PROCESS | 1913 | 09:16:41 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:42 INFO - PROCESS | 1913 | RSS: Main: 260825088 09:16:42 INFO - PROCESS | 1913 | 09:16:45 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:46 INFO - PROCESS | 1913 | RSS: Main: 261644288 09:16:46 INFO - PROCESS | 1913 | 09:16:49 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial) 09:16:50 INFO - PROCESS | 1913 | RSS: Main: 261287936 09:16:50 INFO - PROCESS | 1913 | 09:16:51 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:52 INFO - PROCESS | 1913 | RSS: Main: 260960256 09:16:52 INFO - PROCESS | 1913 | 09:16:54 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:54 INFO - PROCESS | 1913 | RSS: Main: 261005312 09:16:54 INFO - PROCESS | 1913 | 09:16:57 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:57 INFO - PROCESS | 1913 | RSS: Main: 261238784 09:16:57 INFO - PROCESS | 1913 | 09:17:00 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:01 INFO - PROCESS | 1913 | RSS: Main: 261562368 09:17:01 INFO - PROCESS | 1913 | 09:17:04 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:05 INFO - PROCESS | 1913 | RSS: Main: 261222400 09:17:05 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49368/tests/kraken/driver.html?testName=ai-astar) 09:17:07 INFO - PROCESS | 1913 | RSS: Main: 263102464 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | __start_tp_report 09:17:07 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 09:17:07 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 09:17:07 INFO - PROCESS | 1913 | |i|pagename|runs| 09:17:07 INFO - PROCESS | 1913 | |0;ai-astar;108;123;119;120;121;142;119;121;118;140 09:17:07 INFO - PROCESS | 1913 | |1;audio-beat-detection;137;115;113;143;107;134;142;140;135;119 09:17:07 INFO - PROCESS | 1913 | |2;audio-dft;193;197;206;220;210;269;275;202;195;199 09:17:07 INFO - PROCESS | 1913 | |3;audio-fft;81;62;64;85;65;59;61;62;100;83 09:17:07 INFO - PROCESS | 1913 | |4;audio-oscillator;82;70;93;73;73;70;85;60;60;99 09:17:07 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;90;90;88;88;90;93;88;90;90;135 09:17:07 INFO - PROCESS | 1913 | |6;imaging-darkroom;97;99;98;99;97;108;156;101;103;95 09:17:07 INFO - PROCESS | 1913 | |7;imaging-desaturate;141;140;92;92;91;91;94;99;93;92 09:17:07 INFO - PROCESS | 1913 | |8;json-parse-financial;68;70;69;69;70;68;69;69;69;67 09:17:07 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;64;62;74;65;61;68;66;60;59;52 09:17:07 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;79;82;81;110;105;111;101;76;83;111 09:17:07 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;141;141;166;141;155;152;144;151;193;161 09:17:07 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;198;240;240;175;175;172;182;210;174;176 09:17:07 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;63;81;87;91;87;71;67;79;84;87 09:17:07 INFO - PROCESS | 1913 | __end_tp_report 09:17:07 INFO - PROCESS | 1913 | __start_cc_report 09:17:07 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,1014 09:17:07 INFO - PROCESS | 1913 | __end_cc_report 09:17:07 INFO - PROCESS | 1913 | __startTimestamp1489166227376__endTimestamp 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | ------- Summary: start ------- 09:17:07 INFO - PROCESS | 1913 | Number of tests: 14 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:123.10 Median:121.00 stddev:10.27 (8.5%) stddev-sans-first:9.32 09:17:07 INFO - PROCESS | 1913 | Values: 108.0 123.0 119.0 120.0 121.0 142.0 119.0 121.0 118.0 140.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:136.00 stddev:13.52 (9.9%) stddev-sans-first:13.98 09:17:07 INFO - PROCESS | 1913 | Values: 137.0 115.0 113.0 143.0 107.0 134.0 142.0 140.0 135.0 119.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:216.60 Median:208.00 stddev:30.28 (14.6%) stddev-sans-first:30.89 09:17:07 INFO - PROCESS | 1913 | Values: 193.0 197.0 206.0 220.0 210.0 269.0 275.0 202.0 195.0 199.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:72.20 Median:64.50 stddev:13.97 (21.7%) stddev-sans-first:14.45 09:17:07 INFO - PROCESS | 1913 | Values: 81.0 62.0 64.0 85.0 65.0 59.0 61.0 62.0 100.0 83.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:77.50 stddev:13.06 (16.8%) stddev-sans-first:13.70 09:17:07 INFO - PROCESS | 1913 | Values: 82.0 70.0 93.0 73.0 73.0 70.0 85.0 60.0 60.0 99.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:90.00 stddev:14.41 (16.0%) stddev-sans-first:15.21 09:17:07 INFO - PROCESS | 1913 | Values: 90.0 90.0 88.0 88.0 90.0 93.0 88.0 90.0 90.0 135.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:97.00 stddev:18.19 (18.8%) stddev-sans-first:19.04 09:17:07 INFO - PROCESS | 1913 | Values: 97.0 99.0 98.0 99.0 97.0 108.0 156.0 101.0 103.0 95.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:102.50 Median:92.00 stddev:20.16 (21.9%) stddev-sans-first:15.86 09:17:07 INFO - PROCESS | 1913 | Values: 141.0 140.0 92.0 92.0 91.0 91.0 94.0 99.0 93.0 92.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 09:17:07 INFO - PROCESS | 1913 | Values: 68.0 70.0 69.0 69.0 70.0 68.0 69.0 69.0 69.0 67.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:64.50 stddev:5.88 (9.1%) stddev-sans-first:6.22 09:17:07 INFO - PROCESS | 1913 | Values: 64.0 62.0 74.0 65.0 61.0 68.0 66.0 60.0 59.0 52.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:77.50 stddev:14.86 (19.2%) stddev-sans-first:14.75 09:17:07 INFO - PROCESS | 1913 | Values: 79.0 82.0 81.0 110.0 105.0 111.0 101.0 76.0 83.0 111.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:153.50 stddev:16.10 (10.5%) stddev-sans-first:16.32 09:17:07 INFO - PROCESS | 1913 | Values: 141.0 141.0 166.0 141.0 155.0 152.0 144.0 151.0 193.0 161.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.20 Median:190.00 stddev:27.03 (14.2%) stddev-sans-first:28.64 09:17:07 INFO - PROCESS | 1913 | Values: 198.0 240.0 240.0 175.0 175.0 172.0 182.0 210.0 174.0 176.0 09:17:07 INFO - PROCESS | 1913 | 09:17:07 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:85.50 stddev:9.57 (11.2%) stddev-sans-first:8.02 09:17:07 INFO - PROCESS | 1913 | Values: 63.0 81.0 87.0 91.0 87.0 71.0 67.0 79.0 84.0 87.0 09:17:07 INFO - PROCESS | 1913 | -------- Summary: end -------- 09:17:07 INFO - PROCESS | 1913 | 09:17:08 INFO - TEST-INFO | 1913: exit 0 09:17:08 INFO - TEST-OK | kraken | took 61699ms 09:17:08 INFO - SUITE-END | took 1179s 09:17:08 INFO - Completed test suite (00:19:39) 09:17:08 INFO - javascript benchmark 09:17:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7721.132689436966, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3438.968309507148, 3459.360018396595, 3483.4426491761324, 3486.2504561519268, 3534.4344904815234, 5808.854778630536, 5947.375525569818, 5962.552808539361, 5975.9402405975925, 6054.757809687607, 5887.558433117522, 5968.1346204800275, 5976.611520251181, 6073.7874174403905, 6085.361037091097, 5403.864903377427, 5409.783608655669, 5421.593380496479, 5430.972845135769, 5531.25328080708, 5307.893842123155, 5427.158790387496, 5499.092649712793, 5511.090670039459, 5560.86097847553, 5305.495977882095, 5327.573794096463, 5366.731663416814, 5433.864153396157, 5461.481159289861, 5375.059364611177, 5382.946170538284, 5383.703896285702, 5389.9191512127345, 5425.484578964992, 5351.732413379315, 5363.0, 5368.677879327252, 5371.328583927009, 5396.082665946798, 5661.037623603997, 5801.7099145043, 5810.622309549865, 5847.678377689225, 5906.822795316148, 6270.937290627081, 6319.210098737658, 6336.271328797201, 6336.556441049129, 6346.11154438379, 6392.3927226913365, 6412.583182093149, 6412.67936603168, 6412.903806442907, 6425.036244563353, 5148.459411761786, 5726.3700992890745, 6130.601510901777, 6158.291796443422, 6163.322034576193, 5651.378348381675, 6004.739004808952, 6294.874102517924, 6349.0, 6485.351464853571, 6098.855844323405, 6194.721237544321, 6216.564840461125, 6247.125402443661, 6337.271213810471, 5495.873345964068, 6316.8420789479715, 6325.367463253638, 6356.396142366468, 6414.294427613052, 6332.588381755171, 6344.695553328588, 6380.138681278061, 6390.169277993924, 6396.392342727433, 5326.6537675050995, 6135.508280839814, 6208.596441231396, 6295.842603934938, 6389.552731308857, 4500.617447516932, 5110.616703747234, 5155.381354237516, 5178.948210517847, 5236.842894713165, 3922.3135951208424, 4595.149897269016, 4602.171609110393, 4611.976940115278, 4626.0, 5922.703864806743, 6168.660723660242, 6184.443400094013, 6186.350433204539, 6192.752289908443, 5864.296284445893, 5955.106733989849, 6272.5922815016875, 6342.080398342215, 6374.808755737336, 6119.685352982159, 6149.046897730859, 6184.938150618526, 6196.442320191204, 6200.162977997912, 5690.260266165372, 5690.459406356389, 5695.487406133385, 5698.971505142447, 5725.570582206351, 6049.727762250797, 6331.810045698637, 6331.841703957253, 6372.745090196526, 6615.966920165464, 6351.618902865843, 6351.650659213788, 6383.425491705769, 6388.8083357499345, 6398.840028999312, 6536.0522724205675, 6597.736090556324, 6599.175103112111, 6611.471082313499, 6620.90068648961, 6204.875902482016, 6253.812385628438, 6285.088662144055, 6298.7480500781285, 6367.0, 4981.825636102864, 6350.206224221973, 6402.263739669997, 6407.487401008001, 6414.069959855888, 6128.319797384666, 6260.0, 6294.874102518015, 6307.369263073656, 6312.968435157978, 6182.412670796267, 6257.68711564429, 6277.089821975696, 6286.559940804283, 6295.307516173126, 6106.053561697944, 6165.136880836776, 6199.132121503083, 6237.064440333987, 6241.906371404341, 6250.562460627712, 6294.622322660655, 6301.054841773771, 6311.179546658905, 6313.779017734358, 6054.182685337423, 6096.329403765671, 6097.603655762361, 6112.602680825732, 6113.29697084841], "value": 5849.757222057699, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.8863124684881, 778.3656320099119, 792.2354927494968, 921.8340698674236, 940.5532372123238, 38284.0, 39225.82322530325, 41021.0, 41076.0, 41186.17627647445, 38525.80737096318, 38687.226255474874, 38718.0, 38763.837084887426, 38814.417783733195, 7768.456208065438, 7917.366610671133, 10945.0, 11118.944405278004, 11157.2747771395, 10856.674299771019, 10987.39569323687, 10997.065249453806, 11000.119990400748, 11000.889991100106, 9057.50183739894, 9627.277954153431, 10579.100776434012, 10988.450577471134, 11041.061509771638, 8663.0, 9332.160105590461, 10940.960608742156, 10988.175886808522, 10992.450377481095, 9183.632654693803, 10918.399488028155, 10982.06652434544, 10997.890021099767, 11005.009549140615, 38596.22807543833, 39005.41491877624, 39168.608313917066, 39178.0, 39272.60727392747, 3799.4300854871713, 3808.390657494815, 3809.7904615246152, 3822.808859557011, 3837.9616203838164, 28100.297492562848, 28472.715272847214, 28519.0, 28815.9914402997, 29430.558541621893, 2880.4527139843362, 3136.200268931431, 3154.9684503155136, 3160.0993716790604, 3265.689759472846, 305588.3602909923, 359913.0, 368528.9999999973, 397501.0, 405832.0, 49804.0, 49841.75079124581, 49885.750571247634, 50020.49815516621, 50090.0, 51673.0, 51749.741251293504, 52089.739551302, 52168.739156304735, 52314.0, 14362.425502979764, 14414.207218602867, 14438.927805360907, 14480.710385792225, 14540.927295363666, 11896.821547676791, 11908.106891983136, 11934.28394296345, 11935.925766680866, 11940.0, 13600.455981760817, 13621.318934053257, 13670.589882303548, 13694.246816425193, 13782.724345513034, 5094.592432605456, 5856.180134781134, 5881.647101173943, 5921.96365636012, 5952.523798096142, 1083.2958576925062, 1093.748437859297, 1100.625787232345, 1116.5087361560886, 1179.0449735714099, 24345.63481547778, 25990.74009259921, 26015.9593616257, 26288.662370709, 26395.868020659775, 987.9259055570717, 1193.9044876409866, 1198.7782260281876, 1246.2086575024925, 1253.4422182129047, 12482.251064936132, 13338.866611333762, 13490.392932317873, 13636.931815341059, 13726.794098088536, 338672.0, 400096.0, 402307.0, 403070.0, 404996.0, 53510.0, 53772.0, 53777.655558611346, 53833.0, 53904.46095539073, 1321.200673592482, 1395.1071314358614, 1395.8255218097738, 1403.8736513713816, 1406.0579411794122, 24125.396865078514, 24673.753262467864, 25541.61687574725, 25571.0, 25872.0, 46171.61485155451, 46277.30584041309, 46333.0, 46333.30500042435, 46426.76786616045, 358339.0, 358448.0, 358503.0, 358817.0, 359729.201354002, 33737.10811932305, 35698.8215058923, 36163.915082547566, 37701.24597507979, 37707.43438848365, 46364.536354636024, 46698.76650616725, 47349.05301894012, 47732.52267477281, 47958.28062578994, 37952.810235948644, 38619.911070618335, 38693.806530967166, 39368.40947385849, 39595.0, 33832.49251261184, 33968.0, 37787.0, 37967.7730037781, 39037.219255615295, 31252.218694532818, 37624.43563346497, 38197.80901095477, 38355.616443835206, 38394.61605384022, 32422.0, 33476.83261583774, 33585.25327363897, 33910.321793564486, 33968.0, 25001.749982499943, 25009.249722508353, 25145.0, 25195.622065668664, 25420.0], "value": 18998.738673978565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.7349774418057, 359.54517535317825, 393.2547821877542, 412.5503201510353, 429.83666206841394, 20141.899290503545, 21720.3483895483, 22200.444988875286, 22394.44013899653, 22406.775932240693, 21693.0, 21825.781742182575, 22374.66438003431, 22673.54652906945, 22778.31665050047, 6462.4506916912005, 6714.227863795677, 6752.864942701168, 6769.796906092825, 6779.457643388541, 6545.607263564178, 7254.58535585561, 7630.923690763077, 7736.922630773704, 7749.457537972344, 7164.283571642846, 7345.22875098115, 7713.5757533335645, 7745.1093124290865, 7774.0, 7468.58922759248, 7535.472516923817, 7580.9620951894885, 7581.962090189541, 7584.696612135508, 6560.311167327457, 7221.783346499614, 7390.667419966115, 7457.888131678029, 7492.850142997164, 26936.59595106075, 27156.0, 27261.591076133875, 27976.860115699496, 27985.720142798516, 2515.5472015037285, 2662.56221640314, 2757.352022274764, 2838.70193629668, 2892.392597554516, 15352.462663806826, 16101.677966440722, 16427.83572164275, 16532.552304601217, 16824.32702691891, 1744.476657002894, 2013.1846602126163, 2026.4022113476412, 2031.3296612117965, 2039.4391542325832, 168034.0, 169194.0, 170306.0, 171327.0, 174297.0, 18656.34702785396, 22806.543869122524, 22867.885660571923, 23047.308580742603, 23069.769302306762, 29410.411791764473, 35912.281754365285, 36009.27981440356, 36039.4594081089, 36255.81872090622, 9226.446413215228, 9314.673986410444, 10267.691969240936, 10908.290961087503, 10915.672529824118, 8565.52889591066, 8568.871466928002, 8614.655413783505, 8741.213290803858, 8762.693305734269, 10480.528376223088, 10765.793012432432, 10811.459427028618, 10954.56181752721, 10955.068819150301, 3694.4827724118645, 4290.721103128287, 4352.73883566987, 4365.628921541705, 4383.9342409863875, 863.3093525179831, 875.8248350329832, 877.429670714041, 889.8843150390408, 907.8002839375326, 20361.694574581394, 21489.247876324567, 21507.892460537598, 23208.18771342995, 23683.7631623685, 896.3814967672286, 905.8912930448388, 916.2532535983153, 926.4580220571041, 934.6168071090956, 9726.811467419773, 9736.513174341255, 10017.549210285555, 11840.76318473643, 12265.69335766613, 578925.0, 693403.0, 696414.0, 701091.0, 730712.0, 116371.41814290875, 119185.0, 135798.0, 137815.0, 159352.0323983796, 974.91713204377, 1083.4907593431076, 1169.082270417718, 1217.0446199733167, 1219.7621463814648, 16882.409115681385, 20908.268210613165, 21231.575368492853, 21233.57532849365, 21256.681149783075, 58182.54543636443, 60715.78568428695, 62162.37837621566, 62499.6875015622, 62687.0, 85029.57485212534, 85673.57163214144, 86385.13614863771, 86494.13505865113, 87523.0, 7859.263880224579, 8311.792205194919, 10828.404437755999, 10849.860764619601, 12240.938795305967, 12007.859253370916, 13627.795583066063, 13701.657458563615, 13922.651933701738, 14046.367913443715, 9954.751131221778, 10200.846987295048, 10767.923207679169, 11354.26197297173, 11636.88363116358, 10303.742406439898, 11506.0, 11611.709707257387, 11716.472758726048, 11816.70458238551, 11757.588484403004, 11951.402429878644, 12083.51665933388, 12186.695332616755, 12212.69468263265, 10856.45717714127, 12078.18101360835, 12453.439595218055, 12631.621051368473, 12736.426860791102, 11290.7741845161, 11649.708757281136, 11811.232269902428, 11858.525658973544, 11858.703532411759], "value": 11706.49230996963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.7850822376643, 1538.3692685998742, 1566.4517418903379, 1583.3112596020733, 1600.2558810153275, 8658.783530411743, 11091.112710983121, 11376.71558211044, 11420.143489238299, 11426.200165988384, 9564.85652715208, 11147.777044459106, 11276.548938042468, 11333.716657083576, 11366.033887119584, 2341.683872677184, 2371.2530552875787, 2376.4296568823443, 2377.738448770634, 2387.8089752819733, 2036.4094412620323, 2310.503241803012, 2345.1791872844537, 2348.236823032513, 2353.1881500882255, 2325.732540757809, 2331.533693261346, 2340.087365927281, 2344.882755862209, 2345.2846881701075, 2280.1791355112146, 2304.9884750576225, 2305.14709557464, 2306.9307920762403, 2314.710661167354, 2297.9425514362106, 2346.8474549154253, 2353.0470159585393, 2355.4346956730433, 2358.893849776764, 11149.331040137618, 11222.0, 11240.325580465198, 11243.775124497546, 11248.156388270912, 5780.450857168562, 5936.7328470218945, 5944.821655350346, 5948.226730525047, 5961.016432288668, 3132.295233572451, 3269.7874638148683, 3277.4508285581455, 3420.0081976226866, 3439.466882633171, 1125.7988095001065, 1153.6250718516433, 1154.6478324111142, 1173.9141294302735, 1203.6449247472017, 15240.618984525365, 15296.235188240544, 15296.311665975058, 15461.613459663486, 15463.226838658135, 4274.4870615525715, 4552.157850797546, 4669.4396672399525, 4749.715017098985, 4766.95233047672, 9192.540372981324, 10219.693409197736, 10364.689059328231, 10429.582816687247, 10484.370937743759, 5387.138057910715, 5390.865228369322, 5398.73006349681, 5422.945770542323, 5425.9186112208345, 5048.3184770056305, 5151.381834179922, 5178.585713142939, 5249.055170069424, 5295.152775555893, 3815.1797363566966, 3871.4192871069563, 3872.7095467840027, 3943.11279962012, 3960.861369852041, 902.4855832175597, 989.5101924547395, 1011.8886922438526, 1043.5929987304958, 1045.0281238448315, 890.4078787606298, 912.8995810460844, 929.5909799688116, 937.3516848600035, 970.3838062830013, 6505.544611877218, 6512.185976752906, 6766.898496522556, 6845.212800528003, 6873.278305777922, 772.6831998880432, 843.9704610338731, 906.4680689634497, 964.3346091197052, 978.882534095913, 3529.2764983178386, 3557.6620221078956, 4262.722923010057, 4400.713953593006, 4432.512423633398, 13511.391987360592, 13847.515336963157, 13961.162330260217, 13980.58058258254, 14026.789598156036, 12885.033622478164, 13303.933480332536, 13845.930770346084, 13878.375473103735, 13879.653008674662, 9022.233110185576, 9871.457069861226, 9903.900960990442, 10152.847707284396, 10180.338278011906, 5737.713114344183, 6541.430056786242, 6798.082258894986, 6940.861182776417, 7044.119485064367, 11752.177347585586, 11834.644960651194, 11855.288682679067, 12023.879761202275, 12130.514779408724, 11595.478203480694, 11881.524739010343, 11965.641030769091, 12148.757024859276, 12310.630681079581, 9192.0, 9286.257099432165, 9466.195373393339, 9469.0, 9503.002184770776, 10080.445575493124, 10308.536115874653, 10382.584696612052, 10384.273100882865, 10412.531436085243, 9061.0, 9211.815763684823, 9260.953695231481, 9329.253659707343, 9374.765630859283, 9095.408798428081, 9133.725988220363, 9154.496502692416, 9174.036726143659, 9273.72178834636, 7912.643931023003, 7957.124716281089, 8071.677132914618, 8072.798180045545, 8093.87859182101, 5815.185873977562, 5948.851278717893, 5960.5231581474245, 5985.311689155628, 6017.157597936205, 5274.813167037386, 5673.404292549223, 5727.0, 5897.823065308047, 6056.06131049688], "value": 5056.023919958927, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5729425219619, 375.51370974587905, 379.24530184931984, 386.9822367174333, 388.1770646229993, 4765.809367625295, 4789.353437285965, 5087.160618497953, 5103.081445339837, 5171.767270472828, 4673.43918729752, 4858.109424892184, 4964.751762411883, 5076.314697515834, 5103.464136265694, 3669.5963444021136, 3723.3670276053067, 4130.896727581804, 4141.047559061418, 4302.849400270976, 4135.855245066423, 4150.875473735793, 4293.484781826185, 4321.589449002356, 4334.45819272591, 4284.014676624378, 4300.913981720364, 4302.290122129845, 4352.651787856979, 4366.607005369516, 3492.4412094065083, 3727.5154229949935, 3784.2620688965662, 4264.637505812009, 4389.188000219953, 3228.9677103229137, 3761.774293542369, 3861.594532574067, 3910.648041676263, 3930.6265904739003, 4928.10268046801, 4955.281484184809, 4957.82647607332, 4987.276844857512, 5018.172001619729, 4024.9195016099807, 4447.02107562135, 4483.959798291769, 4964.177583260869, 4991.450940396553, 4748.691335063209, 5160.638755287131, 5259.737013149327, 5360.571154307646, 5443.2107344434835, 3793.7534060285993, 4112.670986321087, 4341.088371442001, 4345.739255644671, 4461.709988850715, 4537.455505339381, 5015.498450154955, 5330.253764472977, 5479.150841562405, 5647.548196144298, 3738.738288319846, 4371.475422949203, 4456.75487848165, 4536.206163921301, 4541.886452838706, 4137.855175068858, 4170.562090980464, 4648.7443190624845, 4650.604698600657, 4651.302304654261, 4641.86074417768, 4822.818409489698, 4951.257311403318, 4961.950380496221, 5035.420926593489, 4587.52273772166, 5289.841304760864, 5403.459654034644, 5519.751611177507, 5594.440555944454, 1552.6196081959993, 1561.3910574875808, 1563.9599666222061, 1565.5616427400346, 1566.537871327961, 994.3983889746744, 1164.817710024326, 1169.6783384569312, 1173.4426147580002, 1195.730960533873, 4548.658850586219, 4688.968426946067, 5079.0, 5166.741662916839, 5167.638265321467, 5571.9442805571425, 5667.9595345675525, 5677.467083887327, 5682.7213876878195, 5811.651300921958, 4140.523839758466, 4839.395075615548, 4888.413390393175, 5175.887184255328, 5237.240600112962, 2777.8888844445996, 2874.7125287471085, 2996.5505174223604, 3025.8184508929535, 3058.2965917839024, 5693.430656934356, 5835.912461313083, 6066.272047354258, 6070.7875224366935, 6088.452039316483, 4565.954340456619, 5297.894042119136, 5650.29371328584, 5770.384292398051, 5864.970675146597, 5423.728813559385, 5601.943980560305, 5660.33964036902, 5661.179129026351, 5764.798232061941, 5415.128183348767, 5783.94216057834, 5801.361850196559, 5844.6785426801935, 5871.238628411374, 4615.14619795339, 5150.690958542499, 5293.655912365684, 5402.973435047328, 5511.724413779375, 6035.366286540026, 6043.697815109139, 6048.455638992512, 6055.364186760326, 6070.3929607038945, 4572.908541829078, 4580.702254353457, 4619.815207391666, 4634.675572709878, 4643.233866412139, 4817.855464336076, 5035.471275516018, 5382.989672693868, 5781.843631273846, 5789.971050144891, 5540.390557038803, 5561.8609534760335, 5585.0, 5623.341114371188, 5631.26883461529, 4617.238155704271, 4732.716037037789, 5220.451852555427, 5524.33707955048, 5608.831735047955, 4514.796834142406, 4811.975940120277, 5355.464453554613, 5407.999520088796, 5465.754041068082, 4486.932696009628, 4655.255159174516, 4837.637177211794, 5201.552672464988, 5206.349206349207, 4065.654419374386, 5136.922946155885, 5357.303550538405, 5376.973115134399, 5418.647787893774], "value": 4199.56236669255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9474289428294, 726.1286456252499, 730.6127752291286, 759.123212689344, 863.2360361080443, 14781.26093695315, 15338.616534586641, 15751.763723544156, 15830.050196988175, 15838.524844254676, 14783.408663653468, 14830.406783728638, 15010.774838377432, 15020.324085416156, 15027.624309392271, 898.7977705016368, 947.6114792934898, 963.8216929867962, 963.9180669643089, 964.5948701545333, 918.6371383303591, 954.3939598355059, 955.6464108279946, 957.6456711016933, 970.1462712812715, 991.0485933503845, 1000.3997601439152, 1000.824855650262, 1001.7645853224523, 1002.6139936124572, 878.5826732302137, 980.6861804222651, 993.4734590666958, 994.462989985407, 995.8107959487675, 737.4800765460337, 738.1879932074728, 739.2016622048175, 742.1094686376316, 742.9777106686809, 15595.0, 16058.839411605852, 16133.354665813471, 16545.420910268203, 16829.0, 14605.70788584233, 14911.254437278092, 14913.552593422106, 14943.626409339744, 14952.654261116442, 11747.765044699057, 11783.410829458579, 11947.282072633376, 12049.518019279218, 12293.938530307381, 3641.599424063351, 3668.3396988542054, 3704.9629503704887, 3810.5617853946874, 3812.8284227209565, 112444.0, 118945.40527297395, 119361.64194584003, 121983.78016219902, 122605.38697306546, 10981.286216396069, 11316.660500185008, 11531.619276677508, 11642.24325418845, 11717.707057323634, 21168.576628467345, 24568.385790355027, 24701.0, 25016.37459063538, 25061.24816255515, 7785.688572457151, 7966.920330796734, 8019.599020048974, 8041.356691464669, 8120.75637730869, 4053.331200351909, 4131.0, 4274.294741367702, 4430.069685366045, 4434.7560884151035, 3397.8131202784084, 3481.2515309208643, 3490.7905525668543, 3491.738119641037, 3495.702865256431, 629.2543336146681, 643.5559463969846, 668.1347654787062, 679.9354061364163, 693.2616763147232, 595.7855172138027, 658.9439897608661, 664.1996394344803, 684.8424862281703, 699.4579201119174, 8717.825643487095, 9946.651867184613, 10322.329048611817, 10381.377117372982, 10491.68524944253, 683.8734834055715, 689.5793565924782, 708.8121647763347, 711.6123559059854, 721.0986267166043, 4513.413256276729, 4881.4630390657, 4896.290037944478, 4903.607711383081, 4933.703977761345, 85869.0, 88438.0, 109942.45028774806, 109966.0, 111123.44438277757, 72830.79366506413, 80820.0, 81597.2170157888, 83941.99999999878, 88013.0, 60967.69516152391, 62529.74940501255, 71640.0, 73451.0, 74385.62807186038, 10775.92240775916, 10791.56833726642, 10796.0, 10813.567457301935, 11009.2843965142, 47939.561813145665, 48259.793505161244, 48397.09617422966, 49786.0, 50029.49911502661, 59390.0, 62000.68999654973, 63387.0, 63625.68187159034, 63871.6806415965, 13376.24750499002, 13687.726245475234, 13718.382672779948, 14026.0, 14106.858931410554, 14911.85088149148, 14914.552563423114, 15018.324175411914, 15235.923820380827, 15276.236188190323, 13742.587722368346, 13889.412348127944, 13939.303034848419, 14261.928690356483, 14730.852691472948, 9790.951045245014, 12790.61628151157, 13886.611338866032, 14208.28958552089, 14328.211948342525, 13373.197608143542, 13439.395227214603, 13501.662458438224, 13874.098183618033, 14073.296335182995, 8167.014447029252, 9968.700938971842, 10054.572022146804, 11174.832377514182, 11357.04927144944, 8939.51452447264, 9253.58358873839, 9977.551010204414, 11335.489902954221, 11419.200655954335], "value": 7669.038215372032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 123.0, 119.0, 120.0, 121.0, 142.0, 119.0, 121.0, 118.0, 140.0], "value": 123.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 115.0, 113.0, 143.0, 107.0, 134.0, 142.0, 140.0, 135.0, 119.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 197.0, 206.0, 220.0, 210.0, 269.0, 275.0, 202.0, 195.0, 199.0], "value": 216.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 64.0, 85.0, 65.0, 59.0, 61.0, 62.0, 100.0, 83.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 93.0, 73.0, 73.0, 70.0, 85.0, 60.0, 60.0, 99.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 88.0, 88.0, 90.0, 93.0, 88.0, 90.0, 90.0, 135.0], "value": 94.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 98.0, 99.0, 97.0, 108.0, 156.0, 101.0, 103.0, 95.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 92.0, 92.0, 91.0, 91.0, 94.0, 99.0, 93.0, 92.0], "value": 102.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 69.0, 70.0, 68.0, 69.0, 69.0, 69.0, 67.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 74.0, 65.0, 61.0, 68.0, 66.0, 60.0, 59.0, 52.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 81.0, 110.0, 105.0, 111.0, 101.0, 76.0, 83.0, 111.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 166.0, 141.0, 155.0, 152.0, 144.0, 151.0, 193.0, 161.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 240.0, 240.0, 175.0, 175.0, 172.0, 182.0, 210.0, 174.0, 176.0], "value": 194.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 81.0, 87.0, 91.0, 87.0, 71.0, 67.0, 79.0, 84.0, 87.0], "value": 79.7, "unit": "score"}]}]} 09:17:08 INFO - Return code: 0 09:17:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:08 ERROR - # TBPL SUCCESS # 09:17:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:08 INFO - 2017-03-10 09:17:08.733 screenresolution[1918:16921] starting screenresolution argv=screenresolution get 09:17:08 INFO - 2017-03-10 09:17:08.736 screenresolution[1918:16921] Display 0: 1600x1200x32@60 09:17:08 INFO - 2017-03-10 09:17:08.742 screenresolution[1919:16924] starting screenresolution argv=screenresolution list 09:17:08 INFO - Available Modes on Display 0 09:17:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:08 INFO - Intel Iris: 09:17:08 INFO - Chipset Model: Intel Iris 09:17:08 INFO - Type: GPU 09:17:08 INFO - Bus: Built-In 09:17:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:08 INFO - Vendor: Intel (0x8086) 09:17:08 INFO - Device ID: 0x0a2e 09:17:08 INFO - Revision ID: 0x0009 09:17:08 INFO - Displays: 09:17:08 INFO - Display: 09:17:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:08 INFO - Display Serial Number: 1600x1200 60 09:17:08 INFO - Main Display: Yes 09:17:08 INFO - Mirror: Off 09:17:08 INFO - Online: Yes 09:17:08 INFO - Rotation: Supported 09:17:08 INFO - Return code: 0 09:17:08 INFO - Running post-action listener: _resource_record_post_action 09:17:08 INFO - [mozharness: 2017-03-10 17:17:08.976011Z] Finished run-tests step (success) 09:17:08 INFO - Running post-run listener: _resource_record_post_run 09:17:09 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1992192; Write bytes: 513165824; Read time: 22; Write time: 1632 09:17:09 INFO - TinderboxPrint: CPU usage
54.7% 09:17:09 INFO - TinderboxPrint: I/O read bytes / time
1,992,192 / 22 09:17:09 INFO - TinderboxPrint: I/O write bytes / time
513,165,824 / 1,632 09:17:09 INFO - TinderboxPrint: CPU idle
2,176.3 (45.3%) 09:17:09 INFO - TinderboxPrint: CPU system
962.0 (20.0%) 09:17:09 INFO - TinderboxPrint: CPU user
1,663.3 (34.6%) 09:17:09 INFO - TinderboxPrint: Swap in / out
212,869,120 / 0 09:17:09 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203078144; Write bytes: 200892416; Read time: 15345; Write time: 391 09:17:09 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1992192; Write bytes: 301443584; Read time: 22; Write time: 1208 09:17:09 INFO - Running post-run listener: _upload_blobber_files 09:17:09 INFO - Blob upload gear active. 09:17:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:09 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:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:17:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:10 INFO - (blobuploader) - INFO - Done attempting. 09:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:11 INFO - (blobuploader) - INFO - Done attempting. 09:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:12 INFO - (blobuploader) - INFO - Done attempting. 09:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:14 INFO - (blobuploader) - INFO - Done attempting. 09:17:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:14 INFO - Return code: 0 09:17:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7acfe49a0f25fc8c06a66f38799a4a56e3e5b55fb67ef2c340279f8945d628c32c096d6a8c0f47b18250e30ae47f27fa17268e31cde55dc6859980c1dac24a4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadb3ce244eb9a6f2a25c378874cb06061741d1726a9d04fe69c4c091d1816e33d9a42f9aca27fe02aac8e7f1ebef12dfafade7924791dd56dce60c2996694c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e997be32f3608b8f9229dc83fd4b51f4485ece1fafb959e3586a7969a081fc295123e3e4a7f10711b456c20657d018b0d3c297be386bbf4dcc2b2ce60a9180", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623f845a882605f9651ac8b8ba2d1fe27f36b12e245c4f83a68793633251cdd7770a0285d8226149898b2a765793440cb03fc83227f4b268172856481fe58691"} 09:17:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:14 INFO - Contents: 09:17:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7acfe49a0f25fc8c06a66f38799a4a56e3e5b55fb67ef2c340279f8945d628c32c096d6a8c0f47b18250e30ae47f27fa17268e31cde55dc6859980c1dac24a4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadb3ce244eb9a6f2a25c378874cb06061741d1726a9d04fe69c4c091d1816e33d9a42f9aca27fe02aac8e7f1ebef12dfafade7924791dd56dce60c2996694c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e997be32f3608b8f9229dc83fd4b51f4485ece1fafb959e3586a7969a081fc295123e3e4a7f10711b456c20657d018b0d3c297be386bbf4dcc2b2ce60a9180", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623f845a882605f9651ac8b8ba2d1fe27f36b12e245c4f83a68793633251cdd7770a0285d8226149898b2a765793440cb03fc83227f4b268172856481fe58691"} 09:17:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:14 INFO - Copying logs to upload dir... 09:17:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.061232 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-10 09:17:14.924162) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:17:14.928431) ========= 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.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7acfe49a0f25fc8c06a66f38799a4a56e3e5b55fb67ef2c340279f8945d628c32c096d6a8c0f47b18250e30ae47f27fa17268e31cde55dc6859980c1dac24a4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadb3ce244eb9a6f2a25c378874cb06061741d1726a9d04fe69c4c091d1816e33d9a42f9aca27fe02aac8e7f1ebef12dfafade7924791dd56dce60c2996694c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e997be32f3608b8f9229dc83fd4b51f4485ece1fafb959e3586a7969a081fc295123e3e4a7f10711b456c20657d018b0d3c297be386bbf4dcc2b2ce60a9180", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623f845a882605f9651ac8b8ba2d1fe27f36b12e245c4f83a68793633251cdd7770a0285d8226149898b2a765793440cb03fc83227f4b268172856481fe58691"} build_url:https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010187 build_url: 'https://queue.taskcluster.net/v1/task/LaC8Pi1XTtO5M2M1WFMpvA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7acfe49a0f25fc8c06a66f38799a4a56e3e5b55fb67ef2c340279f8945d628c32c096d6a8c0f47b18250e30ae47f27fa17268e31cde55dc6859980c1dac24a4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aadb3ce244eb9a6f2a25c378874cb06061741d1726a9d04fe69c4c091d1816e33d9a42f9aca27fe02aac8e7f1ebef12dfafade7924791dd56dce60c2996694c3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1e997be32f3608b8f9229dc83fd4b51f4485ece1fafb959e3586a7969a081fc295123e3e4a7f10711b456c20657d018b0d3c297be386bbf4dcc2b2ce60a9180", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/623f845a882605f9651ac8b8ba2d1fe27f36b12e245c4f83a68793633251cdd7770a0285d8226149898b2a765793440cb03fc83227f4b268172856481fe58691"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 09:17:14.962409) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:17:14.962753) ========= 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.E904Oh9hf4/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.0QaYEV3SHG/Listeners TMPDIR=/var/folders/5d/y16jmjts4012__qrlgssr8zw00000w/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.005340 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 09:17:15.011908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:17:15.012237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 09:17:15.012572) ========= ========= Total master_lag: 0.19 =========