builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0310 starttime: 1481646001.38 results: success (0) buildid: 20161213065402 builduid: 8d2b213e83244a0ba9816bb3dc0c8db2 revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.377255) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.377998) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.378485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.499894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.500477) ========= 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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-13 08:20:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.0M=0s 2016-12-13 08:20:01 (26.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147055 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.678259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.678582) ========= 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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.025121 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:01.727287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-13 08:20:01.727647) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --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 fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-13 08:20:01,825 truncating revision to first 12 chars 2016-12-13 08:20:01,825 Setting DEBUG logging. 2016-12-13 08:20:01,825 attempt 1/10 2016-12-13 08:20:01,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fee42adb860e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 08:20:03,994 unpacking tar archive at: mozilla-central-fee42adb860e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.449281 ========= master_lag: 3.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-12-13 08:20:07.345580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.345935) ========= script_repo_revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.346345) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.346623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 08:20:07.371085) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-13 08:20:07.371473) ========= /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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:20:07 INFO - MultiFileLogger online at 20161213 08:20:07 in /builds/slave/test 08:20:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:20:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:07 INFO - {'append_to_log': False, 08:20:07 INFO - 'base_work_dir': '/builds/slave/test', 08:20:07 INFO - 'blob_upload_branch': 'Firefox', 08:20:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:07 INFO - 'branch': 'Firefox', 08:20:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:07 INFO - 'config_files': ('talos/mac_config.py',), 08:20:07 INFO - 'default_actions': ('clobber', 08:20:07 INFO - 'read-buildbot-config', 08:20:07 INFO - 'download-and-extract', 08:20:07 INFO - 'populate-webroot', 08:20:07 INFO - 'create-virtualenv', 08:20:07 INFO - 'install', 08:20:07 INFO - 'run-tests'), 08:20:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:07 INFO - 'download_minidump_stackwalk': True, 08:20:07 INFO - 'download_symbols': 'ondemand', 08:20:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:07 INFO - 'installer_path': 'installer.exe', 08:20:07 INFO - 'log_level': 'info', 08:20:07 INFO - 'log_name': 'talos', 08:20:07 INFO - 'log_to_console': True, 08:20:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:20:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:20:07 INFO - 'opt_config_files': (), 08:20:07 INFO - 'pip_index': False, 08:20:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:07 INFO - 'cmd': ('bash', 08:20:07 INFO - '-c', 08:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:07 INFO - 'enabled': True, 08:20:07 INFO - 'halt_on_failure': False, 08:20:07 INFO - 'name': 'check_screen_resolution'},), 08:20:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:20:07 INFO - 'cmd': ('bash', 08:20:07 INFO - '-c', 08:20:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:20:07 INFO - 'enabled': True, 08:20:07 INFO - 'halt_on_failure': False, 08:20:07 INFO - 'name': 'check_screen_resolution'},), 08:20:07 INFO - 'run_cmd_checks_enabled': True, 08:20:07 INFO - 'sps_profile': False, 08:20:07 INFO - 'sps_profile_interval': 0, 08:20:07 INFO - 'suite': 'dromaeojs-e10s', 08:20:07 INFO - 'system_bits': '32', 08:20:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:07 INFO - 'title': 't-yosemite-r7-0310', 08:20:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:07 INFO - 'use_talos_json': True, 08:20:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:07 INFO - 'work_dir': 'build'} 08:20:07 INFO - [mozharness: 2016-12-13 16:20:07.576669Z] Running clobber step. 08:20:07 INFO - Running pre-action listener: _resource_record_pre_action 08:20:07 INFO - Running main action method: clobber 08:20:07 INFO - rmtree: /builds/slave/test/build 08:20:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.703729Z] Finished clobber step (success) 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.703964Z] Running read-buildbot-config step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: read_buildbot_config 08:20:09 INFO - Using buildbot properties: 08:20:09 INFO - { 08:20:09 INFO - "project": "", 08:20:09 INFO - "product": "firefox", 08:20:09 INFO - "script_repo_revision": "production", 08:20:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:20:09 INFO - "repository": "", 08:20:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:20:09 INFO - "buildid": "20161213065402", 08:20:09 INFO - "pgo_build": "False", 08:20:09 INFO - "basedir": "/builds/slave/test", 08:20:09 INFO - "buildnumber": 29, 08:20:09 INFO - "slavename": "t-yosemite-r7-0310", 08:20:09 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:20:09 INFO - "platform": "yosemite_r7", 08:20:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:20:09 INFO - "branch": "mozilla-central", 08:20:09 INFO - "repo_path": "mozilla-central", 08:20:09 INFO - "revision": "fee42adb860ed03be0de7dcb91cbfd2efcd8c01e", 08:20:09 INFO - "stage_platform": "macosx64", 08:20:09 INFO - "builduid": "8d2b213e83244a0ba9816bb3dc0c8db2", 08:20:09 INFO - "slavebuilddir": "test" 08:20:09 INFO - } 08:20:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.709754Z] Finished read-buildbot-config step (success) 08:20:09 INFO - [mozharness: 2016-12-13 16:20:09.709942Z] Running download-and-extract step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: download_and_extract 08:20:09 INFO - mkdir: /builds/slave/test/build/tests 08:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:09 INFO - trying https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 08:20:11 INFO - Downloaded 1235 bytes. 08:20:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 08:20:11 INFO - Using the following test package requirements: 08:20:11 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:20:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 08:20:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 08:20:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'jsshell-mac64.zip'], 08:20:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 08:20:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 08:20:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 08:20:11 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 08:20:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 08:20:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 08:20:11 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 08:20:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 08:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:20:12 INFO - Expected file size: 16276173 08:20:12 INFO - Obtained file size: 16276173 08:20:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 08:20:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 08:20:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 08:20:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 08:20:19 INFO - Expected file size: 16276173 08:20:19 INFO - Obtained file size: 16276173 08:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 08:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 08:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 08:20:27 INFO - Expected file size: 14409734 08:20:27 INFO - Obtained file size: 14409734 08:20: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')]} 08:20:27 INFO - trying https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 08:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 08:20:29 INFO - Downloaded 69713578 bytes. 08:20:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:29 INFO - mkdir: /builds/slave/test/properties 08:20:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:29 INFO - Contents: 08:20:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 08:20:30 INFO - Running post-action listener: _resource_record_post_action 08:20:30 INFO - Running post-action listener: set_extra_try_arguments 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.023803Z] Finished download-and-extract step (success) 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.023930Z] Running populate-webroot step. 08:20:30 INFO - Running pre-action listener: _resource_record_pre_action 08:20:30 INFO - Running main action method: populate_webroot 08:20:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:30 INFO - '--tppagecycles', 08:20:30 INFO - '7'], 08:20:30 INFO - 'tests': ['tsvgm']}}, 08:20:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['damp', 'tps']}, 08:20:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'tests': ['damp', 'tps']}, 08:20:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['dromaeo_dom']}, 08:20:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['basic_compositor_video']}, 08:20:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:20:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['a11yr', 08:20:30 INFO - 'ts_paint', 08:20:30 INFO - 'tpaint', 08:20:30 INFO - 'sessionrestore', 08:20:30 INFO - 'sessionrestore_no_auto_restore', 08:20:30 INFO - 'tabpaint']}, 08:20:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tsvgx', 08:20:30 INFO - 'tsvgr_opacity', 08:20:30 INFO - 'tart', 08:20:30 INFO - 'tscrollx', 08:20:30 INFO - 'cart', 08:20:30 INFO - 'tsvg_static']}, 08:20:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:30 INFO - 'tsvgr_opacity', 08:20:30 INFO - 'tart', 08:20:30 INFO - 'tscrollx', 08:20:30 INFO - 'cart', 08:20:30 INFO - 'tsvg_static']}, 08:20:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s'], 08:20:30 INFO - 'tests': ['tp5o']}, 08:20:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:20:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--disable-e10s', 08:20:30 INFO - '--xperf_path', 08:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:30 INFO - 'tests': ['tp5n']}, 08:20:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:20:30 INFO - 'talos_options': ['--xperf_path', 08:20:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:30 INFO - 'tests': ['tp5n']}}, 08:20:30 INFO - 'talos.zip': {'path': '', 08:20:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:30 INFO - Running post-action listener: _resource_record_post_action 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.042242Z] Finished populate-webroot step (success) 08:20:30 INFO - [mozharness: 2016-12-13 16:20:30.042365Z] Running create-virtualenv step. 08:20:30 INFO - Running pre-action listener: _resource_record_pre_action 08:20:30 INFO - Running main action method: create_virtualenv 08:20:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:20:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:30 INFO - Using real prefix '/tools/python27' 08:20:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:33 INFO - Installing pip.................done. 08:20:33 INFO - Return code: 0 08:20:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:34 INFO - Reading from file tmpfile_stdout 08:20:34 INFO - Output received: 08:20:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:20:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:34 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:34 INFO - 'HOME': '/Users/cltbld', 08:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:34 INFO - 'LOGNAME': 'cltbld', 08:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:34 INFO - 'MOZ_NO_REMOTE': '1', 08:20:34 INFO - 'NO_EM_RESTART': '1', 08:20:34 INFO - 'PAGER': '/bin/cat', 08:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:34 INFO - 'PWD': '/builds/slave/test', 08:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:34 INFO - 'SHELL': '/bin/bash', 08:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:34 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:34 INFO - 'USER': 'cltbld', 08:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:34 INFO - 'XPC_FLAGS': '0x0', 08:20:34 INFO - 'XPC_SERVICE_NAME': '0', 08:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:20:34 INFO - Cleaning up... 08:20:34 INFO - Return code: 0 08:20:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:35 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:35 INFO - 'HOME': '/Users/cltbld', 08:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:35 INFO - 'LOGNAME': 'cltbld', 08:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:35 INFO - 'MOZ_NO_REMOTE': '1', 08:20:35 INFO - 'NO_EM_RESTART': '1', 08:20:35 INFO - 'PAGER': '/bin/cat', 08:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:35 INFO - 'PWD': '/builds/slave/test', 08:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:35 INFO - 'SHELL': '/bin/bash', 08:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:35 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:35 INFO - 'USER': 'cltbld', 08:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:35 INFO - 'XPC_FLAGS': '0x0', 08:20:35 INFO - 'XPC_SERVICE_NAME': '0', 08:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:35 INFO - Downloading/unpacking psutil>=3.1.1 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:39 INFO - Installing collected packages: psutil 08:20:39 INFO - Running setup.py install for psutil 08:20:39 INFO - building 'psutil._psutil_osx' extension 08:20:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:20:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:20:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:20:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:20:40 INFO - building 'psutil._psutil_posix' extension 08:20:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:20:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:20:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:20:40 INFO - ^ 08:20:40 INFO - 1 warning generated. 08:20:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:40 INFO - Successfully installed psutil 08:20:40 INFO - Cleaning up... 08:20:40 INFO - Return code: 0 08:20:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:20: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 mozsystemmonitor==0.3 08:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:40 INFO - 'HOME': '/Users/cltbld', 08:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:40 INFO - 'LOGNAME': 'cltbld', 08:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:40 INFO - 'MOZ_NO_REMOTE': '1', 08:20:40 INFO - 'NO_EM_RESTART': '1', 08:20:40 INFO - 'PAGER': '/bin/cat', 08:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:40 INFO - 'PWD': '/builds/slave/test', 08:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:40 INFO - 'SHELL': '/bin/bash', 08:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:40 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:40 INFO - 'USER': 'cltbld', 08:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:40 INFO - 'XPC_FLAGS': '0x0', 08:20:40 INFO - 'XPC_SERVICE_NAME': '0', 08:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:43 INFO - Installing collected packages: mozsystemmonitor 08:20:43 INFO - Running setup.py install for mozsystemmonitor 08:20:43 INFO - Successfully installed mozsystemmonitor 08:20:43 INFO - Cleaning up... 08:20:43 INFO - Return code: 0 08:20:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:20:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:43 INFO - 'HOME': '/Users/cltbld', 08:20:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:43 INFO - 'LOGNAME': 'cltbld', 08:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:43 INFO - 'MOZ_NO_REMOTE': '1', 08:20:43 INFO - 'NO_EM_RESTART': '1', 08:20:43 INFO - 'PAGER': '/bin/cat', 08:20:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:43 INFO - 'PWD': '/builds/slave/test', 08:20:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:43 INFO - 'SHELL': '/bin/bash', 08:20:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:43 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:43 INFO - 'USER': 'cltbld', 08:20:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:43 INFO - 'XPC_FLAGS': '0x0', 08:20:43 INFO - 'XPC_SERVICE_NAME': '0', 08:20:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:43 INFO - Downloading/unpacking jsonschema==2.5.1 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:47 INFO - warning: no files found matching '*.txt' 08:20:47 INFO - no previously-included directories found matching 'build' 08:20:47 INFO - no previously-included directories found matching 'dist' 08:20:47 INFO - no previously-included directories found matching '.git*' 08:20:47 INFO - Installing collected packages: jsonschema, functools32 08:20:47 INFO - Running setup.py install for functools32 08:20:47 INFO - warning: no files found matching '*.txt' 08:20:47 INFO - no previously-included directories found matching 'build' 08:20:47 INFO - no previously-included directories found matching 'dist' 08:20:47 INFO - no previously-included directories found matching '.git*' 08:20:47 INFO - Successfully installed jsonschema functools32 08:20:47 INFO - Cleaning up... 08:20:47 INFO - Return code: 0 08:20:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:47 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:47 INFO - 'HOME': '/Users/cltbld', 08:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:47 INFO - 'LOGNAME': 'cltbld', 08:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:47 INFO - 'MOZ_NO_REMOTE': '1', 08:20:47 INFO - 'NO_EM_RESTART': '1', 08:20:47 INFO - 'PAGER': '/bin/cat', 08:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:47 INFO - 'PWD': '/builds/slave/test', 08:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:47 INFO - 'SHELL': '/bin/bash', 08:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:47 INFO - 'USER': 'cltbld', 08:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:47 INFO - 'XPC_FLAGS': '0x0', 08:20:47 INFO - 'XPC_SERVICE_NAME': '0', 08:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:47 INFO - Cleaning up... 08:20:47 INFO - Return code: 0 08:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:47 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:20:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:47 INFO - 'HOME': '/Users/cltbld', 08:20:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:47 INFO - 'LOGNAME': 'cltbld', 08:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:47 INFO - 'MOZ_NO_REMOTE': '1', 08:20:47 INFO - 'NO_EM_RESTART': '1', 08:20:47 INFO - 'PAGER': '/bin/cat', 08:20:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:47 INFO - 'PWD': '/builds/slave/test', 08:20:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:47 INFO - 'SHELL': '/bin/bash', 08:20:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:47 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:47 INFO - 'USER': 'cltbld', 08:20:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:47 INFO - 'XPC_FLAGS': '0x0', 08:20:47 INFO - 'XPC_SERVICE_NAME': '0', 08:20:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:51 INFO - Downloading docopt-0.6.1.tar.gz 08:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:51 INFO - Running setup.py install for blobuploader 08:20:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:52 INFO - Running setup.py install for requests 08:20:52 INFO - Running setup.py install for docopt 08:20:52 INFO - Successfully installed blobuploader requests docopt 08:20:52 INFO - Cleaning up... 08:20:52 INFO - Return code: 0 08:20:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:52 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:52 INFO - 'HOME': '/Users/cltbld', 08:20:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:52 INFO - 'LOGNAME': 'cltbld', 08:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:52 INFO - 'MOZ_NO_REMOTE': '1', 08:20:52 INFO - 'NO_EM_RESTART': '1', 08:20:52 INFO - 'PAGER': '/bin/cat', 08:20:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:52 INFO - 'PWD': '/builds/slave/test', 08:20:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:52 INFO - 'SHELL': '/bin/bash', 08:20:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:52 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:52 INFO - 'USER': 'cltbld', 08:20:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:52 INFO - 'XPC_FLAGS': '0x0', 08:20:52 INFO - 'XPC_SERVICE_NAME': '0', 08:20:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-J6uHAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Pzsryo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-A0ioMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-EO6Hpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-efid0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-LIXo2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-k80YDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-BvGpno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:53 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-l4pP_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-DtJAC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-HhSDwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-DRqfhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Ne3CuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-QUHmvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-0GmwVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-mtxNfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:54 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-KeZHF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:54 INFO - Running setup.py install for manifestparser 08:20:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:54 INFO - Running setup.py install for mozcrash 08:20:55 INFO - Running setup.py install for mozdebug 08:20:55 INFO - Running setup.py install for mozdevice 08:20:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozfile 08:20:55 INFO - Running setup.py install for mozhttpd 08:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozinfo 08:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozInstall 08:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:55 INFO - Running setup.py install for mozleak 08:20:56 INFO - Running setup.py install for mozlog 08:20:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for moznetwork 08:20:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozprocess 08:20:56 INFO - Running setup.py install for mozprofile 08:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozrunner 08:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:56 INFO - Running setup.py install for mozscreenshot 08:20:57 INFO - Running setup.py install for moztest 08:20:57 INFO - Running setup.py install for mozversion 08:20:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:57 INFO - Cleaning up... 08:20:57 INFO - Return code: 0 08:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:57 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:20:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:20:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:57 INFO - 'HOME': '/Users/cltbld', 08:20:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:57 INFO - 'LOGNAME': 'cltbld', 08:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:57 INFO - 'MOZ_NO_REMOTE': '1', 08:20:57 INFO - 'NO_EM_RESTART': '1', 08:20:57 INFO - 'PAGER': '/bin/cat', 08:20:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:57 INFO - 'PWD': '/builds/slave/test', 08:20:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:57 INFO - 'SHELL': '/bin/bash', 08:20:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:20:57 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:20:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:57 INFO - 'USER': 'cltbld', 08:20:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:57 INFO - 'XPC_FLAGS': '0x0', 08:20:57 INFO - 'XPC_SERVICE_NAME': '0', 08:20:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:57 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ZnXGB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:57 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-vs7QiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:57 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-kyQJhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-6UxZ11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-P3CsOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-FRmZyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-wqeCO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-JQXbYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Fu3OYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-skZNtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-RUEdfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-wbfzDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:58 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-xU6FH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:59 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-L5d5zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:59 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-KWonro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-dzAqZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:59 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-VrHKKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:01 INFO - Downloading blessings-1.6.tar.gz 08:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:21:02 INFO - Installing collected packages: blessings 08:21:02 INFO - Running setup.py install for blessings 08:21:02 INFO - Successfully installed blessings 08:21:02 INFO - Cleaning up... 08:21:02 INFO - Return code: 0 08:21:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:21:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:02 INFO - Reading from file tmpfile_stdout 08:21:02 INFO - Current package versions: 08:21:02 INFO - blessings == 1.6 08:21:02 INFO - blobuploader == 1.2.4 08:21:02 INFO - docopt == 0.6.1 08:21:02 INFO - functools32 == 3.2.3-2 08:21:02 INFO - jsonschema == 2.5.1 08:21:02 INFO - manifestparser == 1.1 08:21:02 INFO - mozInstall == 1.12 08:21:02 INFO - mozcrash == 1.0 08:21:02 INFO - mozdebug == 0.1 08:21:02 INFO - mozdevice == 0.49 08:21:02 INFO - mozfile == 1.2 08:21:02 INFO - mozhttpd == 0.7 08:21:02 INFO - mozinfo == 0.9 08:21:02 INFO - mozleak == 0.1 08:21:02 INFO - mozlog == 3.4 08:21:02 INFO - moznetwork == 0.27 08:21:02 INFO - mozprocess == 0.23 08:21:02 INFO - mozprofile == 0.28 08:21:02 INFO - mozrunner == 6.13 08:21:02 INFO - mozscreenshot == 0.1 08:21:02 INFO - mozsystemmonitor == 0.3 08:21:02 INFO - moztest == 0.7 08:21:02 INFO - mozversion == 1.4 08:21:02 INFO - psutil == 3.1.1 08:21:02 INFO - requests == 1.2.3 08:21:02 INFO - wsgiref == 0.1.2 08:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:02 INFO - 'HOME': '/Users/cltbld', 08:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PAGER': '/bin/cat', 08:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:21:02 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - 'XPC_FLAGS': '0x0', 08:21:02 INFO - 'XPC_SERVICE_NAME': '0', 08:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:21:02 INFO - Cleaning up... 08:21:02 INFO - Return code: 0 08:21:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:02 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 0x107daf3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107d25570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c49570c80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, '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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:21:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:21:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:02 INFO - 'HOME': '/Users/cltbld', 08:21:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PAGER': '/bin/cat', 08:21:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:21:02 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:21:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - 'XPC_FLAGS': '0x0', 08:21:02 INFO - 'XPC_SERVICE_NAME': '0', 08:21:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:21:03 INFO - Cleaning up... 08:21:03 INFO - Return code: 0 08:21:03 INFO - Running post-action listener: _resource_record_post_action 08:21:03 INFO - Running post-action listener: _start_resource_monitoring 08:21:03 INFO - Starting resource monitoring. 08:21:03 INFO - [mozharness: 2016-12-13 16:21:03.214591Z] Finished create-virtualenv step (success) 08:21:03 INFO - [mozharness: 2016-12-13 16:21:03.215572Z] Running install step. 08:21:03 INFO - Running pre-action listener: _resource_record_pre_action 08:21:03 INFO - Running main action method: install 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:21:03 INFO - Reading from file tmpfile_stdout 08:21:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:21:03 INFO - Reading from file tmpfile_stdout 08:21:03 INFO - Output received: 08:21:03 INFO - Usage: mozinstall [options] installer 08:21:03 INFO - Options: 08:21:03 INFO - -h, --help show this help message and exit 08:21:03 INFO - -d DEST, --destination=DEST 08:21:03 INFO - Directory to install application into. [default: 08:21:03 INFO - "/builds/slave/test"] 08:21:03 INFO - --app=APP Application being installed. [default: firefox] 08:21:03 INFO - mkdir: /builds/slave/test/build/application 08:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 08:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 08:21:25 INFO - Reading from file tmpfile_stdout 08:21:25 INFO - Output received: 08:21:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:21:25 INFO - Running post-action listener: _resource_record_post_action 08:21:25 INFO - [mozharness: 2016-12-13 16:21:25.521033Z] Finished install step (success) 08:21:25 INFO - [mozharness: 2016-12-13 16:21:25.521182Z] Running run-tests step. 08:21:25 INFO - Running pre-action listener: _resource_record_pre_action 08:21:25 INFO - Running main action method: run_tests 08:21:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:21:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:21:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:21:25 INFO - 2016-12-13 08:21:25.535 screenresolution[1625:7656] starting screenresolution argv=screenresolution get 08:21:25 INFO - 2016-12-13 08:21:25.538 screenresolution[1625:7656] Display 0: 1600x1200x32@60 08:21:25 INFO - 2016-12-13 08:21:25.544 screenresolution[1626:7659] starting screenresolution argv=screenresolution list 08:21:25 INFO - Available Modes on Display 0 08:21:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:21:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:21:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:21:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:21:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:21:25 INFO - Intel Iris: 08:21:25 INFO - Chipset Model: Intel Iris 08:21:25 INFO - Type: GPU 08:21:25 INFO - Bus: Built-In 08:21:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:21:25 INFO - Vendor: Intel (0x8086) 08:21:25 INFO - Device ID: 0x0a2e 08:21:25 INFO - Revision ID: 0x0009 08:21:25 INFO - Displays: 08:21:25 INFO - Display: 08:21:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:21:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:21:25 INFO - Display Serial Number: 1600x1200 60 08:21:25 INFO - Main Display: Yes 08:21:25 INFO - Mirror: Off 08:21:25 INFO - Online: Yes 08:21:25 INFO - Rotation: Supported 08:21:25 INFO - Return code: 0 08:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:25 INFO - Python 2.7.3 08:21:25 INFO - Return code: 0 08:21:25 INFO - grabbing minidump binary from tooltool 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:25 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 0x107bc4d30>, '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 0x107a2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107bbcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:21:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:21:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:21:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:25 INFO - Return code: 0 08:21:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0310 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3TDOHIzV9Z/Render', 08:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:21:25 INFO - 'HOME': '/Users/cltbld', 08:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:21:25 INFO - 'LOGNAME': 'cltbld', 08:21:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:25 INFO - 'MOZ_NO_REMOTE': '1', 08:21:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:25 INFO - 'NO_EM_RESTART': '1', 08:21:25 INFO - 'PAGER': '/bin/cat', 08:21:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:25 INFO - 'PWD': '/builds/slave/test', 08:21:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:21:25 INFO - 'SHELL': '/bin/bash', 08:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7an1Zh1eC3/Listeners', 08:21:25 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 08:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:21:25 INFO - 'USER': 'cltbld', 08:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:25 INFO - 'XPC_FLAGS': '0x0', 08:21:25 INFO - 'XPC_SERVICE_NAME': '0', 08:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:21:25 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/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:21:26 INFO - mozversion application_buildid: 20161213065402 08:21:26 INFO - mozversion application_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 08:21:26 INFO - mozversion application_display_name: Nightly 08:21:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:26 INFO - mozversion application_name: Firefox 08:21:26 INFO - mozversion application_remotingname: firefox 08:21:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:21:26 INFO - mozversion application_vendor: Mozilla 08:21:26 INFO - mozversion application_version: 53.0a1 08:21:26 INFO - mozversion platform_buildid: 20161213065402 08:21:26 INFO - mozversion platform_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 08:21:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:21:26 INFO - mozversion platform_version: 53.0a1 08:21:26 INFO - using testdate: 1481646086 08:21:26 INFO - actual date: 1481646086 08:21:26 INFO - starting webserver on 'localhost:49245' 08:21:26 INFO - SUITE-START | Running 2 tests 08:21:26 INFO - TEST-START | dromaeo_css 08:21:26 INFO - operating with platform_type : mac_ 08:21:26 INFO - Initialising browser for dromaeo_css test... 08:21:26 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpTVIiYh/profile http://localhost:49245/getInfo.html) 08:21:29 INFO - PROCESS | 1636 | 2016-12-13 08:21:29.174 plugin-container[1638:7944] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 08:21:29 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:29 INFO - PROCESS | 1636 | 2016-12-13 08:21:29.176 plugin-container[1638:7944] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 08:21:29 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:29 INFO - PROCESS | 1636 | 2016-12-13 08:21:29.177 plugin-container[1638:7944] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:21:29 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 08:21:29 INFO - PROCESS | 1636 | colorDepth:24 08:21:29 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 08:21:29 INFO - PROCESS | 1636 | __metrics 08:21:29 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 08:21:30 INFO - TEST-INFO | 1636: exit 0 08:21:30 INFO - Browser initialized. 08:21:30 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:30 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpTVIiYh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:32 INFO - PROCESS | 1639 | 2016-12-13 08:21:32.471 plugin-container[1640:8059] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.tsm.portname' 08:21:32 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:32 INFO - PROCESS | 1639 | 2016-12-13 08:21:32.472 plugin-container[1640:8059] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 08:21:32 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:21:32 INFO - PROCESS | 1639 | 2016-12-13 08:21:32.472 plugin-container[1640:8059] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:21:42 INFO - PROCESS | 1639 | RSS: Main: 236724224 08:21:42 INFO - PROCESS | 1639 | 08:22:31 INFO - PROCESS | 1639 | 1481646151741 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:24:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 08:24:46 INFO - PROCESS | 1639 | RSS: Main: 251215872 08:24:46 INFO - PROCESS | 1639 | 08:27:49 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 08:27:49 INFO - PROCESS | 1639 | RSS: Main: 263450624 08:27:49 INFO - PROCESS | 1639 | 08:30:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 08:30:52 INFO - PROCESS | 1639 | RSS: Main: 269086720 08:30:52 INFO - PROCESS | 1639 | 08:33:54 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 08:33:55 INFO - PROCESS | 1639 | RSS: Main: 267898880 08:33:55 INFO - PROCESS | 1639 | 08:36:58 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 08:36:58 INFO - PROCESS | 1639 | RSS: Main: 272482304 08:36:58 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 08:40:01 INFO - PROCESS | 1639 | RSS: Main: 275120128 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | __start_tp_report 08:40:01 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:40:01 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:40:01 INFO - PROCESS | 1639 | |i|pagename|runs| 08:40:01 INFO - PROCESS | 1639 | |0;dojo.html;2476.566600844853;2781.332480204751;3067.7545796336294;3344.8794653790965;3459.066052165915;4197.349410841324;5067.214581739831;5669.518090962263;5705.429457054298;5732.369439361672;5714.914276285859;5726.770929162839;5852.882942341151;5914.940850591493;5915.940840591593;4442.466903971528;4479.39528163697;5256.658317209388;5273.736313184345;5353.57171426285;5267.209918512215;5350.866228344284;5368.91946620801;5371.4897084776885;5411.269478620395;5158.690478571298;5310.150375939869;5317.494837990384;5332.040232758102;5362.892742145174;5203.869903252411;5227.79088836446;5233.031889100528;5239.502247286502;5246.501582349671;5172.922406163911;5173.810023694571;5182.170852663593;5188.273641690166;5219.973900130513;5530.723463826793;5687.658740475544;5719.313682358102;5722.427757224286;5749.137629355589;6217.253929528486;6262.185915830958;6302.747890084391;6304.810855674337;6331.240251169843;6190;6296.433321001132;6300.527460440485;6316.589421687621;6331.303556608769;5646.153077038477;5724.227229324029;5783.103618939072;5786.7395967181155;5853.1220316952795;6239.688015599202;6283.8114856554375;6298.622082675054;6314.936850631527;6319.178506794179;6058.666773327509;6078.969605152034;6081.75672973085;6112.847178820476;6122.142899994004;6133.202683651097;6194.225721784777;6196.504279657616;6208.410201030895;6222.564420490522;6151.046587778901;6155.861165684362;6194.81415557534;6232.626042437469;6253.5622506425025;5261.184516399964;6250.937490625036;6255.624662520263;6263.4362907338555;6292.244930608356;4825.372701548777;4914.70511769295;4950.801967921315;4958.380202474691;4973.825916092919;3673.485712000322;4326.58897404746;4402.537733537933;4453.576910193527;4512.571305725951;5745.396733343023;5866.8533286667325;5872.0898260769645;5889.939810834006;5906.3207731110615;6292.087647291117;6301;6306.653134077578;6310.1481300024825;6328.430441260309;4446.444194475691;5319.547838433699;5713.485786279171;5756.33802112754;5761.222234998221;4039.3738970459626;5422.972885135549;5472.890542189134;5501.174823776386;5509.173623956359;6264.749410023548;6294.213223347082;6306.306306306395;6318.368163183737;6325.683715814283;6137.232845894263;6241.126242326169;6262.34245404226;6307.36926307384;6341.048842673451;6245.68771561411;6250.749970001149;6308.243010838729;6314.02132669437;6325.272593651789;6102.725377358119;6261.499080073492;6266.874662506815;6277;6297.905531416941;6057.969710151421;6136.6722581676495;6197;6254.405831446005;6255.437010669061;6083.300420451705;6124.234470691164;6126.172966649446;6136.846578835565;6137.447629713347;4876.390451193601;5957.940420595739;6133.877322453615;6155.722992465439;6166.938330616816;5840.415958404125;5896.262967129109;5905.202797622266;5973.5519836013345;5976.462118409364;6080.513558915364;6096.847578810565;6101.816945491642;6117.143599896107;6144.880016394337;6017.458428741435;6035.034394496859;6043.516518678583;6058.787942421994;6087.66517841523 08:40:01 INFO - PROCESS | 1639 | |1;ext.html;433.41056163617475;475.22063815342835;484.57841677740373;486.8826044228496;520.789080422429;27769.722302776965;30620.38759224817;39052.60947390525;39061.60938390615;39155.2168956621;39357.60642393575;40039.39940900889;40053.799731001374;40105.3957841686;40170.59829401705;8337.291330236938;8615.56922153893;9099.90900090999;9361.22136794007;9372.437653740762;11018.944905275463;11320.981111699944;11336.943315283412;11468;11482.712932176679;11339.659810205707;11347.489362978686;11381.487833047533;11403.828942565868;11407.315561066363;11305.095592352633;11357.886421135765;11367.147463940197;11368.261063030877;11414.71463213418;11146.164037697125;11249.043831274352;11270.718232044183;11280.661580152608;11304.491297891615;38154;38369.80815095906;38594;38598.614013859784;38730.61269387298;3319.9004029879143;3401.9149521262166;3402.4896265560114;3486.3375958568045;3828.9234215315814;29736.256593585116;30487;30488;30531.69468305333;30613.234669133228;3074.8308843013847;3099.6745341739243;3251.5935508061493;3297.0603378037385;3298.752593555469;361783;363258;364061.35938640806;364265;365117;59439;59671;59971.40028599746;60053;60090.699546501986;61693.38306616966;61911.69044154751;61940.69029654823;61951;62044;15604.609884752745;15718.921405392899;15812;15823.367065317489;15835.287412066486;10947.288426252428;11248.100151987821;12080.335581542924;12135.029197664166;12462.563810266598;16163.030218186712;16237.675246495004;17180.6630948518;18981.81018189828;19711.60576788456;6145.692715364214;6984.860302793915;7188.712451501986;7994.40041996841;8041.26081372153;880.6785523283955;944.8299306124826;986.8618393424927;1089.4824958144977;1126.3298337489182;23399.532009360057;29717;29890.551641725393;30077.849610751808;30199.849000754857;905.8550631898996;944.9102335278137;1039.0700323210683;1147.7532330548804;1200.2978257719333;11786.88213117875;13008.544700935421;13790.793138102936;15505.534833955;15604.765928511082;599101;625138.8743056346;650858;663134;664692;57292;57612.423875761546;57804.71097644485;57816.42183578195;57992;1344.5294147048455;1397.1267957526545;1397.8462369139386;1403.943842246319;1407.9155250684787;25495.74504255008;28610.713892860804;29322.56016159802;29911.401771964003;29963;48630.78423039452;49708.50291497183;50205;50250.74874625603;52763.73618131885;619811;627251;627949;628025;629443;32081.67918320787;32411.837940810146;38043.80978095092;38434.80782596069;38563.421548677354;37216.44175337318;41227.175456490106;41268.79365603153;41438;41919;33157.50263745998;33736.49395259122;34208.657913420546;34378;34573.48139777855;29453.96911108101;33170;34436.48345274773;34731.4790278141;35413.64586354104;34274.14314642154;34334.53651025351;34433.82783086068;34657.48013779745;35589.64410355863;29692.109236722932;31704.682953170173;31772.364552709278;31826.204344890637;31908.6809131915;21719.239826605994;23858.880705596363;24166.516669666158;24418.63372049385;24422.900969456772 08:40:01 INFO - PROCESS | 1639 | |2;jquery.html;319.75059453626153;335.4185017641819;382.60400485497513;387.2274811750558;397.90575916230364;18080.638387232262;19338.709919351204;19992.200311987504;19995.900020499877;20157.59684806303;17934.641307173883;18482.537936551595;18744.06279686017;19341.419757407264;20197.99010049499;5665.150227465882;5827.912581311284;5960.493358064569;5967.746773177638;5967.850803729898;5470.5350045246205;5735.225744524499;5760.6255593386295;5808.070708686611;5823.475887170154;5739.397363276858;5754.568407369443;5755.25181726375;5765.106408506688;5775.509081728058;5499.257600223978;5751.194832723422;5795.2176456178295;5795.594308398414;5797;5071.442141364447;5077.822276220315;5083.237514372874;5084.79660813567;5085.415177254626;11650.883491165065;12466.376681165906;12730.681732956658;13102.672433189247;13146;2137.7114089598017;2156.795104465089;2215.8448908576406;2326.6161083421216;2863.7852161087794;9203.953980230122;10023.097921187129;10148;10337.9483102584;10372.48137593125;1506.495324066439;1836.9448916532526;1840.6226723521645;1848.815118488154;1862.5157459060606;98330.50834745853;106860.4656976718;114276;114801.85198148078;127072.36463817714;9137.994820569733;10173.491325433699;10235.130013948748;11691.649250522498;11866.821997670042;14613.977021608385;14676.926615366854;14682.265886705622;14694.338754756061;14708;8050.355971522265;8282.917170828214;8305.875411868827;8383.538905360141;8409;7288.96355518219;8051.597420129087;8105.351571874236;8204.343652507785;8214.507129572245;3678.7424880258127;4512.4133862597655;4515.119551687455;4515.187266292099;4673.7429441381055;1735.3318972195543;1752.7283271093002;1893.8863668179954;1955.247229816531;1996.760388753359;828.1925123005022;831.9642045653201;873.3100850328169;919.3656377099913;966.3815158298695;19157.80842191588;20317.390478285673;20441.48896277605;20539.973001349874;20944;904.2359206470522;906.207068814787;911.6353458616607;941.755143662639;972.3776782858976;8787.340949428819;10535.367877927349;10780.137588992862;10830.566777328819;10865.945670271598;559407;562923;563209;564923;567936;133301;137130;139276.5180870466;141072;144390;1002.8295189817749;1006.2805094357716;1060.2472244706346;1064.3135177810425;1065.1957771882335;14548.927255363655;15588.986715863433;16770.245338959532;19018.4747785353;19191.808081919004;45153;53250;57025;57236.42763572311;57521.71239143777;80134.59932700299;82373.76439353294;82641.17358826335;82825.58587207267;83912;7895.68417263303;8090.757277281691;8097.975506123469;8170.264676178935;8281.83436331282;11320;12478.87521124777;12647.660182865831;12803.679908002374;12923.870761292643;9515.666951656658;10588.523516441932;10712.410817405118;10961.725956851142;10989.670309890716;8256.926599542021;8990.190882820578;10514.948505149423;10578.206634502289;11073.778524429305;10257.33327333721;11149.275297105662;11222.326660400402;11431.42842857837;11491.195616306779;7948.682052717826;8020.639071241925;8048.235417635316;8082.434229603871;8121.187881211831;9114.131603021233;9951.601935922483;10905.073068789241;10955.945220273848;11125.888741112485 08:40:01 INFO - PROCESS | 1639 | |3;mootools.html;1327.522092046863;1505.315081637855;1685.921010553246;1831.7160840069794;1864.1611274926279;7375.963120184405;7680.539167649945;7913.32736717379;8366.456180348274;8378.455400398978;7825.960870195655;8133.674653013887;8167.877481837777;8253.422260441772;8259.752207433772;2245.360072379376;2301;2303.1248125712204;2303.435658263728;2306.792388685018;2317.5133222023396;2339.076064954342;2358.162852187466;2358.610829213186;2362.783166669167;2292.873891935943;2310;2325.058351367699;2329.440934175794;2329.8136149108113;2278.065992942894;2296.0930432479245;2307.5038866643754;2311.9537609247723;2312.5721741477796;1797.0834874214115;2317.860928344288;2339.3099035784485;2348.236823032504;2369.2536850891915;7874.921250787476;8223.671053157866;8225.753227403187;8232.135625759329;8259.669613215465;4331;4401.977990110061;4565.429321334833;4849.981503884189;5148.9742551287;3242.157039169809;3329.783564068328;3468.4450487921813;3526.647335266453;3548.733844961638;1025.4155131575005;1038.997367540327;1056.894310568937;1071.464267866067;1075.1989767623093;8653.524056176908;8913.55432228386;10638.734031649194;10654.360738355646;10694.679159625224;4415.867523974286;4451.243288640939;4542.795574199169;4542.795574199169;4546.499885012646;9198.2181514572;9279.118483744034;9299.302552308603;9316.767080823034;9318.254539636813;4323.524412314643;5151.381834179922;5154.587632989352;5175.404828444702;5190.896182076337;4243.469566304212;4401.713888597231;4527.4340707411575;4685.226937555265;4742.5020372861045;3605.8737944171826;3791.677707394847;3812.6568608825337;3859.073822282632;3887.125396785757;1248.1076030638137;1255.736295377981;1260.87391260875;1264.6711854917787;1271.8600953895063;797.6291024673554;847.6842178231445;875.8073223890734;918.8254231695956;941.7033634405141;5676.858078547987;5690.715464226772;5705.372409035002;5739.167820666064;5962.433568810956;911.2846415563884;918.8805455290769;921.4149015375151;930.2139691960418;966.2077096780713;3653.3606618841595;3710.666040056408;3723.6090210528046;3823.617638236154;3841.3469710149343;9573.617055317709;9894.455804930654;9952.203823694088;9954.552045157985;9980;9809.166220871306;9891.703248902544;9911.207103431709;9920.553575089138;9952.502374881227;7700.268474494914;7830.060392752906;7844.568548729761;7847.764567062997;7849.293563579191;5275.709835958905;5378.650387724785;5513.751881165277;5516.668999860021;5568.081266590967;9146.908530914605;9343.71968840936;9347;9361.578728957349;9380.577873995822;8890.288776897962;9273.814523709623;9286.210672092948;9297.814043719223;9411.905880941104;6532.5753826001155;6585.6377899216;6766.8646627068165;7061;7260.927390726025;7667.808304792202;7881.2118788123025;7884.329831964347;7891.250331218525;7893.644785984759;6941.47938904574;7054.047703560159;7084.716611335489;7132.393746531396;7196.316349946746;6760.661966901734;6941.687624057031;6974.5466544676465;6993.860122797617;7040.295970402919;6404.903926441014;6570.441512471302;6626.503012274003;6638.502112341497;6706.530542861953;4104.630583247403;4237.855778939607;4347.934755984804;4723.50403207672;4742.217534106834;4076.8369265229057;4137.1932473168645;4712.835050773207;4814.662973591815;4912.459629440687 08:40:01 INFO - PROCESS | 1639 | |4;prototype.html;313.95290706394053;325.72638983254063;359.6888691282041;368.2285611643607;371.19080404717704;4746.976265118674;4905.803767849291;5517.779288828442;5592.496675299222;5624.943750562493;4585.6560757943125;5509.531689806371;5538.944610553894;5573.519783696247;5612.7754889804355;3770.547534295875;3956.723029387944;4047.838086476545;4185.916281674365;4284.828606855722;3935.60643935607;3955.2880481513316;4321.848735294266;4350;4356.564343565634;4314.482262128549;4317.244482215616;4355.257896841257;4367;4388.210122178007;4213.094184750294;4237.809298581571;4352.6278178392695;4375.278079116958;4378.2119218540965;3722.9441558376648;3785.242951409729;3788.5453745550435;3796.924061518754;3802.448644946495;4727.550882666142;5356.758945847446;5384.761504853866;5462.6995515246645;5477.4796394342475;3954.8418063277436;4538.686758666159;4603.723776573383;4961;5024.422191447957;5444.455554444564;5468.781248750045;5789.321096881899;5840.211571437844;5896.93359453082;4179.895502612429;4194.496660400771;4215.725977811432;4216.51510076342;4236.4704411948505;4982.427020892607;5357.785688572413;6076;6160.938390616081;6194.287656919422;3456.861725531001;3580.3888250287473;3709.9443508347395;4009.67922566194;4248.660107191417;4101.630853223164;4155.896102597399;4290.656747460258;4313.568643135662;4314.870553883388;3973.9667686401745;4079.612436818557;4286.863177034177;4772.260299653559;4926.753662316942;4920.778564964585;5080.542751152414;5460.453954604508;5590.86022849432;5853.765849366063;1315.2897435384784;1426.4650755966513;1436.1115133599283;1440.2366745624836;1458.8905832062637;883.765802062454;937.4796987671771;940.210223412337;977.9951100244454;987.8370068938544;4654.930176047362;5167.302414174038;5175.482451754794;5206.817761378409;5230.293910322134;5473.576870013825;5540.612157148961;5760.36635970043;5785.090919996475;5812.941870581325;4874.976254986422;4905.9754701226975;4954.380702412199;5105.8001369678095;5348.866278343073;2640.966455829001;2646.655934728473;2831.8725657345467;2931.7801164912717;3034.7268745812985;5348.823258883117;5478.890422191614;5601.243832082698;5883.352831188566;5912.70436478183;5508.944910550923;5628.690422026828;5658.85852853682;5757.366689664133;5838.416158384128;4920.21276595743;5754.510866576305;5773.797917072882;5821.941780582225;5823.417658234142;4699;5000.899982000413;5582.4648221737725;5604.495595396271;5719.799807006902;5544.279243698294;5759.992001399654;5910.438508341701;5999.5500337473995;6050.727717252822;4691;5813.447722466528;6046;6209.875802484015;6227.003679411272;3212.4217640824877;3266.820324882154;3298.6041674999155;3384.915377115592;3549.538559987185;4767.952320476751;5250.501202385767;5312.017276803804;5821.505172060422;6070.878582428415;4763.285507173951;4915.606751459946;5598.944010559842;5778.8266352009505;5909.23179986599;5147.624519158835;5617.511359489657;5674.028180273743;5805.303363596396;5854.795082172274;4616.268899162814;5476.698781567052;5616.887662246814;5640.520555752807;5676.4323567642905;5410.404855465817;5790.565707571865;5802.767889284551;5822.592418530662;5859.94140058594;5110.4123025852505;5667.914981275367;5707.6290041147195;5721.971390143022;5741.2536370273265 08:40:01 INFO - PROCESS | 1639 | |5;yui.html;722.8771108911485;731.5976213082803;768.6195333310009;792.2671528835825;803.819140693344;14820.258987050645;15679.216039198052;15695.529134125994;15706.136162511071;15771.763423548642;14094;14299.642508937255;14323.069000514959;14329.211893345862;14331.140131592112;702.722424642266;727.5634619228473;868.4051424774018;874.2830878679486;887.3078998381272;885.6191837509868;895.6417433026776;897.5422534507416;899.8560230363144;900.8288425199191;936.7049379445452;957.1194501059042;960.5341409416427;961.5000199896085;966.3187452845762;923.0262073512475;947.3557980573207;949.6581230756922;950.1068995144542;950.1686024728363;715.3776214693198;717.7523754304757;718.1776865489038;719.8380364418016;720.7045111504258;14481.203533805636;14714.33785479656;14856.851431485655;15256.237188140549;15555.22223888801;14168.220747858864;14180.787288190686;14365.281735913162;14383.280835958265;14481.927590362086;8347;9573.808523829484;10852.240343175981;11689.941550292278;11710.473028713728;4410.757408342572;4424.513303536608;4453.176162409932;4512.433225304521;4559.908801823945;76361;106233;107872.42108623641;108816;111544.99999999919;10433.113185379176;10530.947345263377;10615.150787936947;10728.088112510368;10767;20619.58760824775;20721;20751.584968300853;20755.367810633077;21502;7336.559806411632;7415.88876166858;7486.887696684554;7487.925120748831;7892.960535197287;4147.108371700099;4257.127288905829;4269.188854117708;4406.62543683784;4411.691181617256;3535.8408871600327;3606.2246616977477;3622.8188590570894;3631.6005239423644;3655.8301343570333;568.266935653003;575.1688809669987;643.2859525926218;677.9050932869402;680.1769858471206;564.6978866306588;586.8210195890209;593.1902952469848;606.3209205689656;652.360686527206;8759.824803503894;9120.81758364829;9169.174774270214;9187.173154416001;9189.678361257324;566.9115298626647;660.7257987934953;667.2626747444004;671.9764808231786;672.9899051514232;3836.6738827199442;3908.1988192420486;4102.056526998807;4333.241682705514;4586.312053191981;81137;83985;85310.57344713237;105582.47208763906;105766;75667;86786;93681;93804.12391752127;95068;76037.85943210857;76431.61784191155;77055.45889082187;77233.61383193047;78544.21836724423;8586.313094952513;8711.346649001476;9635.470049147365;9819.656312029045;9899.851502227617;44900;45481.635550933526;47795.32716354911;49535;50293.49706502888;60024.09963850459;63755.68122159545;64444;66240;69586.9561956561;12948.935255323662;13148;13212.141210821266;13283.402246898719;13461.596152115451;11699.941500292443;14461.421543138156;14667.633309167357;14892.478763243667;15023.31928677481;11513.963743263146;13655.590332290047;13941.093828901088;13969.533199013957;14056.578302650936;13411.195328280335;13428.802356313254;13606.319684015958;13920.791188132389;14315.069520481135;13094.279814609907;13284.202947823162;13513.527026554417;13951.511697090553;13954.302284885513;8898.332625053017;10965.780684386427;11170.37966739882;11339;11403.543858245577;9465.810683786423;9987.550560224952;11370.488328025423;11534.653960381202;11550.826737598774 08:40:01 INFO - PROCESS | 1639 | __end_tp_report 08:40:01 INFO - PROCESS | 1639 | __start_cc_report 08:40:01 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,374 08:40:01 INFO - PROCESS | 1639 | __end_cc_report 08:40:01 INFO - PROCESS | 1639 | __startTimestamp1481647201913__endTimestamp 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:40:01 INFO - PROCESS | 1639 | Number of tests: 6 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5705.34 Median:5976.46 stddev:735.29 (12.3%) stddev-sans-first:692.55 08:40:01 INFO - PROCESS | 1639 | Values: 2476.6 2781.3 3067.8 3344.9 3459.1 4197.3 5067.2 5669.5 5705.4 5732.4 5714.9 5726.8 5852.9 5914.9 5915.9 4442.5 4479.4 5256.7 5273.7 5353.6 5267.2 5350.9 5368.9 5371.5 5411.3 5158.7 5310.2 5317.5 5332.0 5362.9 5203.9 5227.8 5233.0 5239.5 5246.5 5172.9 5173.8 5182.2 5188.3 5220.0 5530.7 5687.7 5719.3 5722.4 5749.1 6217.3 6262.2 6302.7 6304.8 6331.2 6190.0 6296.4 6300.5 6316.6 6331.3 5646.2 5724.2 5783.1 5786.7 5853.1 6239.7 6283.8 6298.6 6314.9 6319.2 6058.7 6079.0 6081.8 6112.8 6122.1 6133.2 6194.2 6196.5 6208.4 6222.6 6151.0 6155.9 6194.8 6232.6 6253.6 5261.2 6250.9 6255.6 6263.4 6292.2 4825.4 4914.7 4950.8 4958.4 4973.8 3673.5 4326.6 4402.5 4453.6 4512.6 5745.4 5866.9 5872.1 5889.9 5906.3 6292.1 6301.0 6306.7 6310.1 6328.4 4446.4 5319.5 5713.5 5756.3 5761.2 4039.4 5423.0 5472.9 5501.2 5509.2 6264.7 6294.2 6306.3 6318.4 6325.7 6137.2 6241.1 6262.3 6307.4 6341.0 6245.7 6250.7 6308.2 6314.0 6325.3 6102.7 6261.5 6266.9 6277.0 6297.9 6058.0 6136.7 6197.0 6254.4 6255.4 6083.3 6124.2 6126.2 6136.8 6137.4 4876.4 5957.9 6133.9 6155.7 6166.9 5840.4 5896.3 5905.2 5973.6 5976.5 6080.5 6096.8 6101.8 6117.1 6144.9 6017.5 6035.0 6043.5 6058.8 6087.7 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:67411.57 Median:18805.57 stddev:149665.33 (795.9%) stddev-sans-first:150000.69 08:40:01 INFO - PROCESS | 1639 | Values: 433.4 475.2 484.6 486.9 520.8 27769.7 30620.4 39052.6 39061.6 39155.2 39357.6 40039.4 40053.8 40105.4 40170.6 8337.3 8615.6 9099.9 9361.2 9372.4 11018.9 11321.0 11336.9 11468.0 11482.7 11339.7 11347.5 11381.5 11403.8 11407.3 11305.1 11357.9 11367.1 11368.3 11414.7 11146.2 11249.0 11270.7 11280.7 11304.5 38154.0 38369.8 38594.0 38598.6 38730.6 3319.9 3401.9 3402.5 3486.3 3828.9 29736.3 30487.0 30488.0 30531.7 30613.2 3074.8 3099.7 3251.6 3297.1 3298.8 361783.0 363258.0 364061.4 364265.0 365117.0 59439.0 59671.0 59971.4 60053.0 60090.7 61693.4 61911.7 61940.7 61951.0 62044.0 15604.6 15718.9 15812.0 15823.4 15835.3 10947.3 11248.1 12080.3 12135.0 12462.6 16163.0 16237.7 17180.7 18981.8 19711.6 6145.7 6984.9 7188.7 7994.4 8041.3 880.7 944.8 986.9 1089.5 1126.3 23399.5 29717.0 29890.6 30077.8 30199.8 905.9 944.9 1039.1 1147.8 1200.3 11786.9 13008.5 13790.8 15505.5 15604.8 599101.0 625138.9 650858.0 663134.0 664692.0 57292.0 57612.4 57804.7 57816.4 57992.0 1344.5 1397.1 1397.8 1403.9 1407.9 25495.7 28610.7 29322.6 29911.4 29963.0 48630.8 49708.5 50205.0 50250.7 52763.7 619811.0 627251.0 627949.0 628025.0 629443.0 32081.7 32411.8 38043.8 38434.8 38563.4 37216.4 41227.2 41268.8 41438.0 41919.0 33157.5 33736.5 34208.7 34378.0 34573.5 29454.0 33170.0 34436.5 34731.5 35413.6 34274.1 34334.5 34433.8 34657.5 35589.6 29692.1 31704.7 31772.4 31826.2 31908.7 21719.2 23858.9 24166.5 24418.6 24422.9 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:33722.02 Median:1591.77 stddev:94805.02 (5956.0%) stddev-sans-first:95037.80 08:40:01 INFO - PROCESS | 1639 | Values: 319.8 335.4 382.6 387.2 397.9 18080.6 19338.7 19992.2 19995.9 20157.6 17934.6 18482.5 18744.1 19341.4 20198.0 5665.2 5827.9 5960.5 5967.7 5967.9 5470.5 5735.2 5760.6 5808.1 5823.5 5739.4 5754.6 5755.3 5765.1 5775.5 5499.3 5751.2 5795.2 5795.6 5797.0 5071.4 5077.8 5083.2 5084.8 5085.4 11650.9 12466.4 12730.7 13102.7 13146.0 2137.7 2156.8 2215.8 2326.6 2863.8 9204.0 10023.1 10148.0 10337.9 10372.5 1506.5 1836.9 1840.6 1848.8 1862.5 98330.5 106860.5 114276.0 114801.9 127072.4 9138.0 10173.5 10235.1 11691.6 11866.8 14614.0 14676.9 14682.3 14694.3 14708.0 8050.4 8282.9 8305.9 8383.5 8409.0 7289.0 8051.6 8105.4 8204.3 8214.5 3678.7 4512.4 4515.1 4515.2 4673.7 1735.3 1752.7 1893.9 1955.2 1996.8 828.2 832.0 873.3 919.4 966.4 19157.8 20317.4 20441.5 20540.0 20944.0 904.2 906.2 911.6 941.8 972.4 8787.3 10535.4 10780.1 10830.6 10865.9 559407.0 562923.0 563209.0 564923.0 567936.0 133301.0 137130.0 139276.5 141072.0 144390.0 1002.8 1006.3 1060.2 1064.3 1065.2 14548.9 15589.0 16770.2 19018.5 19191.8 45153.0 53250.0 57025.0 57236.4 57521.7 80134.6 82373.8 82641.2 82825.6 83912.0 7895.7 8090.8 8098.0 8170.3 8281.8 11320.0 12478.9 12647.7 12803.7 12923.9 9515.7 10588.5 10712.4 10961.7 10989.7 8256.9 8990.2 10514.9 10578.2 11073.8 10257.3 11149.3 11222.3 11431.4 11491.2 7948.7 8020.6 8048.2 8082.4 8121.2 9114.1 9951.6 10905.1 10955.9 11125.9 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5331.17 Median:5515.21 stddev:2901.41 (52.6%) stddev-sans-first:2893.95 08:40:01 INFO - PROCESS | 1639 | Values: 1327.5 1505.3 1685.9 1831.7 1864.2 7376.0 7680.5 7913.3 8366.5 8378.5 7826.0 8133.7 8167.9 8253.4 8259.8 2245.4 2301.0 2303.1 2303.4 2306.8 2317.5 2339.1 2358.2 2358.6 2362.8 2292.9 2310.0 2325.1 2329.4 2329.8 2278.1 2296.1 2307.5 2312.0 2312.6 1797.1 2317.9 2339.3 2348.2 2369.3 7874.9 8223.7 8225.8 8232.1 8259.7 4331.0 4402.0 4565.4 4850.0 5149.0 3242.2 3329.8 3468.4 3526.6 3548.7 1025.4 1039.0 1056.9 1071.5 1075.2 8653.5 8913.6 10638.7 10654.4 10694.7 4415.9 4451.2 4542.8 4542.8 4546.5 9198.2 9279.1 9299.3 9316.8 9318.3 4323.5 5151.4 5154.6 5175.4 5190.9 4243.5 4401.7 4527.4 4685.2 4742.5 3605.9 3791.7 3812.7 3859.1 3887.1 1248.1 1255.7 1260.9 1264.7 1271.9 797.6 847.7 875.8 918.8 941.7 5676.9 5690.7 5705.4 5739.2 5962.4 911.3 918.9 921.4 930.2 966.2 3653.4 3710.7 3723.6 3823.6 3841.3 9573.6 9894.5 9952.2 9954.6 9980.0 9809.2 9891.7 9911.2 9920.6 9952.5 7700.3 7830.1 7844.6 7847.8 7849.3 5275.7 5378.7 5513.8 5516.7 5568.1 9146.9 9343.7 9347.0 9361.6 9380.6 8890.3 9273.8 9286.2 9297.8 9411.9 6532.6 6585.6 6766.9 7061.0 7260.9 7667.8 7881.2 7884.3 7891.3 7893.6 6941.5 7054.0 7084.7 7132.4 7196.3 6760.7 6941.7 6974.5 6993.9 7040.3 6404.9 6570.4 6626.5 6638.5 6706.5 4104.6 4237.9 4347.9 4723.5 4742.2 4076.8 4137.2 4712.8 4814.7 4912.5 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4623.90 Median:5129.02 stddev:1395.52 (27.2%) stddev-sans-first:1361.42 08:40:01 INFO - PROCESS | 1639 | Values: 314.0 325.7 359.7 368.2 371.2 4747.0 4905.8 5517.8 5592.5 5624.9 4585.7 5509.5 5538.9 5573.5 5612.8 3770.5 3956.7 4047.8 4185.9 4284.8 3935.6 3955.3 4321.8 4350.0 4356.6 4314.5 4317.2 4355.3 4367.0 4388.2 4213.1 4237.8 4352.6 4375.3 4378.2 3722.9 3785.2 3788.5 3796.9 3802.4 4727.6 5356.8 5384.8 5462.7 5477.5 3954.8 4538.7 4603.7 4961.0 5024.4 5444.5 5468.8 5789.3 5840.2 5896.9 4179.9 4194.5 4215.7 4216.5 4236.5 4982.4 5357.8 6076.0 6160.9 6194.3 3456.9 3580.4 3709.9 4009.7 4248.7 4101.6 4155.9 4290.7 4313.6 4314.9 3974.0 4079.6 4286.9 4772.3 4926.8 4920.8 5080.5 5460.5 5590.9 5853.8 1315.3 1426.5 1436.1 1440.2 1458.9 883.8 937.5 940.2 978.0 987.8 4654.9 5167.3 5175.5 5206.8 5230.3 5473.6 5540.6 5760.4 5785.1 5812.9 4875.0 4906.0 4954.4 5105.8 5348.9 2641.0 2646.7 2831.9 2931.8 3034.7 5348.8 5478.9 5601.2 5883.4 5912.7 5508.9 5628.7 5658.9 5757.4 5838.4 4920.2 5754.5 5773.8 5821.9 5823.4 4699.0 5000.9 5582.5 5604.5 5719.8 5544.3 5760.0 5910.4 5999.6 6050.7 4691.0 5813.4 6046.0 6209.9 6227.0 3212.4 3266.8 3298.6 3384.9 3549.5 4768.0 5250.5 5312.0 5821.5 6070.9 4763.3 4915.6 5598.9 5778.8 5909.2 5147.6 5617.5 5674.0 5805.3 5854.8 4616.3 5476.7 5616.9 5640.5 5676.4 5410.4 5790.6 5802.8 5822.6 5859.9 5110.4 5667.9 5707.6 5722.0 5741.3 08:40:01 INFO - PROCESS | 1639 | 08:40:01 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19807.66 Median:25020.77 stddev:28227.29 (112.8%) stddev-sans-first:28270.10 08:40:01 INFO - PROCESS | 1639 | Values: 722.9 731.6 768.6 792.3 803.8 14820.3 15679.2 15695.5 15706.1 15771.8 14094.0 14299.6 14323.1 14329.2 14331.1 702.7 727.6 868.4 874.3 887.3 885.6 895.6 897.5 899.9 900.8 936.7 957.1 960.5 961.5 966.3 923.0 947.4 949.7 950.1 950.2 715.4 717.8 718.2 719.8 720.7 14481.2 14714.3 14856.9 15256.2 15555.2 14168.2 14180.8 14365.3 14383.3 14481.9 8347.0 9573.8 10852.2 11689.9 11710.5 4410.8 4424.5 4453.2 4512.4 4559.9 76361.0 106233.0 107872.4 108816.0 111545.0 10433.1 10530.9 10615.2 10728.1 10767.0 20619.6 20721.0 20751.6 20755.4 21502.0 7336.6 7415.9 7486.9 7487.9 7893.0 4147.1 4257.1 4269.2 4406.6 4411.7 3535.8 3606.2 3622.8 3631.6 3655.8 568.3 575.2 643.3 677.9 680.2 564.7 586.8 593.2 606.3 652.4 8759.8 9120.8 9169.2 9187.2 9189.7 566.9 660.7 667.3 672.0 673.0 3836.7 3908.2 4102.1 4333.2 4586.3 81137.0 83985.0 85310.6 105582.5 105766.0 75667.0 86786.0 93681.0 93804.1 95068.0 76037.9 76431.6 77055.5 77233.6 78544.2 8586.3 8711.3 9635.5 9819.7 9899.9 44900.0 45481.6 47795.3 49535.0 50293.5 60024.1 63755.7 64444.0 66240.0 69587.0 12948.9 13148.0 13212.1 13283.4 13461.6 11699.9 14461.4 14667.6 14892.5 15023.3 11514.0 13655.6 13941.1 13969.5 14056.6 13411.2 13428.8 13606.3 13920.8 14315.1 13094.3 13284.2 13513.5 13951.5 13954.3 8898.3 10965.8 11170.4 11339.0 11403.5 9465.8 9987.6 11370.5 11534.7 11550.8 08:40:01 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:40:01 INFO - PROCESS | 1639 | 08:40:02 INFO - TEST-INFO | 1639: exit 0 08:40:02 INFO - TEST-OK | dromaeo_css | took 1116454ms 08:40:02 INFO - TEST-START | kraken 08:40:02 INFO - operating with platform_type : mac_ 08:40:02 INFO - Initialising browser for kraken test... 08:40:02 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpsWMEHa/profile http://localhost:49245/getInfo.html) 08:40:05 INFO - PROCESS | 1649 | 2016-12-13 08:40:05.335 plugin-container[1650:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 08:40:05 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:05 INFO - PROCESS | 1649 | 2016-12-13 08:40:05.339 plugin-container[1650:10444] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 08:40:05 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:05 INFO - PROCESS | 1649 | 2016-12-13 08:40:05.339 plugin-container[1650:10444] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:05 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:40:05 INFO - PROCESS | 1649 | colorDepth:24 08:40:05 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:40:05 INFO - PROCESS | 1649 | __metrics 08:40:05 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 08:40:06 INFO - TEST-INFO | 1649: exit 0 08:40:06 INFO - Browser initialized. 08:40:06 INFO - Running cycle 1/1 for kraken test... 08:40:06 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpsWMEHa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:08 INFO - PROCESS | 1651 | 2016-12-13 08:40:08.482 plugin-container[1652:10562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 08:40:08 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:08 INFO - PROCESS | 1651 | 2016-12-13 08:40:08.482 plugin-container[1652:10562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:40:08 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:08 INFO - PROCESS | 1651 | 2016-12-13 08:40:08.482 plugin-container[1652:10562] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:18 INFO - PROCESS | 1651 | RSS: Main: 237408256 08:40:18 INFO - PROCESS | 1651 | 08:40:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 08:40:22 INFO - PROCESS | 1651 | RSS: Main: 249671680 08:40:22 INFO - PROCESS | 1651 | 08:40:25 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 08:40:25 INFO - PROCESS | 1651 | RSS: Main: 257163264 08:40:25 INFO - PROCESS | 1651 | 08:40:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 08:40:29 INFO - PROCESS | 1651 | RSS: Main: 259743744 08:40:29 INFO - PROCESS | 1651 | 08:40:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 08:40:32 INFO - PROCESS | 1651 | RSS: Main: 260968448 08:40:32 INFO - PROCESS | 1651 | 08:40:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:34 INFO - PROCESS | 1651 | RSS: Main: 261287936 08:40:34 INFO - PROCESS | 1651 | 08:40:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:39 INFO - PROCESS | 1651 | RSS: Main: 266088448 08:40:39 INFO - PROCESS | 1651 | 08:40:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:42 INFO - PROCESS | 1651 | RSS: Main: 266858496 08:40:42 INFO - PROCESS | 1651 | 08:40:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 08:40:46 INFO - PROCESS | 1651 | RSS: Main: 267354112 08:40:46 INFO - PROCESS | 1651 | 08:40:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:48 INFO - PROCESS | 1651 | RSS: Main: 266694656 08:40:48 INFO - PROCESS | 1651 | 08:40:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:51 INFO - PROCESS | 1651 | RSS: Main: 266731520 08:40:51 INFO - PROCESS | 1651 | 08:40:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:54 INFO - PROCESS | 1651 | RSS: Main: 266772480 08:40:54 INFO - PROCESS | 1651 | 08:40:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:58 INFO - PROCESS | 1651 | RSS: Main: 267087872 08:40:58 INFO - PROCESS | 1651 | 08:41:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:41:02 INFO - PROCESS | 1651 | RSS: Main: 266874880 08:41:02 INFO - PROCESS | 1651 | 08:41:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 08:41:04 INFO - PROCESS | 1651 | RSS: Main: 269434880 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | __start_tp_report 08:41:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:41:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:41:04 INFO - PROCESS | 1651 | |i|pagename|runs| 08:41:04 INFO - PROCESS | 1651 | |0;ai-astar;109;118;120;121;118;96;181;178;171;118 08:41:04 INFO - PROCESS | 1651 | |1;audio-beat-detection;185;153;148;154;121;119;137;154;171;133 08:41:04 INFO - PROCESS | 1651 | |2;audio-dft;205;208;208;197;202;199;198;196;201;195 08:41:04 INFO - PROCESS | 1651 | |3;audio-fft;82;58;60;78;81;58;68;52;93;51 08:41:04 INFO - PROCESS | 1651 | |4;audio-oscillator;79;100;69;88;62;72;75;61;72;69 08:41:04 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;116;174;164;161;101;174;168;112;140;117 08:41:04 INFO - PROCESS | 1651 | |6;imaging-darkroom;138;155;132;95;96;93;97;95;96;147 08:41:04 INFO - PROCESS | 1651 | |7;imaging-desaturate;93;95;93;99;147;145;97;92;77;151 08:41:04 INFO - PROCESS | 1651 | |8;json-parse-financial;58;57;58;60;60;59;58;59;58;61 08:41:04 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;66;74;68;91;105;108;108;74;71;73 08:41:04 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;94;90;90;90;113;81;108;116;111;100 08:41:04 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;154;180;168;157;163;168;152;149;201;193 08:41:04 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;185;216;182;226;188;201;172;230;246;170 08:41:04 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;66;62;79;87;102;70;74;57;64 08:41:04 INFO - PROCESS | 1651 | __end_tp_report 08:41:04 INFO - PROCESS | 1651 | __start_cc_report 08:41:04 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,948 08:41:04 INFO - PROCESS | 1651 | __end_cc_report 08:41:04 INFO - PROCESS | 1651 | __startTimestamp1481647264109__endTimestamp 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:41:04 INFO - PROCESS | 1651 | Number of tests: 14 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:133.00 Median:146.00 stddev:31.10 (21.3%) stddev-sans-first:31.75 08:41:04 INFO - PROCESS | 1651 | Values: 109.0 118.0 120.0 121.0 118.0 96.0 181.0 178.0 171.0 118.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:153.50 stddev:20.84 (13.6%) stddev-sans-first:17.12 08:41:04 INFO - PROCESS | 1651 | Values: 185.0 153.0 148.0 154.0 121.0 119.0 137.0 154.0 171.0 133.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:200.90 Median:201.50 stddev:4.77 (2.4%) stddev-sans-first:4.82 08:41:04 INFO - PROCESS | 1651 | Values: 205.0 208.0 208.0 197.0 202.0 199.0 198.0 196.0 201.0 195.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:68.10 Median:73.00 stddev:14.53 (19.9%) stddev-sans-first:14.51 08:41:04 INFO - PROCESS | 1651 | Values: 82.0 58.0 60.0 78.0 81.0 58.0 68.0 52.0 93.0 51.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:72.00 stddev:11.85 (16.5%) stddev-sans-first:12.47 08:41:04 INFO - PROCESS | 1651 | Values: 79.0 100.0 69.0 88.0 62.0 72.0 75.0 61.0 72.0 69.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:142.70 Median:162.50 stddev:28.77 (17.7%) stddev-sans-first:28.85 08:41:04 INFO - PROCESS | 1651 | Values: 116.0 174.0 164.0 161.0 101.0 174.0 168.0 112.0 140.0 117.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:114.40 Median:95.00 stddev:25.32 (26.6%) stddev-sans-first:25.37 08:41:04 INFO - PROCESS | 1651 | Values: 138.0 155.0 132.0 95.0 96.0 93.0 97.0 95.0 96.0 147.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:108.90 Median:93.00 stddev:27.42 (29.5%) stddev-sans-first:28.48 08:41:04 INFO - PROCESS | 1651 | Values: 93.0 95.0 93.0 99.0 147.0 145.0 97.0 92.0 77.0 151.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.23 (2.1%) stddev-sans-first:1.27 08:41:04 INFO - PROCESS | 1651 | Values: 58.0 57.0 58.0 60.0 60.0 59.0 58.0 59.0 58.0 61.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:83.80 Median:72.00 stddev:17.36 (24.1%) stddev-sans-first:17.17 08:41:04 INFO - PROCESS | 1651 | Values: 66.0 74.0 68.0 91.0 105.0 108.0 108.0 74.0 71.0 73.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:99.30 Median:85.50 stddev:12.03 (14.1%) stddev-sans-first:12.60 08:41:04 INFO - PROCESS | 1651 | Values: 94.0 90.0 90.0 90.0 113.0 81.0 108.0 116.0 111.0 100.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:168.50 Median:168.00 stddev:17.68 (10.5%) stddev-sans-first:17.96 08:41:04 INFO - PROCESS | 1651 | Values: 154.0 180.0 168.0 157.0 163.0 168.0 152.0 149.0 201.0 193.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.60 Median:208.50 stddev:26.46 (12.7%) stddev-sans-first:27.37 08:41:04 INFO - PROCESS | 1651 | Values: 185.0 216.0 182.0 226.0 188.0 201.0 172.0 230.0 246.0 170.0 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:68.00 stddev:13.55 (19.9%) stddev-sans-first:14.09 08:41:04 INFO - PROCESS | 1651 | Values: 65.0 66.0 62.0 79.0 87.0 102.0 70.0 74.0 57.0 64.0 08:41:04 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:41:04 INFO - PROCESS | 1651 | 08:41:04 INFO - TEST-INFO | 1651: exit 0 08:41:05 INFO - TEST-OK | kraken | took 62446ms 08:41:05 INFO - SUITE-END | took 1178s 08:41:05 INFO - Completed test suite (00:19:39) 08:41:05 INFO - javascript benchmark 08:41:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7177.516496863955, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2476.566600844853, 2781.332480204751, 3067.7545796336294, 3344.8794653790965, 3459.066052165915, 4197.349410841324, 5067.214581739831, 5669.518090962263, 5705.429457054298, 5732.369439361672, 5714.914276285859, 5726.770929162839, 5852.882942341151, 5914.940850591493, 5915.940840591593, 4442.466903971528, 4479.39528163697, 5256.658317209388, 5273.736313184345, 5353.57171426285, 5267.209918512215, 5350.866228344284, 5368.91946620801, 5371.4897084776885, 5411.269478620395, 5158.690478571298, 5310.150375939869, 5317.494837990384, 5332.040232758102, 5362.892742145174, 5203.869903252411, 5227.79088836446, 5233.031889100528, 5239.502247286502, 5246.501582349671, 5172.922406163911, 5173.810023694571, 5182.170852663593, 5188.273641690166, 5219.973900130513, 5530.723463826793, 5687.658740475544, 5719.313682358102, 5722.427757224286, 5749.137629355589, 6217.253929528486, 6262.185915830958, 6302.747890084391, 6304.810855674337, 6331.240251169843, 6190.0, 6296.433321001132, 6300.527460440485, 6316.589421687621, 6331.303556608769, 5646.153077038477, 5724.227229324029, 5783.103618939072, 5786.7395967181155, 5853.1220316952795, 6239.688015599202, 6283.8114856554375, 6298.622082675054, 6314.936850631527, 6319.178506794179, 6058.666773327509, 6078.969605152034, 6081.75672973085, 6112.847178820476, 6122.142899994004, 6133.202683651097, 6194.225721784777, 6196.504279657616, 6208.410201030895, 6222.564420490522, 6151.046587778901, 6155.861165684362, 6194.81415557534, 6232.626042437469, 6253.5622506425025, 5261.184516399964, 6250.937490625036, 6255.624662520263, 6263.4362907338555, 6292.244930608356, 4825.372701548777, 4914.70511769295, 4950.801967921315, 4958.380202474691, 4973.825916092919, 3673.485712000322, 4326.58897404746, 4402.537733537933, 4453.576910193527, 4512.571305725951, 5745.396733343023, 5866.8533286667325, 5872.0898260769645, 5889.939810834006, 5906.3207731110615, 6292.087647291117, 6301.0, 6306.653134077578, 6310.1481300024825, 6328.430441260309, 4446.444194475691, 5319.547838433699, 5713.485786279171, 5756.33802112754, 5761.222234998221, 4039.3738970459626, 5422.972885135549, 5472.890542189134, 5501.174823776386, 5509.173623956359, 6264.749410023548, 6294.213223347082, 6306.306306306395, 6318.368163183737, 6325.683715814283, 6137.232845894263, 6241.126242326169, 6262.34245404226, 6307.36926307384, 6341.048842673451, 6245.68771561411, 6250.749970001149, 6308.243010838729, 6314.02132669437, 6325.272593651789, 6102.725377358119, 6261.499080073492, 6266.874662506815, 6277.0, 6297.905531416941, 6057.969710151421, 6136.6722581676495, 6197.0, 6254.405831446005, 6255.437010669061, 6083.300420451705, 6124.234470691164, 6126.172966649446, 6136.846578835565, 6137.447629713347, 4876.390451193601, 5957.940420595739, 6133.877322453615, 6155.722992465439, 6166.938330616816, 5840.415958404125, 5896.262967129109, 5905.202797622266, 5973.5519836013345, 5976.462118409364, 6080.513558915364, 6096.847578810565, 6101.816945491642, 6117.143599896107, 6144.880016394337, 6017.458428741435, 6035.034394496859, 6043.516518678583, 6058.787942421994, 6087.66517841523], "value": 5652.901330231364, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.41056163617475, 475.22063815342835, 484.57841677740373, 486.8826044228496, 520.789080422429, 27769.722302776965, 30620.38759224817, 39052.60947390525, 39061.60938390615, 39155.2168956621, 39357.60642393575, 40039.39940900889, 40053.799731001374, 40105.3957841686, 40170.59829401705, 8337.291330236938, 8615.56922153893, 9099.90900090999, 9361.22136794007, 9372.437653740762, 11018.944905275463, 11320.981111699944, 11336.943315283412, 11468.0, 11482.712932176679, 11339.659810205707, 11347.489362978686, 11381.487833047533, 11403.828942565868, 11407.315561066363, 11305.095592352633, 11357.886421135765, 11367.147463940197, 11368.261063030877, 11414.71463213418, 11146.164037697125, 11249.043831274352, 11270.718232044183, 11280.661580152608, 11304.491297891615, 38154.0, 38369.80815095906, 38594.0, 38598.614013859784, 38730.61269387298, 3319.9004029879143, 3401.9149521262166, 3402.4896265560114, 3486.3375958568045, 3828.9234215315814, 29736.256593585116, 30487.0, 30488.0, 30531.69468305333, 30613.234669133228, 3074.8308843013847, 3099.6745341739243, 3251.5935508061493, 3297.0603378037385, 3298.752593555469, 361783.0, 363258.0, 364061.35938640806, 364265.0, 365117.0, 59439.0, 59671.0, 59971.40028599746, 60053.0, 60090.699546501986, 61693.38306616966, 61911.69044154751, 61940.69029654823, 61951.0, 62044.0, 15604.609884752745, 15718.921405392899, 15812.0, 15823.367065317489, 15835.287412066486, 10947.288426252428, 11248.100151987821, 12080.335581542924, 12135.029197664166, 12462.563810266598, 16163.030218186712, 16237.675246495004, 17180.6630948518, 18981.81018189828, 19711.60576788456, 6145.692715364214, 6984.860302793915, 7188.712451501986, 7994.40041996841, 8041.26081372153, 880.6785523283955, 944.8299306124826, 986.8618393424927, 1089.4824958144977, 1126.3298337489182, 23399.532009360057, 29717.0, 29890.551641725393, 30077.849610751808, 30199.849000754857, 905.8550631898996, 944.9102335278137, 1039.0700323210683, 1147.7532330548804, 1200.2978257719333, 11786.88213117875, 13008.544700935421, 13790.793138102936, 15505.534833955, 15604.765928511082, 599101.0, 625138.8743056346, 650858.0, 663134.0, 664692.0, 57292.0, 57612.423875761546, 57804.71097644485, 57816.42183578195, 57992.0, 1344.5294147048455, 1397.1267957526545, 1397.8462369139386, 1403.943842246319, 1407.9155250684787, 25495.74504255008, 28610.713892860804, 29322.56016159802, 29911.401771964003, 29963.0, 48630.78423039452, 49708.50291497183, 50205.0, 50250.74874625603, 52763.73618131885, 619811.0, 627251.0, 627949.0, 628025.0, 629443.0, 32081.67918320787, 32411.837940810146, 38043.80978095092, 38434.80782596069, 38563.421548677354, 37216.44175337318, 41227.175456490106, 41268.79365603153, 41438.0, 41919.0, 33157.50263745998, 33736.49395259122, 34208.657913420546, 34378.0, 34573.48139777855, 29453.96911108101, 33170.0, 34436.48345274773, 34731.4790278141, 35413.64586354104, 34274.14314642154, 34334.53651025351, 34433.82783086068, 34657.48013779745, 35589.64410355863, 29692.109236722932, 31704.682953170173, 31772.364552709278, 31826.204344890637, 31908.6809131915, 21719.239826605994, 23858.880705596363, 24166.516669666158, 24418.63372049385, 24422.900969456772], "value": 19628.8809798544, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.75059453626153, 335.4185017641819, 382.60400485497513, 387.2274811750558, 397.90575916230364, 18080.638387232262, 19338.709919351204, 19992.200311987504, 19995.900020499877, 20157.59684806303, 17934.641307173883, 18482.537936551595, 18744.06279686017, 19341.419757407264, 20197.99010049499, 5665.150227465882, 5827.912581311284, 5960.493358064569, 5967.746773177638, 5967.850803729898, 5470.5350045246205, 5735.225744524499, 5760.6255593386295, 5808.070708686611, 5823.475887170154, 5739.397363276858, 5754.568407369443, 5755.25181726375, 5765.106408506688, 5775.509081728058, 5499.257600223978, 5751.194832723422, 5795.2176456178295, 5795.594308398414, 5797.0, 5071.442141364447, 5077.822276220315, 5083.237514372874, 5084.79660813567, 5085.415177254626, 11650.883491165065, 12466.376681165906, 12730.681732956658, 13102.672433189247, 13146.0, 2137.7114089598017, 2156.795104465089, 2215.8448908576406, 2326.6161083421216, 2863.7852161087794, 9203.953980230122, 10023.097921187129, 10148.0, 10337.9483102584, 10372.48137593125, 1506.495324066439, 1836.9448916532526, 1840.6226723521645, 1848.815118488154, 1862.5157459060606, 98330.50834745853, 106860.4656976718, 114276.0, 114801.85198148078, 127072.36463817714, 9137.994820569733, 10173.491325433699, 10235.130013948748, 11691.649250522498, 11866.821997670042, 14613.977021608385, 14676.926615366854, 14682.265886705622, 14694.338754756061, 14708.0, 8050.355971522265, 8282.917170828214, 8305.875411868827, 8383.538905360141, 8409.0, 7288.96355518219, 8051.597420129087, 8105.351571874236, 8204.343652507785, 8214.507129572245, 3678.7424880258127, 4512.4133862597655, 4515.119551687455, 4515.187266292099, 4673.7429441381055, 1735.3318972195543, 1752.7283271093002, 1893.8863668179954, 1955.247229816531, 1996.760388753359, 828.1925123005022, 831.9642045653201, 873.3100850328169, 919.3656377099913, 966.3815158298695, 19157.80842191588, 20317.390478285673, 20441.48896277605, 20539.973001349874, 20944.0, 904.2359206470522, 906.207068814787, 911.6353458616607, 941.755143662639, 972.3776782858976, 8787.340949428819, 10535.367877927349, 10780.137588992862, 10830.566777328819, 10865.945670271598, 559407.0, 562923.0, 563209.0, 564923.0, 567936.0, 133301.0, 137130.0, 139276.5180870466, 141072.0, 144390.0, 1002.8295189817749, 1006.2805094357716, 1060.2472244706346, 1064.3135177810425, 1065.1957771882335, 14548.927255363655, 15588.986715863433, 16770.245338959532, 19018.4747785353, 19191.808081919004, 45153.0, 53250.0, 57025.0, 57236.42763572311, 57521.71239143777, 80134.59932700299, 82373.76439353294, 82641.17358826335, 82825.58587207267, 83912.0, 7895.68417263303, 8090.757277281691, 8097.975506123469, 8170.264676178935, 8281.83436331282, 11320.0, 12478.87521124777, 12647.660182865831, 12803.679908002374, 12923.870761292643, 9515.666951656658, 10588.523516441932, 10712.410817405118, 10961.725956851142, 10989.670309890716, 8256.926599542021, 8990.190882820578, 10514.948505149423, 10578.206634502289, 11073.778524429305, 10257.33327333721, 11149.275297105662, 11222.326660400402, 11431.42842857837, 11491.195616306779, 7948.682052717826, 8020.639071241925, 8048.235417635316, 8082.434229603871, 8121.187881211831, 9114.131603021233, 9951.601935922483, 10905.073068789241, 10955.945220273848, 11125.888741112485], "value": 9141.576761758997, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.522092046863, 1505.315081637855, 1685.921010553246, 1831.7160840069794, 1864.1611274926279, 7375.963120184405, 7680.539167649945, 7913.32736717379, 8366.456180348274, 8378.455400398978, 7825.960870195655, 8133.674653013887, 8167.877481837777, 8253.422260441772, 8259.752207433772, 2245.360072379376, 2301.0, 2303.1248125712204, 2303.435658263728, 2306.792388685018, 2317.5133222023396, 2339.076064954342, 2358.162852187466, 2358.610829213186, 2362.783166669167, 2292.873891935943, 2310.0, 2325.058351367699, 2329.440934175794, 2329.8136149108113, 2278.065992942894, 2296.0930432479245, 2307.5038866643754, 2311.9537609247723, 2312.5721741477796, 1797.0834874214115, 2317.860928344288, 2339.3099035784485, 2348.236823032504, 2369.2536850891915, 7874.921250787476, 8223.671053157866, 8225.753227403187, 8232.135625759329, 8259.669613215465, 4331.0, 4401.977990110061, 4565.429321334833, 4849.981503884189, 5148.9742551287, 3242.157039169809, 3329.783564068328, 3468.4450487921813, 3526.647335266453, 3548.733844961638, 1025.4155131575005, 1038.997367540327, 1056.894310568937, 1071.464267866067, 1075.1989767623093, 8653.524056176908, 8913.55432228386, 10638.734031649194, 10654.360738355646, 10694.679159625224, 4415.867523974286, 4451.243288640939, 4542.795574199169, 4542.795574199169, 4546.499885012646, 9198.2181514572, 9279.118483744034, 9299.302552308603, 9316.767080823034, 9318.254539636813, 4323.524412314643, 5151.381834179922, 5154.587632989352, 5175.404828444702, 5190.896182076337, 4243.469566304212, 4401.713888597231, 4527.4340707411575, 4685.226937555265, 4742.5020372861045, 3605.8737944171826, 3791.677707394847, 3812.6568608825337, 3859.073822282632, 3887.125396785757, 1248.1076030638137, 1255.736295377981, 1260.87391260875, 1264.6711854917787, 1271.8600953895063, 797.6291024673554, 847.6842178231445, 875.8073223890734, 918.8254231695956, 941.7033634405141, 5676.858078547987, 5690.715464226772, 5705.372409035002, 5739.167820666064, 5962.433568810956, 911.2846415563884, 918.8805455290769, 921.4149015375151, 930.2139691960418, 966.2077096780713, 3653.3606618841595, 3710.666040056408, 3723.6090210528046, 3823.617638236154, 3841.3469710149343, 9573.617055317709, 9894.455804930654, 9952.203823694088, 9954.552045157985, 9980.0, 9809.166220871306, 9891.703248902544, 9911.207103431709, 9920.553575089138, 9952.502374881227, 7700.268474494914, 7830.060392752906, 7844.568548729761, 7847.764567062997, 7849.293563579191, 5275.709835958905, 5378.650387724785, 5513.751881165277, 5516.668999860021, 5568.081266590967, 9146.908530914605, 9343.71968840936, 9347.0, 9361.578728957349, 9380.577873995822, 8890.288776897962, 9273.814523709623, 9286.210672092948, 9297.814043719223, 9411.905880941104, 6532.5753826001155, 6585.6377899216, 6766.8646627068165, 7061.0, 7260.927390726025, 7667.808304792202, 7881.2118788123025, 7884.329831964347, 7891.250331218525, 7893.644785984759, 6941.47938904574, 7054.047703560159, 7084.716611335489, 7132.393746531396, 7196.316349946746, 6760.661966901734, 6941.687624057031, 6974.5466544676465, 6993.860122797617, 7040.295970402919, 6404.903926441014, 6570.441512471302, 6626.503012274003, 6638.502112341497, 6706.530542861953, 4104.630583247403, 4237.855778939607, 4347.934755984804, 4723.50403207672, 4742.217534106834, 4076.8369265229057, 4137.1932473168645, 4712.835050773207, 4814.662973591815, 4912.459629440687], "value": 4343.683965463799, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.95290706394053, 325.72638983254063, 359.6888691282041, 368.2285611643607, 371.19080404717704, 4746.976265118674, 4905.803767849291, 5517.779288828442, 5592.496675299222, 5624.943750562493, 4585.6560757943125, 5509.531689806371, 5538.944610553894, 5573.519783696247, 5612.7754889804355, 3770.547534295875, 3956.723029387944, 4047.838086476545, 4185.916281674365, 4284.828606855722, 3935.60643935607, 3955.2880481513316, 4321.848735294266, 4350.0, 4356.564343565634, 4314.482262128549, 4317.244482215616, 4355.257896841257, 4367.0, 4388.210122178007, 4213.094184750294, 4237.809298581571, 4352.6278178392695, 4375.278079116958, 4378.2119218540965, 3722.9441558376648, 3785.242951409729, 3788.5453745550435, 3796.924061518754, 3802.448644946495, 4727.550882666142, 5356.758945847446, 5384.761504853866, 5462.6995515246645, 5477.4796394342475, 3954.8418063277436, 4538.686758666159, 4603.723776573383, 4961.0, 5024.422191447957, 5444.455554444564, 5468.781248750045, 5789.321096881899, 5840.211571437844, 5896.93359453082, 4179.895502612429, 4194.496660400771, 4215.725977811432, 4216.51510076342, 4236.4704411948505, 4982.427020892607, 5357.785688572413, 6076.0, 6160.938390616081, 6194.287656919422, 3456.861725531001, 3580.3888250287473, 3709.9443508347395, 4009.67922566194, 4248.660107191417, 4101.630853223164, 4155.896102597399, 4290.656747460258, 4313.568643135662, 4314.870553883388, 3973.9667686401745, 4079.612436818557, 4286.863177034177, 4772.260299653559, 4926.753662316942, 4920.778564964585, 5080.542751152414, 5460.453954604508, 5590.86022849432, 5853.765849366063, 1315.2897435384784, 1426.4650755966513, 1436.1115133599283, 1440.2366745624836, 1458.8905832062637, 883.765802062454, 937.4796987671771, 940.210223412337, 977.9951100244454, 987.8370068938544, 4654.930176047362, 5167.302414174038, 5175.482451754794, 5206.817761378409, 5230.293910322134, 5473.576870013825, 5540.612157148961, 5760.36635970043, 5785.090919996475, 5812.941870581325, 4874.976254986422, 4905.9754701226975, 4954.380702412199, 5105.8001369678095, 5348.866278343073, 2640.966455829001, 2646.655934728473, 2831.8725657345467, 2931.7801164912717, 3034.7268745812985, 5348.823258883117, 5478.890422191614, 5601.243832082698, 5883.352831188566, 5912.70436478183, 5508.944910550923, 5628.690422026828, 5658.85852853682, 5757.366689664133, 5838.416158384128, 4920.21276595743, 5754.510866576305, 5773.797917072882, 5821.941780582225, 5823.417658234142, 4699.0, 5000.899982000413, 5582.4648221737725, 5604.495595396271, 5719.799807006902, 5544.279243698294, 5759.992001399654, 5910.438508341701, 5999.5500337473995, 6050.727717252822, 4691.0, 5813.447722466528, 6046.0, 6209.875802484015, 6227.003679411272, 3212.4217640824877, 3266.820324882154, 3298.6041674999155, 3384.915377115592, 3549.538559987185, 4767.952320476751, 5250.501202385767, 5312.017276803804, 5821.505172060422, 6070.878582428415, 4763.285507173951, 4915.606751459946, 5598.944010559842, 5778.8266352009505, 5909.23179986599, 5147.624519158835, 5617.511359489657, 5674.028180273743, 5805.303363596396, 5854.795082172274, 4616.268899162814, 5476.698781567052, 5616.887662246814, 5640.520555752807, 5676.4323567642905, 5410.404855465817, 5790.565707571865, 5802.767889284551, 5822.592418530662, 5859.94140058594, 5110.4123025852505, 5667.914981275367, 5707.6290041147195, 5721.971390143022, 5741.2536370273265], "value": 4193.714875000262, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8771108911485, 731.5976213082803, 768.6195333310009, 792.2671528835825, 803.819140693344, 14820.258987050645, 15679.216039198052, 15695.529134125994, 15706.136162511071, 15771.763423548642, 14094.0, 14299.642508937255, 14323.069000514959, 14329.211893345862, 14331.140131592112, 702.722424642266, 727.5634619228473, 868.4051424774018, 874.2830878679486, 887.3078998381272, 885.6191837509868, 895.6417433026776, 897.5422534507416, 899.8560230363144, 900.8288425199191, 936.7049379445452, 957.1194501059042, 960.5341409416427, 961.5000199896085, 966.3187452845762, 923.0262073512475, 947.3557980573207, 949.6581230756922, 950.1068995144542, 950.1686024728363, 715.3776214693198, 717.7523754304757, 718.1776865489038, 719.8380364418016, 720.7045111504258, 14481.203533805636, 14714.33785479656, 14856.851431485655, 15256.237188140549, 15555.22223888801, 14168.220747858864, 14180.787288190686, 14365.281735913162, 14383.280835958265, 14481.927590362086, 8347.0, 9573.808523829484, 10852.240343175981, 11689.941550292278, 11710.473028713728, 4410.757408342572, 4424.513303536608, 4453.176162409932, 4512.433225304521, 4559.908801823945, 76361.0, 106233.0, 107872.42108623641, 108816.0, 111544.99999999919, 10433.113185379176, 10530.947345263377, 10615.150787936947, 10728.088112510368, 10767.0, 20619.58760824775, 20721.0, 20751.584968300853, 20755.367810633077, 21502.0, 7336.559806411632, 7415.88876166858, 7486.887696684554, 7487.925120748831, 7892.960535197287, 4147.108371700099, 4257.127288905829, 4269.188854117708, 4406.62543683784, 4411.691181617256, 3535.8408871600327, 3606.2246616977477, 3622.8188590570894, 3631.6005239423644, 3655.8301343570333, 568.266935653003, 575.1688809669987, 643.2859525926218, 677.9050932869402, 680.1769858471206, 564.6978866306588, 586.8210195890209, 593.1902952469848, 606.3209205689656, 652.360686527206, 8759.824803503894, 9120.81758364829, 9169.174774270214, 9187.173154416001, 9189.678361257324, 566.9115298626647, 660.7257987934953, 667.2626747444004, 671.9764808231786, 672.9899051514232, 3836.6738827199442, 3908.1988192420486, 4102.056526998807, 4333.241682705514, 4586.312053191981, 81137.0, 83985.0, 85310.57344713237, 105582.47208763906, 105766.0, 75667.0, 86786.0, 93681.0, 93804.12391752127, 95068.0, 76037.85943210857, 76431.61784191155, 77055.45889082187, 77233.61383193047, 78544.21836724423, 8586.313094952513, 8711.346649001476, 9635.470049147365, 9819.656312029045, 9899.851502227617, 44900.0, 45481.635550933526, 47795.32716354911, 49535.0, 50293.49706502888, 60024.09963850459, 63755.68122159545, 64444.0, 66240.0, 69586.9561956561, 12948.935255323662, 13148.0, 13212.141210821266, 13283.402246898719, 13461.596152115451, 11699.941500292443, 14461.421543138156, 14667.633309167357, 14892.478763243667, 15023.31928677481, 11513.963743263146, 13655.590332290047, 13941.093828901088, 13969.533199013957, 14056.578302650936, 13411.195328280335, 13428.802356313254, 13606.319684015958, 13920.791188132389, 14315.069520481135, 13094.279814609907, 13284.202947823162, 13513.527026554417, 13951.511697090553, 13954.302284885513, 8898.332625053017, 10965.780684386427, 11170.37966739882, 11339.0, 11403.543858245577, 9465.810683786423, 9987.550560224952, 11370.488328025423, 11534.653960381202, 11550.826737598774], "value": 7398.68227423158, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1674.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 120.0, 121.0, 118.0, 96.0, 181.0, 178.0, 171.0, 118.0], "value": 133.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 153.0, 148.0, 154.0, 121.0, 119.0, 137.0, 154.0, 171.0, 133.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 208.0, 208.0, 197.0, 202.0, 199.0, 198.0, 196.0, 201.0, 195.0], "value": 200.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 78.0, 81.0, 58.0, 68.0, 52.0, 93.0, 51.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 100.0, 69.0, 88.0, 62.0, 72.0, 75.0, 61.0, 72.0, 69.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 174.0, 164.0, 161.0, 101.0, 174.0, 168.0, 112.0, 140.0, 117.0], "value": 142.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 155.0, 132.0, 95.0, 96.0, 93.0, 97.0, 95.0, 96.0, 147.0], "value": 114.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 99.0, 147.0, 145.0, 97.0, 92.0, 77.0, 151.0], "value": 108.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 60.0, 60.0, 59.0, 58.0, 59.0, 58.0, 61.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 68.0, 91.0, 105.0, 108.0, 108.0, 74.0, 71.0, 73.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 90.0, 90.0, 113.0, 81.0, 108.0, 116.0, 111.0, 100.0], "value": 99.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 180.0, 168.0, 157.0, 163.0, 168.0, 152.0, 149.0, 201.0, 193.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 216.0, 182.0, 226.0, 188.0, 201.0, 172.0, 230.0, 246.0, 170.0], "value": 201.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 62.0, 79.0, 87.0, 102.0, 70.0, 74.0, 57.0, 64.0], "value": 72.6, "unit": "score"}]}]} 08:41:05 INFO - Return code: 0 08:41:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:41:05 ERROR - # TBPL SUCCESS # 08:41:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:05 INFO - 2016-12-13 08:41:05.421 screenresolution[1656:10954] starting screenresolution argv=screenresolution get 08:41:05 INFO - 2016-12-13 08:41:05.425 screenresolution[1656:10954] Display 0: 1600x1200x32@60 08:41:05 INFO - 2016-12-13 08:41:05.431 screenresolution[1657:10957] starting screenresolution argv=screenresolution list 08:41:05 INFO - Available Modes on Display 0 08:41:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:05 INFO - Intel Iris: 08:41:05 INFO - Chipset Model: Intel Iris 08:41:05 INFO - Type: GPU 08:41:05 INFO - Bus: Built-In 08:41:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:05 INFO - Vendor: Intel (0x8086) 08:41:05 INFO - Device ID: 0x0a2e 08:41:05 INFO - Revision ID: 0x0009 08:41:05 INFO - Displays: 08:41:05 INFO - Display: 08:41:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:05 INFO - Display Serial Number: 1600x1200 60 08:41:05 INFO - Main Display: Yes 08:41:05 INFO - Mirror: Off 08:41:05 INFO - Online: Yes 08:41:05 INFO - Rotation: Supported 08:41:05 INFO - Return code: 0 08:41:05 INFO - Running post-action listener: _resource_record_post_action 08:41:05 INFO - [mozharness: 2016-12-13 16:41:05.671817Z] Finished run-tests step (success) 08:41:05 INFO - Running post-run listener: _resource_record_post_run 08:41:05 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 38709760; Write bytes: 552877056; Read time: 246; Write time: 1689 08:41:05 INFO - TinderboxPrint: CPU usage
54.8% 08:41:05 INFO - TinderboxPrint: I/O read bytes / time
38,709,760 / 246 08:41:05 INFO - TinderboxPrint: I/O write bytes / time
552,877,056 / 1,689 08:41:05 INFO - TinderboxPrint: CPU idle
2,174.5 (45.2%) 08:41:05 INFO - TinderboxPrint: CPU system
970.8 (20.2%) 08:41:05 INFO - TinderboxPrint: CPU user
1,660.3 (34.5%) 08:41:05 INFO - TinderboxPrint: Swap in / out
288,849,920 / 0 08:41:05 INFO - install - Wall time: 22s; CPU: 55.0%; Read bytes: 250853888; Write bytes: 241248256; Read time: 17674; Write time: 522 08:41:05 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 31154688; Write bytes: 297845760; Read time: 183; Write time: 1127 08:41:06 INFO - Running post-run listener: _upload_blobber_files 08:41:06 INFO - Blob upload gear active. 08:41:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:41:06 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 08:41:06 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'] 08:41:06 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 08:41:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:07 INFO - (blobuploader) - INFO - Done attempting. 08:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:08 INFO - (blobuploader) - INFO - Done attempting. 08:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:41:11 INFO - (blobuploader) - INFO - Done attempting. 08:41:11 INFO - (blobuploader) - INFO - Iteration through files over. 08:41:11 INFO - Return code: 0 08:41:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:41:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:41:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cf52348b3d19b63dedca1c7d75b366ad1cd06a0becedccbd5d83998f7fdb411ba830f3109077b90da4c07661cfe04c94111fbfdf91535ba4e5af1c2f7145e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75063ed3e215d1ef3cb188816497860e14bbe5542d6db7e1e1619e899d7f79a64c1863fb997fb0fdeac898312c81f28314966321c4e0b9f8bef238f5f18cba38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9007717a8eb6a2467ac17adbc2b90644db8b8b9883ccbc01384fb8e9f9be7fee67e7c512dccd471e6f68c74eb3358a45e9a7b7582dfcd13191e5705b9f4f0816"} 08:41:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:41:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:41:11 INFO - Contents: 08:41:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cf52348b3d19b63dedca1c7d75b366ad1cd06a0becedccbd5d83998f7fdb411ba830f3109077b90da4c07661cfe04c94111fbfdf91535ba4e5af1c2f7145e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75063ed3e215d1ef3cb188816497860e14bbe5542d6db7e1e1619e899d7f79a64c1863fb997fb0fdeac898312c81f28314966321c4e0b9f8bef238f5f18cba38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9007717a8eb6a2467ac17adbc2b90644db8b8b9883ccbc01384fb8e9f9be7fee67e7c512dccd471e6f68c74eb3358a45e9a7b7582dfcd13191e5705b9f4f0816"} 08:41:11 INFO - Running post-run listener: copy_logs_to_upload_dir 08:41:11 INFO - Copying logs to upload dir... 08:41:11 INFO - mkdir: /builds/slave/test/build/upload/logs 08:41:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.988540 ========= master_lag: 3.53 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-13 08:41:14.887895) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:14.892752) ========= 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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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/77cf52348b3d19b63dedca1c7d75b366ad1cd06a0becedccbd5d83998f7fdb411ba830f3109077b90da4c07661cfe04c94111fbfdf91535ba4e5af1c2f7145e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75063ed3e215d1ef3cb188816497860e14bbe5542d6db7e1e1619e899d7f79a64c1863fb997fb0fdeac898312c81f28314966321c4e0b9f8bef238f5f18cba38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9007717a8eb6a2467ac17adbc2b90644db8b8b9883ccbc01384fb8e9f9be7fee67e7c512dccd471e6f68c74eb3358a45e9a7b7582dfcd13191e5705b9f4f0816"} build_url:https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011553 build_url: 'https://queue.taskcluster.net/v1/task/Xld_o1kGT3Oc_0NAlLyHog/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cf52348b3d19b63dedca1c7d75b366ad1cd06a0becedccbd5d83998f7fdb411ba830f3109077b90da4c07661cfe04c94111fbfdf91535ba4e5af1c2f7145e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75063ed3e215d1ef3cb188816497860e14bbe5542d6db7e1e1619e899d7f79a64c1863fb997fb0fdeac898312c81f28314966321c4e0b9f8bef238f5f18cba38", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9007717a8eb6a2467ac17adbc2b90644db8b8b9883ccbc01384fb8e9f9be7fee67e7c512dccd471e6f68c74eb3358a45e9a7b7582dfcd13191e5705b9f4f0816"}' ========= master_lag: 0.44 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:15.349247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:15.349733) ========= 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.3TDOHIzV9Z/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.7an1Zh1eC3/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.005129 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:41:15.377959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:41:15.378351) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:41:15.379851) ========= ========= Total master_lag: 7.22 =========