builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0353 starttime: 1493131321.5 results: success (0) buildid: 20170425054225 builduid: c62c673659dd4973aabc476cb252e828 revision: 8619db383886e1237486792ff33d5eb331cdec7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.499425) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.499851) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.500136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.528127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.528453) ========= 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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-25 07:42:01-- 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% 18.1M=0.001s 2017-04-25 07:42:01 (18.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158721 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.720345) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.720699) ========= 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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.026902 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.770618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:01.770964) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8619db383886e1237486792ff33d5eb331cdec7d --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 8619db383886e1237486792ff33d5eb331cdec7d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-25 07:42:01,879 truncating revision to first 12 chars 2017-04-25 07:42:01,879 Setting DEBUG logging. 2017-04-25 07:42:01,879 attempt 1/10 2017-04-25 07:42:01,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8619db383886?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 07:42:02,530 unpacking tar archive at: mozilla-beta-8619db383886/testing/mozharness/ program finished with exit code 0 elapsedTime=0.926260 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:02.721302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:02.721626) ========= script_repo_revision: 8619db383886e1237486792ff33d5eb331cdec7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:02.722012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:02.722293) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 07:42:02.742536) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 07:42:02.742927) ========= /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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:42:02 INFO - MultiFileLogger online at 20170425 07:42:02 in /builds/slave/test 07:42:02 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 07:42:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:02 INFO - {'append_to_log': False, 07:42:02 INFO - 'base_work_dir': '/builds/slave/test', 07:42:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:42:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:02 INFO - 'branch': 'Mozilla-Beta', 07:42:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:02 INFO - 'config_files': ('talos/mac_config.py',), 07:42:02 INFO - 'default_actions': ('clobber', 07:42:02 INFO - 'read-buildbot-config', 07:42:02 INFO - 'download-and-extract', 07:42:02 INFO - 'populate-webroot', 07:42:02 INFO - 'create-virtualenv', 07:42:02 INFO - 'install', 07:42:02 INFO - 'run-tests'), 07:42:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:02 INFO - 'download_minidump_stackwalk': True, 07:42:02 INFO - 'download_symbols': 'ondemand', 07:42:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:02 INFO - 'gecko_profile': False, 07:42:02 INFO - 'gecko_profile_interval': 0, 07:42:02 INFO - 'installer_path': 'installer.exe', 07:42:02 INFO - 'log_level': 'info', 07:42:02 INFO - 'log_name': 'talos', 07:42:02 INFO - 'log_to_console': True, 07:42:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:42:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:42:02 INFO - 'opt_config_files': (), 07:42:02 INFO - 'pip_index': False, 07:42:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:02 INFO - 'cmd': ('bash', 07:42:02 INFO - '-c', 07:42:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:02 INFO - 'enabled': True, 07:42:02 INFO - 'halt_on_failure': False, 07:42:02 INFO - 'name': 'check_screen_resolution'},), 07:42:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:02 INFO - 'cmd': ('bash', 07:42:02 INFO - '-c', 07:42:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:02 INFO - 'enabled': True, 07:42:02 INFO - 'halt_on_failure': False, 07:42:02 INFO - 'name': 'check_screen_resolution'},), 07:42:02 INFO - 'run_cmd_checks_enabled': True, 07:42:02 INFO - 'suite': 'dromaeojs', 07:42:02 INFO - 'system_bits': '32', 07:42:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:02 INFO - 'title': 't-yosemite-r7-0353', 07:42:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:02 INFO - 'use_talos_json': True, 07:42:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:02 INFO - 'work_dir': 'build'} 07:42:02 INFO - [mozharness: 2017-04-25 14:42:02.957552Z] Running clobber step. 07:42:02 INFO - Running pre-action listener: _resource_record_pre_action 07:42:02 INFO - Running main action method: clobber 07:42:02 INFO - rmtree: /builds/slave/test/build 07:42:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:05 INFO - Running post-action listener: _resource_record_post_action 07:42:05 INFO - [mozharness: 2017-04-25 14:42:05.417491Z] Finished clobber step (success) 07:42:05 INFO - [mozharness: 2017-04-25 14:42:05.417717Z] Running read-buildbot-config step. 07:42:05 INFO - Running pre-action listener: _resource_record_pre_action 07:42:05 INFO - Running main action method: read_buildbot_config 07:42:05 INFO - Using buildbot properties: 07:42:05 INFO - { 07:42:05 INFO - "project": "", 07:42:05 INFO - "product": "firefox", 07:42:05 INFO - "script_repo_revision": "production", 07:42:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:42:05 INFO - "repository": "", 07:42:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:42:05 INFO - "buildid": "20170425054225", 07:42:05 INFO - "pgo_build": "False", 07:42:05 INFO - "basedir": "/builds/slave/test", 07:42:05 INFO - "buildnumber": 7, 07:42:05 INFO - "slavename": "t-yosemite-r7-0353", 07:42:05 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 07:42:05 INFO - "platform": "yosemite_r7", 07:42:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:42:05 INFO - "branch": "mozilla-beta", 07:42:05 INFO - "repo_path": "releases/mozilla-beta", 07:42:05 INFO - "revision": "8619db383886e1237486792ff33d5eb331cdec7d", 07:42:05 INFO - "stage_platform": "macosx64", 07:42:05 INFO - "builduid": "c62c673659dd4973aabc476cb252e828", 07:42:05 INFO - "slavebuilddir": "test" 07:42:05 INFO - } 07:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:42:05 INFO - Running post-action listener: _resource_record_post_action 07:42:05 INFO - [mozharness: 2017-04-25 14:42:05.423520Z] Finished read-buildbot-config step (success) 07:42:05 INFO - [mozharness: 2017-04-25 14:42:05.423723Z] Running download-and-extract step. 07:42:05 INFO - Running pre-action listener: _resource_record_pre_action 07:42:05 INFO - Running main action method: download_and_extract 07:42:05 INFO - mkdir: /builds/slave/test/build/tests 07:42:05 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')]} 07:42:05 INFO - trying https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/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 07:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/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 07:42:06 INFO - Downloaded 1165 bytes. 07:42:06 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:42:06 INFO - Using the following test package requirements: 07:42:06 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:42:06 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:42:06 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:42:06 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:42:06 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:42:06 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:42:06 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:42:06 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:42:06 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:42:06 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:42:06 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:42:06 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:42:08 INFO - Expected file size: 51221600 07:42:08 INFO - Obtained file size: 51221600 07:42:24 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 07:42:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:42:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:42:24 INFO - Fetch https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:42:26 INFO - Expected file size: 51221600 07:42:26 INFO - Obtained file size: 51221600 07:42:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:42:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:42:40 INFO - Fetch https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:42:42 INFO - Expected file size: 14404449 07:42:42 INFO - Obtained file size: 14404449 07:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:42 INFO - trying https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:42:42 INFO - Downloading https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/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 07:42:44 INFO - Downloaded 59534070 bytes. 07:42:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:42:44 INFO - mkdir: /builds/slave/test/properties 07:42:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:44 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:44 INFO - Contents: 07:42:44 INFO - build_url:https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:42:45 INFO - Running post-action listener: _resource_record_post_action 07:42:45 INFO - Running post-action listener: set_extra_try_arguments 07:42:45 INFO - [mozharness: 2017-04-25 14:42:45.298453Z] Finished download-and-extract step (success) 07:42:45 INFO - [mozharness: 2017-04-25 14:42:45.298562Z] Running populate-webroot step. 07:42:45 INFO - Running pre-action listener: _resource_record_pre_action 07:42:45 INFO - Running main action method: populate_webroot 07:42:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:42:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:42:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:42:45 INFO - '--tppagecycles', 07:42:45 INFO - '7'], 07:42:45 INFO - 'tests': ['tsvgm']}}, 07:42:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:42:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:42:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:42:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:42:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['damp', 'tps']}, 07:42:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'tests': ['damp', 'tps']}, 07:42:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['dromaeo_dom']}, 07:42:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:42:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['basic_compositor_video']}, 07:42:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:42:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'other-e10s': {'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['a11yr', 07:42:45 INFO - 'ts_paint', 07:42:45 INFO - 'tpaint', 07:42:45 INFO - 'sessionrestore', 07:42:45 INFO - 'sessionrestore_no_auto_restore', 07:42:45 INFO - 'tabpaint']}, 07:42:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['tsvgx', 07:42:45 INFO - 'tsvgr_opacity', 07:42:45 INFO - 'tart', 07:42:45 INFO - 'tscrollx', 07:42:45 INFO - 'cart', 07:42:45 INFO - 'tsvg_static']}, 07:42:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:42:45 INFO - 'tsvgr_opacity', 07:42:45 INFO - 'tart', 07:42:45 INFO - 'tscrollx', 07:42:45 INFO - 'cart', 07:42:45 INFO - 'tsvg_static']}, 07:42:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'talos_options': ['--disable-e10s'], 07:42:45 INFO - 'tests': ['tp5o']}, 07:42:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:42:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'talos_options': ['--disable-e10s', 07:42:45 INFO - '--xperf_path', 07:42:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:45 INFO - 'tests': ['tp5n']}, 07:42:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:42:45 INFO - 'talos_options': ['--xperf_path', 07:42:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:45 INFO - 'tests': ['tp5n']}}, 07:42:45 INFO - 'talos.zip': {'path': '', 07:42:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:42:45 INFO - Running post-action listener: _resource_record_post_action 07:42:45 INFO - [mozharness: 2017-04-25 14:42:45.317058Z] Finished populate-webroot step (success) 07:42:45 INFO - [mozharness: 2017-04-25 14:42:45.317180Z] Running create-virtualenv step. 07:42:45 INFO - Running pre-action listener: _resource_record_pre_action 07:42:45 INFO - Running main action method: create_virtualenv 07:42:45 INFO - Creating virtualenv /builds/slave/test/build/venv 07:42:45 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 07:42:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:42:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:42:45 INFO - Using real prefix '/tools/python27' 07:42:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:42:46 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:49 INFO - Installing pip.................done. 07:42:49 INFO - Return code: 0 07:42:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:42:49 INFO - Reading from file tmpfile_stdout 07:42:49 INFO - Output received: 07:42:49 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) 07:42:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:49 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')]} 07:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 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')]} 07:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:42:49 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 07:42:49 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 07:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:49 INFO - 'HOME': '/Users/cltbld', 07:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:49 INFO - 'LOGNAME': 'cltbld', 07:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:49 INFO - 'MOZ_NO_REMOTE': '1', 07:42:49 INFO - 'NO_EM_RESTART': '1', 07:42:49 INFO - 'PAGER': '/bin/cat', 07:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:49 INFO - 'PWD': '/builds/slave/test', 07:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:49 INFO - 'SHELL': '/bin/bash', 07:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:42:49 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:49 INFO - 'USER': 'cltbld', 07:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:49 INFO - 'XPC_FLAGS': '0x0', 07:42:49 INFO - 'XPC_SERVICE_NAME': '0', 07:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:49 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 07:42:49 INFO - Cleaning up... 07:42:49 INFO - Return code: 0 07:42:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:42:49 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')]} 07:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 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')]} 07:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:49 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:42:49 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 07:42:49 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 07:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:49 INFO - 'HOME': '/Users/cltbld', 07:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:49 INFO - 'LOGNAME': 'cltbld', 07:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:49 INFO - 'MOZ_NO_REMOTE': '1', 07:42:49 INFO - 'NO_EM_RESTART': '1', 07:42:49 INFO - 'PAGER': '/bin/cat', 07:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:49 INFO - 'PWD': '/builds/slave/test', 07:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:49 INFO - 'SHELL': '/bin/bash', 07:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:42:49 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:49 INFO - 'USER': 'cltbld', 07:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:49 INFO - 'XPC_FLAGS': '0x0', 07:42:49 INFO - 'XPC_SERVICE_NAME': '0', 07:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:49 INFO - Downloading/unpacking psutil>=3.1.1 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:49 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 07:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:53 INFO - Installing collected packages: psutil 07:42:53 INFO - Running setup.py install for psutil 07:42:53 INFO - building 'psutil._psutil_osx' extension 07:42:53 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 07:42:53 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 07:42:54 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 07:42:54 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 07:42:54 INFO - building 'psutil._psutil_posix' extension 07:42:54 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 07:42:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:42:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:42:54 INFO - ^ 07:42:54 INFO - 1 warning generated. 07:42:54 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 07:42:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:54 INFO - Successfully installed psutil 07:42:54 INFO - Cleaning up... 07:42:54 INFO - Return code: 0 07:42:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:54 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:42:54 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 07:42:54 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 07:42:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:42:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:54 INFO - 'HOME': '/Users/cltbld', 07:42:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:54 INFO - 'LOGNAME': 'cltbld', 07:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:54 INFO - 'MOZ_NO_REMOTE': '1', 07:42:54 INFO - 'NO_EM_RESTART': '1', 07:42:54 INFO - 'PAGER': '/bin/cat', 07:42:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:54 INFO - 'PWD': '/builds/slave/test', 07:42:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:54 INFO - 'SHELL': '/bin/bash', 07:42:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:42:54 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:42:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:54 INFO - 'USER': 'cltbld', 07:42:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:54 INFO - 'XPC_FLAGS': '0x0', 07:42:54 INFO - 'XPC_SERVICE_NAME': '0', 07:42:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:42:54 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 07:42:54 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 07:42:54 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 07:42:54 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 07:42:54 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 07:42:54 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 07:42:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:57 INFO - Installing collected packages: mozsystemmonitor 07:42:57 INFO - Running setup.py install for mozsystemmonitor 07:42:57 INFO - Successfully installed mozsystemmonitor 07:42:57 INFO - Cleaning up... 07:42:57 INFO - Return code: 0 07:42:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:58 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:42:58 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 07:42:58 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 07:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:58 INFO - 'HOME': '/Users/cltbld', 07:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:58 INFO - 'LOGNAME': 'cltbld', 07:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:58 INFO - 'MOZ_NO_REMOTE': '1', 07:42:58 INFO - 'NO_EM_RESTART': '1', 07:42:58 INFO - 'PAGER': '/bin/cat', 07:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:58 INFO - 'PWD': '/builds/slave/test', 07:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:58 INFO - 'SHELL': '/bin/bash', 07:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:42:58 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:58 INFO - 'USER': 'cltbld', 07:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:58 INFO - 'XPC_FLAGS': '0x0', 07:42:58 INFO - 'XPC_SERVICE_NAME': '0', 07:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:58 INFO - Downloading/unpacking jsonschema==2.5.1 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:42:58 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 07:43:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 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 07:43:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:02 INFO - warning: no files found matching '*.txt' 07:43:02 INFO - no previously-included directories found matching 'build' 07:43:02 INFO - no previously-included directories found matching 'dist' 07:43:02 INFO - no previously-included directories found matching '.git*' 07:43:02 INFO - Installing collected packages: jsonschema, functools32 07:43:02 INFO - Running setup.py install for functools32 07:43:02 INFO - warning: no files found matching '*.txt' 07:43:02 INFO - no previously-included directories found matching 'build' 07:43:02 INFO - no previously-included directories found matching 'dist' 07:43:02 INFO - no previously-included directories found matching '.git*' 07:43:02 INFO - Successfully installed jsonschema functools32 07:43:02 INFO - Cleaning up... 07:43:02 INFO - Return code: 0 07:43:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:43:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:02 INFO - 'HOME': '/Users/cltbld', 07:43:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:02 INFO - 'LOGNAME': 'cltbld', 07:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:02 INFO - 'MOZ_NO_REMOTE': '1', 07:43:02 INFO - 'NO_EM_RESTART': '1', 07:43:02 INFO - 'PAGER': '/bin/cat', 07:43:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:02 INFO - 'PWD': '/builds/slave/test', 07:43:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:02 INFO - 'SHELL': '/bin/bash', 07:43:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:02 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:02 INFO - 'USER': 'cltbld', 07:43:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:02 INFO - 'XPC_FLAGS': '0x0', 07:43:02 INFO - 'XPC_SERVICE_NAME': '0', 07:43:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:43:02 INFO - Cleaning up... 07:43:02 INFO - Return code: 0 07:43:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:43:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:02 INFO - 'HOME': '/Users/cltbld', 07:43:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:02 INFO - 'LOGNAME': 'cltbld', 07:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:02 INFO - 'MOZ_NO_REMOTE': '1', 07:43:02 INFO - 'NO_EM_RESTART': '1', 07:43:02 INFO - 'PAGER': '/bin/cat', 07:43:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:02 INFO - 'PWD': '/builds/slave/test', 07:43:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:02 INFO - 'SHELL': '/bin/bash', 07:43:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:02 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:02 INFO - 'USER': 'cltbld', 07:43:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:02 INFO - 'XPC_FLAGS': '0x0', 07:43:02 INFO - 'XPC_SERVICE_NAME': '0', 07:43:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:02 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 07:43:02 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 07:43:02 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 07:43:02 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 07:43:02 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 07:43:02 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 07:43:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43:05 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 07:43:05 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 07:43:05 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 07:43:05 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 07:43:05 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 07:43:05 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 07:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43:06 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 07:43:06 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 07:43:06 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 07:43:06 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 07:43:06 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 07:43:06 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 07:43:06 INFO - Downloading docopt-0.6.1.tar.gz 07:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:06 INFO - Running setup.py install for blobuploader 07:43:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:06 INFO - Running setup.py install for requests 07:43:07 INFO - Running setup.py install for docopt 07:43:07 INFO - Successfully installed blobuploader requests docopt 07:43:07 INFO - Cleaning up... 07:43:07 INFO - Return code: 0 07:43:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:07 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:07 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 07:43:07 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 07:43:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:07 INFO - 'HOME': '/Users/cltbld', 07:43:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:07 INFO - 'LOGNAME': 'cltbld', 07:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:07 INFO - 'MOZ_NO_REMOTE': '1', 07:43:07 INFO - 'NO_EM_RESTART': '1', 07:43:07 INFO - 'PAGER': '/bin/cat', 07:43:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:07 INFO - 'PWD': '/builds/slave/test', 07:43:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:07 INFO - 'SHELL': '/bin/bash', 07:43:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:07 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:07 INFO - 'USER': 'cltbld', 07:43:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:07 INFO - 'XPC_FLAGS': '0x0', 07:43:07 INFO - 'XPC_SERVICE_NAME': '0', 07:43:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:07 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Z6e1qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Zmym6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8P0JSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-wJu_DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-4FDLDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-YQiUHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-gWEyr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-y6xB3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-vdHLqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-hVvUSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:08 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-yDtQFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-9ZMCfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rYbGKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-jZ4DYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-SEmCMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-rNyFaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:09 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-zbvAc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:09 INFO - Running setup.py install for manifestparser 07:43:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:09 INFO - Running setup.py install for mozcrash 07:43:09 INFO - Running setup.py install for mozdebug 07:43:10 INFO - Running setup.py install for mozdevice 07:43:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Running setup.py install for mozfile 07:43:10 INFO - Running setup.py install for mozhttpd 07:43:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Running setup.py install for mozinfo 07:43:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Running setup.py install for mozInstall 07:43:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:10 INFO - Running setup.py install for mozleak 07:43:11 INFO - Running setup.py install for mozlog 07:43:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Running setup.py install for moznetwork 07:43:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Running setup.py install for mozprocess 07:43:11 INFO - Running setup.py install for mozprofile 07:43:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Running setup.py install for mozrunner 07:43:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:11 INFO - Running setup.py install for mozscreenshot 07:43:11 INFO - Running setup.py install for moztest 07:43:12 INFO - Running setup.py install for mozversion 07:43:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:12 INFO - Cleaning up... 07:43:12 INFO - Return code: 0 07:43:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:12 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')]} 07:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:12 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')]} 07:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:12 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:12 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 07:43:12 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 07:43:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:12 INFO - 'HOME': '/Users/cltbld', 07:43:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:12 INFO - 'LOGNAME': 'cltbld', 07:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:12 INFO - 'MOZ_NO_REMOTE': '1', 07:43:12 INFO - 'NO_EM_RESTART': '1', 07:43:12 INFO - 'PAGER': '/bin/cat', 07:43:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:12 INFO - 'PWD': '/builds/slave/test', 07:43:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:12 INFO - 'SHELL': '/bin/bash', 07:43:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:12 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:12 INFO - 'USER': 'cltbld', 07:43:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:12 INFO - 'XPC_FLAGS': '0x0', 07:43:12 INFO - 'XPC_SERVICE_NAME': '0', 07:43:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-kIjcPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:12 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)) 07:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Xn5W67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:12 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)) 07:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-lrRCO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:12 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)) 07:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-JAW0pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:12 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)) 07:43:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:12 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-mgX1i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Y9M8qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-LKnevX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-FOt3iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-m0ONzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-KSpwYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-ebwLhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-1w9v2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-8_FNwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:13 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)) 07:43:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:13 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-cFZ4qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:14 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)) 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:14 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-Nd09VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:14 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)) 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:14 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-nlegtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:14 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)) 07:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:14 INFO - Running setup.py (path:/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/pip-j_d7_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:14 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)) 07:43:14 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)) 07:43:14 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)) 07:43:14 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)) 07:43:14 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)) 07:43:14 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)) 07:43:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:14 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 07:43:14 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 07:43:14 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 07:43:14 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 07:43:14 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 07:43:14 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 07:43:17 INFO - Downloading blessings-1.6.tar.gz 07:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:18 INFO - Installing collected packages: blessings 07:43:18 INFO - Running setup.py install for blessings 07:43:18 INFO - Successfully installed blessings 07:43:18 INFO - Cleaning up... 07:43:18 INFO - Return code: 0 07:43:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:18 INFO - Reading from file tmpfile_stdout 07:43:18 INFO - Current package versions: 07:43:18 INFO - blessings == 1.6 07:43:18 INFO - blobuploader == 1.2.4 07:43:18 INFO - docopt == 0.6.1 07:43:18 INFO - functools32 == 3.2.3-2 07:43:18 INFO - jsonschema == 2.5.1 07:43:18 INFO - manifestparser == 1.1 07:43:18 INFO - mozInstall == 1.12 07:43:18 INFO - mozcrash == 1.0 07:43:18 INFO - mozdebug == 0.1 07:43:18 INFO - mozdevice == 0.49 07:43:18 INFO - mozfile == 1.2 07:43:18 INFO - mozhttpd == 0.7 07:43:18 INFO - mozinfo == 0.9 07:43:18 INFO - mozleak == 0.1 07:43:18 INFO - mozlog == 3.4 07:43:18 INFO - moznetwork == 0.27 07:43:18 INFO - mozprocess == 0.25 07:43:18 INFO - mozprofile == 0.28 07:43:18 INFO - mozrunner == 6.13 07:43:18 INFO - mozscreenshot == 0.1 07:43:18 INFO - mozsystemmonitor == 0.3 07:43:18 INFO - moztest == 0.8 07:43:18 INFO - mozversion == 1.4 07:43:18 INFO - psutil == 3.1.1 07:43:18 INFO - requests == 1.2.3 07:43:18 INFO - wsgiref == 0.1.2 07:43:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:18 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')]} 07:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:18 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')]} 07:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:18 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:18 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 07:43:18 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 07:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:18 INFO - 'HOME': '/Users/cltbld', 07:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:18 INFO - 'LOGNAME': 'cltbld', 07:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:18 INFO - 'MOZ_NO_REMOTE': '1', 07:43:18 INFO - 'NO_EM_RESTART': '1', 07:43:18 INFO - 'PAGER': '/bin/cat', 07:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:18 INFO - 'PWD': '/builds/slave/test', 07:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:18 INFO - 'SHELL': '/bin/bash', 07:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:18 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:18 INFO - 'USER': 'cltbld', 07:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:18 INFO - 'XPC_FLAGS': '0x0', 07:43:18 INFO - 'XPC_SERVICE_NAME': '0', 07:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 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)) 07:43:18 INFO - Cleaning up... 07:43:18 INFO - Return code: 0 07:43:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:18 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')]} 07:43:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:18 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')]} 07:43:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:18 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 0x107684b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107687768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2d0480580>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, '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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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 07:43:18 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 07:43:18 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 07:43:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:18 INFO - 'HOME': '/Users/cltbld', 07:43:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:18 INFO - 'LOGNAME': 'cltbld', 07:43:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:18 INFO - 'MOZ_NO_REMOTE': '1', 07:43:18 INFO - 'NO_EM_RESTART': '1', 07:43:18 INFO - 'PAGER': '/bin/cat', 07:43:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:18 INFO - 'PWD': '/builds/slave/test', 07:43:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:18 INFO - 'SHELL': '/bin/bash', 07:43:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:18 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:18 INFO - 'USER': 'cltbld', 07:43:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:18 INFO - 'XPC_FLAGS': '0x0', 07:43:18 INFO - 'XPC_SERVICE_NAME': '0', 07:43:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:19 INFO - Cleaning up... 07:43:19 INFO - Return code: 0 07:43:19 INFO - Running post-action listener: _resource_record_post_action 07:43:19 INFO - Running post-action listener: _start_resource_monitoring 07:43:19 INFO - Starting resource monitoring. 07:43:19 INFO - [mozharness: 2017-04-25 14:43:19.266259Z] Finished create-virtualenv step (success) 07:43:19 INFO - [mozharness: 2017-04-25 14:43:19.267230Z] Running install step. 07:43:19 INFO - Running pre-action listener: _resource_record_pre_action 07:43:19 INFO - Running main action method: install 07:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:19 INFO - Reading from file tmpfile_stdout 07:43:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:19 INFO - Reading from file tmpfile_stdout 07:43:19 INFO - Output received: 07:43:19 INFO - Usage: mozinstall [options] installer 07:43:19 INFO - Options: 07:43:19 INFO - -h, --help show this help message and exit 07:43:19 INFO - -d DEST, --destination=DEST 07:43:19 INFO - Directory to install application into. [default: 07:43:19 INFO - "/builds/slave/test"] 07:43:19 INFO - --app=APP Application being installed. [default: firefox] 07:43:19 INFO - mkdir: /builds/slave/test/build/application 07:43:19 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'] 07:43:19 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 07:43:34 INFO - Reading from file tmpfile_stdout 07:43:34 INFO - Output received: 07:43:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:43:34 INFO - Running post-action listener: _resource_record_post_action 07:43:34 INFO - [mozharness: 2017-04-25 14:43:34.292722Z] Finished install step (success) 07:43:34 INFO - [mozharness: 2017-04-25 14:43:34.292859Z] Running run-tests step. 07:43:34 INFO - Running pre-action listener: _resource_record_pre_action 07:43:34 INFO - Running main action method: run_tests 07:43:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:43:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:43:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:43:34 INFO - 2017-04-25 07:43:34.307 screenresolution[1626:7388] starting screenresolution argv=screenresolution get 07:43:34 INFO - 2017-04-25 07:43:34.309 screenresolution[1626:7388] Display 0: 1600x1200x32@60 07:43:34 INFO - 2017-04-25 07:43:34.315 screenresolution[1627:7390] starting screenresolution argv=screenresolution list 07:43:34 INFO - Available Modes on Display 0 07:43:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:43:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:43:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:43:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:43:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:43:34 INFO - Intel Iris: 07:43:34 INFO - Chipset Model: Intel Iris 07:43:34 INFO - Type: GPU 07:43:34 INFO - Bus: Built-In 07:43:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:43:34 INFO - Vendor: Intel (0x8086) 07:43:34 INFO - Device ID: 0x0a2e 07:43:34 INFO - Revision ID: 0x0009 07:43:34 INFO - Displays: 07:43:34 INFO - Display: 07:43:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:43:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:43:34 INFO - Display Serial Number: 1600x1200 60 07:43:34 INFO - Main Display: Yes 07:43:34 INFO - Mirror: Off 07:43:34 INFO - Online: Yes 07:43:34 INFO - Rotation: Supported 07:43:34 INFO - Return code: 0 07:43:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:34 INFO - Python 2.7.3 07:43:34 INFO - Return code: 0 07:43:34 INFO - grabbing minidump binary from tooltool 07:43:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:34 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 0x107462d30>, '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 0x107389db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107457be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:34 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 07:43:34 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 07:43:34 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 07:43:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:34 INFO - Return code: 0 07:43:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:43:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:34 INFO - ENV: RUST_BACKTRACE is now 1 07:43:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:43:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:34 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/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 07:43:34 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/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0353 --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 07:43:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wQ9ha2tWFM/Render', 07:43:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:34 INFO - 'HOME': '/Users/cltbld', 07:43:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:34 INFO - 'LOGNAME': 'cltbld', 07:43:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:34 INFO - 'MOZ_NO_REMOTE': '1', 07:43:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:34 INFO - 'NO_EM_RESTART': '1', 07:43:34 INFO - 'PAGER': '/bin/cat', 07:43:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:34 INFO - 'PWD': '/builds/slave/test', 07:43:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:34 INFO - 'RUST_BACKTRACE': '1', 07:43:34 INFO - 'SHELL': '/bin/bash', 07:43:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I4z9qdgMjC/Listeners', 07:43:34 INFO - 'TMPDIR': '/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/', 07:43:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:34 INFO - 'USER': 'cltbld', 07:43:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:34 INFO - 'XPC_FLAGS': '0x0', 07:43:34 INFO - 'XPC_SERVICE_NAME': '0', 07:43:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:34 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/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0353', '--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 07:43:34 INFO - mozversion application_buildid: 20170425054225 07:43:34 INFO - mozversion application_changeset: 8619db383886e1237486792ff33d5eb331cdec7d 07:43:34 INFO - mozversion application_display_name: Firefox 07:43:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:34 INFO - mozversion application_name: Firefox 07:43:34 INFO - mozversion application_remotingname: firefox 07:43:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:43:34 INFO - mozversion application_vendor: Mozilla 07:43:34 INFO - mozversion application_version: 54.0 07:43:34 INFO - mozversion platform_buildid: 20170425054225 07:43:34 INFO - mozversion platform_changeset: 8619db383886e1237486792ff33d5eb331cdec7d 07:43:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:43:34 INFO - mozversion platform_version: 54.0 07:43:34 INFO - using testdate: 1493131414 07:43:34 INFO - actual date: 1493131414 07:43:34 INFO - starting webserver on 'localhost:49242' 07:43:34 INFO - SUITE-START | Running 2 tests 07:43:34 INFO - TEST-START | dromaeo_css 07:43:34 INFO - operating with platform_type : mac_ 07:43:34 INFO - Initialising browser for dromaeo_css test... 07:43:34 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpGyhVEw/profile http://localhost:49242/getInfo.html) 07:43:37 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 07:43:37 INFO - PROCESS | 1637 | colorDepth:24 07:43:37 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 07:43:37 INFO - PROCESS | 1637 | __metrics 07:43:37 INFO - PROCESS | 1637 | 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" 07:43:37 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:38 INFO - TEST-INFO | 1637: exit 0 07:43:38 INFO - Browser initialized. 07:43:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:43:38 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpGyhVEw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:50 INFO - PROCESS | 1640 | RSS: Main: 169164800 07:43:50 INFO - PROCESS | 1640 | 07:46:52 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 07:46:55 INFO - PROCESS | 1640 | RSS: Main: 376344576 07:46:55 INFO - PROCESS | 1640 | 07:49:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 07:49:58 INFO - PROCESS | 1640 | RSS: Main: 306954240 07:49:58 INFO - PROCESS | 1640 | 07:53:01 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 07:53:01 INFO - PROCESS | 1640 | RSS: Main: 280576000 07:53:01 INFO - PROCESS | 1640 | 07:56:04 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 07:56:04 INFO - PROCESS | 1640 | RSS: Main: 271917056 07:56:04 INFO - PROCESS | 1640 | 07:59:08 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 07:59:09 INFO - PROCESS | 1640 | RSS: Main: 273240064 07:59:09 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 08:02:12 INFO - PROCESS | 1640 | RSS: Main: 331268096 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | __start_tp_report 08:02:12 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 08:02:12 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 08:02:12 INFO - PROCESS | 1640 | |i|pagename|runs| 08:02:12 INFO - PROCESS | 1640 | |0;dojo.html;2733.316670832292;3032.4238394705003;3545.8758943436983;3557.6620221079006;3573.5711714594254;5004.7998080076795;6109.877802443949;6146.0473626587955;6184.381561843819;6200.348963358844;6031.72857221425;6113.174721412608;6134.87730245396;6146.385361463851;6157.753689852411;5402.324709411333;5425.864353391177;5450.618456708032;5455.563554915617;5584.106542953128;5332.706701131437;5348.064088784467;5366.302380690524;5540.335159780832;5594.104943209088;5426.131818908975;5473.452654734515;5532.474414930575;5533.253010843545;5543.6119471637;5449.264349312852;5474.562035037207;5506.284183056177;5506.476884695948;5514.5864060195645;5290.867728306785;5426.403095659474;5436.374816896068;5481.780728770845;5499.560035197174;5856.092305692625;5898.852528686774;5969.224000879901;5980.820575382745;5998.790042348497;6226.470749986257;6235.469985051276;6235.594686345373;6243.500519958392;6311.431971122575;6492.837679058014;6499.415052645285;6507.967460162717;6524;6528;6168.660723660197;6216.3162052174675;6224.221972253468;6230.221222347207;6240.5319601030105;6311.147995020705;6611.074449577063;6614.206295244601;6637.701303441357;6640.269570347258;6210.099535567318;6241.21984751906;6246.718897649616;6250.531210159165;6256.186695729526;6474.0612611172055;6480.222373315232;6480.416762491304;6482.254540727877;6490.02649602554;6366.299707032223;6391.201099862517;6403.071554624554;6407.103005579223;6473.805785826433;5788.652680839163;5791.9284932287665;6180.536459765535;6201.937980620136;6372.6495042773095;5099.898002039939;5111.5655169310285;5116.9744151279;5121.590272778169;5212.869678258074;3612.512310838056;4624.098300831373;4628.814847406066;4648.976755116203;4658;6099.329073801879;6145.446909778141;6167.691615419211;6171.537134714914;6180.505559555225;6203;6238.033104868752;6437.2275326960125;6446.709898054599;6468.417842394207;6029.517638588903;6034.1853849730605;6038.275406951194;6044.667543285073;6060.181875446759;5592.468715472024;5603.943960560424;5604.159376093537;5612.102063669875;5623.044082505984;6395;6461.999999999906;6476.352364763486;6487.124238227968;6487.2215334159255;6146.078088286793;6362.809115726535;6422.775202867877;6456.031595260749;6493.9934310182;6653.201615806134;6693.631850248283;6701.0953521274005;6709.094272273376;6731.1922569292;5231.189165679326;5411.404745478073;6374.649394283359;6402.35976402356;6418.229812422353;6164.7842325518395;6203.16257305258;6264.624122552661;6307.43233109004;6327.209098862642;5186.844394668166;6287.748490060347;6289.842753931005;6292.622442653455;6299.149614801943;6246.937530624636;6258.061290806233;6289.874202515833;6294.622322660655;6306.2747784003595;6292.811215663537;6299.685015749103;6309.369063093837;6331.271903730945;6337.207849018872;6149.446549810538;6164.599301045418;6279.71741271653;6280.246370435577;6300.2754683212015;6117;6171.1360409543595;6239.594426362272;6293.559450838397;6305.306416294296 08:02:12 INFO - PROCESS | 1640 | |1;ext.html;709.5990765217651;829.7759604906673;900.4912224593104;910.7677542226735;914.1681070226095;42565.57434425655;43426.78286608566;43686;43688.3446748299;43689;42965.570344296546;43111.35332970008;43163;43184.56815431845;43226.351604725955;7985.081715602693;9808.11726944575;9965.20278377728;9975;9993;7992.960035199816;8070.677172913076;8075.111737708848;8087.069986951487;11928.821067683992;12194.573189938354;12198.695032624211;12230.571929982452;12240.693982650417;12252.816207756847;12142.210756300856;12160.209586376857;12182.81725774114;12184.20802647834;12187.512499500053;11850.585229517012;11913.10651701126;11920.523179072827;11947.462364193632;11952.940235298767;41053.58946410557;41168.176636467106;41216.76349709513;41256.968575785846;41307.58692413098;3980.840766369342;4002.419649150886;4018.678505719565;4034.9394759078637;4046.9595304046875;28484.28789280264;29238.56142157869;29842.552361714592;30158;30919.84540077285;2978.0321395546534;3251.951220731667;3292.670732926712;3310.0400883743687;3335.182880194344;370307;370423;370542;371007;371073;43287.134257314676;43918.68243952686;53980.46019539754;53992.73003634957;54003;54099.188512172346;55060;57545.424545754846;57628.42371576314;57745.422545774;15256.542303730906;15611.921940390452;15637.687246255238;15650.765238521431;15658.217089145497;13233.206007639572;13271.402786874422;13271.93364033193;13290.269035202964;13302.534411295559;12201.145919785708;12209.755804884031;12212.328321942201;12296;12322.75354492923;4642.257238841769;5157.819476318311;5303.893922121536;5349.144136938071;5363.490468405495;1094.2559059839227;1124.1624989382963;1124.4987941098725;1158.8783177766213;1203.7231436769591;23403;23458.64812027821;27076;27317.590236146472;27508.899644014415;1259.2444533280143;1271.650296168561;1273.8789814967563;1308.4962289518603;1333.973320533584;14024.859751402559;14243.359048842827;14479.565613031626;14556.417743290362;14603.050801698068;469634;608683;617909;619338;619512;50055;50354.24468632974;50408.495915041116;50509;50527;1434.9354279057468;1460.974248584907;1474.7787831825096;1478.4455829064102;1485.2499487758828;23539.705316207772;26608.467830643665;27200.047998320755;27432.314192144557;28138.2965425866;41579;41661.58338416577;41733.58266417419;41758.37362439626;41891.371629424975;447932;448558;450266;451014.74492627324;451505;24534.631980520662;24872.751272487043;24878;29611.703882960894;29819.850900745358;36207.63792362148;37783.62216377801;38989.44042238392;39113.608863910995;39133;28159.71840281653;28272.575911361757;29022.274443138245;29156.562651560667;29500.557491637213;23880.522389551763;28346.149615511567;28867.85566072156;29022.984195553054;29055.564166537097;33170;33510.16224594405;33517;33552.66447335593;33565.99302020943;23895.641565376187;23921.28236152918;24905.377365566004;25786;25932.351691207117;22884;23551.29346119619;23618.17336393218;23850.284491465285;24138.637920430858 08:02:12 INFO - PROCESS | 1640 | |2;jquery.html;378.8105947026487;421.5236782435845;430.39529461107117;437.27630771073876;460.5256585716711;21112.4721881953;22105.778942210574;22558.323250302496;23161.76838231617;23438;23408.5318293634;23610.05559777611;23940.281791546236;24051.518969620596;24188.758112418913;6845.794626161223;6911.792646220596;7052.259512751164;7052.682629281695;7224.7110115595315;6459.6447195404235;7025.543339682904;7036.542624729376;7059.788206353817;7128.643567821614;7991.520508769463;8033.638486268132;8051.4766540175;8062.879056814152;8071.878921816177;5171.741412929376;5185.714785686786;5201.40183878855;5208.687478751268;7809.984701988734;5106.591472682177;5107.463716309809;5107.668001579886;5121.667091639031;5146.253793200002;22365;26918;27200.31999200016;27259.727402726116;27282.31794205141;2912.344722437456;3087.938241235163;3097.7212050915527;3097.814131152138;3143.654198038214;16251.593710157222;16632.83367166325;17032;17949.371771987917;17951.281948722037;1980.0014887229154;2016.9092390842447;2047.2220556188702;2055.797358545253;2136.8717876927435;112766.43616781945;122562;124955;138214;169183;16740.83259167417;17936.461906142835;20878.37364879056;20902;20993.950302485122;32798.67201328004;33252.66747332496;33260;33404.498932516035;33436;8756.824863502694;10674.412907290174;10893.945530272456;11087.113030957504;11262;9176.403533770284;9201.309901757395;9232.307576931757;9372.39079459833;9377.578008989612;9370.437773733598;9420.34057615974;9475.336726429085;9570.186534144537;9593.712188634352;3127.5934128563595;3480.095175254452;3910.7458015228917;3922.980385098056;4095.24238015968;756.345760916814;783.3549545953452;841.8568843296654;934.5794392523392;944.9716508504756;22466.865647763436;23016.964236609394;23040;23042.769572304398;23061;863.8963324401112;869.4044579463088;982.4252812104855;996.3374356053289;1010.1060561403065;11352.48913798881;11637.88362116368;11896.583619573274;11948.641540753792;11976.981956533618;626755;770744;782768;796384;800762;123342;156370;157327;164464;168724;1254.9686257843628;1286.0547497589264;1317.2623330934516;1320.4850108457708;1328.8472674267555;19204.71192932135;19413.708794367813;19672.21311147538;19693.70459443081;19711.80288197157;63096.68451657896;63311.733765323515;63439.68280158754;64421.033684495706;67212;93124.06875931154;93204;94152.05847941434;94329.8118603456;96004.51997739967;11361.772764544829;11422.771544569228;11653.47559359814;11850.76298474043;11903.047756179312;10066.848997265193;12573.308468034345;12850.100492965403;12867.356632168166;12981.156224845356;11096.889031109586;11143.442827858737;11196.832047519456;11293.943530282297;11345.602903898323;10251.38491690501;10307.896921030993;10602.310849794738;10646.520906559379;10674.57301707923;11241.831372529583;11388.829167562659;11541.307521548733;11621.418929053345;11682.12384071181;10767.275110731498;11326.603568875049;11540.769184616429;11557.07543396543;11723.648290551297;9646.276529260474;11262.436878156223;11278.09775217997;11570.363630000431;11601.361925094201 08:02:12 INFO - PROCESS | 1640 | |3;mootools.html;1610.4282979542254;1621.1813034417617;1647.0858673436237;1647.250501022035;1667.8582320502758;10824.079953203976;11460.31238125713;11494;11498.367589782558;11498.367589782558;10857.51141198646;11129;11181.217314787948;11334.829977550344;11343.319400835955;2474.0969546115675;2515.0065724038996;2518.785903198221;2520.621906713989;2523.709773376067;2453.852768833867;2457.9754202458016;2489.9253022409266;2491.115653942851;2492.339530024536;2442.487077713682;2446.5351583199226;2457.4347899983013;2492.3644470659956;2497.5254701606636;2075.63676356637;2430.6840110785574;2446.3272600034957;2460.4709987352717;2493.0277191895175;2446.681931348931;2464.2853572463964;2472.678551788256;2476.3809047738064;2489.427431690703;11109.666709998632;11366.261193022427;11368;11376.317420954769;11379.658610241706;5969.70151492428;6175.413335733098;6179.783707570214;6181.6600086995195;6195.4424101831055;3642.9271414571826;3745.325841348556;3784.0350710568628;3836.3094642964256;3840.3663395539984;1291.7610242105147;1491.671832196915;1789.4452719656947;1926.5954149628594;1942;14343.067700599531;14682.779758303634;15004.02473839197;15746.606334841606;16090.678186436206;4310.590493903074;5040.470750571138;5067.746612669425;5213.13983192769;5219.660722053054;7277.526960747535;12284.570040048555;12427.70087533809;12477.376131193403;13453.394597243148;5807.332156801937;5942.554308426886;5958.46373826349;5965.28416590012;6036.5170786336985;5283.705492154447;5373.032854086302;5376.946230537723;5396.703181325065;5481.75332110056;4217.502786510806;4238.237117318912;4274.316109422478;4328.134373125387;4333;1156.843826083468;1168.526746667601;1171.619223752284;1188.4295538141741;1192.527228872342;987.1757082835912;988.110700369673;1002.0430488883245;1020.3418794877412;1032.4012072997643;6628.767993120314;6821.658917054127;6833.0092136639905;6897.241303456616;7067.151941766918;958.8178246133212;1052.1687866585464;1074.4735079810837;1075.7364445710693;1104.7956128116325;3628.600853906068;3861.7489863159367;3925.823337949799;4200.600942910419;4285.571442855689;13508.392122354519;13955.372008259652;13978.86021139796;14077.71844563103;14111.858881411055;11640.592579259684;13625.114367566077;13949.790753138712;14092.506762263272;14096.788548171786;10425.791484170275;10594.894051059546;10610;10610.68167954947;10619.628313009007;6387;6606.273309935999;6696.631685257357;6770.356816102462;6779.661016949034;12271.325077120844;12729.490820367451;12737.87262127367;12738.617841464771;12743.681407964876;12567;12569.245845249314;12862.97096232318;12933.417996190383;12973.771850549992;9375.906240937777;9457.054294570487;9562.235021198148;9585.137337639646;9589.616415343307;10395.32430392022;10430.791384172426;10441.269111162146;10537.736556586147;10545.525451354553;8942.776430589287;8979.371443998858;9049.683261085831;9071.637134514545;9221.216196623362;7501.887471688038;8764.649414023368;8804.075572065098;8829.558522074;9014.684486042957;8101.149379315087;8179.79550511242;8269.04905935825;8291.461055031403;8308.958455207685;5914;5936.13925980739;5954.970225148846;6120.877582448237;6183.3816618337805;5267.789288428573;6059.706073070944;6098.725557349841;6132.540059495466;6267.2479302484 08:02:12 INFO - PROCESS | 1640 | |4;prototype.html;362.6627236669896;371.4409813231089;390.9765414075156;391.25661243637086;402.72614622057006;5014.724190169539;5022.598192144629;5110.310108135401;5110.591152707779;5123.6925784452915;4131.111810960643;4837.9438738536155;5004.374453193351;5057;5102.209157580581;3461.8442170102408;3822.337283281767;4037.8586749463775;4084.95752123938;4273.465816772903;3728.303621852064;4248.192843359767;4268;4302.20409224293;4336.891577710567;3638.1268495561008;3687.1793078295127;3764.270903594899;4265.445492086024;4336.97831510842;3983.621555952209;4219.367094935784;4279.914401711964;4353.586409291112;4372.825086996532;3610.6028336882923;3810.2760475509563;3946.960530394688;3968.523777146761;3980.6465801627296;5031.597472202215;5055.772490237911;5063.518965698253;5075.670081444694;5101.566366858821;4244.214820258231;4462.085272519158;4964.429090654585;4971.37857767779;5038.244263360489;4612.4003879495785;4909.576222895392;5222.772648427616;5269.86825329366;5515.4760297771645;3758.962410375916;4424.911501769947;4429.601335879786;4439.7780110994645;4459.9331010034875;5444.481080703086;5493.670379777226;5626.355612861948;5808.21205821204;5822;3309.6855798699085;3559.394902866519;4014.578469260744;4450.532694067077;4512.842050528216;3611;3974.940375894364;4100.65144462718;4637.333533218345;4641.443026836801;4572.74849883253;4597.885052873638;4664.603508701798;4689.554492323224;4726.71639701619;4593.425821772278;5407.674280317577;5435.728213589384;5469.714617064987;5556.583256255797;1251.0795928250093;1277.163457935054;1331.9134256273312;1558.8153003717257;1574.5197714696899;1008.8890222075565;1105.5025238642481;1168.4800263882491;1184.1178322150054;1187.7743228786503;4616.1996821239745;4850.53919877611;4940.047243072089;5132.230165475134;5158.3552055993005;4816.220535357585;5152.742362881841;5568.106843673089;5568.916466253009;5628.79158879443;4646.395968524071;4827.903441931142;4904.779284932187;4951.83082826991;5135.6918584885025;2562.2448622693514;2660.7095558654037;2729.785245565744;2838.5174520331593;2942.867570959312;4894.755262236874;5290.550303224269;5564.777408903679;5615.803446879339;5881.764729410861;5436.565074794007;5592.3009623797025;5708.402676782137;5715.5427565794635;5731.7298612533095;5034.672746271481;5072.289879416885;5261.394939581997;5273.156294992783;5426.538744206708;4994.975025124996;5103.617228707788;5280.260763493191;5645.237892884572;5734.885302294014;4986.803167239909;5315.777371204567;5546.889062218653;5562.776189238361;5579.414161512983;5106.438291787975;5316.468353164652;5347.903679745565;5593.727669313497;5798.391168927202;3910.865848903786;4464.419625448671;4470.731756094645;4543.4775000875325;4543.6365090793315;4551.522090180483;5265.315508983807;5471.699056551928;5569.567149941824;5585.525230355465;4800.975995120002;4959.933614272949;5110.97444512775;5141.89449268409;5143.7428128594165;4528.592426681483;4811.879703007313;5151.110911261973;5376.521456599467;5473;4603.953960460486;4985.202367621163;5255.842324730264;5344.4922732340365;5411.648242864201;4867.561919427269;5044.167712327571;5232.738363081907;5365.624406291522;5410.945890541044;5127.282180494659;5328.547073498796;5334.386545547157;5373.059714550016;5402.729863506887 08:02:12 INFO - PROCESS | 1640 | |5;yui.html;761.3794757272823;793.9245771651691;816.0656048824096;863.9459858972052;900.6532484993278;13539.052266341349;14495.782563261559;14497.565073047812;14502.854971450282;14536.200508972002;15441.768373474408;15603.219839008061;15774.605634859134;15954.122523261216;15961.281742321595;965.5992763003345;967.0764419978939;967.4630580028081;968.1770495079162;970.3838062830118;955.4601650067724;956.7512446763857;957.9941061884992;958.3291695812924;1010.9797804043915;1072.785442911417;1073.2701762801291;1076.0745758647556;1082.983755243668;1083.0847933496184;1067.1729409707461;1067.3169171730099;1068.1561566362602;1068.9625863094755;1069.150025729539;796.3509739562296;796.7330944133722;796.9481983671043;797.5095316380384;799.2447137455107;16879.24043418037;17149.485515434557;17183.914080429517;17710.822891771048;17994.460166194905;14683.706325873423;14752.852471475255;14793.778093328609;14903.403863845433;14928.552143435605;11757.647270581896;11963.40182990847;11974.34141122238;12108.515659373614;12475;3410.539577157077;3791.279656865187;3954.5254569451563;4015.9397609035886;4064.471618689581;109819.9999999992;120636.39681801622;121153;122609;122688;11296.43517824122;11431.657050288504;11495.080393568494;11545.826812597817;11797.941010295066;24010.51978960411;24476.632850507256;24504.142355017488;24504.754952450246;24504.89727962246;8118.309943654737;8158.632861521246;8205.056418511947;8223.876641850376;8248.793780155424;4538.387317712132;4550.362949187116;4568.88577785558;4647.233206520954;4839.830605928775;3532.523109380252;3624.5831729350934;3624.9456258156147;3627.4921510988484;3644.835982380799;606.254307202135;618.038949433626;629.7071861584385;633.6419922743635;636.6848410037061;653.1867824558456;668.4418510543653;670.7283550162192;692.2661978303015;696.8884978403532;10173.491325433846;10378.325408848401;10431.791364172826;10631.202659800545;10640.095591874777;627.1658693937053;632.3644737039247;665.5806841689705;685.0990946904903;685.7609903664539;4963.528464795839;5000;5003.249512573143;5346.6926320692355;5544.528715059265;74033.6298318505;83509.74735378975;86056.13943860482;93178.53410733039;106963;62259;70757;74216.25783742202;83746.90632734109;87418.56290718506;54167.18749218686;69456;71268.57462850817;73891.52216955523;74802.12994675068;11052.944735276595;11106.944465277622;11190;11294.322340659586;11500.309981401142;48329.5167048325;48359;49300.75349623372;49855.0202971577;52300.47699523108;63548;66786.66426671536;68778;69374;72933.635331823;13526.59420217395;13624.863751362756;13671.931640342133;13680.31598420095;13790.379432925743;12682.28478554561;15126.243687815786;15761.290741916871;15818.92090539586;16027.839721602635;13979.790303145257;14126.858731412554;14787.260636967894;14806.555803325487;14810.77783833265;13914.174252275892;14551;14572.125672459686;15094;15397.30712117935;14030.22833744113;14133.787993180316;14159.787603186167;14245.572632821031;14431.49489767853;10029.44838033886;10104.165117328052;10346.482675866328;10766.515506802056;10864.402457864577;10706.506368431374;10946.890531094905;11075;11614.477348519506;11619.825702614298 08:02:12 INFO - PROCESS | 1640 | __end_tp_report 08:02:12 INFO - PROCESS | 1640 | __start_cc_report 08:02:12 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2135 08:02:12 INFO - PROCESS | 1640 | __end_cc_report 08:02:12 INFO - PROCESS | 1640 | __startTimestamp1493132532967__endTimestamp 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | ------- Summary: start ------- 08:02:12 INFO - PROCESS | 1640 | Number of tests: 6 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5937.58 Median:6200.35 stddev:691.20 (11.1%) stddev-sans-first:646.00 08:02:12 INFO - PROCESS | 1640 | Values: 2733.3 3032.4 3545.9 3557.7 3573.6 5004.8 6109.9 6146.0 6184.4 6200.3 6031.7 6113.2 6134.9 6146.4 6157.8 5402.3 5425.9 5450.6 5455.6 5584.1 5332.7 5348.1 5366.3 5540.3 5594.1 5426.1 5473.5 5532.5 5533.3 5543.6 5449.3 5474.6 5506.3 5506.5 5514.6 5290.9 5426.4 5436.4 5481.8 5499.6 5856.1 5898.9 5969.2 5980.8 5998.8 6226.5 6235.5 6235.6 6243.5 6311.4 6492.8 6499.4 6508.0 6524.0 6528.0 6168.7 6216.3 6224.2 6230.2 6240.5 6311.1 6611.1 6614.2 6637.7 6640.3 6210.1 6241.2 6246.7 6250.5 6256.2 6474.1 6480.2 6480.4 6482.3 6490.0 6366.3 6391.2 6403.1 6407.1 6473.8 5788.7 5791.9 6180.5 6201.9 6372.6 5099.9 5111.6 5117.0 5121.6 5212.9 3612.5 4624.1 4628.8 4649.0 4658.0 6099.3 6145.4 6167.7 6171.5 6180.5 6203.0 6238.0 6437.2 6446.7 6468.4 6029.5 6034.2 6038.3 6044.7 6060.2 5592.5 5603.9 5604.2 5612.1 5623.0 6395.0 6462.0 6476.4 6487.1 6487.2 6146.1 6362.8 6422.8 6456.0 6494.0 6653.2 6693.6 6701.1 6709.1 6731.2 5231.2 5411.4 6374.6 6402.4 6418.2 6164.8 6203.2 6264.6 6307.4 6327.2 5186.8 6287.7 6289.8 6292.6 6299.1 6246.9 6258.1 6289.9 6294.6 6306.3 6292.8 6299.7 6309.4 6331.3 6337.2 6149.4 6164.6 6279.7 6280.2 6300.3 6117.0 6171.1 6239.6 6293.6 6305.3 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:59628.33 Median:30538.92 stddev:127834.43 (418.6%) stddev-sans-first:128116.50 08:02:12 INFO - PROCESS | 1640 | Values: 709.6 829.8 900.5 910.8 914.2 42565.6 43426.8 43686.0 43688.3 43689.0 42965.6 43111.4 43163.0 43184.6 43226.4 7985.1 9808.1 9965.2 9975.0 9993.0 7993.0 8070.7 8075.1 8087.1 11928.8 12194.6 12198.7 12230.6 12240.7 12252.8 12142.2 12160.2 12182.8 12184.2 12187.5 11850.6 11913.1 11920.5 11947.5 11952.9 41053.6 41168.2 41216.8 41257.0 41307.6 3980.8 4002.4 4018.7 4034.9 4047.0 28484.3 29238.6 29842.6 30158.0 30919.8 2978.0 3252.0 3292.7 3310.0 3335.2 370307.0 370423.0 370542.0 371007.0 371073.0 43287.1 43918.7 53980.5 53992.7 54003.0 54099.2 55060.0 57545.4 57628.4 57745.4 15256.5 15611.9 15637.7 15650.8 15658.2 13233.2 13271.4 13271.9 13290.3 13302.5 12201.1 12209.8 12212.3 12296.0 12322.8 4642.3 5157.8 5303.9 5349.1 5363.5 1094.3 1124.2 1124.5 1158.9 1203.7 23403.0 23458.6 27076.0 27317.6 27508.9 1259.2 1271.7 1273.9 1308.5 1334.0 14024.9 14243.4 14479.6 14556.4 14603.1 469634.0 608683.0 617909.0 619338.0 619512.0 50055.0 50354.2 50408.5 50509.0 50527.0 1434.9 1461.0 1474.8 1478.4 1485.2 23539.7 26608.5 27200.0 27432.3 28138.3 41579.0 41661.6 41733.6 41758.4 41891.4 447932.0 448558.0 450266.0 451014.7 451505.0 24534.6 24872.8 24878.0 29611.7 29819.9 36207.6 37783.6 38989.4 39113.6 39133.0 28159.7 28272.6 29022.3 29156.6 29500.6 23880.5 28346.1 28867.9 29023.0 29055.6 33170.0 33510.2 33517.0 33552.7 33566.0 23895.6 23921.3 24905.4 25786.0 25932.4 22884.0 23551.3 23618.2 23850.3 24138.6 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:43116.59 Median:23524.03 stddev:126107.50 (536.1%) stddev-sans-first:126420.43 08:02:12 INFO - PROCESS | 1640 | Values: 378.8 421.5 430.4 437.3 460.5 21112.5 22105.8 22558.3 23161.8 23438.0 23408.5 23610.1 23940.3 24051.5 24188.8 6845.8 6911.8 7052.3 7052.7 7224.7 6459.6 7025.5 7036.5 7059.8 7128.6 7991.5 8033.6 8051.5 8062.9 8071.9 5171.7 5185.7 5201.4 5208.7 7810.0 5106.6 5107.5 5107.7 5121.7 5146.3 22365.0 26918.0 27200.3 27259.7 27282.3 2912.3 3087.9 3097.7 3097.8 3143.7 16251.6 16632.8 17032.0 17949.4 17951.3 1980.0 2016.9 2047.2 2055.8 2136.9 112766.4 122562.0 124955.0 138214.0 169183.0 16740.8 17936.5 20878.4 20902.0 20994.0 32798.7 33252.7 33260.0 33404.5 33436.0 8756.8 10674.4 10893.9 11087.1 11262.0 9176.4 9201.3 9232.3 9372.4 9377.6 9370.4 9420.3 9475.3 9570.2 9593.7 3127.6 3480.1 3910.7 3923.0 4095.2 756.3 783.4 841.9 934.6 945.0 22466.9 23017.0 23040.0 23042.8 23061.0 863.9 869.4 982.4 996.3 1010.1 11352.5 11637.9 11896.6 11948.6 11977.0 626755.0 770744.0 782768.0 796384.0 800762.0 123342.0 156370.0 157327.0 164464.0 168724.0 1255.0 1286.1 1317.3 1320.5 1328.8 19204.7 19413.7 19672.2 19693.7 19711.8 63096.7 63311.7 63439.7 64421.0 67212.0 93124.1 93204.0 94152.1 94329.8 96004.5 11361.8 11422.8 11653.5 11850.8 11903.0 10066.8 12573.3 12850.1 12867.4 12981.2 11096.9 11143.4 11196.8 11293.9 11345.6 10251.4 10307.9 10602.3 10646.5 10674.6 11241.8 11388.8 11541.3 11621.4 11682.1 10767.3 11326.6 11540.8 11557.1 11723.6 9646.3 11262.4 11278.1 11570.4 11601.4 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6907.58 Median:2489.68 stddev:4251.81 (170.8%) stddev-sans-first:4245.10 08:02:12 INFO - PROCESS | 1640 | Values: 1610.4 1621.2 1647.1 1647.3 1667.9 10824.1 11460.3 11494.0 11498.4 11498.4 10857.5 11129.0 11181.2 11334.8 11343.3 2474.1 2515.0 2518.8 2520.6 2523.7 2453.9 2458.0 2489.9 2491.1 2492.3 2442.5 2446.5 2457.4 2492.4 2497.5 2075.6 2430.7 2446.3 2460.5 2493.0 2446.7 2464.3 2472.7 2476.4 2489.4 11109.7 11366.3 11368.0 11376.3 11379.7 5969.7 6175.4 6179.8 6181.7 6195.4 3642.9 3745.3 3784.0 3836.3 3840.4 1291.8 1491.7 1789.4 1926.6 1942.0 14343.1 14682.8 15004.0 15746.6 16090.7 4310.6 5040.5 5067.7 5213.1 5219.7 7277.5 12284.6 12427.7 12477.4 13453.4 5807.3 5942.6 5958.5 5965.3 6036.5 5283.7 5373.0 5376.9 5396.7 5481.8 4217.5 4238.2 4274.3 4328.1 4333.0 1156.8 1168.5 1171.6 1188.4 1192.5 987.2 988.1 1002.0 1020.3 1032.4 6628.8 6821.7 6833.0 6897.2 7067.2 958.8 1052.2 1074.5 1075.7 1104.8 3628.6 3861.7 3925.8 4200.6 4285.6 13508.4 13955.4 13978.9 14077.7 14111.9 11640.6 13625.1 13949.8 14092.5 14096.8 10425.8 10594.9 10610.0 10610.7 10619.6 6387.0 6606.3 6696.6 6770.4 6779.7 12271.3 12729.5 12737.9 12738.6 12743.7 12567.0 12569.2 12863.0 12933.4 12973.8 9375.9 9457.1 9562.2 9585.1 9589.6 10395.3 10430.8 10441.3 10537.7 10545.5 8942.8 8979.4 9049.7 9071.6 9221.2 7501.9 8764.6 8804.1 8829.6 9014.7 8101.1 8179.8 8269.0 8291.5 8309.0 5914.0 5936.1 5955.0 6120.9 6183.4 5267.8 6059.7 6098.7 6132.5 6267.2 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4492.49 Median:4945.94 stddev:1260.68 (25.5%) stddev-sans-first:1225.52 08:02:12 INFO - PROCESS | 1640 | Values: 362.7 371.4 391.0 391.3 402.7 5014.7 5022.6 5110.3 5110.6 5123.7 4131.1 4837.9 5004.4 5057.0 5102.2 3461.8 3822.3 4037.9 4085.0 4273.5 3728.3 4248.2 4268.0 4302.2 4336.9 3638.1 3687.2 3764.3 4265.4 4337.0 3983.6 4219.4 4279.9 4353.6 4372.8 3610.6 3810.3 3947.0 3968.5 3980.6 5031.6 5055.8 5063.5 5075.7 5101.6 4244.2 4462.1 4964.4 4971.4 5038.2 4612.4 4909.6 5222.8 5269.9 5515.5 3759.0 4424.9 4429.6 4439.8 4459.9 5444.5 5493.7 5626.4 5808.2 5822.0 3309.7 3559.4 4014.6 4450.5 4512.8 3611.0 3974.9 4100.7 4637.3 4641.4 4572.7 4597.9 4664.6 4689.6 4726.7 4593.4 5407.7 5435.7 5469.7 5556.6 1251.1 1277.2 1331.9 1558.8 1574.5 1008.9 1105.5 1168.5 1184.1 1187.8 4616.2 4850.5 4940.0 5132.2 5158.4 4816.2 5152.7 5568.1 5568.9 5628.8 4646.4 4827.9 4904.8 4951.8 5135.7 2562.2 2660.7 2729.8 2838.5 2942.9 4894.8 5290.6 5564.8 5615.8 5881.8 5436.6 5592.3 5708.4 5715.5 5731.7 5034.7 5072.3 5261.4 5273.2 5426.5 4995.0 5103.6 5280.3 5645.2 5734.9 4986.8 5315.8 5546.9 5562.8 5579.4 5106.4 5316.5 5347.9 5593.7 5798.4 3910.9 4464.4 4470.7 4543.5 4543.6 4551.5 5265.3 5471.7 5569.6 5585.5 4801.0 4959.9 5111.0 5141.9 5143.7 4528.6 4811.9 5151.1 5376.5 5473.0 4604.0 4985.2 5255.8 5344.5 5411.6 4867.6 5044.2 5232.7 5365.6 5410.9 5127.3 5328.5 5334.4 5373.1 5402.7 08:02:12 INFO - PROCESS | 1640 | 08:02:12 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20256.30 Median:17852.64 stddev:28332.59 (158.7%) stddev-sans-first:28374.25 08:02:12 INFO - PROCESS | 1640 | Values: 761.4 793.9 816.1 863.9 900.7 13539.1 14495.8 14497.6 14502.9 14536.2 15441.8 15603.2 15774.6 15954.1 15961.3 965.6 967.1 967.5 968.2 970.4 955.5 956.8 958.0 958.3 1011.0 1072.8 1073.3 1076.1 1083.0 1083.1 1067.2 1067.3 1068.2 1069.0 1069.2 796.4 796.7 796.9 797.5 799.2 16879.2 17149.5 17183.9 17710.8 17994.5 14683.7 14752.9 14793.8 14903.4 14928.6 11757.6 11963.4 11974.3 12108.5 12475.0 3410.5 3791.3 3954.5 4015.9 4064.5 109820.0 120636.4 121153.0 122609.0 122688.0 11296.4 11431.7 11495.1 11545.8 11797.9 24010.5 24476.6 24504.1 24504.8 24504.9 8118.3 8158.6 8205.1 8223.9 8248.8 4538.4 4550.4 4568.9 4647.2 4839.8 3532.5 3624.6 3624.9 3627.5 3644.8 606.3 618.0 629.7 633.6 636.7 653.2 668.4 670.7 692.3 696.9 10173.5 10378.3 10431.8 10631.2 10640.1 627.2 632.4 665.6 685.1 685.8 4963.5 5000.0 5003.2 5346.7 5544.5 74033.6 83509.7 86056.1 93178.5 106963.0 62259.0 70757.0 74216.3 83746.9 87418.6 54167.2 69456.0 71268.6 73891.5 74802.1 11052.9 11106.9 11190.0 11294.3 11500.3 48329.5 48359.0 49300.8 49855.0 52300.5 63548.0 66786.7 68778.0 69374.0 72933.6 13526.6 13624.9 13671.9 13680.3 13790.4 12682.3 15126.2 15761.3 15818.9 16027.8 13979.8 14126.9 14787.3 14806.6 14810.8 13914.2 14551.0 14572.1 15094.0 15397.3 14030.2 14133.8 14159.8 14245.6 14431.5 10029.4 10104.2 10346.5 10766.5 10864.4 10706.5 10946.9 11075.0 11614.5 11619.8 08:02:12 INFO - PROCESS | 1640 | -------- Summary: end -------- 08:02:12 INFO - PROCESS | 1640 | 08:02:13 INFO - TEST-INFO | 1640: exit 0 08:02:13 INFO - TEST-OK | dromaeo_css | took 1118662ms 08:02:13 INFO - TEST-START | kraken 08:02:13 INFO - operating with platform_type : mac_ 08:02:13 INFO - Initialising browser for kraken test... 08:02:13 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpiYuYBM/profile http://localhost:49242/getInfo.html) 08:02:15 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:02:15 INFO - PROCESS | 1649 | colorDepth:24 08:02:15 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:02:15 INFO - PROCESS | 1649 | __metrics 08:02:15 INFO - PROCESS | 1649 | 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" 08:02:15 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:16 INFO - TEST-INFO | 1649: exit 0 08:02:16 INFO - Browser initialized. 08:02:16 INFO - Running cycle 1/1 for kraken test... 08:02:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/T/tmpiYuYBM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:28 INFO - PROCESS | 1651 | RSS: Main: 165163008 08:02:28 INFO - PROCESS | 1651 | 08:02:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:32 INFO - PROCESS | 1651 | RSS: Main: 216051712 08:02:32 INFO - PROCESS | 1651 | 08:02:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 08:02:35 INFO - PROCESS | 1651 | RSS: Main: 231817216 08:02:35 INFO - PROCESS | 1651 | 08:02:38 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 08:02:39 INFO - PROCESS | 1651 | RSS: Main: 328306688 08:02:39 INFO - PROCESS | 1651 | 08:02:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 08:02:41 INFO - PROCESS | 1651 | RSS: Main: 229371904 08:02:41 INFO - PROCESS | 1651 | 08:02:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:44 INFO - PROCESS | 1651 | RSS: Main: 230555648 08:02:44 INFO - PROCESS | 1651 | 08:02:47 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:47 INFO - PROCESS | 1651 | RSS: Main: 272547840 08:02:47 INFO - PROCESS | 1651 | 08:02:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:51 INFO - PROCESS | 1651 | RSS: Main: 272678912 08:02:51 INFO - PROCESS | 1651 | 08:02:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 08:02:55 INFO - PROCESS | 1651 | RSS: Main: 267739136 08:02:55 INFO - PROCESS | 1651 | 08:02:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:02:57 INFO - PROCESS | 1651 | RSS: Main: 248360960 08:02:57 INFO - PROCESS | 1651 | 08:02:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:59 INFO - PROCESS | 1651 | RSS: Main: 250048512 08:02:59 INFO - PROCESS | 1651 | 08:03:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:02 INFO - PROCESS | 1651 | RSS: Main: 256827392 08:03:02 INFO - PROCESS | 1651 | 08:03:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:06 INFO - PROCESS | 1651 | RSS: Main: 263057408 08:03:06 INFO - PROCESS | 1651 | 08:03:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:09 INFO - PROCESS | 1651 | RSS: Main: 264179712 08:03:09 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 08:03:11 INFO - PROCESS | 1651 | RSS: Main: 308875264 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | __start_tp_report 08:03:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:03:11 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:03:11 INFO - PROCESS | 1651 | |i|pagename|runs| 08:03:11 INFO - PROCESS | 1651 | |0;ai-astar;104;116;115;116;116;116;116;114;122;172 08:03:11 INFO - PROCESS | 1651 | |1;audio-beat-detection;133;109;103;129;108;109;137;133;143;107 08:03:11 INFO - PROCESS | 1651 | |2;audio-dft;250;258;188;184;183;187;185;184;197;261 08:03:11 INFO - PROCESS | 1651 | |3;audio-fft;81;58;59;90;60;60;60;59;75;61 08:03:11 INFO - PROCESS | 1651 | |4;audio-oscillator;88;69;85;69;68;68;81;67;67;83 08:03:11 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;86;87;88;86;87;87;87;86;87;88 08:03:11 INFO - PROCESS | 1651 | |6;imaging-darkroom;94;93;98;94;93;93;96;89;133;150 08:03:11 INFO - PROCESS | 1651 | |7;imaging-desaturate;106;126;126;87;86;86;86;85;83;83 08:03:11 INFO - PROCESS | 1651 | |8;json-parse-financial;62;62;59;63;62;63;65;62;63;62 08:03:11 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;54;56;67;66;61;57;57;57;58;58 08:03:11 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;82;88;99;83;85;83;83;83;87;107 08:03:11 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;144;140;134;132;126;122;134;154;123 08:03:11 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;166;163;162;163;163;169;208;187;165;148 08:03:11 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;62;65;64;64;62;63;63;64;66 08:03:11 INFO - PROCESS | 1651 | __end_tp_report 08:03:11 INFO - PROCESS | 1651 | __start_cc_report 08:03:11 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2045 08:03:11 INFO - PROCESS | 1651 | __end_cc_report 08:03:11 INFO - PROCESS | 1651 | __startTimestamp1493132591563__endTimestamp 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:03:11 INFO - PROCESS | 1651 | Number of tests: 14 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:120.70 Median:116.00 stddev:18.56 (16.0%) stddev-sans-first:18.68 08:03:11 INFO - PROCESS | 1651 | Values: 104.0 116.0 115.0 116.0 116.0 116.0 116.0 114.0 122.0 172.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:131.00 stddev:15.16 (11.6%) stddev-sans-first:15.46 08:03:11 INFO - PROCESS | 1651 | Values: 133.0 109.0 103.0 129.0 108.0 109.0 137.0 133.0 143.0 107.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:207.70 Median:192.50 stddev:33.90 (17.6%) stddev-sans-first:32.31 08:03:11 INFO - PROCESS | 1651 | Values: 250.0 258.0 188.0 184.0 183.0 187.0 185.0 184.0 197.0 261.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.30 Median:60.50 stddev:11.43 (18.9%) stddev-sans-first:10.82 08:03:11 INFO - PROCESS | 1651 | Values: 81.0 58.0 59.0 90.0 60.0 60.0 60.0 59.0 75.0 61.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:75.00 stddev:8.59 (11.5%) stddev-sans-first:7.60 08:03:11 INFO - PROCESS | 1651 | Values: 88.0 69.0 85.0 69.0 68.0 68.0 81.0 67.0 67.0 83.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 08:03:11 INFO - PROCESS | 1651 | Values: 86.0 87.0 88.0 86.0 87.0 87.0 87.0 86.0 87.0 88.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:93.50 stddev:20.66 (22.1%) stddev-sans-first:21.63 08:03:11 INFO - PROCESS | 1651 | Values: 94.0 93.0 98.0 94.0 93.0 93.0 96.0 89.0 133.0 150.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:85.50 stddev:17.44 (20.4%) stddev-sans-first:18.07 08:03:11 INFO - PROCESS | 1651 | Values: 106.0 126.0 126.0 87.0 86.0 86.0 86.0 85.0 83.0 83.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.50 stddev:1.49 (2.4%) stddev-sans-first:1.58 08:03:11 INFO - PROCESS | 1651 | Values: 62.0 62.0 59.0 63.0 62.0 63.0 65.0 62.0 63.0 62.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.00 stddev:4.28 (7.4%) stddev-sans-first:4.12 08:03:11 INFO - PROCESS | 1651 | Values: 54.0 56.0 67.0 66.0 61.0 57.0 57.0 57.0 58.0 58.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:84.00 stddev:8.35 (9.9%) stddev-sans-first:8.57 08:03:11 INFO - PROCESS | 1651 | Values: 82.0 88.0 99.0 83.0 85.0 83.0 83.0 83.0 87.0 107.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:136.50 stddev:9.93 (7.3%) stddev-sans-first:10.42 08:03:11 INFO - PROCESS | 1651 | Values: 139.0 144.0 140.0 134.0 132.0 126.0 122.0 134.0 154.0 123.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:165.50 stddev:16.55 (10.0%) stddev-sans-first:17.51 08:03:11 INFO - PROCESS | 1651 | Values: 166.0 163.0 162.0 163.0 163.0 169.0 208.0 187.0 165.0 148.0 08:03:11 INFO - PROCESS | 1651 | 08:03:11 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.32 (2.1%) stddev-sans-first:1.32 08:03:11 INFO - PROCESS | 1651 | Values: 65.0 62.0 65.0 64.0 64.0 62.0 63.0 63.0 64.0 66.0 08:03:11 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:03:11 INFO - PROCESS | 1651 | 08:03:12 INFO - TEST-INFO | 1651: exit 0 08:03:12 INFO - TEST-OK | kraken | took 58966ms 08:03:12 INFO - SUITE-END | took 1177s 08:03:12 INFO - Completed test suite (00:19:37) 08:03:12 INFO - javascript benchmark 08:03:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7796.447229933072, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2733.316670832292, 3032.4238394705003, 3545.8758943436983, 3557.6620221079006, 3573.5711714594254, 5004.7998080076795, 6109.877802443949, 6146.0473626587955, 6184.381561843819, 6200.348963358844, 6031.72857221425, 6113.174721412608, 6134.87730245396, 6146.385361463851, 6157.753689852411, 5402.324709411333, 5425.864353391177, 5450.618456708032, 5455.563554915617, 5584.106542953128, 5332.706701131437, 5348.064088784467, 5366.302380690524, 5540.335159780832, 5594.104943209088, 5426.131818908975, 5473.452654734515, 5532.474414930575, 5533.253010843545, 5543.6119471637, 5449.264349312852, 5474.562035037207, 5506.284183056177, 5506.476884695948, 5514.5864060195645, 5290.867728306785, 5426.403095659474, 5436.374816896068, 5481.780728770845, 5499.560035197174, 5856.092305692625, 5898.852528686774, 5969.224000879901, 5980.820575382745, 5998.790042348497, 6226.470749986257, 6235.469985051276, 6235.594686345373, 6243.500519958392, 6311.431971122575, 6492.837679058014, 6499.415052645285, 6507.967460162717, 6524.0, 6528.0, 6168.660723660197, 6216.3162052174675, 6224.221972253468, 6230.221222347207, 6240.5319601030105, 6311.147995020705, 6611.074449577063, 6614.206295244601, 6637.701303441357, 6640.269570347258, 6210.099535567318, 6241.21984751906, 6246.718897649616, 6250.531210159165, 6256.186695729526, 6474.0612611172055, 6480.222373315232, 6480.416762491304, 6482.254540727877, 6490.02649602554, 6366.299707032223, 6391.201099862517, 6403.071554624554, 6407.103005579223, 6473.805785826433, 5788.652680839163, 5791.9284932287665, 6180.536459765535, 6201.937980620136, 6372.6495042773095, 5099.898002039939, 5111.5655169310285, 5116.9744151279, 5121.590272778169, 5212.869678258074, 3612.512310838056, 4624.098300831373, 4628.814847406066, 4648.976755116203, 4658.0, 6099.329073801879, 6145.446909778141, 6167.691615419211, 6171.537134714914, 6180.505559555225, 6203.0, 6238.033104868752, 6437.2275326960125, 6446.709898054599, 6468.417842394207, 6029.517638588903, 6034.1853849730605, 6038.275406951194, 6044.667543285073, 6060.181875446759, 5592.468715472024, 5603.943960560424, 5604.159376093537, 5612.102063669875, 5623.044082505984, 6395.0, 6461.999999999906, 6476.352364763486, 6487.124238227968, 6487.2215334159255, 6146.078088286793, 6362.809115726535, 6422.775202867877, 6456.031595260749, 6493.9934310182, 6653.201615806134, 6693.631850248283, 6701.0953521274005, 6709.094272273376, 6731.1922569292, 5231.189165679326, 5411.404745478073, 6374.649394283359, 6402.35976402356, 6418.229812422353, 6164.7842325518395, 6203.16257305258, 6264.624122552661, 6307.43233109004, 6327.209098862642, 5186.844394668166, 6287.748490060347, 6289.842753931005, 6292.622442653455, 6299.149614801943, 6246.937530624636, 6258.061290806233, 6289.874202515833, 6294.622322660655, 6306.2747784003595, 6292.811215663537, 6299.685015749103, 6309.369063093837, 6331.271903730945, 6337.207849018872, 6149.446549810538, 6164.599301045418, 6279.71741271653, 6280.246370435577, 6300.2754683212015, 6117.0, 6171.1360409543595, 6239.594426362272, 6293.559450838397, 6305.306416294296], "value": 5891.448314218267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.5990765217651, 829.7759604906673, 900.4912224593104, 910.7677542226735, 914.1681070226095, 42565.57434425655, 43426.78286608566, 43686.0, 43688.3446748299, 43689.0, 42965.570344296546, 43111.35332970008, 43163.0, 43184.56815431845, 43226.351604725955, 7985.081715602693, 9808.11726944575, 9965.20278377728, 9975.0, 9993.0, 7992.960035199816, 8070.677172913076, 8075.111737708848, 8087.069986951487, 11928.821067683992, 12194.573189938354, 12198.695032624211, 12230.571929982452, 12240.693982650417, 12252.816207756847, 12142.210756300856, 12160.209586376857, 12182.81725774114, 12184.20802647834, 12187.512499500053, 11850.585229517012, 11913.10651701126, 11920.523179072827, 11947.462364193632, 11952.940235298767, 41053.58946410557, 41168.176636467106, 41216.76349709513, 41256.968575785846, 41307.58692413098, 3980.840766369342, 4002.419649150886, 4018.678505719565, 4034.9394759078637, 4046.9595304046875, 28484.28789280264, 29238.56142157869, 29842.552361714592, 30158.0, 30919.84540077285, 2978.0321395546534, 3251.951220731667, 3292.670732926712, 3310.0400883743687, 3335.182880194344, 370307.0, 370423.0, 370542.0, 371007.0, 371073.0, 43287.134257314676, 43918.68243952686, 53980.46019539754, 53992.73003634957, 54003.0, 54099.188512172346, 55060.0, 57545.424545754846, 57628.42371576314, 57745.422545774, 15256.542303730906, 15611.921940390452, 15637.687246255238, 15650.765238521431, 15658.217089145497, 13233.206007639572, 13271.402786874422, 13271.93364033193, 13290.269035202964, 13302.534411295559, 12201.145919785708, 12209.755804884031, 12212.328321942201, 12296.0, 12322.75354492923, 4642.257238841769, 5157.819476318311, 5303.893922121536, 5349.144136938071, 5363.490468405495, 1094.2559059839227, 1124.1624989382963, 1124.4987941098725, 1158.8783177766213, 1203.7231436769591, 23403.0, 23458.64812027821, 27076.0, 27317.590236146472, 27508.899644014415, 1259.2444533280143, 1271.650296168561, 1273.8789814967563, 1308.4962289518603, 1333.973320533584, 14024.859751402559, 14243.359048842827, 14479.565613031626, 14556.417743290362, 14603.050801698068, 469634.0, 608683.0, 617909.0, 619338.0, 619512.0, 50055.0, 50354.24468632974, 50408.495915041116, 50509.0, 50527.0, 1434.9354279057468, 1460.974248584907, 1474.7787831825096, 1478.4455829064102, 1485.2499487758828, 23539.705316207772, 26608.467830643665, 27200.047998320755, 27432.314192144557, 28138.2965425866, 41579.0, 41661.58338416577, 41733.58266417419, 41758.37362439626, 41891.371629424975, 447932.0, 448558.0, 450266.0, 451014.74492627324, 451505.0, 24534.631980520662, 24872.751272487043, 24878.0, 29611.703882960894, 29819.850900745358, 36207.63792362148, 37783.62216377801, 38989.44042238392, 39113.608863910995, 39133.0, 28159.71840281653, 28272.575911361757, 29022.274443138245, 29156.562651560667, 29500.557491637213, 23880.522389551763, 28346.149615511567, 28867.85566072156, 29022.984195553054, 29055.564166537097, 33170.0, 33510.16224594405, 33517.0, 33552.66447335593, 33565.99302020943, 23895.641565376187, 23921.28236152918, 24905.377365566004, 25786.0, 25932.351691207117, 22884.0, 23551.29346119619, 23618.17336393218, 23850.284491465285, 24138.637920430858], "value": 18950.632540484512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.8105947026487, 421.5236782435845, 430.39529461107117, 437.27630771073876, 460.5256585716711, 21112.4721881953, 22105.778942210574, 22558.323250302496, 23161.76838231617, 23438.0, 23408.5318293634, 23610.05559777611, 23940.281791546236, 24051.518969620596, 24188.758112418913, 6845.794626161223, 6911.792646220596, 7052.259512751164, 7052.682629281695, 7224.7110115595315, 6459.6447195404235, 7025.543339682904, 7036.542624729376, 7059.788206353817, 7128.643567821614, 7991.520508769463, 8033.638486268132, 8051.4766540175, 8062.879056814152, 8071.878921816177, 5171.741412929376, 5185.714785686786, 5201.40183878855, 5208.687478751268, 7809.984701988734, 5106.591472682177, 5107.463716309809, 5107.668001579886, 5121.667091639031, 5146.253793200002, 22365.0, 26918.0, 27200.31999200016, 27259.727402726116, 27282.31794205141, 2912.344722437456, 3087.938241235163, 3097.7212050915527, 3097.814131152138, 3143.654198038214, 16251.593710157222, 16632.83367166325, 17032.0, 17949.371771987917, 17951.281948722037, 1980.0014887229154, 2016.9092390842447, 2047.2220556188702, 2055.797358545253, 2136.8717876927435, 112766.43616781945, 122562.0, 124955.0, 138214.0, 169183.0, 16740.83259167417, 17936.461906142835, 20878.37364879056, 20902.0, 20993.950302485122, 32798.67201328004, 33252.66747332496, 33260.0, 33404.498932516035, 33436.0, 8756.824863502694, 10674.412907290174, 10893.945530272456, 11087.113030957504, 11262.0, 9176.403533770284, 9201.309901757395, 9232.307576931757, 9372.39079459833, 9377.578008989612, 9370.437773733598, 9420.34057615974, 9475.336726429085, 9570.186534144537, 9593.712188634352, 3127.5934128563595, 3480.095175254452, 3910.7458015228917, 3922.980385098056, 4095.24238015968, 756.345760916814, 783.3549545953452, 841.8568843296654, 934.5794392523392, 944.9716508504756, 22466.865647763436, 23016.964236609394, 23040.0, 23042.769572304398, 23061.0, 863.8963324401112, 869.4044579463088, 982.4252812104855, 996.3374356053289, 1010.1060561403065, 11352.48913798881, 11637.88362116368, 11896.583619573274, 11948.641540753792, 11976.981956533618, 626755.0, 770744.0, 782768.0, 796384.0, 800762.0, 123342.0, 156370.0, 157327.0, 164464.0, 168724.0, 1254.9686257843628, 1286.0547497589264, 1317.2623330934516, 1320.4850108457708, 1328.8472674267555, 19204.71192932135, 19413.708794367813, 19672.21311147538, 19693.70459443081, 19711.80288197157, 63096.68451657896, 63311.733765323515, 63439.68280158754, 64421.033684495706, 67212.0, 93124.06875931154, 93204.0, 94152.05847941434, 94329.8118603456, 96004.51997739967, 11361.772764544829, 11422.771544569228, 11653.47559359814, 11850.76298474043, 11903.047756179312, 10066.848997265193, 12573.308468034345, 12850.100492965403, 12867.356632168166, 12981.156224845356, 11096.889031109586, 11143.442827858737, 11196.832047519456, 11293.943530282297, 11345.602903898323, 10251.38491690501, 10307.896921030993, 10602.310849794738, 10646.520906559379, 10674.57301707923, 11241.831372529583, 11388.829167562659, 11541.307521548733, 11621.418929053345, 11682.12384071181, 10767.275110731498, 11326.603568875049, 11540.769184616429, 11557.07543396543, 11723.648290551297, 9646.276529260474, 11262.436878156223, 11278.09775217997, 11570.363630000431, 11601.361925094201], "value": 11599.620360404946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1610.4282979542254, 1621.1813034417617, 1647.0858673436237, 1647.250501022035, 1667.8582320502758, 10824.079953203976, 11460.31238125713, 11494.0, 11498.367589782558, 11498.367589782558, 10857.51141198646, 11129.0, 11181.217314787948, 11334.829977550344, 11343.319400835955, 2474.0969546115675, 2515.0065724038996, 2518.785903198221, 2520.621906713989, 2523.709773376067, 2453.852768833867, 2457.9754202458016, 2489.9253022409266, 2491.115653942851, 2492.339530024536, 2442.487077713682, 2446.5351583199226, 2457.4347899983013, 2492.3644470659956, 2497.5254701606636, 2075.63676356637, 2430.6840110785574, 2446.3272600034957, 2460.4709987352717, 2493.0277191895175, 2446.681931348931, 2464.2853572463964, 2472.678551788256, 2476.3809047738064, 2489.427431690703, 11109.666709998632, 11366.261193022427, 11368.0, 11376.317420954769, 11379.658610241706, 5969.70151492428, 6175.413335733098, 6179.783707570214, 6181.6600086995195, 6195.4424101831055, 3642.9271414571826, 3745.325841348556, 3784.0350710568628, 3836.3094642964256, 3840.3663395539984, 1291.7610242105147, 1491.671832196915, 1789.4452719656947, 1926.5954149628594, 1942.0, 14343.067700599531, 14682.779758303634, 15004.02473839197, 15746.606334841606, 16090.678186436206, 4310.590493903074, 5040.470750571138, 5067.746612669425, 5213.13983192769, 5219.660722053054, 7277.526960747535, 12284.570040048555, 12427.70087533809, 12477.376131193403, 13453.394597243148, 5807.332156801937, 5942.554308426886, 5958.46373826349, 5965.28416590012, 6036.5170786336985, 5283.705492154447, 5373.032854086302, 5376.946230537723, 5396.703181325065, 5481.75332110056, 4217.502786510806, 4238.237117318912, 4274.316109422478, 4328.134373125387, 4333.0, 1156.843826083468, 1168.526746667601, 1171.619223752284, 1188.4295538141741, 1192.527228872342, 987.1757082835912, 988.110700369673, 1002.0430488883245, 1020.3418794877412, 1032.4012072997643, 6628.767993120314, 6821.658917054127, 6833.0092136639905, 6897.241303456616, 7067.151941766918, 958.8178246133212, 1052.1687866585464, 1074.4735079810837, 1075.7364445710693, 1104.7956128116325, 3628.600853906068, 3861.7489863159367, 3925.823337949799, 4200.600942910419, 4285.571442855689, 13508.392122354519, 13955.372008259652, 13978.86021139796, 14077.71844563103, 14111.858881411055, 11640.592579259684, 13625.114367566077, 13949.790753138712, 14092.506762263272, 14096.788548171786, 10425.791484170275, 10594.894051059546, 10610.0, 10610.68167954947, 10619.628313009007, 6387.0, 6606.273309935999, 6696.631685257357, 6770.356816102462, 6779.661016949034, 12271.325077120844, 12729.490820367451, 12737.87262127367, 12738.617841464771, 12743.681407964876, 12567.0, 12569.245845249314, 12862.97096232318, 12933.417996190383, 12973.771850549992, 9375.906240937777, 9457.054294570487, 9562.235021198148, 9585.137337639646, 9589.616415343307, 10395.32430392022, 10430.791384172426, 10441.269111162146, 10537.736556586147, 10545.525451354553, 8942.776430589287, 8979.371443998858, 9049.683261085831, 9071.637134514545, 9221.216196623362, 7501.887471688038, 8764.649414023368, 8804.075572065098, 8829.558522074, 9014.684486042957, 8101.149379315087, 8179.79550511242, 8269.04905935825, 8291.461055031403, 8308.958455207685, 5914.0, 5936.13925980739, 5954.970225148846, 6120.877582448237, 6183.3816618337805, 5267.789288428573, 6059.706073070944, 6098.725557349841, 6132.540059495466, 6267.2479302484], "value": 5348.712243660428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6627236669896, 371.4409813231089, 390.9765414075156, 391.25661243637086, 402.72614622057006, 5014.724190169539, 5022.598192144629, 5110.310108135401, 5110.591152707779, 5123.6925784452915, 4131.111810960643, 4837.9438738536155, 5004.374453193351, 5057.0, 5102.209157580581, 3461.8442170102408, 3822.337283281767, 4037.8586749463775, 4084.95752123938, 4273.465816772903, 3728.303621852064, 4248.192843359767, 4268.0, 4302.20409224293, 4336.891577710567, 3638.1268495561008, 3687.1793078295127, 3764.270903594899, 4265.445492086024, 4336.97831510842, 3983.621555952209, 4219.367094935784, 4279.914401711964, 4353.586409291112, 4372.825086996532, 3610.6028336882923, 3810.2760475509563, 3946.960530394688, 3968.523777146761, 3980.6465801627296, 5031.597472202215, 5055.772490237911, 5063.518965698253, 5075.670081444694, 5101.566366858821, 4244.214820258231, 4462.085272519158, 4964.429090654585, 4971.37857767779, 5038.244263360489, 4612.4003879495785, 4909.576222895392, 5222.772648427616, 5269.86825329366, 5515.4760297771645, 3758.962410375916, 4424.911501769947, 4429.601335879786, 4439.7780110994645, 4459.9331010034875, 5444.481080703086, 5493.670379777226, 5626.355612861948, 5808.21205821204, 5822.0, 3309.6855798699085, 3559.394902866519, 4014.578469260744, 4450.532694067077, 4512.842050528216, 3611.0, 3974.940375894364, 4100.65144462718, 4637.333533218345, 4641.443026836801, 4572.74849883253, 4597.885052873638, 4664.603508701798, 4689.554492323224, 4726.71639701619, 4593.425821772278, 5407.674280317577, 5435.728213589384, 5469.714617064987, 5556.583256255797, 1251.0795928250093, 1277.163457935054, 1331.9134256273312, 1558.8153003717257, 1574.5197714696899, 1008.8890222075565, 1105.5025238642481, 1168.4800263882491, 1184.1178322150054, 1187.7743228786503, 4616.1996821239745, 4850.53919877611, 4940.047243072089, 5132.230165475134, 5158.3552055993005, 4816.220535357585, 5152.742362881841, 5568.106843673089, 5568.916466253009, 5628.79158879443, 4646.395968524071, 4827.903441931142, 4904.779284932187, 4951.83082826991, 5135.6918584885025, 2562.2448622693514, 2660.7095558654037, 2729.785245565744, 2838.5174520331593, 2942.867570959312, 4894.755262236874, 5290.550303224269, 5564.777408903679, 5615.803446879339, 5881.764729410861, 5436.565074794007, 5592.3009623797025, 5708.402676782137, 5715.5427565794635, 5731.7298612533095, 5034.672746271481, 5072.289879416885, 5261.394939581997, 5273.156294992783, 5426.538744206708, 4994.975025124996, 5103.617228707788, 5280.260763493191, 5645.237892884572, 5734.885302294014, 4986.803167239909, 5315.777371204567, 5546.889062218653, 5562.776189238361, 5579.414161512983, 5106.438291787975, 5316.468353164652, 5347.903679745565, 5593.727669313497, 5798.391168927202, 3910.865848903786, 4464.419625448671, 4470.731756094645, 4543.4775000875325, 4543.6365090793315, 4551.522090180483, 5265.315508983807, 5471.699056551928, 5569.567149941824, 5585.525230355465, 4800.975995120002, 4959.933614272949, 5110.97444512775, 5141.89449268409, 5143.7428128594165, 4528.592426681483, 4811.879703007313, 5151.110911261973, 5376.521456599467, 5473.0, 4603.953960460486, 4985.202367621163, 5255.842324730264, 5344.4922732340365, 5411.648242864201, 4867.561919427269, 5044.167712327571, 5232.738363081907, 5365.624406291522, 5410.945890541044, 5127.282180494659, 5328.547073498796, 5334.386545547157, 5373.059714550016, 5402.729863506887], "value": 4125.371126860843, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.3794757272823, 793.9245771651691, 816.0656048824096, 863.9459858972052, 900.6532484993278, 13539.052266341349, 14495.782563261559, 14497.565073047812, 14502.854971450282, 14536.200508972002, 15441.768373474408, 15603.219839008061, 15774.605634859134, 15954.122523261216, 15961.281742321595, 965.5992763003345, 967.0764419978939, 967.4630580028081, 968.1770495079162, 970.3838062830118, 955.4601650067724, 956.7512446763857, 957.9941061884992, 958.3291695812924, 1010.9797804043915, 1072.785442911417, 1073.2701762801291, 1076.0745758647556, 1082.983755243668, 1083.0847933496184, 1067.1729409707461, 1067.3169171730099, 1068.1561566362602, 1068.9625863094755, 1069.150025729539, 796.3509739562296, 796.7330944133722, 796.9481983671043, 797.5095316380384, 799.2447137455107, 16879.24043418037, 17149.485515434557, 17183.914080429517, 17710.822891771048, 17994.460166194905, 14683.706325873423, 14752.852471475255, 14793.778093328609, 14903.403863845433, 14928.552143435605, 11757.647270581896, 11963.40182990847, 11974.34141122238, 12108.515659373614, 12475.0, 3410.539577157077, 3791.279656865187, 3954.5254569451563, 4015.9397609035886, 4064.471618689581, 109819.9999999992, 120636.39681801622, 121153.0, 122609.0, 122688.0, 11296.43517824122, 11431.657050288504, 11495.080393568494, 11545.826812597817, 11797.941010295066, 24010.51978960411, 24476.632850507256, 24504.142355017488, 24504.754952450246, 24504.89727962246, 8118.309943654737, 8158.632861521246, 8205.056418511947, 8223.876641850376, 8248.793780155424, 4538.387317712132, 4550.362949187116, 4568.88577785558, 4647.233206520954, 4839.830605928775, 3532.523109380252, 3624.5831729350934, 3624.9456258156147, 3627.4921510988484, 3644.835982380799, 606.254307202135, 618.038949433626, 629.7071861584385, 633.6419922743635, 636.6848410037061, 653.1867824558456, 668.4418510543653, 670.7283550162192, 692.2661978303015, 696.8884978403532, 10173.491325433846, 10378.325408848401, 10431.791364172826, 10631.202659800545, 10640.095591874777, 627.1658693937053, 632.3644737039247, 665.5806841689705, 685.0990946904903, 685.7609903664539, 4963.528464795839, 5000.0, 5003.249512573143, 5346.6926320692355, 5544.528715059265, 74033.6298318505, 83509.74735378975, 86056.13943860482, 93178.53410733039, 106963.0, 62259.0, 70757.0, 74216.25783742202, 83746.90632734109, 87418.56290718506, 54167.18749218686, 69456.0, 71268.57462850817, 73891.52216955523, 74802.12994675068, 11052.944735276595, 11106.944465277622, 11190.0, 11294.322340659586, 11500.309981401142, 48329.5167048325, 48359.0, 49300.75349623372, 49855.0202971577, 52300.47699523108, 63548.0, 66786.66426671536, 68778.0, 69374.0, 72933.635331823, 13526.59420217395, 13624.863751362756, 13671.931640342133, 13680.31598420095, 13790.379432925743, 12682.28478554561, 15126.243687815786, 15761.290741916871, 15818.92090539586, 16027.839721602635, 13979.790303145257, 14126.858731412554, 14787.260636967894, 14806.555803325487, 14810.77783833265, 13914.174252275892, 14551.0, 14572.125672459686, 15094.0, 15397.30712117935, 14030.22833744113, 14133.787993180316, 14159.787603186167, 14245.572632821031, 14431.49489767853, 10029.44838033886, 10104.165117328052, 10346.482675866328, 10766.515506802056, 10864.402457864577, 10706.506368431374, 10946.890531094905, 11075.0, 11614.477348519506, 11619.825702614298], "value": 7858.45323649975, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1453.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 115.0, 116.0, 116.0, 116.0, 116.0, 114.0, 122.0, 172.0], "value": 120.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 109.0, 103.0, 129.0, 108.0, 109.0, 137.0, 133.0, 143.0, 107.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [250.0, 258.0, 188.0, 184.0, 183.0, 187.0, 185.0, 184.0, 197.0, 261.0], "value": 207.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 90.0, 60.0, 60.0, 60.0, 59.0, 75.0, 61.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 85.0, 69.0, 68.0, 68.0, 81.0, 67.0, 67.0, 83.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 88.0, 86.0, 87.0, 87.0, 87.0, 86.0, 87.0, 88.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 98.0, 94.0, 93.0, 93.0, 96.0, 89.0, 133.0, 150.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 126.0, 126.0, 87.0, 86.0, 86.0, 86.0, 85.0, 83.0, 83.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 59.0, 63.0, 62.0, 63.0, 65.0, 62.0, 63.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 67.0, 66.0, 61.0, 57.0, 57.0, 57.0, 58.0, 58.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 99.0, 83.0, 85.0, 83.0, 83.0, 83.0, 87.0, 107.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 144.0, 140.0, 134.0, 132.0, 126.0, 122.0, 134.0, 154.0, 123.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 162.0, 163.0, 163.0, 169.0, 208.0, 187.0, 165.0, 148.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 64.0, 64.0, 62.0, 63.0, 63.0, 64.0, 66.0], "value": 63.8, "unit": "score"}]}]} 08:03:12 INFO - Return code: 0 08:03:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:12 INFO - # TBPL SUCCESS # 08:03:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:12 INFO - 2017-04-25 08:03:12.895 screenresolution[1655:9726] starting screenresolution argv=screenresolution get 08:03:12 INFO - 2017-04-25 08:03:12.897 screenresolution[1655:9726] Display 0: 1600x1200x32@60 08:03:12 INFO - 2017-04-25 08:03:12.904 screenresolution[1656:9729] starting screenresolution argv=screenresolution list 08:03:12 INFO - Available Modes on Display 0 08:03:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:13 INFO - Intel Iris: 08:03:13 INFO - Chipset Model: Intel Iris 08:03:13 INFO - Type: GPU 08:03:13 INFO - Bus: Built-In 08:03:13 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:13 INFO - Vendor: Intel (0x8086) 08:03:13 INFO - Device ID: 0x0a2e 08:03:13 INFO - Revision ID: 0x0009 08:03:13 INFO - Displays: 08:03:13 INFO - Display: 08:03:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:13 INFO - Display Serial Number: 1600x1200 60 08:03:13 INFO - Main Display: Yes 08:03:13 INFO - Mirror: Off 08:03:13 INFO - Online: Yes 08:03:13 INFO - Rotation: Supported 08:03:13 INFO - Return code: 0 08:03:13 INFO - Running post-action listener: _resource_record_post_action 08:03:13 INFO - [mozharness: 2017-04-25 15:03:13.143563Z] Finished run-tests step (success) 08:03:13 INFO - Running post-run listener: _resource_record_post_run 08:03:13 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38347776; Write bytes: 420850688; Read time: 244; Write time: 1378 08:03:13 INFO - TinderboxPrint: CPU usage
53.7% 08:03:13 INFO - TinderboxPrint: I/O read bytes / time
38,347,776 / 244 08:03:13 INFO - TinderboxPrint: I/O write bytes / time
420,850,688 / 1,378 08:03:13 INFO - TinderboxPrint: CPU idle
2,212.4 (46.3%) 08:03:13 INFO - TinderboxPrint: CPU system
950.4 (19.9%) 08:03:13 INFO - TinderboxPrint: CPU user
1,610.9 (33.7%) 08:03:13 INFO - TinderboxPrint: Swap in / out
160,350,208 / 0 08:03:13 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123075072; Write bytes: 124061696; Read time: 11108; Write time: 291 08:03:13 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34325504; Write bytes: 295412736; Read time: 217; Write time: 1081 08:03:13 INFO - Running post-run listener: _upload_blobber_files 08:03:13 INFO - Blob upload gear active. 08:03:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:03:13 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'] 08:03:13 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 08:03:14 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:03:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:03:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:15 INFO - (blobuploader) - INFO - Done attempting. 08:03:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:03:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:03:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:17 INFO - (blobuploader) - INFO - Done attempting. 08:03:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:03:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:03:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:18 INFO - (blobuploader) - INFO - Done attempting. 08:03:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:20 INFO - (blobuploader) - INFO - Done attempting. 08:03:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:20 INFO - Return code: 0 08:03:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2834605887a6a8e33756856ec925e7f4d982a54cef9785a48e912cef05a058e81e2cd6dfcc4b73dd254d2a4c6b0a1d86c385114b88acba5a51c110b4f090102b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30146fc55eb1134e91504ca2c4c6eace87935b8ab8a8bad6d6f7e9a80732405a1312fcddb69f636d1b1f24a94b063214889d34baa71ecfa9b45c216f51055602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f552abb2893dd0fc161d124661d170fed02da2022df27190e7466dc5d4c0dceaa38df43b74e18000b3115a71cb0673bd215753f6945dc0368d02f289c6563a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f53ca60d09c5e5cd94de729272e1ad512a702c239637c4529dc19a7bf5b7bad27ebe245fd727902e531eb54853e5e34e7e307221d931d3397f951545f2f7f939"} 08:03:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:20 INFO - Contents: 08:03:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2834605887a6a8e33756856ec925e7f4d982a54cef9785a48e912cef05a058e81e2cd6dfcc4b73dd254d2a4c6b0a1d86c385114b88acba5a51c110b4f090102b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30146fc55eb1134e91504ca2c4c6eace87935b8ab8a8bad6d6f7e9a80732405a1312fcddb69f636d1b1f24a94b063214889d34baa71ecfa9b45c216f51055602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f552abb2893dd0fc161d124661d170fed02da2022df27190e7466dc5d4c0dceaa38df43b74e18000b3115a71cb0673bd215753f6945dc0368d02f289c6563a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f53ca60d09c5e5cd94de729272e1ad512a702c239637c4529dc19a7bf5b7bad27ebe245fd727902e531eb54853e5e34e7e307221d931d3397f951545f2f7f939"} 08:03:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:20 INFO - Copying logs to upload dir... 08:03:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.540709 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-25 08:03:20.323041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 08:03:20.328774) ========= 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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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/2834605887a6a8e33756856ec925e7f4d982a54cef9785a48e912cef05a058e81e2cd6dfcc4b73dd254d2a4c6b0a1d86c385114b88acba5a51c110b4f090102b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30146fc55eb1134e91504ca2c4c6eace87935b8ab8a8bad6d6f7e9a80732405a1312fcddb69f636d1b1f24a94b063214889d34baa71ecfa9b45c216f51055602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f552abb2893dd0fc161d124661d170fed02da2022df27190e7466dc5d4c0dceaa38df43b74e18000b3115a71cb0673bd215753f6945dc0368d02f289c6563a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f53ca60d09c5e5cd94de729272e1ad512a702c239637c4529dc19a7bf5b7bad27ebe245fd727902e531eb54853e5e34e7e307221d931d3397f951545f2f7f939"} build_url:https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/UYLdxYSdRHWPaQ3F-J0Jrg/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/2834605887a6a8e33756856ec925e7f4d982a54cef9785a48e912cef05a058e81e2cd6dfcc4b73dd254d2a4c6b0a1d86c385114b88acba5a51c110b4f090102b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30146fc55eb1134e91504ca2c4c6eace87935b8ab8a8bad6d6f7e9a80732405a1312fcddb69f636d1b1f24a94b063214889d34baa71ecfa9b45c216f51055602", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f552abb2893dd0fc161d124661d170fed02da2022df27190e7466dc5d4c0dceaa38df43b74e18000b3115a71cb0673bd215753f6945dc0368d02f289c6563a6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f53ca60d09c5e5cd94de729272e1ad512a702c239637c4529dc19a7bf5b7bad27ebe245fd727902e531eb54853e5e34e7e307221d931d3397f951545f2f7f939"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 08:03:20.363810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 08:03:20.364156) ========= 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.wQ9ha2tWFM/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.I4z9qdgMjC/Listeners TMPDIR=/var/folders/hr/wh__d5vx6m195v9p5jynqcc000000w/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.005212 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 08:03:20.413160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 08:03:20.413493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 08:03:20.413807) ========= ========= Total master_lag: 0.19 =========