builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1490711241.25 results: success (0) buildid: 20170328060222 builduid: 3ee0c23847a8421097052ea7d03229ee revision: f823d309838ffcb8412725301c3d1bbb32adb40e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.250244) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.250717) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.251027) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.277352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.277667) ========= 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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-28 07:27:21-- 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% 14.3M=0.001s 2017-03-28 07:27:21 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129184 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.430644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.430987) ========= 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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.039345 ========= master_lag: 0.39 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:21.861952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 07:27:21.862313) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f823d309838ffcb8412725301c3d1bbb32adb40e --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-aurora --rev f823d309838ffcb8412725301c3d1bbb32adb40e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-28 07:27:21,970 truncating revision to first 12 chars 2017-03-28 07:27:21,970 Setting DEBUG logging. 2017-03-28 07:27:21,970 attempt 1/10 2017-03-28 07:27:21,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f823d309838f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 07:27:22,925 unpacking tar archive at: mozilla-aurora-f823d309838f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.223594 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 07:27:23.115651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:23.115975) ========= script_repo_revision: f823d309838ffcb8412725301c3d1bbb32adb40e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:23.116355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:23.116639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 07:27:23.136460) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-28 07:27:23.136854) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:27:23 INFO - MultiFileLogger online at 20170328 07:27:23 in /builds/slave/test 07:27:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:27:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:23 INFO - {'append_to_log': False, 07:27:23 INFO - 'base_work_dir': '/builds/slave/test', 07:27:23 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:27:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:23 INFO - 'branch': 'Mozilla-Aurora', 07:27:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:23 INFO - 'config_files': ('talos/mac_config.py',), 07:27:23 INFO - 'default_actions': ('clobber', 07:27:23 INFO - 'read-buildbot-config', 07:27:23 INFO - 'download-and-extract', 07:27:23 INFO - 'populate-webroot', 07:27:23 INFO - 'create-virtualenv', 07:27:23 INFO - 'install', 07:27:23 INFO - 'run-tests'), 07:27:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:23 INFO - 'download_minidump_stackwalk': True, 07:27:23 INFO - 'download_symbols': 'ondemand', 07:27:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:23 INFO - 'gecko_profile': False, 07:27:23 INFO - 'gecko_profile_interval': 0, 07:27:23 INFO - 'installer_path': 'installer.exe', 07:27:23 INFO - 'log_level': 'info', 07:27:23 INFO - 'log_name': 'talos', 07:27:23 INFO - 'log_to_console': True, 07:27:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:27:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:27:23 INFO - 'opt_config_files': (), 07:27:23 INFO - 'pip_index': False, 07:27:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:23 INFO - 'cmd': ('bash', 07:27:23 INFO - '-c', 07:27:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:23 INFO - 'enabled': True, 07:27:23 INFO - 'halt_on_failure': False, 07:27:23 INFO - 'name': 'check_screen_resolution'},), 07:27:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:23 INFO - 'cmd': ('bash', 07:27:23 INFO - '-c', 07:27:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:23 INFO - 'enabled': True, 07:27:23 INFO - 'halt_on_failure': False, 07:27:23 INFO - 'name': 'check_screen_resolution'},), 07:27:23 INFO - 'run_cmd_checks_enabled': True, 07:27:23 INFO - 'suite': 'dromaeojs', 07:27:23 INFO - 'system_bits': '32', 07:27:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:23 INFO - 'title': 't-yosemite-r7-0103', 07:27:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:23 INFO - 'use_talos_json': True, 07:27:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:23 INFO - 'work_dir': 'build'} 07:27:23 INFO - [mozharness: 2017-03-28 14:27:23.355355Z] Running clobber step. 07:27:23 INFO - Running pre-action listener: _resource_record_pre_action 07:27:23 INFO - Running main action method: clobber 07:27:23 INFO - rmtree: /builds/slave/test/build 07:27:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:25 INFO - Running post-action listener: _resource_record_post_action 07:27:25 INFO - [mozharness: 2017-03-28 14:27:25.916725Z] Finished clobber step (success) 07:27:25 INFO - [mozharness: 2017-03-28 14:27:25.916890Z] Running read-buildbot-config step. 07:27:25 INFO - Running pre-action listener: _resource_record_pre_action 07:27:25 INFO - Running main action method: read_buildbot_config 07:27:25 INFO - Using buildbot properties: 07:27:25 INFO - { 07:27:25 INFO - "project": "", 07:27:25 INFO - "product": "firefox", 07:27:25 INFO - "script_repo_revision": "production", 07:27:25 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:27:25 INFO - "repository": "", 07:27:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:27:25 INFO - "buildid": "20170328060222", 07:27:25 INFO - "pgo_build": "False", 07:27:25 INFO - "basedir": "/builds/slave/test", 07:27:25 INFO - "buildnumber": 64, 07:27:25 INFO - "slavename": "t-yosemite-r7-0103", 07:27:25 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:27:25 INFO - "platform": "yosemite_r7", 07:27:25 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:27:25 INFO - "branch": "mozilla-aurora", 07:27:25 INFO - "repo_path": "releases/mozilla-aurora", 07:27:25 INFO - "revision": "f823d309838ffcb8412725301c3d1bbb32adb40e", 07:27:25 INFO - "stage_platform": "macosx64", 07:27:25 INFO - "builduid": "3ee0c23847a8421097052ea7d03229ee", 07:27:25 INFO - "slavebuilddir": "test" 07:27:25 INFO - } 07:27:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:27:25 INFO - Running post-action listener: _resource_record_post_action 07:27:25 INFO - [mozharness: 2017-03-28 14:27:25.920343Z] Finished read-buildbot-config step (success) 07:27:25 INFO - [mozharness: 2017-03-28 14:27:25.920487Z] Running download-and-extract step. 07:27:25 INFO - Running pre-action listener: _resource_record_pre_action 07:27:25 INFO - Running main action method: download_and_extract 07:27:25 INFO - mkdir: /builds/slave/test/build/tests 07:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:25 INFO - trying https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:27:25 INFO - Downloading https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 07:27:26 INFO - Downloaded 1199 bytes. 07:27:26 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:27:26 INFO - Using the following test package requirements: 07:27:26 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:27:26 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:27:26 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:27:26 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'jsshell-mac.zip'], 07:27:26 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:27:26 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:27:26 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:27:26 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:27:26 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:27:26 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:27:26 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:27:26 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:27:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:27:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:27:26 INFO - Fetch https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:27:28 INFO - Expected file size: 51791076 07:27:28 INFO - Obtained file size: 51791076 07:27:44 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:27:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:27:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:27:44 INFO - Fetch https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:27:46 INFO - Expected file size: 51791076 07:27:46 INFO - Obtained file size: 51791076 07:28:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:28:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:28:02 INFO - Fetch https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:28:03 INFO - Expected file size: 14404438 07:28:03 INFO - Obtained file size: 14404438 07:28: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')]} 07:28:03 INFO - trying https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:28:03 INFO - Downloading https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 07:28:06 INFO - Downloaded 74675176 bytes. 07:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:28:06 INFO - mkdir: /builds/slave/test/properties 07:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:06 INFO - Contents: 07:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:28:06 INFO - Running post-action listener: _resource_record_post_action 07:28:06 INFO - Running post-action listener: set_extra_try_arguments 07:28:06 INFO - [mozharness: 2017-03-28 14:28:06.659838Z] Finished download-and-extract step (success) 07:28:06 INFO - [mozharness: 2017-03-28 14:28:06.659967Z] Running populate-webroot step. 07:28:06 INFO - Running pre-action listener: _resource_record_pre_action 07:28:06 INFO - Running main action method: populate_webroot 07:28:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:06 INFO - '--tppagecycles', 07:28:06 INFO - '7'], 07:28:06 INFO - 'tests': ['tsvgm']}}, 07:28:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['damp', 'tps']}, 07:28:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'tests': ['damp', 'tps']}, 07:28:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['dromaeo_dom']}, 07:28:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['basic_compositor_video']}, 07:28:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:28:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['a11yr', 07:28:06 INFO - 'ts_paint', 07:28:06 INFO - 'tpaint', 07:28:06 INFO - 'sessionrestore', 07:28:06 INFO - 'sessionrestore_no_auto_restore', 07:28:06 INFO - 'tabpaint']}, 07:28:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['tsvgx', 07:28:06 INFO - 'tsvgr_opacity', 07:28:06 INFO - 'tart', 07:28:06 INFO - 'tscrollx', 07:28:06 INFO - 'cart', 07:28:06 INFO - 'tsvg_static']}, 07:28:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:06 INFO - 'tsvgr_opacity', 07:28:06 INFO - 'tart', 07:28:06 INFO - 'tscrollx', 07:28:06 INFO - 'cart', 07:28:06 INFO - 'tsvg_static']}, 07:28:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'talos_options': ['--disable-e10s'], 07:28:06 INFO - 'tests': ['tp5o']}, 07:28:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:28:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'talos_options': ['--disable-e10s', 07:28:06 INFO - '--xperf_path', 07:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:06 INFO - 'tests': ['tp5n']}, 07:28:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:28:06 INFO - 'talos_options': ['--xperf_path', 07:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:06 INFO - 'tests': ['tp5n']}}, 07:28:06 INFO - 'talos.zip': {'path': '', 07:28:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:06 INFO - Running post-action listener: _resource_record_post_action 07:28:06 INFO - [mozharness: 2017-03-28 14:28:06.678485Z] Finished populate-webroot step (success) 07:28:06 INFO - [mozharness: 2017-03-28 14:28:06.678620Z] Running create-virtualenv step. 07:28:06 INFO - Running pre-action listener: _resource_record_pre_action 07:28:06 INFO - Running main action method: create_virtualenv 07:28:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:28:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:06 INFO - Using real prefix '/tools/python27' 07:28:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:10 INFO - Installing pip.................done. 07:28:10 INFO - Return code: 0 07:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:28:10 INFO - Reading from file tmpfile_stdout 07:28:10 INFO - Output received: 07:28:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:28:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:10 INFO - 'HOME': '/Users/cltbld', 07:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:10 INFO - 'LOGNAME': 'cltbld', 07:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:10 INFO - 'MOZ_NO_REMOTE': '1', 07:28:10 INFO - 'NO_EM_RESTART': '1', 07:28:10 INFO - 'PAGER': '/bin/cat', 07:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:10 INFO - 'PWD': '/builds/slave/test', 07:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:10 INFO - 'SHELL': '/bin/bash', 07:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:10 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:10 INFO - 'USER': 'cltbld', 07:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:10 INFO - 'XPC_FLAGS': '0x0', 07:28:10 INFO - 'XPC_SERVICE_NAME': '0', 07:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:28:10 INFO - Cleaning up... 07:28:10 INFO - Return code: 0 07:28:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:10 INFO - 'HOME': '/Users/cltbld', 07:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:10 INFO - 'LOGNAME': 'cltbld', 07:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:10 INFO - 'MOZ_NO_REMOTE': '1', 07:28:10 INFO - 'NO_EM_RESTART': '1', 07:28:10 INFO - 'PAGER': '/bin/cat', 07:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:10 INFO - 'PWD': '/builds/slave/test', 07:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:10 INFO - 'SHELL': '/bin/bash', 07:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:10 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:10 INFO - 'USER': 'cltbld', 07:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:10 INFO - 'XPC_FLAGS': '0x0', 07:28:10 INFO - 'XPC_SERVICE_NAME': '0', 07:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:11 INFO - Downloading/unpacking psutil>=3.1.1 07:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:14 INFO - Installing collected packages: psutil 07:28:14 INFO - Running setup.py install for psutil 07:28:14 INFO - building 'psutil._psutil_osx' extension 07:28:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:28:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:28:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:28:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:28:15 INFO - building 'psutil._psutil_posix' extension 07:28:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:28:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:28:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:28:15 INFO - ^ 07:28:15 INFO - 1 warning generated. 07:28:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:28:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:15 INFO - Successfully installed psutil 07:28:15 INFO - Cleaning up... 07:28:16 INFO - Return code: 0 07:28:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:28:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:16 INFO - 'HOME': '/Users/cltbld', 07:28:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:16 INFO - 'LOGNAME': 'cltbld', 07:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:16 INFO - 'MOZ_NO_REMOTE': '1', 07:28:16 INFO - 'NO_EM_RESTART': '1', 07:28:16 INFO - 'PAGER': '/bin/cat', 07:28:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:16 INFO - 'PWD': '/builds/slave/test', 07:28:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:16 INFO - 'SHELL': '/bin/bash', 07:28:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:16 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:16 INFO - 'USER': 'cltbld', 07:28:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:16 INFO - 'XPC_FLAGS': '0x0', 07:28:16 INFO - 'XPC_SERVICE_NAME': '0', 07:28:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:18 INFO - Installing collected packages: mozsystemmonitor 07:28:18 INFO - Running setup.py install for mozsystemmonitor 07:28:19 INFO - Successfully installed mozsystemmonitor 07:28:19 INFO - Cleaning up... 07:28:19 INFO - Return code: 0 07:28:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:28:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:19 INFO - 'HOME': '/Users/cltbld', 07:28:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:19 INFO - 'LOGNAME': 'cltbld', 07:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:19 INFO - 'MOZ_NO_REMOTE': '1', 07:28:19 INFO - 'NO_EM_RESTART': '1', 07:28:19 INFO - 'PAGER': '/bin/cat', 07:28:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:19 INFO - 'PWD': '/builds/slave/test', 07:28:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:19 INFO - 'SHELL': '/bin/bash', 07:28:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:19 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:19 INFO - 'USER': 'cltbld', 07:28:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:19 INFO - 'XPC_FLAGS': '0x0', 07:28:19 INFO - 'XPC_SERVICE_NAME': '0', 07:28:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:20 INFO - Downloading/unpacking jsonschema==2.5.1 07:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:23 INFO - warning: no files found matching '*.txt' 07:28:23 INFO - no previously-included directories found matching 'build' 07:28:23 INFO - no previously-included directories found matching 'dist' 07:28:23 INFO - no previously-included directories found matching '.git*' 07:28:23 INFO - Installing collected packages: jsonschema, functools32 07:28:23 INFO - Running setup.py install for functools32 07:28:23 INFO - warning: no files found matching '*.txt' 07:28:23 INFO - no previously-included directories found matching 'build' 07:28:23 INFO - no previously-included directories found matching 'dist' 07:28:23 INFO - no previously-included directories found matching '.git*' 07:28:23 INFO - Successfully installed jsonschema functools32 07:28:23 INFO - Cleaning up... 07:28:23 INFO - Return code: 0 07:28:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:28:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:23 INFO - 'HOME': '/Users/cltbld', 07:28:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:23 INFO - 'LOGNAME': 'cltbld', 07:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:23 INFO - 'MOZ_NO_REMOTE': '1', 07:28:23 INFO - 'NO_EM_RESTART': '1', 07:28:23 INFO - 'PAGER': '/bin/cat', 07:28:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:23 INFO - 'PWD': '/builds/slave/test', 07:28:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:23 INFO - 'SHELL': '/bin/bash', 07:28:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:23 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:23 INFO - 'USER': 'cltbld', 07:28:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:23 INFO - 'XPC_FLAGS': '0x0', 07:28:23 INFO - 'XPC_SERVICE_NAME': '0', 07:28:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:28:24 INFO - Cleaning up... 07:28:24 INFO - Return code: 0 07:28:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:24 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:24 INFO - 'HOME': '/Users/cltbld', 07:28:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:24 INFO - 'LOGNAME': 'cltbld', 07:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:24 INFO - 'MOZ_NO_REMOTE': '1', 07:28:24 INFO - 'NO_EM_RESTART': '1', 07:28:24 INFO - 'PAGER': '/bin/cat', 07:28:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:24 INFO - 'PWD': '/builds/slave/test', 07:28:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:24 INFO - 'SHELL': '/bin/bash', 07:28:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:24 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:24 INFO - 'USER': 'cltbld', 07:28:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:24 INFO - 'XPC_FLAGS': '0x0', 07:28:24 INFO - 'XPC_SERVICE_NAME': '0', 07:28:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:24 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:26 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:28 INFO - Downloading docopt-0.6.1.tar.gz 07:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:28 INFO - Running setup.py install for blobuploader 07:28:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:28 INFO - Running setup.py install for requests 07:28:28 INFO - Running setup.py install for docopt 07:28:29 INFO - Successfully installed blobuploader requests docopt 07:28:29 INFO - Cleaning up... 07:28:29 INFO - Return code: 0 07:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:29 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:29 INFO - 'HOME': '/Users/cltbld', 07:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:29 INFO - 'LOGNAME': 'cltbld', 07:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:29 INFO - 'MOZ_NO_REMOTE': '1', 07:28:29 INFO - 'NO_EM_RESTART': '1', 07:28:29 INFO - 'PAGER': '/bin/cat', 07:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:29 INFO - 'PWD': '/builds/slave/test', 07:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:29 INFO - 'SHELL': '/bin/bash', 07:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:29 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:29 INFO - 'USER': 'cltbld', 07:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:29 INFO - 'XPC_FLAGS': '0x0', 07:28:29 INFO - 'XPC_SERVICE_NAME': '0', 07:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Ge_dag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-3j7lhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Dt1ZDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-qFveVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-KBuaHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:29 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-vXunW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-yaTPAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-9oRtdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-N7jZrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-mlEZTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-hrDSfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Sjhp_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-6BjgrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jjEf3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:30 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-wpBP1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:31 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-awvw5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:31 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LUBiWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:31 INFO - Running setup.py install for manifestparser 07:28:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:31 INFO - Running setup.py install for mozcrash 07:28:31 INFO - Running setup.py install for mozdebug 07:28:31 INFO - Running setup.py install for mozdevice 07:28:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:31 INFO - Running setup.py install for mozfile 07:28:32 INFO - Running setup.py install for mozhttpd 07:28:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Running setup.py install for mozinfo 07:28:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Running setup.py install for mozInstall 07:28:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Running setup.py install for mozleak 07:28:32 INFO - Running setup.py install for mozlog 07:28:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Running setup.py install for moznetwork 07:28:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:32 INFO - Running setup.py install for mozprocess 07:28:33 INFO - Running setup.py install for mozprofile 07:28:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozrunner 07:28:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Running setup.py install for mozscreenshot 07:28:33 INFO - Running setup.py install for moztest 07:28:33 INFO - Running setup.py install for mozversion 07:28:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:33 INFO - Cleaning up... 07:28:33 INFO - Return code: 0 07:28:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:33 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:33 INFO - 'HOME': '/Users/cltbld', 07:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:33 INFO - 'LOGNAME': 'cltbld', 07:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:33 INFO - 'MOZ_NO_REMOTE': '1', 07:28:33 INFO - 'NO_EM_RESTART': '1', 07:28:33 INFO - 'PAGER': '/bin/cat', 07:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:33 INFO - 'PWD': '/builds/slave/test', 07:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:33 INFO - 'SHELL': '/bin/bash', 07:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:33 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:33 INFO - 'USER': 'cltbld', 07:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:33 INFO - 'XPC_FLAGS': '0x0', 07:28:33 INFO - 'XPC_SERVICE_NAME': '0', 07:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-FusljR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-J3HUFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gk4lX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eJ3nm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-F4Hm7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8ZrCHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-n5s3pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:28:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:34 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-SjEGbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-10OgHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-fe_8rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-utofwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ORxDG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Li1M8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Cqn7ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HhU1NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-5ZJz5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:28:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:35 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-UQ_EK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:38 INFO - Downloading blessings-1.6.tar.gz 07:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:38 INFO - Installing collected packages: blessings 07:28:38 INFO - Running setup.py install for blessings 07:28:38 INFO - Successfully installed blessings 07:28:38 INFO - Cleaning up... 07:28:39 INFO - Return code: 0 07:28:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:39 INFO - Reading from file tmpfile_stdout 07:28:39 INFO - Current package versions: 07:28:39 INFO - blessings == 1.6 07:28:39 INFO - blobuploader == 1.2.4 07:28:39 INFO - docopt == 0.6.1 07:28:39 INFO - functools32 == 3.2.3-2 07:28:39 INFO - jsonschema == 2.5.1 07:28:39 INFO - manifestparser == 1.1 07:28:39 INFO - mozInstall == 1.12 07:28:39 INFO - mozcrash == 1.0 07:28:39 INFO - mozdebug == 0.1 07:28:39 INFO - mozdevice == 0.49 07:28:39 INFO - mozfile == 1.2 07:28:39 INFO - mozhttpd == 0.7 07:28:39 INFO - mozinfo == 0.9 07:28:39 INFO - mozleak == 0.1 07:28:39 INFO - mozlog == 3.4 07:28:39 INFO - moznetwork == 0.27 07:28:39 INFO - mozprocess == 0.25 07:28:39 INFO - mozprofile == 0.28 07:28:39 INFO - mozrunner == 6.13 07:28:39 INFO - mozscreenshot == 0.1 07:28:39 INFO - mozsystemmonitor == 0.3 07:28:39 INFO - moztest == 0.8 07:28:39 INFO - mozversion == 1.4 07:28:39 INFO - psutil == 3.1.1 07:28:39 INFO - requests == 1.2.3 07:28:39 INFO - wsgiref == 0.1.2 07:28:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:39 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:39 INFO - 'HOME': '/Users/cltbld', 07:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:39 INFO - 'LOGNAME': 'cltbld', 07:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:39 INFO - 'MOZ_NO_REMOTE': '1', 07:28:39 INFO - 'NO_EM_RESTART': '1', 07:28:39 INFO - 'PAGER': '/bin/cat', 07:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:39 INFO - 'PWD': '/builds/slave/test', 07:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:39 INFO - 'SHELL': '/bin/bash', 07:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:39 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:39 INFO - 'USER': 'cltbld', 07:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:39 INFO - 'XPC_FLAGS': '0x0', 07:28:39 INFO - 'XPC_SERVICE_NAME': '0', 07:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:39 INFO - Cleaning up... 07:28:39 INFO - Return code: 0 07:28:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:39 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 0x11014ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11014d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39b554540>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, '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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:28:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:39 INFO - 'HOME': '/Users/cltbld', 07:28:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:39 INFO - 'LOGNAME': 'cltbld', 07:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:39 INFO - 'MOZ_NO_REMOTE': '1', 07:28:39 INFO - 'NO_EM_RESTART': '1', 07:28:39 INFO - 'PAGER': '/bin/cat', 07:28:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:39 INFO - 'PWD': '/builds/slave/test', 07:28:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:39 INFO - 'SHELL': '/bin/bash', 07:28:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:28:39 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:28:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:39 INFO - 'USER': 'cltbld', 07:28:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:39 INFO - 'XPC_FLAGS': '0x0', 07:28:39 INFO - 'XPC_SERVICE_NAME': '0', 07:28:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:28:39 INFO - Cleaning up... 07:28:39 INFO - Return code: 0 07:28:39 INFO - Running post-action listener: _resource_record_post_action 07:28:39 INFO - Running post-action listener: _start_resource_monitoring 07:28:39 INFO - Starting resource monitoring. 07:28:39 INFO - [mozharness: 2017-03-28 14:28:39.883131Z] Finished create-virtualenv step (success) 07:28:39 INFO - [mozharness: 2017-03-28 14:28:39.884108Z] Running install step. 07:28:39 INFO - Running pre-action listener: _resource_record_pre_action 07:28:39 INFO - Running main action method: install 07:28:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:40 INFO - Reading from file tmpfile_stdout 07:28:40 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:40 INFO - Reading from file tmpfile_stdout 07:28:40 INFO - Output received: 07:28:40 INFO - Usage: mozinstall [options] installer 07:28:40 INFO - Options: 07:28:40 INFO - -h, --help show this help message and exit 07:28:40 INFO - -d DEST, --destination=DEST 07:28:40 INFO - Directory to install application into. [default: 07:28:40 INFO - "/builds/slave/test"] 07:28:40 INFO - --app=APP Application being installed. [default: firefox] 07:28:40 INFO - mkdir: /builds/slave/test/build/application 07:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:29:00 INFO - Reading from file tmpfile_stdout 07:29:00 INFO - Output received: 07:29:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:29:00 INFO - Running post-action listener: _resource_record_post_action 07:29:00 INFO - [mozharness: 2017-03-28 14:29:00.023241Z] Finished install step (success) 07:29:00 INFO - [mozharness: 2017-03-28 14:29:00.023404Z] Running run-tests step. 07:29:00 INFO - Running pre-action listener: _resource_record_pre_action 07:29:00 INFO - Running main action method: run_tests 07:29:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:29:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:29:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:29:00 INFO - 2017-03-28 07:29:00.038 screenresolution[1622:7508] starting screenresolution argv=screenresolution get 07:29:00 INFO - 2017-03-28 07:29:00.041 screenresolution[1622:7508] Display 0: 1600x1200x32@60 07:29:00 INFO - 2017-03-28 07:29:00.046 screenresolution[1623:7510] starting screenresolution argv=screenresolution list 07:29:00 INFO - Available Modes on Display 0 07:29:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:29:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:29:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:29:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:29:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:29:00 INFO - Intel Iris: 07:29:00 INFO - Chipset Model: Intel Iris 07:29:00 INFO - Type: GPU 07:29:00 INFO - Bus: Built-In 07:29:00 INFO - VRAM (Dynamic, Max): 1536 MB 07:29:00 INFO - Vendor: Intel (0x8086) 07:29:00 INFO - Device ID: 0x0a2e 07:29:00 INFO - Revision ID: 0x0009 07:29:00 INFO - Displays: 07:29:00 INFO - Display: 07:29:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:29:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:29:00 INFO - Display Serial Number: 1600x1200 60 07:29:00 INFO - Main Display: Yes 07:29:00 INFO - Mirror: Off 07:29:00 INFO - Online: Yes 07:29:00 INFO - Rotation: Supported 07:29:00 INFO - Return code: 0 07:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:00 INFO - Python 2.7.3 07:29:00 INFO - Return code: 0 07:29:00 INFO - grabbing minidump binary from tooltool 07:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff28d30>, '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 0x10fe4fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff1dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:29:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:29:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:29:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:00 INFO - Return code: 0 07:29:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:29:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:00 INFO - ENV: RUST_BACKTRACE is now 1 07:29:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:29:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5JO0PdlFe7/Render', 07:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:29:00 INFO - 'HOME': '/Users/cltbld', 07:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:29:00 INFO - 'LOGNAME': 'cltbld', 07:29:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:00 INFO - 'MOZ_NO_REMOTE': '1', 07:29:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:00 INFO - 'NO_EM_RESTART': '1', 07:29:00 INFO - 'PAGER': '/bin/cat', 07:29:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:00 INFO - 'PWD': '/builds/slave/test', 07:29:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:29:00 INFO - 'RUST_BACKTRACE': '1', 07:29:00 INFO - 'SHELL': '/bin/bash', 07:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRTOxjEmpr/Listeners', 07:29:00 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 07:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:29:00 INFO - 'USER': 'cltbld', 07:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:00 INFO - 'XPC_FLAGS': '0x0', 07:29:00 INFO - 'XPC_SERVICE_NAME': '0', 07:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:29:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:29:00 INFO - mozversion application_buildid: 20170328060222 07:29:00 INFO - mozversion application_changeset: f823d309838ffcb8412725301c3d1bbb32adb40e 07:29:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:29:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:00 INFO - mozversion application_name: Firefox 07:29:00 INFO - mozversion application_remotingname: firefox-dev 07:29:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:29:00 INFO - mozversion application_vendor: Mozilla 07:29:00 INFO - mozversion application_version: 54.0a2 07:29:00 INFO - mozversion platform_buildid: 20170328060222 07:29:00 INFO - mozversion platform_changeset: f823d309838ffcb8412725301c3d1bbb32adb40e 07:29:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:29:00 INFO - mozversion platform_version: 54.0a2 07:29:00 INFO - using testdate: 1490711340 07:29:00 INFO - actual date: 1490711340 07:29:00 INFO - starting webserver on 'localhost:49248' 07:29:00 INFO - SUITE-START | Running 2 tests 07:29:00 INFO - TEST-START | dromaeo_css 07:29:00 INFO - operating with platform_type : mac_ 07:29:00 INFO - Initialising browser for dromaeo_css test... 07:29:00 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpT2We9C/profile http://localhost:49248/getInfo.html) 07:29:03 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 07:29:03 INFO - PROCESS | 1633 | colorDepth:24 07:29:03 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 07:29:03 INFO - PROCESS | 1633 | __metrics 07:29:03 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:29:03 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:04 INFO - TEST-INFO | 1633: exit 0 07:29:04 INFO - Browser initialized. 07:29:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpT2We9C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:16 INFO - PROCESS | 1635 | RSS: Main: 214695936 07:29:16 INFO - PROCESS | 1635 | 07:32:20 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 07:32:22 INFO - PROCESS | 1635 | RSS: Main: 369942528 07:32:22 INFO - PROCESS | 1635 | 07:34:05 INFO - PROCESS | 1635 | ************************* 07:34:05 INFO - PROCESS | 1635 | A coding exception was thrown and uncaught in a Task. 07:34:05 INFO - PROCESS | 1635 | 07:34:05 ERROR - PROCESS | 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:34:05 INFO - PROCESS | 1635 | Full stack: 07:34:05 INFO - PROCESS | 1635 | ************************* 07:35:25 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 07:35:26 INFO - PROCESS | 1635 | RSS: Main: 353759232 07:35:26 INFO - PROCESS | 1635 | 07:38:28 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 07:38:29 INFO - PROCESS | 1635 | RSS: Main: 330018816 07:38:29 INFO - PROCESS | 1635 | 07:41:31 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 07:41:32 INFO - PROCESS | 1635 | RSS: Main: 313122816 07:41:32 INFO - PROCESS | 1635 | 07:44:36 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 07:44:36 INFO - PROCESS | 1635 | RSS: Main: 322330624 07:44:36 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 07:47:40 INFO - PROCESS | 1635 | RSS: Main: 381145088 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | __start_tp_report 07:47:40 INFO - PROCESS | 1635 | _x_x_mozilla_page_load 07:47:40 INFO - PROCESS | 1635 | _x_x_mozilla_page_load_details 07:47:40 INFO - PROCESS | 1635 | |i|pagename|runs| 07:47:40 INFO - PROCESS | 1635 | |0;dojo.html;2806.7193280671927;3110.7355874750647;3375.2574433624623;3391.4912763085536;3432.9141771455725;4949.5297946695055;5950.55370847186;5993.340732519419;6019.367966363535;6045.093236014594;5934.1692163097205;6049.909251361233;6054.424829641188;6067.120267561201;6083.969580152093;4359.433273674418;5371.973140134294;5373.274607927929;5419.810306639269;5488.318747350841;5296.8146114885985;5298.788048478056;5505.311836020497;5506;5518.227448157261;5323.068463018975;5377.596680248997;5404.351477822667;5405.054115529786;5406.83779486616;5373.489518495737;5380.811671591495;5397.730113494349;5399.83800485986;5413.242146099529;5220.8694782630355;5344.518993290622;5345.946540534584;5363.517283444469;5401.70290634015;5979.402059794029;5991.430814072656;5999.310079340888;6006.909896351558;6007.699615019275;6295.527835412317;6332.1135041094285;6335;6341.968290158566;6368.076628888785;6312.084747711556;6330.461910737593;6332.715027823759;6332.841678958017;6361.045843123522;6086.543509236825;6153.077038444225;6162.1681073055015;6170.691465426756;6180.505559555225;6563.573367731177;6565.441937435276;6565.93434065658;6569.146011018584;6576.80269591913;6194.907076393858;6245.0632405139595;6257.812265632038;6309.179806625109;6342.39747224013;6431.5819471734185;6436.292007879129;6441.838954026093;6445.548811583238;6454.935450645527;6353.491720662336;6356.173697419398;6360.491160707133;6362.777302794472;6379.776707815204;6224.315325314212;6279.403456671609;6285.214348206474;6327.177466929362;6380.872382552323;5062.316587260672;5211.791528338824;5211.7915283389;5228.790848366023;5229.790808367698;4605.263157894721;4607.894105414676;4610.492845786961;4613.423322084739;4667.369905062773;5677.829665110054;5766.221560089418;5994.010988186988;6014.398560143951;6015.428534289235;6290.182276304051;6306.148669929501;6334.619922804646;6362.681865906686;6410.519211059189;5985.820425387245;6031.698415079316;6039.939600604026;6048.0625503047095;6054.878902422015;5663.830085097454;5669.40471250521;5684.971575142181;5696;5701.714914254354;6277.686115694106;6394.712237949397;6541.738330466728;6592.868142637025;6671.899921501182;6377.23473183221;6399.392057754506;6405.03924411342;6413.038044293393;6416.550841441054;6478.3197764235965;6612.933870661232;6618.1065556151225;6640.900386494303;6641.103451034049;6236.875262494816;6274.811755647338;6302.842428939313;6332.841678958063;6355.300916899045;6269.467095296951;6338.651374174465;6367.299597044229;6390.7443702251385;6413.2945376007665;6307.400796924285;6308.810735677937;6314.936850631435;6323.177986861862;6334.651594162181;6130.673316708229;6217;6242.250929888442;6242.687865606611;6340.746370145327;6127.417895299939;6145.463634091477;6149.41580549847;6155.322914479314;6169.537284703755;6271.3415091414745;6289.748410063729;6297.275813281532;6298.370162983848;6303.810885673437;6042.1540984261355;6086.969565152146;6097.176881120992;6174.351693072343;6181.103739957591 07:47:40 INFO - PROCESS | 1635 | |1;ext.html;760.2853317881192;799.9720009799656;816.8121332093616;879.4635272483788;888.8711136885148;27742.16773496796;27914.883404663815;28592.999999999975;39647.20705585887;40248;40108.39837402434;40232.79883600585;40313.19373612526;40320.79839600805;40348.798256008755;8954;9097.044810294923;9123.543822808866;9127.995920448746;9131.589078491485;7266.890996635055;7417.777466676009;8969.730908072768;10836.67489975302;11087.72280692981;11027.779444411108;11032;11082.778344433107;11097.722556936102;11137.665870023871;11024.724381890477;11037.724056898642;11051.668449946434;11053.723656908642;11062.05972492339;7092.078029856086;7269.927300726978;10631.893681063168;10752.892471075267;10889.945550272278;38328.42507362392;38514.422283665765;38544.42183367252;38567.80716096402;38602.42096368557;3752.6247375262255;3767.867664169624;3787.394016957301;3790.77255364679;3825.4261860720835;26393.3401664958;26783.464330713276;28160.71839281622;28709.138725838257;28770;2992.6558445778796;3056.602641656593;3168.825714585697;3209.8555564999633;3290.2925870937624;350638;351059.2447037774;352614;353407;353516.23241883627;51712;51776.22335664968;51865;51872.48127518752;51951.740241298554;54177.72911135498;54180.72909635427;54249.45750542523;54295.72852135793;54407.455925441034;14894.404223830925;15022.948393612562;15046.54860354191;15059.322330495153;15074.944753867343;12930.870691293156;12943.870561294454;12952.417141228667;12959.805602915963;12966.80549791754;10583.682489525327;10798.892011079946;10961;10996.725081873017;11005.614803482;4810.394289798588;4910.877228069256;5718.628289161191;5814.273215848019;5818.272715910512;934.6401635370296;938.8732521109699;945.6784693204206;958.9808203835884;982.1357205658975;27681;28568;28679;29049.7095029047;29169.854150729112;1027.3784360461962;1032.8450732390202;1039.6101461951769;1040.7710303733168;1073.6510634043811;14247.572572822832;14632.561023169323;14662.120272783666;15052.32264548098;15070.171140587372;468171;469062.6546867312;469235;469783;470261;54587.90824183494;54597;54619.72690136524;54643.72678136663;54668.45331546713;1436.8850491960827;1454.6508837878832;1482.7775833625042;1492.037635724973;1495.940162393492;26442.206733798015;27616.723832762218;28237;28274.575881361383;28394.432111357244;44299.778501107285;44321.77839110784;44330.335044975;44371.450283976556;44601;410934;412072;412257.9387103045;413029;413137;28901.7109828899;30178.69821301759;30259.394812104074;33248.1687957803;33342.499862501594;36484.27031459409;36791.8160409207;37873.81063094667;38049.80975095107;38305.61694383132;27339;27423.314417139733;27782.305442364104;27931.58102628503;28254.59835913888;24997.37506562278;25936.610950835377;26030.73969260283;26359.20922372332;26655.866720667047;31194.688053120088;31903;31926;32097;32206.516902246018;27359.316017099733;27545.724542754317;27562;28061.579076313465;28463.28841778972;18541.721874172166;19896.70154947706;22214.444638884157;22305.10779568864;22685.773142268365 07:47:40 INFO - PROCESS | 1635 | |2;jquery.html;363.2118303281879;386.16202839837587;393.3117045170949;428.9056407590331;453.2702349217759;12502.124851260416;14479.710405791891;17200.397986070504;21193.258235961745;21298;21779.23772667953;21914.671279930815;22665.206717764882;23089.191878284262;23506.294811155694;6509.707063182156;6647.700853461606;6686.297938716438;6709.5303328767;6717.261101278856;3997.3004724173297;6437.0988061671405;6692.9665351673175;6718.093057437257;6719.832004199885;4352.042550638855;4440.755758433284;7677.692892284302;7763.611819409035;7791.532508049535;7635.312821846005;7675.04061992251;7729.381649468057;7757.224277572226;7790.415718821055;6680.799576012728;6782.457403407765;7180.030695856045;7275.1633562140505;7503.324700776956;27130.457390852072;27333.86333068342;27406.45187096267;27692.892284308604;27726.890924363204;2894.6815850256453;2909.11272062021;2909.3599408130176;2924.1519959212014;2955.896543620963;16291.59271018234;16527.091009994445;16533;16957.830421695748;17214.82785172145;1766.8692037096268;1934.5067007913033;1936.0900376822872;1969.8719583227187;1978.4163671716879;126154;127576;129322;132603;135715;18161.818381816276;19487.8051219486;19675.90162049209;19975.101120449322;20007.899960500104;30624.387512249632;30740;31034.844825775726;31177.688223117933;31217.063488095395;10051.648192313234;10268.640597579199;10345.741356465998;10413.53139108742;10556.736081598021;7808.414368922354;8337.541435221121;8736.737897862948;8739.825203495895;8938.955305223562;9181.862272065924;9225.215856652125;9390.389624674373;9393.20157786582;9420.340576159602;3797.9620203798163;3864.9806750966063;3865.091703449687;3877.2051729395407;3887.183691424776;891.1864356035437;892.9598168082451;893.2005854760083;899.5592159841761;903.3631289940577;21523.569528609652;21751.12995480195;21806.672899906513;21919.780802191774;22522.32433027012;906.727981605529;913.3423934766957;928.8560273157672;935.373299889076;939.9718008459757;10996.890031099747;11305.26515776472;11425.143114266297;11523.50194474713;11569.652910412533;742294;743288;744901;757303;761661;147376;147712;147828;148934.7659785104;157887;1014.3052009373603;1222.8715984821465;1272.5418849214275;1276.349061978379;1286.1511402474323;19577.412677619694;20000.099995499946;20320.79679203189;20358.694619580423;20405.795942040982;64492;64658;65304.34695652983;65522;65970;93844;94081.05918940723;95069.57395638933;95443;96384.51807740917;11241.381724005258;11438;11526.250793698382;11748.88251117478;11907.880921191023;12522.436490358137;12623.179493333271;12863.6784080395;12916.870831291566;12958.481660733465;10908.236423450282;11061.834072488758;11285.661430157108;11426.314421134759;11462.4268786562;9730.80538389214;9811.607535698493;9815.901840981498;9892.802143956937;9941.403515789076;11155.665330040112;11332.716682083013;11468.885311146782;11493.597724079616;11625.76748465009;11412.258203216765;11446.713832154262;11731.296122232694;11741.06071514294;11769.058475321783;10850.29473084247;10939.617113401311;11001.61494347694;11015.008649221609;11238.100951923663 07:47:40 INFO - PROCESS | 1635 | |3;mootools.html;1350.885174760146;1548.829628740839;1555.7510798272272;1587.8253392126865;1595.5771720494067;10567.10179634731;11202.607908723186;11208.607698730546;11215.607453739121;11222.214444988855;10683.893161068387;10917;11019.724506887333;11167.329960202394;11204.103671706263;2396.760323967598;2433.1727212747664;2436.719777225624;2439.9878000609974;2440.7681270279295;2323.6514522821544;2411.5538625354366;2421.8183636227263;2424.660547523348;2426.575349313863;2332.1137967572386;2396.9640455393182;2409.9277021689377;2414.1550457339877;2414.239514552919;2319.2810228829117;2383.8450500717486;2386.8925898334614;2395.688560487143;2395.73646898841;2344.859308441499;2365.337705442462;2368.242162507981;2372.8813559321966;2374.0622454130694;10782.083522900562;11057.170712196537;11074.778504429867;11084.889151108466;11115.221934464591;5727.312722473288;5872.794452194195;5898.970505147447;5901.468867801918;5902.557308201859;3448.7241020718534;3507.6316986716283;3574.285142971416;3592.5329707138167;3633.0009247456896;1154.4747140051256;1160.3444054109486;1187.8158885372782;1198.2750435986277;1210.1468464732343;13602.387892544859;13923.094998825043;14162.362693678706;15211.695766084616;15411.691766164726;4722.409698787652;4861.270809378621;5088.669236499616;5103.18349064148;5118.846434606968;11855.940720296516;12820.038497112568;13023;13027;13030.869691303154;5050.4697006814495;5220.9477905220465;5821.912671309934;6025.126356678257;6049.395060494004;4766.6901651392545;5191;5317.468253174729;5399.2980912481125;5407.432219616962;3461.8269086546075;3918.412238164241;4115.909284039732;4146.937795933063;4192.790360481964;1107.5625128074525;1130.1241537808264;1130.3556972525582;1145.8453108830367;1146.1232157399595;795.3197723671265;822.8601137806587;874.3136637739344;950.4249928793118;969.6751588218026;5588.077967135378;6638.302978187221;6825.453963682893;6843;6881.483888708367;957.9749667855328;961.1733908838394;1007.6825799873017;1038.0294424712918;1102.1458369763498;4242.766647834399;4269.893252668646;4308.655307575386;4384.8246070157475;4423.314386270134;13209.867901321057;13798.793018104736;13804.17174969505;13838.4464621414;13872.028957972845;13435.12671676338;13790.310484475736;13822.654433639038;13849.030567860354;13889.236092014835;9914.702558923243;10276.640317588848;10281.691549253534;10304.793904122025;10312.535935882903;6340.112384266298;6554.311797261219;6589;6741.258461569126;6801.285864984304;11650.592229271935;12192.390380481118;12271.57049503263;12283.877161228273;12310.07674424404;11278.492467838803;11677.299362038304;11894;12013.75972480563;12030;8291.33669306442;8572.657093716181;8572.742817715478;8590.957045214735;8604.913950860411;10108.747281318027;10207.081362677394;10352.741181470523;10361.274710770174;10363.481825908826;8772.210501054935;8815.955920220358;8893.822123557364;8925.73222803317;9082.954585227031;8621.525816080175;8639.611217495354;8681.348898832486;8755.956220218859;8763.342749293955;7867.84264314722;7898.328642065259;7938.444308898322;7942.324902383131;7964.323032542299;5879.441453061952;5883;5939.376365481735;6078.3617720138745;6112.602680825732;5056.367954005749;5091.694498330112;5140.203268493389;5245;6057.969710151421 07:47:40 INFO - PROCESS | 1635 | |4;prototype.html;347.595051764694;367.2178260305549;375.3113037576048;379.45358683495783;387.2931899283808;4065.5324637666677;4445.644348452124;4736.00543885784;4907.582855457282;5089.363829521305;4568.885777855547;4775.403074615673;4887.484879687299;4941.677411616534;5064.645474816764;3360.647132051136;3539.982210140221;3683.926321473569;3913.0630337982666;3934.921301573981;3709.5919448860604;3733.216024634816;3884.3008258513455;3925.41118832176;3962.3858301963096;3667.706583473329;3944.8027598620097;3946.8026598670094;3968.7420317679257;3979.2041591681636;3086.99345425473;3892.9610703893163;3971.801409929492;4010.651106326221;4160.1679664067005;3836.731428799985;3855.8264878080554;3858.5562660294145;3867.9226415471535;3939.606039396066;4625.392194088617;4949.109160351135;4958.785097651099;4980.352554167971;4985.900281994376;4391.780410979471;4578.862634120982;4681.602063824579;4713.242752989505;4832.685875418087;5290.624437646201;5381.892362152735;5433.945660543383;5460.672359658393;5542.254189930159;3912.4131380292897;4023.919521609581;4131.690123240769;4334;4339.934900976488;4711.72783348494;4807.149247539687;4952.33143525623;4961.627877909135;5702.4054055404695;3322.903441864179;3622.7645203061716;4036.899077523027;4139.399787030864;4356.542563030899;4202.390653355307;4217.810198541073;4286.742795432284;4416.422697614942;4455.910881782411;4415.072834704683;4580.725156490555;4843.685160464559;4847.321375007502;4919.975400122977;4190.748555086643;5110.591152707849;5166.43169251382;5411.945880541144;5506.614536982453;1411.8094057302133;1440.6758479342063;1472.580314610331;1506.6760646460843;1551.1778757258671;1049.9632512862013;1138.7836311100864;1144.2619510415734;1149.6665966869682;1167.1304877866044;4466.883279180205;4575.7483338416705;4813.278008298783;4935.087008903364;5029.723365214948;4448;5158.716270605153;5470.863228419322;5581.957832981035;5672.730907636896;4154.169166166718;4694.577488026094;4997.950840155591;5031.949680503221;5050.646454748133;2382.4639456122236;2440.64610631461;2868.6987866274158;2868.899588514392;2892.580575816537;4955.72743499111;5073.518015788494;5604.215409842625;5706.4606250219085;5715.428457154251;5457.836264912059;5627.915581266202;5665.688387138747;5709.601147718836;5834;4842.612590992712;5139.408967968731;5162.754201922101;5578.246936663499;5851.864069614475;5574.91637625444;5622.550195984393;5639.238702775073;5642.391918303264;5662.131496606193;4694.582290120659;4791.904161916812;4823.879403014953;4922.680025798311;5219.530242278061;5108.438071812024;5170.741462926914;5508.724563771715;5710.828675139753;5802.82591522255;3770.924581508409;3849.268638958589;4040.393940908887;4324.529659915644;4480.753558554311;4717.646176536705;4812.711237325771;4855.761780746028;5406.891862162814;5460.3993560707495;4706.858794236178;5311.41574426805;5327.786888524571;5331.535176444176;5419.430959749169;5178.922316165336;5300.072487314627;5325.656711047127;5363.2759577456545;5372.811951581676;4381.693281470267;4631.93052104212;4912.606991440748;5182.740862956913;5252.579793616578;4678.532146785295;4737.668363214542;5071.670341427795;5276.973615131899;5360.65155764874;4452.732836029849;4764.33299338086;5210.218467229945;5231.750347350676;5235.4764523548865 07:47:40 INFO - PROCESS | 1635 | |5;yui.html;761.6458346868708;766.4596459496056;788.2905385153365;807.8303556253187;821.4085858182107;14010.719785604282;15838;15839.683206335867;15882.36470541177;15917.204139793008;12884.484620615163;14533.854661453383;14537.49118780843;14578.489752858652;15217.315220815062;913.6984795017628;928.0626567167142;929.0848514213494;930.2604429478564;946.6639343033228;938.6433155400938;941.2140862379921;942.0391200975035;942.6229508196708;943.5188054092428;999.4652860719516;999.5252255178805;1001.5142655811925;1002.413588050991;1003.413003393016;993.3493561717087;994.28908330544;995.1541189988452;995.3579940938091;996.9202463802878;741.7700512840983;742.4617152564401;742.7140550887893;743.1676522295064;745.7986343687228;15636.843631563652;15852;15903;16137;16443.09562974036;13977.650558736012;14001.29993500321;14145.575632731034;14178.787318190236;14219.217943013131;11590.616599337192;11823.527058917633;11914.404279785977;11918.702032449171;12061.457234424472;3509.78941263525;3548.2371290172737;3748.6626203641804;3774.830132644038;3775.263823554408;101585;107288.99999999921;109847;110950;111522.32716509259;10585.9470702646;10592.576296948037;10782.838257426145;11139.832902506469;11251.887481125248;22938;23203;23232;23267.650985235236;23269.88365058164;7576.772696819105;7671.2712292332135;7732.110807257125;7790.688372465152;8007.919920800718;4189.392538081961;4278.272693642089;4373.956260437355;4450.599446049806;4453.398791163217;3326;3404.727621790251;3416.829158542063;3422.7261819054415;3427.2117412994653;582.5223316880117;587.858913860679;589.1251491535068;590.3742033444563;590.4921767280135;527.564759073758;630.3003665930813;672.0758956434902;673.4074014866886;675.7263308360122;10709.357438553712;11116.166287528467;11160.330380177214;11471.942640286912;11648.126390520576;486.76878482721133;514.1413838889064;520.8906129712802;550.0099820323481;721.7549726721469;4698.248280275208;4759.547842954914;5323.095073837457;5393.622446428791;5455.8363249102595;55129.72435137798;85081.57459212789;97372.51313743528;97797.51101244448;110560.44719776511;66483.6703265932;84054.57972710098;86629;87075.56462217648;89022;74811;76952.61523692458;78900.21099788928;79281;79462;9703.417794932328;10871.075958543612;10900;11305.547778088785;11413;47335.76332118317;48450.75774621104;48726;48769.51230487791;49543.256851147984;43257.56742432535;59484.70257648684;59953.10070349035;60472.697636513294;65087;12977.351132443151;12991.350432478528;13162.539311124065;13553.119047261896;13706.190965449376;14929.701405971602;15021.098734075991;15167.772483412537;15325.540233793005;15484.303206355966;13893.444262229397;14124.364403601658;14400.99193056476;14443.988920775444;15049.699006019599;14049.297535122998;14191.858081419054;14549.709005819612;14969.476068337555;15007.77488337654;13435.395407206504;13581;13765.38055787512;13957.651058723613;14369.353379097756;9988.250881184085;10103.070109668113;10275.948620256851;10793.244472887136;10836.837447438136;10772.784544308914;11225.768445436217;11593.768124637292;11600.18798684084;11618.825717614412 07:47:40 INFO - PROCESS | 1635 | __end_tp_report 07:47:40 INFO - PROCESS | 1635 | __start_cc_report 07:47:40 INFO - PROCESS | 1635 | _x_x_mozilla_cycle_collect,1751 07:47:40 INFO - PROCESS | 1635 | __end_cc_report 07:47:40 INFO - PROCESS | 1635 | __startTimestamp1490712460303__endTimestamp 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | ------- Summary: start ------- 07:47:40 INFO - PROCESS | 1635 | Number of tests: 6 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#0] dojo.html Cycles:165 Average:5926.45 Median:6170.69 stddev:683.95 (11.1%) stddev-sans-first:640.76 07:47:40 INFO - PROCESS | 1635 | Values: 2806.7 3110.7 3375.3 3391.5 3432.9 4949.5 5950.6 5993.3 6019.4 6045.1 5934.2 6049.9 6054.4 6067.1 6084.0 4359.4 5372.0 5373.3 5419.8 5488.3 5296.8 5298.8 5505.3 5506.0 5518.2 5323.1 5377.6 5404.4 5405.1 5406.8 5373.5 5380.8 5397.7 5399.8 5413.2 5220.9 5344.5 5345.9 5363.5 5401.7 5979.4 5991.4 5999.3 6006.9 6007.7 6295.5 6332.1 6335.0 6342.0 6368.1 6312.1 6330.5 6332.7 6332.8 6361.0 6086.5 6153.1 6162.2 6170.7 6180.5 6563.6 6565.4 6565.9 6569.1 6576.8 6194.9 6245.1 6257.8 6309.2 6342.4 6431.6 6436.3 6441.8 6445.5 6454.9 6353.5 6356.2 6360.5 6362.8 6379.8 6224.3 6279.4 6285.2 6327.2 6380.9 5062.3 5211.8 5211.8 5228.8 5229.8 4605.3 4607.9 4610.5 4613.4 4667.4 5677.8 5766.2 5994.0 6014.4 6015.4 6290.2 6306.1 6334.6 6362.7 6410.5 5985.8 6031.7 6039.9 6048.1 6054.9 5663.8 5669.4 5685.0 5696.0 5701.7 6277.7 6394.7 6541.7 6592.9 6671.9 6377.2 6399.4 6405.0 6413.0 6416.6 6478.3 6612.9 6618.1 6640.9 6641.1 6236.9 6274.8 6302.8 6332.8 6355.3 6269.5 6338.7 6367.3 6390.7 6413.3 6307.4 6308.8 6314.9 6323.2 6334.7 6130.7 6217.0 6242.3 6242.7 6340.7 6127.4 6145.5 6149.4 6155.3 6169.5 6271.3 6289.7 6297.3 6298.4 6303.8 6042.2 6087.0 6097.2 6174.4 6181.1 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#1] ext.html Cycles:180 Average:54383.83 Median:31914.50 stddev:109895.04 (344.3%) stddev-sans-first:110129.57 07:47:40 INFO - PROCESS | 1635 | Values: 760.3 800.0 816.8 879.5 888.9 27742.2 27914.9 28593.0 39647.2 40248.0 40108.4 40232.8 40313.2 40320.8 40348.8 8954.0 9097.0 9123.5 9128.0 9131.6 7266.9 7417.8 8969.7 10836.7 11087.7 11027.8 11032.0 11082.8 11097.7 11137.7 11024.7 11037.7 11051.7 11053.7 11062.1 7092.1 7269.9 10631.9 10752.9 10889.9 38328.4 38514.4 38544.4 38567.8 38602.4 3752.6 3767.9 3787.4 3790.8 3825.4 26393.3 26783.5 28160.7 28709.1 28770.0 2992.7 3056.6 3168.8 3209.9 3290.3 350638.0 351059.2 352614.0 353407.0 353516.2 51712.0 51776.2 51865.0 51872.5 51951.7 54177.7 54180.7 54249.5 54295.7 54407.5 14894.4 15022.9 15046.5 15059.3 15074.9 12930.9 12943.9 12952.4 12959.8 12966.8 10583.7 10798.9 10961.0 10996.7 11005.6 4810.4 4910.9 5718.6 5814.3 5818.3 934.6 938.9 945.7 959.0 982.1 27681.0 28568.0 28679.0 29049.7 29169.9 1027.4 1032.8 1039.6 1040.8 1073.7 14247.6 14632.6 14662.1 15052.3 15070.2 468171.0 469062.7 469235.0 469783.0 470261.0 54587.9 54597.0 54619.7 54643.7 54668.5 1436.9 1454.7 1482.8 1492.0 1495.9 26442.2 27616.7 28237.0 28274.6 28394.4 44299.8 44321.8 44330.3 44371.5 44601.0 410934.0 412072.0 412257.9 413029.0 413137.0 28901.7 30178.7 30259.4 33248.2 33342.5 36484.3 36791.8 37873.8 38049.8 38305.6 27339.0 27423.3 27782.3 27931.6 28254.6 24997.4 25936.6 26030.7 26359.2 26655.9 31194.7 31903.0 31926.0 32097.0 32206.5 27359.3 27545.7 27562.0 28061.6 28463.3 18541.7 19896.7 22214.4 22305.1 22685.8 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#2] jquery.html Cycles:180 Average:42552.96 Median:27232.16 stddev:124578.89 (457.5%) stddev-sans-first:124888.09 07:47:40 INFO - PROCESS | 1635 | Values: 363.2 386.2 393.3 428.9 453.3 12502.1 14479.7 17200.4 21193.3 21298.0 21779.2 21914.7 22665.2 23089.2 23506.3 6509.7 6647.7 6686.3 6709.5 6717.3 3997.3 6437.1 6693.0 6718.1 6719.8 4352.0 4440.8 7677.7 7763.6 7791.5 7635.3 7675.0 7729.4 7757.2 7790.4 6680.8 6782.5 7180.0 7275.2 7503.3 27130.5 27333.9 27406.5 27692.9 27726.9 2894.7 2909.1 2909.4 2924.2 2955.9 16291.6 16527.1 16533.0 16957.8 17214.8 1766.9 1934.5 1936.1 1969.9 1978.4 126154.0 127576.0 129322.0 132603.0 135715.0 18161.8 19487.8 19675.9 19975.1 20007.9 30624.4 30740.0 31034.8 31177.7 31217.1 10051.6 10268.6 10345.7 10413.5 10556.7 7808.4 8337.5 8736.7 8739.8 8939.0 9181.9 9225.2 9390.4 9393.2 9420.3 3798.0 3865.0 3865.1 3877.2 3887.2 891.2 893.0 893.2 899.6 903.4 21523.6 21751.1 21806.7 21919.8 22522.3 906.7 913.3 928.9 935.4 940.0 10996.9 11305.3 11425.1 11523.5 11569.7 742294.0 743288.0 744901.0 757303.0 761661.0 147376.0 147712.0 147828.0 148934.8 157887.0 1014.3 1222.9 1272.5 1276.3 1286.2 19577.4 20000.1 20320.8 20358.7 20405.8 64492.0 64658.0 65304.3 65522.0 65970.0 93844.0 94081.1 95069.6 95443.0 96384.5 11241.4 11438.0 11526.3 11748.9 11907.9 12522.4 12623.2 12863.7 12916.9 12958.5 10908.2 11061.8 11285.7 11426.3 11462.4 9730.8 9811.6 9815.9 9892.8 9941.4 11155.7 11332.7 11468.9 11493.6 11625.8 11412.3 11446.7 11731.3 11741.1 11769.1 10850.3 10939.6 11001.6 11015.0 11238.1 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#3] mootools.html Cycles:180 Average:6720.31 Median:2423.24 stddev:4187.80 (172.8%) stddev-sans-first:4180.11 07:47:40 INFO - PROCESS | 1635 | Values: 1350.9 1548.8 1555.8 1587.8 1595.6 10567.1 11202.6 11208.6 11215.6 11222.2 10683.9 10917.0 11019.7 11167.3 11204.1 2396.8 2433.2 2436.7 2440.0 2440.8 2323.7 2411.6 2421.8 2424.7 2426.6 2332.1 2397.0 2409.9 2414.2 2414.2 2319.3 2383.8 2386.9 2395.7 2395.7 2344.9 2365.3 2368.2 2372.9 2374.1 10782.1 11057.2 11074.8 11084.9 11115.2 5727.3 5872.8 5899.0 5901.5 5902.6 3448.7 3507.6 3574.3 3592.5 3633.0 1154.5 1160.3 1187.8 1198.3 1210.1 13602.4 13923.1 14162.4 15211.7 15411.7 4722.4 4861.3 5088.7 5103.2 5118.8 11855.9 12820.0 13023.0 13027.0 13030.9 5050.5 5220.9 5821.9 6025.1 6049.4 4766.7 5191.0 5317.5 5399.3 5407.4 3461.8 3918.4 4115.9 4146.9 4192.8 1107.6 1130.1 1130.4 1145.8 1146.1 795.3 822.9 874.3 950.4 969.7 5588.1 6638.3 6825.5 6843.0 6881.5 958.0 961.2 1007.7 1038.0 1102.1 4242.8 4269.9 4308.7 4384.8 4423.3 13209.9 13798.8 13804.2 13838.4 13872.0 13435.1 13790.3 13822.7 13849.0 13889.2 9914.7 10276.6 10281.7 10304.8 10312.5 6340.1 6554.3 6589.0 6741.3 6801.3 11650.6 12192.4 12271.6 12283.9 12310.1 11278.5 11677.3 11894.0 12013.8 12030.0 8291.3 8572.7 8572.7 8591.0 8604.9 10108.7 10207.1 10352.7 10361.3 10363.5 8772.2 8816.0 8893.8 8925.7 9083.0 8621.5 8639.6 8681.3 8756.0 8763.3 7867.8 7898.3 7938.4 7942.3 7964.3 5879.4 5883.0 5939.4 6078.4 6112.6 5056.4 5091.7 5140.2 5245.0 6058.0 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#4] prototype.html Cycles:180 Average:4393.54 Median:4751.00 stddev:1245.80 (26.2%) stddev-sans-first:1211.71 07:47:40 INFO - PROCESS | 1635 | Values: 347.6 367.2 375.3 379.5 387.3 4065.5 4445.6 4736.0 4907.6 5089.4 4568.9 4775.4 4887.5 4941.7 5064.6 3360.6 3540.0 3683.9 3913.1 3934.9 3709.6 3733.2 3884.3 3925.4 3962.4 3667.7 3944.8 3946.8 3968.7 3979.2 3087.0 3893.0 3971.8 4010.7 4160.2 3836.7 3855.8 3858.6 3867.9 3939.6 4625.4 4949.1 4958.8 4980.4 4985.9 4391.8 4578.9 4681.6 4713.2 4832.7 5290.6 5381.9 5433.9 5460.7 5542.3 3912.4 4023.9 4131.7 4334.0 4339.9 4711.7 4807.1 4952.3 4961.6 5702.4 3322.9 3622.8 4036.9 4139.4 4356.5 4202.4 4217.8 4286.7 4416.4 4455.9 4415.1 4580.7 4843.7 4847.3 4920.0 4190.7 5110.6 5166.4 5411.9 5506.6 1411.8 1440.7 1472.6 1506.7 1551.2 1050.0 1138.8 1144.3 1149.7 1167.1 4466.9 4575.7 4813.3 4935.1 5029.7 4448.0 5158.7 5470.9 5582.0 5672.7 4154.2 4694.6 4998.0 5031.9 5050.6 2382.5 2440.6 2868.7 2868.9 2892.6 4955.7 5073.5 5604.2 5706.5 5715.4 5457.8 5627.9 5665.7 5709.6 5834.0 4842.6 5139.4 5162.8 5578.2 5851.9 5574.9 5622.6 5639.2 5642.4 5662.1 4694.6 4791.9 4823.9 4922.7 5219.5 5108.4 5170.7 5508.7 5710.8 5802.8 3770.9 3849.3 4040.4 4324.5 4480.8 4717.6 4812.7 4855.8 5406.9 5460.4 4706.9 5311.4 5327.8 5331.5 5419.4 5178.9 5300.1 5325.7 5363.3 5372.8 4381.7 4631.9 4912.6 5182.7 5252.6 4678.5 4737.7 5071.7 5277.0 5360.7 4452.7 4764.3 5210.2 5231.8 5235.5 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - PROCESS | 1635 | [#5] yui.html Cycles:180 Average:19904.61 Median:3424.97 stddev:27874.14 (813.9%) stddev-sans-first:27915.27 07:47:40 INFO - PROCESS | 1635 | Values: 761.6 766.5 788.3 807.8 821.4 14010.7 15838.0 15839.7 15882.4 15917.2 12884.5 14533.9 14537.5 14578.5 15217.3 913.7 928.1 929.1 930.3 946.7 938.6 941.2 942.0 942.6 943.5 999.5 999.5 1001.5 1002.4 1003.4 993.3 994.3 995.2 995.4 996.9 741.8 742.5 742.7 743.2 745.8 15636.8 15852.0 15903.0 16137.0 16443.1 13977.7 14001.3 14145.6 14178.8 14219.2 11590.6 11823.5 11914.4 11918.7 12061.5 3509.8 3548.2 3748.7 3774.8 3775.3 101585.0 107289.0 109847.0 110950.0 111522.3 10585.9 10592.6 10782.8 11139.8 11251.9 22938.0 23203.0 23232.0 23267.7 23269.9 7576.8 7671.3 7732.1 7790.7 8007.9 4189.4 4278.3 4374.0 4450.6 4453.4 3326.0 3404.7 3416.8 3422.7 3427.2 582.5 587.9 589.1 590.4 590.5 527.6 630.3 672.1 673.4 675.7 10709.4 11116.2 11160.3 11471.9 11648.1 486.8 514.1 520.9 550.0 721.8 4698.2 4759.5 5323.1 5393.6 5455.8 55129.7 85081.6 97372.5 97797.5 110560.4 66483.7 84054.6 86629.0 87075.6 89022.0 74811.0 76952.6 78900.2 79281.0 79462.0 9703.4 10871.1 10900.0 11305.5 11413.0 47335.8 48450.8 48726.0 48769.5 49543.3 43257.6 59484.7 59953.1 60472.7 65087.0 12977.4 12991.4 13162.5 13553.1 13706.2 14929.7 15021.1 15167.8 15325.5 15484.3 13893.4 14124.4 14401.0 14444.0 15049.7 14049.3 14191.9 14549.7 14969.5 15007.8 13435.4 13581.0 13765.4 13957.7 14369.4 9988.3 10103.1 10275.9 10793.2 10836.8 10772.8 11225.8 11593.8 11600.2 11618.8 07:47:40 INFO - PROCESS | 1635 | -------- Summary: end -------- 07:47:40 INFO - PROCESS | 1635 | 07:47:40 INFO - TEST-INFO | 1635: exit 0 07:47:40 INFO - TEST-OK | dromaeo_css | took 1120344ms 07:47:40 INFO - TEST-START | kraken 07:47:40 INFO - operating with platform_type : mac_ 07:47:40 INFO - Initialising browser for kraken test... 07:47:40 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpWpVFHf/profile http://localhost:49248/getInfo.html) 07:47:43 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 07:47:43 INFO - PROCESS | 1645 | colorDepth:24 07:47:43 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 07:47:43 INFO - PROCESS | 1645 | __metrics 07:47:43 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:43 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:44 INFO - TEST-INFO | 1645: exit 0 07:47:44 INFO - Browser initialized. 07:47:44 INFO - Running cycle 1/1 for kraken test... 07:47:44 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpWpVFHf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:56 INFO - PROCESS | 1646 | RSS: Main: 215048192 07:47:56 INFO - PROCESS | 1646 | 07:47:59 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:00 INFO - PROCESS | 1646 | RSS: Main: 268091392 07:48:00 INFO - PROCESS | 1646 | 07:48:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 07:48:03 INFO - PROCESS | 1646 | RSS: Main: 279638016 07:48:03 INFO - PROCESS | 1646 | 07:48:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 07:48:07 INFO - PROCESS | 1646 | RSS: Main: 375480320 07:48:07 INFO - PROCESS | 1646 | 07:48:09 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 07:48:10 INFO - PROCESS | 1646 | RSS: Main: 279162880 07:48:10 INFO - PROCESS | 1646 | 07:48:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:12 INFO - PROCESS | 1646 | RSS: Main: 280707072 07:48:12 INFO - PROCESS | 1646 | 07:48:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:16 INFO - PROCESS | 1646 | RSS: Main: 320438272 07:48:16 INFO - PROCESS | 1646 | 07:48:19 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:20 INFO - PROCESS | 1646 | RSS: Main: 320167936 07:48:20 INFO - PROCESS | 1646 | 07:48:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 07:48:23 INFO - PROCESS | 1646 | RSS: Main: 317652992 07:48:23 INFO - PROCESS | 1646 | 07:48:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:26 INFO - PROCESS | 1646 | RSS: Main: 294694912 07:48:26 INFO - PROCESS | 1646 | 07:48:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:28 INFO - PROCESS | 1646 | RSS: Main: 297414656 07:48:28 INFO - PROCESS | 1646 | 07:48:30 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:31 INFO - PROCESS | 1646 | RSS: Main: 300240896 07:48:31 INFO - PROCESS | 1646 | 07:48:34 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:35 INFO - PROCESS | 1646 | RSS: Main: 320294912 07:48:35 INFO - PROCESS | 1646 | 07:48:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:38 INFO - PROCESS | 1646 | RSS: Main: 313720832 07:48:38 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 07:48:40 INFO - PROCESS | 1646 | RSS: Main: 358653952 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | __start_tp_report 07:48:40 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 07:48:40 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 07:48:40 INFO - PROCESS | 1646 | |i|pagename|runs| 07:48:40 INFO - PROCESS | 1646 | |0;ai-astar;117;115;115;114;112;114;115;112;114;113 07:48:40 INFO - PROCESS | 1646 | |1;audio-beat-detection;140;109;109;142;110;108;109;107;129;107 07:48:40 INFO - PROCESS | 1646 | |2;audio-dft;184;187;182;188;181;183;184;183;186;185 07:48:40 INFO - PROCESS | 1646 | |3;audio-fft;84;61;62;91;62;75;83;82;93;60 07:48:40 INFO - PROCESS | 1646 | |4;audio-oscillator;87;68;86;70;69;68;81;69;68;83 07:48:40 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;87;86;86;86;86;87;90;134;86;86 07:48:40 INFO - PROCESS | 1646 | |6;imaging-darkroom;94;93;94;93;108;129;147;134;94;93 07:48:40 INFO - PROCESS | 1646 | |7;imaging-desaturate;84;83;94;95;128;68;127;128;127;84 07:48:40 INFO - PROCESS | 1646 | |8;json-parse-financial;59;61;59;63;63;64;64;64;63;64 07:48:40 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;55;66;66;65;58;58;58;57;57;58 07:48:40 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;85;83;82;83;83;78;82;82;82;85 07:48:40 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;150;135;135;137;138;140;136;155;202;142 07:48:40 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;171;164;163;158;162;163;166;165;163;164 07:48:40 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;65;64;67;63;63 07:48:40 INFO - PROCESS | 1646 | __end_tp_report 07:48:40 INFO - PROCESS | 1646 | __start_cc_report 07:48:40 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2143 07:48:40 INFO - PROCESS | 1646 | __end_cc_report 07:48:40 INFO - PROCESS | 1646 | __startTimestamp1490712520496__endTimestamp 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | ------- Summary: start ------- 07:48:40 INFO - PROCESS | 1646 | Number of tests: 14 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:1.52 (1.3%) stddev-sans-first:1.20 07:48:40 INFO - PROCESS | 1646 | Values: 117.0 115.0 115.0 114.0 112.0 114.0 115.0 112.0 114.0 113.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:109.50 stddev:14.22 (13.0%) stddev-sans-first:12.41 07:48:40 INFO - PROCESS | 1646 | Values: 140.0 109.0 109.0 142.0 110.0 108.0 109.0 107.0 129.0 107.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:184.30 Median:184.50 stddev:2.21 (1.2%) stddev-sans-first:2.35 07:48:40 INFO - PROCESS | 1646 | Values: 184.0 187.0 182.0 188.0 181.0 183.0 184.0 183.0 186.0 185.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:75.30 Median:82.50 stddev:13.05 (15.8%) stddev-sans-first:13.45 07:48:40 INFO - PROCESS | 1646 | Values: 84.0 61.0 62.0 91.0 62.0 75.0 83.0 82.0 93.0 60.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:8.23 (10.9%) stddev-sans-first:7.47 07:48:40 INFO - PROCESS | 1646 | Values: 87.0 68.0 86.0 70.0 69.0 68.0 81.0 69.0 68.0 83.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:86.00 stddev:15.02 (17.5%) stddev-sans-first:15.85 07:48:40 INFO - PROCESS | 1646 | Values: 87.0 86.0 86.0 86.0 86.0 87.0 90.0 134.0 86.0 86.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:107.90 Median:93.00 stddev:20.82 (22.4%) stddev-sans-first:21.47 07:48:40 INFO - PROCESS | 1646 | Values: 94.0 93.0 94.0 93.0 108.0 129.0 147.0 134.0 94.0 93.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:101.80 Median:83.50 stddev:23.28 (27.9%) stddev-sans-first:23.79 07:48:40 INFO - PROCESS | 1646 | Values: 84.0 83.0 94.0 95.0 128.0 68.0 127.0 128.0 127.0 84.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.50 stddev:2.01 (3.2%) stddev-sans-first:1.72 07:48:40 INFO - PROCESS | 1646 | Values: 59.0 61.0 59.0 63.0 63.0 64.0 64.0 64.0 63.0 64.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:58.00 stddev:4.16 (7.2%) stddev-sans-first:4.03 07:48:40 INFO - PROCESS | 1646 | Values: 55.0 66.0 66.0 65.0 58.0 58.0 58.0 57.0 57.0 58.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:1.86 07:48:40 INFO - PROCESS | 1646 | Values: 85.0 83.0 82.0 83.0 83.0 78.0 82.0 82.0 82.0 85.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:141.00 stddev:20.45 (14.5%) stddev-sans-first:21.66 07:48:40 INFO - PROCESS | 1646 | Values: 150.0 135.0 135.0 137.0 138.0 140.0 136.0 155.0 202.0 142.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:164.00 stddev:3.28 (2.0%) stddev-sans-first:2.26 07:48:40 INFO - PROCESS | 1646 | Values: 171.0 164.0 163.0 158.0 162.0 163.0 166.0 165.0 163.0 164.0 07:48:40 INFO - PROCESS | 1646 | 07:48:40 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.41 07:48:40 INFO - PROCESS | 1646 | Values: 67.0 66.0 66.0 65.0 66.0 65.0 64.0 67.0 63.0 63.0 07:48:40 INFO - PROCESS | 1646 | -------- Summary: end -------- 07:48:40 INFO - PROCESS | 1646 | 07:48:41 INFO - TEST-INFO | 1646: exit 0 07:48:41 INFO - TEST-OK | kraken | took 60558ms 07:48:41 INFO - SUITE-END | took 1180s 07:48:41 INFO - Completed test suite (00:19:41) 07:48:41 INFO - javascript benchmark 07:48:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7592.473246983719, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2806.7193280671927, 3110.7355874750647, 3375.2574433624623, 3391.4912763085536, 3432.9141771455725, 4949.5297946695055, 5950.55370847186, 5993.340732519419, 6019.367966363535, 6045.093236014594, 5934.1692163097205, 6049.909251361233, 6054.424829641188, 6067.120267561201, 6083.969580152093, 4359.433273674418, 5371.973140134294, 5373.274607927929, 5419.810306639269, 5488.318747350841, 5296.8146114885985, 5298.788048478056, 5505.311836020497, 5506.0, 5518.227448157261, 5323.068463018975, 5377.596680248997, 5404.351477822667, 5405.054115529786, 5406.83779486616, 5373.489518495737, 5380.811671591495, 5397.730113494349, 5399.83800485986, 5413.242146099529, 5220.8694782630355, 5344.518993290622, 5345.946540534584, 5363.517283444469, 5401.70290634015, 5979.402059794029, 5991.430814072656, 5999.310079340888, 6006.909896351558, 6007.699615019275, 6295.527835412317, 6332.1135041094285, 6335.0, 6341.968290158566, 6368.076628888785, 6312.084747711556, 6330.461910737593, 6332.715027823759, 6332.841678958017, 6361.045843123522, 6086.543509236825, 6153.077038444225, 6162.1681073055015, 6170.691465426756, 6180.505559555225, 6563.573367731177, 6565.441937435276, 6565.93434065658, 6569.146011018584, 6576.80269591913, 6194.907076393858, 6245.0632405139595, 6257.812265632038, 6309.179806625109, 6342.39747224013, 6431.5819471734185, 6436.292007879129, 6441.838954026093, 6445.548811583238, 6454.935450645527, 6353.491720662336, 6356.173697419398, 6360.491160707133, 6362.777302794472, 6379.776707815204, 6224.315325314212, 6279.403456671609, 6285.214348206474, 6327.177466929362, 6380.872382552323, 5062.316587260672, 5211.791528338824, 5211.7915283389, 5228.790848366023, 5229.790808367698, 4605.263157894721, 4607.894105414676, 4610.492845786961, 4613.423322084739, 4667.369905062773, 5677.829665110054, 5766.221560089418, 5994.010988186988, 6014.398560143951, 6015.428534289235, 6290.182276304051, 6306.148669929501, 6334.619922804646, 6362.681865906686, 6410.519211059189, 5985.820425387245, 6031.698415079316, 6039.939600604026, 6048.0625503047095, 6054.878902422015, 5663.830085097454, 5669.40471250521, 5684.971575142181, 5696.0, 5701.714914254354, 6277.686115694106, 6394.712237949397, 6541.738330466728, 6592.868142637025, 6671.899921501182, 6377.23473183221, 6399.392057754506, 6405.03924411342, 6413.038044293393, 6416.550841441054, 6478.3197764235965, 6612.933870661232, 6618.1065556151225, 6640.900386494303, 6641.103451034049, 6236.875262494816, 6274.811755647338, 6302.842428939313, 6332.841678958063, 6355.300916899045, 6269.467095296951, 6338.651374174465, 6367.299597044229, 6390.7443702251385, 6413.2945376007665, 6307.400796924285, 6308.810735677937, 6314.936850631435, 6323.177986861862, 6334.651594162181, 6130.673316708229, 6217.0, 6242.250929888442, 6242.687865606611, 6340.746370145327, 6127.417895299939, 6145.463634091477, 6149.41580549847, 6155.322914479314, 6169.537284703755, 6271.3415091414745, 6289.748410063729, 6297.275813281532, 6298.370162983848, 6303.810885673437, 6042.1540984261355, 6086.969565152146, 6097.176881120992, 6174.351693072343, 6181.103739957591], "value": 5879.164177548257, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.2853317881192, 799.9720009799656, 816.8121332093616, 879.4635272483788, 888.8711136885148, 27742.16773496796, 27914.883404663815, 28592.999999999975, 39647.20705585887, 40248.0, 40108.39837402434, 40232.79883600585, 40313.19373612526, 40320.79839600805, 40348.798256008755, 8954.0, 9097.044810294923, 9123.543822808866, 9127.995920448746, 9131.589078491485, 7266.890996635055, 7417.777466676009, 8969.730908072768, 10836.67489975302, 11087.72280692981, 11027.779444411108, 11032.0, 11082.778344433107, 11097.722556936102, 11137.665870023871, 11024.724381890477, 11037.724056898642, 11051.668449946434, 11053.723656908642, 11062.05972492339, 7092.078029856086, 7269.927300726978, 10631.893681063168, 10752.892471075267, 10889.945550272278, 38328.42507362392, 38514.422283665765, 38544.42183367252, 38567.80716096402, 38602.42096368557, 3752.6247375262255, 3767.867664169624, 3787.394016957301, 3790.77255364679, 3825.4261860720835, 26393.3401664958, 26783.464330713276, 28160.71839281622, 28709.138725838257, 28770.0, 2992.6558445778796, 3056.602641656593, 3168.825714585697, 3209.8555564999633, 3290.2925870937624, 350638.0, 351059.2447037774, 352614.0, 353407.0, 353516.23241883627, 51712.0, 51776.22335664968, 51865.0, 51872.48127518752, 51951.740241298554, 54177.72911135498, 54180.72909635427, 54249.45750542523, 54295.72852135793, 54407.455925441034, 14894.404223830925, 15022.948393612562, 15046.54860354191, 15059.322330495153, 15074.944753867343, 12930.870691293156, 12943.870561294454, 12952.417141228667, 12959.805602915963, 12966.80549791754, 10583.682489525327, 10798.892011079946, 10961.0, 10996.725081873017, 11005.614803482, 4810.394289798588, 4910.877228069256, 5718.628289161191, 5814.273215848019, 5818.272715910512, 934.6401635370296, 938.8732521109699, 945.6784693204206, 958.9808203835884, 982.1357205658975, 27681.0, 28568.0, 28679.0, 29049.7095029047, 29169.854150729112, 1027.3784360461962, 1032.8450732390202, 1039.6101461951769, 1040.7710303733168, 1073.6510634043811, 14247.572572822832, 14632.561023169323, 14662.120272783666, 15052.32264548098, 15070.171140587372, 468171.0, 469062.6546867312, 469235.0, 469783.0, 470261.0, 54587.90824183494, 54597.0, 54619.72690136524, 54643.72678136663, 54668.45331546713, 1436.8850491960827, 1454.6508837878832, 1482.7775833625042, 1492.037635724973, 1495.940162393492, 26442.206733798015, 27616.723832762218, 28237.0, 28274.575881361383, 28394.432111357244, 44299.778501107285, 44321.77839110784, 44330.335044975, 44371.450283976556, 44601.0, 410934.0, 412072.0, 412257.9387103045, 413029.0, 413137.0, 28901.7109828899, 30178.69821301759, 30259.394812104074, 33248.1687957803, 33342.499862501594, 36484.27031459409, 36791.8160409207, 37873.81063094667, 38049.80975095107, 38305.61694383132, 27339.0, 27423.314417139733, 27782.305442364104, 27931.58102628503, 28254.59835913888, 24997.37506562278, 25936.610950835377, 26030.73969260283, 26359.20922372332, 26655.866720667047, 31194.688053120088, 31903.0, 31926.0, 32097.0, 32206.516902246018, 27359.316017099733, 27545.724542754317, 27562.0, 28061.579076313465, 28463.28841778972, 18541.721874172166, 19896.70154947706, 22214.444638884157, 22305.10779568864, 22685.773142268365], "value": 18103.94576069823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.2118303281879, 386.16202839837587, 393.3117045170949, 428.9056407590331, 453.2702349217759, 12502.124851260416, 14479.710405791891, 17200.397986070504, 21193.258235961745, 21298.0, 21779.23772667953, 21914.671279930815, 22665.206717764882, 23089.191878284262, 23506.294811155694, 6509.707063182156, 6647.700853461606, 6686.297938716438, 6709.5303328767, 6717.261101278856, 3997.3004724173297, 6437.0988061671405, 6692.9665351673175, 6718.093057437257, 6719.832004199885, 4352.042550638855, 4440.755758433284, 7677.692892284302, 7763.611819409035, 7791.532508049535, 7635.312821846005, 7675.04061992251, 7729.381649468057, 7757.224277572226, 7790.415718821055, 6680.799576012728, 6782.457403407765, 7180.030695856045, 7275.1633562140505, 7503.324700776956, 27130.457390852072, 27333.86333068342, 27406.45187096267, 27692.892284308604, 27726.890924363204, 2894.6815850256453, 2909.11272062021, 2909.3599408130176, 2924.1519959212014, 2955.896543620963, 16291.59271018234, 16527.091009994445, 16533.0, 16957.830421695748, 17214.82785172145, 1766.8692037096268, 1934.5067007913033, 1936.0900376822872, 1969.8719583227187, 1978.4163671716879, 126154.0, 127576.0, 129322.0, 132603.0, 135715.0, 18161.818381816276, 19487.8051219486, 19675.90162049209, 19975.101120449322, 20007.899960500104, 30624.387512249632, 30740.0, 31034.844825775726, 31177.688223117933, 31217.063488095395, 10051.648192313234, 10268.640597579199, 10345.741356465998, 10413.53139108742, 10556.736081598021, 7808.414368922354, 8337.541435221121, 8736.737897862948, 8739.825203495895, 8938.955305223562, 9181.862272065924, 9225.215856652125, 9390.389624674373, 9393.20157786582, 9420.340576159602, 3797.9620203798163, 3864.9806750966063, 3865.091703449687, 3877.2051729395407, 3887.183691424776, 891.1864356035437, 892.9598168082451, 893.2005854760083, 899.5592159841761, 903.3631289940577, 21523.569528609652, 21751.12995480195, 21806.672899906513, 21919.780802191774, 22522.32433027012, 906.727981605529, 913.3423934766957, 928.8560273157672, 935.373299889076, 939.9718008459757, 10996.890031099747, 11305.26515776472, 11425.143114266297, 11523.50194474713, 11569.652910412533, 742294.0, 743288.0, 744901.0, 757303.0, 761661.0, 147376.0, 147712.0, 147828.0, 148934.7659785104, 157887.0, 1014.3052009373603, 1222.8715984821465, 1272.5418849214275, 1276.349061978379, 1286.1511402474323, 19577.412677619694, 20000.099995499946, 20320.79679203189, 20358.694619580423, 20405.795942040982, 64492.0, 64658.0, 65304.34695652983, 65522.0, 65970.0, 93844.0, 94081.05918940723, 95069.57395638933, 95443.0, 96384.51807740917, 11241.381724005258, 11438.0, 11526.250793698382, 11748.88251117478, 11907.880921191023, 12522.436490358137, 12623.179493333271, 12863.6784080395, 12916.870831291566, 12958.481660733465, 10908.236423450282, 11061.834072488758, 11285.661430157108, 11426.314421134759, 11462.4268786562, 9730.80538389214, 9811.607535698493, 9815.901840981498, 9892.802143956937, 9941.403515789076, 11155.665330040112, 11332.716682083013, 11468.885311146782, 11493.597724079616, 11625.76748465009, 11412.258203216765, 11446.713832154262, 11731.296122232694, 11741.06071514294, 11769.058475321783, 10850.29473084247, 10939.617113401311, 11001.61494347694, 11015.008649221609, 11238.100951923663], "value": 11425.50174630334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1350.885174760146, 1548.829628740839, 1555.7510798272272, 1587.8253392126865, 1595.5771720494067, 10567.10179634731, 11202.607908723186, 11208.607698730546, 11215.607453739121, 11222.214444988855, 10683.893161068387, 10917.0, 11019.724506887333, 11167.329960202394, 11204.103671706263, 2396.760323967598, 2433.1727212747664, 2436.719777225624, 2439.9878000609974, 2440.7681270279295, 2323.6514522821544, 2411.5538625354366, 2421.8183636227263, 2424.660547523348, 2426.575349313863, 2332.1137967572386, 2396.9640455393182, 2409.9277021689377, 2414.1550457339877, 2414.239514552919, 2319.2810228829117, 2383.8450500717486, 2386.8925898334614, 2395.688560487143, 2395.73646898841, 2344.859308441499, 2365.337705442462, 2368.242162507981, 2372.8813559321966, 2374.0622454130694, 10782.083522900562, 11057.170712196537, 11074.778504429867, 11084.889151108466, 11115.221934464591, 5727.312722473288, 5872.794452194195, 5898.970505147447, 5901.468867801918, 5902.557308201859, 3448.7241020718534, 3507.6316986716283, 3574.285142971416, 3592.5329707138167, 3633.0009247456896, 1154.4747140051256, 1160.3444054109486, 1187.8158885372782, 1198.2750435986277, 1210.1468464732343, 13602.387892544859, 13923.094998825043, 14162.362693678706, 15211.695766084616, 15411.691766164726, 4722.409698787652, 4861.270809378621, 5088.669236499616, 5103.18349064148, 5118.846434606968, 11855.940720296516, 12820.038497112568, 13023.0, 13027.0, 13030.869691303154, 5050.4697006814495, 5220.9477905220465, 5821.912671309934, 6025.126356678257, 6049.395060494004, 4766.6901651392545, 5191.0, 5317.468253174729, 5399.2980912481125, 5407.432219616962, 3461.8269086546075, 3918.412238164241, 4115.909284039732, 4146.937795933063, 4192.790360481964, 1107.5625128074525, 1130.1241537808264, 1130.3556972525582, 1145.8453108830367, 1146.1232157399595, 795.3197723671265, 822.8601137806587, 874.3136637739344, 950.4249928793118, 969.6751588218026, 5588.077967135378, 6638.302978187221, 6825.453963682893, 6843.0, 6881.483888708367, 957.9749667855328, 961.1733908838394, 1007.6825799873017, 1038.0294424712918, 1102.1458369763498, 4242.766647834399, 4269.893252668646, 4308.655307575386, 4384.8246070157475, 4423.314386270134, 13209.867901321057, 13798.793018104736, 13804.17174969505, 13838.4464621414, 13872.028957972845, 13435.12671676338, 13790.310484475736, 13822.654433639038, 13849.030567860354, 13889.236092014835, 9914.702558923243, 10276.640317588848, 10281.691549253534, 10304.793904122025, 10312.535935882903, 6340.112384266298, 6554.311797261219, 6589.0, 6741.258461569126, 6801.285864984304, 11650.592229271935, 12192.390380481118, 12271.57049503263, 12283.877161228273, 12310.07674424404, 11278.492467838803, 11677.299362038304, 11894.0, 12013.75972480563, 12030.0, 8291.33669306442, 8572.657093716181, 8572.742817715478, 8590.957045214735, 8604.913950860411, 10108.747281318027, 10207.081362677394, 10352.741181470523, 10361.274710770174, 10363.481825908826, 8772.210501054935, 8815.955920220358, 8893.822123557364, 8925.73222803317, 9082.954585227031, 8621.525816080175, 8639.611217495354, 8681.348898832486, 8755.956220218859, 8763.342749293955, 7867.84264314722, 7898.328642065259, 7938.444308898322, 7942.324902383131, 7964.323032542299, 5879.441453061952, 5883.0, 5939.376365481735, 6078.3617720138745, 6112.602680825732, 5056.367954005749, 5091.694498330112, 5140.203268493389, 5245.0, 6057.969710151421], "value": 5135.013473164039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.595051764694, 367.2178260305549, 375.3113037576048, 379.45358683495783, 387.2931899283808, 4065.5324637666677, 4445.644348452124, 4736.00543885784, 4907.582855457282, 5089.363829521305, 4568.885777855547, 4775.403074615673, 4887.484879687299, 4941.677411616534, 5064.645474816764, 3360.647132051136, 3539.982210140221, 3683.926321473569, 3913.0630337982666, 3934.921301573981, 3709.5919448860604, 3733.216024634816, 3884.3008258513455, 3925.41118832176, 3962.3858301963096, 3667.706583473329, 3944.8027598620097, 3946.8026598670094, 3968.7420317679257, 3979.2041591681636, 3086.99345425473, 3892.9610703893163, 3971.801409929492, 4010.651106326221, 4160.1679664067005, 3836.731428799985, 3855.8264878080554, 3858.5562660294145, 3867.9226415471535, 3939.606039396066, 4625.392194088617, 4949.109160351135, 4958.785097651099, 4980.352554167971, 4985.900281994376, 4391.780410979471, 4578.862634120982, 4681.602063824579, 4713.242752989505, 4832.685875418087, 5290.624437646201, 5381.892362152735, 5433.945660543383, 5460.672359658393, 5542.254189930159, 3912.4131380292897, 4023.919521609581, 4131.690123240769, 4334.0, 4339.934900976488, 4711.72783348494, 4807.149247539687, 4952.33143525623, 4961.627877909135, 5702.4054055404695, 3322.903441864179, 3622.7645203061716, 4036.899077523027, 4139.399787030864, 4356.542563030899, 4202.390653355307, 4217.810198541073, 4286.742795432284, 4416.422697614942, 4455.910881782411, 4415.072834704683, 4580.725156490555, 4843.685160464559, 4847.321375007502, 4919.975400122977, 4190.748555086643, 5110.591152707849, 5166.43169251382, 5411.945880541144, 5506.614536982453, 1411.8094057302133, 1440.6758479342063, 1472.580314610331, 1506.6760646460843, 1551.1778757258671, 1049.9632512862013, 1138.7836311100864, 1144.2619510415734, 1149.6665966869682, 1167.1304877866044, 4466.883279180205, 4575.7483338416705, 4813.278008298783, 4935.087008903364, 5029.723365214948, 4448.0, 5158.716270605153, 5470.863228419322, 5581.957832981035, 5672.730907636896, 4154.169166166718, 4694.577488026094, 4997.950840155591, 5031.949680503221, 5050.646454748133, 2382.4639456122236, 2440.64610631461, 2868.6987866274158, 2868.899588514392, 2892.580575816537, 4955.72743499111, 5073.518015788494, 5604.215409842625, 5706.4606250219085, 5715.428457154251, 5457.836264912059, 5627.915581266202, 5665.688387138747, 5709.601147718836, 5834.0, 4842.612590992712, 5139.408967968731, 5162.754201922101, 5578.246936663499, 5851.864069614475, 5574.91637625444, 5622.550195984393, 5639.238702775073, 5642.391918303264, 5662.131496606193, 4694.582290120659, 4791.904161916812, 4823.879403014953, 4922.680025798311, 5219.530242278061, 5108.438071812024, 5170.741462926914, 5508.724563771715, 5710.828675139753, 5802.82591522255, 3770.924581508409, 3849.268638958589, 4040.393940908887, 4324.529659915644, 4480.753558554311, 4717.646176536705, 4812.711237325771, 4855.761780746028, 5406.891862162814, 5460.3993560707495, 4706.858794236178, 5311.41574426805, 5327.786888524571, 5331.535176444176, 5419.430959749169, 5178.922316165336, 5300.072487314627, 5325.656711047127, 5363.2759577456545, 5372.811951581676, 4381.693281470267, 4631.93052104212, 4912.606991440748, 5182.740862956913, 5252.579793616578, 4678.532146785295, 4737.668363214542, 5071.670341427795, 5276.973615131899, 5360.65155764874, 4452.732836029849, 4764.33299338086, 5210.218467229945, 5231.750347350676, 5235.4764523548865], "value": 4036.5146766437924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.6458346868708, 766.4596459496056, 788.2905385153365, 807.8303556253187, 821.4085858182107, 14010.719785604282, 15838.0, 15839.683206335867, 15882.36470541177, 15917.204139793008, 12884.484620615163, 14533.854661453383, 14537.49118780843, 14578.489752858652, 15217.315220815062, 913.6984795017628, 928.0626567167142, 929.0848514213494, 930.2604429478564, 946.6639343033228, 938.6433155400938, 941.2140862379921, 942.0391200975035, 942.6229508196708, 943.5188054092428, 999.4652860719516, 999.5252255178805, 1001.5142655811925, 1002.413588050991, 1003.413003393016, 993.3493561717087, 994.28908330544, 995.1541189988452, 995.3579940938091, 996.9202463802878, 741.7700512840983, 742.4617152564401, 742.7140550887893, 743.1676522295064, 745.7986343687228, 15636.843631563652, 15852.0, 15903.0, 16137.0, 16443.09562974036, 13977.650558736012, 14001.29993500321, 14145.575632731034, 14178.787318190236, 14219.217943013131, 11590.616599337192, 11823.527058917633, 11914.404279785977, 11918.702032449171, 12061.457234424472, 3509.78941263525, 3548.2371290172737, 3748.6626203641804, 3774.830132644038, 3775.263823554408, 101585.0, 107288.99999999921, 109847.0, 110950.0, 111522.32716509259, 10585.9470702646, 10592.576296948037, 10782.838257426145, 11139.832902506469, 11251.887481125248, 22938.0, 23203.0, 23232.0, 23267.650985235236, 23269.88365058164, 7576.772696819105, 7671.2712292332135, 7732.110807257125, 7790.688372465152, 8007.919920800718, 4189.392538081961, 4278.272693642089, 4373.956260437355, 4450.599446049806, 4453.398791163217, 3326.0, 3404.727621790251, 3416.829158542063, 3422.7261819054415, 3427.2117412994653, 582.5223316880117, 587.858913860679, 589.1251491535068, 590.3742033444563, 590.4921767280135, 527.564759073758, 630.3003665930813, 672.0758956434902, 673.4074014866886, 675.7263308360122, 10709.357438553712, 11116.166287528467, 11160.330380177214, 11471.942640286912, 11648.126390520576, 486.76878482721133, 514.1413838889064, 520.8906129712802, 550.0099820323481, 721.7549726721469, 4698.248280275208, 4759.547842954914, 5323.095073837457, 5393.622446428791, 5455.8363249102595, 55129.72435137798, 85081.57459212789, 97372.51313743528, 97797.51101244448, 110560.44719776511, 66483.6703265932, 84054.57972710098, 86629.0, 87075.56462217648, 89022.0, 74811.0, 76952.61523692458, 78900.21099788928, 79281.0, 79462.0, 9703.417794932328, 10871.075958543612, 10900.0, 11305.547778088785, 11413.0, 47335.76332118317, 48450.75774621104, 48726.0, 48769.51230487791, 49543.256851147984, 43257.56742432535, 59484.70257648684, 59953.10070349035, 60472.697636513294, 65087.0, 12977.351132443151, 12991.350432478528, 13162.539311124065, 13553.119047261896, 13706.190965449376, 14929.701405971602, 15021.098734075991, 15167.772483412537, 15325.540233793005, 15484.303206355966, 13893.444262229397, 14124.364403601658, 14400.99193056476, 14443.988920775444, 15049.699006019599, 14049.297535122998, 14191.858081419054, 14549.709005819612, 14969.476068337555, 15007.77488337654, 13435.395407206504, 13581.0, 13765.38055787512, 13957.651058723613, 14369.353379097756, 9988.250881184085, 10103.070109668113, 10275.948620256851, 10793.244472887136, 10836.837447438136, 10772.784544308914, 11225.768445436217, 11593.768124637292, 11600.18798684084, 11618.825717614412], "value": 7598.807018258666, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 114.0, 112.0, 114.0, 115.0, 112.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 142.0, 110.0, 108.0, 109.0, 107.0, 129.0, 107.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 182.0, 188.0, 181.0, 183.0, 184.0, 183.0, 186.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 61.0, 62.0, 91.0, 62.0, 75.0, 83.0, 82.0, 93.0, 60.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 68.0, 86.0, 70.0, 69.0, 68.0, 81.0, 69.0, 68.0, 83.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 86.0, 87.0, 90.0, 134.0, 86.0, 86.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 108.0, 129.0, 147.0, 134.0, 94.0, 93.0], "value": 107.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 94.0, 95.0, 128.0, 68.0, 127.0, 128.0, 127.0, 84.0], "value": 101.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 59.0, 63.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 66.0, 66.0, 65.0, 58.0, 58.0, 58.0, 57.0, 57.0, 58.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 83.0, 83.0, 78.0, 82.0, 82.0, 82.0, 85.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 135.0, 137.0, 138.0, 140.0, 136.0, 155.0, 202.0, 142.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 163.0, 158.0, 162.0, 163.0, 166.0, 165.0, 163.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0, 67.0, 63.0, 63.0], "value": 65.2, "unit": "score"}]}]} 07:48:41 INFO - Return code: 0 07:48:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:48:41 ERROR - # TBPL SUCCESS # 07:48:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:41 INFO - 2017-03-28 07:48:41.829 screenresolution[1650:9980] starting screenresolution argv=screenresolution get 07:48:41 INFO - 2017-03-28 07:48:41.832 screenresolution[1650:9980] Display 0: 1600x1200x32@60 07:48:41 INFO - 2017-03-28 07:48:41.838 screenresolution[1651:9983] starting screenresolution argv=screenresolution list 07:48:41 INFO - Available Modes on Display 0 07:48:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:42 INFO - Intel Iris: 07:48:42 INFO - Chipset Model: Intel Iris 07:48:42 INFO - Type: GPU 07:48:42 INFO - Bus: Built-In 07:48:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:42 INFO - Vendor: Intel (0x8086) 07:48:42 INFO - Device ID: 0x0a2e 07:48:42 INFO - Revision ID: 0x0009 07:48:42 INFO - Displays: 07:48:42 INFO - Display: 07:48:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:42 INFO - Display Serial Number: 1600x1200 60 07:48:42 INFO - Main Display: Yes 07:48:42 INFO - Mirror: Off 07:48:42 INFO - Online: Yes 07:48:42 INFO - Rotation: Supported 07:48:42 INFO - Return code: 0 07:48:42 INFO - Running post-action listener: _resource_record_post_action 07:48:42 INFO - [mozharness: 2017-03-28 14:48:42.083635Z] Finished run-tests step (success) 07:48:42 INFO - Running post-run listener: _resource_record_post_run 07:48:42 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39281664; Write bytes: 506953728; Read time: 382; Write time: 1718 07:48:42 INFO - TinderboxPrint: CPU usage
53.9% 07:48:42 INFO - TinderboxPrint: I/O read bytes / time
39,281,664 / 382 07:48:42 INFO - TinderboxPrint: I/O write bytes / time
506,953,728 / 1,718 07:48:42 INFO - TinderboxPrint: CPU idle
2,215.8 (46.1%) 07:48:42 INFO - TinderboxPrint: CPU system
955.7 (19.9%) 07:48:42 INFO - TinderboxPrint: CPU user
1,634.2 (34.0%) 07:48:42 INFO - TinderboxPrint: Swap in / out
246,894,592 / 0 07:48:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207923712; Write bytes: 202868224; Read time: 15846; Write time: 446 07:48:42 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 34452480; Write bytes: 293902848; Read time: 343; Write time: 1231 07:48:42 INFO - Running post-run listener: _upload_blobber_files 07:48:42 INFO - Blob upload gear active. 07:48:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:42 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 07:48:42 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:48:42 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:48:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:43 INFO - (blobuploader) - INFO - Done attempting. 07:48:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:44 INFO - (blobuploader) - INFO - Done attempting. 07:48:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:48:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:48:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:46 INFO - (blobuploader) - INFO - Done attempting. 07:48:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:48:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:48 INFO - (blobuploader) - INFO - Done attempting. 07:48:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:48 INFO - Return code: 0 07:48:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ec7b7d0e21a64eb6f792275278fd92cbe2a6019ceca85c9515adfbe6b3de4c096d8f4bb2f19bfa0b5f5666cc1858607ec591a5920e380067ef8ced8034a8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b278fb2ac1845b3891661a7b44fe3cf9375496ac22a7ec8ee16ae9b2d94b54c1091fa49109dac733479f8c1ff166e681f271fc5e5e31cf10cc5d9986ce8c6449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a196318e5fcc57ac1edcea253f7d718d87a374bb3b568aeeb78ed8d95d1e81f25fa00aae8e2221f7026bb794268fdc545670376080bbf5347fc202faa2cb7e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2e0ed543f3d003b087793e7b52d1e6f1d3ada1aedcea52e2edd9b624d557e410af872714523f2a42b9d2652096211474aeaeea2c2bef85d6e394de1219d4552"} 07:48:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:48 INFO - Contents: 07:48:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ec7b7d0e21a64eb6f792275278fd92cbe2a6019ceca85c9515adfbe6b3de4c096d8f4bb2f19bfa0b5f5666cc1858607ec591a5920e380067ef8ced8034a8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b278fb2ac1845b3891661a7b44fe3cf9375496ac22a7ec8ee16ae9b2d94b54c1091fa49109dac733479f8c1ff166e681f271fc5e5e31cf10cc5d9986ce8c6449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a196318e5fcc57ac1edcea253f7d718d87a374bb3b568aeeb78ed8d95d1e81f25fa00aae8e2221f7026bb794268fdc545670376080bbf5347fc202faa2cb7e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2e0ed543f3d003b087793e7b52d1e6f1d3ada1aedcea52e2edd9b624d557e410af872714523f2a42b9d2652096211474aeaeea2c2bef85d6e394de1219d4552"} 07:48:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:48 INFO - Copying logs to upload dir... 07:48:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.304688 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-28 07:48:48.483225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 07:48:48.487137) ========= 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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-Aurora/sha512/51ec7b7d0e21a64eb6f792275278fd92cbe2a6019ceca85c9515adfbe6b3de4c096d8f4bb2f19bfa0b5f5666cc1858607ec591a5920e380067ef8ced8034a8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b278fb2ac1845b3891661a7b44fe3cf9375496ac22a7ec8ee16ae9b2d94b54c1091fa49109dac733479f8c1ff166e681f271fc5e5e31cf10cc5d9986ce8c6449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a196318e5fcc57ac1edcea253f7d718d87a374bb3b568aeeb78ed8d95d1e81f25fa00aae8e2221f7026bb794268fdc545670376080bbf5347fc202faa2cb7e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2e0ed543f3d003b087793e7b52d1e6f1d3ada1aedcea52e2edd9b624d557e410af872714523f2a42b9d2652096211474aeaeea2c2bef85d6e394de1219d4552"} build_url:https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/H4SfbBbhThewRp4nvW_Ygw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/51ec7b7d0e21a64eb6f792275278fd92cbe2a6019ceca85c9515adfbe6b3de4c096d8f4bb2f19bfa0b5f5666cc1858607ec591a5920e380067ef8ced8034a8f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b278fb2ac1845b3891661a7b44fe3cf9375496ac22a7ec8ee16ae9b2d94b54c1091fa49109dac733479f8c1ff166e681f271fc5e5e31cf10cc5d9986ce8c6449", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2a196318e5fcc57ac1edcea253f7d718d87a374bb3b568aeeb78ed8d95d1e81f25fa00aae8e2221f7026bb794268fdc545670376080bbf5347fc202faa2cb7e3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a2e0ed543f3d003b087793e7b52d1e6f1d3ada1aedcea52e2edd9b624d557e410af872714523f2a42b9d2652096211474aeaeea2c2bef85d6e394de1219d4552"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 07:48:48.522352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:48:48.522733) ========= 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.5JO0PdlFe7/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.xRTOxjEmpr/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.004999 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 07:48:48.571755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 07:48:48.572103) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 07:48:48.572440) ========= ========= Total master_lag: 0.55 =========