builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0097 starttime: 1493870734.44 results: success (0) buildid: 20170503192620 builduid: b9cb30f053134188a1eb09bae405a3f1 revision: e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.436311) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.436797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.437086) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.463991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.464293) ========= 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.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-05-03 21:05:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 138M=0s 2017-05-03 21:05:34 (138 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177958 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.670434) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.671217) ========= 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.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.028725 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:34.722307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 21:05:34.722711) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 --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 e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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-05-03 21:05:34,825 truncating revision to first 12 chars 2017-05-03 21:05:34,825 Setting DEBUG logging. 2017-05-03 21:05:34,825 attempt 1/10 2017-05-03 21:05:34,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e664fb8bf2fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 21:05:36,001 unpacking tar archive at: mozilla-beta-e664fb8bf2fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.445307 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 21:05:36.198982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:36.199355) ========= script_repo_revision: e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:36.199846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:36.200147) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 21:05:36.220750) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-03 21:05:36.221086) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:05:36 INFO - MultiFileLogger online at 20170503 21:05:36 in /builds/slave/test 21:05:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:05:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:05:36 INFO - {'append_to_log': False, 21:05:36 INFO - 'base_work_dir': '/builds/slave/test', 21:05:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:05:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:05:36 INFO - 'branch': 'Mozilla-Beta', 21:05:36 INFO - 'buildbot_json_path': 'buildprops.json', 21:05:36 INFO - 'config_files': ('talos/mac_config.py',), 21:05:36 INFO - 'default_actions': ('clobber', 21:05:36 INFO - 'read-buildbot-config', 21:05:36 INFO - 'download-and-extract', 21:05:36 INFO - 'populate-webroot', 21:05:36 INFO - 'create-virtualenv', 21:05:36 INFO - 'install', 21:05:36 INFO - 'run-tests'), 21:05:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:05:36 INFO - 'download_minidump_stackwalk': True, 21:05:36 INFO - 'download_symbols': 'ondemand', 21:05:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:05:36 INFO - 'tooltool.py': '/tools/tooltool.py', 21:05:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:05:36 INFO - '/tools/misc-python/virtualenv.py')}, 21:05:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:05:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:05:36 INFO - 'gecko_profile': False, 21:05:36 INFO - 'gecko_profile_interval': 0, 21:05:36 INFO - 'installer_path': 'installer.exe', 21:05:36 INFO - 'log_level': 'info', 21:05:36 INFO - 'log_name': 'talos', 21:05:36 INFO - 'log_to_console': True, 21:05:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:05:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:05:36 INFO - 'opt_config_files': (), 21:05:36 INFO - 'pip_index': False, 21:05:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:05:36 INFO - 'cmd': ('bash', 21:05:36 INFO - '-c', 21:05:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:05:36 INFO - 'enabled': True, 21:05:36 INFO - 'halt_on_failure': False, 21:05:36 INFO - 'name': 'check_screen_resolution'},), 21:05:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:05:36 INFO - 'cmd': ('bash', 21:05:36 INFO - '-c', 21:05:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:05:36 INFO - 'enabled': True, 21:05:36 INFO - 'halt_on_failure': False, 21:05:36 INFO - 'name': 'check_screen_resolution'},), 21:05:36 INFO - 'run_cmd_checks_enabled': True, 21:05:36 INFO - 'suite': 'dromaeojs', 21:05:36 INFO - 'system_bits': '32', 21:05:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:05:36 INFO - 'title': 't-yosemite-r7-0097', 21:05:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:05:36 INFO - 'use_talos_json': True, 21:05:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:05:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:05:36 INFO - 'work_dir': 'build'} 21:05:36 INFO - [mozharness: 2017-05-04 04:05:36.435044Z] Running clobber step. 21:05:36 INFO - Running pre-action listener: _resource_record_pre_action 21:05:36 INFO - Running main action method: clobber 21:05:36 INFO - rmtree: /builds/slave/test/build 21:05:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:05:39 INFO - Running post-action listener: _resource_record_post_action 21:05:39 INFO - [mozharness: 2017-05-04 04:05:39.136957Z] Finished clobber step (success) 21:05:39 INFO - [mozharness: 2017-05-04 04:05:39.137129Z] Running read-buildbot-config step. 21:05:39 INFO - Running pre-action listener: _resource_record_pre_action 21:05:39 INFO - Running main action method: read_buildbot_config 21:05:39 INFO - Using buildbot properties: 21:05:39 INFO - { 21:05:39 INFO - "project": "", 21:05:39 INFO - "product": "firefox", 21:05:39 INFO - "script_repo_revision": "production", 21:05:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:05:39 INFO - "repository": "", 21:05:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:05:39 INFO - "buildid": "20170503192620", 21:05:39 INFO - "pgo_build": "False", 21:05:39 INFO - "basedir": "/builds/slave/test", 21:05:39 INFO - "buildnumber": 7, 21:05:39 INFO - "slavename": "t-yosemite-r7-0097", 21:05:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 21:05:39 INFO - "platform": "yosemite_r7", 21:05:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:05:39 INFO - "branch": "mozilla-beta", 21:05:39 INFO - "repo_path": "releases/mozilla-beta", 21:05:39 INFO - "revision": "e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739", 21:05:39 INFO - "stage_platform": "macosx64", 21:05:39 INFO - "builduid": "b9cb30f053134188a1eb09bae405a3f1", 21:05:39 INFO - "slavebuilddir": "test" 21:05:39 INFO - } 21:05:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 21:05:39 INFO - Running post-action listener: _resource_record_post_action 21:05:39 INFO - [mozharness: 2017-05-04 04:05:39.140662Z] Finished read-buildbot-config step (success) 21:05:39 INFO - [mozharness: 2017-05-04 04:05:39.140762Z] Running download-and-extract step. 21:05:39 INFO - Running pre-action listener: _resource_record_pre_action 21:05:39 INFO - Running main action method: download_and_extract 21:05:39 INFO - mkdir: /builds/slave/test/build/tests 21:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:39 INFO - trying https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 21:05:39 INFO - Downloading https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 21:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 21:05:40 INFO - Downloaded 1287 bytes. 21:05:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 21:05:40 INFO - Using the following test package requirements: 21:05:40 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 21:05:40 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 21:05:40 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 21:05:40 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 21:05:40 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:05:40 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 21:05:40 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 21:05:40 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 21:05:40 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 21:05:40 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 21:05:40 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 21:05:40 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 21:05:40 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 21:05:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 21:05:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 21:05:40 INFO - Fetch https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 21:05:42 INFO - Expected file size: 51226513 21:05:42 INFO - Obtained file size: 51226513 21:05:58 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:05:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 21:05:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 21:05:58 INFO - Fetch https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 21:05:59 INFO - Expected file size: 51226513 21:05:59 INFO - Obtained file size: 51226513 21:06:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 21:06:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 21:06:15 INFO - Fetch https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 21:06:16 INFO - Expected file size: 14404449 21:06:16 INFO - Obtained file size: 14404449 21:06: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')]} 21:06:16 INFO - trying https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 21:06:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 21:06:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 21:06:18 INFO - Downloaded 59547296 bytes. 21:06:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 21:06:18 INFO - mkdir: /builds/slave/test/properties 21:06:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:06:18 INFO - Writing to file /builds/slave/test/properties/build_url 21:06:18 INFO - Contents: 21:06:18 INFO - build_url:https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 21:06:19 INFO - Running post-action listener: _resource_record_post_action 21:06:19 INFO - Running post-action listener: set_extra_try_arguments 21:06:19 INFO - [mozharness: 2017-05-04 04:06:19.086760Z] Finished download-and-extract step (success) 21:06:19 INFO - [mozharness: 2017-05-04 04:06:19.086911Z] Running populate-webroot step. 21:06:19 INFO - Running pre-action listener: _resource_record_pre_action 21:06:19 INFO - Running main action method: populate_webroot 21:06:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:06:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:06:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:06:19 INFO - '--tppagecycles', 21:06:19 INFO - '7'], 21:06:19 INFO - 'tests': ['tsvgm']}}, 21:06:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:06:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:06:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:06:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:06:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['damp', 'tps']}, 21:06:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'tests': ['damp', 'tps']}, 21:06:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['dromaeo_dom']}, 21:06:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:06:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['basic_compositor_video']}, 21:06:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:06:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'other-e10s': {'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['a11yr', 21:06:19 INFO - 'ts_paint', 21:06:19 INFO - 'tpaint', 21:06:19 INFO - 'sessionrestore', 21:06:19 INFO - 'sessionrestore_no_auto_restore', 21:06:19 INFO - 'tabpaint']}, 21:06:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['tsvgx', 21:06:19 INFO - 'tsvgr_opacity', 21:06:19 INFO - 'tart', 21:06:19 INFO - 'tscrollx', 21:06:19 INFO - 'cart', 21:06:19 INFO - 'tsvg_static']}, 21:06:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:06:19 INFO - 'tsvgr_opacity', 21:06:19 INFO - 'tart', 21:06:19 INFO - 'tscrollx', 21:06:19 INFO - 'cart', 21:06:19 INFO - 'tsvg_static']}, 21:06:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'talos_options': ['--disable-e10s'], 21:06:19 INFO - 'tests': ['tp5o']}, 21:06:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:06:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'talos_options': ['--disable-e10s', 21:06:19 INFO - '--xperf_path', 21:06:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:19 INFO - 'tests': ['tp5n']}, 21:06:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:06:19 INFO - 'talos_options': ['--xperf_path', 21:06:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:19 INFO - 'tests': ['tp5n']}}, 21:06:19 INFO - 'talos.zip': {'path': '', 21:06:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:06:19 INFO - Running post-action listener: _resource_record_post_action 21:06:19 INFO - [mozharness: 2017-05-04 04:06:19.104989Z] Finished populate-webroot step (success) 21:06:19 INFO - [mozharness: 2017-05-04 04:06:19.105126Z] Running create-virtualenv step. 21:06:19 INFO - Running pre-action listener: _resource_record_pre_action 21:06:19 INFO - Running main action method: create_virtualenv 21:06:19 INFO - Creating virtualenv /builds/slave/test/build/venv 21:06:19 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 21:06:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:06:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:06:19 INFO - Using real prefix '/tools/python27' 21:06:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:06:19 INFO - Installing distribute.............................................................................................................................................................................................done. 21:06:22 INFO - Installing pip.................done. 21:06:22 INFO - Return code: 0 21:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:06:23 INFO - Reading from file tmpfile_stdout 21:06:23 INFO - Output received: 21:06:23 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) 21:06:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:06:23 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')]} 21:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:23 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')]} 21:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:23 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:23 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 21:06:23 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 21:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:23 INFO - 'HOME': '/Users/cltbld', 21:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:23 INFO - 'LOGNAME': 'cltbld', 21:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:23 INFO - 'MOZ_NO_REMOTE': '1', 21:06:23 INFO - 'NO_EM_RESTART': '1', 21:06:23 INFO - 'PAGER': '/bin/cat', 21:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:23 INFO - 'PWD': '/builds/slave/test', 21:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:23 INFO - 'SHELL': '/bin/bash', 21:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:23 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:23 INFO - 'USER': 'cltbld', 21:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:23 INFO - 'XPC_FLAGS': '0x0', 21:06:23 INFO - 'XPC_SERVICE_NAME': '0', 21:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:23 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 21:06:23 INFO - Cleaning up... 21:06:23 INFO - Return code: 0 21:06:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:06:23 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')]} 21:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:23 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')]} 21:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:23 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:23 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 21:06:23 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 21:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:23 INFO - 'HOME': '/Users/cltbld', 21:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:23 INFO - 'LOGNAME': 'cltbld', 21:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:23 INFO - 'MOZ_NO_REMOTE': '1', 21:06:23 INFO - 'NO_EM_RESTART': '1', 21:06:23 INFO - 'PAGER': '/bin/cat', 21:06:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:23 INFO - 'PWD': '/builds/slave/test', 21:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:23 INFO - 'SHELL': '/bin/bash', 21:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:23 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:23 INFO - 'USER': 'cltbld', 21:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:23 INFO - 'XPC_FLAGS': '0x0', 21:06:23 INFO - 'XPC_SERVICE_NAME': '0', 21:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:23 INFO - Downloading/unpacking psutil>=3.1.1 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:25 INFO - Installing collected packages: psutil 21:06:25 INFO - Running setup.py install for psutil 21:06:25 INFO - building 'psutil._psutil_osx' extension 21:06:25 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 21:06: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:06: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:06:26 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 21:06:26 INFO - building 'psutil._psutil_posix' extension 21:06:26 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 21:06:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:06:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:06:26 INFO - ^ 21:06:26 INFO - 1 warning generated. 21:06:26 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 21:06:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:27 INFO - Successfully installed psutil 21:06:27 INFO - Cleaning up... 21:06:27 INFO - Return code: 0 21:06:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:06: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')]} 21:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06: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')]} 21:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06: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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06: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 21:06: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 21:06:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:27 INFO - 'HOME': '/Users/cltbld', 21:06:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:27 INFO - 'LOGNAME': 'cltbld', 21:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:27 INFO - 'MOZ_NO_REMOTE': '1', 21:06:27 INFO - 'NO_EM_RESTART': '1', 21:06:27 INFO - 'PAGER': '/bin/cat', 21:06:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:27 INFO - 'PWD': '/builds/slave/test', 21:06:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:27 INFO - 'SHELL': '/bin/bash', 21:06:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:27 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:27 INFO - 'USER': 'cltbld', 21:06:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:27 INFO - 'XPC_FLAGS': '0x0', 21:06:27 INFO - 'XPC_SERVICE_NAME': '0', 21:06:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:06:27 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 21:06:27 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 21:06:27 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 21:06:27 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 21:06:27 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 21:06:27 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 21:06:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:06:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:06:28 INFO - Installing collected packages: mozsystemmonitor 21:06:28 INFO - Running setup.py install for mozsystemmonitor 21:06:28 INFO - Successfully installed mozsystemmonitor 21:06:28 INFO - Cleaning up... 21:06:28 INFO - Return code: 0 21:06:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:29 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')]} 21:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:29 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:29 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 21:06:29 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 21:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:29 INFO - 'HOME': '/Users/cltbld', 21:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:29 INFO - 'LOGNAME': 'cltbld', 21:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:29 INFO - 'MOZ_NO_REMOTE': '1', 21:06:29 INFO - 'NO_EM_RESTART': '1', 21:06:29 INFO - 'PAGER': '/bin/cat', 21:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:29 INFO - 'PWD': '/builds/slave/test', 21:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:29 INFO - 'SHELL': '/bin/bash', 21:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:29 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:29 INFO - 'USER': 'cltbld', 21:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:29 INFO - 'XPC_FLAGS': '0x0', 21:06:29 INFO - 'XPC_SERVICE_NAME': '0', 21:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:30 INFO - Downloading/unpacking jsonschema==2.5.1 21:06:30 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 21:06:30 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 21:06:30 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 21:06:30 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 21:06:30 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 21:06:30 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 21:06:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:06:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06:31 INFO - Downloading functools32-3.2.3-2.tar.gz 21:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:06:32 INFO - warning: no files found matching '*.txt' 21:06:32 INFO - no previously-included directories found matching 'build' 21:06:32 INFO - no previously-included directories found matching 'dist' 21:06:32 INFO - no previously-included directories found matching '.git*' 21:06:32 INFO - Installing collected packages: jsonschema, functools32 21:06:32 INFO - Running setup.py install for functools32 21:06:32 INFO - warning: no files found matching '*.txt' 21:06:32 INFO - no previously-included directories found matching 'build' 21:06:32 INFO - no previously-included directories found matching 'dist' 21:06:32 INFO - no previously-included directories found matching '.git*' 21:06:32 INFO - Successfully installed jsonschema functools32 21:06:32 INFO - Cleaning up... 21:06:32 INFO - Return code: 0 21:06:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:32 INFO - 'HOME': '/Users/cltbld', 21:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:32 INFO - 'LOGNAME': 'cltbld', 21:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:32 INFO - 'MOZ_NO_REMOTE': '1', 21:06:32 INFO - 'NO_EM_RESTART': '1', 21:06:32 INFO - 'PAGER': '/bin/cat', 21:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:32 INFO - 'PWD': '/builds/slave/test', 21:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:32 INFO - 'SHELL': '/bin/bash', 21:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:32 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:32 INFO - 'USER': 'cltbld', 21:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:32 INFO - 'XPC_FLAGS': '0x0', 21:06:32 INFO - 'XPC_SERVICE_NAME': '0', 21:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:06:32 INFO - Cleaning up... 21:06:32 INFO - Return code: 0 21:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:32 INFO - 'HOME': '/Users/cltbld', 21:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:32 INFO - 'LOGNAME': 'cltbld', 21:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:32 INFO - 'MOZ_NO_REMOTE': '1', 21:06:32 INFO - 'NO_EM_RESTART': '1', 21:06:32 INFO - 'PAGER': '/bin/cat', 21:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:32 INFO - 'PWD': '/builds/slave/test', 21:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:32 INFO - 'SHELL': '/bin/bash', 21:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:32 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:32 INFO - 'USER': 'cltbld', 21:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:32 INFO - 'XPC_FLAGS': '0x0', 21:06:32 INFO - 'XPC_SERVICE_NAME': '0', 21:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:32 INFO - Downloading/unpacking blobuploader==1.2.4 21:06:32 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 21:06:32 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 21:06:32 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 21:06:32 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 21:06:32 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 21:06:32 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 21:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 21:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:06:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:06:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06: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 21:06:34 INFO - Downloading docopt-0.6.1.tar.gz 21:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:06:35 INFO - Installing collected packages: blobuploader, requests, docopt 21:06:35 INFO - Running setup.py install for blobuploader 21:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:06:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:06:35 INFO - Running setup.py install for requests 21:06:35 INFO - Running setup.py install for docopt 21:06:35 INFO - Successfully installed blobuploader requests docopt 21:06:35 INFO - Cleaning up... 21:06:35 INFO - Return code: 0 21:06:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06: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')]} 21:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06: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')]} 21:06:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:35 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:35 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 21:06:35 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 21:06:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:35 INFO - 'HOME': '/Users/cltbld', 21:06:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:35 INFO - 'LOGNAME': 'cltbld', 21:06:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:35 INFO - 'MOZ_NO_REMOTE': '1', 21:06:35 INFO - 'NO_EM_RESTART': '1', 21:06:35 INFO - 'PAGER': '/bin/cat', 21:06:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:35 INFO - 'PWD': '/builds/slave/test', 21:06:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:35 INFO - 'SHELL': '/bin/bash', 21:06:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:35 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:35 INFO - 'USER': 'cltbld', 21:06:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:35 INFO - 'XPC_FLAGS': '0x0', 21:06:35 INFO - 'XPC_SERVICE_NAME': '0', 21:06:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-lsF5Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1sQO8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-pnkyEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Remdd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-5ecZvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-uec5pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-zakuUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:36 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-RtQhK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-G1Fp3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-x50aGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1VRsTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-vXuNou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-jyMN2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-guXDkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-zReqKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Bub6Bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:37 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-Xjkih_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:06:37 INFO - Running setup.py install for manifestparser 21:06:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:06:38 INFO - Running setup.py install for mozcrash 21:06:38 INFO - Running setup.py install for mozdebug 21:06:38 INFO - Running setup.py install for mozdevice 21:06:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:06:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:06:38 INFO - Running setup.py install for mozfile 21:06:38 INFO - Running setup.py install for mozhttpd 21:06:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:06:38 INFO - Running setup.py install for mozinfo 21:06:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:06:38 INFO - Running setup.py install for mozInstall 21:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Running setup.py install for mozleak 21:06:39 INFO - Running setup.py install for mozlog 21:06:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Running setup.py install for moznetwork 21:06:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Running setup.py install for mozprocess 21:06:39 INFO - Running setup.py install for mozprofile 21:06:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:06:39 INFO - Running setup.py install for mozrunner 21:06:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:06:40 INFO - Running setup.py install for mozscreenshot 21:06:40 INFO - Running setup.py install for moztest 21:06:40 INFO - Running setup.py install for mozversion 21:06:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:06:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:06:40 INFO - Cleaning up... 21:06:40 INFO - Return code: 0 21:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:40 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:40 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 21:06:40 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 21:06:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:40 INFO - 'HOME': '/Users/cltbld', 21:06:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:40 INFO - 'LOGNAME': 'cltbld', 21:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:40 INFO - 'MOZ_NO_REMOTE': '1', 21:06:40 INFO - 'NO_EM_RESTART': '1', 21:06:40 INFO - 'PAGER': '/bin/cat', 21:06:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:40 INFO - 'PWD': '/builds/slave/test', 21:06:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:40 INFO - 'SHELL': '/bin/bash', 21:06:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:40 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:40 INFO - 'USER': 'cltbld', 21:06:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:40 INFO - 'XPC_FLAGS': '0x0', 21:06:40 INFO - 'XPC_SERVICE_NAME': '0', 21:06:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:40 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ez4d9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:40 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)) 21:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:40 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-VrQtT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-SP4VFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-1jRxV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-ibbeHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-qbwufn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-6uqMFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-H4HY0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-OtM9UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-9WbKq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-wzq5hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:41 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)) 21:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:41 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-k2_d3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:42 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-SK81JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:42 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)) 21:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:42 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-b_ne8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:42 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)) 21:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:42 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-MkWyd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:42 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)) 21:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:42 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-f_dRBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:42 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)) 21:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:42 INFO - Running setup.py (path:/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/pip-qSEY3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:42 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)) 21:06:42 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)) 21:06:42 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)) 21:06:42 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)) 21:06:42 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)) 21:06:42 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)) 21:06:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:06:42 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 21:06:42 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 21:06:42 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 21:06:42 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 21:06:42 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 21:06:42 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 21:06:43 INFO - Downloading blessings-1.6.tar.gz 21:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:06:44 INFO - Installing collected packages: blessings 21:06:44 INFO - Running setup.py install for blessings 21:06:44 INFO - Successfully installed blessings 21:06:44 INFO - Cleaning up... 21:06:44 INFO - Return code: 0 21:06:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:06:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:44 INFO - Reading from file tmpfile_stdout 21:06:44 INFO - Current package versions: 21:06:44 INFO - blessings == 1.6 21:06:44 INFO - blobuploader == 1.2.4 21:06:44 INFO - docopt == 0.6.1 21:06:44 INFO - functools32 == 3.2.3-2 21:06:44 INFO - jsonschema == 2.5.1 21:06:44 INFO - manifestparser == 1.1 21:06:44 INFO - mozInstall == 1.12 21:06:44 INFO - mozcrash == 1.0 21:06:44 INFO - mozdebug == 0.1 21:06:44 INFO - mozdevice == 0.49 21:06:44 INFO - mozfile == 1.2 21:06:44 INFO - mozhttpd == 0.7 21:06:44 INFO - mozinfo == 0.9 21:06:44 INFO - mozleak == 0.1 21:06:44 INFO - mozlog == 3.4 21:06:44 INFO - moznetwork == 0.27 21:06:44 INFO - mozprocess == 0.25 21:06:44 INFO - mozprofile == 0.28 21:06:44 INFO - mozrunner == 6.13 21:06:44 INFO - mozscreenshot == 0.1 21:06:44 INFO - mozsystemmonitor == 0.3 21:06:44 INFO - moztest == 0.8 21:06:44 INFO - mozversion == 1.4 21:06:44 INFO - psutil == 3.1.1 21:06:44 INFO - requests == 1.2.3 21:06:44 INFO - wsgiref == 0.1.2 21:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:44 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:44 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 21:06:44 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 21:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:44 INFO - 'HOME': '/Users/cltbld', 21:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:44 INFO - 'LOGNAME': 'cltbld', 21:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:44 INFO - 'MOZ_NO_REMOTE': '1', 21:06:44 INFO - 'NO_EM_RESTART': '1', 21:06:44 INFO - 'PAGER': '/bin/cat', 21:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:44 INFO - 'PWD': '/builds/slave/test', 21:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:44 INFO - 'SHELL': '/bin/bash', 21:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:44 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:44 INFO - 'USER': 'cltbld', 21:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:44 INFO - 'XPC_FLAGS': '0x0', 21:06:44 INFO - 'XPC_SERVICE_NAME': '0', 21:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 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)) 21:06:44 INFO - Cleaning up... 21:06:44 INFO - Return code: 0 21:06:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:44 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 0x101b58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101b5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc088cc73c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, '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.bcpmkD1C12/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.eG1eR63H0f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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 21:06:44 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 21:06:44 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 21:06:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:06:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:06:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:06:44 INFO - 'HOME': '/Users/cltbld', 21:06:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:06:44 INFO - 'LOGNAME': 'cltbld', 21:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:44 INFO - 'MOZ_NO_REMOTE': '1', 21:06:44 INFO - 'NO_EM_RESTART': '1', 21:06:44 INFO - 'PAGER': '/bin/cat', 21:06:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:44 INFO - 'PWD': '/builds/slave/test', 21:06:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:06:44 INFO - 'SHELL': '/bin/bash', 21:06:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:06:44 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:06:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:06:44 INFO - 'USER': 'cltbld', 21:06:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:06:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:44 INFO - 'XPC_FLAGS': '0x0', 21:06:44 INFO - 'XPC_SERVICE_NAME': '0', 21:06:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:06:45 INFO - Cleaning up... 21:06:45 INFO - Return code: 0 21:06:45 INFO - Running post-action listener: _resource_record_post_action 21:06:45 INFO - Running post-action listener: _start_resource_monitoring 21:06:45 INFO - Starting resource monitoring. 21:06:45 INFO - [mozharness: 2017-05-04 04:06:45.105157Z] Finished create-virtualenv step (success) 21:06:45 INFO - [mozharness: 2017-05-04 04:06:45.106138Z] Running install step. 21:06:45 INFO - Running pre-action listener: _resource_record_pre_action 21:06:45 INFO - Running main action method: install 21:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:45 INFO - Reading from file tmpfile_stdout 21:06:45 INFO - Detecting whether we're running mozinstall >=1.0... 21:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:06:45 INFO - Reading from file tmpfile_stdout 21:06:45 INFO - Output received: 21:06:45 INFO - Usage: mozinstall [options] installer 21:06:45 INFO - Options: 21:06:45 INFO - -h, --help show this help message and exit 21:06:45 INFO - -d DEST, --destination=DEST 21:06:45 INFO - Directory to install application into. [default: 21:06:45 INFO - "/builds/slave/test"] 21:06:45 INFO - --app=APP Application being installed. [default: firefox] 21:06:45 INFO - mkdir: /builds/slave/test/build/application 21:06:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 21:07:00 INFO - Reading from file tmpfile_stdout 21:07:00 INFO - Output received: 21:07:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:07:00 INFO - Running post-action listener: _resource_record_post_action 21:07:00 INFO - [mozharness: 2017-05-04 04:07:00.196712Z] Finished install step (success) 21:07:00 INFO - [mozharness: 2017-05-04 04:07:00.196844Z] Running run-tests step. 21:07:00 INFO - Running pre-action listener: _resource_record_pre_action 21:07:00 INFO - Running main action method: run_tests 21:07:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:07:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:07:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:07:00 INFO - 2017-05-03 21:07:00.211 screenresolution[1623:7265] starting screenresolution argv=screenresolution get 21:07:00 INFO - 2017-05-03 21:07:00.214 screenresolution[1623:7265] Display 0: 1600x1200x32@60 21:07:00 INFO - 2017-05-03 21:07:00.220 screenresolution[1624:7267] starting screenresolution argv=screenresolution list 21:07:00 INFO - Available Modes on Display 0 21:07:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:07:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:07:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:07:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:07:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:07:00 INFO - Intel Iris: 21:07:00 INFO - Chipset Model: Intel Iris 21:07:00 INFO - Type: GPU 21:07:00 INFO - Bus: Built-In 21:07:00 INFO - VRAM (Dynamic, Max): 1536 MB 21:07:00 INFO - Vendor: Intel (0x8086) 21:07:00 INFO - Device ID: 0x0a2e 21:07:00 INFO - Revision ID: 0x0009 21:07:00 INFO - Displays: 21:07:00 INFO - Display: 21:07:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:07:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:07:00 INFO - Display Serial Number: 1600x1200 60 21:07:00 INFO - Main Display: Yes 21:07:00 INFO - Mirror: Off 21:07:00 INFO - Online: Yes 21:07:00 INFO - Rotation: Supported 21:07:00 INFO - Return code: 0 21:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:07:00 INFO - Python 2.7.3 21:07:00 INFO - Return code: 0 21:07:00 INFO - grabbing minidump binary from tooltool 21:07:00 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')]} 21:07:00 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 0x101936d30>, '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 0x10185ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10192bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:07:00 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 21:07:00 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 21:07:00 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 21:07:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:07:00 INFO - Return code: 0 21:07:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:07:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:07:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:07:00 INFO - ENV: RUST_BACKTRACE is now 1 21:07:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:07:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:07:00 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:07:00 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0097 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bcpmkD1C12/Render', 21:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:07:00 INFO - 'HOME': '/Users/cltbld', 21:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:07:00 INFO - 'LOGNAME': 'cltbld', 21:07:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:07:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:00 INFO - 'MOZ_NO_REMOTE': '1', 21:07:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:07:00 INFO - 'NO_EM_RESTART': '1', 21:07:00 INFO - 'PAGER': '/bin/cat', 21:07:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:00 INFO - 'PWD': '/builds/slave/test', 21:07:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:07:00 INFO - 'RUST_BACKTRACE': '1', 21:07:00 INFO - 'SHELL': '/bin/bash', 21:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eG1eR63H0f/Listeners', 21:07:00 INFO - 'TMPDIR': '/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/', 21:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:07:00 INFO - 'USER': 'cltbld', 21:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:00 INFO - 'XPC_FLAGS': '0x0', 21:07:00 INFO - 'XPC_SERVICE_NAME': '0', 21:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:07:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0097', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:07:00 INFO - mozversion application_buildid: 20170503192620 21:07:00 INFO - mozversion application_changeset: e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 21:07:00 INFO - mozversion application_display_name: Firefox 21:07:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:07:00 INFO - mozversion application_name: Firefox 21:07:00 INFO - mozversion application_remotingname: firefox 21:07:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:07:00 INFO - mozversion application_vendor: Mozilla 21:07:00 INFO - mozversion application_version: 54.0 21:07:00 INFO - mozversion platform_buildid: 20170503192620 21:07:00 INFO - mozversion platform_changeset: e664fb8bf2fd8f686c73cb61cdd58c0b16d4d739 21:07:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:07:00 INFO - mozversion platform_version: 54.0 21:07:00 INFO - using testdate: 1493870820 21:07:00 INFO - actual date: 1493870820 21:07:00 INFO - starting webserver on 'localhost:49235' 21:07:00 INFO - SUITE-START | Running 2 tests 21:07:00 INFO - TEST-START | dromaeo_css 21:07:00 INFO - operating with platform_type : mac_ 21:07:00 INFO - Initialising browser for dromaeo_css test... 21:07:00 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpxu41sr/profile http://localhost:49235/getInfo.html) 21:07:03 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 21:07:03 INFO - PROCESS | 1634 | colorDepth:24 21:07:03 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 21:07:03 INFO - PROCESS | 1634 | __metrics 21:07:03 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:07:03 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:07:04 INFO - TEST-INFO | 1634: exit 0 21:07:04 INFO - Browser initialized. 21:07:04 INFO - Running cycle 1/1 for dromaeo_css test... 21:07:04 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpxu41sr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:16 INFO - PROCESS | 1637 | RSS: Main: 184578048 21:07:16 INFO - PROCESS | 1637 | 21:10:20 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 21:10:22 INFO - PROCESS | 1637 | RSS: Main: 362754048 21:10:22 INFO - PROCESS | 1637 | 21:13:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 21:13:25 INFO - PROCESS | 1637 | RSS: Main: 320471040 21:13:25 INFO - PROCESS | 1637 | 21:16:28 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 21:16:28 INFO - PROCESS | 1637 | RSS: Main: 300269568 21:16:28 INFO - PROCESS | 1637 | 21:19:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 21:19:31 INFO - PROCESS | 1637 | RSS: Main: 310919168 21:19:31 INFO - PROCESS | 1637 | 21:22:35 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 21:22:36 INFO - PROCESS | 1637 | RSS: Main: 287420416 21:22:36 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 21:25:39 INFO - PROCESS | 1637 | RSS: Main: 452894720 21:25:39 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | __start_tp_report 21:25:39 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 21:25:39 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 21:25:39 INFO - PROCESS | 1637 | |i|pagename|runs| 21:25:39 INFO - PROCESS | 1637 | |0;dojo.html;3046.9999999999995;3545.4681797730336;3551.2719892422056;3564.946525802112;3606.098475381155;5834.883302333961;6083.878322433554;6112.022076467766;6140.662263575501;6180.629162250269;6084.3611420800735;6099;6150;6154.723037463314;6188.443040126388;5449.073657478229;5479.123340265558;5491.862703432426;5504.64219825712;5645.689487078209;5351.7056561889085;5363.758630861601;5398.973005134989;5443.237946687467;5601.411851755568;5476.972615136919;5484.561235101182;5489.1217405215175;5490.478404551562;5493.807716729915;5439.5104440600335;5469.206964990054;5475.479829416239;5475.67145971239;5480.342358916955;5300.310959575269;5419.105847535152;5424.430434804328;5429.511343979061;5463.098588732854;6031.215941927565;6042.305134909498;6050.8184754457;6055.455009049163;6065.666388348639;6215.098810672473;6234.719437625317;6261.248650161964;6264.21697287839;6264.874702505925;6305.968470157666;6317.715702793339;6441.935580644181;6463.159789227418;6475.125858009203;6162.322144564095;6204.751809927598;6215.471684906744;6223.471004964584;6252.87494250117;6290.591111577733;6328.810135695937;6660.2340730816095;6682.231543372574;6700.765473208512;4828.583327440063;6160.9383906161265;6299.338569450233;6313.43179113882;6332.461740751995;6360.9045864312075;6405.9750439929385;6464.612123272619;6492.415682588589;6509.121268628769;6336.366363363719;6346.460550853137;6350.015747559136;6356.951103068034;6362.172917520693;6374.298827129012;6378.107065010902;6390.392912673288;6408.455281301049;6420.5184611154355;5090.312807770978;5098.490150984946;5102.056119617882;5140.280360749498;5170.689758614495;3996.7002474814503;4515.819367225275;4623.491415944243;4630.421197350332;4646.976765116153;6121.989871671124;6146.661933593606;6176.9073463897175;6177.351378105324;6181.96909015461;6200.844978875564;6241.313455519889;6322.272938612026;6480.870382592416;6505.674716264168;6000.249968753906;6027.427394397525;6046.606970546901;6112;6129.938700612936;5707.229524014288;5742.253507044057;5746.942530574641;5751.252337196138;5756.7121643917635;6643.46852251809;6643.800685979429;6646.700898459678;6718.764843230463;6724.731010759613;6489.545731798728;6525.216973962965;6526.4452521536205;6533.803985880431;6535.379138981789;6334.588251763621;6402.551821372459;6561.278259391559;6570.77002304917;6644.933550664625;6347.17486726741;6383.808485745435;6415.166028416276;6419.614823110628;6432.195975503062;6483.870322593616;6488.70800813974;6493.22081350241;6495.1556297681;6511.967440162769;6212.81361559154;6240.032794916795;6247.562670613195;6272.278687950944;6308.526860485574;4629;5835.270591176103;6240.719167637377;6274.341194174546;6305.2433707953505;6165.876682466236;6174.783882564088;6257.7184026718;6307.495400368051;6348.619082855043;5560.471755183251;6166.660833654192;6203.875922481435;6233.283172435228;6293.842653933688;5720.685362305113;5941.881162376641;6160;6244.1570387997035;6270.341614130451 21:25:39 INFO - PROCESS | 1637 | |1;ext.html;758.5410826449996;758.5638258001651;831.5343407691693;904.3127223310282;908.4322298563397;29345.85327073364;41221;41244.96887577812;41870.11584478702;41889.79055104728;41772.37341439881;42033.579664203346;42060.57939420605;42098.15803683932;42111.57888421115;9600.855987160216;9753;9757.609695612202;9766.804663906718;9791.167750741195;7881.566513841736;8000.559969201691;11677.766444671102;11836.585719499819;12111.818322725167;11853.881461185363;11882.702932426671;11899.821502677467;11903.642890713249;11953.22304050234;11897.464614092343;11924;11933.985611223057;11943.701407464796;11946.701332466671;9161.541922903894;11485.483153258123;11633.185677002613;11647.010004149657;11690.824637630443;40538.59461405378;40648;40721;40726;40790;4061.2689715851134;4062.634362907323;4065.1869626074904;4084.7344922580232;4092.9386059209137;28148.577771333243;28637.713622863714;28712.856435717687;29283.707162928524;30236;3101.705337992887;3212.855421506038;3220.130564747505;3251.96748032519;3363.83180840957;340340;344473;345036;345060.54939450783;345541;54601;54720;54744;54808.72595636996;54816.45183548193;57053.42946570481;57211.427885721445;57373.71313143407;57395.13907291394;57480;15237.238138093051;15610.609734756721;15611.141387223812;15612.219389030502;15619.14094724801;13182.73634527304;13189.076764626576;13199.53801616958;13215.405306761219;13241.139325943783;11210.495527701272;11229.71925701864;11380.658580242605;11617.825732614017;12680.873191268154;5254.185601231815;5378.97310513445;5410.269613602192;5417.51242388187;5482.5613950883835;1123.8314252862135;1139.75495268516;1148.6841118692425;1151.6832870960386;1168.6961390038482;27205.2473680794;27222.183334499998;27705.584416233774;27762.444751105268;27838.86080569584;1274.20362273579;1278.2394475287374;1280.295837289487;1323.08706992177;1333.8466076401144;14313.85686143146;14415.42338306477;14472.986890917535;14640.414383424757;14647.633809154857;460597;460672;461292;461858;462547;58350.70824645935;58540.707296463246;58569.70715146397;58589.41410585925;58637.41362586405;1457.140287230518;1474.1670955909876;1516.408600645749;1519.1492764052166;1521.5511424129909;25715;26567.7343226573;27069.86465067662;27196.864015679796;27238;48060.7596962013;48164.5183548174;48170.759146204044;48270.517294826604;48464.515354846;411915.940420296;412146;412214;412257;413667;29004;36033.27933441264;36056.098597535274;36097;36124;37384.87845364644;37843.62156378401;37880.05299867525;38361;38680.2263954725;27371.72628273692;27385.863070684518;27623.447531048863;27688;28398.29004274827;27791;28272.43455130927;28384.71615283903;28591.571126433537;28710.282242944093;31618.841905790323;31744.36511269808;32321.868734594176;32605.673943260263;32785.836070819496;22859.542809144055;25377;27984.46085465319;28047.859760701067;28261.858690706416;21411.143554257655;21708.67436988478;22213.77786222117;22325.627690546306;22470.438239044153 21:25:39 INFO - PROCESS | 1637 | |2;jquery.html;393.35293442287457;431.8790738593195;442.1510699457043;447.35357408544667;450.4189595421906;17607.735883961752;21598.460038499026;22786.65820012701;23528;23760.287191384243;23049.76950230497;23369.415764605852;23718.407039824015;23885.641715374284;23921.282361529138;5450.482204190595;7020.368166864994;7298.744543940963;7314.561126332437;7345.449091318173;6652.700628471706;6658.400743933045;7122.928770712304;7259.020032295652;7269.3457588817;7166.068411106575;7166.8208294792785;7179.533330333512;7179.89230161548;7187.496875218737;6936.895946560806;7091.645417729119;7109.928900711005;7131.393831524327;7148.285171482836;6635.203775546917;6805.693743781541;6913.516053876231;6924.723011079551;6961.686724097377;26939;26967.92128314865;27054;27210.727892721017;27262.454750905068;3025.5612936124357;3066.0801759472292;3192.0423872838055;3237.7409807215604;3261.6575259597876;15860;16383.83616163847;16412.507624771275;16422.917885410618;17614.295428182857;1898.7246849206927;2065.524929266277;2102.7897210279;2116.7459904811367;2145.6674215496623;126861;127008.0948785769;129596;131302.3434882829;132103.33948330293;15221.467248646244;20300.79699202989;20642.86464244451;20812.43906707003;21137.471563210736;34821.651783482346;35052;35129.946101616995;35187;35260.47109293363;11296;11567;11576.884231157748;11585.189036767513;11747.353895535827;7275.854482910418;9301.767455813524;9445.14993650561;9473.005334439922;9649.228061755042;8171.63227654757;8547;10493.737656558647;10520.473976301155;10526.31578947366;4270.7864606769535;4302.827886884552;4309.1381723655395;4334.783260836945;4359.498657654347;1063.5161001744189;1077.8922107789158;1079.5681727309138;1090.7273181704575;1128.6388355726253;22557;22756.886215568815;22925.426864328525;22974.195903143645;22994.42513937165;941.6327632223438;968.3947532792005;1066.157735389034;1104.6685994201707;1106.6016234155697;11237.83143252852;11256.718582035515;11920.403979800974;12143.14997950135;12148.5140594377;736945;751963;776082;778713;795225.047749515;70677;94701;115043;156090.99999999773;156874;1393.4286942353585;1419.6237996930822;1449.2753623188405;1449.8405175430694;1454.4763885001391;12819.42312595954;19340.292359070023;21364.679529807378;21973.450663732896;22065;55121.724391377786;64807.67596161989;66636;67073.66463167653;68754.9686754689;60467.09299360601;91129.54435227781;91397.17205655716;91480.54259728659;91875;9937.602495900372;11740.41297935117;11836.408179591159;12015.579454719043;12245.938770306448;11312.886871131512;13463.394147263592;13470.124441911245;13494.460221591418;13818.239996800272;11327.602106077178;11722.94138529336;11869.76260474803;11962.102842287037;11962.700932476757;8718.869216961877;10711.464426778786;10731.463426828783;11004.889951100387;11006.504707288032;11669.416529173677;11735;11740.823887641864;11798.823017654913;11821.172517923662;11815.527378904748;11931;12123.575674851338;12139;12163.331016794162;11297.096232301561;11549.422528873354;11763;11765.88234117682;11966.46150923228 21:25:39 INFO - PROCESS | 1637 | |3;mootools.html;1623.1478473801253;1628.259142090349;1659.684659914616;1661.9418320358782;1671.4901954903753;11272.985431311181;12045.879541204586;12050.879491205085;12058.819117713241;12064.939675301623;11220.775584488305;11675.41622918855;11790.705232369173;11806.173567850254;11815.291082535054;2464.593342098556;2509.987450062747;2510.786583140435;2513.7988960883085;2516.0564788204424;2443.1937460637946;2457.2628211536467;2488.8880000400027;2491.626256061596;2499.2252401755422;2411.6623672685837;2434;2459.5449841779237;2461.618449140386;2466.7533246675366;2291.988540057289;2414.6619473273754;2414.8551086934754;2433.6227884677905;2464.7904928081134;2327.0924339507606;2351.870647114408;2359.6814430051895;2360.1031607989025;2361.1027809432476;11198.720031999184;11450.541978320856;11455.427228638535;11462.885371146265;11471.13966452511;5838.532917366643;6016.398360163992;6030.547708921805;6033.758649654009;6037.577369584131;3459.1697992481877;3574.035010547164;3654.397024490956;3673.4673472346362;3716.0338312038793;998.9850152247722;1109.3343993603853;1216.6471723200261;1264.3109505319624;1281.7246839394768;13967.37146828395;14085.64785880351;14438.566842994727;15200;16260.186990650538;4071.7353372030725;4794.880127996828;4917.164082106051;4920.75396230187;4922.458529561745;12397.75204495923;12420.00639948802;12428.254304741744;12440.00479961619;12441;5115;5305.628605997543;5328.866778330573;5333.439988801198;6049.364816694272;4822.324874517571;5311.309529761106;5522.144067669437;5542.445755424506;5553.611247212656;3961.5840336764227;4038.596140385938;4107.835686572504;4126.649234815074;4137.234611596804;1035.4512108582464;1053.1890444357803;1061.6125114333213;1071.2982996137541;1071.3250652089134;940.3370623710268;966.9854952175723;988.4020167798523;988.6094992478074;1022.6318525330875;6725.932740672629;6749.493787965824;6847.452203823682;6871.862562748717;6907.7236910524025;993.9900600993898;997.8203923293731;1026.38416949831;1036.9740756480996;1074.6937122920087;4255;4313.094250207429;4324.978375108104;4426.114777044604;4446.466424029137;14215.289235538181;14901;14910.478133265284;14931.029483083565;14939.477118300807;13327.66680832987;13676.452941882213;14285.714285714228;14300.284985750672;14317.57047288583;10271.178305735522;10631.46842657864;10778.4071876046;10797.35215887065;10827.837582436112;6960.269171736894;6966;6988.580685158907;7132.607706576188;7170.856582868209;12631.684207894876;12891.935540322238;12902.290374029519;13066;13081.280529570964;13148.868511315148;13296.202227866359;13313.400896959854;13437.260950647807;13544.187348759106;9163.35856490066;9488.95255523718;9546.761330966781;9554.665586704432;9558;10432.321899076536;10515.579376825148;10588.894111058791;10622.681319560426;10702.304350217211;7531.322181003736;7784.2215778421705;8934.508602026692;9090.181883630505;9169.954150229207;8728.127187281221;8815.471071735716;8864.86702699447;8874.733757987271;8911.2425443838;7590.316871481593;7746.147923728273;7916.247956444128;8073.798155046171;8175.550344730859;5823.621464604787;5892.998190307572;5951.137085122719;5969.52243820502;6080.148779170831;5768.134779783066;5995.790147344822;6022.277326720647;6024.518038556817;6067.936901453527 21:25:39 INFO - PROCESS | 1637 | |4;prototype.html;373.3280095827511;387.4362802122911;389.6356906292615;395.693337663311;396.2372433066348;4348.956510434895;4467.4862390825065;4585.3580498730125;5012.974935125324;5109.897802043962;4086.734362266458;4780.330753694477;4791.257355109955;4828.97585512072;4839.274108883669;3477.6263375966605;3563.6280032187665;3929.879984204488;3947.250022495731;4125.814338354774;3844.404572102574;3895.5130608673917;4118.608732170439;4134.338505839067;4159.854405095823;3939.5863434339412;4237.6821738369745;4273.829046838123;4295.957040429603;4303.24693178694;3694.7783133012103;4095.877123686294;4185.053949913275;4289.935650965253;4304.784760761965;3702.7037836972977;3773.962260377416;3898.8440462381473;4039.929418704046;4104.56902025289;4180.216903702154;4800.359802108826;4811.639127065484;4827.599996001156;4834.20235661119;4110.815013324408;4295.742255464682;4806.770042362733;4832.879178020543;4990.629451010777;4704;5250.396204436501;5270.521455839166;5302.814401495929;5330.546903513206;3828.444875493066;4098.672106231495;4616.5152658970665;4630.004549021943;4661.696989695659;4295.548967358445;4719.59883409914;5489.890202196014;5544.362398324163;5576.525995290364;4015.598440155961;4115.9176816463505;4258.5954334338185;4731.645126615517;4744.5492678195515;4836;4844.806207751721;4862.513748625109;4880.6095512358925;4899.975500122548;4504.198320671758;4597.7241365518175;4910.680805747615;4992.354052352259;5048.3184770056305;4501.639868810487;4587.977060114745;5115.851342436112;5208.427073021964;5216.895662086737;1455.4281376113772;1504.6163228376695;1582.6705567323504;1629.9022058676517;1638.500257421498;1207.8067509198486;1275.596843472173;1279.1749321687646;1298.104308027458;1339.4776037345443;4377.627901628333;4626.259798432302;4683.5082316356975;4811.254255590389;4958.529029679239;4746.359241502353;5023.723695196799;5179.533841954167;5388.946110538923;5394.408649448422;4496.505384407713;4557.339185818038;4875.220544501231;4925;4928.6303527235605;2462.692163479565;2483.3543278747293;2811.831290122558;2840.1621521651164;2847.900323488668;5094.388673359221;5137.743112844343;5397.247403824;5513.889722205614;5560.609847538116;5253.975474782381;5318.016167009038;5492.890142197134;5531.585131115102;5588.674738530568;5238.266642670029;5450.781968721365;5483.451654834565;5606.495415412551;5622.803201887832;4796.37647105874;5054.620903432184;5130.050940576006;5164.173732202829;5354.544863686475;4914.655974081923;5146.459621739813;5153.45888681683;5169.327987361619;5337.759800809051;4524.479684836154;4749.976250118727;4989.575886049582;5212.848838370607;5582.7766889323975;4481.843135490242;4744.4069491313585;4744.92882606768;4809.038192361471;4829.468758436639;4448.021435284232;5025.96967621644;5399.514043736082;5456.427075157051;5468.835934921959;4897.706137631753;5269.367675878919;5278.419373868948;5278.865044015555;5299.523042926001;4859.663592512087;4905.215165573634;5277.709725965109;5300.734963251899;5349.732513374393;4581.67928245033;5156.56169225605;5172.301739265151;5215.478452154754;5269.894602108013;4534.478534968521;5013.470891378165;5149.510796474329;5237.292965449616;5297.496737809902;4540;4677.649176311722;4970.850874473772;5166.844994650167;5205.791768329376 21:25:39 INFO - PROCESS | 1637 | |5;yui.html;793.4802704228729;817.9672813087473;832.5296207642685;884.5533005832056;889.8264838356521;15532.378704851806;17384.391546295883;17422.128893555335;17449.651006979868;17472.737908931376;16082.437114700988;16274.104924229192;16292.511224663249;16328.83671163288;16339.754903676454;971.7959228562011;974.0648976982105;978.9559469823876;980.2550061952932;980.4215512847419;995.3231802374382;998.0967224661692;1009.6213919780082;1015.5836107196051;1032.2877214721855;1067.871855377352;1069.3797597393532;1069.4813015687425;1069.5775168808354;1069.9090577300938;1061.389700921973;1064.106150833296;1064.3986147826454;1066.0831684751147;1069.4652673663168;791.3748138970207;791.4934441957153;793.3415265329762;794.7178751543235;795.9084705258854;17299.913500432544;17315.65368692632;17362;17964.91017544904;18216.998065106545;14472.565823025327;14803.481878134322;14830.406783728638;14883.925580372137;15139.091654500655;11651.452447472402;12038.217515861441;12084.093692972974;12468.376581170905;12742.044346674036;3560.537130173087;3775.5846856845724;3870.1872606752618;3872.283627528916;4040.7575545467366;116938;119337;119581.99999999913;121592;121758;11426.371549564687;11453.370064646524;11539.846015398562;11605.477753501113;11656.766864662659;23612.17357392483;23812.523749524913;24165.879170604036;24173.395665108514;24218.63672044921;8144.877826832602;8166.060902996232;8171.7548473545885;8194.918050819415;8354.331653467709;4576.679632425765;4659.301104834234;4660.067986402733;4737.905241895142;4749.928751068736;3622.6558476944647;3719.683826874692;3730;3735.3089678409583;3736.9065773355883;630.5775130662468;667.8163505036154;674.0428591400223;680.2177495879778;684.8904175331922;665.8871559087622;691.3432239372617;736.6316841579211;749.4266885832343;758.8671982403167;9886.80226395468;10655.413952232702;10712.625058123083;10747.946260268805;10960.945195273973;682.3551743602249;712.7861641507527;727.4107972542258;737.3363972424753;737.4505993035223;4611.608013318838;5219.530242278213;5232.633715639869;5247.921281180786;5264.289320941701;106544;108041;109916;110020;112110.43944780224;92645.61031584532;92705;95120;96514.0348596519;96717;78262.6086869562;79722.60138699385;81325.59337203513;82223.5888820552;83039.58480207682;9579;10262.230332725225;10298.3820970739;10306.793864122526;10332.380057196593;38560;49750.502494974586;51408.48591514037;51749;52406;64979;66502.66748666226;66726.66636666785;67050.3294967044;74112;12803.10378273512;14986.850131498546;15124.243787810785;15202.239888005335;15315.923420382827;14728;15012.699746005237;15598.844011559739;16036.599085022968;16778.664426711643;13893.305334733424;14700.632484187981;14920.701585968003;15268.3892644293;15332.540023799304;14243.928780356031;15074.895146794575;15530.607456807975;15539.766903496231;15618.531444056242;13847.099938503965;13865.514706985206;14253.073550219202;14419.42322307096;14888.478903238334;9939.304248702521;10022.649207277711;10186.74533136648;10252.743681408025;10586.206034547286;11662.300261984308;11849.822252666045;11955.109627645712;12326.81509777336;12338.50645974151 21:25:39 INFO - PROCESS | 1637 | __end_tp_report 21:25:39 INFO - PROCESS | 1637 | __start_cc_report 21:25:39 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1799 21:25:39 INFO - PROCESS | 1637 | __end_cc_report 21:25:39 INFO - PROCESS | 1637 | __startTimestamp1493871939979__endTimestamp 21:25:39 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | ------- Summary: start ------- 21:25:39 INFO - PROCESS | 1637 | Number of tests: 6 21:25:39 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5958.59 Median:6200.84 stddev:672.14 (10.8%) stddev-sans-first:634.21 21:25:39 INFO - PROCESS | 1637 | Values: 3047.0 3545.5 3551.3 3564.9 3606.1 5834.9 6083.9 6112.0 6140.7 6180.6 6084.4 6099.0 6150.0 6154.7 6188.4 5449.1 5479.1 5491.9 5504.6 5645.7 5351.7 5363.8 5399.0 5443.2 5601.4 5477.0 5484.6 5489.1 5490.5 5493.8 5439.5 5469.2 5475.5 5475.7 5480.3 5300.3 5419.1 5424.4 5429.5 5463.1 6031.2 6042.3 6050.8 6055.5 6065.7 6215.1 6234.7 6261.2 6264.2 6264.9 6306.0 6317.7 6441.9 6463.2 6475.1 6162.3 6204.8 6215.5 6223.5 6252.9 6290.6 6328.8 6660.2 6682.2 6700.8 4828.6 6160.9 6299.3 6313.4 6332.5 6360.9 6406.0 6464.6 6492.4 6509.1 6336.4 6346.5 6350.0 6357.0 6362.2 6374.3 6378.1 6390.4 6408.5 6420.5 5090.3 5098.5 5102.1 5140.3 5170.7 3996.7 4515.8 4623.5 4630.4 4647.0 6122.0 6146.7 6176.9 6177.4 6182.0 6200.8 6241.3 6322.3 6480.9 6505.7 6000.2 6027.4 6046.6 6112.0 6129.9 5707.2 5742.3 5746.9 5751.3 5756.7 6643.5 6643.8 6646.7 6718.8 6724.7 6489.5 6525.2 6526.4 6533.8 6535.4 6334.6 6402.6 6561.3 6570.8 6644.9 6347.2 6383.8 6415.2 6419.6 6432.2 6483.9 6488.7 6493.2 6495.2 6512.0 6212.8 6240.0 6247.6 6272.3 6308.5 4629.0 5835.3 6240.7 6274.3 6305.2 6165.9 6174.8 6257.7 6307.5 6348.6 5560.5 6166.7 6203.9 6233.3 6293.8 5720.7 5941.9 6160.0 6244.2 6270.3 21:25:39 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:54962.59 Median:31681.60 stddev:108295.42 (341.8%) stddev-sans-first:108522.74 21:25:39 INFO - PROCESS | 1637 | Values: 758.5 758.6 831.5 904.3 908.4 29345.9 41221.0 41245.0 41870.1 41889.8 41772.4 42033.6 42060.6 42098.2 42111.6 9600.9 9753.0 9757.6 9766.8 9791.2 7881.6 8000.6 11677.8 11836.6 12111.8 11853.9 11882.7 11899.8 11903.6 11953.2 11897.5 11924.0 11934.0 11943.7 11946.7 9161.5 11485.5 11633.2 11647.0 11690.8 40538.6 40648.0 40721.0 40726.0 40790.0 4061.3 4062.6 4065.2 4084.7 4092.9 28148.6 28637.7 28712.9 29283.7 30236.0 3101.7 3212.9 3220.1 3252.0 3363.8 340340.0 344473.0 345036.0 345060.5 345541.0 54601.0 54720.0 54744.0 54808.7 54816.5 57053.4 57211.4 57373.7 57395.1 57480.0 15237.2 15610.6 15611.1 15612.2 15619.1 13182.7 13189.1 13199.5 13215.4 13241.1 11210.5 11229.7 11380.7 11617.8 12680.9 5254.2 5379.0 5410.3 5417.5 5482.6 1123.8 1139.8 1148.7 1151.7 1168.7 27205.2 27222.2 27705.6 27762.4 27838.9 1274.2 1278.2 1280.3 1323.1 1333.8 14313.9 14415.4 14473.0 14640.4 14647.6 460597.0 460672.0 461292.0 461858.0 462547.0 58350.7 58540.7 58569.7 58589.4 58637.4 1457.1 1474.2 1516.4 1519.1 1521.6 25715.0 26567.7 27069.9 27196.9 27238.0 48060.8 48164.5 48170.8 48270.5 48464.5 411915.9 412146.0 412214.0 412257.0 413667.0 29004.0 36033.3 36056.1 36097.0 36124.0 37384.9 37843.6 37880.1 38361.0 38680.2 27371.7 27385.9 27623.4 27688.0 28398.3 27791.0 28272.4 28384.7 28591.6 28710.3 31618.8 31744.4 32321.9 32605.7 32785.8 22859.5 25377.0 27984.5 28047.9 28261.9 21411.1 21708.7 22213.8 22325.6 22470.4 21:25:39 INFO - PROCESS | 1637 | 21:25:39 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:42348.41 Median:22771.77 stddev:126759.36 (556.7%) stddev-sans-first:127075.81 21:25:39 INFO - PROCESS | 1637 | Values: 393.4 431.9 442.2 447.4 450.4 17607.7 21598.5 22786.7 23528.0 23760.3 23049.8 23369.4 23718.4 23885.6 23921.3 5450.5 7020.4 7298.7 7314.6 7345.4 6652.7 6658.4 7122.9 7259.0 7269.3 7166.1 7166.8 7179.5 7179.9 7187.5 6936.9 7091.6 7109.9 7131.4 7148.3 6635.2 6805.7 6913.5 6924.7 6961.7 26939.0 26967.9 27054.0 27210.7 27262.5 3025.6 3066.1 3192.0 3237.7 3261.7 15860.0 16383.8 16412.5 16422.9 17614.3 1898.7 2065.5 2102.8 2116.7 2145.7 126861.0 127008.1 129596.0 131302.3 132103.3 15221.5 20300.8 20642.9 20812.4 21137.5 34821.7 35052.0 35129.9 35187.0 35260.5 11296.0 11567.0 11576.9 11585.2 11747.4 7275.9 9301.8 9445.1 9473.0 9649.2 8171.6 8547.0 10493.7 10520.5 10526.3 4270.8 4302.8 4309.1 4334.8 4359.5 1063.5 1077.9 1079.6 1090.7 1128.6 22557.0 22756.9 22925.4 22974.2 22994.4 941.6 968.4 1066.2 1104.7 1106.6 11237.8 11256.7 11920.4 12143.1 12148.5 736945.0 751963.0 776082.0 778713.0 795225.0 70677.0 94701.0 115043.0 156091.0 156874.0 1393.4 1419.6 1449.3 1449.8 1454.5 12819.4 19340.3 21364.7 21973.5 22065.0 55121.7 64807.7 66636.0 67073.7 68755.0 60467.1 91129.5 91397.2 91480.5 91875.0 9937.6 11740.4 11836.4 12015.6 12245.9 11312.9 13463.4 13470.1 13494.5 13818.2 11327.6 11722.9 11869.8 11962.1 11962.7 8718.9 10711.5 10731.5 11004.9 11006.5 11669.4 11735.0 11740.8 11798.8 11821.2 11815.5 11931.0 12123.6 12139.0 12163.3 11297.1 11549.4 11763.0 11765.9 11966.5 21:25:40 INFO - PROCESS | 1637 | 21:25:40 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6959.32 Median:2477.82 stddev:4406.49 (177.8%) stddev-sans-first:4400.62 21:25:40 INFO - PROCESS | 1637 | Values: 1623.1 1628.3 1659.7 1661.9 1671.5 11273.0 12045.9 12050.9 12058.8 12064.9 11220.8 11675.4 11790.7 11806.2 11815.3 2464.6 2510.0 2510.8 2513.8 2516.1 2443.2 2457.3 2488.9 2491.6 2499.2 2411.7 2434.0 2459.5 2461.6 2466.8 2292.0 2414.7 2414.9 2433.6 2464.8 2327.1 2351.9 2359.7 2360.1 2361.1 11198.7 11450.5 11455.4 11462.9 11471.1 5838.5 6016.4 6030.5 6033.8 6037.6 3459.2 3574.0 3654.4 3673.5 3716.0 999.0 1109.3 1216.6 1264.3 1281.7 13967.4 14085.6 14438.6 15200.0 16260.2 4071.7 4794.9 4917.2 4920.8 4922.5 12397.8 12420.0 12428.3 12440.0 12441.0 5115.0 5305.6 5328.9 5333.4 6049.4 4822.3 5311.3 5522.1 5542.4 5553.6 3961.6 4038.6 4107.8 4126.6 4137.2 1035.5 1053.2 1061.6 1071.3 1071.3 940.3 967.0 988.4 988.6 1022.6 6725.9 6749.5 6847.5 6871.9 6907.7 994.0 997.8 1026.4 1037.0 1074.7 4255.0 4313.1 4325.0 4426.1 4446.5 14215.3 14901.0 14910.5 14931.0 14939.5 13327.7 13676.5 14285.7 14300.3 14317.6 10271.2 10631.5 10778.4 10797.4 10827.8 6960.3 6966.0 6988.6 7132.6 7170.9 12631.7 12891.9 12902.3 13066.0 13081.3 13148.9 13296.2 13313.4 13437.3 13544.2 9163.4 9489.0 9546.8 9554.7 9558.0 10432.3 10515.6 10588.9 10622.7 10702.3 7531.3 7784.2 8934.5 9090.2 9170.0 8728.1 8815.5 8864.9 8874.7 8911.2 7590.3 7746.1 7916.2 8073.8 8175.6 5823.6 5893.0 5951.1 5969.5 6080.1 5768.1 5995.8 6022.3 6024.5 6067.9 21:25:40 INFO - PROCESS | 1637 | 21:25:40 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4435.18 Median:4810.15 stddev:1183.05 (24.6%) stddev-sans-first:1146.41 21:25:40 INFO - PROCESS | 1637 | Values: 373.3 387.4 389.6 395.7 396.2 4349.0 4467.5 4585.4 5013.0 5109.9 4086.7 4780.3 4791.3 4829.0 4839.3 3477.6 3563.6 3929.9 3947.3 4125.8 3844.4 3895.5 4118.6 4134.3 4159.9 3939.6 4237.7 4273.8 4296.0 4303.2 3694.8 4095.9 4185.1 4289.9 4304.8 3702.7 3774.0 3898.8 4039.9 4104.6 4180.2 4800.4 4811.6 4827.6 4834.2 4110.8 4295.7 4806.8 4832.9 4990.6 4704.0 5250.4 5270.5 5302.8 5330.5 3828.4 4098.7 4616.5 4630.0 4661.7 4295.5 4719.6 5489.9 5544.4 5576.5 4015.6 4115.9 4258.6 4731.6 4744.5 4836.0 4844.8 4862.5 4880.6 4900.0 4504.2 4597.7 4910.7 4992.4 5048.3 4501.6 4588.0 5115.9 5208.4 5216.9 1455.4 1504.6 1582.7 1629.9 1638.5 1207.8 1275.6 1279.2 1298.1 1339.5 4377.6 4626.3 4683.5 4811.3 4958.5 4746.4 5023.7 5179.5 5388.9 5394.4 4496.5 4557.3 4875.2 4925.0 4928.6 2462.7 2483.4 2811.8 2840.2 2847.9 5094.4 5137.7 5397.2 5513.9 5560.6 5254.0 5318.0 5492.9 5531.6 5588.7 5238.3 5450.8 5483.5 5606.5 5622.8 4796.4 5054.6 5130.1 5164.2 5354.5 4914.7 5146.5 5153.5 5169.3 5337.8 4524.5 4750.0 4989.6 5212.8 5582.8 4481.8 4744.4 4744.9 4809.0 4829.5 4448.0 5026.0 5399.5 5456.4 5468.8 4897.7 5269.4 5278.4 5278.9 5299.5 4859.7 4905.2 5277.7 5300.7 5349.7 4581.7 5156.6 5172.3 5215.5 5269.9 4534.5 5013.5 5149.5 5237.3 5297.5 4540.0 4677.6 4970.9 5166.8 5205.8 21:25:40 INFO - PROCESS | 1637 | 21:25:40 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21831.71 Median:17435.89 stddev:31441.40 (180.3%) stddev-sans-first:31489.91 21:25:40 INFO - PROCESS | 1637 | Values: 793.5 818.0 832.5 884.6 889.8 15532.4 17384.4 17422.1 17449.7 17472.7 16082.4 16274.1 16292.5 16328.8 16339.8 971.8 974.1 979.0 980.3 980.4 995.3 998.1 1009.6 1015.6 1032.3 1067.9 1069.4 1069.5 1069.6 1069.9 1061.4 1064.1 1064.4 1066.1 1069.5 791.4 791.5 793.3 794.7 795.9 17299.9 17315.7 17362.0 17964.9 18217.0 14472.6 14803.5 14830.4 14883.9 15139.1 11651.5 12038.2 12084.1 12468.4 12742.0 3560.5 3775.6 3870.2 3872.3 4040.8 116938.0 119337.0 119582.0 121592.0 121758.0 11426.4 11453.4 11539.8 11605.5 11656.8 23612.2 23812.5 24165.9 24173.4 24218.6 8144.9 8166.1 8171.8 8194.9 8354.3 4576.7 4659.3 4660.1 4737.9 4749.9 3622.7 3719.7 3730.0 3735.3 3736.9 630.6 667.8 674.0 680.2 684.9 665.9 691.3 736.6 749.4 758.9 9886.8 10655.4 10712.6 10747.9 10960.9 682.4 712.8 727.4 737.3 737.5 4611.6 5219.5 5232.6 5247.9 5264.3 106544.0 108041.0 109916.0 110020.0 112110.4 92645.6 92705.0 95120.0 96514.0 96717.0 78262.6 79722.6 81325.6 82223.6 83039.6 9579.0 10262.2 10298.4 10306.8 10332.4 38560.0 49750.5 51408.5 51749.0 52406.0 64979.0 66502.7 66726.7 67050.3 74112.0 12803.1 14986.9 15124.2 15202.2 15315.9 14728.0 15012.7 15598.8 16036.6 16778.7 13893.3 14700.6 14920.7 15268.4 15332.5 14243.9 15074.9 15530.6 15539.8 15618.5 13847.1 13865.5 14253.1 14419.4 14888.5 9939.3 10022.6 10186.7 10252.7 10586.2 11662.3 11849.8 11955.1 12326.8 12338.5 21:25:40 INFO - PROCESS | 1637 | -------- Summary: end -------- 21:25:40 INFO - PROCESS | 1637 | 21:25:40 INFO - TEST-INFO | 1637: exit 0 21:25:40 INFO - TEST-OK | dromaeo_css | took 1119768ms 21:25:40 INFO - TEST-START | kraken 21:25:40 INFO - operating with platform_type : mac_ 21:25:40 INFO - Initialising browser for kraken test... 21:25:40 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpXPIL6O/profile http://localhost:49235/getInfo.html) 21:25:42 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 21:25:42 INFO - PROCESS | 1647 | colorDepth:24 21:25:42 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 21:25:42 INFO - PROCESS | 1647 | __metrics 21:25:42 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:25:42 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:25:43 INFO - TEST-INFO | 1647: exit 0 21:25:43 INFO - Browser initialized. 21:25:43 INFO - Running cycle 1/1 for kraken test... 21:25:43 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/T/tmpXPIL6O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:25:55 INFO - PROCESS | 1649 | RSS: Main: 187777024 21:25:55 INFO - PROCESS | 1649 | 21:25:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 21:25:59 INFO - PROCESS | 1649 | RSS: Main: 236015616 21:25:59 INFO - PROCESS | 1649 | 21:26:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 21:26:02 INFO - PROCESS | 1649 | RSS: Main: 249991168 21:26:02 INFO - PROCESS | 1649 | 21:26:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 21:26:06 INFO - PROCESS | 1649 | RSS: Main: 345780224 21:26:06 INFO - PROCESS | 1649 | 21:26:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 21:26:08 INFO - PROCESS | 1649 | RSS: Main: 245137408 21:26:08 INFO - PROCESS | 1649 | 21:26:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:26:11 INFO - PROCESS | 1649 | RSS: Main: 246620160 21:26:11 INFO - PROCESS | 1649 | 21:26:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 21:26:14 INFO - PROCESS | 1649 | RSS: Main: 287629312 21:26:14 INFO - PROCESS | 1649 | 21:26:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 21:26:18 INFO - PROCESS | 1649 | RSS: Main: 288563200 21:26:18 INFO - PROCESS | 1649 | 21:26:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 21:26:21 INFO - PROCESS | 1649 | RSS: Main: 284557312 21:26:21 INFO - PROCESS | 1649 | 21:26:23 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:26:24 INFO - PROCESS | 1649 | RSS: Main: 263340032 21:26:24 INFO - PROCESS | 1649 | 21:26:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:26:26 INFO - PROCESS | 1649 | RSS: Main: 266928128 21:26:26 INFO - PROCESS | 1649 | 21:26:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:26:29 INFO - PROCESS | 1649 | RSS: Main: 274087936 21:26:29 INFO - PROCESS | 1649 | 21:26:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:26:33 INFO - PROCESS | 1649 | RSS: Main: 288899072 21:26:33 INFO - PROCESS | 1649 | 21:26:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:26:36 INFO - PROCESS | 1649 | RSS: Main: 282857472 21:26:36 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 21:26:38 INFO - PROCESS | 1649 | RSS: Main: 327778304 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | __start_tp_report 21:26:38 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 21:26:38 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 21:26:38 INFO - PROCESS | 1649 | |i|pagename|runs| 21:26:38 INFO - PROCESS | 1649 | |0;ai-astar;114;114;115;113;115;115;114;115;113;115 21:26:38 INFO - PROCESS | 1649 | |1;audio-beat-detection;141;108;109;140;103;108;107;107;126;107 21:26:38 INFO - PROCESS | 1649 | |2;audio-dft;185;187;186;185;185;183;183;185;186;183 21:26:38 INFO - PROCESS | 1649 | |3;audio-fft;82;60;60;91;63;62;61;77;95;82 21:26:38 INFO - PROCESS | 1649 | |4;audio-oscillator;88;69;84;68;69;68;81;67;68;82 21:26:38 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;98;133;97;89;89;87;89;88;89;88 21:26:38 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;95;95;95;96;95;95;96;96;96 21:26:38 INFO - PROCESS | 1649 | |7;imaging-desaturate;84;83;83;85;83;82;82;84;85;85 21:26:38 INFO - PROCESS | 1649 | |8;json-parse-financial;62;61;62;60;63;62;60;69;75;94 21:26:38 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;49;65;77;60;60;57;57;57;56;57 21:26:38 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;83;81;81;84;83;84;79;83;81;82 21:26:38 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;128;133;138;134;150;125;140;148;186;169 21:26:38 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;162;162;167;162;160;164;159;161;163;163 21:26:38 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;65;66;64;64;64;63;64;63;63 21:26:38 INFO - PROCESS | 1649 | __end_tp_report 21:26:38 INFO - PROCESS | 1649 | __start_cc_report 21:26:38 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2111 21:26:38 INFO - PROCESS | 1649 | __end_cc_report 21:26:38 INFO - PROCESS | 1649 | __startTimestamp1493871998605__endTimestamp 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | ------- Summary: start ------- 21:26:38 INFO - PROCESS | 1649 | Number of tests: 14 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 21:26:38 INFO - PROCESS | 1649 | Values: 114.0 114.0 115.0 113.0 115.0 115.0 114.0 115.0 113.0 115.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:115.60 Median:108.50 stddev:14.49 (13.4%) stddev-sans-first:12.10 21:26:38 INFO - PROCESS | 1649 | Values: 141.0 108.0 109.0 140.0 103.0 108.0 107.0 107.0 126.0 107.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 21:26:38 INFO - PROCESS | 1649 | Values: 185.0 187.0 186.0 185.0 185.0 183.0 183.0 185.0 186.0 183.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:73.30 Median:79.50 stddev:13.70 (17.2%) stddev-sans-first:14.16 21:26:38 INFO - PROCESS | 1649 | Values: 82.0 60.0 60.0 91.0 63.0 62.0 61.0 77.0 95.0 82.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:74.40 Median:75.00 stddev:8.26 (11.0%) stddev-sans-first:7.15 21:26:38 INFO - PROCESS | 1649 | Values: 88.0 69.0 84.0 68.0 69.0 68.0 81.0 67.0 68.0 82.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:89.00 stddev:13.99 (15.7%) stddev-sans-first:14.79 21:26:38 INFO - PROCESS | 1649 | Values: 98.0 133.0 97.0 89.0 89.0 87.0 89.0 88.0 89.0 88.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:26:38 INFO - PROCESS | 1649 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 96.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.17 (1.4%) stddev-sans-first:1.24 21:26:38 INFO - PROCESS | 1649 | Values: 84.0 83.0 83.0 85.0 83.0 82.0 82.0 84.0 85.0 85.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:62.50 stddev:10.65 (17.0%) stddev-sans-first:11.16 21:26:38 INFO - PROCESS | 1649 | Values: 62.0 61.0 62.0 60.0 63.0 62.0 60.0 69.0 75.0 94.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:58.50 stddev:7.34 (12.5%) stddev-sans-first:6.73 21:26:38 INFO - PROCESS | 1649 | Values: 49.0 65.0 77.0 60.0 60.0 57.0 57.0 57.0 56.0 57.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:1.60 (1.9%) stddev-sans-first:1.66 21:26:38 INFO - PROCESS | 1649 | Values: 83.0 81.0 81.0 84.0 83.0 84.0 79.0 83.0 81.0 82.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:144.00 stddev:19.20 (13.3%) stddev-sans-first:19.35 21:26:38 INFO - PROCESS | 1649 | Values: 128.0 133.0 138.0 134.0 150.0 125.0 140.0 148.0 186.0 169.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:2.21 (1.4%) stddev-sans-first:2.35 21:26:38 INFO - PROCESS | 1649 | Values: 162.0 162.0 167.0 162.0 160.0 164.0 159.0 161.0 163.0 163.0 21:26:38 INFO - PROCESS | 1649 | 21:26:38 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 21:26:38 INFO - PROCESS | 1649 | Values: 65.0 65.0 66.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 21:26:38 INFO - PROCESS | 1649 | -------- Summary: end -------- 21:26:38 INFO - PROCESS | 1649 | 21:26:39 INFO - TEST-INFO | 1649: exit 0 21:26:39 INFO - TEST-OK | kraken | took 58888ms 21:26:39 INFO - SUITE-END | took 1178s 21:26:39 INFO - Completed test suite (00:19:38) 21:26:39 INFO - javascript benchmark 21:26:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7864.264194934038, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.9999999999995, 3545.4681797730336, 3551.2719892422056, 3564.946525802112, 3606.098475381155, 5834.883302333961, 6083.878322433554, 6112.022076467766, 6140.662263575501, 6180.629162250269, 6084.3611420800735, 6099.0, 6150.0, 6154.723037463314, 6188.443040126388, 5449.073657478229, 5479.123340265558, 5491.862703432426, 5504.64219825712, 5645.689487078209, 5351.7056561889085, 5363.758630861601, 5398.973005134989, 5443.237946687467, 5601.411851755568, 5476.972615136919, 5484.561235101182, 5489.1217405215175, 5490.478404551562, 5493.807716729915, 5439.5104440600335, 5469.206964990054, 5475.479829416239, 5475.67145971239, 5480.342358916955, 5300.310959575269, 5419.105847535152, 5424.430434804328, 5429.511343979061, 5463.098588732854, 6031.215941927565, 6042.305134909498, 6050.8184754457, 6055.455009049163, 6065.666388348639, 6215.098810672473, 6234.719437625317, 6261.248650161964, 6264.21697287839, 6264.874702505925, 6305.968470157666, 6317.715702793339, 6441.935580644181, 6463.159789227418, 6475.125858009203, 6162.322144564095, 6204.751809927598, 6215.471684906744, 6223.471004964584, 6252.87494250117, 6290.591111577733, 6328.810135695937, 6660.2340730816095, 6682.231543372574, 6700.765473208512, 4828.583327440063, 6160.9383906161265, 6299.338569450233, 6313.43179113882, 6332.461740751995, 6360.9045864312075, 6405.9750439929385, 6464.612123272619, 6492.415682588589, 6509.121268628769, 6336.366363363719, 6346.460550853137, 6350.015747559136, 6356.951103068034, 6362.172917520693, 6374.298827129012, 6378.107065010902, 6390.392912673288, 6408.455281301049, 6420.5184611154355, 5090.312807770978, 5098.490150984946, 5102.056119617882, 5140.280360749498, 5170.689758614495, 3996.7002474814503, 4515.819367225275, 4623.491415944243, 4630.421197350332, 4646.976765116153, 6121.989871671124, 6146.661933593606, 6176.9073463897175, 6177.351378105324, 6181.96909015461, 6200.844978875564, 6241.313455519889, 6322.272938612026, 6480.870382592416, 6505.674716264168, 6000.249968753906, 6027.427394397525, 6046.606970546901, 6112.0, 6129.938700612936, 5707.229524014288, 5742.253507044057, 5746.942530574641, 5751.252337196138, 5756.7121643917635, 6643.46852251809, 6643.800685979429, 6646.700898459678, 6718.764843230463, 6724.731010759613, 6489.545731798728, 6525.216973962965, 6526.4452521536205, 6533.803985880431, 6535.379138981789, 6334.588251763621, 6402.551821372459, 6561.278259391559, 6570.77002304917, 6644.933550664625, 6347.17486726741, 6383.808485745435, 6415.166028416276, 6419.614823110628, 6432.195975503062, 6483.870322593616, 6488.70800813974, 6493.22081350241, 6495.1556297681, 6511.967440162769, 6212.81361559154, 6240.032794916795, 6247.562670613195, 6272.278687950944, 6308.526860485574, 4629.0, 5835.270591176103, 6240.719167637377, 6274.341194174546, 6305.2433707953505, 6165.876682466236, 6174.783882564088, 6257.7184026718, 6307.495400368051, 6348.619082855043, 5560.471755183251, 6166.660833654192, 6203.875922481435, 6233.283172435228, 6293.842653933688, 5720.685362305113, 5941.881162376641, 6160.0, 6244.1570387997035, 6270.341614130451], "value": 5916.227462300274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.5410826449996, 758.5638258001651, 831.5343407691693, 904.3127223310282, 908.4322298563397, 29345.85327073364, 41221.0, 41244.96887577812, 41870.11584478702, 41889.79055104728, 41772.37341439881, 42033.579664203346, 42060.57939420605, 42098.15803683932, 42111.57888421115, 9600.855987160216, 9753.0, 9757.609695612202, 9766.804663906718, 9791.167750741195, 7881.566513841736, 8000.559969201691, 11677.766444671102, 11836.585719499819, 12111.818322725167, 11853.881461185363, 11882.702932426671, 11899.821502677467, 11903.642890713249, 11953.22304050234, 11897.464614092343, 11924.0, 11933.985611223057, 11943.701407464796, 11946.701332466671, 9161.541922903894, 11485.483153258123, 11633.185677002613, 11647.010004149657, 11690.824637630443, 40538.59461405378, 40648.0, 40721.0, 40726.0, 40790.0, 4061.2689715851134, 4062.634362907323, 4065.1869626074904, 4084.7344922580232, 4092.9386059209137, 28148.577771333243, 28637.713622863714, 28712.856435717687, 29283.707162928524, 30236.0, 3101.705337992887, 3212.855421506038, 3220.130564747505, 3251.96748032519, 3363.83180840957, 340340.0, 344473.0, 345036.0, 345060.54939450783, 345541.0, 54601.0, 54720.0, 54744.0, 54808.72595636996, 54816.45183548193, 57053.42946570481, 57211.427885721445, 57373.71313143407, 57395.13907291394, 57480.0, 15237.238138093051, 15610.609734756721, 15611.141387223812, 15612.219389030502, 15619.14094724801, 13182.73634527304, 13189.076764626576, 13199.53801616958, 13215.405306761219, 13241.139325943783, 11210.495527701272, 11229.71925701864, 11380.658580242605, 11617.825732614017, 12680.873191268154, 5254.185601231815, 5378.97310513445, 5410.269613602192, 5417.51242388187, 5482.5613950883835, 1123.8314252862135, 1139.75495268516, 1148.6841118692425, 1151.6832870960386, 1168.6961390038482, 27205.2473680794, 27222.183334499998, 27705.584416233774, 27762.444751105268, 27838.86080569584, 1274.20362273579, 1278.2394475287374, 1280.295837289487, 1323.08706992177, 1333.8466076401144, 14313.85686143146, 14415.42338306477, 14472.986890917535, 14640.414383424757, 14647.633809154857, 460597.0, 460672.0, 461292.0, 461858.0, 462547.0, 58350.70824645935, 58540.707296463246, 58569.70715146397, 58589.41410585925, 58637.41362586405, 1457.140287230518, 1474.1670955909876, 1516.408600645749, 1519.1492764052166, 1521.5511424129909, 25715.0, 26567.7343226573, 27069.86465067662, 27196.864015679796, 27238.0, 48060.7596962013, 48164.5183548174, 48170.759146204044, 48270.517294826604, 48464.515354846, 411915.940420296, 412146.0, 412214.0, 412257.0, 413667.0, 29004.0, 36033.27933441264, 36056.098597535274, 36097.0, 36124.0, 37384.87845364644, 37843.62156378401, 37880.05299867525, 38361.0, 38680.2263954725, 27371.72628273692, 27385.863070684518, 27623.447531048863, 27688.0, 28398.29004274827, 27791.0, 28272.43455130927, 28384.71615283903, 28591.571126433537, 28710.282242944093, 31618.841905790323, 31744.36511269808, 32321.868734594176, 32605.673943260263, 32785.836070819496, 22859.542809144055, 25377.0, 27984.46085465319, 28047.859760701067, 28261.858690706416, 21411.143554257655, 21708.67436988478, 22213.77786222117, 22325.627690546306, 22470.438239044153], "value": 19038.294964340475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.35293442287457, 431.8790738593195, 442.1510699457043, 447.35357408544667, 450.4189595421906, 17607.735883961752, 21598.460038499026, 22786.65820012701, 23528.0, 23760.287191384243, 23049.76950230497, 23369.415764605852, 23718.407039824015, 23885.641715374284, 23921.282361529138, 5450.482204190595, 7020.368166864994, 7298.744543940963, 7314.561126332437, 7345.449091318173, 6652.700628471706, 6658.400743933045, 7122.928770712304, 7259.020032295652, 7269.3457588817, 7166.068411106575, 7166.8208294792785, 7179.533330333512, 7179.89230161548, 7187.496875218737, 6936.895946560806, 7091.645417729119, 7109.928900711005, 7131.393831524327, 7148.285171482836, 6635.203775546917, 6805.693743781541, 6913.516053876231, 6924.723011079551, 6961.686724097377, 26939.0, 26967.92128314865, 27054.0, 27210.727892721017, 27262.454750905068, 3025.5612936124357, 3066.0801759472292, 3192.0423872838055, 3237.7409807215604, 3261.6575259597876, 15860.0, 16383.83616163847, 16412.507624771275, 16422.917885410618, 17614.295428182857, 1898.7246849206927, 2065.524929266277, 2102.7897210279, 2116.7459904811367, 2145.6674215496623, 126861.0, 127008.0948785769, 129596.0, 131302.3434882829, 132103.33948330293, 15221.467248646244, 20300.79699202989, 20642.86464244451, 20812.43906707003, 21137.471563210736, 34821.651783482346, 35052.0, 35129.946101616995, 35187.0, 35260.47109293363, 11296.0, 11567.0, 11576.884231157748, 11585.189036767513, 11747.353895535827, 7275.854482910418, 9301.767455813524, 9445.14993650561, 9473.005334439922, 9649.228061755042, 8171.63227654757, 8547.0, 10493.737656558647, 10520.473976301155, 10526.31578947366, 4270.7864606769535, 4302.827886884552, 4309.1381723655395, 4334.783260836945, 4359.498657654347, 1063.5161001744189, 1077.8922107789158, 1079.5681727309138, 1090.7273181704575, 1128.6388355726253, 22557.0, 22756.886215568815, 22925.426864328525, 22974.195903143645, 22994.42513937165, 941.6327632223438, 968.3947532792005, 1066.157735389034, 1104.6685994201707, 1106.6016234155697, 11237.83143252852, 11256.718582035515, 11920.403979800974, 12143.14997950135, 12148.5140594377, 736945.0, 751963.0, 776082.0, 778713.0, 795225.047749515, 70677.0, 94701.0, 115043.0, 156090.99999999773, 156874.0, 1393.4286942353585, 1419.6237996930822, 1449.2753623188405, 1449.8405175430694, 1454.4763885001391, 12819.42312595954, 19340.292359070023, 21364.679529807378, 21973.450663732896, 22065.0, 55121.724391377786, 64807.67596161989, 66636.0, 67073.66463167653, 68754.9686754689, 60467.09299360601, 91129.54435227781, 91397.17205655716, 91480.54259728659, 91875.0, 9937.602495900372, 11740.41297935117, 11836.408179591159, 12015.579454719043, 12245.938770306448, 11312.886871131512, 13463.394147263592, 13470.124441911245, 13494.460221591418, 13818.239996800272, 11327.602106077178, 11722.94138529336, 11869.76260474803, 11962.102842287037, 11962.700932476757, 8718.869216961877, 10711.464426778786, 10731.463426828783, 11004.889951100387, 11006.504707288032, 11669.416529173677, 11735.0, 11740.823887641864, 11798.823017654913, 11821.172517923662, 11815.527378904748, 11931.0, 12123.575674851338, 12139.0, 12163.331016794162, 11297.096232301561, 11549.422528873354, 11763.0, 11765.88234117682, 11966.46150923228], "value": 11918.133968879505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1623.1478473801253, 1628.259142090349, 1659.684659914616, 1661.9418320358782, 1671.4901954903753, 11272.985431311181, 12045.879541204586, 12050.879491205085, 12058.819117713241, 12064.939675301623, 11220.775584488305, 11675.41622918855, 11790.705232369173, 11806.173567850254, 11815.291082535054, 2464.593342098556, 2509.987450062747, 2510.786583140435, 2513.7988960883085, 2516.0564788204424, 2443.1937460637946, 2457.2628211536467, 2488.8880000400027, 2491.626256061596, 2499.2252401755422, 2411.6623672685837, 2434.0, 2459.5449841779237, 2461.618449140386, 2466.7533246675366, 2291.988540057289, 2414.6619473273754, 2414.8551086934754, 2433.6227884677905, 2464.7904928081134, 2327.0924339507606, 2351.870647114408, 2359.6814430051895, 2360.1031607989025, 2361.1027809432476, 11198.720031999184, 11450.541978320856, 11455.427228638535, 11462.885371146265, 11471.13966452511, 5838.532917366643, 6016.398360163992, 6030.547708921805, 6033.758649654009, 6037.577369584131, 3459.1697992481877, 3574.035010547164, 3654.397024490956, 3673.4673472346362, 3716.0338312038793, 998.9850152247722, 1109.3343993603853, 1216.6471723200261, 1264.3109505319624, 1281.7246839394768, 13967.37146828395, 14085.64785880351, 14438.566842994727, 15200.0, 16260.186990650538, 4071.7353372030725, 4794.880127996828, 4917.164082106051, 4920.75396230187, 4922.458529561745, 12397.75204495923, 12420.00639948802, 12428.254304741744, 12440.00479961619, 12441.0, 5115.0, 5305.628605997543, 5328.866778330573, 5333.439988801198, 6049.364816694272, 4822.324874517571, 5311.309529761106, 5522.144067669437, 5542.445755424506, 5553.611247212656, 3961.5840336764227, 4038.596140385938, 4107.835686572504, 4126.649234815074, 4137.234611596804, 1035.4512108582464, 1053.1890444357803, 1061.6125114333213, 1071.2982996137541, 1071.3250652089134, 940.3370623710268, 966.9854952175723, 988.4020167798523, 988.6094992478074, 1022.6318525330875, 6725.932740672629, 6749.493787965824, 6847.452203823682, 6871.862562748717, 6907.7236910524025, 993.9900600993898, 997.8203923293731, 1026.38416949831, 1036.9740756480996, 1074.6937122920087, 4255.0, 4313.094250207429, 4324.978375108104, 4426.114777044604, 4446.466424029137, 14215.289235538181, 14901.0, 14910.478133265284, 14931.029483083565, 14939.477118300807, 13327.66680832987, 13676.452941882213, 14285.714285714228, 14300.284985750672, 14317.57047288583, 10271.178305735522, 10631.46842657864, 10778.4071876046, 10797.35215887065, 10827.837582436112, 6960.269171736894, 6966.0, 6988.580685158907, 7132.607706576188, 7170.856582868209, 12631.684207894876, 12891.935540322238, 12902.290374029519, 13066.0, 13081.280529570964, 13148.868511315148, 13296.202227866359, 13313.400896959854, 13437.260950647807, 13544.187348759106, 9163.35856490066, 9488.95255523718, 9546.761330966781, 9554.665586704432, 9558.0, 10432.321899076536, 10515.579376825148, 10588.894111058791, 10622.681319560426, 10702.304350217211, 7531.322181003736, 7784.2215778421705, 8934.508602026692, 9090.181883630505, 9169.954150229207, 8728.127187281221, 8815.471071735716, 8864.86702699447, 8874.733757987271, 8911.2425443838, 7590.316871481593, 7746.147923728273, 7916.247956444128, 8073.798155046171, 8175.550344730859, 5823.621464604787, 5892.998190307572, 5951.137085122719, 5969.52243820502, 6080.148779170831, 5768.134779783066, 5995.790147344822, 6022.277326720647, 6024.518038556817, 6067.936901453527], "value": 5281.783919032799, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3280095827511, 387.4362802122911, 389.6356906292615, 395.693337663311, 396.2372433066348, 4348.956510434895, 4467.4862390825065, 4585.3580498730125, 5012.974935125324, 5109.897802043962, 4086.734362266458, 4780.330753694477, 4791.257355109955, 4828.97585512072, 4839.274108883669, 3477.6263375966605, 3563.6280032187665, 3929.879984204488, 3947.250022495731, 4125.814338354774, 3844.404572102574, 3895.5130608673917, 4118.608732170439, 4134.338505839067, 4159.854405095823, 3939.5863434339412, 4237.6821738369745, 4273.829046838123, 4295.957040429603, 4303.24693178694, 3694.7783133012103, 4095.877123686294, 4185.053949913275, 4289.935650965253, 4304.784760761965, 3702.7037836972977, 3773.962260377416, 3898.8440462381473, 4039.929418704046, 4104.56902025289, 4180.216903702154, 4800.359802108826, 4811.639127065484, 4827.599996001156, 4834.20235661119, 4110.815013324408, 4295.742255464682, 4806.770042362733, 4832.879178020543, 4990.629451010777, 4704.0, 5250.396204436501, 5270.521455839166, 5302.814401495929, 5330.546903513206, 3828.444875493066, 4098.672106231495, 4616.5152658970665, 4630.004549021943, 4661.696989695659, 4295.548967358445, 4719.59883409914, 5489.890202196014, 5544.362398324163, 5576.525995290364, 4015.598440155961, 4115.9176816463505, 4258.5954334338185, 4731.645126615517, 4744.5492678195515, 4836.0, 4844.806207751721, 4862.513748625109, 4880.6095512358925, 4899.975500122548, 4504.198320671758, 4597.7241365518175, 4910.680805747615, 4992.354052352259, 5048.3184770056305, 4501.639868810487, 4587.977060114745, 5115.851342436112, 5208.427073021964, 5216.895662086737, 1455.4281376113772, 1504.6163228376695, 1582.6705567323504, 1629.9022058676517, 1638.500257421498, 1207.8067509198486, 1275.596843472173, 1279.1749321687646, 1298.104308027458, 1339.4776037345443, 4377.627901628333, 4626.259798432302, 4683.5082316356975, 4811.254255590389, 4958.529029679239, 4746.359241502353, 5023.723695196799, 5179.533841954167, 5388.946110538923, 5394.408649448422, 4496.505384407713, 4557.339185818038, 4875.220544501231, 4925.0, 4928.6303527235605, 2462.692163479565, 2483.3543278747293, 2811.831290122558, 2840.1621521651164, 2847.900323488668, 5094.388673359221, 5137.743112844343, 5397.247403824, 5513.889722205614, 5560.609847538116, 5253.975474782381, 5318.016167009038, 5492.890142197134, 5531.585131115102, 5588.674738530568, 5238.266642670029, 5450.781968721365, 5483.451654834565, 5606.495415412551, 5622.803201887832, 4796.37647105874, 5054.620903432184, 5130.050940576006, 5164.173732202829, 5354.544863686475, 4914.655974081923, 5146.459621739813, 5153.45888681683, 5169.327987361619, 5337.759800809051, 4524.479684836154, 4749.976250118727, 4989.575886049582, 5212.848838370607, 5582.7766889323975, 4481.843135490242, 4744.4069491313585, 4744.92882606768, 4809.038192361471, 4829.468758436639, 4448.021435284232, 5025.96967621644, 5399.514043736082, 5456.427075157051, 5468.835934921959, 4897.706137631753, 5269.367675878919, 5278.419373868948, 5278.865044015555, 5299.523042926001, 4859.663592512087, 4905.215165573634, 5277.709725965109, 5300.734963251899, 5349.732513374393, 4581.67928245033, 5156.56169225605, 5172.301739265151, 5215.478452154754, 5269.894602108013, 4534.478534968521, 5013.470891378165, 5149.510796474329, 5237.292965449616, 5297.496737809902, 4540.0, 4677.649176311722, 4970.850874473772, 5166.844994650167, 5205.791768329376], "value": 4103.684372114679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.4802704228729, 817.9672813087473, 832.5296207642685, 884.5533005832056, 889.8264838356521, 15532.378704851806, 17384.391546295883, 17422.128893555335, 17449.651006979868, 17472.737908931376, 16082.437114700988, 16274.104924229192, 16292.511224663249, 16328.83671163288, 16339.754903676454, 971.7959228562011, 974.0648976982105, 978.9559469823876, 980.2550061952932, 980.4215512847419, 995.3231802374382, 998.0967224661692, 1009.6213919780082, 1015.5836107196051, 1032.2877214721855, 1067.871855377352, 1069.3797597393532, 1069.4813015687425, 1069.5775168808354, 1069.9090577300938, 1061.389700921973, 1064.106150833296, 1064.3986147826454, 1066.0831684751147, 1069.4652673663168, 791.3748138970207, 791.4934441957153, 793.3415265329762, 794.7178751543235, 795.9084705258854, 17299.913500432544, 17315.65368692632, 17362.0, 17964.91017544904, 18216.998065106545, 14472.565823025327, 14803.481878134322, 14830.406783728638, 14883.925580372137, 15139.091654500655, 11651.452447472402, 12038.217515861441, 12084.093692972974, 12468.376581170905, 12742.044346674036, 3560.537130173087, 3775.5846856845724, 3870.1872606752618, 3872.283627528916, 4040.7575545467366, 116938.0, 119337.0, 119581.99999999913, 121592.0, 121758.0, 11426.371549564687, 11453.370064646524, 11539.846015398562, 11605.477753501113, 11656.766864662659, 23612.17357392483, 23812.523749524913, 24165.879170604036, 24173.395665108514, 24218.63672044921, 8144.877826832602, 8166.060902996232, 8171.7548473545885, 8194.918050819415, 8354.331653467709, 4576.679632425765, 4659.301104834234, 4660.067986402733, 4737.905241895142, 4749.928751068736, 3622.6558476944647, 3719.683826874692, 3730.0, 3735.3089678409583, 3736.9065773355883, 630.5775130662468, 667.8163505036154, 674.0428591400223, 680.2177495879778, 684.8904175331922, 665.8871559087622, 691.3432239372617, 736.6316841579211, 749.4266885832343, 758.8671982403167, 9886.80226395468, 10655.413952232702, 10712.625058123083, 10747.946260268805, 10960.945195273973, 682.3551743602249, 712.7861641507527, 727.4107972542258, 737.3363972424753, 737.4505993035223, 4611.608013318838, 5219.530242278213, 5232.633715639869, 5247.921281180786, 5264.289320941701, 106544.0, 108041.0, 109916.0, 110020.0, 112110.43944780224, 92645.61031584532, 92705.0, 95120.0, 96514.0348596519, 96717.0, 78262.6086869562, 79722.60138699385, 81325.59337203513, 82223.5888820552, 83039.58480207682, 9579.0, 10262.230332725225, 10298.3820970739, 10306.793864122526, 10332.380057196593, 38560.0, 49750.502494974586, 51408.48591514037, 51749.0, 52406.0, 64979.0, 66502.66748666226, 66726.66636666785, 67050.3294967044, 74112.0, 12803.10378273512, 14986.850131498546, 15124.243787810785, 15202.239888005335, 15315.923420382827, 14728.0, 15012.699746005237, 15598.844011559739, 16036.599085022968, 16778.664426711643, 13893.305334733424, 14700.632484187981, 14920.701585968003, 15268.3892644293, 15332.540023799304, 14243.928780356031, 15074.895146794575, 15530.607456807975, 15539.766903496231, 15618.531444056242, 13847.099938503965, 13865.514706985206, 14253.073550219202, 14419.42322307096, 14888.478903238334, 9939.304248702521, 10022.649207277711, 10186.74533136648, 10252.743681408025, 10586.206034547286, 11662.300261984308, 11849.822252666045, 11955.109627645712, 12326.81509777336, 12338.50645974151], "value": 8129.61596813546, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 115.0, 115.0, 114.0, 115.0, 113.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 109.0, 140.0, 103.0, 108.0, 107.0, 107.0, 126.0, 107.0], "value": 115.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 186.0, 185.0, 185.0, 183.0, 183.0, 185.0, 186.0, 183.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 60.0, 91.0, 63.0, 62.0, 61.0, 77.0, 95.0, 82.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 84.0, 68.0, 69.0, 68.0, 81.0, 67.0, 68.0, 82.0], "value": 74.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 133.0, 97.0, 89.0, 89.0, 87.0, 89.0, 88.0, 89.0, 88.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 85.0, 83.0, 82.0, 82.0, 84.0, 85.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 60.0, 63.0, 62.0, 60.0, 69.0, 75.0, 94.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 65.0, 77.0, 60.0, 60.0, 57.0, 57.0, 57.0, 56.0, 57.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 84.0, 83.0, 84.0, 79.0, 83.0, 81.0, 82.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 138.0, 134.0, 150.0, 125.0, 140.0, 148.0, 186.0, 169.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 162.0, 160.0, 164.0, 159.0, 161.0, 163.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 64.1, "unit": "score"}]}]} 21:26:39 INFO - Return code: 0 21:26:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:26:39 INFO - # TBPL SUCCESS # 21:26:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:26:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:26:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:26:39 INFO - 2017-05-03 21:26:39.929 screenresolution[1653:9787] starting screenresolution argv=screenresolution get 21:26:39 INFO - 2017-05-03 21:26:39.931 screenresolution[1653:9787] Display 0: 1600x1200x32@60 21:26:39 INFO - 2017-05-03 21:26:39.937 screenresolution[1654:9790] starting screenresolution argv=screenresolution list 21:26:39 INFO - Available Modes on Display 0 21:26:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:26:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:26:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:26:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:26:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:26:40 INFO - Intel Iris: 21:26:40 INFO - Chipset Model: Intel Iris 21:26:40 INFO - Type: GPU 21:26:40 INFO - Bus: Built-In 21:26:40 INFO - VRAM (Dynamic, Max): 1536 MB 21:26:40 INFO - Vendor: Intel (0x8086) 21:26:40 INFO - Device ID: 0x0a2e 21:26:40 INFO - Revision ID: 0x0009 21:26:40 INFO - Displays: 21:26:40 INFO - Display: 21:26:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:26:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:26:40 INFO - Display Serial Number: 1600x1200 60 21:26:40 INFO - Main Display: Yes 21:26:40 INFO - Mirror: Off 21:26:40 INFO - Online: Yes 21:26:40 INFO - Rotation: Supported 21:26:40 INFO - Return code: 0 21:26:40 INFO - Running post-action listener: _resource_record_post_action 21:26:40 INFO - [mozharness: 2017-05-04 04:26:40.176065Z] Finished run-tests step (success) 21:26:40 INFO - Running post-run listener: _resource_record_post_run 21:26:40 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 50841600; Write bytes: 432387584; Read time: 567; Write time: 1833 21:26:40 INFO - TinderboxPrint: CPU usage
53.9% 21:26:40 INFO - TinderboxPrint: I/O read bytes / time
50,841,600 / 567 21:26:40 INFO - TinderboxPrint: I/O write bytes / time
432,387,584 / 1,833 21:26:40 INFO - TinderboxPrint: CPU idle
2,201.7 (46.1%) 21:26:40 INFO - TinderboxPrint: CPU system
954.5 (20.0%) 21:26:40 INFO - TinderboxPrint: CPU user
1,621.4 (33.9%) 21:26:40 INFO - TinderboxPrint: Swap in / out
165,720,064 / 0 21:26:40 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122980864; Write bytes: 122621952; Read time: 11074; Write time: 257 21:26:40 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 45885440; Write bytes: 308221440; Read time: 534; Write time: 1569 21:26:40 INFO - Running post-run listener: _upload_blobber_files 21:26:40 INFO - Blob upload gear active. 21:26:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:26:40 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 21:26:40 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'] 21:26:40 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 21:26:41 INFO - (blobuploader) - INFO - Open directory for files ... 21:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:41 INFO - (blobuploader) - INFO - Done attempting. 21:26:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:26:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:26:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:42 INFO - (blobuploader) - INFO - Done attempting. 21:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:43 INFO - (blobuploader) - INFO - Done attempting. 21:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:26:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:45 INFO - (blobuploader) - INFO - Done attempting. 21:26:45 INFO - (blobuploader) - INFO - Iteration through files over. 21:26:45 INFO - Return code: 0 21:26:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:26:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:26:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e70f73c9c7a89ae85145d0aa0801a178cfa7dbd53843dc49ac51f5dc8f664c771453b0ec267d018af4a536bb689cea4787737366c8a8855b85b07eba7b4acde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cc7a0b628665e7f043dda47f63947c7b938d92002b57371e09460b0cccb2cd72b80eb72c5cb916982a37dcbc1dfcb1c1cad9c70395e2d044d200f7de5a1fcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b00aee4f61641217046113aa52c9111b018ce1b0cb4b681d4f4964bd976398130a3464b49d5397600bebc77c76f427541925dafd7dc09890d5e651a4f44aeed7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a974288bf2a3a06830164787fd0332e7cf82b9ba24e958e94d543aa39ce02569388acadf855842a0605e25c0cf7fff6317bb900e87aaeac3937411d0c070c8"} 21:26:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:26:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:26:45 INFO - Contents: 21:26:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e70f73c9c7a89ae85145d0aa0801a178cfa7dbd53843dc49ac51f5dc8f664c771453b0ec267d018af4a536bb689cea4787737366c8a8855b85b07eba7b4acde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cc7a0b628665e7f043dda47f63947c7b938d92002b57371e09460b0cccb2cd72b80eb72c5cb916982a37dcbc1dfcb1c1cad9c70395e2d044d200f7de5a1fcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b00aee4f61641217046113aa52c9111b018ce1b0cb4b681d4f4964bd976398130a3464b49d5397600bebc77c76f427541925dafd7dc09890d5e651a4f44aeed7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a974288bf2a3a06830164787fd0332e7cf82b9ba24e958e94d543aa39ce02569388acadf855842a0605e25c0cf7fff6317bb900e87aaeac3937411d0c070c8"} 21:26:45 INFO - Running post-run listener: copy_logs_to_upload_dir 21:26:45 INFO - Copying logs to upload dir... 21:26:45 INFO - mkdir: /builds/slave/test/build/upload/logs 21:26:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.778216 ========= master_lag: -0.43 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-03 21:26:45.571095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:26:45.574240) ========= 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.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e70f73c9c7a89ae85145d0aa0801a178cfa7dbd53843dc49ac51f5dc8f664c771453b0ec267d018af4a536bb689cea4787737366c8a8855b85b07eba7b4acde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cc7a0b628665e7f043dda47f63947c7b938d92002b57371e09460b0cccb2cd72b80eb72c5cb916982a37dcbc1dfcb1c1cad9c70395e2d044d200f7de5a1fcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b00aee4f61641217046113aa52c9111b018ce1b0cb4b681d4f4964bd976398130a3464b49d5397600bebc77c76f427541925dafd7dc09890d5e651a4f44aeed7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a974288bf2a3a06830164787fd0332e7cf82b9ba24e958e94d543aa39ce02569388acadf855842a0605e25c0cf7fff6317bb900e87aaeac3937411d0c070c8"} build_url:https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/TU338oDtRSKc1hefJu5vFw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e70f73c9c7a89ae85145d0aa0801a178cfa7dbd53843dc49ac51f5dc8f664c771453b0ec267d018af4a536bb689cea4787737366c8a8855b85b07eba7b4acde", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cc7a0b628665e7f043dda47f63947c7b938d92002b57371e09460b0cccb2cd72b80eb72c5cb916982a37dcbc1dfcb1c1cad9c70395e2d044d200f7de5a1fcac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b00aee4f61641217046113aa52c9111b018ce1b0cb4b681d4f4964bd976398130a3464b49d5397600bebc77c76f427541925dafd7dc09890d5e651a4f44aeed7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a974288bf2a3a06830164787fd0332e7cf82b9ba24e958e94d543aa39ce02569388acadf855842a0605e25c0cf7fff6317bb900e87aaeac3937411d0c070c8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 21:26:45.608746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:26:45.609138) ========= 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.bcpmkD1C12/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.eG1eR63H0f/Listeners TMPDIR=/var/folders/9r/dqqyy7gj0jq4nplzz_zpf1hm00000w/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.004496 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 21:26:45.656626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:26:45.657023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 21:26:45.657325) ========= ========= Total master_lag: -0.28 =========