builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1494021479.26 results: success (0) buildid: 20170505135642 builduid: d136471e25854d8187882ce90d66d575 revision: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.255573) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.256041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.256315) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.282236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.282648) ========= 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.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-05 14:57:59-- 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% 7.77M=0.001s 2017-05-05 14:57:59 (7.77 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.462818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.463131) ========= 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.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.022574 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 14:57:59.512867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:57:59.513403) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7868898154ed9e19d98d9aa4c53b7da57c2bd187 --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 7868898154ed9e19d98d9aa4c53b7da57c2bd187 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-05 14:57:59,591 truncating revision to first 12 chars 2017-05-05 14:57:59,591 Setting DEBUG logging. 2017-05-05 14:57:59,591 attempt 1/10 2017-05-05 14:57:59,591 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7868898154ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 14:58:00,436 unpacking tar archive at: mozilla-beta-7868898154ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094641 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 14:58:00.635083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:00.635616) ========= script_repo_revision: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:00.636292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:00.636785) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 14:58:00.659191) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-05 14:58:00.659819) ========= /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.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58:00 INFO - MultiFileLogger online at 20170505 14:58:00 in /builds/slave/test 14:58:00 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 14:58:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:00 INFO - {'append_to_log': False, 14:58:00 INFO - 'base_work_dir': '/builds/slave/test', 14:58:00 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:58:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:00 INFO - 'branch': 'Mozilla-Beta', 14:58:00 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:00 INFO - 'config_files': ('talos/mac_config.py',), 14:58:00 INFO - 'default_actions': ('clobber', 14:58:00 INFO - 'read-buildbot-config', 14:58:00 INFO - 'download-and-extract', 14:58:00 INFO - 'populate-webroot', 14:58:00 INFO - 'create-virtualenv', 14:58:00 INFO - 'install', 14:58:00 INFO - 'run-tests'), 14:58:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:00 INFO - 'download_minidump_stackwalk': True, 14:58:00 INFO - 'download_symbols': 'ondemand', 14:58:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:00 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:00 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:00 INFO - 'gecko_profile': False, 14:58:00 INFO - 'gecko_profile_interval': 0, 14:58:00 INFO - 'installer_path': 'installer.exe', 14:58:00 INFO - 'log_level': 'info', 14:58:00 INFO - 'log_name': 'talos', 14:58:00 INFO - 'log_to_console': True, 14:58:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:58:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:58:00 INFO - 'opt_config_files': (), 14:58:00 INFO - 'pip_index': False, 14:58:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:00 INFO - 'cmd': ('bash', 14:58:00 INFO - '-c', 14:58:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:00 INFO - 'enabled': True, 14:58:00 INFO - 'halt_on_failure': False, 14:58:00 INFO - 'name': 'check_screen_resolution'},), 14:58:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:58:00 INFO - 'cmd': ('bash', 14:58:00 INFO - '-c', 14:58:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:58:00 INFO - 'enabled': True, 14:58:00 INFO - 'halt_on_failure': False, 14:58:00 INFO - 'name': 'check_screen_resolution'},), 14:58:00 INFO - 'run_cmd_checks_enabled': True, 14:58:00 INFO - 'suite': 'dromaeojs', 14:58:00 INFO - 'system_bits': '32', 14:58:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:00 INFO - 'title': 't-yosemite-r7-0135', 14:58:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:00 INFO - 'use_talos_json': True, 14:58:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:00 INFO - 'work_dir': 'build'} 14:58:00 INFO - [mozharness: 2017-05-05 21:58:00.861769Z] Running clobber step. 14:58:00 INFO - Running pre-action listener: _resource_record_pre_action 14:58:00 INFO - Running main action method: clobber 14:58:00 INFO - rmtree: /builds/slave/test/build 14:58:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:03 INFO - Running post-action listener: _resource_record_post_action 14:58:03 INFO - [mozharness: 2017-05-05 21:58:03.006932Z] Finished clobber step (success) 14:58:03 INFO - [mozharness: 2017-05-05 21:58:03.007141Z] Running read-buildbot-config step. 14:58:03 INFO - Running pre-action listener: _resource_record_pre_action 14:58:03 INFO - Running main action method: read_buildbot_config 14:58:03 INFO - Using buildbot properties: 14:58:03 INFO - { 14:58:03 INFO - "project": "", 14:58:03 INFO - "product": "firefox", 14:58:03 INFO - "script_repo_revision": "production", 14:58:03 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:58:03 INFO - "repository": "", 14:58:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:58:03 INFO - "buildid": "20170505135642", 14:58:03 INFO - "pgo_build": "False", 14:58:03 INFO - "basedir": "/builds/slave/test", 14:58:03 INFO - "buildnumber": 20, 14:58:03 INFO - "slavename": "t-yosemite-r7-0135", 14:58:03 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:58:03 INFO - "platform": "yosemite_r7", 14:58:03 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:58:03 INFO - "branch": "mozilla-beta", 14:58:03 INFO - "repo_path": "releases/mozilla-beta", 14:58:03 INFO - "revision": "7868898154ed9e19d98d9aa4c53b7da57c2bd187", 14:58:03 INFO - "stage_platform": "macosx64", 14:58:03 INFO - "builduid": "d136471e25854d8187882ce90d66d575", 14:58:03 INFO - "slavebuilddir": "test" 14:58:03 INFO - } 14:58:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 14:58:03 INFO - Running post-action listener: _resource_record_post_action 14:58:03 INFO - [mozharness: 2017-05-05 21:58:03.012842Z] Finished read-buildbot-config step (success) 14:58:03 INFO - [mozharness: 2017-05-05 21:58:03.013060Z] Running download-and-extract step. 14:58:03 INFO - Running pre-action listener: _resource_record_pre_action 14:58:03 INFO - Running main action method: download_and_extract 14:58:03 INFO - mkdir: /builds/slave/test/build/tests 14:58:03 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')]} 14:58:03 INFO - trying https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 14:58:03 INFO - Downloading https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:58:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:58:03 INFO - Downloaded 1287 bytes. 14:58:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 14:58:03 INFO - Using the following test package requirements: 14:58:03 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 14:58:03 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:58:03 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 14:58:03 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 14:58:03 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:58:03 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 14:58:03 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 14:58:03 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 14:58:03 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 14:58:03 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 14:58:03 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 14:58:03 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 14:58:03 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 14:58:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:58:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:58:03 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:58:05 INFO - Expected file size: 51227137 14:58:05 INFO - Obtained file size: 51227137 14:58:21 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 14:58:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 14:58:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 14:58:21 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 14:58:23 INFO - Expected file size: 51227137 14:58:23 INFO - Obtained file size: 51227137 14:58:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 14:58:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 14:58:38 INFO - Fetch https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 14:58:39 INFO - Expected file size: 14404449 14:58:39 INFO - Obtained file size: 14404449 14:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:39 INFO - trying https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:58:39 INFO - Downloading https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 14:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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 14:58:41 INFO - Downloaded 59560474 bytes. 14:58:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:58:41 INFO - mkdir: /builds/slave/test/properties 14:58:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:58:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:58:41 INFO - Contents: 14:58:41 INFO - build_url:https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 14:58:42 INFO - Running post-action listener: _resource_record_post_action 14:58:42 INFO - Running post-action listener: set_extra_try_arguments 14:58:42 INFO - [mozharness: 2017-05-05 21:58:42.370768Z] Finished download-and-extract step (success) 14:58:42 INFO - [mozharness: 2017-05-05 21:58:42.370894Z] Running populate-webroot step. 14:58:42 INFO - Running pre-action listener: _resource_record_pre_action 14:58:42 INFO - Running main action method: populate_webroot 14:58:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:58:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:58:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:58:42 INFO - '--tppagecycles', 14:58:42 INFO - '7'], 14:58:42 INFO - 'tests': ['tsvgm']}}, 14:58:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:58:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:58:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:58:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:58:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['damp', 'tps']}, 14:58:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'tests': ['damp', 'tps']}, 14:58:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['dromaeo_dom']}, 14:58:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:58:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['basic_compositor_video']}, 14:58:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:58:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['a11yr', 14:58:42 INFO - 'ts_paint', 14:58:42 INFO - 'tpaint', 14:58:42 INFO - 'sessionrestore', 14:58:42 INFO - 'sessionrestore_no_auto_restore', 14:58:42 INFO - 'tabpaint']}, 14:58:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['tsvgx', 14:58:42 INFO - 'tsvgr_opacity', 14:58:42 INFO - 'tart', 14:58:42 INFO - 'tscrollx', 14:58:42 INFO - 'cart', 14:58:42 INFO - 'tsvg_static']}, 14:58:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:58:42 INFO - 'tsvgr_opacity', 14:58:42 INFO - 'tart', 14:58:42 INFO - 'tscrollx', 14:58:42 INFO - 'cart', 14:58:42 INFO - 'tsvg_static']}, 14:58:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'talos_options': ['--disable-e10s'], 14:58:42 INFO - 'tests': ['tp5o']}, 14:58:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:58:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'talos_options': ['--disable-e10s', 14:58:42 INFO - '--xperf_path', 14:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:42 INFO - 'tests': ['tp5n']}, 14:58:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:58:42 INFO - 'talos_options': ['--xperf_path', 14:58:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:42 INFO - 'tests': ['tp5n']}}, 14:58:42 INFO - 'talos.zip': {'path': '', 14:58:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:58:42 INFO - Running post-action listener: _resource_record_post_action 14:58:42 INFO - [mozharness: 2017-05-05 21:58:42.389298Z] Finished populate-webroot step (success) 14:58:42 INFO - [mozharness: 2017-05-05 21:58:42.389407Z] Running create-virtualenv step. 14:58:42 INFO - Running pre-action listener: _resource_record_pre_action 14:58:42 INFO - Running main action method: create_virtualenv 14:58:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:58:42 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 14:58:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:58:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:58:42 INFO - Using real prefix '/tools/python27' 14:58:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:58:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:58:46 INFO - Installing pip.................done. 14:58:46 INFO - Return code: 0 14:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:58:46 INFO - Reading from file tmpfile_stdout 14:58:46 INFO - Output received: 14:58:46 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) 14:58:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:58:46 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')]} 14:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 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')]} 14:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58:46 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 14:58:46 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 14:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:46 INFO - 'HOME': '/Users/cltbld', 14:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:46 INFO - 'LOGNAME': 'cltbld', 14:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:46 INFO - 'MOZ_NO_REMOTE': '1', 14:58:46 INFO - 'NO_EM_RESTART': '1', 14:58:46 INFO - 'PAGER': '/bin/cat', 14:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:46 INFO - 'PWD': '/builds/slave/test', 14:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:46 INFO - 'SHELL': '/bin/bash', 14:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:46 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:46 INFO - 'USER': 'cltbld', 14:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:46 INFO - 'XPC_FLAGS': '0x0', 14:58:46 INFO - 'XPC_SERVICE_NAME': '0', 14:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:46 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 14:58:46 INFO - Cleaning up... 14:58:46 INFO - Return code: 0 14:58:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:58:46 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')]} 14:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 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')]} 14:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58:46 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 14:58:46 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 14:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:46 INFO - 'HOME': '/Users/cltbld', 14:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:46 INFO - 'LOGNAME': 'cltbld', 14:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:46 INFO - 'MOZ_NO_REMOTE': '1', 14:58:46 INFO - 'NO_EM_RESTART': '1', 14:58:46 INFO - 'PAGER': '/bin/cat', 14:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:46 INFO - 'PWD': '/builds/slave/test', 14:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:46 INFO - 'SHELL': '/bin/bash', 14:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:46 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:46 INFO - 'USER': 'cltbld', 14:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:46 INFO - 'XPC_FLAGS': '0x0', 14:58:46 INFO - 'XPC_SERVICE_NAME': '0', 14:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:46 INFO - Downloading/unpacking psutil>=3.1.1 14:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:49 INFO - Installing collected packages: psutil 14:58:49 INFO - Running setup.py install for psutil 14:58:49 INFO - building 'psutil._psutil_osx' extension 14:58:49 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 14:58:49 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 14:58:49 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 14:58:49 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 14:58:49 INFO - building 'psutil._psutil_posix' extension 14:58:49 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 14:58:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:58:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:58:49 INFO - ^ 14:58:49 INFO - 1 warning generated. 14:58:49 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 14:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:49 INFO - Successfully installed psutil 14:58:49 INFO - Cleaning up... 14:58:49 INFO - Return code: 0 14:58:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:58: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 mozsystemmonitor==0.3 14:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:49 INFO - 'HOME': '/Users/cltbld', 14:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:49 INFO - 'LOGNAME': 'cltbld', 14:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:49 INFO - 'MOZ_NO_REMOTE': '1', 14:58:49 INFO - 'NO_EM_RESTART': '1', 14:58:49 INFO - 'PAGER': '/bin/cat', 14:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:49 INFO - 'PWD': '/builds/slave/test', 14:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:49 INFO - 'SHELL': '/bin/bash', 14:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:49 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:49 INFO - 'USER': 'cltbld', 14:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:49 INFO - 'XPC_FLAGS': '0x0', 14:58:49 INFO - 'XPC_SERVICE_NAME': '0', 14:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:58:51 INFO - Installing collected packages: mozsystemmonitor 14:58:51 INFO - Running setup.py install for mozsystemmonitor 14:58:51 INFO - Successfully installed mozsystemmonitor 14:58:51 INFO - Cleaning up... 14:58:51 INFO - Return code: 0 14:58:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:51 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58:51 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 14:58:51 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 14:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:51 INFO - 'HOME': '/Users/cltbld', 14:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:51 INFO - 'LOGNAME': 'cltbld', 14:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:51 INFO - 'MOZ_NO_REMOTE': '1', 14:58:51 INFO - 'NO_EM_RESTART': '1', 14:58:51 INFO - 'PAGER': '/bin/cat', 14:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:51 INFO - 'PWD': '/builds/slave/test', 14:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:51 INFO - 'SHELL': '/bin/bash', 14:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:51 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:51 INFO - 'USER': 'cltbld', 14:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:51 INFO - 'XPC_FLAGS': '0x0', 14:58:51 INFO - 'XPC_SERVICE_NAME': '0', 14:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:52 INFO - Downloading/unpacking jsonschema==2.5.1 14:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:58:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 INFO - Downloading functools32-3.2.3-2.tar.gz 14:58:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:58:53 INFO - warning: no files found matching '*.txt' 14:58:53 INFO - no previously-included directories found matching 'build' 14:58:53 INFO - no previously-included directories found matching 'dist' 14:58:53 INFO - no previously-included directories found matching '.git*' 14:58:53 INFO - Installing collected packages: jsonschema, functools32 14:58:53 INFO - Running setup.py install for functools32 14:58:53 INFO - warning: no files found matching '*.txt' 14:58:53 INFO - no previously-included directories found matching 'build' 14:58:53 INFO - no previously-included directories found matching 'dist' 14:58:53 INFO - no previously-included directories found matching '.git*' 14:58:53 INFO - Successfully installed jsonschema functools32 14:58:53 INFO - Cleaning up... 14:58:54 INFO - Return code: 0 14:58:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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', '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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:58: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 functools32==3.2.3-2 14:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:54 INFO - 'HOME': '/Users/cltbld', 14:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:54 INFO - 'LOGNAME': 'cltbld', 14:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:54 INFO - 'MOZ_NO_REMOTE': '1', 14:58:54 INFO - 'NO_EM_RESTART': '1', 14:58:54 INFO - 'PAGER': '/bin/cat', 14:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:54 INFO - 'PWD': '/builds/slave/test', 14:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:54 INFO - 'SHELL': '/bin/bash', 14:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:54 INFO - 'USER': 'cltbld', 14:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:54 INFO - 'XPC_FLAGS': '0x0', 14:58:54 INFO - 'XPC_SERVICE_NAME': '0', 14:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:58:54 INFO - Cleaning up... 14:58:54 INFO - Return code: 0 14:58:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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', '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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:58: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 blobuploader==1.2.4 14:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:54 INFO - 'HOME': '/Users/cltbld', 14:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:54 INFO - 'LOGNAME': 'cltbld', 14:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:54 INFO - 'MOZ_NO_REMOTE': '1', 14:58:54 INFO - 'NO_EM_RESTART': '1', 14:58:54 INFO - 'PAGER': '/bin/cat', 14:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:54 INFO - 'PWD': '/builds/slave/test', 14:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:54 INFO - 'SHELL': '/bin/bash', 14:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:54 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:54 INFO - 'USER': 'cltbld', 14:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:54 INFO - 'XPC_FLAGS': '0x0', 14:58:54 INFO - 'XPC_SERVICE_NAME': '0', 14:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:58:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:58:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 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 14:58:56 INFO - Downloading docopt-0.6.1.tar.gz 14:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:58:56 INFO - Installing collected packages: blobuploader, requests, docopt 14:58:56 INFO - Running setup.py install for blobuploader 14:58:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:58:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:58:57 INFO - Running setup.py install for requests 14:58:57 INFO - Running setup.py install for docopt 14:58:57 INFO - Successfully installed blobuploader requests docopt 14:58:57 INFO - Cleaning up... 14:58:57 INFO - Return code: 0 14:58:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:58 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:58:58 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 14:58:58 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 14:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:58:58 INFO - 'HOME': '/Users/cltbld', 14:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:58:58 INFO - 'LOGNAME': 'cltbld', 14:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:58 INFO - 'MOZ_NO_REMOTE': '1', 14:58:58 INFO - 'NO_EM_RESTART': '1', 14:58:58 INFO - 'PAGER': '/bin/cat', 14:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:58 INFO - 'PWD': '/builds/slave/test', 14:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:58:58 INFO - 'SHELL': '/bin/bash', 14:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:58:58 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:58:58 INFO - 'USER': 'cltbld', 14:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:58 INFO - 'XPC_FLAGS': '0x0', 14:58:58 INFO - 'XPC_SERVICE_NAME': '0', 14:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:58 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Fim7OO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:58 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-948wS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XQHHFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qxG01b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FFCMYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-D9OlYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aYQaW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-vsDWca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-40hGmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-xTXEFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:59 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-TXNAQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-C8KTk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lyrepo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-5etGKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-cDWfFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DTnYzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:00 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-iRBsjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:59:00 INFO - Running setup.py install for manifestparser 14:59:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:59:00 INFO - Running setup.py install for mozcrash 14:59:00 INFO - Running setup.py install for mozdebug 14:59:01 INFO - Running setup.py install for mozdevice 14:59:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Running setup.py install for mozfile 14:59:01 INFO - Running setup.py install for mozhttpd 14:59:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Running setup.py install for mozinfo 14:59:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Running setup.py install for mozInstall 14:59:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:59:01 INFO - Running setup.py install for mozleak 14:59:01 INFO - Running setup.py install for mozlog 14:59:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Running setup.py install for moznetwork 14:59:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Running setup.py install for mozprocess 14:59:02 INFO - Running setup.py install for mozprofile 14:59:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Running setup.py install for mozrunner 14:59:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:59:02 INFO - Running setup.py install for mozscreenshot 14:59:02 INFO - Running setup.py install for moztest 14:59:03 INFO - Running setup.py install for mozversion 14:59:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:59:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:59:03 INFO - Cleaning up... 14:59:03 INFO - Return code: 0 14:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:03 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')]} 14:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:03 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')]} 14:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:03 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:59:03 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 14:59:03 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 14:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:03 INFO - 'HOME': '/Users/cltbld', 14:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:03 INFO - 'LOGNAME': 'cltbld', 14:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:03 INFO - 'MOZ_NO_REMOTE': '1', 14:59:03 INFO - 'NO_EM_RESTART': '1', 14:59:03 INFO - 'PAGER': '/bin/cat', 14:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:03 INFO - 'PWD': '/builds/slave/test', 14:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:03 INFO - 'SHELL': '/bin/bash', 14:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:59:03 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:03 INFO - 'USER': 'cltbld', 14:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:03 INFO - 'XPC_FLAGS': '0x0', 14:59:03 INFO - 'XPC_SERVICE_NAME': '0', 14:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:59:03 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-gTG2f9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hrDc2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-KfpQ3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-10nSOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-xinHW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-75tT4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BeGr8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-9ixNLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ixuqjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hONzIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:59:04 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)) 14:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:59:04 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-TysuH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FFiX5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qosiqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-AmP3Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_hBSbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-_RG93q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:59:05 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)) 14:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:59:05 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-WY2tUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:59:05 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)) 14:59:05 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)) 14:59:05 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)) 14:59:05 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)) 14:59:05 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)) 14:59:05 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)) 14:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59: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 14:59:07 INFO - Downloading blessings-1.6.tar.gz 14:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:59:07 INFO - Installing collected packages: blessings 14:59:07 INFO - Running setup.py install for blessings 14:59:07 INFO - Successfully installed blessings 14:59:07 INFO - Cleaning up... 14:59:07 INFO - Return code: 0 14:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:08 INFO - Reading from file tmpfile_stdout 14:59:08 INFO - Current package versions: 14:59:08 INFO - blessings == 1.6 14:59:08 INFO - blobuploader == 1.2.4 14:59:08 INFO - docopt == 0.6.1 14:59:08 INFO - functools32 == 3.2.3-2 14:59:08 INFO - jsonschema == 2.5.1 14:59:08 INFO - manifestparser == 1.1 14:59:08 INFO - mozInstall == 1.12 14:59:08 INFO - mozcrash == 1.0 14:59:08 INFO - mozdebug == 0.1 14:59:08 INFO - mozdevice == 0.49 14:59:08 INFO - mozfile == 1.2 14:59:08 INFO - mozhttpd == 0.7 14:59:08 INFO - mozinfo == 0.9 14:59:08 INFO - mozleak == 0.1 14:59:08 INFO - mozlog == 3.4 14:59:08 INFO - moznetwork == 0.27 14:59:08 INFO - mozprocess == 0.25 14:59:08 INFO - mozprofile == 0.28 14:59:08 INFO - mozrunner == 6.13 14:59:08 INFO - mozscreenshot == 0.1 14:59:08 INFO - mozsystemmonitor == 0.3 14:59:08 INFO - moztest == 0.8 14:59:08 INFO - mozversion == 1.4 14:59:08 INFO - psutil == 3.1.1 14:59:08 INFO - requests == 1.2.3 14:59:08 INFO - wsgiref == 0.1.2 14:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:08 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:59:08 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 14:59:08 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 14:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:08 INFO - 'HOME': '/Users/cltbld', 14:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:08 INFO - 'LOGNAME': 'cltbld', 14:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:08 INFO - 'MOZ_NO_REMOTE': '1', 14:59:08 INFO - 'NO_EM_RESTART': '1', 14:59:08 INFO - 'PAGER': '/bin/cat', 14:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:08 INFO - 'PWD': '/builds/slave/test', 14:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:08 INFO - 'SHELL': '/bin/bash', 14:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:59:08 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:08 INFO - 'USER': 'cltbld', 14:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:08 INFO - 'XPC_FLAGS': '0x0', 14:59:08 INFO - 'XPC_SERVICE_NAME': '0', 14:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 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)) 14:59:08 INFO - Cleaning up... 14:59:08 INFO - Return code: 0 14:59:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:59:08 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 0x100b39b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100b3c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2434a2780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, '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.Fj9t24GI5F/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.ukg31hi1EO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 14:59:08 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 14:59:08 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 14:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:08 INFO - 'HOME': '/Users/cltbld', 14:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:08 INFO - 'LOGNAME': 'cltbld', 14:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:08 INFO - 'MOZ_NO_REMOTE': '1', 14:59:08 INFO - 'NO_EM_RESTART': '1', 14:59:08 INFO - 'PAGER': '/bin/cat', 14:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:08 INFO - 'PWD': '/builds/slave/test', 14:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:08 INFO - 'SHELL': '/bin/bash', 14:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:59:08 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:08 INFO - 'USER': 'cltbld', 14:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:08 INFO - 'XPC_FLAGS': '0x0', 14:59:08 INFO - 'XPC_SERVICE_NAME': '0', 14:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:59:08 INFO - Cleaning up... 14:59:08 INFO - Return code: 0 14:59:08 INFO - Running post-action listener: _resource_record_post_action 14:59:08 INFO - Running post-action listener: _start_resource_monitoring 14:59:08 INFO - Starting resource monitoring. 14:59:08 INFO - [mozharness: 2017-05-05 21:59:08.737908Z] Finished create-virtualenv step (success) 14:59:08 INFO - [mozharness: 2017-05-05 21:59:08.738965Z] Running install step. 14:59:08 INFO - Running pre-action listener: _resource_record_pre_action 14:59:08 INFO - Running main action method: install 14:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:59:08 INFO - Reading from file tmpfile_stdout 14:59:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:59:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:59:09 INFO - Reading from file tmpfile_stdout 14:59:09 INFO - Output received: 14:59:09 INFO - Usage: mozinstall [options] installer 14:59:09 INFO - Options: 14:59:09 INFO - -h, --help show this help message and exit 14:59:09 INFO - -d DEST, --destination=DEST 14:59:09 INFO - Directory to install application into. [default: 14:59:09 INFO - "/builds/slave/test"] 14:59:09 INFO - --app=APP Application being installed. [default: firefox] 14:59:09 INFO - mkdir: /builds/slave/test/build/application 14:59:09 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'] 14:59:09 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 14:59:23 INFO - Reading from file tmpfile_stdout 14:59:23 INFO - Output received: 14:59:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:59:23 INFO - Running post-action listener: _resource_record_post_action 14:59:23 INFO - [mozharness: 2017-05-05 21:59:23.911354Z] Finished install step (success) 14:59:23 INFO - [mozharness: 2017-05-05 21:59:23.911474Z] Running run-tests step. 14:59:23 INFO - Running pre-action listener: _resource_record_pre_action 14:59:23 INFO - Running main action method: run_tests 14:59:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:59:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:59:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:59:23 INFO - 2017-05-05 14:59:23.926 screenresolution[1979:15173] starting screenresolution argv=screenresolution get 14:59:23 INFO - 2017-05-05 14:59:23.928 screenresolution[1979:15173] Display 0: 1600x1200x32@60 14:59:23 INFO - 2017-05-05 14:59:23.934 screenresolution[1980:15176] starting screenresolution argv=screenresolution list 14:59:23 INFO - Available Modes on Display 0 14:59:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:59:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:59:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:59:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:59:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:59:24 INFO - Intel Iris: 14:59:24 INFO - Chipset Model: Intel Iris 14:59:24 INFO - Type: GPU 14:59:24 INFO - Bus: Built-In 14:59:24 INFO - VRAM (Dynamic, Max): 1536 MB 14:59:24 INFO - Vendor: Intel (0x8086) 14:59:24 INFO - Device ID: 0x0a2e 14:59:24 INFO - Revision ID: 0x0009 14:59:24 INFO - Displays: 14:59:24 INFO - Display: 14:59:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:59:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:59:24 INFO - Display Serial Number: 1600x1200 60 14:59:24 INFO - Main Display: Yes 14:59:24 INFO - Mirror: Off 14:59:24 INFO - Online: Yes 14:59:24 INFO - Rotation: Supported 14:59:24 INFO - Return code: 0 14:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:24 INFO - Python 2.7.3 14:59:24 INFO - Return code: 0 14:59:24 INFO - grabbing minidump binary from tooltool 14:59:24 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')]} 14:59:24 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 0x100917d30>, '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 0x10083edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10090cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:24 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 14:59:24 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 14:59:24 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 14:59:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:24 INFO - Return code: 0 14:59:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:59:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:24 INFO - ENV: RUST_BACKTRACE is now 1 14:59:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:59:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:24 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 14:59:24 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 14:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Fj9t24GI5F/Render', 14:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:59:24 INFO - 'HOME': '/Users/cltbld', 14:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:59:24 INFO - 'LOGNAME': 'cltbld', 14:59:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:24 INFO - 'MOZ_NO_REMOTE': '1', 14:59:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:24 INFO - 'NO_EM_RESTART': '1', 14:59:24 INFO - 'PAGER': '/bin/cat', 14:59:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:24 INFO - 'PWD': '/builds/slave/test', 14:59:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:59:24 INFO - 'RUST_BACKTRACE': '1', 14:59:24 INFO - 'SHELL': '/bin/bash', 14:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ukg31hi1EO/Listeners', 14:59:24 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 14:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:59:24 INFO - 'USER': 'cltbld', 14:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:24 INFO - 'XPC_FLAGS': '0x0', 14:59:24 INFO - 'XPC_SERVICE_NAME': '0', 14:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:59:24 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/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 14:59:24 INFO - mozversion application_buildid: 20170505135642 14:59:24 INFO - mozversion application_changeset: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 14:59:24 INFO - mozversion application_display_name: Firefox 14:59:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:24 INFO - mozversion application_name: Firefox 14:59:24 INFO - mozversion application_remotingname: firefox 14:59:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:59:24 INFO - mozversion application_vendor: Mozilla 14:59:24 INFO - mozversion application_version: 54.0 14:59:24 INFO - mozversion platform_buildid: 20170505135642 14:59:24 INFO - mozversion platform_changeset: 7868898154ed9e19d98d9aa4c53b7da57c2bd187 14:59:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:59:24 INFO - mozversion platform_version: 54.0 14:59:24 INFO - using testdate: 1494021564 14:59:24 INFO - actual date: 1494021564 14:59:24 INFO - starting webserver on 'localhost:49646' 14:59:24 INFO - SUITE-START | Running 2 tests 14:59:24 INFO - TEST-START | dromaeo_css 14:59:24 INFO - operating with platform_type : mac_ 14:59:24 INFO - Initialising browser for dromaeo_css test... 14:59:24 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpZ1ZoiQ/profile http://localhost:49646/getInfo.html) 14:59:27 INFO - PROCESS | 1990 | __metrics Screen width/height:1600/1200 14:59:27 INFO - PROCESS | 1990 | colorDepth:24 14:59:27 INFO - PROCESS | 1990 | Browser inner width/height: 1024/689 14:59:27 INFO - PROCESS | 1990 | __metrics 14:59:27 INFO - PROCESS | 1990 | 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" 14:59:27 INFO - PROCESS | 1990 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:27 INFO - TEST-INFO | 1990: exit 0 14:59:27 INFO - Browser initialized. 14:59:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:27 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpZ1ZoiQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:39 INFO - PROCESS | 1993 | RSS: Main: 165105664 14:59:39 INFO - PROCESS | 1993 | 15:02:43 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49646/tests/dromaeo/cssquery-ext.html) 15:02:45 INFO - PROCESS | 1993 | RSS: Main: 294354944 15:02:45 INFO - PROCESS | 1993 | 15:05:48 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-ext.html (next: http://localhost:49646/tests/dromaeo/cssquery-jquery.html) 15:05:48 INFO - PROCESS | 1993 | RSS: Main: 301268992 15:05:48 INFO - PROCESS | 1993 | 15:08:50 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49646/tests/dromaeo/cssquery-mootools.html) 15:08:51 INFO - PROCESS | 1993 | RSS: Main: 282296320 15:08:51 INFO - PROCESS | 1993 | 15:11:53 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49646/tests/dromaeo/cssquery-prototype.html) 15:11:54 INFO - PROCESS | 1993 | RSS: Main: 280285184 15:11:54 INFO - PROCESS | 1993 | 15:14:58 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49646/tests/dromaeo/cssquery-yui.html) 15:14:58 INFO - PROCESS | 1993 | RSS: Main: 261488640 15:14:58 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | Cycle 1(1): loaded http://localhost:49646/tests/dromaeo/cssquery-yui.html (next: http://localhost:49646/tests/dromaeo/cssquery-dojo.html) 15:18:02 INFO - PROCESS | 1993 | RSS: Main: 548519936 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | __start_tp_report 15:18:02 INFO - PROCESS | 1993 | _x_x_mozilla_page_load 15:18:02 INFO - PROCESS | 1993 | _x_x_mozilla_page_load_details 15:18:02 INFO - PROCESS | 1993 | |i|pagename|runs| 15:18:02 INFO - PROCESS | 1993 | |0;dojo.html;3262.9999999999986;3424.263783286593;3433.141714571357;3479.8434070466833;3496.7901925884466;6066.272047354318;6084.604500707462;6102.572819902609;6103.816885493431;6136.23297087864;6064.5148388128955;6146.323904370515;6154.138420621117;6165.475934545569;6170.47550958168;5344.278522399475;5357.7589008494715;5389.865253368677;5414.593905457106;5474.7810087596445;5309.362876454831;5313.20301954708;5497.45025497451;5514.228008078872;5534.972325138388;5359.38367087786;5414.972925135369;5418.106012507951;5421.864453388657;5424.783008679648;5425.13197888338;5433.375161856397;5441;5442.102053161263;5470.671759694411;5302.92045619316;5393.379761327458;5402.594805389572;5431.34823821144;5523.337199536041;5881.117832325142;5906.468417842372;5910.793122240744;6015.969920150415;6095.177151084591;5466.808661696821;6380.521460890405;6383.170187875547;6392.232932048184;6393.392627700361;6393.1688880445245;6452.161219041542;6464.806055818286;6474.02889566564;6515.609063456208;5158.92261616076;5338.492843179931;5386.649867758583;6023.69881505923;6273.184486016834;6436.935630643728;6437.517186211053;6559.5408321418;6593.571417857824;6617.172853393326;6365.395287447685;6368.203974503187;6373.904391434132;6376.521760867953;6416.165898433173;6292.8426789329715;6406.935930640634;6429.067785171217;6433.549651524442;6445.45213656835;6289.0880822280515;6333;6333.018382150774;6368.044793280952;6384.170057892537;6356.237251529754;6371.203599550056;6390.4248617624635;6390.616563006141;6395.232572091379;5172.27588137661;5210.400803907523;5213;5222.21666749983;5253.868653283698;4527.2303708369;4556.476005259437;4643.396358473445;4656.95343046572;4675.509071547506;6131.540134489931;6155.938440615626;6190.721417536221;6246.75012999484;6265.96867015662;6451.1936007999;6457.063725759738;6461.224653041665;6469.967650161813;6479.384458476437;6231.875362492725;6257.061440783918;6267;6276.592021518587;6282.748690052438;5518.420565840609;5547.611667183339;5590.496855283044;5634.577406694514;5635.3519345275;5485.369182544058;6446.613203207822;6453.322401147906;6464.8707025858275;6470.061841033118;6321.778737744341;6332.208473940757;6373.936260637334;6391.776287829904;6439.710213040518;6633.469322454289;6708.02733603615;6709.630970296681;6725.663716814041;6733.192016957996;6355.300916899045;6368.840778980562;6373.936260637334;6387.361263873576;6388.39310265524;5461.235427040138;6307.369263073656;6318.0838778375955;6381.8723625528155;6414.807555773335;4927.778249978831;6332.525060620564;6349.904751428825;6350.618962862059;6363;6320.1638339535875;6350.872982540416;6352.809415717536;6354.459870911024;6367.363263673596;6148.200733904742;6148.44663980244;6160.969195153995;6192.504599632109;6214.627122372672;6306.2747784003595;6320.336364681826;6324.146240257506;6325.240971083499;6325.525585581007;6182.443580077815;6198.752049917953;6217.595856269328;6217.813465596039;6228.22147231596 15:18:02 INFO - PROCESS | 1993 | |1;ext.html;776.7009701265011;805.8186907945712;824.2787560884225;896.6323807239029;905.9411138276016;29664;30195.24511887204;42140.578594214014;42980.355294670604;42986.785066074706;43841.561584384144;43907.68276951688;43939.34090988638;43957.78021109898;44088.77955610226;9770.755731106708;9933.155681767023;9968.551415186334;9974.551145198484;9980.800383992315;6893.3795958363735;8217.876731849026;11810.409479526032;11955.222910510833;11965.940170299136;11979.40102994851;12020.278783272988;12022.57920972766;12040;12057.517699292017;11907.583234586791;11965.820512692317;11970.102242331859;11980.28118312904;12027.158098933078;11742;11798.705032374173;11806.350650714206;11807.88192118085;11814.527418903233;40865.591344086475;41030.38454423186;41099.7945010273;41169.58830411718;41197.38203926943;4003.83984640614;4037.7577345359373;4069.369247766601;4070.5725898780497;4078.530968938551;28678;28755.28111797222;30032.529611879472;30264.394712105634;30940.8452957736;2811.915642530707;3246.6915643013876;3310.586176727909;3326.334733053399;3336.9332613347597;339160;339628.3018584916;340057;340735;340833;53162.734186328824;53303.46696533063;53330.20004699933;53356;53449.198262026104;55279.72360138174;55291;55384;55422.72288638531;55511.88976220453;15492.690146197014;15603.297851596706;15610.063396196265;15614.765778513105;15629.14039727826;9726.90273097274;13321.933390332986;13324.200547967153;13332.333383330795;13347;11152.553897844158;11273.605423810128;11320.037796787201;11320.09439244875;11337.979581837673;4953;5406.243125962368;5425.26758887553;5435.42927992563;5439.619226654176;1049.41757324684;1068.3536460441476;1070.6787963610886;1072.6889202131294;1116.3804088730833;27220.727792722217;27819.721802782118;28245.71754282472;29170.708292917225;29196.562051569243;977.8875429325576;1133.478599844081;1137.766757814646;1164.4410682872099;1178.723000094977;12180.269183848997;13575.049746517649;14645.853541464448;14759.77860332096;14966.850331496764;452050;453879;454246;454487;454988;48568.7571562147;48762.5123748758;51890.22164667533;56856.43143568594;56943.715281424156;1459.6642772162463;1494.940202391914;1498.4081287891004;1510.8035955325956;1514.6364872430759;29690.554641680825;31122.844385777928;31295.687043129277;31742.682573173974;31760.682393176696;46912.53087469082;47149.05701886012;48053.03893922172;49827.25259121044;50145.49854501408;483126;486209;488275.55862220464;491717;497296;30181.547276791305;30214.848925755232;30277;30281.091567253017;30992.22519437032;39540;39666.40500392439;39764.80117599509;40032;40082.19835603213;24585.508289833746;27682.584761229;28315.43369132647;28695.85652071726;29686.25784355322;27553.035643752373;28111.875524978772;28503.857480712464;28925.421491570472;29151.81361397861;33321.333573328884;33416.832915835264;34014.149646258054;34187;34252;28313.57529637016;28590.285242869093;28781.56827647629;29146.854265728536;29792.404151917275;22349.888250558644;23845.165419210243;23937.880310598335;24178.637320439855;24208.87895560511 15:18:02 INFO - PROCESS | 1993 | |2;jquery.html;392.6681953749082;421.300640936046;426.69704509798044;445.9843905463308;462.34116384152594;19210.519737006565;20293.188272469102;21309.893450532727;21433.356999290027;21581.784182158175;21797.67303490449;21896.562068758656;22753;23099.0760369585;23138.537229255406;6609.041688955099;6864;6870.141232345957;6876.931230687705;6881.621510816903;6492.610443373413;7835;8050.677972881078;8051.0741264754715;8057.597120143999;7697.384209263273;7748.30265276125;7816.983792107047;7828.608569571527;8039.598020099001;7886.960565197137;7902.723404680866;7921.683132674686;7986.880196797053;7992.280694737473;7444.776656700307;7500.499900020018;7665.655045522964;7666.8466630667635;7693.730719424793;23572;24820;26217.73782262172;27094.5935810963;27184.864075679692;2913.883444662211;3028.348904985439;3052.252198211452;3076.6769489203534;3133.7336326412283;15555.844441555553;16069.357225710957;16243.512694619063;16563.585910352336;17419.8677085989;2088.237793205484;2150.5913876363443;2151.505153814616;2162.76209616942;2171.4462811982844;151827;155664;156707;158521;161190;19212;19899.701504477154;20031.39905802828;20211.191552338038;20226.89886550558;31669.733210671777;32152.19619509531;32178.83910580432;32223.838880805914;32290;10326.586936522455;10509.159267258601;10634.734131646615;10668.839967400496;10881.183911206692;8860.202581767671;8871.379003469825;8882.80355991739;9069.911610606638;9084.40951338161;9224.492652904155;9354.111359420844;9361.34470587066;9389.76525586852;9396.154346108746;2954.3648115655237;3733.5893051764283;3778.8110594470168;3831.923361532754;3844.231153769257;1011.8229309870743;1039.26212389203;1046.4819914142547;1061.264831999686;1065.17628022177;21723.891380542995;22960.19639312616;24580.754192458204;24620.5075898481;24655.506889862103;1018.3482571154467;1031.2214278220047;1072.1851392941421;1074.8871368506195;1080.4111759091313;6471.061696054046;7140.321669441395;7155.534890232118;7283.963580182065;7528.284812942762;820735;823969;827226;832788;858450;162359;164347;164639;166526.16736916237;169965.15017424832;1288.6907142285972;1306.888914442264;1337.2043634037732;1338.8326459192406;1342.1209108034254;10107.69676909694;12539.74920501603;12721.109522333349;12995.805062924253;13245.27151006704;68035;68175.31824681888;68367;68758;69633.65183174255;79148;85294;95001.57497637403;95049.5247523758;96143;11514.30914145154;11648.94175529117;11990.280583165038;12068;12082.275063496218;12156.635300940987;12546.309952952675;13152.73694526085;13244.867551324363;13588.25264610456;9626;11680.532778688757;11728.648140555797;11892.10809189297;12011.81982270284;9054.728358149267;10771.353718776585;11030.558777648805;11136;11274.943625281821;10070.44612546317;11630.127740419333;11823.994960428116;11936.701582460508;12017.939910300393;11759.059275257789;11789.174757766874;11854.051675865738;11874.643760687193;12056.939715301367;9827.164691001059;10609.310394824312;10824.079953204066;11728.003119734918;11941.82087268709 15:18:02 INFO - PROCESS | 1993 | |3;mootools.html;1441.4594527052354;1574.8188958269802;1607.4889603772453;1638.4920674590874;1644.0135918448932;10715.571377144915;11371.658850234506;11380.203385763;11380.943095284512;11407.657770266906;10847.783044339109;11110.333379997206;11128.332300062002;11286;11332.376719280437;2321.2339927823778;2356.2460012795914;2499.950000999979;2509.397744541315;2516.6225066240117;2418.4074901649033;2497.2133777859917;2510.272021113875;2514.748525147489;2515.3585835611893;2433.221369161869;2459.225344016629;2477.8513289202615;2480.0327872129883;2489.6887889013874;2430.3559556717482;2434.6469761884427;2451.7915977141965;2457.103157347573;2503.674522312106;2460.4095017195746;2485.5401750676183;2490.8256422050463;2494.4262819551604;2494.6382774497597;10973.725656858562;11247.60633377836;11248.55005799767;11250.54997800087;11257.774844503147;5937.406259374071;6104.725287362079;6126.969365153146;6131.724072416752;6154.692265386758;3653.50677658518;3657.030886814996;3743.419769935664;3784.4512545680996;3854;1197.9640610781692;1223.920445171061;1240.2930329712067;1290.69023434376;1296.7860303049986;13979.021468497209;14247.928760356235;14500.492482763053;15502.457413990569;15748.740100791909;4702.52974702527;4816.735079570657;4850.278151256323;4884.609231261491;4899.093667671492;10401.68794936153;11898.286102833685;11900.583479578347;11907.226030308002;11914.88085119155;5152.201408781645;5209.479052094836;5210.270562121306;5212.322398088224;5215.305025866609;5321.388040375329;5420.295361602966;5484.972575137099;5559;5607.327120745536;3973.2450834341385;4000.3199456092534;4025.5370632377067;4058.431819545266;4090.9795451022555;1072.104792498257;1072.1797824663981;1074.5970261152067;1081.5133190064503;1081.5349399758022;847.4449235750593;930.8184903943801;950.4154944708954;968.7335982604699;1016.1058268723624;6562.50781191403;6637.269900310962;6676.499262555328;6939.7224111036;6961.26906674802;1014.1886490807472;1022.7749895023084;1045.7333379988206;1065.9413732244645;1112.8942750438696;4049.967258349161;4239.427677263591;4249.915001699948;4364.650827933758;4415.977920110379;12269.447874845653;13906.791398129037;13917.234552099731;13936.303184840717;13946.093503922213;11739;13443.32783360828;13838.23889686077;13849.653758656113;13895.166290022631;9468.053194680615;9690;10384.844227336596;10388.532516036796;10400.791984160123;6520.967395162994;6762.087118238975;6847.417969472651;7029.332213439715;7180.281971802778;12099.79002099783;12343.814842777545;12586.937065314614;12654.493820247455;12703.93648031754;10522.789544209227;11151.219414640897;12680.11239213283;12888.935555322163;12889.742205155657;8983.101689830964;9183.77040573991;9341.065893410605;9475.241980641395;9481.857772133286;10486.947565262124;10523.894761052597;10665.36007839532;10690.839637405601;10705.357678539312;8673.869891951499;8690.044095149402;8892.15524525169;9003.81992360136;9071.637134514545;8648.351373646876;8680.305575553813;8748.300135988979;8789.868151977853;8833.160849719266;7251.021112149792;7977.561234131947;7992.680292788224;8019.6391162398995;8126.796830079295;6032.638041717511;6049.213602231682;6074.483668888017;6093.507090762791;6115.84710382244;5944.702764861826;6178.876422471615;6241.469475094668;6314.400131987454;6332.778352757631 15:18:02 INFO - PROCESS | 1993 | |4;prototype.html;375.50058422298343;385.84373328801837;393.2351576184319;394.73552719677815;394.9368101103823;4599.170870585888;5201.817936372223;5281.683099014062;5353.464653534649;5485.616006879515;4325.4593175853015;4618.930716039262;4653.812708027231;4911.158315631638;5218.277968270461;4277.786110694468;4295.52749197588;4323.913521729563;4333.133373325331;4340.809505013828;3827.8468861245515;4011.7363030645397;4260.637845783112;4272.615464608185;4317.546657600954;3545.964540354589;4237.364395340708;4256.084941737526;4263.3178691409385;4313.805878735465;3467.618561958208;3983.426546514125;4217.945513621579;4233.174530966463;4252.575387245277;3834.2523207974455;3981;4004.3392840181627;4005.178938317638;4026.617471340218;4774.307725379836;5022.849314520534;5039.823606173766;5114.43741188469;5118.59051275897;4515.63874890008;4933.28467372229;4956.87607809804;4978.103941290567;4996.100701873661;4824.686395384324;5258.790478190038;5493;5654.038813401731;5660.518855897254;3866.9891656338827;3946.5856085110936;4256.446661933929;4433.9556604433865;4448.755318457484;4482.977585112054;4853.927191092136;5264.763085661154;5619.971900140514;5689.260396148474;3965.960340396559;4303.33298338758;4552.931706024412;4580.427446569179;4605.424321959755;4221.810018549173;4678.941265843018;4681.555252251031;4690.437147542249;4702.4592171899985;4179.895502612399;4434.224010798098;4481.3726078349055;4813.590844778233;4852.660313778072;4596.908061838744;4918.639053254458;4972.8756781080765;5104.417630534546;5369.463053694677;1446.5660301909595;1517.673700154472;1518.5444366689949;1523.535321726884;1578.6211309285688;1121.388843080523;1159.7300955453766;1186.863510696281;1195.6847467785367;1222.7615614955175;4699.765011749467;5195.896082078413;5286.312779338738;5317.8404647860625;5318.441563635763;5162.716050617177;5245.239440281138;5447.809326673548;5635.887282254332;5798.652080875161;4540.977295113504;4920.163572192664;5280.788768449219;5284.5772338212855;5298.629095963245;2678.437528119117;2812.2266376746147;2942.661593916727;2947.9263018424713;2955.4040817958494;5305.734713264322;5583.911137328182;5827.79602713903;5846.216903844368;5869.735861886225;4674.883127921761;5504.587155963319;5512.141500949351;5800.883982320414;5895.764169433261;5326.707031113326;5433.972830135824;5912.586118971717;5967.970160149258;6012.789552365646;5220.556252718561;5392.624880655565;5488;5626.971865140648;5664.348599910898;4753.287006948847;5612.550995920398;5674.183961439558;5687.8862422752145;5694.234787215976;5078.390593128848;5674.148877668383;5782.467646073878;5836.854078648068;6001.7599296027665;4208.9789551052045;4639.100562148657;5005.4744251853035;5131.79472821083;5133.5092137346965;4854.83008094715;5597.468240517144;5848.444397782204;5895.580563273205;5916.349201587908;4479.552044795625;5208.713520756243;5274.89450210986;5439.809606663906;5533.280673512418;5106.004329155779;5227.869303267449;5575.526080283059;5617.831465056055;5692.402297758676;5234.351179378484;5257.763400646903;5284.286621306228;5374.516293533601;5549;4988.351514303263;4996.00159936014;5188.896222075613;5273.839755253838;5565.415631358811;5475.6440831345835;5477.425609963311;5478.561715062706;5512.310961129859;5519.530839878656 15:18:02 INFO - PROCESS | 1993 | |5;yui.html;758.5789886612928;775.6509570693189;793.2028311546898;884.8539990901502;894.7360528644049;15835.287412066456;17410.82589174108;17457.999999999985;17461.825381746177;17531.737023944635;16038.43865464709;16138.193090345465;16215.594610134753;16278.511644650649;16279;979.8089372572351;980.6616717232544;1008.2977619978454;1010.5705075342987;1043.2332235806714;1029.428667089765;1033.0495943731746;1033.4316126130636;1033.633060263607;1035.6634093919506;1054.520193312045;1055.709679838043;1056.2236755984384;1056.3239526702878;1059.2003037706559;1046.0062940206797;1047.9790404191874;1049.407084996982;1049.9527521261523;1050.123147172112;780.5004796929969;780.9101953275332;781.3436713160916;781.9687212511493;784.3176436500281;16229;16690.83309166905;17309.7403538947;17403.042832644198;17434.476965690923;14590.416383344653;14725.852741472556;14911.328990195467;15033.173175475344;15150.848491515164;10664.306820056749;11883.940580297043;11926.940365298206;12211.389430528527;12484;3798.26424472863;3798.525184351956;3881.4565960765517;3896.883093507199;3908.0425295802424;102167.97832021733;110414.44792776064;115586;116596;121998;10943.507542160622;11194.832077518844;11301.49143288554;11437.59968401102;11623.816102006633;23897.402564936016;24294.39264018378;24443.266701998968;24509.754902451103;24548.895299711556;7828.21717828224;8026.638801253957;8116.8782468263025;8319.292860106838;8342.582870856433;4579.22153233951;4592.609628181642;4613.6770426070525;4653.23221668421;4829.372181616367;3511.9824400877833;3565.750397472204;3578.141246100969;3582.8566857325413;3590.3716849551224;656.6454114777966;668.2582333609689;697.6651207420365;699.2692636195188;701.123595505618;702.1714377035046;711.7224282529818;726.934575888162;749.628933677833;763.904511936008;10384.896151038543;10790.374240982706;10877.184211184034;10985.670429887115;11180.434739136528;745.8843879198624;749.8425330680509;761.2996043639864;762.9885551716728;771.9546389493395;4830.203016502238;4960.90078198434;5206.76569554371;5222.399424066205;5281.181416880389;87524.5623771877;104493.47753261185;105136.94863051425;107755.46122269338;109408;53915.730421348424;69892;74246.5150696983;78444;91299;78406;79151;79189.60405198052;81155.5942220297;83151;11099.155109198227;11222.607208747655;11271.88806866621;11368.31790092564;11512.884871151182;45561.77219113883;47954.520454795005;48398.5160148394;48500;50054.74972625114;61774.69112654408;63618;66255.01234962959;69583.60832783215;69760;12981.870181298444;13068;13360.131591446914;13401.798973015217;13539.323033848465;15252.923735381251;15599.405982884957;15727.685446290781;16154;16289.59276018109;12262.938685306517;12689.175203611736;12794.232346059267;12892.548760793326;13144.342782860627;13427.395767190696;14296.409041105746;14546.345414456164;14665.633359166106;14682;13256.93371533136;13519;14728.042677225945;14909;15109.32008059618;10186;10429.895701042893;10668.359898406121;10717.732056698645;10886.346819190874;9770.451455395289;9975.31160354632;10959.232853700483;12197.817032744339;12416.627501174979 15:18:02 INFO - PROCESS | 1993 | __end_tp_report 15:18:02 INFO - PROCESS | 1993 | __start_cc_report 15:18:02 INFO - PROCESS | 1993 | _x_x_mozilla_cycle_collect,1369 15:18:02 INFO - PROCESS | 1993 | __end_cc_report 15:18:02 INFO - PROCESS | 1993 | __startTimestamp1494022682271__endTimestamp 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | ------- Summary: start ------- 15:18:02 INFO - PROCESS | 1993 | Number of tests: 6 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#0] dojo.html Cycles:165 Average:5951.07 Median:6246.75 stddev:670.33 (10.7%) stddev-sans-first:638.36 15:18:02 INFO - PROCESS | 1993 | Values: 3263.0 3424.3 3433.1 3479.8 3496.8 6066.3 6084.6 6102.6 6103.8 6136.2 6064.5 6146.3 6154.1 6165.5 6170.5 5344.3 5357.8 5389.9 5414.6 5474.8 5309.4 5313.2 5497.5 5514.2 5535.0 5359.4 5415.0 5418.1 5421.9 5424.8 5425.1 5433.4 5441.0 5442.1 5470.7 5302.9 5393.4 5402.6 5431.3 5523.3 5881.1 5906.5 5910.8 6016.0 6095.2 5466.8 6380.5 6383.2 6392.2 6393.4 6393.2 6452.2 6464.8 6474.0 6515.6 5158.9 5338.5 5386.6 6023.7 6273.2 6436.9 6437.5 6559.5 6593.6 6617.2 6365.4 6368.2 6373.9 6376.5 6416.2 6292.8 6406.9 6429.1 6433.5 6445.5 6289.1 6333.0 6333.0 6368.0 6384.2 6356.2 6371.2 6390.4 6390.6 6395.2 5172.3 5210.4 5213.0 5222.2 5253.9 4527.2 4556.5 4643.4 4657.0 4675.5 6131.5 6155.9 6190.7 6246.8 6266.0 6451.2 6457.1 6461.2 6470.0 6479.4 6231.9 6257.1 6267.0 6276.6 6282.7 5518.4 5547.6 5590.5 5634.6 5635.4 5485.4 6446.6 6453.3 6464.9 6470.1 6321.8 6332.2 6373.9 6391.8 6439.7 6633.5 6708.0 6709.6 6725.7 6733.2 6355.3 6368.8 6373.9 6387.4 6388.4 5461.2 6307.4 6318.1 6381.9 6414.8 4927.8 6332.5 6349.9 6350.6 6363.0 6320.2 6350.9 6352.8 6354.5 6367.4 6148.2 6148.4 6161.0 6192.5 6214.6 6306.3 6320.3 6324.1 6325.2 6325.5 6182.4 6198.8 6217.6 6217.8 6228.2 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#1] ext.html Cycles:180 Average:56785.69 Median:31209.27 stddev:114812.61 (367.9%) stddev-sans-first:115057.68 15:18:02 INFO - PROCESS | 1993 | Values: 776.7 805.8 824.3 896.6 905.9 29664.0 30195.2 42140.6 42980.4 42986.8 43841.6 43907.7 43939.3 43957.8 44088.8 9770.8 9933.2 9968.6 9974.6 9980.8 6893.4 8217.9 11810.4 11955.2 11965.9 11979.4 12020.3 12022.6 12040.0 12057.5 11907.6 11965.8 11970.1 11980.3 12027.2 11742.0 11798.7 11806.4 11807.9 11814.5 40865.6 41030.4 41099.8 41169.6 41197.4 4003.8 4037.8 4069.4 4070.6 4078.5 28678.0 28755.3 30032.5 30264.4 30940.8 2811.9 3246.7 3310.6 3326.3 3336.9 339160.0 339628.3 340057.0 340735.0 340833.0 53162.7 53303.5 53330.2 53356.0 53449.2 55279.7 55291.0 55384.0 55422.7 55511.9 15492.7 15603.3 15610.1 15614.8 15629.1 9726.9 13321.9 13324.2 13332.3 13347.0 11152.6 11273.6 11320.0 11320.1 11338.0 4953.0 5406.2 5425.3 5435.4 5439.6 1049.4 1068.4 1070.7 1072.7 1116.4 27220.7 27819.7 28245.7 29170.7 29196.6 977.9 1133.5 1137.8 1164.4 1178.7 12180.3 13575.0 14645.9 14759.8 14966.9 452050.0 453879.0 454246.0 454487.0 454988.0 48568.8 48762.5 51890.2 56856.4 56943.7 1459.7 1494.9 1498.4 1510.8 1514.6 29690.6 31122.8 31295.7 31742.7 31760.7 46912.5 47149.1 48053.0 49827.3 50145.5 483126.0 486209.0 488275.6 491717.0 497296.0 30181.5 30214.8 30277.0 30281.1 30992.2 39540.0 39666.4 39764.8 40032.0 40082.2 24585.5 27682.6 28315.4 28695.9 29686.3 27553.0 28111.9 28503.9 28925.4 29151.8 33321.3 33416.8 34014.1 34187.0 34252.0 28313.6 28590.3 28781.6 29146.9 29792.4 22349.9 23845.2 23937.9 24178.6 24208.9 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#2] jquery.html Cycles:180 Average:45970.97 Median:22856.60 stddev:138616.63 (606.5%) stddev-sans-first:138963.24 15:18:02 INFO - PROCESS | 1993 | Values: 392.7 421.3 426.7 446.0 462.3 19210.5 20293.2 21309.9 21433.4 21581.8 21797.7 21896.6 22753.0 23099.1 23138.5 6609.0 6864.0 6870.1 6876.9 6881.6 6492.6 7835.0 8050.7 8051.1 8057.6 7697.4 7748.3 7817.0 7828.6 8039.6 7887.0 7902.7 7921.7 7986.9 7992.3 7444.8 7500.5 7665.7 7666.8 7693.7 23572.0 24820.0 26217.7 27094.6 27184.9 2913.9 3028.3 3052.3 3076.7 3133.7 15555.8 16069.4 16243.5 16563.6 17419.9 2088.2 2150.6 2151.5 2162.8 2171.4 151827.0 155664.0 156707.0 158521.0 161190.0 19212.0 19899.7 20031.4 20211.2 20226.9 31669.7 32152.2 32178.8 32223.8 32290.0 10326.6 10509.2 10634.7 10668.8 10881.2 8860.2 8871.4 8882.8 9069.9 9084.4 9224.5 9354.1 9361.3 9389.8 9396.2 2954.4 3733.6 3778.8 3831.9 3844.2 1011.8 1039.3 1046.5 1061.3 1065.2 21723.9 22960.2 24580.8 24620.5 24655.5 1018.3 1031.2 1072.2 1074.9 1080.4 6471.1 7140.3 7155.5 7284.0 7528.3 820735.0 823969.0 827226.0 832788.0 858450.0 162359.0 164347.0 164639.0 166526.2 169965.2 1288.7 1306.9 1337.2 1338.8 1342.1 10107.7 12539.7 12721.1 12995.8 13245.3 68035.0 68175.3 68367.0 68758.0 69633.7 79148.0 85294.0 95001.6 95049.5 96143.0 11514.3 11648.9 11990.3 12068.0 12082.3 12156.6 12546.3 13152.7 13244.9 13588.3 9626.0 11680.5 11728.6 11892.1 12011.8 9054.7 10771.4 11030.6 11136.0 11274.9 10070.4 11630.1 11824.0 11936.7 12017.9 11759.1 11789.2 11854.1 11874.6 12056.9 9827.2 10609.3 10824.1 11728.0 11941.8 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#3] mootools.html Cycles:180 Average:6796.36 Median:2495.93 stddev:4171.40 (167.1%) stddev-sans-first:4163.69 15:18:02 INFO - PROCESS | 1993 | Values: 1441.5 1574.8 1607.5 1638.5 1644.0 10715.6 11371.7 11380.2 11380.9 11407.7 10847.8 11110.3 11128.3 11286.0 11332.4 2321.2 2356.2 2500.0 2509.4 2516.6 2418.4 2497.2 2510.3 2514.7 2515.4 2433.2 2459.2 2477.9 2480.0 2489.7 2430.4 2434.6 2451.8 2457.1 2503.7 2460.4 2485.5 2490.8 2494.4 2494.6 10973.7 11247.6 11248.6 11250.5 11257.8 5937.4 6104.7 6127.0 6131.7 6154.7 3653.5 3657.0 3743.4 3784.5 3854.0 1198.0 1223.9 1240.3 1290.7 1296.8 13979.0 14247.9 14500.5 15502.5 15748.7 4702.5 4816.7 4850.3 4884.6 4899.1 10401.7 11898.3 11900.6 11907.2 11914.9 5152.2 5209.5 5210.3 5212.3 5215.3 5321.4 5420.3 5485.0 5559.0 5607.3 3973.2 4000.3 4025.5 4058.4 4091.0 1072.1 1072.2 1074.6 1081.5 1081.5 847.4 930.8 950.4 968.7 1016.1 6562.5 6637.3 6676.5 6939.7 6961.3 1014.2 1022.8 1045.7 1065.9 1112.9 4050.0 4239.4 4249.9 4364.7 4416.0 12269.4 13906.8 13917.2 13936.3 13946.1 11739.0 13443.3 13838.2 13849.7 13895.2 9468.1 9690.0 10384.8 10388.5 10400.8 6521.0 6762.1 6847.4 7029.3 7180.3 12099.8 12343.8 12586.9 12654.5 12703.9 10522.8 11151.2 12680.1 12888.9 12889.7 8983.1 9183.8 9341.1 9475.2 9481.9 10486.9 10523.9 10665.4 10690.8 10705.4 8673.9 8690.0 8892.2 9003.8 9071.6 8648.4 8680.3 8748.3 8789.9 8833.2 7251.0 7977.6 7992.7 8019.6 8126.8 6032.6 6049.2 6074.5 6093.5 6115.8 5944.7 6178.9 6241.5 6314.4 6332.8 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#4] prototype.html Cycles:180 Average:4610.33 Median:4992.18 stddev:1278.84 (25.6%) stddev-sans-first:1242.30 15:18:02 INFO - PROCESS | 1993 | Values: 375.5 385.8 393.2 394.7 394.9 4599.2 5201.8 5281.7 5353.5 5485.6 4325.5 4618.9 4653.8 4911.2 5218.3 4277.8 4295.5 4323.9 4333.1 4340.8 3827.8 4011.7 4260.6 4272.6 4317.5 3546.0 4237.4 4256.1 4263.3 4313.8 3467.6 3983.4 4217.9 4233.2 4252.6 3834.3 3981.0 4004.3 4005.2 4026.6 4774.3 5022.8 5039.8 5114.4 5118.6 4515.6 4933.3 4956.9 4978.1 4996.1 4824.7 5258.8 5493.0 5654.0 5660.5 3867.0 3946.6 4256.4 4434.0 4448.8 4483.0 4853.9 5264.8 5620.0 5689.3 3966.0 4303.3 4552.9 4580.4 4605.4 4221.8 4678.9 4681.6 4690.4 4702.5 4179.9 4434.2 4481.4 4813.6 4852.7 4596.9 4918.6 4972.9 5104.4 5369.5 1446.6 1517.7 1518.5 1523.5 1578.6 1121.4 1159.7 1186.9 1195.7 1222.8 4699.8 5195.9 5286.3 5317.8 5318.4 5162.7 5245.2 5447.8 5635.9 5798.7 4541.0 4920.2 5280.8 5284.6 5298.6 2678.4 2812.2 2942.7 2947.9 2955.4 5305.7 5583.9 5827.8 5846.2 5869.7 4674.9 5504.6 5512.1 5800.9 5895.8 5326.7 5434.0 5912.6 5968.0 6012.8 5220.6 5392.6 5488.0 5627.0 5664.3 4753.3 5612.6 5674.2 5687.9 5694.2 5078.4 5674.1 5782.5 5836.9 6001.8 4209.0 4639.1 5005.5 5131.8 5133.5 4854.8 5597.5 5848.4 5895.6 5916.3 4479.6 5208.7 5274.9 5439.8 5533.3 5106.0 5227.9 5575.5 5617.8 5692.4 5234.4 5257.8 5284.3 5374.5 5549.0 4988.4 4996.0 5188.9 5273.8 5565.4 5475.6 5477.4 5478.6 5512.3 5519.5 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - PROCESS | 1993 | [#5] yui.html Cycles:180 Average:20678.87 Median:16284.30 stddev:29141.39 (179.0%) stddev-sans-first:29184.75 15:18:02 INFO - PROCESS | 1993 | Values: 758.6 775.7 793.2 884.9 894.7 15835.3 17410.8 17458.0 17461.8 17531.7 16038.4 16138.2 16215.6 16278.5 16279.0 979.8 980.7 1008.3 1010.6 1043.2 1029.4 1033.0 1033.4 1033.6 1035.7 1054.5 1055.7 1056.2 1056.3 1059.2 1046.0 1048.0 1049.4 1050.0 1050.1 780.5 780.9 781.3 782.0 784.3 16229.0 16690.8 17309.7 17403.0 17434.5 14590.4 14725.9 14911.3 15033.2 15150.8 10664.3 11883.9 11926.9 12211.4 12484.0 3798.3 3798.5 3881.5 3896.9 3908.0 102168.0 110414.4 115586.0 116596.0 121998.0 10943.5 11194.8 11301.5 11437.6 11623.8 23897.4 24294.4 24443.3 24509.8 24548.9 7828.2 8026.6 8116.9 8319.3 8342.6 4579.2 4592.6 4613.7 4653.2 4829.4 3512.0 3565.8 3578.1 3582.9 3590.4 656.6 668.3 697.7 699.3 701.1 702.2 711.7 726.9 749.6 763.9 10384.9 10790.4 10877.2 10985.7 11180.4 745.9 749.8 761.3 763.0 772.0 4830.2 4960.9 5206.8 5222.4 5281.2 87524.6 104493.5 105136.9 107755.5 109408.0 53915.7 69892.0 74246.5 78444.0 91299.0 78406.0 79151.0 79189.6 81155.6 83151.0 11099.2 11222.6 11271.9 11368.3 11512.9 45561.8 47954.5 48398.5 48500.0 50054.7 61774.7 63618.0 66255.0 69583.6 69760.0 12981.9 13068.0 13360.1 13401.8 13539.3 15252.9 15599.4 15727.7 16154.0 16289.6 12262.9 12689.2 12794.2 12892.5 13144.3 13427.4 14296.4 14546.3 14665.6 14682.0 13256.9 13519.0 14728.0 14909.0 15109.3 10186.0 10429.9 10668.4 10717.7 10886.3 9770.5 9975.3 10959.2 12197.8 12416.6 15:18:02 INFO - PROCESS | 1993 | -------- Summary: end -------- 15:18:02 INFO - PROCESS | 1993 | 15:18:02 INFO - TEST-INFO | 1993: exit 0 15:18:02 INFO - TEST-OK | dromaeo_css | took 1118409ms 15:18:02 INFO - TEST-START | kraken 15:18:02 INFO - operating with platform_type : mac_ 15:18:02 INFO - Initialising browser for kraken test... 15:18:02 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpyiEIrE/profile http://localhost:49646/getInfo.html) 15:18:05 INFO - PROCESS | 1998 | __metrics Screen width/height:1600/1200 15:18:05 INFO - PROCESS | 1998 | colorDepth:24 15:18:05 INFO - PROCESS | 1998 | Browser inner width/height: 1024/689 15:18:05 INFO - PROCESS | 1998 | __metrics 15:18:05 INFO - PROCESS | 1998 | 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" 15:18:05 INFO - PROCESS | 1998 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:05 INFO - TEST-INFO | 1998: exit 0 15:18:05 INFO - Browser initialized. 15:18:05 INFO - Running cycle 1/1 for kraken test... 15:18:05 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpyiEIrE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:18 INFO - PROCESS | 2000 | RSS: Main: 169209856 15:18:18 INFO - PROCESS | 2000 | 15:18:20 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-beat-detection) 15:18:21 INFO - PROCESS | 2000 | RSS: Main: 219795456 15:18:21 INFO - PROCESS | 2000 | 15:18:24 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-dft) 15:18:25 INFO - PROCESS | 2000 | RSS: Main: 229580800 15:18:25 INFO - PROCESS | 2000 | 15:18:28 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-fft) 15:18:28 INFO - PROCESS | 2000 | RSS: Main: 326553600 15:18:28 INFO - PROCESS | 2000 | 15:18:30 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49646/tests/kraken/driver.html?testName=audio-oscillator) 15:18:31 INFO - PROCESS | 2000 | RSS: Main: 230563840 15:18:31 INFO - PROCESS | 2000 | 15:18:33 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:34 INFO - PROCESS | 2000 | RSS: Main: 231112704 15:18:34 INFO - PROCESS | 2000 | 15:18:37 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:37 INFO - PROCESS | 2000 | RSS: Main: 272871424 15:18:37 INFO - PROCESS | 2000 | 15:18:40 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49646/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:41 INFO - PROCESS | 2000 | RSS: Main: 272510976 15:18:41 INFO - PROCESS | 2000 | 15:18:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49646/tests/kraken/driver.html?testName=json-parse-financial) 15:18:44 INFO - PROCESS | 2000 | RSS: Main: 271163392 15:18:44 INFO - PROCESS | 2000 | 15:18:46 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49646/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:18:47 INFO - PROCESS | 2000 | RSS: Main: 250040320 15:18:47 INFO - PROCESS | 2000 | 15:18:48 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:18:49 INFO - PROCESS | 2000 | RSS: Main: 252403712 15:18:49 INFO - PROCESS | 2000 | 15:18:51 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:18:52 INFO - PROCESS | 2000 | RSS: Main: 262238208 15:18:52 INFO - PROCESS | 2000 | 15:18:55 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:18:56 INFO - PROCESS | 2000 | RSS: Main: 274763776 15:18:56 INFO - PROCESS | 2000 | 15:18:58 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:18:59 INFO - PROCESS | 2000 | RSS: Main: 268582912 15:18:59 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49646/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49646/tests/kraken/driver.html?testName=ai-astar) 15:19:01 INFO - PROCESS | 2000 | RSS: Main: 312709120 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | __start_tp_report 15:19:01 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 15:19:01 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 15:19:01 INFO - PROCESS | 2000 | |i|pagename|runs| 15:19:01 INFO - PROCESS | 2000 | |0;ai-astar;118;118;123;171;154;119;117;115;117;117 15:19:01 INFO - PROCESS | 2000 | |1;audio-beat-detection;139;131;129;150;107;108;134;129;126;110 15:19:01 INFO - PROCESS | 2000 | |2;audio-dft;187;188;182;185;186;184;185;189;186;188 15:19:01 INFO - PROCESS | 2000 | |3;audio-fft;78;60;62;89;60;61;58;76;96;78 15:19:01 INFO - PROCESS | 2000 | |4;audio-oscillator;85;70;85;69;68;67;80;67;68;82 15:19:01 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;88;88;99;132;90;89;88;133;89;89 15:19:01 INFO - PROCESS | 2000 | |6;imaging-darkroom;97;95;94;94;94;96;95;95;96;94 15:19:01 INFO - PROCESS | 2000 | |7;imaging-desaturate;100;130;128;87;87;86;86;87;87;87 15:19:01 INFO - PROCESS | 2000 | |8;json-parse-financial;59;59;60;63;62;62;64;66;65;64 15:19:01 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;54;64;62;61;61;59;58;57;59;59 15:19:01 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;81;77;83;79;84;83;83;85;82;89 15:19:01 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;134;138;143;132;135;127;123;136;186;148 15:19:01 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;162;165;161;161;162;166;163;159;176;211 15:19:01 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;64;65;64;66;74;78;65;58;74;77 15:19:01 INFO - PROCESS | 2000 | __end_tp_report 15:19:01 INFO - PROCESS | 2000 | __start_cc_report 15:19:01 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,2137 15:19:01 INFO - PROCESS | 2000 | __end_cc_report 15:19:01 INFO - PROCESS | 2000 | __startTimestamp1494022741566__endTimestamp 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | ------- Summary: start ------- 15:19:01 INFO - PROCESS | 2000 | Number of tests: 14 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:126.90 Median:118.50 stddev:19.30 (16.3%) stddev-sans-first:20.20 15:19:01 INFO - PROCESS | 2000 | Values: 118.0 118.0 123.0 171.0 154.0 119.0 117.0 115.0 117.0 117.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:130.00 stddev:14.11 (10.9%) stddev-sans-first:14.20 15:19:01 INFO - PROCESS | 2000 | Values: 139.0 131.0 129.0 150.0 107.0 108.0 134.0 129.0 126.0 110.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:186.00 Median:186.50 stddev:2.11 (1.1%) stddev-sans-first:2.20 15:19:01 INFO - PROCESS | 2000 | Values: 187.0 188.0 182.0 185.0 186.0 184.0 185.0 189.0 186.0 188.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:71.80 Median:77.00 stddev:13.57 (17.6%) stddev-sans-first:14.21 15:19:01 INFO - PROCESS | 2000 | Values: 78.0 60.0 62.0 89.0 60.0 61.0 58.0 76.0 96.0 78.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:74.10 Median:75.00 stddev:7.84 (10.5%) stddev-sans-first:7.25 15:19:01 INFO - PROCESS | 2000 | Values: 85.0 70.0 85.0 69.0 68.0 67.0 80.0 67.0 68.0 82.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:89.00 stddev:18.22 (20.5%) stddev-sans-first:18.92 15:19:01 INFO - PROCESS | 2000 | Values: 88.0 88.0 99.0 132.0 90.0 89.0 88.0 133.0 89.0 89.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:1.05 (1.1%) stddev-sans-first:0.83 15:19:01 INFO - PROCESS | 2000 | Values: 97.0 95.0 94.0 94.0 94.0 96.0 95.0 95.0 96.0 94.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:87.00 stddev:17.63 (20.3%) stddev-sans-first:18.66 15:19:01 INFO - PROCESS | 2000 | Values: 100.0 130.0 128.0 87.0 87.0 86.0 86.0 87.0 87.0 87.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.50 stddev:2.46 (3.9%) stddev-sans-first:2.28 15:19:01 INFO - PROCESS | 2000 | Values: 59.0 59.0 60.0 63.0 62.0 62.0 64.0 66.0 65.0 64.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:60.00 stddev:2.80 (4.7%) stddev-sans-first:2.18 15:19:01 INFO - PROCESS | 2000 | Values: 54.0 64.0 62.0 61.0 61.0 59.0 58.0 57.0 59.0 59.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:3.27 (3.9%) stddev-sans-first:3.42 15:19:01 INFO - PROCESS | 2000 | Values: 81.0 77.0 83.0 79.0 84.0 83.0 83.0 85.0 82.0 89.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:137.00 stddev:17.61 (12.9%) stddev-sans-first:18.54 15:19:01 INFO - PROCESS | 2000 | Values: 134.0 138.0 143.0 132.0 135.0 127.0 123.0 136.0 186.0 148.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:164.00 stddev:15.63 (9.5%) stddev-sans-first:16.39 15:19:01 INFO - PROCESS | 2000 | Values: 162.0 165.0 161.0 161.0 162.0 166.0 163.0 159.0 176.0 211.0 15:19:01 INFO - PROCESS | 2000 | 15:19:01 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:70.00 stddev:6.70 (9.6%) stddev-sans-first:6.91 15:19:01 INFO - PROCESS | 2000 | Values: 64.0 65.0 64.0 66.0 74.0 78.0 65.0 58.0 74.0 77.0 15:19:01 INFO - PROCESS | 2000 | -------- Summary: end -------- 15:19:01 INFO - PROCESS | 2000 | 15:19:02 INFO - TEST-INFO | 2000: exit 0 15:19:02 INFO - TEST-OK | kraken | took 59581ms 15:19:02 INFO - SUITE-END | took 1177s 15:19:02 INFO - Completed test suite (00:19:38) 15:19:02 INFO - javascript benchmark 15:19:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7850.471987268657, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.9999999999986, 3424.263783286593, 3433.141714571357, 3479.8434070466833, 3496.7901925884466, 6066.272047354318, 6084.604500707462, 6102.572819902609, 6103.816885493431, 6136.23297087864, 6064.5148388128955, 6146.323904370515, 6154.138420621117, 6165.475934545569, 6170.47550958168, 5344.278522399475, 5357.7589008494715, 5389.865253368677, 5414.593905457106, 5474.7810087596445, 5309.362876454831, 5313.20301954708, 5497.45025497451, 5514.228008078872, 5534.972325138388, 5359.38367087786, 5414.972925135369, 5418.106012507951, 5421.864453388657, 5424.783008679648, 5425.13197888338, 5433.375161856397, 5441.0, 5442.102053161263, 5470.671759694411, 5302.92045619316, 5393.379761327458, 5402.594805389572, 5431.34823821144, 5523.337199536041, 5881.117832325142, 5906.468417842372, 5910.793122240744, 6015.969920150415, 6095.177151084591, 5466.808661696821, 6380.521460890405, 6383.170187875547, 6392.232932048184, 6393.392627700361, 6393.1688880445245, 6452.161219041542, 6464.806055818286, 6474.02889566564, 6515.609063456208, 5158.92261616076, 5338.492843179931, 5386.649867758583, 6023.69881505923, 6273.184486016834, 6436.935630643728, 6437.517186211053, 6559.5408321418, 6593.571417857824, 6617.172853393326, 6365.395287447685, 6368.203974503187, 6373.904391434132, 6376.521760867953, 6416.165898433173, 6292.8426789329715, 6406.935930640634, 6429.067785171217, 6433.549651524442, 6445.45213656835, 6289.0880822280515, 6333.0, 6333.018382150774, 6368.044793280952, 6384.170057892537, 6356.237251529754, 6371.203599550056, 6390.4248617624635, 6390.616563006141, 6395.232572091379, 5172.27588137661, 5210.400803907523, 5213.0, 5222.21666749983, 5253.868653283698, 4527.2303708369, 4556.476005259437, 4643.396358473445, 4656.95343046572, 4675.509071547506, 6131.540134489931, 6155.938440615626, 6190.721417536221, 6246.75012999484, 6265.96867015662, 6451.1936007999, 6457.063725759738, 6461.224653041665, 6469.967650161813, 6479.384458476437, 6231.875362492725, 6257.061440783918, 6267.0, 6276.592021518587, 6282.748690052438, 5518.420565840609, 5547.611667183339, 5590.496855283044, 5634.577406694514, 5635.3519345275, 5485.369182544058, 6446.613203207822, 6453.322401147906, 6464.8707025858275, 6470.061841033118, 6321.778737744341, 6332.208473940757, 6373.936260637334, 6391.776287829904, 6439.710213040518, 6633.469322454289, 6708.02733603615, 6709.630970296681, 6725.663716814041, 6733.192016957996, 6355.300916899045, 6368.840778980562, 6373.936260637334, 6387.361263873576, 6388.39310265524, 5461.235427040138, 6307.369263073656, 6318.0838778375955, 6381.8723625528155, 6414.807555773335, 4927.778249978831, 6332.525060620564, 6349.904751428825, 6350.618962862059, 6363.0, 6320.1638339535875, 6350.872982540416, 6352.809415717536, 6354.459870911024, 6367.363263673596, 6148.200733904742, 6148.44663980244, 6160.969195153995, 6192.504599632109, 6214.627122372672, 6306.2747784003595, 6320.336364681826, 6324.146240257506, 6325.240971083499, 6325.525585581007, 6182.443580077815, 6198.752049917953, 6217.595856269328, 6217.813465596039, 6228.22147231596], "value": 5908.555174585421, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.7009701265011, 805.8186907945712, 824.2787560884225, 896.6323807239029, 905.9411138276016, 29664.0, 30195.24511887204, 42140.578594214014, 42980.355294670604, 42986.785066074706, 43841.561584384144, 43907.68276951688, 43939.34090988638, 43957.78021109898, 44088.77955610226, 9770.755731106708, 9933.155681767023, 9968.551415186334, 9974.551145198484, 9980.800383992315, 6893.3795958363735, 8217.876731849026, 11810.409479526032, 11955.222910510833, 11965.940170299136, 11979.40102994851, 12020.278783272988, 12022.57920972766, 12040.0, 12057.517699292017, 11907.583234586791, 11965.820512692317, 11970.102242331859, 11980.28118312904, 12027.158098933078, 11742.0, 11798.705032374173, 11806.350650714206, 11807.88192118085, 11814.527418903233, 40865.591344086475, 41030.38454423186, 41099.7945010273, 41169.58830411718, 41197.38203926943, 4003.83984640614, 4037.7577345359373, 4069.369247766601, 4070.5725898780497, 4078.530968938551, 28678.0, 28755.28111797222, 30032.529611879472, 30264.394712105634, 30940.8452957736, 2811.915642530707, 3246.6915643013876, 3310.586176727909, 3326.334733053399, 3336.9332613347597, 339160.0, 339628.3018584916, 340057.0, 340735.0, 340833.0, 53162.734186328824, 53303.46696533063, 53330.20004699933, 53356.0, 53449.198262026104, 55279.72360138174, 55291.0, 55384.0, 55422.72288638531, 55511.88976220453, 15492.690146197014, 15603.297851596706, 15610.063396196265, 15614.765778513105, 15629.14039727826, 9726.90273097274, 13321.933390332986, 13324.200547967153, 13332.333383330795, 13347.0, 11152.553897844158, 11273.605423810128, 11320.037796787201, 11320.09439244875, 11337.979581837673, 4953.0, 5406.243125962368, 5425.26758887553, 5435.42927992563, 5439.619226654176, 1049.41757324684, 1068.3536460441476, 1070.6787963610886, 1072.6889202131294, 1116.3804088730833, 27220.727792722217, 27819.721802782118, 28245.71754282472, 29170.708292917225, 29196.562051569243, 977.8875429325576, 1133.478599844081, 1137.766757814646, 1164.4410682872099, 1178.723000094977, 12180.269183848997, 13575.049746517649, 14645.853541464448, 14759.77860332096, 14966.850331496764, 452050.0, 453879.0, 454246.0, 454487.0, 454988.0, 48568.7571562147, 48762.5123748758, 51890.22164667533, 56856.43143568594, 56943.715281424156, 1459.6642772162463, 1494.940202391914, 1498.4081287891004, 1510.8035955325956, 1514.6364872430759, 29690.554641680825, 31122.844385777928, 31295.687043129277, 31742.682573173974, 31760.682393176696, 46912.53087469082, 47149.05701886012, 48053.03893922172, 49827.25259121044, 50145.49854501408, 483126.0, 486209.0, 488275.55862220464, 491717.0, 497296.0, 30181.547276791305, 30214.848925755232, 30277.0, 30281.091567253017, 30992.22519437032, 39540.0, 39666.40500392439, 39764.80117599509, 40032.0, 40082.19835603213, 24585.508289833746, 27682.584761229, 28315.43369132647, 28695.85652071726, 29686.25784355322, 27553.035643752373, 28111.875524978772, 28503.857480712464, 28925.421491570472, 29151.81361397861, 33321.333573328884, 33416.832915835264, 34014.149646258054, 34187.0, 34252.0, 28313.57529637016, 28590.285242869093, 28781.56827647629, 29146.854265728536, 29792.404151917275, 22349.888250558644, 23845.165419210243, 23937.880310598335, 24178.637320439855, 24208.87895560511], "value": 19079.138014271495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.6681953749082, 421.300640936046, 426.69704509798044, 445.9843905463308, 462.34116384152594, 19210.519737006565, 20293.188272469102, 21309.893450532727, 21433.356999290027, 21581.784182158175, 21797.67303490449, 21896.562068758656, 22753.0, 23099.0760369585, 23138.537229255406, 6609.041688955099, 6864.0, 6870.141232345957, 6876.931230687705, 6881.621510816903, 6492.610443373413, 7835.0, 8050.677972881078, 8051.0741264754715, 8057.597120143999, 7697.384209263273, 7748.30265276125, 7816.983792107047, 7828.608569571527, 8039.598020099001, 7886.960565197137, 7902.723404680866, 7921.683132674686, 7986.880196797053, 7992.280694737473, 7444.776656700307, 7500.499900020018, 7665.655045522964, 7666.8466630667635, 7693.730719424793, 23572.0, 24820.0, 26217.73782262172, 27094.5935810963, 27184.864075679692, 2913.883444662211, 3028.348904985439, 3052.252198211452, 3076.6769489203534, 3133.7336326412283, 15555.844441555553, 16069.357225710957, 16243.512694619063, 16563.585910352336, 17419.8677085989, 2088.237793205484, 2150.5913876363443, 2151.505153814616, 2162.76209616942, 2171.4462811982844, 151827.0, 155664.0, 156707.0, 158521.0, 161190.0, 19212.0, 19899.701504477154, 20031.39905802828, 20211.191552338038, 20226.89886550558, 31669.733210671777, 32152.19619509531, 32178.83910580432, 32223.838880805914, 32290.0, 10326.586936522455, 10509.159267258601, 10634.734131646615, 10668.839967400496, 10881.183911206692, 8860.202581767671, 8871.379003469825, 8882.80355991739, 9069.911610606638, 9084.40951338161, 9224.492652904155, 9354.111359420844, 9361.34470587066, 9389.76525586852, 9396.154346108746, 2954.3648115655237, 3733.5893051764283, 3778.8110594470168, 3831.923361532754, 3844.231153769257, 1011.8229309870743, 1039.26212389203, 1046.4819914142547, 1061.264831999686, 1065.17628022177, 21723.891380542995, 22960.19639312616, 24580.754192458204, 24620.5075898481, 24655.506889862103, 1018.3482571154467, 1031.2214278220047, 1072.1851392941421, 1074.8871368506195, 1080.4111759091313, 6471.061696054046, 7140.321669441395, 7155.534890232118, 7283.963580182065, 7528.284812942762, 820735.0, 823969.0, 827226.0, 832788.0, 858450.0, 162359.0, 164347.0, 164639.0, 166526.16736916237, 169965.15017424832, 1288.6907142285972, 1306.888914442264, 1337.2043634037732, 1338.8326459192406, 1342.1209108034254, 10107.69676909694, 12539.74920501603, 12721.109522333349, 12995.805062924253, 13245.27151006704, 68035.0, 68175.31824681888, 68367.0, 68758.0, 69633.65183174255, 79148.0, 85294.0, 95001.57497637403, 95049.5247523758, 96143.0, 11514.30914145154, 11648.94175529117, 11990.280583165038, 12068.0, 12082.275063496218, 12156.635300940987, 12546.309952952675, 13152.73694526085, 13244.867551324363, 13588.25264610456, 9626.0, 11680.532778688757, 11728.648140555797, 11892.10809189297, 12011.81982270284, 9054.728358149267, 10771.353718776585, 11030.558777648805, 11136.0, 11274.943625281821, 10070.44612546317, 11630.127740419333, 11823.994960428116, 11936.701582460508, 12017.939910300393, 11759.059275257789, 11789.174757766874, 11854.051675865738, 11874.643760687193, 12056.939715301367, 9827.164691001059, 10609.310394824312, 10824.079953204066, 11728.003119734918, 11941.82087268709], "value": 11738.573034416462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4594527052354, 1574.8188958269802, 1607.4889603772453, 1638.4920674590874, 1644.0135918448932, 10715.571377144915, 11371.658850234506, 11380.203385763, 11380.943095284512, 11407.657770266906, 10847.783044339109, 11110.333379997206, 11128.332300062002, 11286.0, 11332.376719280437, 2321.2339927823778, 2356.2460012795914, 2499.950000999979, 2509.397744541315, 2516.6225066240117, 2418.4074901649033, 2497.2133777859917, 2510.272021113875, 2514.748525147489, 2515.3585835611893, 2433.221369161869, 2459.225344016629, 2477.8513289202615, 2480.0327872129883, 2489.6887889013874, 2430.3559556717482, 2434.6469761884427, 2451.7915977141965, 2457.103157347573, 2503.674522312106, 2460.4095017195746, 2485.5401750676183, 2490.8256422050463, 2494.4262819551604, 2494.6382774497597, 10973.725656858562, 11247.60633377836, 11248.55005799767, 11250.54997800087, 11257.774844503147, 5937.406259374071, 6104.725287362079, 6126.969365153146, 6131.724072416752, 6154.692265386758, 3653.50677658518, 3657.030886814996, 3743.419769935664, 3784.4512545680996, 3854.0, 1197.9640610781692, 1223.920445171061, 1240.2930329712067, 1290.69023434376, 1296.7860303049986, 13979.021468497209, 14247.928760356235, 14500.492482763053, 15502.457413990569, 15748.740100791909, 4702.52974702527, 4816.735079570657, 4850.278151256323, 4884.609231261491, 4899.093667671492, 10401.68794936153, 11898.286102833685, 11900.583479578347, 11907.226030308002, 11914.88085119155, 5152.201408781645, 5209.479052094836, 5210.270562121306, 5212.322398088224, 5215.305025866609, 5321.388040375329, 5420.295361602966, 5484.972575137099, 5559.0, 5607.327120745536, 3973.2450834341385, 4000.3199456092534, 4025.5370632377067, 4058.431819545266, 4090.9795451022555, 1072.104792498257, 1072.1797824663981, 1074.5970261152067, 1081.5133190064503, 1081.5349399758022, 847.4449235750593, 930.8184903943801, 950.4154944708954, 968.7335982604699, 1016.1058268723624, 6562.50781191403, 6637.269900310962, 6676.499262555328, 6939.7224111036, 6961.26906674802, 1014.1886490807472, 1022.7749895023084, 1045.7333379988206, 1065.9413732244645, 1112.8942750438696, 4049.967258349161, 4239.427677263591, 4249.915001699948, 4364.650827933758, 4415.977920110379, 12269.447874845653, 13906.791398129037, 13917.234552099731, 13936.303184840717, 13946.093503922213, 11739.0, 13443.32783360828, 13838.23889686077, 13849.653758656113, 13895.166290022631, 9468.053194680615, 9690.0, 10384.844227336596, 10388.532516036796, 10400.791984160123, 6520.967395162994, 6762.087118238975, 6847.417969472651, 7029.332213439715, 7180.281971802778, 12099.79002099783, 12343.814842777545, 12586.937065314614, 12654.493820247455, 12703.93648031754, 10522.789544209227, 11151.219414640897, 12680.11239213283, 12888.935555322163, 12889.742205155657, 8983.101689830964, 9183.77040573991, 9341.065893410605, 9475.241980641395, 9481.857772133286, 10486.947565262124, 10523.894761052597, 10665.36007839532, 10690.839637405601, 10705.357678539312, 8673.869891951499, 8690.044095149402, 8892.15524525169, 9003.81992360136, 9071.637134514545, 8648.351373646876, 8680.305575553813, 8748.300135988979, 8789.868151977853, 8833.160849719266, 7251.021112149792, 7977.561234131947, 7992.680292788224, 8019.6391162398995, 8126.796830079295, 6032.638041717511, 6049.213602231682, 6074.483668888017, 6093.507090762791, 6115.84710382244, 5944.702764861826, 6178.876422471615, 6241.469475094668, 6314.400131987454, 6332.778352757631], "value": 5228.172528181978, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.50058422298343, 385.84373328801837, 393.2351576184319, 394.73552719677815, 394.9368101103823, 4599.170870585888, 5201.817936372223, 5281.683099014062, 5353.464653534649, 5485.616006879515, 4325.4593175853015, 4618.930716039262, 4653.812708027231, 4911.158315631638, 5218.277968270461, 4277.786110694468, 4295.52749197588, 4323.913521729563, 4333.133373325331, 4340.809505013828, 3827.8468861245515, 4011.7363030645397, 4260.637845783112, 4272.615464608185, 4317.546657600954, 3545.964540354589, 4237.364395340708, 4256.084941737526, 4263.3178691409385, 4313.805878735465, 3467.618561958208, 3983.426546514125, 4217.945513621579, 4233.174530966463, 4252.575387245277, 3834.2523207974455, 3981.0, 4004.3392840181627, 4005.178938317638, 4026.617471340218, 4774.307725379836, 5022.849314520534, 5039.823606173766, 5114.43741188469, 5118.59051275897, 4515.63874890008, 4933.28467372229, 4956.87607809804, 4978.103941290567, 4996.100701873661, 4824.686395384324, 5258.790478190038, 5493.0, 5654.038813401731, 5660.518855897254, 3866.9891656338827, 3946.5856085110936, 4256.446661933929, 4433.9556604433865, 4448.755318457484, 4482.977585112054, 4853.927191092136, 5264.763085661154, 5619.971900140514, 5689.260396148474, 3965.960340396559, 4303.33298338758, 4552.931706024412, 4580.427446569179, 4605.424321959755, 4221.810018549173, 4678.941265843018, 4681.555252251031, 4690.437147542249, 4702.4592171899985, 4179.895502612399, 4434.224010798098, 4481.3726078349055, 4813.590844778233, 4852.660313778072, 4596.908061838744, 4918.639053254458, 4972.8756781080765, 5104.417630534546, 5369.463053694677, 1446.5660301909595, 1517.673700154472, 1518.5444366689949, 1523.535321726884, 1578.6211309285688, 1121.388843080523, 1159.7300955453766, 1186.863510696281, 1195.6847467785367, 1222.7615614955175, 4699.765011749467, 5195.896082078413, 5286.312779338738, 5317.8404647860625, 5318.441563635763, 5162.716050617177, 5245.239440281138, 5447.809326673548, 5635.887282254332, 5798.652080875161, 4540.977295113504, 4920.163572192664, 5280.788768449219, 5284.5772338212855, 5298.629095963245, 2678.437528119117, 2812.2266376746147, 2942.661593916727, 2947.9263018424713, 2955.4040817958494, 5305.734713264322, 5583.911137328182, 5827.79602713903, 5846.216903844368, 5869.735861886225, 4674.883127921761, 5504.587155963319, 5512.141500949351, 5800.883982320414, 5895.764169433261, 5326.707031113326, 5433.972830135824, 5912.586118971717, 5967.970160149258, 6012.789552365646, 5220.556252718561, 5392.624880655565, 5488.0, 5626.971865140648, 5664.348599910898, 4753.287006948847, 5612.550995920398, 5674.183961439558, 5687.8862422752145, 5694.234787215976, 5078.390593128848, 5674.148877668383, 5782.467646073878, 5836.854078648068, 6001.7599296027665, 4208.9789551052045, 4639.100562148657, 5005.4744251853035, 5131.79472821083, 5133.5092137346965, 4854.83008094715, 5597.468240517144, 5848.444397782204, 5895.580563273205, 5916.349201587908, 4479.552044795625, 5208.713520756243, 5274.89450210986, 5439.809606663906, 5533.280673512418, 5106.004329155779, 5227.869303267449, 5575.526080283059, 5617.831465056055, 5692.402297758676, 5234.351179378484, 5257.763400646903, 5284.286621306228, 5374.516293533601, 5549.0, 4988.351514303263, 4996.00159936014, 5188.896222075613, 5273.839755253838, 5565.415631358811, 5475.6440831345835, 5477.425609963311, 5478.561715062706, 5512.310961129859, 5519.530839878656], "value": 4240.2621551937555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.5789886612928, 775.6509570693189, 793.2028311546898, 884.8539990901502, 894.7360528644049, 15835.287412066456, 17410.82589174108, 17457.999999999985, 17461.825381746177, 17531.737023944635, 16038.43865464709, 16138.193090345465, 16215.594610134753, 16278.511644650649, 16279.0, 979.8089372572351, 980.6616717232544, 1008.2977619978454, 1010.5705075342987, 1043.2332235806714, 1029.428667089765, 1033.0495943731746, 1033.4316126130636, 1033.633060263607, 1035.6634093919506, 1054.520193312045, 1055.709679838043, 1056.2236755984384, 1056.3239526702878, 1059.2003037706559, 1046.0062940206797, 1047.9790404191874, 1049.407084996982, 1049.9527521261523, 1050.123147172112, 780.5004796929969, 780.9101953275332, 781.3436713160916, 781.9687212511493, 784.3176436500281, 16229.0, 16690.83309166905, 17309.7403538947, 17403.042832644198, 17434.476965690923, 14590.416383344653, 14725.852741472556, 14911.328990195467, 15033.173175475344, 15150.848491515164, 10664.306820056749, 11883.940580297043, 11926.940365298206, 12211.389430528527, 12484.0, 3798.26424472863, 3798.525184351956, 3881.4565960765517, 3896.883093507199, 3908.0425295802424, 102167.97832021733, 110414.44792776064, 115586.0, 116596.0, 121998.0, 10943.507542160622, 11194.832077518844, 11301.49143288554, 11437.59968401102, 11623.816102006633, 23897.402564936016, 24294.39264018378, 24443.266701998968, 24509.754902451103, 24548.895299711556, 7828.21717828224, 8026.638801253957, 8116.8782468263025, 8319.292860106838, 8342.582870856433, 4579.22153233951, 4592.609628181642, 4613.6770426070525, 4653.23221668421, 4829.372181616367, 3511.9824400877833, 3565.750397472204, 3578.141246100969, 3582.8566857325413, 3590.3716849551224, 656.6454114777966, 668.2582333609689, 697.6651207420365, 699.2692636195188, 701.123595505618, 702.1714377035046, 711.7224282529818, 726.934575888162, 749.628933677833, 763.904511936008, 10384.896151038543, 10790.374240982706, 10877.184211184034, 10985.670429887115, 11180.434739136528, 745.8843879198624, 749.8425330680509, 761.2996043639864, 762.9885551716728, 771.9546389493395, 4830.203016502238, 4960.90078198434, 5206.76569554371, 5222.399424066205, 5281.181416880389, 87524.5623771877, 104493.47753261185, 105136.94863051425, 107755.46122269338, 109408.0, 53915.730421348424, 69892.0, 74246.5150696983, 78444.0, 91299.0, 78406.0, 79151.0, 79189.60405198052, 81155.5942220297, 83151.0, 11099.155109198227, 11222.607208747655, 11271.88806866621, 11368.31790092564, 11512.884871151182, 45561.77219113883, 47954.520454795005, 48398.5160148394, 48500.0, 50054.74972625114, 61774.69112654408, 63618.0, 66255.01234962959, 69583.60832783215, 69760.0, 12981.870181298444, 13068.0, 13360.131591446914, 13401.798973015217, 13539.323033848465, 15252.923735381251, 15599.405982884957, 15727.685446290781, 16154.0, 16289.59276018109, 12262.938685306517, 12689.175203611736, 12794.232346059267, 12892.548760793326, 13144.342782860627, 13427.395767190696, 14296.409041105746, 14546.345414456164, 14665.633359166106, 14682.0, 13256.93371533136, 13519.0, 14728.042677225945, 14909.0, 15109.32008059618, 10186.0, 10429.895701042893, 10668.359898406121, 10717.732056698645, 10886.346819190874, 9770.451455395289, 9975.31160354632, 10959.232853700483, 12197.817032744339, 12416.627501174979], "value": 7978.759811040023, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 123.0, 171.0, 154.0, 119.0, 117.0, 115.0, 117.0, 117.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 129.0, 150.0, 107.0, 108.0, 134.0, 129.0, 126.0, 110.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 188.0, 182.0, 185.0, 186.0, 184.0, 185.0, 189.0, 186.0, 188.0], "value": 186.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 62.0, 89.0, 60.0, 61.0, 58.0, 76.0, 96.0, 78.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 85.0, 69.0, 68.0, 67.0, 80.0, 67.0, 68.0, 82.0], "value": 74.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 99.0, 132.0, 90.0, 89.0, 88.0, 133.0, 89.0, 89.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0, 96.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 130.0, 128.0, 87.0, 87.0, 86.0, 86.0, 87.0, 87.0, 87.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 63.0, 62.0, 62.0, 64.0, 66.0, 65.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 64.0, 62.0, 61.0, 61.0, 59.0, 58.0, 57.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 83.0, 79.0, 84.0, 83.0, 83.0, 85.0, 82.0, 89.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 143.0, 132.0, 135.0, 127.0, 123.0, 136.0, 186.0, 148.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 161.0, 161.0, 162.0, 166.0, 163.0, 159.0, 176.0, 211.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 66.0, 74.0, 78.0, 65.0, 58.0, 74.0, 77.0], "value": 68.5, "unit": "score"}]}]} 15:19:02 INFO - Return code: 0 15:19:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:19:02 INFO - # TBPL SUCCESS # 15:19:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:19:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:19:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:19:02 INFO - 2017-05-05 15:19:02.892 screenresolution[2004:17288] starting screenresolution argv=screenresolution get 15:19:02 INFO - 2017-05-05 15:19:02.895 screenresolution[2004:17288] Display 0: 1600x1200x32@60 15:19:02 INFO - 2017-05-05 15:19:02.902 screenresolution[2005:17291] starting screenresolution argv=screenresolution list 15:19:02 INFO - Available Modes on Display 0 15:19:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:19:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:19:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:19:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:19:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:19:03 INFO - Intel Iris: 15:19:03 INFO - Chipset Model: Intel Iris 15:19:03 INFO - Type: GPU 15:19:03 INFO - Bus: Built-In 15:19:03 INFO - VRAM (Dynamic, Max): 1536 MB 15:19:03 INFO - Vendor: Intel (0x8086) 15:19:03 INFO - Device ID: 0x0a2e 15:19:03 INFO - Revision ID: 0x0009 15:19:03 INFO - Displays: 15:19:03 INFO - Display: 15:19:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:19:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:19:03 INFO - Display Serial Number: 1600x1200 60 15:19:03 INFO - Main Display: Yes 15:19:03 INFO - Mirror: Off 15:19:03 INFO - Online: Yes 15:19:03 INFO - Rotation: Supported 15:19:03 INFO - Return code: 0 15:19:03 INFO - Running post-action listener: _resource_record_post_action 15:19:03 INFO - [mozharness: 2017-05-05 22:19:03.144304Z] Finished run-tests step (success) 15:19:03 INFO - Running post-run listener: _resource_record_post_run 15:19:03 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 663552; Write bytes: 424015872; Read time: 12; Write time: 1477 15:19:03 INFO - TinderboxPrint: CPU usage
54.0% 15:19:03 INFO - TinderboxPrint: I/O read bytes / time
663,552 / 12 15:19:03 INFO - TinderboxPrint: I/O write bytes / time
424,015,872 / 1,477 15:19:03 INFO - TinderboxPrint: CPU idle
2,195.1 (46.0%) 15:19:03 INFO - TinderboxPrint: CPU system
958.5 (20.1%) 15:19:03 INFO - TinderboxPrint: CPU user
1,620.2 (33.9%) 15:19:03 INFO - TinderboxPrint: Swap in / out
123,088,896 / 0 15:19:03 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121397760; Write bytes: 118945792; Read time: 11095; Write time: 302 15:19:03 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 565248; Write bytes: 294924288; Read time: 11; Write time: 1101 15:19:03 INFO - Running post-run listener: _upload_blobber_files 15:19:03 INFO - Blob upload gear active. 15:19:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:19:03 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 15:19:03 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'] 15:19:03 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 15:19:04 INFO - (blobuploader) - INFO - Open directory for files ... 15:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:04 INFO - (blobuploader) - INFO - Done attempting. 15:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:05 INFO - (blobuploader) - INFO - Done attempting. 15:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:19:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:06 INFO - (blobuploader) - INFO - Done attempting. 15:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:19:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:08 INFO - (blobuploader) - INFO - Done attempting. 15:19:08 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:08 INFO - Return code: 0 15:19:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e5c590a55a99e205a38249f196185d02b33ee92082938627ba897ff35d179aca2ba84e8d62e5c5529e72ce02758efaafc62a792d973637f850c8c4c528aaf9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9387508d57f881b82038c1047e3e17b98b60c757181c42f1bdc209ff668a4953a5b881fa2bd8f3239f030158cf55f64de7e448e3b8f665af282bd2ae9b6d1ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf934c093b600808099dd41c6161e5fb23bea20cd44422728173946ccd6e010c2feda5a20a6d6d5a8f980bab2ed146f1bc033b01f59f76bcb017b430962b0dd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d80ea70e1136aab57de46d0a0383dc6207feb2a0fe78e9efba25152b5bbd8e570739e1952d6d39d2c8d47349bb2c207829926cd81542cc8cbf930fea916ddc5"} 15:19:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:08 INFO - Contents: 15:19:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e5c590a55a99e205a38249f196185d02b33ee92082938627ba897ff35d179aca2ba84e8d62e5c5529e72ce02758efaafc62a792d973637f850c8c4c528aaf9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9387508d57f881b82038c1047e3e17b98b60c757181c42f1bdc209ff668a4953a5b881fa2bd8f3239f030158cf55f64de7e448e3b8f665af282bd2ae9b6d1ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf934c093b600808099dd41c6161e5fb23bea20cd44422728173946ccd6e010c2feda5a20a6d6d5a8f980bab2ed146f1bc033b01f59f76bcb017b430962b0dd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d80ea70e1136aab57de46d0a0383dc6207feb2a0fe78e9efba25152b5bbd8e570739e1952d6d39d2c8d47349bb2c207829926cd81542cc8cbf930fea916ddc5"} 15:19:08 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:08 INFO - Copying logs to upload dir... 15:19:08 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.105134 ========= master_lag: 0.90 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-05 15:19:09.667319) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:09.671149) ========= 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.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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/2e5c590a55a99e205a38249f196185d02b33ee92082938627ba897ff35d179aca2ba84e8d62e5c5529e72ce02758efaafc62a792d973637f850c8c4c528aaf9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9387508d57f881b82038c1047e3e17b98b60c757181c42f1bdc209ff668a4953a5b881fa2bd8f3239f030158cf55f64de7e448e3b8f665af282bd2ae9b6d1ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf934c093b600808099dd41c6161e5fb23bea20cd44422728173946ccd6e010c2feda5a20a6d6d5a8f980bab2ed146f1bc033b01f59f76bcb017b430962b0dd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d80ea70e1136aab57de46d0a0383dc6207feb2a0fe78e9efba25152b5bbd8e570739e1952d6d39d2c8d47349bb2c207829926cd81542cc8cbf930fea916ddc5"} build_url:https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/S3OT4avYTwOZkNe5CbTmCg/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/2e5c590a55a99e205a38249f196185d02b33ee92082938627ba897ff35d179aca2ba84e8d62e5c5529e72ce02758efaafc62a792d973637f850c8c4c528aaf9d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9387508d57f881b82038c1047e3e17b98b60c757181c42f1bdc209ff668a4953a5b881fa2bd8f3239f030158cf55f64de7e448e3b8f665af282bd2ae9b6d1ff6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf934c093b600808099dd41c6161e5fb23bea20cd44422728173946ccd6e010c2feda5a20a6d6d5a8f980bab2ed146f1bc033b01f59f76bcb017b430962b0dd8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d80ea70e1136aab57de46d0a0383dc6207feb2a0fe78e9efba25152b5bbd8e570739e1952d6d39d2c8d47349bb2c207829926cd81542cc8cbf930fea916ddc5"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:09.707557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:09.707920) ========= 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.Fj9t24GI5F/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.ukg31hi1EO/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005248 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 15:19:09.756681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:19:09.756998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 15:19:09.757339) ========= ========= Total master_lag: 1.05 =========