builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0145 starttime: 1489061500.57 results: success (0) buildid: 20170309022424 builduid: 54b790976e4d422394fabbd936258307 revision: da0ea1c722078f30c6f390627d3c680d3556a7a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.571350) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.572340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.572989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.597911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.598266) ========= 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.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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-09 04:11:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.12M=0.002s 2017-03-09 04:11:40 (6.12 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122678 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.744169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.744485) ========= 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.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.022687 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.793603) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:40.793973) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev da0ea1c722078f30c6f390627d3c680d3556a7a6 --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 da0ea1c722078f30c6f390627d3c680d3556a7a6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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-09 04:11:40,880 truncating revision to first 12 chars 2017-03-09 04:11:40,880 Setting DEBUG logging. 2017-03-09 04:11:40,880 attempt 1/10 2017-03-09 04:11:40,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/da0ea1c72207?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 04:11:41,590 unpacking tar archive at: mozilla-central-da0ea1c72207/testing/mozharness/ program finished with exit code 0 elapsedTime=0.971339 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.792371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.793046) ========= script_repo_revision: da0ea1c722078f30c6f390627d3c680d3556a7a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.793421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.793680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 04:11:41.813724) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-09 04:11:41.814363) ========= /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.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:11:42 INFO - MultiFileLogger online at 20170309 04:11:42 in /builds/slave/test 04:11:42 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 04:11:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:42 INFO - {'append_to_log': False, 04:11:42 INFO - 'base_work_dir': '/builds/slave/test', 04:11:42 INFO - 'blob_upload_branch': 'Firefox', 04:11:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:42 INFO - 'branch': 'Firefox', 04:11:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:42 INFO - 'config_files': ('talos/mac_config.py',), 04:11:42 INFO - 'default_actions': ('clobber', 04:11:42 INFO - 'read-buildbot-config', 04:11:42 INFO - 'download-and-extract', 04:11:42 INFO - 'populate-webroot', 04:11:42 INFO - 'create-virtualenv', 04:11:42 INFO - 'install', 04:11:42 INFO - 'run-tests'), 04:11:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:42 INFO - 'download_minidump_stackwalk': True, 04:11:42 INFO - 'download_symbols': 'ondemand', 04:11:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:42 INFO - 'gecko_profile': False, 04:11:42 INFO - 'gecko_profile_interval': 0, 04:11:42 INFO - 'installer_path': 'installer.exe', 04:11:42 INFO - 'log_level': 'info', 04:11:42 INFO - 'log_name': 'talos', 04:11:42 INFO - 'log_to_console': True, 04:11:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:42 INFO - 'opt_config_files': (), 04:11:42 INFO - 'pip_index': False, 04:11:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:42 INFO - 'cmd': ('bash', 04:11:42 INFO - '-c', 04:11:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:42 INFO - 'enabled': True, 04:11:42 INFO - 'halt_on_failure': False, 04:11:42 INFO - 'name': 'check_screen_resolution'},), 04:11:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:42 INFO - 'cmd': ('bash', 04:11:42 INFO - '-c', 04:11:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:42 INFO - 'enabled': True, 04:11:42 INFO - 'halt_on_failure': False, 04:11:42 INFO - 'name': 'check_screen_resolution'},), 04:11:42 INFO - 'run_cmd_checks_enabled': True, 04:11:42 INFO - 'suite': 'dromaeojs-e10s', 04:11:42 INFO - 'system_bits': '32', 04:11:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:42 INFO - 'title': 't-yosemite-r7-0145', 04:11:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:42 INFO - 'use_talos_json': True, 04:11:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:42 INFO - 'work_dir': 'build'} 04:11:42 INFO - [mozharness: 2017-03-09 12:11:42.025233Z] Running clobber step. 04:11:42 INFO - Running pre-action listener: _resource_record_pre_action 04:11:42 INFO - Running main action method: clobber 04:11:42 INFO - rmtree: /builds/slave/test/build 04:11:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:42 INFO - Running post-action listener: _resource_record_post_action 04:11:42 INFO - [mozharness: 2017-03-09 12:11:42.788263Z] Finished clobber step (success) 04:11:42 INFO - [mozharness: 2017-03-09 12:11:42.788461Z] Running read-buildbot-config step. 04:11:42 INFO - Running pre-action listener: _resource_record_pre_action 04:11:42 INFO - Running main action method: read_buildbot_config 04:11:42 INFO - Using buildbot properties: 04:11:42 INFO - { 04:11:42 INFO - "project": "", 04:11:42 INFO - "product": "firefox", 04:11:42 INFO - "script_repo_revision": "production", 04:11:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:11:42 INFO - "repository": "", 04:11:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:11:42 INFO - "buildid": "20170309022424", 04:11:42 INFO - "pgo_build": "False", 04:11:42 INFO - "basedir": "/builds/slave/test", 04:11:42 INFO - "buildnumber": 106, 04:11:42 INFO - "slavename": "t-yosemite-r7-0145", 04:11:42 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:11:42 INFO - "platform": "yosemite_r7", 04:11:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:11:42 INFO - "branch": "mozilla-central", 04:11:42 INFO - "repo_path": "mozilla-central", 04:11:42 INFO - "revision": "da0ea1c722078f30c6f390627d3c680d3556a7a6", 04:11:42 INFO - "stage_platform": "macosx64", 04:11:42 INFO - "builduid": "54b790976e4d422394fabbd936258307", 04:11:42 INFO - "slavebuilddir": "test" 04:11:42 INFO - } 04:11:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:11:42 INFO - Running post-action listener: _resource_record_post_action 04:11:42 INFO - [mozharness: 2017-03-09 12:11:42.794095Z] Finished read-buildbot-config step (success) 04:11:42 INFO - [mozharness: 2017-03-09 12:11:42.794293Z] Running download-and-extract step. 04:11:42 INFO - Running pre-action listener: _resource_record_pre_action 04:11:42 INFO - Running main action method: download_and_extract 04:11:42 INFO - mkdir: /builds/slave/test/build/tests 04:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:11:42 INFO - trying https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:11:42 INFO - Downloading https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/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 04:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/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 04:11:44 INFO - Downloaded 1199 bytes. 04:11:44 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:11:44 INFO - Using the following test package requirements: 04:11:44 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:11:44 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:44 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:11:44 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'jsshell-mac.zip'], 04:11:44 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:11:44 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:11:44 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:11:44 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:11:44 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:11:44 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:11:44 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:44 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:11:45 INFO - Expected file size: 51785363 04:11:45 INFO - Obtained file size: 51785363 04:12:02 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 04:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:12:04 INFO - Expected file size: 51785363 04:12:04 INFO - Obtained file size: 51785363 04:12:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:12:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:12:19 INFO - Fetch https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:12:20 INFO - Expected file size: 14404424 04:12:20 INFO - Obtained file size: 14404424 04:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:20 INFO - trying https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/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 04:12:23 INFO - Downloaded 74933209 bytes. 04:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:23 INFO - mkdir: /builds/slave/test/properties 04:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:23 INFO - Contents: 04:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:12:23 INFO - Running post-action listener: _resource_record_post_action 04:12:23 INFO - Running post-action listener: set_extra_try_arguments 04:12:23 INFO - [mozharness: 2017-03-09 12:12:23.681192Z] Finished download-and-extract step (success) 04:12:23 INFO - [mozharness: 2017-03-09 12:12:23.681333Z] Running populate-webroot step. 04:12:23 INFO - Running pre-action listener: _resource_record_pre_action 04:12:23 INFO - Running main action method: populate_webroot 04:12:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:23 INFO - '--tppagecycles', 04:12:23 INFO - '7'], 04:12:23 INFO - 'tests': ['tsvgm']}}, 04:12:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['damp', 'tps']}, 04:12:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'tests': ['damp', 'tps']}, 04:12:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['dromaeo_dom']}, 04:12:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['basic_compositor_video']}, 04:12:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:12:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['a11yr', 04:12:23 INFO - 'ts_paint', 04:12:23 INFO - 'tpaint', 04:12:23 INFO - 'sessionrestore', 04:12:23 INFO - 'sessionrestore_no_auto_restore', 04:12:23 INFO - 'tabpaint']}, 04:12:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['tsvgx', 04:12:23 INFO - 'tsvgr_opacity', 04:12:23 INFO - 'tart', 04:12:23 INFO - 'tscrollx', 04:12:23 INFO - 'cart', 04:12:23 INFO - 'tsvg_static']}, 04:12:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:23 INFO - 'tsvgr_opacity', 04:12:23 INFO - 'tart', 04:12:23 INFO - 'tscrollx', 04:12:23 INFO - 'cart', 04:12:23 INFO - 'tsvg_static']}, 04:12:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'talos_options': ['--disable-e10s'], 04:12:23 INFO - 'tests': ['tp5o']}, 04:12:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:12:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'talos_options': ['--disable-e10s', 04:12:23 INFO - '--xperf_path', 04:12:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:23 INFO - 'tests': ['tp5n']}, 04:12:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:12:23 INFO - 'talos_options': ['--xperf_path', 04:12:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:23 INFO - 'tests': ['tp5n']}}, 04:12:23 INFO - 'talos.zip': {'path': '', 04:12:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:23 INFO - Running post-action listener: _resource_record_post_action 04:12:23 INFO - [mozharness: 2017-03-09 12:12:23.699476Z] Finished populate-webroot step (success) 04:12:23 INFO - [mozharness: 2017-03-09 12:12:23.699605Z] Running create-virtualenv step. 04:12:23 INFO - Running pre-action listener: _resource_record_pre_action 04:12:23 INFO - Running main action method: create_virtualenv 04:12:23 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:23 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 04:12:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:23 INFO - Using real prefix '/tools/python27' 04:12:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:24 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:27 INFO - Installing pip.................done. 04:12:27 INFO - Return code: 0 04:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:12:27 INFO - Reading from file tmpfile_stdout 04:12:27 INFO - Output received: 04:12:27 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) 04:12:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:27 INFO - 'HOME': '/Users/cltbld', 04:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:27 INFO - 'LOGNAME': 'cltbld', 04:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:27 INFO - 'MOZ_NO_REMOTE': '1', 04:12:27 INFO - 'NO_EM_RESTART': '1', 04:12:27 INFO - 'PAGER': '/bin/cat', 04:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:27 INFO - 'PWD': '/builds/slave/test', 04:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:27 INFO - 'SHELL': '/bin/bash', 04:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:27 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:27 INFO - 'USER': 'cltbld', 04:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:27 INFO - 'XPC_FLAGS': '0x0', 04:12:27 INFO - 'XPC_SERVICE_NAME': '0', 04:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:27 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 04:12:27 INFO - Cleaning up... 04:12:27 INFO - Return code: 0 04:12:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:27 INFO - 'HOME': '/Users/cltbld', 04:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:27 INFO - 'LOGNAME': 'cltbld', 04:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:27 INFO - 'MOZ_NO_REMOTE': '1', 04:12:27 INFO - 'NO_EM_RESTART': '1', 04:12:27 INFO - 'PAGER': '/bin/cat', 04:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:27 INFO - 'PWD': '/builds/slave/test', 04:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:27 INFO - 'SHELL': '/bin/bash', 04:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:27 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:27 INFO - 'USER': 'cltbld', 04:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:27 INFO - 'XPC_FLAGS': '0x0', 04:12:27 INFO - 'XPC_SERVICE_NAME': '0', 04:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:28 INFO - Downloading/unpacking psutil>=3.1.1 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:28 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 04:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:32 INFO - Installing collected packages: psutil 04:12:32 INFO - Running setup.py install for psutil 04:12:32 INFO - building 'psutil._psutil_osx' extension 04:12:32 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 04:12:32 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 04:12:32 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 04:12:32 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 04:12:32 INFO - building 'psutil._psutil_posix' extension 04:12:32 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 04:12:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:12:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:12:32 INFO - ^ 04:12:32 INFO - 1 warning generated. 04:12:32 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 04:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:32 INFO - Successfully installed psutil 04:12:32 INFO - Cleaning up... 04:12:32 INFO - Return code: 0 04:12:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:32 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:32 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 04:12:32 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 04:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:32 INFO - 'HOME': '/Users/cltbld', 04:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:32 INFO - 'LOGNAME': 'cltbld', 04:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:32 INFO - 'MOZ_NO_REMOTE': '1', 04:12:32 INFO - 'NO_EM_RESTART': '1', 04:12:32 INFO - 'PAGER': '/bin/cat', 04:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:32 INFO - 'PWD': '/builds/slave/test', 04:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:32 INFO - 'SHELL': '/bin/bash', 04:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:32 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:32 INFO - 'USER': 'cltbld', 04:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:32 INFO - 'XPC_FLAGS': '0x0', 04:12:32 INFO - 'XPC_SERVICE_NAME': '0', 04:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:33 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 04:12:33 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 04:12:33 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 04:12:33 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 04:12:33 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 04:12:33 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 04:12:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:35 INFO - Installing collected packages: mozsystemmonitor 04:12:35 INFO - Running setup.py install for mozsystemmonitor 04:12:36 INFO - Successfully installed mozsystemmonitor 04:12:36 INFO - Cleaning up... 04:12:36 INFO - Return code: 0 04:12:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:36 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:36 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 04:12:36 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 04:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:36 INFO - 'HOME': '/Users/cltbld', 04:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:36 INFO - 'LOGNAME': 'cltbld', 04:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:36 INFO - 'MOZ_NO_REMOTE': '1', 04:12:36 INFO - 'NO_EM_RESTART': '1', 04:12:36 INFO - 'PAGER': '/bin/cat', 04:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:36 INFO - 'PWD': '/builds/slave/test', 04:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:36 INFO - 'SHELL': '/bin/bash', 04:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:36 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:36 INFO - 'USER': 'cltbld', 04:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:36 INFO - 'XPC_FLAGS': '0x0', 04:12:36 INFO - 'XPC_SERVICE_NAME': '0', 04:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 INFO - Downloading/unpacking jsonschema==2.5.1 04:12:37 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 04:12:37 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 04:12:37 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 04:12:37 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 04:12:37 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 04:12:37 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 04:12:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:40 INFO - warning: no files found matching '*.txt' 04:12:40 INFO - no previously-included directories found matching 'build' 04:12:40 INFO - no previously-included directories found matching 'dist' 04:12:40 INFO - no previously-included directories found matching '.git*' 04:12:40 INFO - Installing collected packages: jsonschema, functools32 04:12:40 INFO - Running setup.py install for functools32 04:12:40 INFO - warning: no files found matching '*.txt' 04:12:40 INFO - no previously-included directories found matching 'build' 04:12:40 INFO - no previously-included directories found matching 'dist' 04:12:40 INFO - no previously-included directories found matching '.git*' 04:12:40 INFO - Successfully installed jsonschema functools32 04:12:40 INFO - Cleaning up... 04:12:40 INFO - Return code: 0 04:12:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:40 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 04:12:40 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 04:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:40 INFO - 'HOME': '/Users/cltbld', 04:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:40 INFO - 'LOGNAME': 'cltbld', 04:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:40 INFO - 'MOZ_NO_REMOTE': '1', 04:12:40 INFO - 'NO_EM_RESTART': '1', 04:12:40 INFO - 'PAGER': '/bin/cat', 04:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:40 INFO - 'PWD': '/builds/slave/test', 04:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:40 INFO - 'SHELL': '/bin/bash', 04:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:40 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:40 INFO - 'USER': 'cltbld', 04:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:40 INFO - 'XPC_FLAGS': '0x0', 04:12:40 INFO - 'XPC_SERVICE_NAME': '0', 04:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:40 INFO - Cleaning up... 04:12:40 INFO - Return code: 0 04:12:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:40 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:40 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 04:12:40 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 04:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:40 INFO - 'HOME': '/Users/cltbld', 04:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:40 INFO - 'LOGNAME': 'cltbld', 04:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:40 INFO - 'MOZ_NO_REMOTE': '1', 04:12:40 INFO - 'NO_EM_RESTART': '1', 04:12:40 INFO - 'PAGER': '/bin/cat', 04:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:40 INFO - 'PWD': '/builds/slave/test', 04:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:40 INFO - 'SHELL': '/bin/bash', 04:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:40 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:40 INFO - 'USER': 'cltbld', 04:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:40 INFO - 'XPC_FLAGS': '0x0', 04:12:40 INFO - 'XPC_SERVICE_NAME': '0', 04:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:43 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 04:12:43 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 04:12:43 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 04:12:43 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 04:12:43 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 04:12:43 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 04:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:44 INFO - Downloading docopt-0.6.1.tar.gz 04:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:45 INFO - Running setup.py install for blobuploader 04:12:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:45 INFO - Running setup.py install for requests 04:12:45 INFO - Running setup.py install for docopt 04:12:45 INFO - Successfully installed blobuploader requests docopt 04:12:45 INFO - Cleaning up... 04:12:45 INFO - Return code: 0 04:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:45 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')]} 04:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 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')]} 04:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:45 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 04:12:45 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 04:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:45 INFO - 'HOME': '/Users/cltbld', 04:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:45 INFO - 'LOGNAME': 'cltbld', 04:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:45 INFO - 'MOZ_NO_REMOTE': '1', 04:12:45 INFO - 'NO_EM_RESTART': '1', 04:12:45 INFO - 'PAGER': '/bin/cat', 04:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:45 INFO - 'PWD': '/builds/slave/test', 04:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:45 INFO - 'SHELL': '/bin/bash', 04:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:45 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:45 INFO - 'USER': 'cltbld', 04:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:45 INFO - 'XPC_FLAGS': '0x0', 04:12:45 INFO - 'XPC_SERVICE_NAME': '0', 04:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-7d1bfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-BkNuZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-O5rc8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-RwdQmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-e6vgaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-cwJH12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-w7304h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:46 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-OLVKtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-q7n8pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Ed0Udy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-iWotJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-nI68bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-1y_I2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-XEuvdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-KU6YCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gBj7LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:47 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-UFjopW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:48 INFO - Running setup.py install for manifestparser 04:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozcrash 04:12:48 INFO - Running setup.py install for mozdebug 04:12:48 INFO - Running setup.py install for mozdevice 04:12:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozfile 04:12:48 INFO - Running setup.py install for mozhttpd 04:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:48 INFO - Running setup.py install for mozinfo 04:12:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozInstall 04:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozleak 04:12:49 INFO - Running setup.py install for mozlog 04:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for moznetwork 04:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozprocess 04:12:49 INFO - Running setup.py install for mozprofile 04:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:49 INFO - Running setup.py install for mozrunner 04:12:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Running setup.py install for mozscreenshot 04:12:50 INFO - Running setup.py install for moztest 04:12:50 INFO - Running setup.py install for mozversion 04:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:50 INFO - Cleaning up... 04:12:50 INFO - Return code: 0 04:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:50 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:50 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 04:12:50 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 04:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:50 INFO - 'HOME': '/Users/cltbld', 04:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:50 INFO - 'LOGNAME': 'cltbld', 04:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:50 INFO - 'MOZ_NO_REMOTE': '1', 04:12:50 INFO - 'NO_EM_RESTART': '1', 04:12:50 INFO - 'PAGER': '/bin/cat', 04:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:50 INFO - 'PWD': '/builds/slave/test', 04:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:50 INFO - 'SHELL': '/bin/bash', 04:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:50 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:50 INFO - 'USER': 'cltbld', 04:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:50 INFO - 'XPC_FLAGS': '0x0', 04:12:50 INFO - 'XPC_SERVICE_NAME': '0', 04:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:50 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-WOLt1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-bcv9g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CwUfWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-5j8zL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-UzGlOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Fdy_Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-uSH9Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ZnNvC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-hCbpeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CjYs72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:51 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)) 04:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:51 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gYLSHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-U8FR3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vDoFMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-6yOQT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-9nA1xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-85azBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:52 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)) 04:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:52 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-qIHsnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:52 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)) 04:12:52 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)) 04:12:52 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)) 04:12:52 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)) 04:12:52 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)) 04:12:52 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)) 04:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:55 INFO - Downloading blessings-1.6.tar.gz 04:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:55 INFO - Installing collected packages: blessings 04:12:55 INFO - Running setup.py install for blessings 04:12:55 INFO - Successfully installed blessings 04:12:55 INFO - Cleaning up... 04:12:55 INFO - Return code: 0 04:12:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:55 INFO - Reading from file tmpfile_stdout 04:12:55 INFO - Current package versions: 04:12:55 INFO - blessings == 1.6 04:12:55 INFO - blobuploader == 1.2.4 04:12:55 INFO - docopt == 0.6.1 04:12:55 INFO - functools32 == 3.2.3-2 04:12:55 INFO - jsonschema == 2.5.1 04:12:55 INFO - manifestparser == 1.1 04:12:55 INFO - mozInstall == 1.12 04:12:55 INFO - mozcrash == 1.0 04:12:55 INFO - mozdebug == 0.1 04:12:55 INFO - mozdevice == 0.49 04:12:55 INFO - mozfile == 1.2 04:12:55 INFO - mozhttpd == 0.7 04:12:55 INFO - mozinfo == 0.9 04:12:55 INFO - mozleak == 0.1 04:12:55 INFO - mozlog == 3.4 04:12:55 INFO - moznetwork == 0.27 04:12:55 INFO - mozprocess == 0.25 04:12:55 INFO - mozprofile == 0.28 04:12:55 INFO - mozrunner == 6.13 04:12:55 INFO - mozscreenshot == 0.1 04:12:55 INFO - mozsystemmonitor == 0.3 04:12:55 INFO - moztest == 0.8 04:12:55 INFO - mozversion == 1.4 04:12:55 INFO - psutil == 3.1.1 04:12:55 INFO - requests == 1.2.3 04:12:55 INFO - wsgiref == 0.1.2 04:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:55 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')]} 04:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:55 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')]} 04:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:55 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:55 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 04:12:55 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 04:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:55 INFO - 'HOME': '/Users/cltbld', 04:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:55 INFO - 'LOGNAME': 'cltbld', 04:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:55 INFO - 'MOZ_NO_REMOTE': '1', 04:12:55 INFO - 'NO_EM_RESTART': '1', 04:12:55 INFO - 'PAGER': '/bin/cat', 04:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:55 INFO - 'PWD': '/builds/slave/test', 04:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:55 INFO - 'SHELL': '/bin/bash', 04:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:55 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:55 INFO - 'USER': 'cltbld', 04:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:55 INFO - 'XPC_FLAGS': '0x0', 04:12:55 INFO - 'XPC_SERVICE_NAME': '0', 04:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 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)) 04:12:56 INFO - Cleaning up... 04:12:56 INFO - Return code: 0 04:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:56 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')]} 04:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:56 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')]} 04:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:56 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 0x105be5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105be8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9888583710>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, '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.YNNfMAwxpS/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.adCELVVAZV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 04:12:56 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 04:12:56 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 04:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:56 INFO - 'HOME': '/Users/cltbld', 04:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:56 INFO - 'LOGNAME': 'cltbld', 04:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:56 INFO - 'MOZ_NO_REMOTE': '1', 04:12:56 INFO - 'NO_EM_RESTART': '1', 04:12:56 INFO - 'PAGER': '/bin/cat', 04:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:56 INFO - 'PWD': '/builds/slave/test', 04:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:56 INFO - 'SHELL': '/bin/bash', 04:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:12:56 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:56 INFO - 'USER': 'cltbld', 04:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:56 INFO - 'XPC_FLAGS': '0x0', 04:12:56 INFO - 'XPC_SERVICE_NAME': '0', 04:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:56 INFO - Cleaning up... 04:12:56 INFO - Return code: 0 04:12:56 INFO - Running post-action listener: _resource_record_post_action 04:12:56 INFO - Running post-action listener: _start_resource_monitoring 04:12:56 INFO - Starting resource monitoring. 04:12:56 INFO - [mozharness: 2017-03-09 12:12:56.551048Z] Finished create-virtualenv step (success) 04:12:56 INFO - [mozharness: 2017-03-09 12:12:56.552118Z] Running install step. 04:12:56 INFO - Running pre-action listener: _resource_record_pre_action 04:12:56 INFO - Running main action method: install 04:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:56 INFO - Reading from file tmpfile_stdout 04:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:56 INFO - Reading from file tmpfile_stdout 04:12:56 INFO - Output received: 04:12:56 INFO - Usage: mozinstall [options] installer 04:12:56 INFO - Options: 04:12:56 INFO - -h, --help show this help message and exit 04:12:56 INFO - -d DEST, --destination=DEST 04:12:56 INFO - Directory to install application into. [default: 04:12:56 INFO - "/builds/slave/test"] 04:12:56 INFO - --app=APP Application being installed. [default: firefox] 04:12:56 INFO - mkdir: /builds/slave/test/build/application 04:12:56 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'] 04:12:56 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 04:13:17 INFO - Reading from file tmpfile_stdout 04:13:17 INFO - Output received: 04:13:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:13:17 INFO - Running post-action listener: _resource_record_post_action 04:13:17 INFO - [mozharness: 2017-03-09 12:13:17.308288Z] Finished install step (success) 04:13:17 INFO - [mozharness: 2017-03-09 12:13:17.308442Z] Running run-tests step. 04:13:17 INFO - Running pre-action listener: _resource_record_pre_action 04:13:17 INFO - Running main action method: run_tests 04:13:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:13:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:13:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:13:17 INFO - 2017-03-09 04:13:17.323 screenresolution[11597:236091] starting screenresolution argv=screenresolution get 04:13:17 INFO - 2017-03-09 04:13:17.326 screenresolution[11597:236091] Display 0: 1600x1200x32@60 04:13:17 INFO - 2017-03-09 04:13:17.332 screenresolution[11598:236093] starting screenresolution argv=screenresolution list 04:13:17 INFO - Available Modes on Display 0 04:13:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:13:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:13:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:13:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:13:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:13:17 INFO - Intel Iris: 04:13:17 INFO - Chipset Model: Intel Iris 04:13:17 INFO - Type: GPU 04:13:17 INFO - Bus: Built-In 04:13:17 INFO - VRAM (Dynamic, Max): 1536 MB 04:13:17 INFO - Vendor: Intel (0x8086) 04:13:17 INFO - Device ID: 0x0a2e 04:13:17 INFO - Revision ID: 0x0009 04:13:17 INFO - Displays: 04:13:17 INFO - Display: 04:13:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:13:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:13:17 INFO - Display Serial Number: 1600x1200 60 04:13:17 INFO - Main Display: Yes 04:13:17 INFO - Mirror: Off 04:13:17 INFO - Online: Yes 04:13:17 INFO - Rotation: Supported 04:13:17 INFO - Return code: 0 04:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:17 INFO - Python 2.7.3 04:13:17 INFO - Return code: 0 04:13:17 INFO - grabbing minidump binary from tooltool 04:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:13:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1059c3d30>, '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 0x1058eadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1059b8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:13:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:13:17 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:13:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:17 INFO - Return code: 0 04:13:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:13:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:17 INFO - ENV: RUST_BACKTRACE is now 1 04:13:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:13:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 04:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --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 04:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YNNfMAwxpS/Render', 04:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:17 INFO - 'HOME': '/Users/cltbld', 04:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:17 INFO - 'LOGNAME': 'cltbld', 04:13:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:17 INFO - 'MOZ_NO_REMOTE': '1', 04:13:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:17 INFO - 'NO_EM_RESTART': '1', 04:13:17 INFO - 'PAGER': '/bin/cat', 04:13:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:17 INFO - 'PWD': '/builds/slave/test', 04:13:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:17 INFO - 'RUST_BACKTRACE': '1', 04:13:17 INFO - 'SHELL': '/bin/bash', 04:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.adCELVVAZV/Listeners', 04:13:17 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 04:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:17 INFO - 'USER': 'cltbld', 04:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:17 INFO - 'XPC_FLAGS': '0x0', 04:13:17 INFO - 'XPC_SERVICE_NAME': '0', 04:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:17 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/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 04:13:17 INFO - mozversion application_buildid: 20170309022424 04:13:17 INFO - mozversion application_changeset: da0ea1c722078f30c6f390627d3c680d3556a7a6 04:13:17 INFO - mozversion application_display_name: Nightly 04:13:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:17 INFO - mozversion application_name: Firefox 04:13:17 INFO - mozversion application_remotingname: firefox 04:13:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:13:17 INFO - mozversion application_vendor: Mozilla 04:13:17 INFO - mozversion application_version: 55.0a1 04:13:17 INFO - mozversion platform_buildid: 20170309022424 04:13:17 INFO - mozversion platform_changeset: da0ea1c722078f30c6f390627d3c680d3556a7a6 04:13:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:13:17 INFO - mozversion platform_version: 55.0a1 04:13:17 INFO - using testdate: 1489061597 04:13:17 INFO - actual date: 1489061597 04:13:17 INFO - starting webserver on 'localhost:49880' 04:13:17 INFO - SUITE-START | Running 2 tests 04:13:17 INFO - TEST-START | dromaeo_css 04:13:17 INFO - operating with platform_type : mac_ 04:13:17 INFO - Initialising browser for dromaeo_css test... 04:13:17 INFO - TEST-INFO | started process 11608 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpukHE5A/profile http://localhost:49880/getInfo.html) 04:13:21 INFO - PROCESS | 11608 | 2017-03-09 04:13:21.383 plugin-container[11611:236271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x484b, name = 'com.apple.tsm.portname' 04:13:21 INFO - PROCESS | 11608 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:21 INFO - PROCESS | 11608 | 2017-03-09 04:13:21.385 plugin-container[11611:236271] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 04:13:21 INFO - PROCESS | 11608 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:21 INFO - PROCESS | 11608 | 2017-03-09 04:13:21.385 plugin-container[11611:236271] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:21 INFO - PROCESS | 11608 | __metrics Screen width/height:1600/1200 04:13:21 INFO - PROCESS | 11608 | colorDepth:24 04:13:21 INFO - PROCESS | 11608 | Browser inner width/height: 1024/689 04:13:21 INFO - PROCESS | 11608 | __metrics 04:13:21 ERROR - PROCESS | 11608 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:13:22 INFO - TEST-INFO | 11608: exit 0 04:13:22 INFO - Browser initialized. 04:13:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:22 INFO - TEST-INFO | started process 11613 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpukHE5A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:24 INFO - PROCESS | 11613 | 2017-03-09 04:13:24.914 plugin-container[11614:236403] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 04:13:24 INFO - PROCESS | 11613 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:24 INFO - PROCESS | 11613 | 2017-03-09 04:13:24.917 plugin-container[11614:236403] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 04:13:24 INFO - PROCESS | 11613 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:13:24 INFO - PROCESS | 11613 | 2017-03-09 04:13:24.917 plugin-container[11614:236403] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:13:34 INFO - PROCESS | 11613 | RSS: Main: 228507648 04:13:34 INFO - PROCESS | 11613 | 04:16:38 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49880/tests/dromaeo/cssquery-ext.html) 04:16:40 INFO - PROCESS | 11613 | RSS: Main: 250343424 04:16:40 INFO - PROCESS | 11613 | 04:18:23 INFO - PROCESS | 11613 | ************************* 04:18:23 INFO - PROCESS | 11613 | A coding exception was thrown and uncaught in a Task. 04:18:23 INFO - PROCESS | 11613 | 04:18:23 ERROR - PROCESS | 11613 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:18:23 INFO - PROCESS | 11613 | Full stack: 04:18:23 INFO - PROCESS | 11613 | ************************* 04:19:42 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-ext.html (next: http://localhost:49880/tests/dromaeo/cssquery-jquery.html) 04:19:43 INFO - PROCESS | 11613 | RSS: Main: 258981888 04:19:43 INFO - PROCESS | 11613 | 04:22:45 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49880/tests/dromaeo/cssquery-mootools.html) 04:22:46 INFO - PROCESS | 11613 | RSS: Main: 270942208 04:22:46 INFO - PROCESS | 11613 | 04:25:48 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49880/tests/dromaeo/cssquery-prototype.html) 04:25:48 INFO - PROCESS | 11613 | RSS: Main: 263200768 04:25:48 INFO - PROCESS | 11613 | 04:28:52 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49880/tests/dromaeo/cssquery-yui.html) 04:28:52 INFO - PROCESS | 11613 | RSS: Main: 273489920 04:28:52 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | Cycle 1(1): loaded http://localhost:49880/tests/dromaeo/cssquery-yui.html (next: http://localhost:49880/tests/dromaeo/cssquery-dojo.html) 04:31:55 INFO - PROCESS | 11613 | RSS: Main: 267440128 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | __start_tp_report 04:31:55 INFO - PROCESS | 11613 | _x_x_mozilla_page_load 04:31:55 INFO - PROCESS | 11613 | _x_x_mozilla_page_load_details 04:31:55 INFO - PROCESS | 11613 | |i|pagename|runs| 04:31:55 INFO - PROCESS | 11613 | |0;dojo.html;3207.6311224209217;3462.221000274937;3482.8084455354947;3501.124718820295;3506.789592624442;4832.130216561018;4883.316335713003;5576.665400075998;5894.2042824218715;6115.082737589364;6131.9884064911685;6132.294322189902;6139.662318572477;6142.529470848967;6179.5674302798825;5343.919841202385;5404.567634589223;5503.532199763015;5506.779728810843;5598.972005139969;5494.36814766301;5536.612437129403;5537.0863807471715;5543.944560554403;5567.192757050226;5388.973055134719;5436.673799572039;5518.392976772552;5540.778368865241;5576.219329293902;5441.347038355423;5459.317585301837;5461.590380721422;5462.644928079662;5467.617266791326;5247.265382846366;5457.672539647634;5476.151196564499;5494.395616482184;5508.394076651565;5016.3227964224725;5164.715940623264;5965.313988891289;6097.57316987811;6124.258880972529;6450.193725784277;6456.451201647866;6468.159139311906;6473.93526064738;6478.4169424752;5890.234269544974;6023.82557878174;6571.342865713438;6590.967045164792;6617.437517810992;5977.581569290108;5989.850253743648;6092.390760923872;6105.389461053948;6251.218597675291;6550.377714117151;6552.508561857784;6594.439472644879;6625.436837868739;6666.633335166515;6205.937940620626;6252.124702541648;6290.2766181889665;6323.336049714806;6377.74489020434;5502.449755024546;6460.806175814733;6511.902321465182;6539.771108011197;6550.410463058348;6260.373962603794;6424.935750642528;6434.260060093149;6446.580972236883;6447.065175549519;5269.367675878919;6311;6325.620462772156;6375.872482550323;6412.615243085336;5153.819616313411;5206.739663016834;5219.582433405319;5231.189165679326;5265.605079619044;4617.907641847211;4632.884177895579;4646.697964632355;4654.325122857234;4681.227597446383;6115.571909966259;6126.426068710516;6130.846728831726;6190.659513726699;6196.938030619726;6512.413882750575;6560.770373036921;6577.901331480031;6588.143541339595;6588.703508342136;6181.690915454209;6209.161763162006;6232.283287421914;6246.750649870044;6282.4974002079725;5573.275474188411;5583.35791383996;5634.408387119375;5640.802571909963;5744.569157313134;6627.138471998705;6672.132622759011;6700.329967003456;6701.296363881917;6720.227173875067;6536.444402225864;6538.051982462422;6540.901886471612;6544.345565443417;6550.082988381726;6515.706793194223;6559.376859198369;6646.368594983469;6696.430803381767;6742.6291553965;6315.400036996478;6338.556301058881;6378.362163783585;6395.872082558416;6420.7431702731365;5843.29880414353;5895.793647222498;6515.706793194412;6546.247181573989;6548.410643042149;6135.1408007826785;6176;6206.751729930752;6214.130021796862;6290.339514350927;6291.087792270004;6320.968395157995;6322.49420046386;6325.399087086719;6355.713992870239;4971.751412429437;5740.655560666373;6140.9030504681905;6163.582376053622;6205.410486003822;5194.922076168936;6162.568620196544;6298.1812364392335;6315.368463153648;6318.652474113968;6283.685815709105;6297.307296197323;6311.084892690626;6316.62100273985;6317.778877739257 04:31:55 INFO - PROCESS | 11613 | |1;ext.html;772.3242163107282;828.8715249136386;833.8290650416665;856.4347530629784;879.890013748281;29607.40785184295;39444.40833387501;39463;39538.8023059885;39539.011524711896;37615.811920940425;38211;38432.423513647314;38651.22697546047;38787.41818872719;6810.795676129712;7382.224866389032;7531.246875312452;7823.726169584065;10768.515416806224;11023.61417350393;11043.006129448348;11137.387443690593;11140.108791296718;11152.888471115306;10195.643152489665;10415.843762343571;11122.666320010372;11168.944155279252;11170.497327620276;11046.613368532062;11100.888991110067;11139.498722557504;11147.386893720843;11169.329840209532;10777.62278320255;10823.296485728402;10839.83740243897;10846.891531084668;10848.457577121113;38573.42139867904;38578.614213857785;38831.61168388308;38854.61145388538;38938.22123557513;3244.5619841321354;3813.2564149990762;3823.8661646842506;3854.3447613905705;3990.541087774914;23047.654285185567;27713.722862771316;27867.721322786714;28105.437891242265;28480.572791408147;3101.4882544380152;3138.3865717395392;3169.9683003170135;3191.4255434021866;3257.3485302939507;337680;340569;342583;342898;344569;42779.36375408063;43464;49807.750961245685;50699.746501267255;51868.740656296475;41817.95455113646;46805.06389872252;53720;53813.92372152535;53842.15420612164;13628.65928351799;13737.107088039445;13742.519011834538;13762.105463145064;13763.243021633705;10897.346159230314;10980.341179529254;11037.558497660164;11060.004599586076;11073.114150867912;12730;12871.163374380636;12895.548655797002;12962.092653514352;13015.414306356237;4801.95198048022;5123.359580052494;5297.125974214288;5345.1982202669915;5364.436734142937;1083.4203701019917;1098.1379617000775;1114.1532435349193;1126.9770761483157;1162.8255461983288;25876.353091172496;25948.74051259463;26191.607125893126;26203.73796262051;26308;1173.700706319883;1207.6799648093263;1213.4114954247184;1217.6103646833105;1265.7278685082752;11592.710182245342;13657.863421365857;13663;16119;16409.58976025585;450626;451735;452259;452462;468104.6594767004;58531.70734146302;58898.41101589015;58946.11580826291;58973.705131474926;59121;1402.7825687018528;1440.6110350205386;1446.4575784080969;1446.7178900114377;1447.6815100677834;28732.138035858123;29017.564736528548;29289.85355073211;29866.552001720425;29940;45858.77070614626;45865;45923;46040;46653.066938661716;421926;423016;423103;423152;425791;26599.468010640066;27957.580636290066;31487.008734170216;33086.51110699976;33255.833720831244;41273.96815079647;43127.35308970431;43419.56580434155;43453.348199776396;43879;35600.821995889855;35677.1080722984;35975.460368093976;36734;37222.44166337561;35247;35498.467522987696;36459.90620281396;36600.63399365972;37471;34781.13047173841;35075.82462087673;36039.27921441609;36227.91316260411;36582.8170859144;23207.88396058009;30301.696983029888;30348.965103489474;31834.52248216325;31951;24101.879490602434;24141;24162.75837241605;24452.266432006356;24503.264902052968 04:31:55 INFO - PROCESS | 11613 | |2;jquery.html;398.7746922988511;403.29624804715775;404.5125623623533;412.92360913231045;433.95443478434765;20813.375598732044;20896.89551552244;21534;21880.45298867529;22181.445463863412;21124.83813390263;21306.57386852262;21687.02408391622;21718.348449546498;21846.890765546188;6545.541812073145;6845.247022827485;6899.724011039552;6904.585724856524;6920.930790692079;6688.431483323923;7247.891281630754;7617.5048621839405;7721.22787721229;7777.572233527182;7257.528260663066;7519.13529944058;7740.187280335568;7742.574158421285;7758.961205193966;7443.85112297751;7625.580593067379;7629.580373079479;7680.692772289101;7691.9230807691765;7363.77908662741;7468.85062298751;7480.775576732653;7492.925070749277;7496.925030749677;22906.54186916269;27257.86371068152;27507.17478475649;27663.723362766315;28416;2838.8580570971576;2874.3389020525187;3297.1757060734817;3309.9172520687175;3414.6756058174433;16233.918830405772;16357.67284654312;16590.50228493147;17228.176110689026;17513;1904.4096330137702;1929.536911141316;2025.9392218233477;2116.5661039486868;2145.517258616814;125990;147094;150946;154589;155818.22090889586;21900.671489927663;22417.292368602775;22603.773962260497;23127.3061808146;23315.987062781584;35474.46788298178;35555.28889422197;35626.643733562334;35820.746273880286;36138.27723445516;9358.719238422858;10237.7440563985;10504;10696.732581685364;10914.945425272981;7579.924200758032;8473.237408633253;8591.871121933176;8730.607122679368;8905.287576993825;8793.757591814046;8828.8675669865;10478.37129772216;10565.75682382134;10834.837477437844;3888.786116763605;4152.750834949913;4265.3815196796295;4285.700000999963;4306.375575541591;974.9415035097917;1013.9239557033252;1041.3439533094102;1049.4123290957089;1090.3566895531517;22194.44513887166;22278.331650050524;22586.661200082013;22609;22630;903.2818908967387;906.40177482861;965.0494263150791;977.8044391121804;1081.2863510083307;11733.706657333465;11893.821592676117;12419;12999.610011699664;13439.798403023962;696055;698481;707633;722671;726348;155627;158714.20642896942;159379.67133779763;160716;168556;957.4973139101888;1270.0259337356806;1298.727267273864;1312.8030795380578;1332.1740520877117;18189.272429102686;20784.064717087465;21347.7865221352;21415.250466233607;21446.89276553607;46059;61476;61540.69229653823;62228;63181.68409157925;88130.55934720286;89266.10733892578;89404;89868.55065724629;90927;10414.427206503715;11517;11912.880871191177;11919.04647628205;12252.632421027383;12938.805917911051;13162.60512184636;13170.868291316965;13507.864921350661;13521.18872867631;8155.83688326242;11095.889041109485;11531.654050378502;11700.239484433485;11764.411779411166;11119.332840029625;11285.548578056785;11392.430378480876;11479.598214062467;11684.766304674029;11435.714107147387;11507.712307192052;11896;11926.821097683714;11985.101117416054;11649.883501165219;11673.941630292135;11912.40437978115;11955.64133076009;12359.69100772488;9550.283728720235;9953.113597056772;10448.68653940383;11086.390248536085;11553.862535430972 04:31:55 INFO - PROCESS | 11613 | |3;mootools.html;1467.1343907094817;1553.2777258574768;1555.5955451582586;1590.562595286296;1599.9760003599947;9354.438733675985;9626.807463850737;10563.630272940449;11183.608573699912;11225.831612525808;10437.478126093703;10802.891971080287;10991.670249892495;11031.338119712824;11056.668299951014;2324.2097686786487;2373.632087026505;2376.9286921392386;2378.3816207785926;2383.7735415135535;2324.384038229862;2337.053493335202;2337.602607556711;2362.3149286706835;2363.61000434928;2322.314917099451;2330.1262026739973;2334.708161479815;2347.7652234776556;2354.9058037678474;2265.150568536799;2302.735185453669;2316.1198744477074;2321.3268152235914;2322.280093171122;2283.8401311908174;2320.9187678431344;2341.3678306857223;2341.8594884306995;2347.8239132065164;11012.229143959927;11062.834057489144;11112.222144449892;11116.555337786478;11146.21976461648;5510.256115424407;5632.831015069554;5779.826605201851;5829.766809327622;5837.416258374171;3205.2627895583914;3363.704973585163;3534.929301413983;3647.452882067711;3672.4010469739537;1114.832775083736;1176.8999635030948;1236.8824961628632;1240.9565665201674;1780.8842425242447;12880.677983050406;15252.161131137784;15309.464168754152;15518.689626207413;15534.844651553452;4672.112298663243;4748.382710247645;4749.1926372516755;4796.904061918812;4953.90092198154;11642.476088576035;11664.94167529157;11701;11774.234674746114;11829.645110646694;5593.608447408724;5739.282589676291;5828.242328497353;5829.47534721877;5836.474717275466;3273.6562660920736;4637.976810115995;4645.094206629742;5169.017886601609;5278.709670968057;3786.4888240087234;3838.500994870649;3872.6127387261613;3959.366501359769;3973.463582416337;1021.22897212604;1030.5723124903232;1036.2849633752687;1048.4233671480656;1049.6746008737164;790.8378782349605;849.5285116760257;862.1335557764406;893.4683863101444;895.9328050396247;5404.351477822686;6077.848053798691;6377.5216858735785;6441.259255185713;6739.293388636231;863.2921004776024;1007.6120693532896;1024.4570377699831;1027.712240572641;1028.3469996552244;3763.9059023524633;4199.286121359376;4208.642265407475;4303.483581970184;4338.132373525307;13029.804552931713;13486.730265394637;13607.727845443036;13627.318634068257;13628;12930.806037909251;13083.084184107021;13393.263370514715;13489.730205396034;13542.864571354357;9814.75463113428;9903.900960990299;9992.400455972665;10065.647702330383;10162.237832162617;6445.613263204223;6550.901736474052;6554.442872355712;6593.340665933369;6684.0642310075655;9930;10838.891611084104;11866.762664746484;12206.572769953364;12301.815472767737;12202.938985305016;12351.752964940471;12481.313527756061;12509.061820363328;12688.302143382203;8065.919340806751;8386.790330241549;9169.862452063358;9253.629854805733;9398.624055037722;9880.802383952425;10243.282970192015;10388.636397726346;10391.844122338322;10414.791704166026;8994;9070.591823367833;9107.22588579978;9130.543472826199;9216.631334746804;8962.865557016781;9029.77425564366;9111.772205694646;9307.534623268673;9327.927288361654;7835.098963619257;7843.960780196063;7870.921290787019;7937.801554961172;7938.6030698466;5155.304033955368;5220.895582088413;5296.602754793483;5794.536437084938;5895.29256489224;5183.481651834937;5203.705172960928;5282.81510147143;5439.918401224064;5591 04:31:55 INFO - PROCESS | 11613 | |4;prototype.html;364.63354328899453;370.4258399480804;376.69111328710466;382.4760078692192;389.9220155968806;4798.592119669832;4837.443693975194;5222.71275079871;5413.702246376448;5458.590605704573;4085.836566537335;4829.619266513446;4983.825566105178;4996.725834912101;5213.201445501306;3884.8834534963926;4443.289073748201;4458.464984201884;4462.679406708509;4472.46330440346;3917;4466.865994020169;4476.798544065525;4481.865544033684;4591.852036990752;3920.45170639084;3984.665137179034;4053.209624123297;4210.873673789792;4694.413198350207;3890.8521986014193;4315.697901146921;4571.160225410655;4657.767111644438;4701.7414042227665;3810.542734871833;3838.846446142179;4073.959260407388;4103.9179216415805;4394.318880573516;4500.727132797949;4700.365450664151;4945.406551213878;5043.646944713872;5185.662931909414;4484.686071974963;4576.771161441915;5123.795048198068;5356.6518176318805;5385.8114965976;4173.64524015459;5400.891982160335;5690.459406356389;5768.336641286264;5778.971105144489;4554.635629149693;4656.348111264426;4821.397325334333;4863.659543831933;4953.851384458472;5202.583793296527;5357.946420535823;5872.412758724094;6151.415615516519;6155.661438620874;4693.775601958197;4853.344798452164;4881.536254055859;5035.77339019745;5088.236764485357;4913.828016019422;5020.874478138003;5149.021685879671;5163.741812909415;5182.507661772125;4455.732656040648;4472.904138486027;5002.89994200114;5097;5340.385855626575;5076.93384389275;5446.673199608036;5550.944490555124;5649.378568357477;5743.261809007502;1546.984530154684;1592.6018495376156;1687.8480936715755;1764.54121928297;1777.795553511337;1382.3019375215451;1439.2012433099521;1452.0706747681493;1457.9781303280458;1480.9337277160428;4404.405405270248;4582.747948862778;4655.348251244828;4865.416150061945;5307.495787900143;5062.898742025139;5329.520343169133;5732.971335143381;5819.468531188862;5858.56060795442;4251.80866860992;4548.044910568818;4554.385158003627;5353.564128321605;5417.426722306952;2645.6957449893507;2961.9111426657237;3015.894443694504;3036.817790932551;3052.8168309901475;4852.44196917359;6063.302275362906;6064.636121832704;6128.356522565066;6139.29398119222;5340.385855626575;5598.776048958078;5931.347551769302;5943.494802941798;6003.249593800775;5214.504622060898;5285.31290932184;5317.421050790286;6016.909746353808;6056.394360563909;4875.975620121877;4909.656324057281;5043.846507261135;5282.788688452419;5831.591788574929;4191.97904010478;4925.876853078558;5431.103867861759;5474.91787623194;5521.080033176329;5265.578753699619;5413.9729301353245;5664.716764161858;5689.943100568941;5781.392953739797;4177.248095342868;4287.935680964851;4575.7187987363595;4787.808487660454;5044.772985215747;5341.599380046434;5403.162509810985;5412.75642596092;5893.994063027801;5897.555099000772;4567.406237189144;5380.730963451733;5655.377908430151;5655.604107712421;5717.371089180104;5353.759080841293;5617.494425501724;5634.295713035871;5701.828945131652;5787.495251234794;5147.510986456281;5168.9483105169975;5266.8419947401635;5329.786808527616;5340.679559226459;5637.718114094361;5653.297090405791;5682.715864206856;5687.5449964001955;5691.268191268132;4932.558383599998;4973.850784476472;5570.604640004837;5577.832665019893;5599.300087489064 04:31:55 INFO - PROCESS | 11613 | |5;yui.html;700.6881937537792;727.618000549711;727.6398182899464;766.6779952419984;855.8031652719874;14919.627009324773;15948.122853243067;15980.961237519568;15994.440194593191;15998.520044398687;14462.92768536156;14937.925310373434;15068.910873270981;15069.493050694926;15243.618909527268;919.3013309884486;956.1872408452829;959.644931375392;960.3037797596756;965.9758506037335;930.5114814722291;955.9808803823919;958.9280803939697;959.6689142245914;962.4850704872895;1006.6124542051326;1017.3387298256156;1017.3895662602416;1021.1830535571551;1021.4688362051729;999.4203362050066;1015.9847602285971;1016.1768967136643;1018.6536577563664;1020.8877023527406;749.0599297881179;760.2929275773529;761.5506850957961;762.1958833430729;763.9770806875803;16435.83564164355;16744;16823.579410514714;16912.49262522114;17076.658466830595;13584;14388.136711797326;14403.78394324086;14659.193744344057;14678.192699401528;9607.711768646952;11530.884691153065;11653.766924661544;11730.53077876884;12159.392030398445;3738.813059347049;3775.924481510382;3825.1393436476847;3830.7318487705593;3907.7459965102175;96142;104496;106021;107454.46272768587;107567.46216268947;9693.176080033136;11271.830922536168;11375.943120284346;11386.94306528462;11411.714707132389;20980.475488112614;24729.134480293462;24915;25214.873925630254;25309.62035569468;7801.375889928792;7804.208463677041;7858.214178582096;8069.394795390369;8141.389395795339;3840.231953609289;4229.978850105791;4257.8509752158525;4274.508431530414;4286;3390.1694084949345;3423.9144021399666;3438.8108654023767;3460.186856088817;3477.652234776502;527.459354161987;630.6625955113992;630.7981445937256;635.7488791927162;643.3694978920684;608.5323369524816;612.7671484835734;642.1876326447049;644.9484041276687;664.7407511070686;9147.63409463614;9637.325387222967;9770.31607787448;9860.556274967643;9881.357711748857;583.3874431846544;643.8712257548509;656.3436563436563;659.3274859643137;666.3037126203129;3445.896623101311;4413.183561041217;4732.692374995683;4752.405949256343;4804.663673542888;86917.1308286909;104254.47872760739;107598;107934.74619911096;110286;56694;63462.682686586275;77404.61297693588;79416.6029169862;93778;79279.20720792719;79479;79539.60230198812;79787;81537;10779.461026948778;10796.946015269874;11047.392393418439;11117.499712513118;11224.326540407601;42569;46364.6090617282;49521.75239123782;49701;51994.74002629962;62048.68975655093;65084;67221;70283.59432811418;70630.64684676749;13416.932915335361;13484.730305393641;13554.390052447861;13594.52419165364;14127.293635318398;14611.707765844836;14664.706705866036;14676.853231467549;14878.628034299229;15180.696386072437;13565.728685426038;13575.321233938066;13641.288338350987;13687.520936767165;13823.930880345533;11321.660350189508;13583.660408489866;13705.794413084011;14079;14154.575362739135;13204.141730787467;13296;13360.532381366605;13494.93252533731;13711.588652340446;10734.355938643706;10967.725806854893;11142.240525878165;11587.88412115868;11832.053435724949;8730.956345218234;8779.736607901774;9671.758206044906;11269.943650281695;11371.48828302745 04:31:55 INFO - PROCESS | 11613 | __end_tp_report 04:31:55 INFO - PROCESS | 11613 | __start_cc_report 04:31:55 INFO - PROCESS | 11613 | _x_x_mozilla_cycle_collect,425 04:31:55 INFO - PROCESS | 11613 | __end_cc_report 04:31:55 INFO - PROCESS | 11613 | __startTimestamp1489062715945__endTimestamp 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | ------- Summary: start ------- 04:31:55 INFO - PROCESS | 11613 | Number of tests: 6 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#0] dojo.html Cycles:165 Average:5951.96 Median:6190.66 stddev:687.97 (11.1%) stddev-sans-first:655.53 04:31:55 INFO - PROCESS | 11613 | Values: 3207.6 3462.2 3482.8 3501.1 3506.8 4832.1 4883.3 5576.7 5894.2 6115.1 6132.0 6132.3 6139.7 6142.5 6179.6 5343.9 5404.6 5503.5 5506.8 5599.0 5494.4 5536.6 5537.1 5543.9 5567.2 5389.0 5436.7 5518.4 5540.8 5576.2 5441.3 5459.3 5461.6 5462.6 5467.6 5247.3 5457.7 5476.2 5494.4 5508.4 5016.3 5164.7 5965.3 6097.6 6124.3 6450.2 6456.5 6468.2 6473.9 6478.4 5890.2 6023.8 6571.3 6591.0 6617.4 5977.6 5989.9 6092.4 6105.4 6251.2 6550.4 6552.5 6594.4 6625.4 6666.6 6205.9 6252.1 6290.3 6323.3 6377.7 5502.4 6460.8 6511.9 6539.8 6550.4 6260.4 6424.9 6434.3 6446.6 6447.1 5269.4 6311.0 6325.6 6375.9 6412.6 5153.8 5206.7 5219.6 5231.2 5265.6 4617.9 4632.9 4646.7 4654.3 4681.2 6115.6 6126.4 6130.8 6190.7 6196.9 6512.4 6560.8 6577.9 6588.1 6588.7 6181.7 6209.2 6232.3 6246.8 6282.5 5573.3 5583.4 5634.4 5640.8 5744.6 6627.1 6672.1 6700.3 6701.3 6720.2 6536.4 6538.1 6540.9 6544.3 6550.1 6515.7 6559.4 6646.4 6696.4 6742.6 6315.4 6338.6 6378.4 6395.9 6420.7 5843.3 5895.8 6515.7 6546.2 6548.4 6135.1 6176.0 6206.8 6214.1 6290.3 6291.1 6321.0 6322.5 6325.4 6355.7 4971.8 5740.7 6140.9 6163.6 6205.4 5194.9 6162.6 6298.2 6315.4 6318.7 6283.7 6297.3 6311.1 6316.6 6317.8 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#1] ext.html Cycles:180 Average:54889.22 Median:18171.93 stddev:108465.93 (596.9%) stddev-sans-first:108694.10 04:31:55 INFO - PROCESS | 11613 | Values: 772.3 828.9 833.8 856.4 879.9 29607.4 39444.4 39463.0 39538.8 39539.0 37615.8 38211.0 38432.4 38651.2 38787.4 6810.8 7382.2 7531.2 7823.7 10768.5 11023.6 11043.0 11137.4 11140.1 11152.9 10195.6 10415.8 11122.7 11168.9 11170.5 11046.6 11100.9 11139.5 11147.4 11169.3 10777.6 10823.3 10839.8 10846.9 10848.5 38573.4 38578.6 38831.6 38854.6 38938.2 3244.6 3813.3 3823.9 3854.3 3990.5 23047.7 27713.7 27867.7 28105.4 28480.6 3101.5 3138.4 3170.0 3191.4 3257.3 337680.0 340569.0 342583.0 342898.0 344569.0 42779.4 43464.0 49807.8 50699.7 51868.7 41818.0 46805.1 53720.0 53813.9 53842.2 13628.7 13737.1 13742.5 13762.1 13763.2 10897.3 10980.3 11037.6 11060.0 11073.1 12730.0 12871.2 12895.5 12962.1 13015.4 4802.0 5123.4 5297.1 5345.2 5364.4 1083.4 1098.1 1114.2 1127.0 1162.8 25876.4 25948.7 26191.6 26203.7 26308.0 1173.7 1207.7 1213.4 1217.6 1265.7 11592.7 13657.9 13663.0 16119.0 16409.6 450626.0 451735.0 452259.0 452462.0 468104.7 58531.7 58898.4 58946.1 58973.7 59121.0 1402.8 1440.6 1446.5 1446.7 1447.7 28732.1 29017.6 29289.9 29866.6 29940.0 45858.8 45865.0 45923.0 46040.0 46653.1 421926.0 423016.0 423103.0 423152.0 425791.0 26599.5 27957.6 31487.0 33086.5 33255.8 41274.0 43127.4 43419.6 43453.3 43879.0 35600.8 35677.1 35975.5 36734.0 37222.4 35247.0 35498.5 36459.9 36600.6 37471.0 34781.1 35075.8 36039.3 36227.9 36582.8 23207.9 30301.7 30349.0 31834.5 31951.0 24101.9 24141.0 24162.8 24452.3 24503.3 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#2] jquery.html Cycles:180 Average:42404.31 Median:22347.81 stddev:118796.32 (531.6%) stddev-sans-first:119087.70 04:31:55 INFO - PROCESS | 11613 | Values: 398.8 403.3 404.5 412.9 434.0 20813.4 20896.9 21534.0 21880.5 22181.4 21124.8 21306.6 21687.0 21718.3 21846.9 6545.5 6845.2 6899.7 6904.6 6920.9 6688.4 7247.9 7617.5 7721.2 7777.6 7257.5 7519.1 7740.2 7742.6 7759.0 7443.9 7625.6 7629.6 7680.7 7691.9 7363.8 7468.9 7480.8 7492.9 7496.9 22906.5 27257.9 27507.2 27663.7 28416.0 2838.9 2874.3 3297.2 3309.9 3414.7 16233.9 16357.7 16590.5 17228.2 17513.0 1904.4 1929.5 2025.9 2116.6 2145.5 125990.0 147094.0 150946.0 154589.0 155818.2 21900.7 22417.3 22603.8 23127.3 23316.0 35474.5 35555.3 35626.6 35820.7 36138.3 9358.7 10237.7 10504.0 10696.7 10914.9 7579.9 8473.2 8591.9 8730.6 8905.3 8793.8 8828.9 10478.4 10565.8 10834.8 3888.8 4152.8 4265.4 4285.7 4306.4 974.9 1013.9 1041.3 1049.4 1090.4 22194.4 22278.3 22586.7 22609.0 22630.0 903.3 906.4 965.0 977.8 1081.3 11733.7 11893.8 12419.0 12999.6 13439.8 696055.0 698481.0 707633.0 722671.0 726348.0 155627.0 158714.2 159379.7 160716.0 168556.0 957.5 1270.0 1298.7 1312.8 1332.2 18189.3 20784.1 21347.8 21415.3 21446.9 46059.0 61476.0 61540.7 62228.0 63181.7 88130.6 89266.1 89404.0 89868.6 90927.0 10414.4 11517.0 11912.9 11919.0 12252.6 12938.8 13162.6 13170.9 13507.9 13521.2 8155.8 11095.9 11531.7 11700.2 11764.4 11119.3 11285.5 11392.4 11479.6 11684.8 11435.7 11507.7 11896.0 11926.8 11985.1 11649.9 11673.9 11912.4 11955.6 12359.7 9550.3 9953.1 10448.7 11086.4 11553.9 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#3] mootools.html Cycles:180 Average:6618.62 Median:2381.08 stddev:4162.47 (174.8%) stddev-sans-first:4156.15 04:31:55 INFO - PROCESS | 11613 | Values: 1467.1 1553.3 1555.6 1590.6 1600.0 9354.4 9626.8 10563.6 11183.6 11225.8 10437.5 10802.9 10991.7 11031.3 11056.7 2324.2 2373.6 2376.9 2378.4 2383.8 2324.4 2337.1 2337.6 2362.3 2363.6 2322.3 2330.1 2334.7 2347.8 2354.9 2265.2 2302.7 2316.1 2321.3 2322.3 2283.8 2320.9 2341.4 2341.9 2347.8 11012.2 11062.8 11112.2 11116.6 11146.2 5510.3 5632.8 5779.8 5829.8 5837.4 3205.3 3363.7 3534.9 3647.5 3672.4 1114.8 1176.9 1236.9 1241.0 1780.9 12880.7 15252.2 15309.5 15518.7 15534.8 4672.1 4748.4 4749.2 4796.9 4953.9 11642.5 11664.9 11701.0 11774.2 11829.6 5593.6 5739.3 5828.2 5829.5 5836.5 3273.7 4638.0 4645.1 5169.0 5278.7 3786.5 3838.5 3872.6 3959.4 3973.5 1021.2 1030.6 1036.3 1048.4 1049.7 790.8 849.5 862.1 893.5 895.9 5404.4 6077.8 6377.5 6441.3 6739.3 863.3 1007.6 1024.5 1027.7 1028.3 3763.9 4199.3 4208.6 4303.5 4338.1 13029.8 13486.7 13607.7 13627.3 13628.0 12930.8 13083.1 13393.3 13489.7 13542.9 9814.8 9903.9 9992.4 10065.6 10162.2 6445.6 6550.9 6554.4 6593.3 6684.1 9930.0 10838.9 11866.8 12206.6 12301.8 12202.9 12351.8 12481.3 12509.1 12688.3 8065.9 8386.8 9169.9 9253.6 9398.6 9880.8 10243.3 10388.6 10391.8 10414.8 8994.0 9070.6 9107.2 9130.5 9216.6 8962.9 9029.8 9111.8 9307.5 9327.9 7835.1 7844.0 7870.9 7937.8 7938.6 5155.3 5220.9 5296.6 5794.5 5895.3 5183.5 5203.7 5282.8 5439.9 5591.0 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#4] prototype.html Cycles:180 Average:4708.79 Median:5043.75 stddev:1267.29 (25.1%) stddev-sans-first:1228.18 04:31:55 INFO - PROCESS | 11613 | Values: 364.6 370.4 376.7 382.5 389.9 4798.6 4837.4 5222.7 5413.7 5458.6 4085.8 4829.6 4983.8 4996.7 5213.2 3884.9 4443.3 4458.5 4462.7 4472.5 3917.0 4466.9 4476.8 4481.9 4591.9 3920.5 3984.7 4053.2 4210.9 4694.4 3890.9 4315.7 4571.2 4657.8 4701.7 3810.5 3838.8 4074.0 4103.9 4394.3 4500.7 4700.4 4945.4 5043.6 5185.7 4484.7 4576.8 5123.8 5356.7 5385.8 4173.6 5400.9 5690.5 5768.3 5779.0 4554.6 4656.3 4821.4 4863.7 4953.9 5202.6 5357.9 5872.4 6151.4 6155.7 4693.8 4853.3 4881.5 5035.8 5088.2 4913.8 5020.9 5149.0 5163.7 5182.5 4455.7 4472.9 5002.9 5097.0 5340.4 5076.9 5446.7 5550.9 5649.4 5743.3 1547.0 1592.6 1687.8 1764.5 1777.8 1382.3 1439.2 1452.1 1458.0 1480.9 4404.4 4582.7 4655.3 4865.4 5307.5 5062.9 5329.5 5733.0 5819.5 5858.6 4251.8 4548.0 4554.4 5353.6 5417.4 2645.7 2961.9 3015.9 3036.8 3052.8 4852.4 6063.3 6064.6 6128.4 6139.3 5340.4 5598.8 5931.3 5943.5 6003.2 5214.5 5285.3 5317.4 6016.9 6056.4 4876.0 4909.7 5043.8 5282.8 5831.6 4192.0 4925.9 5431.1 5474.9 5521.1 5265.6 5414.0 5664.7 5689.9 5781.4 4177.2 4287.9 4575.7 4787.8 5044.8 5341.6 5403.2 5412.8 5894.0 5897.6 4567.4 5380.7 5655.4 5655.6 5717.4 5353.8 5617.5 5634.3 5701.8 5787.5 5147.5 5168.9 5266.8 5329.8 5340.7 5637.7 5653.3 5682.7 5687.5 5691.3 4932.6 4973.9 5570.6 5577.8 5599.3 04:31:55 INFO - PROCESS | 11613 | 04:31:55 INFO - PROCESS | 11613 | [#5] yui.html Cycles:180 Average:20201.15 Median:3453.04 stddev:28551.32 (826.8%) stddev-sans-first:28593.86 04:31:55 INFO - PROCESS | 11613 | Values: 700.7 727.6 727.6 766.7 855.8 14919.6 15948.1 15981.0 15994.4 15998.5 14462.9 14937.9 15068.9 15069.5 15243.6 919.3 956.2 959.6 960.3 966.0 930.5 956.0 958.9 959.7 962.5 1006.6 1017.3 1017.4 1021.2 1021.5 999.4 1016.0 1016.2 1018.7 1020.9 749.1 760.3 761.6 762.2 764.0 16435.8 16744.0 16823.6 16912.5 17076.7 13584.0 14388.1 14403.8 14659.2 14678.2 9607.7 11530.9 11653.8 11730.5 12159.4 3738.8 3775.9 3825.1 3830.7 3907.7 96142.0 104496.0 106021.0 107454.5 107567.5 9693.2 11271.8 11375.9 11386.9 11411.7 20980.5 24729.1 24915.0 25214.9 25309.6 7801.4 7804.2 7858.2 8069.4 8141.4 3840.2 4230.0 4257.9 4274.5 4286.0 3390.2 3423.9 3438.8 3460.2 3477.7 527.5 630.7 630.8 635.7 643.4 608.5 612.8 642.2 644.9 664.7 9147.6 9637.3 9770.3 9860.6 9881.4 583.4 643.9 656.3 659.3 666.3 3445.9 4413.2 4732.7 4752.4 4804.7 86917.1 104254.5 107598.0 107934.7 110286.0 56694.0 63462.7 77404.6 79416.6 93778.0 79279.2 79479.0 79539.6 79787.0 81537.0 10779.5 10796.9 11047.4 11117.5 11224.3 42569.0 46364.6 49521.8 49701.0 51994.7 62048.7 65084.0 67221.0 70283.6 70630.6 13416.9 13484.7 13554.4 13594.5 14127.3 14611.7 14664.7 14676.9 14878.6 15180.7 13565.7 13575.3 13641.3 13687.5 13823.9 11321.7 13583.7 13705.8 14079.0 14154.6 13204.1 13296.0 13360.5 13494.9 13711.6 10734.4 10967.7 11142.2 11587.9 11832.1 8731.0 8779.7 9671.8 11269.9 11371.5 04:31:55 INFO - PROCESS | 11613 | -------- Summary: end -------- 04:31:55 INFO - PROCESS | 11613 | 04:31:56 INFO - TEST-INFO | 11613: exit 0 04:31:56 INFO - TEST-OK | dromaeo_css | took 1118759ms 04:31:56 INFO - TEST-START | kraken 04:31:56 INFO - operating with platform_type : mac_ 04:31:56 INFO - Initialising browser for kraken test... 04:31:56 INFO - TEST-INFO | started process 11618 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYsnkuM/profile http://localhost:49880/getInfo.html) 04:31:59 INFO - PROCESS | 11618 | 2017-03-09 04:31:59.701 plugin-container[11619:238593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c4f, name = 'com.apple.tsm.portname' 04:31:59 INFO - PROCESS | 11618 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:59 INFO - PROCESS | 11618 | 2017-03-09 04:31:59.704 plugin-container[11619:238593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 04:31:59 INFO - PROCESS | 11618 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:59 INFO - PROCESS | 11618 | 2017-03-09 04:31:59.704 plugin-container[11619:238593] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:59 INFO - PROCESS | 11618 | __metrics Screen width/height:1600/1200 04:31:59 INFO - PROCESS | 11618 | colorDepth:24 04:31:59 INFO - PROCESS | 11618 | Browser inner width/height: 1024/689 04:31:59 INFO - PROCESS | 11618 | __metrics 04:31:59 ERROR - PROCESS | 11618 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:32:00 INFO - TEST-INFO | 11618: exit 0 04:32:00 INFO - Browser initialized. 04:32:00 INFO - Running cycle 1/1 for kraken test... 04:32:00 INFO - TEST-INFO | started process 11620 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpYsnkuM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:03 INFO - PROCESS | 11620 | 2017-03-09 04:32:03.098 plugin-container[11621:238727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a37, name = 'com.apple.tsm.portname' 04:32:03 INFO - PROCESS | 11620 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:03 INFO - PROCESS | 11620 | 2017-03-09 04:32:03.099 plugin-container[11621:238727] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 04:32:03 INFO - PROCESS | 11620 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:32:03 INFO - PROCESS | 11620 | 2017-03-09 04:32:03.099 plugin-container[11621:238727] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:32:12 INFO - PROCESS | 11620 | RSS: Main: 227328000 04:32:12 INFO - PROCESS | 11620 | 04:32:15 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49880/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:16 INFO - PROCESS | 11620 | RSS: Main: 241471488 04:32:16 INFO - PROCESS | 11620 | 04:32:19 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49880/tests/kraken/driver.html?testName=audio-dft) 04:32:20 INFO - PROCESS | 11620 | RSS: Main: 249806848 04:32:20 INFO - PROCESS | 11620 | 04:32:23 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49880/tests/kraken/driver.html?testName=audio-fft) 04:32:24 INFO - PROCESS | 11620 | RSS: Main: 252526592 04:32:24 INFO - PROCESS | 11620 | 04:32:26 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49880/tests/kraken/driver.html?testName=audio-oscillator) 04:32:27 INFO - PROCESS | 11620 | RSS: Main: 254738432 04:32:27 INFO - PROCESS | 11620 | 04:32:29 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:29 INFO - PROCESS | 11620 | RSS: Main: 255373312 04:32:29 INFO - PROCESS | 11620 | 04:32:33 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49880/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:33 INFO - PROCESS | 11620 | RSS: Main: 261251072 04:32:33 INFO - PROCESS | 11620 | 04:32:37 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49880/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:37 INFO - PROCESS | 11620 | RSS: Main: 261464064 04:32:37 INFO - PROCESS | 11620 | 04:32:41 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49880/tests/kraken/driver.html?testName=json-parse-financial) 04:32:41 INFO - PROCESS | 11620 | RSS: Main: 261165056 04:32:41 INFO - PROCESS | 11620 | 04:32:43 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:44 INFO - PROCESS | 11620 | RSS: Main: 261308416 04:32:44 INFO - PROCESS | 11620 | 04:32:46 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:46 INFO - PROCESS | 11620 | RSS: Main: 261255168 04:32:46 INFO - PROCESS | 11620 | 04:32:48 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:49 INFO - PROCESS | 11620 | RSS: Main: 261136384 04:32:49 INFO - PROCESS | 11620 | 04:32:52 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:53 INFO - PROCESS | 11620 | RSS: Main: 261468160 04:32:53 INFO - PROCESS | 11620 | 04:32:56 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:57 INFO - PROCESS | 11620 | RSS: Main: 261177344 04:32:57 INFO - PROCESS | 11620 | 04:32:58 INFO - PROCESS | 11620 | Cycle 1(1): loaded http://localhost:49880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49880/tests/kraken/driver.html?testName=ai-astar) 04:32:59 INFO - PROCESS | 11620 | RSS: Main: 264441856 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | __start_tp_report 04:32:59 INFO - PROCESS | 11620 | _x_x_mozilla_page_load 04:32:59 INFO - PROCESS | 11620 | _x_x_mozilla_page_load_details 04:32:59 INFO - PROCESS | 11620 | |i|pagename|runs| 04:32:59 INFO - PROCESS | 11620 | |0;ai-astar;109;124;128;182;127;122;123;140;183;156 04:32:59 INFO - PROCESS | 11620 | |1;audio-beat-detection;131;137;141;152;115;112;114;131;169;108 04:32:59 INFO - PROCESS | 11620 | |2;audio-dft;223;224;255;276;273;206;213;237;234;281 04:32:59 INFO - PROCESS | 11620 | |3;audio-fft;85;63;73;87;69;86;54;78;99;51 04:32:59 INFO - PROCESS | 11620 | |4;audio-oscillator;90;72;86;72;72;73;76;91;61;100 04:32:59 INFO - PROCESS | 11620 | |5;imaging-gaussian-blur;90;106;136;90;92;87;137;135;89;90 04:32:59 INFO - PROCESS | 11620 | |6;imaging-darkroom;97;94;103;101;136;135;96;97;96;106 04:32:59 INFO - PROCESS | 11620 | |7;imaging-desaturate;143;91;90;119;115;145;148;96;91;92 04:32:59 INFO - PROCESS | 11620 | |8;json-parse-financial;68;69;67;73;69;67;68;80;69;67 04:32:59 INFO - PROCESS | 11620 | |9;json-stringify-tinderbox;67;58;65;99;88;58;58;67;68;61 04:32:59 INFO - PROCESS | 11620 | |10;stanford-crypto-aes;85;88;91;88;85;88;88;86;88;85 04:32:59 INFO - PROCESS | 11620 | |11;stanford-crypto-ccm;142;145;142;170;151;131;142;148;177;167 04:32:59 INFO - PROCESS | 11620 | |12;stanford-crypto-pbkdf2;176;219;187;174;177;180;205;173;178;178 04:32:59 INFO - PROCESS | 11620 | |13;stanford-crypto-sha256-iterative;68;67;72;69;70;66;68;68;66;67 04:32:59 INFO - PROCESS | 11620 | __end_tp_report 04:32:59 INFO - PROCESS | 11620 | __start_cc_report 04:32:59 INFO - PROCESS | 11620 | _x_x_mozilla_cycle_collect,1002 04:32:59 INFO - PROCESS | 11620 | __end_cc_report 04:32:59 INFO - PROCESS | 11620 | __startTimestamp1489062779020__endTimestamp 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | ------- Summary: start ------- 04:32:59 INFO - PROCESS | 11620 | Number of tests: 14 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#0] ai-astar Cycles:10 Average:139.40 Median:134.00 stddev:25.84 (19.3%) stddev-sans-first:24.95 04:32:59 INFO - PROCESS | 11620 | Values: 109.0 124.0 128.0 182.0 127.0 122.0 123.0 140.0 183.0 156.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:134.00 stddev:19.60 (14.6%) stddev-sans-first:20.78 04:32:59 INFO - PROCESS | 11620 | Values: 131.0 137.0 141.0 152.0 115.0 112.0 114.0 131.0 169.0 108.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#2] audio-dft Cycles:10 Average:242.20 Median:246.00 stddev:27.32 (11.1%) stddev-sans-first:28.08 04:32:59 INFO - PROCESS | 11620 | Values: 223.0 224.0 255.0 276.0 273.0 206.0 213.0 237.0 234.0 281.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#3] audio-fft Cycles:10 Average:74.50 Median:81.50 stddev:15.45 (19.0%) stddev-sans-first:15.91 04:32:59 INFO - PROCESS | 11620 | Values: 85.0 63.0 73.0 87.0 69.0 86.0 54.0 78.0 99.0 51.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:74.50 stddev:11.88 (15.9%) stddev-sans-first:11.95 04:32:59 INFO - PROCESS | 11620 | Values: 90.0 72.0 86.0 72.0 72.0 73.0 76.0 91.0 61.0 100.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#5] imaging-gaussian-blur Cycles:10 Average:105.20 Median:89.50 stddev:21.88 (24.4%) stddev-sans-first:22.51 04:32:59 INFO - PROCESS | 11620 | Values: 90.0 106.0 136.0 90.0 92.0 87.0 137.0 135.0 89.0 90.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:95.00 stddev:15.92 (16.8%) stddev-sans-first:16.54 04:32:59 INFO - PROCESS | 11620 | Values: 97.0 94.0 103.0 101.0 136.0 135.0 96.0 97.0 96.0 106.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#7] imaging-desaturate Cycles:10 Average:113.00 Median:90.50 stddev:24.53 (27.1%) stddev-sans-first:23.49 04:32:59 INFO - PROCESS | 11620 | Values: 143.0 91.0 90.0 119.0 115.0 145.0 148.0 96.0 91.0 92.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#8] json-parse-financial Cycles:10 Average:69.70 Median:69.00 stddev:4.03 (5.8%) stddev-sans-first:4.23 04:32:59 INFO - PROCESS | 11620 | Values: 68.0 69.0 67.0 73.0 69.0 67.0 68.0 80.0 69.0 67.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:67.00 stddev:13.80 (20.6%) stddev-sans-first:14.62 04:32:59 INFO - PROCESS | 11620 | Values: 67.0 58.0 65.0 99.0 88.0 58.0 58.0 67.0 68.0 61.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:88.00 stddev:1.93 (2.2%) stddev-sans-first:1.88 04:32:59 INFO - PROCESS | 11620 | Values: 85.0 88.0 91.0 88.0 85.0 88.0 88.0 86.0 88.0 85.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:149.50 stddev:14.83 (9.9%) stddev-sans-first:15.32 04:32:59 INFO - PROCESS | 11620 | Values: 142.0 145.0 142.0 170.0 151.0 131.0 142.0 148.0 177.0 167.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:179.00 stddev:15.25 (8.5%) stddev-sans-first:15.84 04:32:59 INFO - PROCESS | 11620 | Values: 176.0 219.0 187.0 174.0 177.0 180.0 205.0 173.0 178.0 178.0 04:32:59 INFO - PROCESS | 11620 | 04:32:59 INFO - PROCESS | 11620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:1.85 (2.7%) stddev-sans-first:1.96 04:32:59 INFO - PROCESS | 11620 | Values: 68.0 67.0 72.0 69.0 70.0 66.0 68.0 68.0 66.0 67.0 04:32:59 INFO - PROCESS | 11620 | -------- Summary: end -------- 04:32:59 INFO - PROCESS | 11620 | 04:33:00 INFO - TEST-INFO | 11620: exit 0 04:33:00 INFO - TEST-OK | kraken | took 63416ms 04:33:00 INFO - SUITE-END | took 1182s 04:33:00 INFO - Completed test suite (00:19:42) 04:33:00 INFO - javascript benchmark 04:33:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7780.441820496084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3207.6311224209217, 3462.221000274937, 3482.8084455354947, 3501.124718820295, 3506.789592624442, 4832.130216561018, 4883.316335713003, 5576.665400075998, 5894.2042824218715, 6115.082737589364, 6131.9884064911685, 6132.294322189902, 6139.662318572477, 6142.529470848967, 6179.5674302798825, 5343.919841202385, 5404.567634589223, 5503.532199763015, 5506.779728810843, 5598.972005139969, 5494.36814766301, 5536.612437129403, 5537.0863807471715, 5543.944560554403, 5567.192757050226, 5388.973055134719, 5436.673799572039, 5518.392976772552, 5540.778368865241, 5576.219329293902, 5441.347038355423, 5459.317585301837, 5461.590380721422, 5462.644928079662, 5467.617266791326, 5247.265382846366, 5457.672539647634, 5476.151196564499, 5494.395616482184, 5508.394076651565, 5016.3227964224725, 5164.715940623264, 5965.313988891289, 6097.57316987811, 6124.258880972529, 6450.193725784277, 6456.451201647866, 6468.159139311906, 6473.93526064738, 6478.4169424752, 5890.234269544974, 6023.82557878174, 6571.342865713438, 6590.967045164792, 6617.437517810992, 5977.581569290108, 5989.850253743648, 6092.390760923872, 6105.389461053948, 6251.218597675291, 6550.377714117151, 6552.508561857784, 6594.439472644879, 6625.436837868739, 6666.633335166515, 6205.937940620626, 6252.124702541648, 6290.2766181889665, 6323.336049714806, 6377.74489020434, 5502.449755024546, 6460.806175814733, 6511.902321465182, 6539.771108011197, 6550.410463058348, 6260.373962603794, 6424.935750642528, 6434.260060093149, 6446.580972236883, 6447.065175549519, 5269.367675878919, 6311.0, 6325.620462772156, 6375.872482550323, 6412.615243085336, 5153.819616313411, 5206.739663016834, 5219.582433405319, 5231.189165679326, 5265.605079619044, 4617.907641847211, 4632.884177895579, 4646.697964632355, 4654.325122857234, 4681.227597446383, 6115.571909966259, 6126.426068710516, 6130.846728831726, 6190.659513726699, 6196.938030619726, 6512.413882750575, 6560.770373036921, 6577.901331480031, 6588.143541339595, 6588.703508342136, 6181.690915454209, 6209.161763162006, 6232.283287421914, 6246.750649870044, 6282.4974002079725, 5573.275474188411, 5583.35791383996, 5634.408387119375, 5640.802571909963, 5744.569157313134, 6627.138471998705, 6672.132622759011, 6700.329967003456, 6701.296363881917, 6720.227173875067, 6536.444402225864, 6538.051982462422, 6540.901886471612, 6544.345565443417, 6550.082988381726, 6515.706793194223, 6559.376859198369, 6646.368594983469, 6696.430803381767, 6742.6291553965, 6315.400036996478, 6338.556301058881, 6378.362163783585, 6395.872082558416, 6420.7431702731365, 5843.29880414353, 5895.793647222498, 6515.706793194412, 6546.247181573989, 6548.410643042149, 6135.1408007826785, 6176.0, 6206.751729930752, 6214.130021796862, 6290.339514350927, 6291.087792270004, 6320.968395157995, 6322.49420046386, 6325.399087086719, 6355.713992870239, 4971.751412429437, 5740.655560666373, 6140.9030504681905, 6163.582376053622, 6205.410486003822, 5194.922076168936, 6162.568620196544, 6298.1812364392335, 6315.368463153648, 6318.652474113968, 6283.685815709105, 6297.307296197323, 6311.084892690626, 6316.62100273985, 6317.778877739257], "value": 5909.2190974617, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.3242163107282, 828.8715249136386, 833.8290650416665, 856.4347530629784, 879.890013748281, 29607.40785184295, 39444.40833387501, 39463.0, 39538.8023059885, 39539.011524711896, 37615.811920940425, 38211.0, 38432.423513647314, 38651.22697546047, 38787.41818872719, 6810.795676129712, 7382.224866389032, 7531.246875312452, 7823.726169584065, 10768.515416806224, 11023.61417350393, 11043.006129448348, 11137.387443690593, 11140.108791296718, 11152.888471115306, 10195.643152489665, 10415.843762343571, 11122.666320010372, 11168.944155279252, 11170.497327620276, 11046.613368532062, 11100.888991110067, 11139.498722557504, 11147.386893720843, 11169.329840209532, 10777.62278320255, 10823.296485728402, 10839.83740243897, 10846.891531084668, 10848.457577121113, 38573.42139867904, 38578.614213857785, 38831.61168388308, 38854.61145388538, 38938.22123557513, 3244.5619841321354, 3813.2564149990762, 3823.8661646842506, 3854.3447613905705, 3990.541087774914, 23047.654285185567, 27713.722862771316, 27867.721322786714, 28105.437891242265, 28480.572791408147, 3101.4882544380152, 3138.3865717395392, 3169.9683003170135, 3191.4255434021866, 3257.3485302939507, 337680.0, 340569.0, 342583.0, 342898.0, 344569.0, 42779.36375408063, 43464.0, 49807.750961245685, 50699.746501267255, 51868.740656296475, 41817.95455113646, 46805.06389872252, 53720.0, 53813.92372152535, 53842.15420612164, 13628.65928351799, 13737.107088039445, 13742.519011834538, 13762.105463145064, 13763.243021633705, 10897.346159230314, 10980.341179529254, 11037.558497660164, 11060.004599586076, 11073.114150867912, 12730.0, 12871.163374380636, 12895.548655797002, 12962.092653514352, 13015.414306356237, 4801.95198048022, 5123.359580052494, 5297.125974214288, 5345.1982202669915, 5364.436734142937, 1083.4203701019917, 1098.1379617000775, 1114.1532435349193, 1126.9770761483157, 1162.8255461983288, 25876.353091172496, 25948.74051259463, 26191.607125893126, 26203.73796262051, 26308.0, 1173.700706319883, 1207.6799648093263, 1213.4114954247184, 1217.6103646833105, 1265.7278685082752, 11592.710182245342, 13657.863421365857, 13663.0, 16119.0, 16409.58976025585, 450626.0, 451735.0, 452259.0, 452462.0, 468104.6594767004, 58531.70734146302, 58898.41101589015, 58946.11580826291, 58973.705131474926, 59121.0, 1402.7825687018528, 1440.6110350205386, 1446.4575784080969, 1446.7178900114377, 1447.6815100677834, 28732.138035858123, 29017.564736528548, 29289.85355073211, 29866.552001720425, 29940.0, 45858.77070614626, 45865.0, 45923.0, 46040.0, 46653.066938661716, 421926.0, 423016.0, 423103.0, 423152.0, 425791.0, 26599.468010640066, 27957.580636290066, 31487.008734170216, 33086.51110699976, 33255.833720831244, 41273.96815079647, 43127.35308970431, 43419.56580434155, 43453.348199776396, 43879.0, 35600.821995889855, 35677.1080722984, 35975.460368093976, 36734.0, 37222.44166337561, 35247.0, 35498.467522987696, 36459.90620281396, 36600.63399365972, 37471.0, 34781.13047173841, 35075.82462087673, 36039.27921441609, 36227.91316260411, 36582.8170859144, 23207.88396058009, 30301.696983029888, 30348.965103489474, 31834.52248216325, 31951.0, 24101.879490602434, 24141.0, 24162.75837241605, 24452.266432006356, 24503.264902052968], "value": 18778.092066985904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.7746922988511, 403.29624804715775, 404.5125623623533, 412.92360913231045, 433.95443478434765, 20813.375598732044, 20896.89551552244, 21534.0, 21880.45298867529, 22181.445463863412, 21124.83813390263, 21306.57386852262, 21687.02408391622, 21718.348449546498, 21846.890765546188, 6545.541812073145, 6845.247022827485, 6899.724011039552, 6904.585724856524, 6920.930790692079, 6688.431483323923, 7247.891281630754, 7617.5048621839405, 7721.22787721229, 7777.572233527182, 7257.528260663066, 7519.13529944058, 7740.187280335568, 7742.574158421285, 7758.961205193966, 7443.85112297751, 7625.580593067379, 7629.580373079479, 7680.692772289101, 7691.9230807691765, 7363.77908662741, 7468.85062298751, 7480.775576732653, 7492.925070749277, 7496.925030749677, 22906.54186916269, 27257.86371068152, 27507.17478475649, 27663.723362766315, 28416.0, 2838.8580570971576, 2874.3389020525187, 3297.1757060734817, 3309.9172520687175, 3414.6756058174433, 16233.918830405772, 16357.67284654312, 16590.50228493147, 17228.176110689026, 17513.0, 1904.4096330137702, 1929.536911141316, 2025.9392218233477, 2116.5661039486868, 2145.517258616814, 125990.0, 147094.0, 150946.0, 154589.0, 155818.22090889586, 21900.671489927663, 22417.292368602775, 22603.773962260497, 23127.3061808146, 23315.987062781584, 35474.46788298178, 35555.28889422197, 35626.643733562334, 35820.746273880286, 36138.27723445516, 9358.719238422858, 10237.7440563985, 10504.0, 10696.732581685364, 10914.945425272981, 7579.924200758032, 8473.237408633253, 8591.871121933176, 8730.607122679368, 8905.287576993825, 8793.757591814046, 8828.8675669865, 10478.37129772216, 10565.75682382134, 10834.837477437844, 3888.786116763605, 4152.750834949913, 4265.3815196796295, 4285.700000999963, 4306.375575541591, 974.9415035097917, 1013.9239557033252, 1041.3439533094102, 1049.4123290957089, 1090.3566895531517, 22194.44513887166, 22278.331650050524, 22586.661200082013, 22609.0, 22630.0, 903.2818908967387, 906.40177482861, 965.0494263150791, 977.8044391121804, 1081.2863510083307, 11733.706657333465, 11893.821592676117, 12419.0, 12999.610011699664, 13439.798403023962, 696055.0, 698481.0, 707633.0, 722671.0, 726348.0, 155627.0, 158714.20642896942, 159379.67133779763, 160716.0, 168556.0, 957.4973139101888, 1270.0259337356806, 1298.727267273864, 1312.8030795380578, 1332.1740520877117, 18189.272429102686, 20784.064717087465, 21347.7865221352, 21415.250466233607, 21446.89276553607, 46059.0, 61476.0, 61540.69229653823, 62228.0, 63181.68409157925, 88130.55934720286, 89266.10733892578, 89404.0, 89868.55065724629, 90927.0, 10414.427206503715, 11517.0, 11912.880871191177, 11919.04647628205, 12252.632421027383, 12938.805917911051, 13162.60512184636, 13170.868291316965, 13507.864921350661, 13521.18872867631, 8155.83688326242, 11095.889041109485, 11531.654050378502, 11700.239484433485, 11764.411779411166, 11119.332840029625, 11285.548578056785, 11392.430378480876, 11479.598214062467, 11684.766304674029, 11435.714107147387, 11507.712307192052, 11896.0, 11926.821097683714, 11985.101117416054, 11649.883501165219, 11673.941630292135, 11912.40437978115, 11955.64133076009, 12359.69100772488, 9550.283728720235, 9953.113597056772, 10448.68653940383, 11086.390248536085, 11553.862535430972], "value": 11954.212861703592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.1343907094817, 1553.2777258574768, 1555.5955451582586, 1590.562595286296, 1599.9760003599947, 9354.438733675985, 9626.807463850737, 10563.630272940449, 11183.608573699912, 11225.831612525808, 10437.478126093703, 10802.891971080287, 10991.670249892495, 11031.338119712824, 11056.668299951014, 2324.2097686786487, 2373.632087026505, 2376.9286921392386, 2378.3816207785926, 2383.7735415135535, 2324.384038229862, 2337.053493335202, 2337.602607556711, 2362.3149286706835, 2363.61000434928, 2322.314917099451, 2330.1262026739973, 2334.708161479815, 2347.7652234776556, 2354.9058037678474, 2265.150568536799, 2302.735185453669, 2316.1198744477074, 2321.3268152235914, 2322.280093171122, 2283.8401311908174, 2320.9187678431344, 2341.3678306857223, 2341.8594884306995, 2347.8239132065164, 11012.229143959927, 11062.834057489144, 11112.222144449892, 11116.555337786478, 11146.21976461648, 5510.256115424407, 5632.831015069554, 5779.826605201851, 5829.766809327622, 5837.416258374171, 3205.2627895583914, 3363.704973585163, 3534.929301413983, 3647.452882067711, 3672.4010469739537, 1114.832775083736, 1176.8999635030948, 1236.8824961628632, 1240.9565665201674, 1780.8842425242447, 12880.677983050406, 15252.161131137784, 15309.464168754152, 15518.689626207413, 15534.844651553452, 4672.112298663243, 4748.382710247645, 4749.1926372516755, 4796.904061918812, 4953.90092198154, 11642.476088576035, 11664.94167529157, 11701.0, 11774.234674746114, 11829.645110646694, 5593.608447408724, 5739.282589676291, 5828.242328497353, 5829.47534721877, 5836.474717275466, 3273.6562660920736, 4637.976810115995, 4645.094206629742, 5169.017886601609, 5278.709670968057, 3786.4888240087234, 3838.500994870649, 3872.6127387261613, 3959.366501359769, 3973.463582416337, 1021.22897212604, 1030.5723124903232, 1036.2849633752687, 1048.4233671480656, 1049.6746008737164, 790.8378782349605, 849.5285116760257, 862.1335557764406, 893.4683863101444, 895.9328050396247, 5404.351477822686, 6077.848053798691, 6377.5216858735785, 6441.259255185713, 6739.293388636231, 863.2921004776024, 1007.6120693532896, 1024.4570377699831, 1027.712240572641, 1028.3469996552244, 3763.9059023524633, 4199.286121359376, 4208.642265407475, 4303.483581970184, 4338.132373525307, 13029.804552931713, 13486.730265394637, 13607.727845443036, 13627.318634068257, 13628.0, 12930.806037909251, 13083.084184107021, 13393.263370514715, 13489.730205396034, 13542.864571354357, 9814.75463113428, 9903.900960990299, 9992.400455972665, 10065.647702330383, 10162.237832162617, 6445.613263204223, 6550.901736474052, 6554.442872355712, 6593.340665933369, 6684.0642310075655, 9930.0, 10838.891611084104, 11866.762664746484, 12206.572769953364, 12301.815472767737, 12202.938985305016, 12351.752964940471, 12481.313527756061, 12509.061820363328, 12688.302143382203, 8065.919340806751, 8386.790330241549, 9169.862452063358, 9253.629854805733, 9398.624055037722, 9880.802383952425, 10243.282970192015, 10388.636397726346, 10391.844122338322, 10414.791704166026, 8994.0, 9070.591823367833, 9107.22588579978, 9130.543472826199, 9216.631334746804, 8962.865557016781, 9029.77425564366, 9111.772205694646, 9307.534623268673, 9327.927288361654, 7835.098963619257, 7843.960780196063, 7870.921290787019, 7937.801554961172, 7938.6030698466, 5155.304033955368, 5220.895582088413, 5296.602754793483, 5794.536437084938, 5895.29256489224, 5183.481651834937, 5203.705172960928, 5282.81510147143, 5439.918401224064, 5591.0], "value": 5046.297339961058, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.63354328899453, 370.4258399480804, 376.69111328710466, 382.4760078692192, 389.9220155968806, 4798.592119669832, 4837.443693975194, 5222.71275079871, 5413.702246376448, 5458.590605704573, 4085.836566537335, 4829.619266513446, 4983.825566105178, 4996.725834912101, 5213.201445501306, 3884.8834534963926, 4443.289073748201, 4458.464984201884, 4462.679406708509, 4472.46330440346, 3917.0, 4466.865994020169, 4476.798544065525, 4481.865544033684, 4591.852036990752, 3920.45170639084, 3984.665137179034, 4053.209624123297, 4210.873673789792, 4694.413198350207, 3890.8521986014193, 4315.697901146921, 4571.160225410655, 4657.767111644438, 4701.7414042227665, 3810.542734871833, 3838.846446142179, 4073.959260407388, 4103.9179216415805, 4394.318880573516, 4500.727132797949, 4700.365450664151, 4945.406551213878, 5043.646944713872, 5185.662931909414, 4484.686071974963, 4576.771161441915, 5123.795048198068, 5356.6518176318805, 5385.8114965976, 4173.64524015459, 5400.891982160335, 5690.459406356389, 5768.336641286264, 5778.971105144489, 4554.635629149693, 4656.348111264426, 4821.397325334333, 4863.659543831933, 4953.851384458472, 5202.583793296527, 5357.946420535823, 5872.412758724094, 6151.415615516519, 6155.661438620874, 4693.775601958197, 4853.344798452164, 4881.536254055859, 5035.77339019745, 5088.236764485357, 4913.828016019422, 5020.874478138003, 5149.021685879671, 5163.741812909415, 5182.507661772125, 4455.732656040648, 4472.904138486027, 5002.89994200114, 5097.0, 5340.385855626575, 5076.93384389275, 5446.673199608036, 5550.944490555124, 5649.378568357477, 5743.261809007502, 1546.984530154684, 1592.6018495376156, 1687.8480936715755, 1764.54121928297, 1777.795553511337, 1382.3019375215451, 1439.2012433099521, 1452.0706747681493, 1457.9781303280458, 1480.9337277160428, 4404.405405270248, 4582.747948862778, 4655.348251244828, 4865.416150061945, 5307.495787900143, 5062.898742025139, 5329.520343169133, 5732.971335143381, 5819.468531188862, 5858.56060795442, 4251.80866860992, 4548.044910568818, 4554.385158003627, 5353.564128321605, 5417.426722306952, 2645.6957449893507, 2961.9111426657237, 3015.894443694504, 3036.817790932551, 3052.8168309901475, 4852.44196917359, 6063.302275362906, 6064.636121832704, 6128.356522565066, 6139.29398119222, 5340.385855626575, 5598.776048958078, 5931.347551769302, 5943.494802941798, 6003.249593800775, 5214.504622060898, 5285.31290932184, 5317.421050790286, 6016.909746353808, 6056.394360563909, 4875.975620121877, 4909.656324057281, 5043.846507261135, 5282.788688452419, 5831.591788574929, 4191.97904010478, 4925.876853078558, 5431.103867861759, 5474.91787623194, 5521.080033176329, 5265.578753699619, 5413.9729301353245, 5664.716764161858, 5689.943100568941, 5781.392953739797, 4177.248095342868, 4287.935680964851, 4575.7187987363595, 4787.808487660454, 5044.772985215747, 5341.599380046434, 5403.162509810985, 5412.75642596092, 5893.994063027801, 5897.555099000772, 4567.406237189144, 5380.730963451733, 5655.377908430151, 5655.604107712421, 5717.371089180104, 5353.759080841293, 5617.494425501724, 5634.295713035871, 5701.828945131652, 5787.495251234794, 5147.510986456281, 5168.9483105169975, 5266.8419947401635, 5329.786808527616, 5340.679559226459, 5637.718114094361, 5653.297090405791, 5682.715864206856, 5687.5449964001955, 5691.268191268132, 4932.558383599998, 4973.850784476472, 5570.604640004837, 5577.832665019893, 5599.300087489064], "value": 4352.577738743785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.6881937537792, 727.618000549711, 727.6398182899464, 766.6779952419984, 855.8031652719874, 14919.627009324773, 15948.122853243067, 15980.961237519568, 15994.440194593191, 15998.520044398687, 14462.92768536156, 14937.925310373434, 15068.910873270981, 15069.493050694926, 15243.618909527268, 919.3013309884486, 956.1872408452829, 959.644931375392, 960.3037797596756, 965.9758506037335, 930.5114814722291, 955.9808803823919, 958.9280803939697, 959.6689142245914, 962.4850704872895, 1006.6124542051326, 1017.3387298256156, 1017.3895662602416, 1021.1830535571551, 1021.4688362051729, 999.4203362050066, 1015.9847602285971, 1016.1768967136643, 1018.6536577563664, 1020.8877023527406, 749.0599297881179, 760.2929275773529, 761.5506850957961, 762.1958833430729, 763.9770806875803, 16435.83564164355, 16744.0, 16823.579410514714, 16912.49262522114, 17076.658466830595, 13584.0, 14388.136711797326, 14403.78394324086, 14659.193744344057, 14678.192699401528, 9607.711768646952, 11530.884691153065, 11653.766924661544, 11730.53077876884, 12159.392030398445, 3738.813059347049, 3775.924481510382, 3825.1393436476847, 3830.7318487705593, 3907.7459965102175, 96142.0, 104496.0, 106021.0, 107454.46272768587, 107567.46216268947, 9693.176080033136, 11271.830922536168, 11375.943120284346, 11386.94306528462, 11411.714707132389, 20980.475488112614, 24729.134480293462, 24915.0, 25214.873925630254, 25309.62035569468, 7801.375889928792, 7804.208463677041, 7858.214178582096, 8069.394795390369, 8141.389395795339, 3840.231953609289, 4229.978850105791, 4257.8509752158525, 4274.508431530414, 4286.0, 3390.1694084949345, 3423.9144021399666, 3438.8108654023767, 3460.186856088817, 3477.652234776502, 527.459354161987, 630.6625955113992, 630.7981445937256, 635.7488791927162, 643.3694978920684, 608.5323369524816, 612.7671484835734, 642.1876326447049, 644.9484041276687, 664.7407511070686, 9147.63409463614, 9637.325387222967, 9770.31607787448, 9860.556274967643, 9881.357711748857, 583.3874431846544, 643.8712257548509, 656.3436563436563, 659.3274859643137, 666.3037126203129, 3445.896623101311, 4413.183561041217, 4732.692374995683, 4752.405949256343, 4804.663673542888, 86917.1308286909, 104254.47872760739, 107598.0, 107934.74619911096, 110286.0, 56694.0, 63462.682686586275, 77404.61297693588, 79416.6029169862, 93778.0, 79279.20720792719, 79479.0, 79539.60230198812, 79787.0, 81537.0, 10779.461026948778, 10796.946015269874, 11047.392393418439, 11117.499712513118, 11224.326540407601, 42569.0, 46364.6090617282, 49521.75239123782, 49701.0, 51994.74002629962, 62048.68975655093, 65084.0, 67221.0, 70283.59432811418, 70630.64684676749, 13416.932915335361, 13484.730305393641, 13554.390052447861, 13594.52419165364, 14127.293635318398, 14611.707765844836, 14664.706705866036, 14676.853231467549, 14878.628034299229, 15180.696386072437, 13565.728685426038, 13575.321233938066, 13641.288338350987, 13687.520936767165, 13823.930880345533, 11321.660350189508, 13583.660408489866, 13705.794413084011, 14079.0, 14154.575362739135, 13204.141730787467, 13296.0, 13360.532381366605, 13494.93252533731, 13711.588652340446, 10734.355938643706, 10967.725806854893, 11142.240525878165, 11587.88412115868, 11832.053435724949, 8730.956345218234, 8779.736607901774, 9671.758206044906, 11269.943650281695, 11371.48828302745], "value": 7613.120915111221, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1620.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 124.0, 128.0, 182.0, 127.0, 122.0, 123.0, 140.0, 183.0, 156.0], "value": 139.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 141.0, 152.0, 115.0, 112.0, 114.0, 131.0, 169.0, 108.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [223.0, 224.0, 255.0, 276.0, 273.0, 206.0, 213.0, 237.0, 234.0, 281.0], "value": 242.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 63.0, 73.0, 87.0, 69.0, 86.0, 54.0, 78.0, 99.0, 51.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 86.0, 72.0, 72.0, 73.0, 76.0, 91.0, 61.0, 100.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 106.0, 136.0, 90.0, 92.0, 87.0, 137.0, 135.0, 89.0, 90.0], "value": 105.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 103.0, 101.0, 136.0, 135.0, 96.0, 97.0, 96.0, 106.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 91.0, 90.0, 119.0, 115.0, 145.0, 148.0, 96.0, 91.0, 92.0], "value": 113.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 73.0, 69.0, 67.0, 68.0, 80.0, 69.0, 67.0], "value": 69.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 58.0, 65.0, 99.0, 88.0, 58.0, 58.0, 67.0, 68.0, 61.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 91.0, 88.0, 85.0, 88.0, 88.0, 86.0, 88.0, 85.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 145.0, 142.0, 170.0, 151.0, 131.0, 142.0, 148.0, 177.0, 167.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 219.0, 187.0, 174.0, 177.0, 180.0, 205.0, 173.0, 178.0, 178.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 72.0, 69.0, 70.0, 66.0, 68.0, 68.0, 66.0, 67.0], "value": 68.1, "unit": "score"}]}]} 04:33:00 INFO - Return code: 0 04:33:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:33:00 ERROR - # TBPL SUCCESS # 04:33:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:00 INFO - 2017-03-09 04:33:00.358 screenresolution[11625:239113] starting screenresolution argv=screenresolution get 04:33:00 INFO - 2017-03-09 04:33:00.361 screenresolution[11625:239113] Display 0: 1600x1200x32@60 04:33:00 INFO - 2017-03-09 04:33:00.367 screenresolution[11626:239116] starting screenresolution argv=screenresolution list 04:33:00 INFO - Available Modes on Display 0 04:33:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:00 INFO - Intel Iris: 04:33:00 INFO - Chipset Model: Intel Iris 04:33:00 INFO - Type: GPU 04:33:00 INFO - Bus: Built-In 04:33:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:00 INFO - Vendor: Intel (0x8086) 04:33:00 INFO - Device ID: 0x0a2e 04:33:00 INFO - Revision ID: 0x0009 04:33:00 INFO - Displays: 04:33:00 INFO - Display: 04:33:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:00 INFO - Display Serial Number: 1600x1200 60 04:33:00 INFO - Main Display: Yes 04:33:00 INFO - Mirror: Off 04:33:00 INFO - Online: Yes 04:33:00 INFO - Rotation: Supported 04:33:00 INFO - Return code: 0 04:33:00 INFO - Running post-action listener: _resource_record_post_action 04:33:00 INFO - [mozharness: 2017-03-09 12:33:00.609609Z] Finished run-tests step (success) 04:33:00 INFO - Running post-run listener: _resource_record_post_run 04:33:00 INFO - Total resource usage - Wall time: 1203s; CPU: 55.0%; Read bytes: 3901440; Write bytes: 517898240; Read time: 59; Write time: 1670 04:33:00 INFO - TinderboxPrint: CPU usage
54.9% 04:33:00 INFO - TinderboxPrint: I/O read bytes / time
3,901,440 / 59 04:33:00 INFO - TinderboxPrint: I/O write bytes / time
517,898,240 / 1,670 04:33:00 INFO - TinderboxPrint: CPU idle
2,170.7 (45.1%) 04:33:00 INFO - TinderboxPrint: CPU system
974.9 (20.3%) 04:33:00 INFO - TinderboxPrint: CPU user
1,668.2 (34.7%) 04:33:00 INFO - TinderboxPrint: Swap in / out
228,528,128 / 0 04:33:00 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202189312; Write bytes: 203507712; Read time: 15889; Write time: 417 04:33:00 INFO - run-tests - Wall time: 1183s; CPU: 55.0%; Read bytes: 3629568; Write bytes: 304482304; Read time: 48; Write time: 1220 04:33:01 INFO - Running post-run listener: _upload_blobber_files 04:33:01 INFO - Blob upload gear active. 04:33:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:33:01 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 04:33:01 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'] 04:33:01 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 04:33:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:33:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:02 INFO - (blobuploader) - INFO - Done attempting. 04:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:03 INFO - (blobuploader) - INFO - Done attempting. 04:33:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:33:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:33:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:04 INFO - (blobuploader) - INFO - Done attempting. 04:33:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:33:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:33:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:33:06 INFO - (blobuploader) - INFO - Done attempting. 04:33:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:33:06 INFO - Return code: 0 04:33:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:33:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:33:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fef697bdd83d113f52d4dafa6527fe9ec847276e657844f9bf335c9b1f832ceb3fb480b5636e0acac85b93b3469158d893bbee83b735612d2fa126c416e978f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5918f02beca79cef846f5ba347e7f3b12480502cdca989d84b189e504246b8e366b63fe2d43487d61337054456611223eedfcb795c34804cc92c64d022b3f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255ec430476a3eb10d3f0c463f1033dc2f67f0342851a8fe9884977c878df5090a27bdd393b574cb38861cc164b73b2858290eaa675f7f74623928f7e8bab15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54995c68e8c7e17b6dcf73dd88c46e12466624eaeb1364220d4700778c2ab4245056e5ab806b8428945857651ffb65f2fa38e6a3c44914e56972e25f549ce3eb"} 04:33:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:33:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:33:06 INFO - Contents: 04:33:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4fef697bdd83d113f52d4dafa6527fe9ec847276e657844f9bf335c9b1f832ceb3fb480b5636e0acac85b93b3469158d893bbee83b735612d2fa126c416e978f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5918f02beca79cef846f5ba347e7f3b12480502cdca989d84b189e504246b8e366b63fe2d43487d61337054456611223eedfcb795c34804cc92c64d022b3f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255ec430476a3eb10d3f0c463f1033dc2f67f0342851a8fe9884977c878df5090a27bdd393b574cb38861cc164b73b2858290eaa675f7f74623928f7e8bab15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54995c68e8c7e17b6dcf73dd88c46e12466624eaeb1364220d4700778c2ab4245056e5ab806b8428945857651ffb65f2fa38e6a3c44914e56972e25f549ce3eb"} 04:33:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:33:06 INFO - Copying logs to upload dir... 04:33:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:33:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.053549 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-09 04:33:06.909206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:06.913141) ========= 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.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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/4fef697bdd83d113f52d4dafa6527fe9ec847276e657844f9bf335c9b1f832ceb3fb480b5636e0acac85b93b3469158d893bbee83b735612d2fa126c416e978f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5918f02beca79cef846f5ba347e7f3b12480502cdca989d84b189e504246b8e366b63fe2d43487d61337054456611223eedfcb795c34804cc92c64d022b3f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255ec430476a3eb10d3f0c463f1033dc2f67f0342851a8fe9884977c878df5090a27bdd393b574cb38861cc164b73b2858290eaa675f7f74623928f7e8bab15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54995c68e8c7e17b6dcf73dd88c46e12466624eaeb1364220d4700778c2ab4245056e5ab806b8428945857651ffb65f2fa38e6a3c44914e56972e25f549ce3eb"} build_url:https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011602 build_url: 'https://queue.taskcluster.net/v1/task/VivP9G1OTLiFoUMxDokQeg/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/4fef697bdd83d113f52d4dafa6527fe9ec847276e657844f9bf335c9b1f832ceb3fb480b5636e0acac85b93b3469158d893bbee83b735612d2fa126c416e978f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5918f02beca79cef846f5ba347e7f3b12480502cdca989d84b189e504246b8e366b63fe2d43487d61337054456611223eedfcb795c34804cc92c64d022b3f5f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255ec430476a3eb10d3f0c463f1033dc2f67f0342851a8fe9884977c878df5090a27bdd393b574cb38861cc164b73b2858290eaa675f7f74623928f7e8bab15a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/54995c68e8c7e17b6dcf73dd88c46e12466624eaeb1364220d4700778c2ab4245056e5ab806b8428945857651ffb65f2fa38e6a3c44914e56972e25f549ce3eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:06.948419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:06.948759) ========= 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.YNNfMAwxpS/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.adCELVVAZV/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005427 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 04:33:06.997637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 04:33:06.997973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 04:33:06.998290) ========= ========= Total master_lag: 0.19 =========