builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0182 starttime: 1491432174.67 results: success (0) buildid: 20170405144620 builduid: e86936d5148540c7abd45c182d46646d revision: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.665913) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.667042) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.667798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.696561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.697271) ========= 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.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-05 15:42:54-- 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% 24.9M=0s 2017-04-05 15:42:54 (24.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104951 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.832386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.833524) ========= 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.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.027372 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:54.887499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 15:42:54.888331) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-05 15:42:54,997 truncating revision to first 12 chars 2017-04-05 15:42:54,997 Setting DEBUG logging. 2017-04-05 15:42:54,997 attempt 1/10 2017-04-05 15:42:54,997 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/db91f4e6e0a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 15:42:55,877 unpacking tar archive at: mozilla-beta-db91f4e6e0a8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.155161 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 15:42:56.072955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:56.073870) ========= script_repo_revision: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:56.074970) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:56.076233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 15:42:56.099207) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-05 15:42:56.099875) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:42:56 INFO - MultiFileLogger online at 20170405 15:42:56 in /builds/slave/test 15:42:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:42:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:56 INFO - {'append_to_log': False, 15:42:56 INFO - 'base_work_dir': '/builds/slave/test', 15:42:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:42:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:56 INFO - 'branch': 'Mozilla-Beta', 15:42:56 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:56 INFO - 'config_files': ('talos/mac_config.py',), 15:42:56 INFO - 'default_actions': ('clobber', 15:42:56 INFO - 'read-buildbot-config', 15:42:56 INFO - 'download-and-extract', 15:42:56 INFO - 'populate-webroot', 15:42:56 INFO - 'create-virtualenv', 15:42:56 INFO - 'install', 15:42:56 INFO - 'run-tests'), 15:42:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:56 INFO - 'download_minidump_stackwalk': True, 15:42:56 INFO - 'download_symbols': 'ondemand', 15:42:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:42:56 INFO - 'tooltool.py': '/tools/tooltool.py', 15:42:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:42:56 INFO - '/tools/misc-python/virtualenv.py')}, 15:42:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:56 INFO - 'installer_path': 'installer.exe', 15:42:56 INFO - 'log_level': 'info', 15:42:56 INFO - 'log_name': 'talos', 15:42:56 INFO - 'log_to_console': True, 15:42:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:42:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:42:56 INFO - 'opt_config_files': (), 15:42:56 INFO - 'pip_index': False, 15:42:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:56 INFO - 'cmd': ('bash', 15:42:56 INFO - '-c', 15:42:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:56 INFO - 'enabled': True, 15:42:56 INFO - 'halt_on_failure': False, 15:42:56 INFO - 'name': 'check_screen_resolution'},), 15:42:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:42:56 INFO - 'cmd': ('bash', 15:42:56 INFO - '-c', 15:42:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:42:56 INFO - 'enabled': True, 15:42:56 INFO - 'halt_on_failure': False, 15:42:56 INFO - 'name': 'check_screen_resolution'},), 15:42:56 INFO - 'run_cmd_checks_enabled': True, 15:42:56 INFO - 'sps_profile': False, 15:42:56 INFO - 'sps_profile_interval': 0, 15:42:56 INFO - 'suite': 'dromaeojs-e10s', 15:42:56 INFO - 'system_bits': '32', 15:42:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:56 INFO - 'title': 't-yosemite-r7-0182', 15:42:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:56 INFO - 'use_talos_json': True, 15:42:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:56 INFO - 'work_dir': 'build'} 15:42:56 INFO - [mozharness: 2017-04-05 22:42:56.316156Z] Running clobber step. 15:42:56 INFO - Running pre-action listener: _resource_record_pre_action 15:42:56 INFO - Running main action method: clobber 15:42:56 INFO - rmtree: /builds/slave/test/build 15:42:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:58 INFO - Running post-action listener: _resource_record_post_action 15:42:58 INFO - [mozharness: 2017-04-05 22:42:58.766273Z] Finished clobber step (success) 15:42:58 INFO - [mozharness: 2017-04-05 22:42:58.766405Z] Running read-buildbot-config step. 15:42:58 INFO - Running pre-action listener: _resource_record_pre_action 15:42:58 INFO - Running main action method: read_buildbot_config 15:42:58 INFO - Using buildbot properties: 15:42:58 INFO - { 15:42:58 INFO - "project": "", 15:42:58 INFO - "product": "firefox", 15:42:58 INFO - "script_repo_revision": "production", 15:42:58 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:42:58 INFO - "repository": "", 15:42:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:42:58 INFO - "buildid": "20170405144620", 15:42:58 INFO - "pgo_build": "False", 15:42:58 INFO - "basedir": "/builds/slave/test", 15:42:58 INFO - "buildnumber": 3, 15:42:58 INFO - "slavename": "t-yosemite-r7-0182", 15:42:58 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:42:58 INFO - "platform": "yosemite_r7", 15:42:58 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:42:58 INFO - "branch": "mozilla-beta", 15:42:58 INFO - "repo_path": "releases/mozilla-beta", 15:42:58 INFO - "revision": "db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb", 15:42:58 INFO - "stage_platform": "macosx64", 15:42:58 INFO - "builduid": "e86936d5148540c7abd45c182d46646d", 15:42:58 INFO - "slavebuilddir": "test" 15:42:58 INFO - } 15:42:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 15:42:58 INFO - Running post-action listener: _resource_record_post_action 15:42:58 INFO - [mozharness: 2017-04-05 22:42:58.769711Z] Finished read-buildbot-config step (success) 15:42:58 INFO - [mozharness: 2017-04-05 22:42:58.769860Z] Running download-and-extract step. 15:42:58 INFO - Running pre-action listener: _resource_record_pre_action 15:42:58 INFO - Running main action method: download_and_extract 15:42:58 INFO - mkdir: /builds/slave/test/build/tests 15:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:58 INFO - trying https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 15:42:58 INFO - Downloading https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 15:42:59 INFO - Downloaded 1165 bytes. 15:42:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 15:42:59 INFO - Using the following test package requirements: 15:42:59 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:42:59 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 15:42:59 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 15:42:59 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:42:59 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 15:42:59 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 15:42:59 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 15:42:59 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 15:42:59 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 15:42:59 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 15:42:59 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 15:42:59 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 15:42:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:42:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:42:59 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:43:00 INFO - Expected file size: 16116371 15:43:00 INFO - Obtained file size: 16116371 15:43:07 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:43:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 15:43:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 15:43:07 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 15:43:08 INFO - Expected file size: 16116371 15:43:08 INFO - Obtained file size: 16116371 15:43:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 15:43:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 15:43:14 INFO - Fetch https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 15:43:15 INFO - Expected file size: 14403663 15:43:15 INFO - Obtained file size: 14403663 15:43:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:16 INFO - trying https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:43:16 INFO - Downloading https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 15:43:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 15:43:17 INFO - Downloaded 58737630 bytes. 15:43:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:43:17 INFO - mkdir: /builds/slave/test/properties 15:43:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:43:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:43:17 INFO - Contents: 15:43:17 INFO - build_url:https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg 15:43:18 INFO - Running post-action listener: _resource_record_post_action 15:43:18 INFO - Running post-action listener: set_extra_try_arguments 15:43:18 INFO - [mozharness: 2017-04-05 22:43:18.636192Z] Finished download-and-extract step (success) 15:43:18 INFO - [mozharness: 2017-04-05 22:43:18.636316Z] Running populate-webroot step. 15:43:18 INFO - Running pre-action listener: _resource_record_pre_action 15:43:18 INFO - Running main action method: populate_webroot 15:43:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:43:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:43:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:43:18 INFO - '--tppagecycles', 15:43:18 INFO - '7'], 15:43:18 INFO - 'tests': ['tsvgm']}}, 15:43:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:43:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:43:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:43:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:43:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:43:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['damp', 'tps']}, 15:43:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'tests': ['damp', 'tps']}, 15:43:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['dromaeo_dom']}, 15:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:43:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['basic_compositor_video']}, 15:43:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:43:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'other-e10s': {'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['a11yr', 15:43:18 INFO - 'ts_paint', 15:43:18 INFO - 'tpaint', 15:43:18 INFO - 'sessionrestore', 15:43:18 INFO - 'sessionrestore_no_auto_restore', 15:43:18 INFO - 'tabpaint']}, 15:43:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['tsvgx', 15:43:18 INFO - 'tsvgr_opacity', 15:43:18 INFO - 'tart', 15:43:18 INFO - 'tscrollx', 15:43:18 INFO - 'cart', 15:43:18 INFO - 'tsvg_static']}, 15:43:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:43:18 INFO - 'tsvgr_opacity', 15:43:18 INFO - 'tart', 15:43:18 INFO - 'tscrollx', 15:43:18 INFO - 'cart', 15:43:18 INFO - 'tsvg_static']}, 15:43:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'talos_options': ['--disable-e10s'], 15:43:18 INFO - 'tests': ['tp5o']}, 15:43:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:43:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'talos_options': ['--disable-e10s', 15:43:18 INFO - '--xperf_path', 15:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:18 INFO - 'tests': ['tp5n']}, 15:43:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:43:18 INFO - 'talos_options': ['--xperf_path', 15:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:43:18 INFO - 'tests': ['tp5n']}}, 15:43:18 INFO - 'talos.zip': {'path': '', 15:43:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:43:18 INFO - Running post-action listener: _resource_record_post_action 15:43:18 INFO - [mozharness: 2017-04-05 22:43:18.654534Z] Finished populate-webroot step (success) 15:43:18 INFO - [mozharness: 2017-04-05 22:43:18.654666Z] Running create-virtualenv step. 15:43:18 INFO - Running pre-action listener: _resource_record_pre_action 15:43:18 INFO - Running main action method: create_virtualenv 15:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 15:43:18 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 15:43:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:43:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:43:18 INFO - Using real prefix '/tools/python27' 15:43:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 15:43:22 INFO - Installing pip.................done. 15:43:22 INFO - Return code: 0 15:43:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:43:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:43:22 INFO - Reading from file tmpfile_stdout 15:43:22 INFO - Output received: 15:43:22 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) 15:43:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:43:22 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')]} 15:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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')]} 15:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:22 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 15:43:22 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 15:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:22 INFO - 'HOME': '/Users/cltbld', 15:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:22 INFO - 'LOGNAME': 'cltbld', 15:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:22 INFO - 'MOZ_NO_REMOTE': '1', 15:43:22 INFO - 'NO_EM_RESTART': '1', 15:43:22 INFO - 'PAGER': '/bin/cat', 15:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:22 INFO - 'PWD': '/builds/slave/test', 15:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:22 INFO - 'SHELL': '/bin/bash', 15:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:22 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:22 INFO - 'USER': 'cltbld', 15:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:22 INFO - 'XPC_FLAGS': '0x0', 15:43:22 INFO - 'XPC_SERVICE_NAME': '0', 15:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:22 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 15:43:22 INFO - Cleaning up... 15:43:22 INFO - Return code: 0 15:43:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:43:22 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')]} 15:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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')]} 15:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:22 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:22 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 15:43:22 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 15:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:22 INFO - 'HOME': '/Users/cltbld', 15:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:22 INFO - 'LOGNAME': 'cltbld', 15:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:22 INFO - 'MOZ_NO_REMOTE': '1', 15:43:22 INFO - 'NO_EM_RESTART': '1', 15:43:22 INFO - 'PAGER': '/bin/cat', 15:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:22 INFO - 'PWD': '/builds/slave/test', 15:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:22 INFO - 'SHELL': '/bin/bash', 15:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:22 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:22 INFO - 'USER': 'cltbld', 15:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:22 INFO - 'XPC_FLAGS': '0x0', 15:43:22 INFO - 'XPC_SERVICE_NAME': '0', 15:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:23 INFO - Downloading/unpacking psutil>=3.1.1 15:43:23 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 15:43:23 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 15:43:23 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 15:43:23 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 15:43:23 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 15:43:23 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 15:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:43:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:26 INFO - Installing collected packages: psutil 15:43:26 INFO - Running setup.py install for psutil 15:43:26 INFO - building 'psutil._psutil_osx' extension 15:43:26 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 15:43:27 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 15:43:27 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 15:43:27 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 15:43:27 INFO - building 'psutil._psutil_posix' extension 15:43:27 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 15:43:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:43:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:43:27 INFO - ^ 15:43:27 INFO - 1 warning generated. 15:43:27 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 15:43:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:43:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:43:27 INFO - Successfully installed psutil 15:43:27 INFO - Cleaning up... 15:43:27 INFO - Return code: 0 15:43:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:43:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:27 INFO - 'HOME': '/Users/cltbld', 15:43:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:27 INFO - 'LOGNAME': 'cltbld', 15:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:27 INFO - 'MOZ_NO_REMOTE': '1', 15:43:27 INFO - 'NO_EM_RESTART': '1', 15:43:27 INFO - 'PAGER': '/bin/cat', 15:43:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:27 INFO - 'PWD': '/builds/slave/test', 15:43:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:27 INFO - 'SHELL': '/bin/bash', 15:43:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:27 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:27 INFO - 'USER': 'cltbld', 15:43:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:27 INFO - 'XPC_FLAGS': '0x0', 15:43:27 INFO - 'XPC_SERVICE_NAME': '0', 15:43:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:43:30 INFO - Installing collected packages: mozsystemmonitor 15:43:30 INFO - Running setup.py install for mozsystemmonitor 15:43:31 INFO - Successfully installed mozsystemmonitor 15:43:31 INFO - Cleaning up... 15:43:31 INFO - Return code: 0 15:43:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:43:31 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')]} 15:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:31 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')]} 15:43:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:31 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:31 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 15:43:31 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 15:43:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:31 INFO - 'HOME': '/Users/cltbld', 15:43:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:31 INFO - 'LOGNAME': 'cltbld', 15:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:31 INFO - 'MOZ_NO_REMOTE': '1', 15:43:31 INFO - 'NO_EM_RESTART': '1', 15:43:31 INFO - 'PAGER': '/bin/cat', 15:43:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:31 INFO - 'PWD': '/builds/slave/test', 15:43:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:31 INFO - 'SHELL': '/bin/bash', 15:43:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:31 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:31 INFO - 'USER': 'cltbld', 15:43:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:31 INFO - 'XPC_FLAGS': '0x0', 15:43:31 INFO - 'XPC_SERVICE_NAME': '0', 15:43:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:31 INFO - Downloading/unpacking jsonschema==2.5.1 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:31 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 15:43:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:43:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:43:34 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 15:43:34 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 15:43:34 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 15:43:34 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 15:43:34 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 15:43:34 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 15:43:34 INFO - Downloading functools32-3.2.3-2.tar.gz 15:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:43:34 INFO - warning: no files found matching '*.txt' 15:43:34 INFO - no previously-included directories found matching 'build' 15:43:34 INFO - no previously-included directories found matching 'dist' 15:43:34 INFO - no previously-included directories found matching '.git*' 15:43:34 INFO - Installing collected packages: jsonschema, functools32 15:43:34 INFO - Running setup.py install for functools32 15:43:34 INFO - warning: no files found matching '*.txt' 15:43:34 INFO - no previously-included directories found matching 'build' 15:43:34 INFO - no previously-included directories found matching 'dist' 15:43:34 INFO - no previously-included directories found matching '.git*' 15:43:34 INFO - Successfully installed jsonschema functools32 15:43:34 INFO - Cleaning up... 15:43:34 INFO - Return code: 0 15:43:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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', '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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:43: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 functools32==3.2.3-2 15:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:34 INFO - 'HOME': '/Users/cltbld', 15:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:34 INFO - 'LOGNAME': 'cltbld', 15:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:34 INFO - 'MOZ_NO_REMOTE': '1', 15:43:34 INFO - 'NO_EM_RESTART': '1', 15:43:34 INFO - 'PAGER': '/bin/cat', 15:43:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:34 INFO - 'PWD': '/builds/slave/test', 15:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:34 INFO - 'SHELL': '/bin/bash', 15:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:34 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:34 INFO - 'USER': 'cltbld', 15:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:34 INFO - 'XPC_FLAGS': '0x0', 15:43:34 INFO - 'XPC_SERVICE_NAME': '0', 15:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:43:35 INFO - Cleaning up... 15:43:35 INFO - Return code: 0 15:43:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:43:35 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')]} 15:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:35 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')]} 15:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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', '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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:43: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 blobuploader==1.2.4 15:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:35 INFO - 'HOME': '/Users/cltbld', 15:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:35 INFO - 'LOGNAME': 'cltbld', 15:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:35 INFO - 'MOZ_NO_REMOTE': '1', 15:43:35 INFO - 'NO_EM_RESTART': '1', 15:43:35 INFO - 'PAGER': '/bin/cat', 15:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:35 INFO - 'PWD': '/builds/slave/test', 15:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:35 INFO - 'SHELL': '/bin/bash', 15:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:35 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:35 INFO - 'USER': 'cltbld', 15:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:35 INFO - 'XPC_FLAGS': '0x0', 15:43:35 INFO - 'XPC_SERVICE_NAME': '0', 15:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:35 INFO - Downloading/unpacking blobuploader==1.2.4 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:43:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:43:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:43:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:40 INFO - Downloading docopt-0.6.1.tar.gz 15:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:43:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:43:40 INFO - Running setup.py install for blobuploader 15:43:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:43:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:43:40 INFO - Running setup.py install for requests 15:43:41 INFO - Running setup.py install for docopt 15:43:41 INFO - Successfully installed blobuploader requests docopt 15:43:41 INFO - Cleaning up... 15:43:41 INFO - Return code: 0 15:43:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:41 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:41 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 15:43:41 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 15:43:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:41 INFO - 'HOME': '/Users/cltbld', 15:43:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:41 INFO - 'LOGNAME': 'cltbld', 15:43:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:41 INFO - 'MOZ_NO_REMOTE': '1', 15:43:41 INFO - 'NO_EM_RESTART': '1', 15:43:41 INFO - 'PAGER': '/bin/cat', 15:43:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:41 INFO - 'PWD': '/builds/slave/test', 15:43:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:41 INFO - 'SHELL': '/bin/bash', 15:43:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:41 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:41 INFO - 'USER': 'cltbld', 15:43:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:41 INFO - 'XPC_FLAGS': '0x0', 15:43:41 INFO - 'XPC_SERVICE_NAME': '0', 15:43:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:41 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-OWRqtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:41 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-bd32D4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:41 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-sBRL1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:41 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-5SxsZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:41 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-K2YmmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-rMESgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-D_0dNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-2C6sTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-bckj0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-4pDRL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ExX7AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-U2Teh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-yetWaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-wFbX11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:42 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-BYfeCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:43 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ERuFuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:43 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-ZUbtcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:43:43 INFO - Running setup.py install for manifestparser 15:43:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:43:43 INFO - Running setup.py install for mozcrash 15:43:43 INFO - Running setup.py install for mozdebug 15:43:43 INFO - Running setup.py install for mozdevice 15:43:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:43:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:43:43 INFO - Running setup.py install for mozfile 15:43:44 INFO - Running setup.py install for mozhttpd 15:43:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Running setup.py install for mozinfo 15:43:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Running setup.py install for mozInstall 15:43:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Running setup.py install for mozleak 15:43:44 INFO - Running setup.py install for mozlog 15:43:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Running setup.py install for moznetwork 15:43:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:43:44 INFO - Running setup.py install for mozprocess 15:43:45 INFO - Running setup.py install for mozprofile 15:43:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:45 INFO - Running setup.py install for mozrunner 15:43:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:45 INFO - Running setup.py install for mozscreenshot 15:43:45 INFO - Running setup.py install for moztest 15:43:45 INFO - Running setup.py install for mozversion 15:43:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:45 INFO - Cleaning up... 15:43:45 INFO - Return code: 0 15:43:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:45 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:45 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 15:43:45 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 15:43:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:45 INFO - 'HOME': '/Users/cltbld', 15:43:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:45 INFO - 'LOGNAME': 'cltbld', 15:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:45 INFO - 'MOZ_NO_REMOTE': '1', 15:43:45 INFO - 'NO_EM_RESTART': '1', 15:43:45 INFO - 'PAGER': '/bin/cat', 15:43:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:45 INFO - 'PWD': '/builds/slave/test', 15:43:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:45 INFO - 'SHELL': '/bin/bash', 15:43:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:45 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:45 INFO - 'USER': 'cltbld', 15:43:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:45 INFO - 'XPC_FLAGS': '0x0', 15:43:45 INFO - 'XPC_SERVICE_NAME': '0', 15:43:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-2irWv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-K7La48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-HPVE00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-eKnU8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-2Eogyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-GiOYLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-cpA7eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Caof1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:46 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)) 15:43:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:46 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-Y7I1bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-omZsVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-bvm1fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-jy38q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-_slZnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-sWQbjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-MXdjaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:47 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)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-XVUVuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:43:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:47 INFO - Running setup.py (path:/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/pip-NVDbSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43:47 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)) 15:43:47 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)) 15:43:47 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)) 15:43:47 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)) 15:43:47 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)) 15:43:47 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)) 15:43:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43: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 15:43:50 INFO - Downloading blessings-1.6.tar.gz 15:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:50 INFO - Installing collected packages: blessings 15:43:50 INFO - Running setup.py install for blessings 15:43:50 INFO - Successfully installed blessings 15:43:50 INFO - Cleaning up... 15:43:50 INFO - Return code: 0 15:43:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:51 INFO - Reading from file tmpfile_stdout 15:43:51 INFO - Current package versions: 15:43:51 INFO - blessings == 1.6 15:43:51 INFO - blobuploader == 1.2.4 15:43:51 INFO - docopt == 0.6.1 15:43:51 INFO - functools32 == 3.2.3-2 15:43:51 INFO - jsonschema == 2.5.1 15:43:51 INFO - manifestparser == 1.1 15:43:51 INFO - mozInstall == 1.12 15:43:51 INFO - mozcrash == 1.0 15:43:51 INFO - mozdebug == 0.1 15:43:51 INFO - mozdevice == 0.49 15:43:51 INFO - mozfile == 1.2 15:43:51 INFO - mozhttpd == 0.7 15:43:51 INFO - mozinfo == 0.9 15:43:51 INFO - mozleak == 0.1 15:43:51 INFO - mozlog == 3.4 15:43:51 INFO - moznetwork == 0.27 15:43:51 INFO - mozprocess == 0.24 15:43:51 INFO - mozprofile == 0.28 15:43:51 INFO - mozrunner == 6.13 15:43:51 INFO - mozscreenshot == 0.1 15:43:51 INFO - mozsystemmonitor == 0.3 15:43:51 INFO - moztest == 0.8 15:43:51 INFO - mozversion == 1.4 15:43:51 INFO - psutil == 3.1.1 15:43:51 INFO - requests == 1.2.3 15:43:51 INFO - wsgiref == 0.1.2 15:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:51 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')]} 15:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:51 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')]} 15:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:52 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 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:52 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 15:43:52 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 15:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:52 INFO - 'HOME': '/Users/cltbld', 15:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:52 INFO - 'LOGNAME': 'cltbld', 15:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:52 INFO - 'MOZ_NO_REMOTE': '1', 15:43:52 INFO - 'NO_EM_RESTART': '1', 15:43:52 INFO - 'PAGER': '/bin/cat', 15:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:52 INFO - 'PWD': '/builds/slave/test', 15:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:52 INFO - 'SHELL': '/bin/bash', 15:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:52 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:52 INFO - 'USER': 'cltbld', 15:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:52 INFO - 'XPC_FLAGS': '0x0', 15:43:52 INFO - 'XPC_SERVICE_NAME': '0', 15:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 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)) 15:43:52 INFO - Cleaning up... 15:43:52 INFO - Return code: 0 15:43:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43: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')]} 15:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43: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')]} 15:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108884b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108887768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb41b4d6b50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, '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.PttzprIXJX/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.Zkjz7XexP5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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 15:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:43:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:43:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:43:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:43:52 INFO - 'HOME': '/Users/cltbld', 15:43:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:43:52 INFO - 'LOGNAME': 'cltbld', 15:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:52 INFO - 'MOZ_NO_REMOTE': '1', 15:43:52 INFO - 'NO_EM_RESTART': '1', 15:43:52 INFO - 'PAGER': '/bin/cat', 15:43:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:52 INFO - 'PWD': '/builds/slave/test', 15:43:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:43:52 INFO - 'SHELL': '/bin/bash', 15:43:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:43:52 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:43:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:43:52 INFO - 'USER': 'cltbld', 15:43:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:43:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:52 INFO - 'XPC_FLAGS': '0x0', 15:43:52 INFO - 'XPC_SERVICE_NAME': '0', 15:43:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:52 INFO - Cleaning up... 15:43:52 INFO - Return code: 0 15:43:52 INFO - Running post-action listener: _resource_record_post_action 15:43:52 INFO - Running post-action listener: _start_resource_monitoring 15:43:52 INFO - Starting resource monitoring. 15:43:52 INFO - [mozharness: 2017-04-05 22:43:52.965762Z] Finished create-virtualenv step (success) 15:43:52 INFO - [mozharness: 2017-04-05 22:43:52.966694Z] Running install step. 15:43:52 INFO - Running pre-action listener: _resource_record_pre_action 15:43:52 INFO - Running main action method: install 15:43:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:53 INFO - Reading from file tmpfile_stdout 15:43:53 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:53 INFO - Reading from file tmpfile_stdout 15:43:53 INFO - Output received: 15:43:53 INFO - Usage: mozinstall [options] installer 15:43:53 INFO - Options: 15:43:53 INFO - -h, --help show this help message and exit 15:43:53 INFO - -d DEST, --destination=DEST 15:43:53 INFO - Directory to install application into. [default: 15:43:53 INFO - "/builds/slave/test"] 15:43:53 INFO - --app=APP Application being installed. [default: firefox] 15:43:53 INFO - mkdir: /builds/slave/test/build/application 15:43:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:43:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:44:08 INFO - Reading from file tmpfile_stdout 15:44:08 INFO - Output received: 15:44:08 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:44:08 INFO - Running post-action listener: _resource_record_post_action 15:44:08 INFO - [mozharness: 2017-04-05 22:44:08.375396Z] Finished install step (success) 15:44:08 INFO - [mozharness: 2017-04-05 22:44:08.375531Z] Running run-tests step. 15:44:08 INFO - Running pre-action listener: _resource_record_pre_action 15:44:08 INFO - Running main action method: run_tests 15:44:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:44:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:44:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:44:08 INFO - 2017-04-05 15:44:08.389 screenresolution[1620:7325] starting screenresolution argv=screenresolution get 15:44:08 INFO - 2017-04-05 15:44:08.391 screenresolution[1620:7325] Display 0: 1600x1200x32@60 15:44:08 INFO - 2017-04-05 15:44:08.397 screenresolution[1621:7327] starting screenresolution argv=screenresolution list 15:44:08 INFO - Available Modes on Display 0 15:44:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:44:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:44:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:44:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:44:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:44:08 INFO - Intel Iris: 15:44:08 INFO - Chipset Model: Intel Iris 15:44:08 INFO - Type: GPU 15:44:08 INFO - Bus: Built-In 15:44:08 INFO - VRAM (Dynamic, Max): 1536 MB 15:44:08 INFO - Vendor: Intel (0x8086) 15:44:08 INFO - Device ID: 0x0a2e 15:44:08 INFO - Revision ID: 0x0009 15:44:08 INFO - Displays: 15:44:08 INFO - Display: 15:44:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:44:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:44:08 INFO - Display Serial Number: 1600x1200 60 15:44:08 INFO - Main Display: Yes 15:44:08 INFO - Mirror: Off 15:44:08 INFO - Online: Yes 15:44:08 INFO - Rotation: Supported 15:44:08 INFO - Return code: 0 15:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:44:08 INFO - Python 2.7.3 15:44:08 INFO - Return code: 0 15:44:08 INFO - grabbing minidump binary from tooltool 15:44:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:08 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 0x108662d30>, '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 0x108589db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108657be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:44:08 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 15:44:08 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 15:44:08 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 15:44:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:44:08 INFO - Return code: 0 15:44:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:44:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:44:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:44:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:44:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 15:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0182 --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 15:44:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PttzprIXJX/Render', 15:44:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:08 INFO - 'HOME': '/Users/cltbld', 15:44:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:08 INFO - 'LOGNAME': 'cltbld', 15:44:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:44:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:44:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:08 INFO - 'MOZ_NO_REMOTE': '1', 15:44:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:44:08 INFO - 'NO_EM_RESTART': '1', 15:44:08 INFO - 'PAGER': '/bin/cat', 15:44:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:08 INFO - 'PWD': '/builds/slave/test', 15:44:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:44:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:08 INFO - 'SHELL': '/bin/bash', 15:44:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Zkjz7XexP5/Listeners', 15:44:08 INFO - 'TMPDIR': '/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/', 15:44:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:08 INFO - 'USER': 'cltbld', 15:44:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:08 INFO - 'XPC_FLAGS': '0x0', 15:44:08 INFO - 'XPC_SERVICE_NAME': '0', 15:44:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0182', '--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 15:44:08 INFO - mozversion application_buildid: 20170405144620 15:44:08 INFO - mozversion application_changeset: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb 15:44:08 INFO - mozversion application_display_name: Firefox 15:44:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:44:08 INFO - mozversion application_name: Firefox 15:44:08 INFO - mozversion application_remotingname: firefox 15:44:08 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:44:08 INFO - mozversion application_vendor: Mozilla 15:44:08 INFO - mozversion application_version: 53.0 15:44:08 INFO - mozversion platform_buildid: 20170405144620 15:44:08 INFO - mozversion platform_changeset: db91f4e6e0a88c46f6dc02ffe31a933f5fe538bb 15:44:08 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:44:08 INFO - mozversion platform_version: 53.0 15:44:08 INFO - using testdate: 1491432248 15:44:08 INFO - actual date: 1491432248 15:44:08 INFO - starting webserver on 'localhost:49241' 15:44:08 INFO - SUITE-START | Running 2 tests 15:44:08 INFO - TEST-START | dromaeo_css 15:44:08 INFO - operating with platform_type : mac_ 15:44:08 INFO - Initialising browser for dromaeo_css test... 15:44:09 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmphFKFjz/profile http://localhost:49241/getInfo.html) 15:44:11 INFO - PROCESS | 1631 | 2017-04-05 15:44:11.908 plugin-container[1635:7502] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c43, name = 'com.apple.tsm.portname' 15:44:11 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:44:11 INFO - PROCESS | 1631 | 2017-04-05 15:44:11.908 plugin-container[1635:7502] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 15:44:11 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:44:11 INFO - PROCESS | 1631 | 2017-04-05 15:44:11.908 plugin-container[1635:7502] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:44:11 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 15:44:11 INFO - PROCESS | 1631 | colorDepth:24 15:44:11 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 15:44:11 INFO - PROCESS | 1631 | __metrics 15:44:12 ERROR - PROCESS | 1631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 15:44:12 INFO - TEST-INFO | 1631: exit 0 15:44:12 INFO - Browser initialized. 15:44:12 INFO - Running cycle 1/1 for dromaeo_css test... 15:44:12 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmphFKFjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:44:14 INFO - PROCESS | 1636 | 2017-04-05 15:44:14.903 plugin-container[1637:7648] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853b, name = 'com.apple.tsm.portname' 15:44:14 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:44:14 INFO - PROCESS | 1636 | 2017-04-05 15:44:14.904 plugin-container[1637:7648] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 15:44:14 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:44:14 INFO - PROCESS | 1636 | 2017-04-05 15:44:14.904 plugin-container[1637:7648] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:44:24 INFO - PROCESS | 1636 | RSS: Main: 173416448 15:44:24 INFO - PROCESS | 1636 | 15:47:26 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:47:28 INFO - PROCESS | 1636 | RSS: Main: 188620800 15:47:28 INFO - PROCESS | 1636 | 15:50:30 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:50:31 INFO - PROCESS | 1636 | RSS: Main: 200290304 15:50:31 INFO - PROCESS | 1636 | 15:53:33 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:53:33 INFO - PROCESS | 1636 | RSS: Main: 205144064 15:53:33 INFO - PROCESS | 1636 | 15:56:35 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:56:36 INFO - PROCESS | 1636 | RSS: Main: 208166912 15:56:36 INFO - PROCESS | 1636 | 15:59:39 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:59:39 INFO - PROCESS | 1636 | RSS: Main: 209412096 15:59:39 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 16:02:42 INFO - PROCESS | 1636 | RSS: Main: 209805312 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | __start_tp_report 16:02:42 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 16:02:42 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 16:02:42 INFO - PROCESS | 1636 | |i|pagename|runs| 16:02:42 INFO - PROCESS | 1636 | |0;dojo.html;3110.7666924980626;3246.8051916885;3548.2193917338177;3610.6750392464673;3631.219287853112;5940.405959404057;5941.732622032008;6029.216201893753;6049.243844519435;6065.878682426349;4815.855524334267;6050.8184754457325;6117.877642447148;6150.784722534712;6168.876622467548;5369.40936496985;5423.356936272081;5441.809536666217;5470.781168753265;5477.397486276506;4730.124926888537;5472.042392581302;5475.123980163175;5479.232907392969;5498.285222921015;5282.286891269687;5314.176302673091;5478.150886612581;5482.451754824526;5518.530924871391;5338.06583847827;5372.811951581676;5380.139177731564;5432.837014889559;5470.99999999996;5321.813736519203;5397.298351214317;5411.107167317388;5417.052015897241;5445.428230035868;5816.069428891399;5978.641281523122;6036.124761909542;6103.847403814896;6142.293636231846;6232.501399887998;6237.844053898643;6240.375962403723;6290.559660823744;6349.746010159588;6350.587211831216;6363.077353783722;6377.362263773632;6378.968105159444;6400.359964003563;6104.023356262976;6131.9269127902435;6137.140800287963;6137.693115344215;6140.232470941132;6313.652749098844;6345.460635846005;6400.7119679614525;6412.102305677209;6429.292777794439;6253.6873156342;6288.276848162428;6316.936830631635;6322.114903913456;6337.683115844189;6363.300036995926;6369.5222858285815;6371.872562548723;6393.7762178324465;6396.1045453636525;6203.596766210182;6218.657973811484;6226.719797609118;6253.78111766086;6284.622922624657;6192.628442293477;6293.716782744787;6296.275928268216;6302.558820882494;6309.242890853127;5168.250603662448;5176.042432150064;5177.197534382177;5191.506806853343;5194.27280180775;4564.315352697122;4603.470600880942;4614.907701845944;4628.514006029386;4651.790669419885;5478.45215478449;6112.41229444207;6115.848865095035;6135.04893764628;6226.844328891723;6389;6417.294097649255;6425.325340839238;6426.903596446057;6438.066480360415;5042.747862606855;5696.3164420269;6108.205933228652;6117.796956032686;6168;4619.9076018479445;5342.679439233659;5632.352279487829;5667.659940403589;5715.628484148517;6505.967470162714;6556.573822701509;6589.374009469188;6619.27188009309;6668.899966500409;6369.14016607752;6401.903971440339;6433.678316084271;6433.935660643334;6468.029795530708;6752;6770.830729231809;6778.084958530732;6778.254392016973;6781.2879647638265;5222.824864405478;6145.324014358506;6225.066240064027;6277.3408792078;6283.96858015707;6382.36176382358;6396.328385519453;6405.3594640535575;6408.391202835724;6408.775692850728;5817.941820581909;5923.822285331447;6300.401461861115;6308.243010838729;6311.27420346666;5141.845744627667;6234.15838861766;6236.18929539157;6253.3121356651645;6259.436650701458;6133.969330153321;6248.094026366242;6264.968675156595;6271.874562508816;6290.24517057956;6247.0629405589525;6254.4996400286955;6254.843628909131;6268.968655156695;6284.685765711788;4984.501549844987;6145.67867908384;6194.349593292639;6222.28443728977;6257.2491301044165 16:02:42 INFO - PROCESS | 1636 | |1;ext.html;491.65829748324916;537.2237117365408;537.4840153452683;545.6644163839237;549.9532539734121;41087.56193533227;42957;42986.355204671956;43052;43151.78424107879;45598.77200614;45990.7700461498;46068.76965615176;46169.538304616945;46264.30603540949;9729.610815567368;9927.305088643798;9955.402675839472;9985.800283994316;11500.654980350602;11680.82478762815;11797.528098876035;11809.645710628694;11816.58641947532;11833.704157396049;11806.291622502635;11845.17083804134;11871.584494542692;11874;11907.047436205126;11635.301881887113;11749.706257343549;11801.17391782567;11845.230060046155;11858.466369013415;11640.708982275512;11741.941290293495;11782.587609433629;11814.11394145434;11817.290962542274;38242;38591.80704096462;38619;38629.806850965564;38767.80616096901;4081.530623978251;4084.7344922580232;4099.0162361033135;4172.749635021908;4176.1230141670285;28349;28561.000364987332;28566.143015709564;28590;31121.533177002362;3281.5569898063695;3458.4639380896;3486.6861982421706;3508.105433114565;3551.8401671924826;494927;507176;507725;508499;510193.44903275615;59537.404625954056;60172;60514;60540.78918421607;60592.69703651542;61735;62660.06009909855;62741.68629156825;62863;62886.685566571876;15759.921200394154;16841.410550630913;17049.40327088546;17049.7442538362;17059.48821535356;12027.27836329823;12241.387930603434;12969.740605187844;13148.737025259441;13239.66900827487;18767.530811729543;18844;18972;19046;19054.90472547656;6797.592144471348;7449.813754656177;8346.248837604644;8453.619587118594;8453.788655283544;909.8134882349102;922.6447817590142;927.11460555171;953.413650604873;958.7938593202356;29355.55966660502;29544.704552954194;31117.222069448446;31689;32001.679983200334;907.7866701325183;1114;1139.7489957334365;1143.2111842828588;1251.6245126462024;13107.344632768514;16219.432319868747;16306.510804675641;16355.182240888145;16731.079790611635;599275;612505;651612;659978;662570;58666.82666346734;58959.82080358369;64181;64565;64695.67652161709;1468.3539242733164;1470.2869108482378;1498.4305963733711;1512.7277090123664;1516.5222954769213;24085.37648659034;30722;30771.53842692406;31413;31419.214519636276;50492.990140197726;53046;53291.6677083076;53322.2001669983;53546.46453535415;441662;499258;500335;500645;501257;23680.28959131229;28003.159905202876;28079.859600701864;28450.57324140181;28460;49836.25245621246;50420.74789626028;50664.98670026505;50922.490775093254;51136;32768.67231327656;33463.089391942995;33478.497822533165;33858.32283354369;34178.48732269068;33302.33395332031;33449.16377090592;33956;34017.48973765346;34376.48435273423;38612.034699132746;39629;39629;39666.80166599149;39819.00452488711;33142.5028624566;33147.34263286874;33370.165745856546;34153.316933661685;34502.65497344994;26091;26137.6079358806;26172.73827261703;26397.20808375752;26673.599896001186 16:02:42 INFO - PROCESS | 1636 | |2;jquery.html;335.50010484378276;393.80506649208627;399.1507014558703;402.6979765176117;425.92878909542486;15599.92200039001;17168.9698618083;20797.792022079775;22254.109835606596;22282.66576001359;17626.735598966025;21793.91030448479;22363.664545031796;22499.437514062156;22685.54628907421;5510.256115424427;5845.181674565543;5906.37983011784;5908.379620139866;5919.2009078774245;5716.8284951451315;5863.58954873159;5911.586188966774;5913.852153696171;5936.554758393117;5913.7338819752995;5939.198208241897;5940.227770389865;5941.910871336933;5945.37573554777;5699.971500142494;5799.623024503394;5836.824895253149;5903.645781253117;5963.970180149093;5187.48125187482;5194.065068287707;5201.45384734605;5209.374875015023;5215.687058776448;20247;21141.260055898125;26145.607815882777;26332.73667263322;26489.337766555796;2838.8722507487214;2856.8285902845896;2871;2895.4788138135127;2916.9854150729325;15491.690166196726;15674.451394201149;15947;15973.440929567525;16345.91827040869;1846.6675998320297;1863.8602104842055;1866.4027511196423;1885.4437940807495;1888.225827410755;115345;132554;134259;135496;137503.5624109395;9568.330216884891;11722.824157637642;11834.994025507756;11857.940710296394;11963.700907477383;14833.961622686309;14855.628609284855;14858.702825943421;14874.702505949821;14888.553343399715;7453.440991925628;8678.56607169639;8989.46063236208;9090.13643703847;9190.540472976325;7470.663820128108;9047.81904361909;9081.68214112503;9231.307651926132;9285.164335209864;6561.507886908405;7239.348458638748;7262.564246145248;7275.781726548212;7306.561606303639;1996.301294546897;2038.4699978005528;2042.0708577597454;2048.139781291861;2048.5185981294385;902.4224496322358;1074.1872990234112;1085.4464223246202;1093.8796732359433;1122.680036189682;18616.534586635444;22097.889510552344;22636.320910372717;22739.772602274097;22826.42933926665;960.1262850805733;1081.4592703648175;1108.6396921000708;1111.5776005118003;1118.82658187981;10622.787544249071;11438.599649012245;11624.6512604622;11661.125415593695;11778.234414763014;774765;782869;788479;795126;796893;110110;137448;143988.56011439962;149706;151015.24492377468;1057.677408390433;1084.7505073833063;1096.1942971915475;1104.4974536585835;1107.883672214422;14586.270686465847;17645;19015;19092.95567919202;19143.23427062902;59020.70489647524;59837.401625983184;60765;60868.47828804315;62717;87821;88425.55787221022;89388.6591701138;90603;91074.54462727644;6563.9343606563325;7825.804354891174;7888.68445262206;8220.054693710299;8311.792205194919;9156.633734650806;12178.57374991871;13208.669783255495;13210.207387556777;13224.933875330562;9778.951105244429;11141.777164456827;11369.31784092957;11705.941470292593;11727.237729547553;10529.420586912025;10621.990910863455;10668.253222274676;10750.623728169476;11050.723731906766;11445.370504621993;11570.537178513101;11754.941225293818;11813.173077884465;11891;6648.7340506379205;7125.002499650157;8025.836253743291;8339.166083391612;8627.705844123431;10393.220508461744;11055.22613417053;11070.114390848552;11296.322220666787;11391.145664075393 16:02:42 INFO - PROCESS | 1636 | |3;mootools.html;1384.5569417786307;1468.6328417895527;1496.5360738171169;1499.9175045372508;1505.5784380373493;7676.117246516652;7930.643121059552;8212.055613604438;8640.870386944202;8649.437786543871;8125.878111828328;8424.747257582283;8431.957840210805;8531.872021919677;8560.700375486858;2371.1108334374653;2412.19191570824;2415.2995631266913;2417.891194896225;2433.4159801647565;2069.3067822279554;2365.680633114525;2381.6546600742968;2382.797462215714;2406.867622280774;2338.5673650374733;2347.9413014674683;2354.458474550854;2378.9286321410386;2384.2727967969763;2347.8708671023087;2349.788519033287;2370.6207006878903;2371.27676058802;2379.464620460383;2353.411647088228;2380.297812145404;2385.4751954569965;2402.60357041088;2412.8793560322088;8457;8474.406791524596;8515.74452766418;8520.318374530023;8602.2688071514;5169.948300516984;5272.604554658377;5314.0700377433795;5321.255024296602;5337.092694241988;3028.6668466468673;3414.6756058174433;3529.94705079424;3601.837917293728;3622.2574372253625;1058.5077938758436;1263.993680031594;1300.856905740368;1308.3719814489004;1318.24859829897;8935.597898094602;10787.67636970892;10859.619913302997;10948.671539853816;10958.397288149228;4388.341748737715;4571.81712731487;4599.402077729874;4619.838305659286;4663.463701674283;8603;8752.387332886638;8782.824343513093;8795.252403545643;8808.691695790616;5192.402873669501;5206.271122042917;5209;5228.738563071907;5244.606654500928;4282.957170428318;4350.58669426404;4767.974885399586;4843.370361853007;4895.363602731693;3950.1902110067367;4011.959880401217;4072.1855628874346;4091.6112969267874;4128.112455822013;1292.0180662696418;1310.344827586207;1314.4413624209865;1325.191633103806;1329.2157627000117;788.645109700637;931.1154403316741;936.6628013914985;942.7313215733483;952.4333021851987;5500.697461639568;5572.219889215513;5687.146927960839;5868.794592189338;5884.0585506318785;582.0541619867715;591.3642833953431;599.0235915457775;602.7829981206762;607.5079185859468;3766.114962983697;3863.5943225961432;3902.434147048662;3961.2473630010204;3962.6829853611644;8251.628676709563;9719.076687714656;9854.704358869245;9899.851502227473;9924.404535727735;9768.07203315684;9816.852747208797;9831.31180817336;9855.90144098564;9867.753306167404;7841.176676449005;7891.368690504746;7949.920500794918;7953.880691789628;7990.240927111915;5421.674699518042;5487.807926722546;5530.55755539564;5593;5650.124230744241;8747.16901894319;8961.014288428138;9030.819383612423;9056.909430905871;9241.630334786532;9119.179273865384;9193.310501712265;9248.16766491019;9288.164065234161;9305.348625596143;6766.729330826909;6931.757388491378;7131.536450130725;7263.237360077327;7390.371818395497;7923.20767923203;8048.356131509348;8103.716369927024;8130.39022073335;8145.8370832584205;6087.330393656783;6958.582485050913;7041.612711300928;7051.1186101737285;7093.3970612498515;6893.965530172518;6934;6940.583564986117;6972.337627925339;6980.860382792417;6391.840203994937;6470.6441145737435;6503.317151699003;6520.217573890974;6531.738730450728;4229.344451610005;4305.397244385851;5019.974900125476;5027.296178535081;5097.566706829961;5001.8499445016705;5019.096562618618;5166.844994650167;5173.198154285941;5189.792408303626 16:02:42 INFO - PROCESS | 1636 | |4;prototype.html;310.731217496865;328.453125545966;366.82025807354387;370.5719893522981;382.3175631497777;4300.741955482673;4430.5126436092005;5275.709835959021;5364.927014597081;5374.6775193488365;4327.394164816928;5130.71781052042;5312.521873031426;5338.572914166867;5413.53984911282;3899.454076429302;3967.8412863485496;4189.413482112506;4234.661227101825;4254.808533615979;3515.7694806817535;3880.592537783534;3910;4037.7792214282176;4233.44965154531;3993.4409182714444;4048.6153815387493;4051.97974010131;4071.97964010181;4073.9019405006447;3709.332320182366;4056.492938382702;4068.084680946778;4076.2051399977017;4095.6279646318517;3374.9156271093175;3560.857565697369;3568.822288644767;3571.39286321326;3589;4993.975030124826;5105.897882042375;5195.610329225323;5208.9739551302;5298.496642818926;3928.666063384616;3950.644442000205;4460.568989900512;4726.5746082852365;4734.526547345273;5209.583233341324;5488.012157811592;5657.886842263173;5679.148127780824;5703.31560212773;3416.521686963827;3785.280796648628;3856.2480316338324;3912.6478616924614;3913;5918.496927761145;5949.791757288474;5965.164876917235;5973.522118230575;6007.969960150215;3664.670179683841;3942.172143849766;3942.4230307876505;3958.4853968984426;3959.703022273341;3640.162762564625;3806.809659517013;3834.7890866002635;4018.738781979162;4028.194361127786;3745.831437585315;4638.582527572535;4658.133748988332;4658.976705116453;4679.251319788817;4829.966977573695;5024.824131155465;5461.535769459561;5605.859853503695;5637.689927054052;1110.6945589962825;1258.993705031469;1260.521002019227;1289.348878816192;1290.5483080921601;743.7173873927981;869.6347534035721;884.4030279561271;885.7608445719749;901.9052999435096;4962.454130045692;5123.513266239701;5159.871003224875;5172.637915345889;5183.45573714762;4859.101066302675;4988.084353782264;5001.924971125436;5009.947910938744;5227.3465816772905;4090.6727461802984;4918.754062296871;4997.450280469146;5123.641345105807;5245.606579506552;2375.3349062262596;2890;2938.2213713365977;2945.231482406574;2945.5434407666844;5435.918461223085;5726.247214811697;5811.9709401453565;5855.736491857877;5876.529877609781;4822.359118865234;5018;5457.680485793522;5707.287813655887;5815;5816.76732930678;5850.882982340415;5861.794837180678;5867.442592953663;5880.794172204038;4775.856724298276;5518.199861020049;5569.44305569456;5592.524635405874;5647.322321321468;4957.03337849116;5005.448311023594;5050.797968081236;5097.7960881565805;5134.717590532557;4742.596879265301;5299.4700529946695;5749.7125143741805;5778.313084415767;5872.5301975842685;3410.64188260239;3548.5209496718644;3756.2111956489443;3770.86873937823;3800.643600967418;4161.9583804161575;5013.523715247045;5105.591552675852;5568.693721845338;5570.546261318009;4627.791749371219;5198.038362902875;5473.31583552056;5646.689432081275;5670.383940576916;4560.703554269095;4708.540352490739;5439;5489.176623506506;5591.748371323219;5042.647014708935;5353.357597088374;5446.965076635426;5535.782127931849;5579.358373787067;5466.125419932791;5547.2511210986;5603.2155498231095;5614.69119198448;5632.831015069554;4903.53416425439;5256.6320357574605;5404.243405923095;5567.387587365468;5581.274434323512 16:02:42 INFO - PROCESS | 1636 | |5;yui.html;728.9890651640223;780.3718007004361;794.9046114466265;809.9511133082657;870.9651613935442;15154.621134471643;15760.605984850385;15911.124888131148;16068;16261.430849920254;13525.594232173025;14004.859951400484;14775.630609234775;14935.551933441988;14936.327865246063;558.123745719221;692.1935944624506;859.5831021954347;892.7054072156205;892.959816808242;750.2759836757527;894.7047474333455;905.7056456651582;908.7955210077746;909.3043821476542;955.3217215776772;958.7842735384518;959.0122174160625;959.4962644611564;963.8939716631165;914.8444764390036;916.5921165081542;930.1117432851611;938.5729493080667;960.7165886063628;687.5530904911798;702.9613371264578;709.1915216653019;716.9926253613629;718.823888147402;12944.741105177844;14935.25323733809;15384.846151538453;15986.920065399714;16238.18809059554;13320.181025979115;13895.58313250604;14678.633034174125;14832.406703731838;14929.253537323199;11702.063834893188;11875.940620296844;11888.346140962243;11905.082044769784;11906.821397679041;3782.3191825471404;3805.771653700787;3810.085579460937;3907.589703081164;3918.216356728637;97724.51137744266;98412.50793746057;100568;100795;101658;11276.718082048015;11500.884991149982;11633;11830.290182589073;11916.94041529804;21988.560228795333;23563.882180588986;23847.52304953891;23868.761312386654;23899.40251493692;7547.207543207884;8141;8156.592170391456;8161.714339998191;8317.001959764866;4358.694891357638;4361.105973275471;4409.096135292258;4424.181526417623;4430.867073987785;3611.530501034849;3661.3043521730788;3690.944635830465;3691.4647376130847;3711.5175027246823;655.6625629630353;668.2782594797607;672.700648211551;682.8292926768308;689.5414549324643;593.3028691287719;647.6146692717825;664.6842749693857;678.1353773938268;699.5313140196081;9602.471864047544;9674.903250967542;10068.90718674588;10206.13247873939;10221.386716797017;655.8360409897525;677.7898851356096;692.7090621938697;693.143967200507;694.8888177891513;4480.350349199413;4606.147862645421;4634.328022436728;4682.2040253156365;4709.458412282563;95915;104147.4792626032;113321.4333928325;113326;113882;74037.88943165856;94209;96668;98250.52624210643;99727.50136249272;86015;88628;89282;89940;90938;9054.275657947217;9066.90933090687;9075.455472671661;9181.632734690806;9192.264618830612;56002.159967599706;57554.71222644027;57827;58370;58416.123758142814;59273.407265928516;70890;73408.53182936205;74467.62766186135;77129.61435192788;11475.885241147482;11781.52873885035;13452.394642240926;13623.386947587183;13726.245056521988;13212.471501139848;13738.931305343409;14741.410343586136;15069.773953390488;15547.922260389078;14294.571162865132;14310.069845460011;14378.856211437751;14582.85417145815;14806.851931480547;11952.820707689218;14252.928735356672;14313.642158945693;14486.348114335091;14547.85452145465;13029;13088.672783180496;13890.325403771329;14085.929570352082;14101.576952691436;9482.952585237306;9996.300258982092;10121.596419246549;10275.126614237874;10649.574017039542;8622.568871556523;9146.673732308911;10332.225083118947;10364.481775911325;10417.374957502574 16:02:42 INFO - PROCESS | 1636 | __end_tp_report 16:02:42 INFO - PROCESS | 1636 | __start_cc_report 16:02:42 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,378 16:02:42 INFO - PROCESS | 1636 | __end_cc_report 16:02:42 INFO - PROCESS | 1636 | __startTimestamp1491433362438__endTimestamp 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | ------- Summary: start ------- 16:02:42 INFO - PROCESS | 1636 | Number of tests: 6 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5906.94 Median:6192.63 stddev:677.08 (10.9%) stddev-sans-first:642.65 16:02:42 INFO - PROCESS | 1636 | Values: 3110.8 3246.8 3548.2 3610.7 3631.2 5940.4 5941.7 6029.2 6049.2 6065.9 4815.9 6050.8 6117.9 6150.8 6168.9 5369.4 5423.4 5441.8 5470.8 5477.4 4730.1 5472.0 5475.1 5479.2 5498.3 5282.3 5314.2 5478.2 5482.5 5518.5 5338.1 5372.8 5380.1 5432.8 5471.0 5321.8 5397.3 5411.1 5417.1 5445.4 5816.1 5978.6 6036.1 6103.8 6142.3 6232.5 6237.8 6240.4 6290.6 6349.7 6350.6 6363.1 6377.4 6379.0 6400.4 6104.0 6131.9 6137.1 6137.7 6140.2 6313.7 6345.5 6400.7 6412.1 6429.3 6253.7 6288.3 6316.9 6322.1 6337.7 6363.3 6369.5 6371.9 6393.8 6396.1 6203.6 6218.7 6226.7 6253.8 6284.6 6192.6 6293.7 6296.3 6302.6 6309.2 5168.3 5176.0 5177.2 5191.5 5194.3 4564.3 4603.5 4614.9 4628.5 4651.8 5478.5 6112.4 6115.8 6135.0 6226.8 6389.0 6417.3 6425.3 6426.9 6438.1 5042.7 5696.3 6108.2 6117.8 6168.0 4619.9 5342.7 5632.4 5667.7 5715.6 6506.0 6556.6 6589.4 6619.3 6668.9 6369.1 6401.9 6433.7 6433.9 6468.0 6752.0 6770.8 6778.1 6778.3 6781.3 5222.8 6145.3 6225.1 6277.3 6284.0 6382.4 6396.3 6405.4 6408.4 6408.8 5817.9 5923.8 6300.4 6308.2 6311.3 5141.8 6234.2 6236.2 6253.3 6259.4 6134.0 6248.1 6265.0 6271.9 6290.2 6247.1 6254.5 6254.8 6269.0 6284.7 4984.5 6145.7 6194.3 6222.3 6257.2 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:68662.98 Median:18980.56 stddev:146193.11 (770.2%) stddev-sans-first:146513.62 16:02:42 INFO - PROCESS | 1636 | Values: 491.7 537.2 537.5 545.7 550.0 41087.6 42957.0 42986.4 43052.0 43151.8 45598.8 45990.8 46068.8 46169.5 46264.3 9729.6 9927.3 9955.4 9985.8 11500.7 11680.8 11797.5 11809.6 11816.6 11833.7 11806.3 11845.2 11871.6 11874.0 11907.0 11635.3 11749.7 11801.2 11845.2 11858.5 11640.7 11741.9 11782.6 11814.1 11817.3 38242.0 38591.8 38619.0 38629.8 38767.8 4081.5 4084.7 4099.0 4172.7 4176.1 28349.0 28561.0 28566.1 28590.0 31121.5 3281.6 3458.5 3486.7 3508.1 3551.8 494927.0 507176.0 507725.0 508499.0 510193.4 59537.4 60172.0 60514.0 60540.8 60592.7 61735.0 62660.1 62741.7 62863.0 62886.7 15759.9 16841.4 17049.4 17049.7 17059.5 12027.3 12241.4 12969.7 13148.7 13239.7 18767.5 18844.0 18972.0 19046.0 19054.9 6797.6 7449.8 8346.2 8453.6 8453.8 909.8 922.6 927.1 953.4 958.8 29355.6 29544.7 31117.2 31689.0 32001.7 907.8 1114.0 1139.7 1143.2 1251.6 13107.3 16219.4 16306.5 16355.2 16731.1 599275.0 612505.0 651612.0 659978.0 662570.0 58666.8 58959.8 64181.0 64565.0 64695.7 1468.4 1470.3 1498.4 1512.7 1516.5 24085.4 30722.0 30771.5 31413.0 31419.2 50493.0 53046.0 53291.7 53322.2 53546.5 441662.0 499258.0 500335.0 500645.0 501257.0 23680.3 28003.2 28079.9 28450.6 28460.0 49836.3 50420.7 50665.0 50922.5 51136.0 32768.7 33463.1 33478.5 33858.3 34178.5 33302.3 33449.2 33956.0 34017.5 34376.5 38612.0 39629.0 39629.0 39666.8 39819.0 33142.5 33147.3 33370.2 34153.3 34502.7 26091.0 26137.6 26172.7 26397.2 26673.6 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:41709.80 Median:22323.17 stddev:130559.50 (584.9%) stddev-sans-first:130888.79 16:02:42 INFO - PROCESS | 1636 | Values: 335.5 393.8 399.2 402.7 425.9 15599.9 17169.0 20797.8 22254.1 22282.7 17626.7 21793.9 22363.7 22499.4 22685.5 5510.3 5845.2 5906.4 5908.4 5919.2 5716.8 5863.6 5911.6 5913.9 5936.6 5913.7 5939.2 5940.2 5941.9 5945.4 5700.0 5799.6 5836.8 5903.6 5964.0 5187.5 5194.1 5201.5 5209.4 5215.7 20247.0 21141.3 26145.6 26332.7 26489.3 2838.9 2856.8 2871.0 2895.5 2917.0 15491.7 15674.5 15947.0 15973.4 16345.9 1846.7 1863.9 1866.4 1885.4 1888.2 115345.0 132554.0 134259.0 135496.0 137503.6 9568.3 11722.8 11835.0 11857.9 11963.7 14834.0 14855.6 14858.7 14874.7 14888.6 7453.4 8678.6 8989.5 9090.1 9190.5 7470.7 9047.8 9081.7 9231.3 9285.2 6561.5 7239.3 7262.6 7275.8 7306.6 1996.3 2038.5 2042.1 2048.1 2048.5 902.4 1074.2 1085.4 1093.9 1122.7 18616.5 22097.9 22636.3 22739.8 22826.4 960.1 1081.5 1108.6 1111.6 1118.8 10622.8 11438.6 11624.7 11661.1 11778.2 774765.0 782869.0 788479.0 795126.0 796893.0 110110.0 137448.0 143988.6 149706.0 151015.2 1057.7 1084.8 1096.2 1104.5 1107.9 14586.3 17645.0 19015.0 19093.0 19143.2 59020.7 59837.4 60765.0 60868.5 62717.0 87821.0 88425.6 89388.7 90603.0 91074.5 6563.9 7825.8 7888.7 8220.1 8311.8 9156.6 12178.6 13208.7 13210.2 13224.9 9779.0 11141.8 11369.3 11705.9 11727.2 10529.4 10622.0 10668.3 10750.6 11050.7 11445.4 11570.5 11754.9 11813.2 11891.0 6648.7 7125.0 8025.8 8339.2 8627.7 10393.2 11055.2 11070.1 11296.3 11391.1 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5414.10 Median:5494.25 stddev:2897.61 (52.7%) stddev-sans-first:2889.91 16:02:42 INFO - PROCESS | 1636 | Values: 1384.6 1468.6 1496.5 1499.9 1505.6 7676.1 7930.6 8212.1 8640.9 8649.4 8125.9 8424.7 8432.0 8531.9 8560.7 2371.1 2412.2 2415.3 2417.9 2433.4 2069.3 2365.7 2381.7 2382.8 2406.9 2338.6 2347.9 2354.5 2378.9 2384.3 2347.9 2349.8 2370.6 2371.3 2379.5 2353.4 2380.3 2385.5 2402.6 2412.9 8457.0 8474.4 8515.7 8520.3 8602.3 5169.9 5272.6 5314.1 5321.3 5337.1 3028.7 3414.7 3529.9 3601.8 3622.3 1058.5 1264.0 1300.9 1308.4 1318.2 8935.6 10787.7 10859.6 10948.7 10958.4 4388.3 4571.8 4599.4 4619.8 4663.5 8603.0 8752.4 8782.8 8795.3 8808.7 5192.4 5206.3 5209.0 5228.7 5244.6 4283.0 4350.6 4768.0 4843.4 4895.4 3950.2 4012.0 4072.2 4091.6 4128.1 1292.0 1310.3 1314.4 1325.2 1329.2 788.6 931.1 936.7 942.7 952.4 5500.7 5572.2 5687.1 5868.8 5884.1 582.1 591.4 599.0 602.8 607.5 3766.1 3863.6 3902.4 3961.2 3962.7 8251.6 9719.1 9854.7 9899.9 9924.4 9768.1 9816.9 9831.3 9855.9 9867.8 7841.2 7891.4 7949.9 7953.9 7990.2 5421.7 5487.8 5530.6 5593.0 5650.1 8747.2 8961.0 9030.8 9056.9 9241.6 9119.2 9193.3 9248.2 9288.2 9305.3 6766.7 6931.8 7131.5 7263.2 7390.4 7923.2 8048.4 8103.7 8130.4 8145.8 6087.3 6958.6 7041.6 7051.1 7093.4 6894.0 6934.0 6940.6 6972.3 6980.9 6391.8 6470.6 6503.3 6520.2 6531.7 4229.3 4305.4 5020.0 5027.3 5097.6 5001.8 5019.1 5166.8 5173.2 5189.8 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4465.21 Median:5003.69 stddev:1360.32 (27.2%) stddev-sans-first:1327.92 16:02:42 INFO - PROCESS | 1636 | Values: 310.7 328.5 366.8 370.6 382.3 4300.7 4430.5 5275.7 5364.9 5374.7 4327.4 5130.7 5312.5 5338.6 5413.5 3899.5 3967.8 4189.4 4234.7 4254.8 3515.8 3880.6 3910.0 4037.8 4233.4 3993.4 4048.6 4052.0 4072.0 4073.9 3709.3 4056.5 4068.1 4076.2 4095.6 3374.9 3560.9 3568.8 3571.4 3589.0 4994.0 5105.9 5195.6 5209.0 5298.5 3928.7 3950.6 4460.6 4726.6 4734.5 5209.6 5488.0 5657.9 5679.1 5703.3 3416.5 3785.3 3856.2 3912.6 3913.0 5918.5 5949.8 5965.2 5973.5 6008.0 3664.7 3942.2 3942.4 3958.5 3959.7 3640.2 3806.8 3834.8 4018.7 4028.2 3745.8 4638.6 4658.1 4659.0 4679.3 4830.0 5024.8 5461.5 5605.9 5637.7 1110.7 1259.0 1260.5 1289.3 1290.5 743.7 869.6 884.4 885.8 901.9 4962.5 5123.5 5159.9 5172.6 5183.5 4859.1 4988.1 5001.9 5009.9 5227.3 4090.7 4918.8 4997.5 5123.6 5245.6 2375.3 2890.0 2938.2 2945.2 2945.5 5435.9 5726.2 5812.0 5855.7 5876.5 4822.4 5018.0 5457.7 5707.3 5815.0 5816.8 5850.9 5861.8 5867.4 5880.8 4775.9 5518.2 5569.4 5592.5 5647.3 4957.0 5005.4 5050.8 5097.8 5134.7 4742.6 5299.5 5749.7 5778.3 5872.5 3410.6 3548.5 3756.2 3770.9 3800.6 4162.0 5013.5 5105.6 5568.7 5570.5 4627.8 5198.0 5473.3 5646.7 5670.4 4560.7 4708.5 5439.0 5489.2 5591.7 5042.6 5353.4 5447.0 5535.8 5579.4 5466.1 5547.3 5603.2 5614.7 5632.8 4903.5 5256.6 5404.2 5567.4 5581.3 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21241.30 Median:4455.61 stddev:30660.85 (688.1%) stddev-sans-first:30708.18 16:02:42 INFO - PROCESS | 1636 | Values: 729.0 780.4 794.9 810.0 871.0 15154.6 15760.6 15911.1 16068.0 16261.4 13525.6 14004.9 14775.6 14935.6 14936.3 558.1 692.2 859.6 892.7 893.0 750.3 894.7 905.7 908.8 909.3 955.3 958.8 959.0 959.5 963.9 914.8 916.6 930.1 938.6 960.7 687.6 703.0 709.2 717.0 718.8 12944.7 14935.3 15384.8 15986.9 16238.2 13320.2 13895.6 14678.6 14832.4 14929.3 11702.1 11875.9 11888.3 11905.1 11906.8 3782.3 3805.8 3810.1 3907.6 3918.2 97724.5 98412.5 100568.0 100795.0 101658.0 11276.7 11500.9 11633.0 11830.3 11916.9 21988.6 23563.9 23847.5 23868.8 23899.4 7547.2 8141.0 8156.6 8161.7 8317.0 4358.7 4361.1 4409.1 4424.2 4430.9 3611.5 3661.3 3690.9 3691.5 3711.5 655.7 668.3 672.7 682.8 689.5 593.3 647.6 664.7 678.1 699.5 9602.5 9674.9 10068.9 10206.1 10221.4 655.8 677.8 692.7 693.1 694.9 4480.4 4606.1 4634.3 4682.2 4709.5 95915.0 104147.5 113321.4 113326.0 113882.0 74037.9 94209.0 96668.0 98250.5 99727.5 86015.0 88628.0 89282.0 89940.0 90938.0 9054.3 9066.9 9075.5 9181.6 9192.3 56002.2 57554.7 57827.0 58370.0 58416.1 59273.4 70890.0 73408.5 74467.6 77129.6 11475.9 11781.5 13452.4 13623.4 13726.2 13212.5 13738.9 14741.4 15069.8 15547.9 14294.6 14310.1 14378.9 14582.9 14806.9 11952.8 14252.9 14313.6 14486.3 14547.9 13029.0 13088.7 13890.3 14085.9 14101.6 9483.0 9996.3 10121.6 10275.1 10649.6 8622.6 9146.7 10332.2 10364.5 10417.4 16:02:42 INFO - PROCESS | 1636 | -------- Summary: end -------- 16:02:42 INFO - PROCESS | 1636 | 16:02:42 INFO - TEST-INFO | 1636: exit 0 16:02:43 INFO - TEST-OK | dromaeo_css | took 1114032ms 16:02:43 INFO - TEST-START | kraken 16:02:43 INFO - operating with platform_type : mac_ 16:02:43 INFO - Initialising browser for kraken test... 16:02:43 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpOXrzrD/profile http://localhost:49241/getInfo.html) 16:02:45 INFO - PROCESS | 1647 | 2017-04-05 16:02:45.399 plugin-container[1649:9912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853b, name = 'com.apple.tsm.portname' 16:02:45 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:02:45 INFO - PROCESS | 1647 | 2017-04-05 16:02:45.399 plugin-container[1649:9912] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x870b, name = 'com.apple.CFPasteboardClient' 16:02:45 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:02:45 INFO - PROCESS | 1647 | 2017-04-05 16:02:45.400 plugin-container[1649:9912] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:02:45 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 16:02:45 INFO - PROCESS | 1647 | colorDepth:24 16:02:45 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 16:02:45 INFO - PROCESS | 1647 | __metrics 16:02:45 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 16:02:46 INFO - TEST-INFO | 1647: exit 0 16:02:46 INFO - Browser initialized. 16:02:46 INFO - Running cycle 1/1 for kraken test... 16:02:46 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/T/tmpOXrzrD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:48 INFO - PROCESS | 1650 | 2017-04-05 16:02:48.636 plugin-container[1651:10040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x842f, name = 'com.apple.tsm.portname' 16:02:48 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:02:48 INFO - PROCESS | 1650 | 2017-04-05 16:02:48.636 plugin-container[1651:10040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 16:02:48 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:02:48 INFO - PROCESS | 1650 | 2017-04-05 16:02:48.636 plugin-container[1651:10040] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:02:58 INFO - PROCESS | 1650 | RSS: Main: 173473792 16:02:58 INFO - PROCESS | 1650 | 16:03:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 16:03:02 INFO - PROCESS | 1650 | RSS: Main: 186531840 16:03:02 INFO - PROCESS | 1650 | 16:03:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 16:03:05 INFO - PROCESS | 1650 | RSS: Main: 194281472 16:03:05 INFO - PROCESS | 1650 | 16:03:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 16:03:09 INFO - PROCESS | 1650 | RSS: Main: 198234112 16:03:09 INFO - PROCESS | 1650 | 16:03:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 16:03:11 INFO - PROCESS | 1650 | RSS: Main: 198709248 16:03:11 INFO - PROCESS | 1650 | 16:03:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:03:14 INFO - PROCESS | 1650 | RSS: Main: 199790592 16:03:14 INFO - PROCESS | 1650 | 16:03:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 16:03:18 INFO - PROCESS | 1650 | RSS: Main: 204505088 16:03:18 INFO - PROCESS | 1650 | 16:03:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 16:03:21 INFO - PROCESS | 1650 | RSS: Main: 203767808 16:03:21 INFO - PROCESS | 1650 | 16:03:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 16:03:25 INFO - PROCESS | 1650 | RSS: Main: 203251712 16:03:25 INFO - PROCESS | 1650 | 16:03:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:03:27 INFO - PROCESS | 1650 | RSS: Main: 202461184 16:03:27 INFO - PROCESS | 1650 | 16:03:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:03:30 INFO - PROCESS | 1650 | RSS: Main: 202473472 16:03:30 INFO - PROCESS | 1650 | 16:03:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:03:32 INFO - PROCESS | 1650 | RSS: Main: 202424320 16:03:32 INFO - PROCESS | 1650 | 16:03:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:03:36 INFO - PROCESS | 1650 | RSS: Main: 202510336 16:03:36 INFO - PROCESS | 1650 | 16:03:39 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:03:40 INFO - PROCESS | 1650 | RSS: Main: 202895360 16:03:40 INFO - PROCESS | 1650 | 16:03:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 16:03:42 INFO - PROCESS | 1650 | RSS: Main: 204685312 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | __start_tp_report 16:03:42 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:03:42 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:03:42 INFO - PROCESS | 1650 | |i|pagename|runs| 16:03:42 INFO - PROCESS | 1650 | |0;ai-astar;104;118;118;117;117;117;119;117;117;119 16:03:42 INFO - PROCESS | 1650 | |1;audio-beat-detection;140;110;109;139;110;117;142;142;129;112 16:03:42 INFO - PROCESS | 1650 | |2;audio-dft;191;230;274;201;193;197;193;193;187;196 16:03:42 INFO - PROCESS | 1650 | |3;audio-fft;83;57;60;85;58;59;57;60;70;59 16:03:42 INFO - PROCESS | 1650 | |4;audio-oscillator;82;68;85;71;70;78;103;101;88;81 16:03:42 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;92;90;91;90;92;88;89;123;135;103 16:03:42 INFO - PROCESS | 1650 | |6;imaging-darkroom;116;98;97;96;96;98;97;118;119;98 16:03:42 INFO - PROCESS | 1650 | |7;imaging-desaturate;136;138;90;94;92;91;93;92;90;94 16:03:42 INFO - PROCESS | 1650 | |8;json-parse-financial;57;55;64;76;51;86;91;92;93;76 16:03:42 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;70;77;74;79;68;110;101;99;68;71 16:03:42 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;86;84;83;84;78;78;80;85;88;83 16:03:42 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;142;153;127;154;158;139;149;138;202;167 16:03:42 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;178;195;218;165;166;166;171;213;164;166 16:03:42 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;64;67;67;64;66;63;65;65;69 16:03:42 INFO - PROCESS | 1650 | __end_tp_report 16:03:42 INFO - PROCESS | 1650 | __start_cc_report 16:03:42 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,930 16:03:42 INFO - PROCESS | 1650 | __end_cc_report 16:03:42 INFO - PROCESS | 1650 | __startTimestamp1491433422010__endTimestamp 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:03:42 INFO - PROCESS | 1650 | Number of tests: 14 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.50 stddev:4.40 (3.7%) stddev-sans-first:0.87 16:03:42 INFO - PROCESS | 1650 | Values: 104.0 118.0 118.0 117.0 117.0 117.0 119.0 117.0 117.0 119.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:134.00 stddev:14.73 (11.0%) stddev-sans-first:14.59 16:03:42 INFO - PROCESS | 1650 | Values: 140.0 110.0 109.0 139.0 110.0 117.0 142.0 142.0 129.0 112.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:205.50 Median:196.50 stddev:26.87 (13.7%) stddev-sans-first:27.98 16:03:42 INFO - PROCESS | 1650 | Values: 191.0 230.0 274.0 201.0 193.0 197.0 193.0 193.0 187.0 196.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.80 Median:60.00 stddev:10.79 (18.0%) stddev-sans-first:9.22 16:03:42 INFO - PROCESS | 1650 | Values: 83.0 57.0 60.0 85.0 58.0 59.0 57.0 60.0 70.0 59.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:79.50 stddev:12.11 (15.2%) stddev-sans-first:12.84 16:03:42 INFO - PROCESS | 1650 | Values: 82.0 68.0 85.0 71.0 70.0 78.0 103.0 101.0 88.0 81.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:90.00 stddev:16.44 (18.3%) stddev-sans-first:17.22 16:03:42 INFO - PROCESS | 1650 | Values: 92.0 90.0 91.0 90.0 92.0 88.0 89.0 123.0 135.0 103.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:97.00 stddev:9.97 (10.3%) stddev-sans-first:9.45 16:03:42 INFO - PROCESS | 1650 | Values: 116.0 98.0 97.0 96.0 96.0 98.0 97.0 118.0 119.0 98.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:92.00 stddev:19.03 (20.7%) stddev-sans-first:15.41 16:03:42 INFO - PROCESS | 1650 | Values: 136.0 138.0 90.0 94.0 92.0 91.0 93.0 92.0 90.0 94.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:74.10 Median:81.00 stddev:16.35 (20.2%) stddev-sans-first:16.12 16:03:42 INFO - PROCESS | 1650 | Values: 57.0 55.0 64.0 76.0 51.0 86.0 91.0 92.0 93.0 76.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:72.50 stddev:15.59 (21.5%) stddev-sans-first:15.95 16:03:42 INFO - PROCESS | 1650 | Values: 70.0 77.0 74.0 79.0 68.0 110.0 101.0 99.0 68.0 71.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:84.00 stddev:3.31 (3.9%) stddev-sans-first:3.32 16:03:42 INFO - PROCESS | 1650 | Values: 86.0 84.0 83.0 84.0 78.0 78.0 80.0 85.0 88.0 83.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:153.50 stddev:20.70 (13.5%) stddev-sans-first:21.58 16:03:42 INFO - PROCESS | 1650 | Values: 142.0 153.0 127.0 154.0 158.0 139.0 149.0 138.0 202.0 167.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:174.50 stddev:20.85 (11.9%) stddev-sans-first:22.10 16:03:42 INFO - PROCESS | 1650 | Values: 178.0 195.0 218.0 165.0 166.0 166.0 171.0 213.0 164.0 166.0 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.78 (2.7%) stddev-sans-first:1.88 16:03:42 INFO - PROCESS | 1650 | Values: 66.0 64.0 67.0 67.0 64.0 66.0 63.0 65.0 65.0 69.0 16:03:42 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:03:42 INFO - PROCESS | 1650 | 16:03:42 INFO - TEST-INFO | 1650: exit 0 16:03:42 INFO - TEST-OK | kraken | took 59827ms 16:03:42 INFO - SUITE-END | took 1173s 16:03:43 INFO - Completed test suite (00:19:34) 16:03:43 INFO - javascript benchmark 16:03:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7429.891550918063, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.7666924980626, 3246.8051916885, 3548.2193917338177, 3610.6750392464673, 3631.219287853112, 5940.405959404057, 5941.732622032008, 6029.216201893753, 6049.243844519435, 6065.878682426349, 4815.855524334267, 6050.8184754457325, 6117.877642447148, 6150.784722534712, 6168.876622467548, 5369.40936496985, 5423.356936272081, 5441.809536666217, 5470.781168753265, 5477.397486276506, 4730.124926888537, 5472.042392581302, 5475.123980163175, 5479.232907392969, 5498.285222921015, 5282.286891269687, 5314.176302673091, 5478.150886612581, 5482.451754824526, 5518.530924871391, 5338.06583847827, 5372.811951581676, 5380.139177731564, 5432.837014889559, 5470.99999999996, 5321.813736519203, 5397.298351214317, 5411.107167317388, 5417.052015897241, 5445.428230035868, 5816.069428891399, 5978.641281523122, 6036.124761909542, 6103.847403814896, 6142.293636231846, 6232.501399887998, 6237.844053898643, 6240.375962403723, 6290.559660823744, 6349.746010159588, 6350.587211831216, 6363.077353783722, 6377.362263773632, 6378.968105159444, 6400.359964003563, 6104.023356262976, 6131.9269127902435, 6137.140800287963, 6137.693115344215, 6140.232470941132, 6313.652749098844, 6345.460635846005, 6400.7119679614525, 6412.102305677209, 6429.292777794439, 6253.6873156342, 6288.276848162428, 6316.936830631635, 6322.114903913456, 6337.683115844189, 6363.300036995926, 6369.5222858285815, 6371.872562548723, 6393.7762178324465, 6396.1045453636525, 6203.596766210182, 6218.657973811484, 6226.719797609118, 6253.78111766086, 6284.622922624657, 6192.628442293477, 6293.716782744787, 6296.275928268216, 6302.558820882494, 6309.242890853127, 5168.250603662448, 5176.042432150064, 5177.197534382177, 5191.506806853343, 5194.27280180775, 4564.315352697122, 4603.470600880942, 4614.907701845944, 4628.514006029386, 4651.790669419885, 5478.45215478449, 6112.41229444207, 6115.848865095035, 6135.04893764628, 6226.844328891723, 6389.0, 6417.294097649255, 6425.325340839238, 6426.903596446057, 6438.066480360415, 5042.747862606855, 5696.3164420269, 6108.205933228652, 6117.796956032686, 6168.0, 4619.9076018479445, 5342.679439233659, 5632.352279487829, 5667.659940403589, 5715.628484148517, 6505.967470162714, 6556.573822701509, 6589.374009469188, 6619.27188009309, 6668.899966500409, 6369.14016607752, 6401.903971440339, 6433.678316084271, 6433.935660643334, 6468.029795530708, 6752.0, 6770.830729231809, 6778.084958530732, 6778.254392016973, 6781.2879647638265, 5222.824864405478, 6145.324014358506, 6225.066240064027, 6277.3408792078, 6283.96858015707, 6382.36176382358, 6396.328385519453, 6405.3594640535575, 6408.391202835724, 6408.775692850728, 5817.941820581909, 5923.822285331447, 6300.401461861115, 6308.243010838729, 6311.27420346666, 5141.845744627667, 6234.15838861766, 6236.18929539157, 6253.3121356651645, 6259.436650701458, 6133.969330153321, 6248.094026366242, 6264.968675156595, 6271.874562508816, 6290.24517057956, 6247.0629405589525, 6254.4996400286955, 6254.843628909131, 6268.968655156695, 6284.685765711788, 4984.501549844987, 6145.67867908384, 6194.349593292639, 6222.28443728977, 6257.2491301044165], "value": 5865.338627600013, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.65829748324916, 537.2237117365408, 537.4840153452683, 545.6644163839237, 549.9532539734121, 41087.56193533227, 42957.0, 42986.355204671956, 43052.0, 43151.78424107879, 45598.77200614, 45990.7700461498, 46068.76965615176, 46169.538304616945, 46264.30603540949, 9729.610815567368, 9927.305088643798, 9955.402675839472, 9985.800283994316, 11500.654980350602, 11680.82478762815, 11797.528098876035, 11809.645710628694, 11816.58641947532, 11833.704157396049, 11806.291622502635, 11845.17083804134, 11871.584494542692, 11874.0, 11907.047436205126, 11635.301881887113, 11749.706257343549, 11801.17391782567, 11845.230060046155, 11858.466369013415, 11640.708982275512, 11741.941290293495, 11782.587609433629, 11814.11394145434, 11817.290962542274, 38242.0, 38591.80704096462, 38619.0, 38629.806850965564, 38767.80616096901, 4081.530623978251, 4084.7344922580232, 4099.0162361033135, 4172.749635021908, 4176.1230141670285, 28349.0, 28561.000364987332, 28566.143015709564, 28590.0, 31121.533177002362, 3281.5569898063695, 3458.4639380896, 3486.6861982421706, 3508.105433114565, 3551.8401671924826, 494927.0, 507176.0, 507725.0, 508499.0, 510193.44903275615, 59537.404625954056, 60172.0, 60514.0, 60540.78918421607, 60592.69703651542, 61735.0, 62660.06009909855, 62741.68629156825, 62863.0, 62886.685566571876, 15759.921200394154, 16841.410550630913, 17049.40327088546, 17049.7442538362, 17059.48821535356, 12027.27836329823, 12241.387930603434, 12969.740605187844, 13148.737025259441, 13239.66900827487, 18767.530811729543, 18844.0, 18972.0, 19046.0, 19054.90472547656, 6797.592144471348, 7449.813754656177, 8346.248837604644, 8453.619587118594, 8453.788655283544, 909.8134882349102, 922.6447817590142, 927.11460555171, 953.413650604873, 958.7938593202356, 29355.55966660502, 29544.704552954194, 31117.222069448446, 31689.0, 32001.679983200334, 907.7866701325183, 1114.0, 1139.7489957334365, 1143.2111842828588, 1251.6245126462024, 13107.344632768514, 16219.432319868747, 16306.510804675641, 16355.182240888145, 16731.079790611635, 599275.0, 612505.0, 651612.0, 659978.0, 662570.0, 58666.82666346734, 58959.82080358369, 64181.0, 64565.0, 64695.67652161709, 1468.3539242733164, 1470.2869108482378, 1498.4305963733711, 1512.7277090123664, 1516.5222954769213, 24085.37648659034, 30722.0, 30771.53842692406, 31413.0, 31419.214519636276, 50492.990140197726, 53046.0, 53291.6677083076, 53322.2001669983, 53546.46453535415, 441662.0, 499258.0, 500335.0, 500645.0, 501257.0, 23680.28959131229, 28003.159905202876, 28079.859600701864, 28450.57324140181, 28460.0, 49836.25245621246, 50420.74789626028, 50664.98670026505, 50922.490775093254, 51136.0, 32768.67231327656, 33463.089391942995, 33478.497822533165, 33858.32283354369, 34178.48732269068, 33302.33395332031, 33449.16377090592, 33956.0, 34017.48973765346, 34376.48435273423, 38612.034699132746, 39629.0, 39629.0, 39666.80166599149, 39819.00452488711, 33142.5028624566, 33147.34263286874, 33370.165745856546, 34153.316933661685, 34502.65497344994, 26091.0, 26137.6079358806, 26172.73827261703, 26397.20808375752, 26673.599896001186], "value": 20734.29021792536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.50010484378276, 393.80506649208627, 399.1507014558703, 402.6979765176117, 425.92878909542486, 15599.92200039001, 17168.9698618083, 20797.792022079775, 22254.109835606596, 22282.66576001359, 17626.735598966025, 21793.91030448479, 22363.664545031796, 22499.437514062156, 22685.54628907421, 5510.256115424427, 5845.181674565543, 5906.37983011784, 5908.379620139866, 5919.2009078774245, 5716.8284951451315, 5863.58954873159, 5911.586188966774, 5913.852153696171, 5936.554758393117, 5913.7338819752995, 5939.198208241897, 5940.227770389865, 5941.910871336933, 5945.37573554777, 5699.971500142494, 5799.623024503394, 5836.824895253149, 5903.645781253117, 5963.970180149093, 5187.48125187482, 5194.065068287707, 5201.45384734605, 5209.374875015023, 5215.687058776448, 20247.0, 21141.260055898125, 26145.607815882777, 26332.73667263322, 26489.337766555796, 2838.8722507487214, 2856.8285902845896, 2871.0, 2895.4788138135127, 2916.9854150729325, 15491.690166196726, 15674.451394201149, 15947.0, 15973.440929567525, 16345.91827040869, 1846.6675998320297, 1863.8602104842055, 1866.4027511196423, 1885.4437940807495, 1888.225827410755, 115345.0, 132554.0, 134259.0, 135496.0, 137503.5624109395, 9568.330216884891, 11722.824157637642, 11834.994025507756, 11857.940710296394, 11963.700907477383, 14833.961622686309, 14855.628609284855, 14858.702825943421, 14874.702505949821, 14888.553343399715, 7453.440991925628, 8678.56607169639, 8989.46063236208, 9090.13643703847, 9190.540472976325, 7470.663820128108, 9047.81904361909, 9081.68214112503, 9231.307651926132, 9285.164335209864, 6561.507886908405, 7239.348458638748, 7262.564246145248, 7275.781726548212, 7306.561606303639, 1996.301294546897, 2038.4699978005528, 2042.0708577597454, 2048.139781291861, 2048.5185981294385, 902.4224496322358, 1074.1872990234112, 1085.4464223246202, 1093.8796732359433, 1122.680036189682, 18616.534586635444, 22097.889510552344, 22636.320910372717, 22739.772602274097, 22826.42933926665, 960.1262850805733, 1081.4592703648175, 1108.6396921000708, 1111.5776005118003, 1118.82658187981, 10622.787544249071, 11438.599649012245, 11624.6512604622, 11661.125415593695, 11778.234414763014, 774765.0, 782869.0, 788479.0, 795126.0, 796893.0, 110110.0, 137448.0, 143988.56011439962, 149706.0, 151015.24492377468, 1057.677408390433, 1084.7505073833063, 1096.1942971915475, 1104.4974536585835, 1107.883672214422, 14586.270686465847, 17645.0, 19015.0, 19092.95567919202, 19143.23427062902, 59020.70489647524, 59837.401625983184, 60765.0, 60868.47828804315, 62717.0, 87821.0, 88425.55787221022, 89388.6591701138, 90603.0, 91074.54462727644, 6563.9343606563325, 7825.804354891174, 7888.68445262206, 8220.054693710299, 8311.792205194919, 9156.633734650806, 12178.57374991871, 13208.669783255495, 13210.207387556777, 13224.933875330562, 9778.951105244429, 11141.777164456827, 11369.31784092957, 11705.941470292593, 11727.237729547553, 10529.420586912025, 10621.990910863455, 10668.253222274676, 10750.623728169476, 11050.723731906766, 11445.370504621993, 11570.537178513101, 11754.941225293818, 11813.173077884465, 11891.0, 6648.7340506379205, 7125.002499650157, 8025.836253743291, 8339.166083391612, 8627.705844123431, 10393.220508461744, 11055.22613417053, 11070.114390848552, 11296.322220666787, 11391.145664075393], "value": 10180.83097977214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.5569417786307, 1468.6328417895527, 1496.5360738171169, 1499.9175045372508, 1505.5784380373493, 7676.117246516652, 7930.643121059552, 8212.055613604438, 8640.870386944202, 8649.437786543871, 8125.878111828328, 8424.747257582283, 8431.957840210805, 8531.872021919677, 8560.700375486858, 2371.1108334374653, 2412.19191570824, 2415.2995631266913, 2417.891194896225, 2433.4159801647565, 2069.3067822279554, 2365.680633114525, 2381.6546600742968, 2382.797462215714, 2406.867622280774, 2338.5673650374733, 2347.9413014674683, 2354.458474550854, 2378.9286321410386, 2384.2727967969763, 2347.8708671023087, 2349.788519033287, 2370.6207006878903, 2371.27676058802, 2379.464620460383, 2353.411647088228, 2380.297812145404, 2385.4751954569965, 2402.60357041088, 2412.8793560322088, 8457.0, 8474.406791524596, 8515.74452766418, 8520.318374530023, 8602.2688071514, 5169.948300516984, 5272.604554658377, 5314.0700377433795, 5321.255024296602, 5337.092694241988, 3028.6668466468673, 3414.6756058174433, 3529.94705079424, 3601.837917293728, 3622.2574372253625, 1058.5077938758436, 1263.993680031594, 1300.856905740368, 1308.3719814489004, 1318.24859829897, 8935.597898094602, 10787.67636970892, 10859.619913302997, 10948.671539853816, 10958.397288149228, 4388.341748737715, 4571.81712731487, 4599.402077729874, 4619.838305659286, 4663.463701674283, 8603.0, 8752.387332886638, 8782.824343513093, 8795.252403545643, 8808.691695790616, 5192.402873669501, 5206.271122042917, 5209.0, 5228.738563071907, 5244.606654500928, 4282.957170428318, 4350.58669426404, 4767.974885399586, 4843.370361853007, 4895.363602731693, 3950.1902110067367, 4011.959880401217, 4072.1855628874346, 4091.6112969267874, 4128.112455822013, 1292.0180662696418, 1310.344827586207, 1314.4413624209865, 1325.191633103806, 1329.2157627000117, 788.645109700637, 931.1154403316741, 936.6628013914985, 942.7313215733483, 952.4333021851987, 5500.697461639568, 5572.219889215513, 5687.146927960839, 5868.794592189338, 5884.0585506318785, 582.0541619867715, 591.3642833953431, 599.0235915457775, 602.7829981206762, 607.5079185859468, 3766.114962983697, 3863.5943225961432, 3902.434147048662, 3961.2473630010204, 3962.6829853611644, 8251.628676709563, 9719.076687714656, 9854.704358869245, 9899.851502227473, 9924.404535727735, 9768.07203315684, 9816.852747208797, 9831.31180817336, 9855.90144098564, 9867.753306167404, 7841.176676449005, 7891.368690504746, 7949.920500794918, 7953.880691789628, 7990.240927111915, 5421.674699518042, 5487.807926722546, 5530.55755539564, 5593.0, 5650.124230744241, 8747.16901894319, 8961.014288428138, 9030.819383612423, 9056.909430905871, 9241.630334786532, 9119.179273865384, 9193.310501712265, 9248.16766491019, 9288.164065234161, 9305.348625596143, 6766.729330826909, 6931.757388491378, 7131.536450130725, 7263.237360077327, 7390.371818395497, 7923.20767923203, 8048.356131509348, 8103.716369927024, 8130.39022073335, 8145.8370832584205, 6087.330393656783, 6958.582485050913, 7041.612711300928, 7051.1186101737285, 7093.3970612498515, 6893.965530172518, 6934.0, 6940.583564986117, 6972.337627925339, 6980.860382792417, 6391.840203994937, 6470.6441145737435, 6503.317151699003, 6520.217573890974, 6531.738730450728, 4229.344451610005, 4305.397244385851, 5019.974900125476, 5027.296178535081, 5097.566706829961, 5001.8499445016705, 5019.096562618618, 5166.844994650167, 5173.198154285941, 5189.792408303626], "value": 4394.520759648748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.731217496865, 328.453125545966, 366.82025807354387, 370.5719893522981, 382.3175631497777, 4300.741955482673, 4430.5126436092005, 5275.709835959021, 5364.927014597081, 5374.6775193488365, 4327.394164816928, 5130.71781052042, 5312.521873031426, 5338.572914166867, 5413.53984911282, 3899.454076429302, 3967.8412863485496, 4189.413482112506, 4234.661227101825, 4254.808533615979, 3515.7694806817535, 3880.592537783534, 3910.0, 4037.7792214282176, 4233.44965154531, 3993.4409182714444, 4048.6153815387493, 4051.97974010131, 4071.97964010181, 4073.9019405006447, 3709.332320182366, 4056.492938382702, 4068.084680946778, 4076.2051399977017, 4095.6279646318517, 3374.9156271093175, 3560.857565697369, 3568.822288644767, 3571.39286321326, 3589.0, 4993.975030124826, 5105.897882042375, 5195.610329225323, 5208.9739551302, 5298.496642818926, 3928.666063384616, 3950.644442000205, 4460.568989900512, 4726.5746082852365, 4734.526547345273, 5209.583233341324, 5488.012157811592, 5657.886842263173, 5679.148127780824, 5703.31560212773, 3416.521686963827, 3785.280796648628, 3856.2480316338324, 3912.6478616924614, 3913.0, 5918.496927761145, 5949.791757288474, 5965.164876917235, 5973.522118230575, 6007.969960150215, 3664.670179683841, 3942.172143849766, 3942.4230307876505, 3958.4853968984426, 3959.703022273341, 3640.162762564625, 3806.809659517013, 3834.7890866002635, 4018.738781979162, 4028.194361127786, 3745.831437585315, 4638.582527572535, 4658.133748988332, 4658.976705116453, 4679.251319788817, 4829.966977573695, 5024.824131155465, 5461.535769459561, 5605.859853503695, 5637.689927054052, 1110.6945589962825, 1258.993705031469, 1260.521002019227, 1289.348878816192, 1290.5483080921601, 743.7173873927981, 869.6347534035721, 884.4030279561271, 885.7608445719749, 901.9052999435096, 4962.454130045692, 5123.513266239701, 5159.871003224875, 5172.637915345889, 5183.45573714762, 4859.101066302675, 4988.084353782264, 5001.924971125436, 5009.947910938744, 5227.3465816772905, 4090.6727461802984, 4918.754062296871, 4997.450280469146, 5123.641345105807, 5245.606579506552, 2375.3349062262596, 2890.0, 2938.2213713365977, 2945.231482406574, 2945.5434407666844, 5435.918461223085, 5726.247214811697, 5811.9709401453565, 5855.736491857877, 5876.529877609781, 4822.359118865234, 5018.0, 5457.680485793522, 5707.287813655887, 5815.0, 5816.76732930678, 5850.882982340415, 5861.794837180678, 5867.442592953663, 5880.794172204038, 4775.856724298276, 5518.199861020049, 5569.44305569456, 5592.524635405874, 5647.322321321468, 4957.03337849116, 5005.448311023594, 5050.797968081236, 5097.7960881565805, 5134.717590532557, 4742.596879265301, 5299.4700529946695, 5749.7125143741805, 5778.313084415767, 5872.5301975842685, 3410.64188260239, 3548.5209496718644, 3756.2111956489443, 3770.86873937823, 3800.643600967418, 4161.9583804161575, 5013.523715247045, 5105.591552675852, 5568.693721845338, 5570.546261318009, 4627.791749371219, 5198.038362902875, 5473.31583552056, 5646.689432081275, 5670.383940576916, 4560.703554269095, 4708.540352490739, 5439.0, 5489.176623506506, 5591.748371323219, 5042.647014708935, 5353.357597088374, 5446.965076635426, 5535.782127931849, 5579.358373787067, 5466.125419932791, 5547.2511210986, 5603.2155498231095, 5614.69119198448, 5632.831015069554, 4903.53416425439, 5256.6320357574605, 5404.243405923095, 5567.387587365468, 5581.274434323512], "value": 4042.183695831894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.9890651640223, 780.3718007004361, 794.9046114466265, 809.9511133082657, 870.9651613935442, 15154.621134471643, 15760.605984850385, 15911.124888131148, 16068.0, 16261.430849920254, 13525.594232173025, 14004.859951400484, 14775.630609234775, 14935.551933441988, 14936.327865246063, 558.123745719221, 692.1935944624506, 859.5831021954347, 892.7054072156205, 892.959816808242, 750.2759836757527, 894.7047474333455, 905.7056456651582, 908.7955210077746, 909.3043821476542, 955.3217215776772, 958.7842735384518, 959.0122174160625, 959.4962644611564, 963.8939716631165, 914.8444764390036, 916.5921165081542, 930.1117432851611, 938.5729493080667, 960.7165886063628, 687.5530904911798, 702.9613371264578, 709.1915216653019, 716.9926253613629, 718.823888147402, 12944.741105177844, 14935.25323733809, 15384.846151538453, 15986.920065399714, 16238.18809059554, 13320.181025979115, 13895.58313250604, 14678.633034174125, 14832.406703731838, 14929.253537323199, 11702.063834893188, 11875.940620296844, 11888.346140962243, 11905.082044769784, 11906.821397679041, 3782.3191825471404, 3805.771653700787, 3810.085579460937, 3907.589703081164, 3918.216356728637, 97724.51137744266, 98412.50793746057, 100568.0, 100795.0, 101658.0, 11276.718082048015, 11500.884991149982, 11633.0, 11830.290182589073, 11916.94041529804, 21988.560228795333, 23563.882180588986, 23847.52304953891, 23868.761312386654, 23899.40251493692, 7547.207543207884, 8141.0, 8156.592170391456, 8161.714339998191, 8317.001959764866, 4358.694891357638, 4361.105973275471, 4409.096135292258, 4424.181526417623, 4430.867073987785, 3611.530501034849, 3661.3043521730788, 3690.944635830465, 3691.4647376130847, 3711.5175027246823, 655.6625629630353, 668.2782594797607, 672.700648211551, 682.8292926768308, 689.5414549324643, 593.3028691287719, 647.6146692717825, 664.6842749693857, 678.1353773938268, 699.5313140196081, 9602.471864047544, 9674.903250967542, 10068.90718674588, 10206.13247873939, 10221.386716797017, 655.8360409897525, 677.7898851356096, 692.7090621938697, 693.143967200507, 694.8888177891513, 4480.350349199413, 4606.147862645421, 4634.328022436728, 4682.2040253156365, 4709.458412282563, 95915.0, 104147.4792626032, 113321.4333928325, 113326.0, 113882.0, 74037.88943165856, 94209.0, 96668.0, 98250.52624210643, 99727.50136249272, 86015.0, 88628.0, 89282.0, 89940.0, 90938.0, 9054.275657947217, 9066.90933090687, 9075.455472671661, 9181.632734690806, 9192.264618830612, 56002.159967599706, 57554.71222644027, 57827.0, 58370.0, 58416.123758142814, 59273.407265928516, 70890.0, 73408.53182936205, 74467.62766186135, 77129.61435192788, 11475.885241147482, 11781.52873885035, 13452.394642240926, 13623.386947587183, 13726.245056521988, 13212.471501139848, 13738.931305343409, 14741.410343586136, 15069.773953390488, 15547.922260389078, 14294.571162865132, 14310.069845460011, 14378.856211437751, 14582.85417145815, 14806.851931480547, 11952.820707689218, 14252.928735356672, 14313.642158945693, 14486.348114335091, 14547.85452145465, 13029.0, 13088.672783180496, 13890.325403771329, 14085.929570352082, 14101.576952691436, 9482.952585237306, 9996.300258982092, 10121.596419246549, 10275.126614237874, 10649.574017039542, 8622.568871556523, 9146.673732308911, 10332.225083118947, 10364.481775911325, 10417.374957502574], "value": 7648.069370651093, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 118.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 119.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 109.0, 139.0, 110.0, 117.0, 142.0, 142.0, 129.0, 112.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 230.0, 274.0, 201.0, 193.0, 197.0, 193.0, 193.0, 187.0, 196.0], "value": 205.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 60.0, 85.0, 58.0, 59.0, 57.0, 60.0, 70.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 68.0, 85.0, 71.0, 70.0, 78.0, 103.0, 101.0, 88.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 90.0, 92.0, 88.0, 89.0, 123.0, 135.0, 103.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 98.0, 97.0, 96.0, 96.0, 98.0, 97.0, 118.0, 119.0, 98.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 90.0, 94.0, 92.0, 91.0, 93.0, 92.0, 90.0, 94.0], "value": 101.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 64.0, 76.0, 51.0, 86.0, 91.0, 92.0, 93.0, 76.0], "value": 74.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 77.0, 74.0, 79.0, 68.0, 110.0, 101.0, 99.0, 68.0, 71.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 84.0, 78.0, 78.0, 80.0, 85.0, 88.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 153.0, 127.0, 154.0, 158.0, 139.0, 149.0, 138.0, 202.0, 167.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 195.0, 218.0, 165.0, 166.0, 166.0, 171.0, 213.0, 164.0, 166.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 67.0, 67.0, 64.0, 66.0, 63.0, 65.0, 65.0, 69.0], "value": 65.6, "unit": "score"}]}]} 16:03:43 INFO - Return code: 0 16:03:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:03:43 ERROR - # TBPL SUCCESS # 16:03:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:03:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:03:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:03:43 INFO - 2017-04-05 16:03:43.344 screenresolution[1655:10420] starting screenresolution argv=screenresolution get 16:03:43 INFO - 2017-04-05 16:03:43.347 screenresolution[1655:10420] Display 0: 1600x1200x32@60 16:03:43 INFO - 2017-04-05 16:03:43.352 screenresolution[1656:10423] starting screenresolution argv=screenresolution list 16:03:43 INFO - Available Modes on Display 0 16:03:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:03:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:03:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:03:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:03:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:03:43 INFO - Intel Iris: 16:03:43 INFO - Chipset Model: Intel Iris 16:03:43 INFO - Type: GPU 16:03:43 INFO - Bus: Built-In 16:03:43 INFO - VRAM (Dynamic, Max): 1536 MB 16:03:43 INFO - Vendor: Intel (0x8086) 16:03:43 INFO - Device ID: 0x0a2e 16:03:43 INFO - Revision ID: 0x0009 16:03:43 INFO - Displays: 16:03:43 INFO - Display: 16:03:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:03:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:03:43 INFO - Display Serial Number: 1600x1200 60 16:03:43 INFO - Main Display: Yes 16:03:43 INFO - Mirror: Off 16:03:43 INFO - Online: Yes 16:03:43 INFO - Rotation: Supported 16:03:43 INFO - Return code: 0 16:03:43 INFO - Running post-action listener: _resource_record_post_action 16:03:43 INFO - [mozharness: 2017-04-05 23:03:43.587109Z] Finished run-tests step (success) 16:03:43 INFO - Running post-run listener: _resource_record_post_run 16:03:43 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38610944; Write bytes: 424736768; Read time: 392; Write time: 1512 16:03:43 INFO - TinderboxPrint: CPU usage
54.4% 16:03:43 INFO - TinderboxPrint: I/O read bytes / time
38,610,944 / 392 16:03:43 INFO - TinderboxPrint: I/O write bytes / time
424,736,768 / 1,512 16:03:43 INFO - TinderboxPrint: CPU idle
2,173.6 (45.6%) 16:03:43 INFO - TinderboxPrint: CPU system
959.5 (20.1%) 16:03:43 INFO - TinderboxPrint: CPU user
1,628.6 (34.2%) 16:03:43 INFO - TinderboxPrint: Swap in / out
160,628,736 / 0 16:03:43 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 117318144; Write bytes: 114472960; Read time: 10771; Write time: 273 16:03:43 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36583424; Write bytes: 299307008; Read time: 370; Write time: 1204 16:03:44 INFO - Running post-run listener: _upload_blobber_files 16:03:44 INFO - Blob upload gear active. 16:03:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:03:44 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 16:03:44 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:03:44 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:03:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:45 INFO - (blobuploader) - INFO - Done attempting. 16:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:46 INFO - (blobuploader) - INFO - Done attempting. 16:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:03:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:47 INFO - (blobuploader) - INFO - Done attempting. 16:03:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:03:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:48 INFO - (blobuploader) - INFO - Done attempting. 16:03:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:48 INFO - Return code: 0 16:03:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00add47cf27671fd73125ded8794fc46968d48d84aecc253f14ff0535a5124e7b59b954270651d596363a3e6c07c67cf04041309005a0d99a3d30f98ddcdfa7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9acd1cb970cfe357c1fd100525cb8b3e77abca563846b26e2d563d6cbce23b3e195be5964846a3a6a997df58d02b57364b1d23a72c372825cc952ec2870afb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b04a8aefccbc406fba0e839f6d1427abd6648acea1252b7361f5c13fe1eedfe560f6895fcd81cba6b2ed74a7c379e6a1377bedd6f0390b0fd37eb68a7cb8b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27c3bff5ed236361fb9b3bb5c25516af7f801bb0bc2d50863f4fffb871ea6a882e19e36b0075d71992e3e8d3eaba7157c36008a940832d7c811481489710394"} 16:03:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:48 INFO - Contents: 16:03:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00add47cf27671fd73125ded8794fc46968d48d84aecc253f14ff0535a5124e7b59b954270651d596363a3e6c07c67cf04041309005a0d99a3d30f98ddcdfa7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9acd1cb970cfe357c1fd100525cb8b3e77abca563846b26e2d563d6cbce23b3e195be5964846a3a6a997df58d02b57364b1d23a72c372825cc952ec2870afb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b04a8aefccbc406fba0e839f6d1427abd6648acea1252b7361f5c13fe1eedfe560f6895fcd81cba6b2ed74a7c379e6a1377bedd6f0390b0fd37eb68a7cb8b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27c3bff5ed236361fb9b3bb5c25516af7f801bb0bc2d50863f4fffb871ea6a882e19e36b0075d71992e3e8d3eaba7157c36008a940832d7c811481489710394"} 16:03:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:48 INFO - Copying logs to upload dir... 16:03:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.847297 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-05 16:03:48.998909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:49.002678) ========= 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.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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/Mozilla-Beta/sha512/00add47cf27671fd73125ded8794fc46968d48d84aecc253f14ff0535a5124e7b59b954270651d596363a3e6c07c67cf04041309005a0d99a3d30f98ddcdfa7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9acd1cb970cfe357c1fd100525cb8b3e77abca563846b26e2d563d6cbce23b3e195be5964846a3a6a997df58d02b57364b1d23a72c372825cc952ec2870afb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b04a8aefccbc406fba0e839f6d1427abd6648acea1252b7361f5c13fe1eedfe560f6895fcd81cba6b2ed74a7c379e6a1377bedd6f0390b0fd37eb68a7cb8b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27c3bff5ed236361fb9b3bb5c25516af7f801bb0bc2d50863f4fffb871ea6a882e19e36b0075d71992e3e8d3eaba7157c36008a940832d7c811481489710394"} build_url:https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011034 build_url: 'https://queue.taskcluster.net/v1/task/A_8Vm6DISB26Wae52EqG6A/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/00add47cf27671fd73125ded8794fc46968d48d84aecc253f14ff0535a5124e7b59b954270651d596363a3e6c07c67cf04041309005a0d99a3d30f98ddcdfa7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f9acd1cb970cfe357c1fd100525cb8b3e77abca563846b26e2d563d6cbce23b3e195be5964846a3a6a997df58d02b57364b1d23a72c372825cc952ec2870afb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0b04a8aefccbc406fba0e839f6d1427abd6648acea1252b7361f5c13fe1eedfe560f6895fcd81cba6b2ed74a7c379e6a1377bedd6f0390b0fd37eb68a7cb8b84", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b27c3bff5ed236361fb9b3bb5c25516af7f801bb0bc2d50863f4fffb871ea6a882e19e36b0075d71992e3e8d3eaba7157c36008a940832d7c811481489710394"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:49.046638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:49.047459) ========= 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.PttzprIXJX/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.Zkjz7XexP5/Listeners TMPDIR=/var/folders/11/9f8m5vpx6cs7tqgxgrkjczwm00000w/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.004734 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 16:03:49.101023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 16:03:49.101754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 16:03:49.102588) ========= ========= Total master_lag: 0.22 =========