builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1490155086.17 results: success (0) buildid: 20170321200735 builduid: 7b83031d305344068192ba6da06213e9 revision: aa03407e251b883e9034796feb2301b9fb68af6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.175180) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.175647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.175920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.202332) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.202638) ========= 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.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-21 20:58:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.3M=0.001s 2017-03-21 20:58:06 (13.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.209076 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.435753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.436064) ========= 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.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.027736 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:06.486234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 20:58:06.486577) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aa03407e251b883e9034796feb2301b9fb68af6e --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 aa03407e251b883e9034796feb2301b9fb68af6e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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-21 20:58:06,586 truncating revision to first 12 chars 2017-03-21 20:58:06,586 Setting DEBUG logging. 2017-03-21 20:58:06,586 attempt 1/10 2017-03-21 20:58:06,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/aa03407e251b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 20:58:07,337 unpacking tar archive at: mozilla-aurora-aa03407e251b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.027398 ========= master_lag: 1.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-21 20:58:08.790784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:08.791097) ========= script_repo_revision: aa03407e251b883e9034796feb2301b9fb68af6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:08.791858) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:08.792117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 20:58:08.817758) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 20:58:08.818120) ========= /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.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:58:09 INFO - MultiFileLogger online at 20170321 20:58:09 in /builds/slave/test 20:58:09 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 20:58:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:58:09 INFO - {'append_to_log': False, 20:58:09 INFO - 'base_work_dir': '/builds/slave/test', 20:58:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:58:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:58:09 INFO - 'branch': 'Mozilla-Aurora', 20:58:09 INFO - 'buildbot_json_path': 'buildprops.json', 20:58:09 INFO - 'config_files': ('talos/mac_config.py',), 20:58:09 INFO - 'default_actions': ('clobber', 20:58:09 INFO - 'read-buildbot-config', 20:58:09 INFO - 'download-and-extract', 20:58:09 INFO - 'populate-webroot', 20:58:09 INFO - 'create-virtualenv', 20:58:09 INFO - 'install', 20:58:09 INFO - 'run-tests'), 20:58:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:58:09 INFO - 'download_minidump_stackwalk': True, 20:58:09 INFO - 'download_symbols': 'ondemand', 20:58:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:58:09 INFO - 'tooltool.py': '/tools/tooltool.py', 20:58:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:58:09 INFO - '/tools/misc-python/virtualenv.py')}, 20:58:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:58:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:58:09 INFO - 'gecko_profile': False, 20:58:09 INFO - 'gecko_profile_interval': 0, 20:58:09 INFO - 'installer_path': 'installer.exe', 20:58:09 INFO - 'log_level': 'info', 20:58:09 INFO - 'log_name': 'talos', 20:58:09 INFO - 'log_to_console': True, 20:58:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:58:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:58:09 INFO - 'opt_config_files': (), 20:58:09 INFO - 'pip_index': False, 20:58:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:58:09 INFO - 'cmd': ('bash', 20:58:09 INFO - '-c', 20:58:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:58:09 INFO - 'enabled': True, 20:58:09 INFO - 'halt_on_failure': False, 20:58:09 INFO - 'name': 'check_screen_resolution'},), 20:58:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:58:09 INFO - 'cmd': ('bash', 20:58:09 INFO - '-c', 20:58:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:58:09 INFO - 'enabled': True, 20:58:09 INFO - 'halt_on_failure': False, 20:58:09 INFO - 'name': 'check_screen_resolution'},), 20:58:09 INFO - 'run_cmd_checks_enabled': True, 20:58:09 INFO - 'suite': 'dromaeojs', 20:58:09 INFO - 'system_bits': '32', 20:58:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:58:09 INFO - 'title': 't-yosemite-r7-0023', 20:58:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:58:09 INFO - 'use_talos_json': True, 20:58:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:58:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:58:09 INFO - 'work_dir': 'build'} 20:58:09 INFO - [mozharness: 2017-03-22 03:58:09.031483Z] Running clobber step. 20:58:09 INFO - Running pre-action listener: _resource_record_pre_action 20:58:09 INFO - Running main action method: clobber 20:58:09 INFO - rmtree: /builds/slave/test/build 20:58:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:58:11 INFO - Running post-action listener: _resource_record_post_action 20:58:11 INFO - [mozharness: 2017-03-22 03:58:11.550520Z] Finished clobber step (success) 20:58:11 INFO - [mozharness: 2017-03-22 03:58:11.550650Z] Running read-buildbot-config step. 20:58:11 INFO - Running pre-action listener: _resource_record_pre_action 20:58:11 INFO - Running main action method: read_buildbot_config 20:58:11 INFO - Using buildbot properties: 20:58:11 INFO - { 20:58:11 INFO - "project": "", 20:58:11 INFO - "product": "firefox", 20:58:11 INFO - "script_repo_revision": "production", 20:58:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 20:58:11 INFO - "repository": "", 20:58:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 20:58:11 INFO - "buildid": "20170321200735", 20:58:11 INFO - "pgo_build": "False", 20:58:11 INFO - "basedir": "/builds/slave/test", 20:58:11 INFO - "buildnumber": 16, 20:58:11 INFO - "slavename": "t-yosemite-r7-0023", 20:58:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:58:11 INFO - "platform": "yosemite_r7", 20:58:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:58:11 INFO - "branch": "mozilla-aurora", 20:58:11 INFO - "repo_path": "releases/mozilla-aurora", 20:58:11 INFO - "revision": "aa03407e251b883e9034796feb2301b9fb68af6e", 20:58:11 INFO - "stage_platform": "macosx64", 20:58:11 INFO - "builduid": "7b83031d305344068192ba6da06213e9", 20:58:11 INFO - "slavebuilddir": "test" 20:58:11 INFO - } 20:58:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 20:58:11 INFO - Running post-action listener: _resource_record_post_action 20:58:11 INFO - [mozharness: 2017-03-22 03:58:11.554071Z] Finished read-buildbot-config step (success) 20:58:11 INFO - [mozharness: 2017-03-22 03:58:11.554217Z] Running download-and-extract step. 20:58:11 INFO - Running pre-action listener: _resource_record_pre_action 20:58:11 INFO - Running main action method: download_and_extract 20:58:11 INFO - mkdir: /builds/slave/test/build/tests 20:58:11 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')]} 20:58:11 INFO - trying https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 20:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/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 20:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/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 20:58:12 INFO - Downloaded 1199 bytes. 20:58:12 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 20:58:12 INFO - Using the following test package requirements: 20:58:12 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:58:12 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 20:58:12 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 20:58:12 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'jsshell-mac.zip'], 20:58:12 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 20:58:12 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 20:58:12 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 20:58:12 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 20:58:12 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 20:58:12 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 20:58:12 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 20:58:12 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:58:14 INFO - Expected file size: 51782017 20:58:14 INFO - Obtained file size: 51782017 20:58:30 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 20:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 20:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 20:58:32 INFO - Expected file size: 51782017 20:58:32 INFO - Obtained file size: 51782017 20:58:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 20:58:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:58:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 20:58:48 INFO - Expected file size: 14404438 20:58:48 INFO - Obtained file size: 14404438 20:58:48 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')]} 20:58:48 INFO - trying https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:58:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 20:58:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/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 20:58:50 INFO - Downloaded 74694700 bytes. 20:58:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:58:50 INFO - mkdir: /builds/slave/test/properties 20:58:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:58:50 INFO - Writing to file /builds/slave/test/properties/build_url 20:58:50 INFO - Contents: 20:58:50 INFO - build_url:https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 20:58:51 INFO - Running post-action listener: _resource_record_post_action 20:58:51 INFO - Running post-action listener: set_extra_try_arguments 20:58:51 INFO - [mozharness: 2017-03-22 03:58:51.126528Z] Finished download-and-extract step (success) 20:58:51 INFO - [mozharness: 2017-03-22 03:58:51.126673Z] Running populate-webroot step. 20:58:51 INFO - Running pre-action listener: _resource_record_pre_action 20:58:51 INFO - Running main action method: populate_webroot 20:58:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:58:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:58:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:58:51 INFO - '--tppagecycles', 20:58:51 INFO - '7'], 20:58:51 INFO - 'tests': ['tsvgm']}}, 20:58:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:58:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:58:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:58:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:58:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['damp', 'tps']}, 20:58:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'tests': ['damp', 'tps']}, 20:58:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['dromaeo_dom']}, 20:58:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:58:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['basic_compositor_video']}, 20:58:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:58:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['a11yr', 20:58:51 INFO - 'ts_paint', 20:58:51 INFO - 'tpaint', 20:58:51 INFO - 'sessionrestore', 20:58:51 INFO - 'sessionrestore_no_auto_restore', 20:58:51 INFO - 'tabpaint']}, 20:58:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['tsvgx', 20:58:51 INFO - 'tsvgr_opacity', 20:58:51 INFO - 'tart', 20:58:51 INFO - 'tscrollx', 20:58:51 INFO - 'cart', 20:58:51 INFO - 'tsvg_static']}, 20:58:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:58:51 INFO - 'tsvgr_opacity', 20:58:51 INFO - 'tart', 20:58:51 INFO - 'tscrollx', 20:58:51 INFO - 'cart', 20:58:51 INFO - 'tsvg_static']}, 20:58:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'talos_options': ['--disable-e10s'], 20:58:51 INFO - 'tests': ['tp5o']}, 20:58:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:58:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'talos_options': ['--disable-e10s', 20:58:51 INFO - '--xperf_path', 20:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:51 INFO - 'tests': ['tp5n']}, 20:58:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:58:51 INFO - 'talos_options': ['--xperf_path', 20:58:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:51 INFO - 'tests': ['tp5n']}}, 20:58:51 INFO - 'talos.zip': {'path': '', 20:58:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:58:51 INFO - Running post-action listener: _resource_record_post_action 20:58:51 INFO - [mozharness: 2017-03-22 03:58:51.145092Z] Finished populate-webroot step (success) 20:58:51 INFO - [mozharness: 2017-03-22 03:58:51.145213Z] Running create-virtualenv step. 20:58:51 INFO - Running pre-action listener: _resource_record_pre_action 20:58:51 INFO - Running main action method: create_virtualenv 20:58:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:58:51 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 20:58:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:58:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:58:51 INFO - Using real prefix '/tools/python27' 20:58:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:58:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:58:54 INFO - Installing pip.................done. 20:58:54 INFO - Return code: 0 20:58:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:58:55 INFO - Reading from file tmpfile_stdout 20:58:55 INFO - Output received: 20:58:55 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) 20:58:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:58:55 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')]} 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:55 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')]} 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:55 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:58:55 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 20:58:55 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 20:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:55 INFO - 'HOME': '/Users/cltbld', 20:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:55 INFO - 'LOGNAME': 'cltbld', 20:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:55 INFO - 'MOZ_NO_REMOTE': '1', 20:58:55 INFO - 'NO_EM_RESTART': '1', 20:58:55 INFO - 'PAGER': '/bin/cat', 20:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:55 INFO - 'PWD': '/builds/slave/test', 20:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:55 INFO - 'SHELL': '/bin/bash', 20:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:58:55 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:55 INFO - 'USER': 'cltbld', 20:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:55 INFO - 'XPC_FLAGS': '0x0', 20:58:55 INFO - 'XPC_SERVICE_NAME': '0', 20:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:55 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 20:58:55 INFO - Cleaning up... 20:58:55 INFO - Return code: 0 20:58:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:58:55 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')]} 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:55 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')]} 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:55 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:58:55 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 20:58:55 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 20:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:58:55 INFO - 'HOME': '/Users/cltbld', 20:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:58:55 INFO - 'LOGNAME': 'cltbld', 20:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:55 INFO - 'MOZ_NO_REMOTE': '1', 20:58:55 INFO - 'NO_EM_RESTART': '1', 20:58:55 INFO - 'PAGER': '/bin/cat', 20:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:55 INFO - 'PWD': '/builds/slave/test', 20:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:58:55 INFO - 'SHELL': '/bin/bash', 20:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:58:55 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:58:55 INFO - 'USER': 'cltbld', 20:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:55 INFO - 'XPC_FLAGS': '0x0', 20:58:55 INFO - 'XPC_SERVICE_NAME': '0', 20:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:55 INFO - Downloading/unpacking psutil>=3.1.1 20:58:55 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 20:58:55 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 20:58:55 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 20:58:55 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 20:58:55 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 20:58:55 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 20:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:58:59 INFO - Installing collected packages: psutil 20:58:59 INFO - Running setup.py install for psutil 20:58:59 INFO - building 'psutil._psutil_osx' extension 20:58:59 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 20:58:59 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 20:58:59 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 20:59:00 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 20:59:00 INFO - building 'psutil._psutil_posix' extension 20:59:00 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 20:59:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:59:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:59:00 INFO - ^ 20:59:00 INFO - 1 warning generated. 20:59:00 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 20:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:59:00 INFO - Successfully installed psutil 20:59:00 INFO - Cleaning up... 20:59:00 INFO - Return code: 0 20:59:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:00 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:00 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 20:59:00 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 20:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:00 INFO - 'HOME': '/Users/cltbld', 20:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:00 INFO - 'LOGNAME': 'cltbld', 20:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:00 INFO - 'MOZ_NO_REMOTE': '1', 20:59:00 INFO - 'NO_EM_RESTART': '1', 20:59:00 INFO - 'PAGER': '/bin/cat', 20:59:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:00 INFO - 'PWD': '/builds/slave/test', 20:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:00 INFO - 'SHELL': '/bin/bash', 20:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:00 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:00 INFO - 'USER': 'cltbld', 20:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:00 INFO - 'XPC_FLAGS': '0x0', 20:59:00 INFO - 'XPC_SERVICE_NAME': '0', 20:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:00 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 20:59:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:59:03 INFO - Installing collected packages: mozsystemmonitor 20:59:03 INFO - Running setup.py install for mozsystemmonitor 20:59:03 INFO - Successfully installed mozsystemmonitor 20:59:03 INFO - Cleaning up... 20:59:03 INFO - Return code: 0 20:59:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:04 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')]} 20:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:04 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:04 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 20:59:04 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 20:59:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:04 INFO - 'HOME': '/Users/cltbld', 20:59:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:04 INFO - 'LOGNAME': 'cltbld', 20:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:04 INFO - 'MOZ_NO_REMOTE': '1', 20:59:04 INFO - 'NO_EM_RESTART': '1', 20:59:04 INFO - 'PAGER': '/bin/cat', 20:59:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:04 INFO - 'PWD': '/builds/slave/test', 20:59:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:04 INFO - 'SHELL': '/bin/bash', 20:59:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:04 INFO - 'USER': 'cltbld', 20:59:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:04 INFO - 'XPC_FLAGS': '0x0', 20:59:04 INFO - 'XPC_SERVICE_NAME': '0', 20:59:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:04 INFO - Downloading/unpacking jsonschema==2.5.1 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:04 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 20:59:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:59:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:59:07 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 20:59:07 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 20:59:07 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 20:59:07 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 20:59:07 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 20:59:07 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 20:59:08 INFO - Downloading functools32-3.2.3-2.tar.gz 20:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:59:08 INFO - warning: no files found matching '*.txt' 20:59:08 INFO - no previously-included directories found matching 'build' 20:59:08 INFO - no previously-included directories found matching 'dist' 20:59:08 INFO - no previously-included directories found matching '.git*' 20:59:08 INFO - Installing collected packages: jsonschema, functools32 20:59:08 INFO - Running setup.py install for functools32 20:59:08 INFO - warning: no files found matching '*.txt' 20:59:08 INFO - no previously-included directories found matching 'build' 20:59:08 INFO - no previously-included directories found matching 'dist' 20:59:08 INFO - no previously-included directories found matching '.git*' 20:59:08 INFO - Successfully installed jsonschema functools32 20:59:08 INFO - Cleaning up... 20:59:08 INFO - Return code: 0 20:59:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:08 INFO - 'HOME': '/Users/cltbld', 20:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:08 INFO - 'LOGNAME': 'cltbld', 20:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:08 INFO - 'MOZ_NO_REMOTE': '1', 20:59:08 INFO - 'NO_EM_RESTART': '1', 20:59:08 INFO - 'PAGER': '/bin/cat', 20:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:08 INFO - 'PWD': '/builds/slave/test', 20:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:08 INFO - 'SHELL': '/bin/bash', 20:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:08 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:08 INFO - 'USER': 'cltbld', 20:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:08 INFO - 'XPC_FLAGS': '0x0', 20:59:08 INFO - 'XPC_SERVICE_NAME': '0', 20:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:59:08 INFO - Cleaning up... 20:59:08 INFO - Return code: 0 20:59:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:59:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:08 INFO - 'HOME': '/Users/cltbld', 20:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:08 INFO - 'LOGNAME': 'cltbld', 20:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:08 INFO - 'MOZ_NO_REMOTE': '1', 20:59:08 INFO - 'NO_EM_RESTART': '1', 20:59:08 INFO - 'PAGER': '/bin/cat', 20:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:08 INFO - 'PWD': '/builds/slave/test', 20:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:08 INFO - 'SHELL': '/bin/bash', 20:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:08 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:08 INFO - 'USER': 'cltbld', 20:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:08 INFO - 'XPC_FLAGS': '0x0', 20:59:08 INFO - 'XPC_SERVICE_NAME': '0', 20:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:09 INFO - Downloading/unpacking blobuploader==1.2.4 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:09 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 20:59:11 INFO - Downloading blobuploader-1.2.4.tar.gz 20:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:59:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:59:12 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 20:59:12 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 20:59:12 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 20:59:12 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 20:59:12 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 20:59:12 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 20:59:12 INFO - Downloading docopt-0.6.1.tar.gz 20:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:59:13 INFO - Installing collected packages: blobuploader, requests, docopt 20:59:13 INFO - Running setup.py install for blobuploader 20:59:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:59:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:59:13 INFO - Running setup.py install for requests 20:59:13 INFO - Running setup.py install for docopt 20:59:13 INFO - Successfully installed blobuploader requests docopt 20:59:13 INFO - Cleaning up... 20:59:14 INFO - Return code: 0 20:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:14 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')]} 20:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:14 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')]} 20:59:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:14 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:14 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 20:59:14 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 20:59:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:14 INFO - 'HOME': '/Users/cltbld', 20:59:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:14 INFO - 'LOGNAME': 'cltbld', 20:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:14 INFO - 'MOZ_NO_REMOTE': '1', 20:59:14 INFO - 'NO_EM_RESTART': '1', 20:59:14 INFO - 'PAGER': '/bin/cat', 20:59:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:14 INFO - 'PWD': '/builds/slave/test', 20:59:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:14 INFO - 'SHELL': '/bin/bash', 20:59:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:14 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:14 INFO - 'USER': 'cltbld', 20:59:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:14 INFO - 'XPC_FLAGS': '0x0', 20:59:14 INFO - 'XPC_SERVICE_NAME': '0', 20:59:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ckZOHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-wp2Sri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WqBpaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-XooB3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MW6NaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-B9kiWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:14 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-FgsNDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-j52i2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-WzO1S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CCCvOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-1nPTQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AWvJjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-KfVDZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-g60TpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-lWcZwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zuY_Zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:15 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-smErai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:59:16 INFO - Running setup.py install for manifestparser 20:59:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:59:16 INFO - Running setup.py install for mozcrash 20:59:16 INFO - Running setup.py install for mozdebug 20:59:16 INFO - Running setup.py install for mozdevice 20:59:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:59:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:59:16 INFO - Running setup.py install for mozfile 20:59:16 INFO - Running setup.py install for mozhttpd 20:59:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:59:16 INFO - Running setup.py install for mozinfo 20:59:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Running setup.py install for mozInstall 20:59:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Running setup.py install for mozleak 20:59:17 INFO - Running setup.py install for mozlog 20:59:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Running setup.py install for moznetwork 20:59:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:59:17 INFO - Running setup.py install for mozprocess 20:59:17 INFO - Running setup.py install for mozprofile 20:59:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:59:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:59:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:59:18 INFO - Running setup.py install for mozrunner 20:59:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:59:18 INFO - Running setup.py install for mozscreenshot 20:59:18 INFO - Running setup.py install for moztest 20:59:18 INFO - Running setup.py install for mozversion 20:59:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:59:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:59:18 INFO - Cleaning up... 20:59:18 INFO - Return code: 0 20:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:18 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:18 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 20:59:18 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 20:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:18 INFO - 'HOME': '/Users/cltbld', 20:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:18 INFO - 'LOGNAME': 'cltbld', 20:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:18 INFO - 'MOZ_NO_REMOTE': '1', 20:59:18 INFO - 'NO_EM_RESTART': '1', 20:59:18 INFO - 'PAGER': '/bin/cat', 20:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:18 INFO - 'PWD': '/builds/slave/test', 20:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:18 INFO - 'SHELL': '/bin/bash', 20:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:18 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:18 INFO - 'USER': 'cltbld', 20:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:18 INFO - 'XPC_FLAGS': '0x0', 20:59:18 INFO - 'XPC_SERVICE_NAME': '0', 20:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-D7a2VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-4Cx9be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MGbSpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-fsIPf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l9KsFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-PuuMkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-IW89Yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-voqfk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AoeAvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:19 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)) 20:59:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:19 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-NxNVO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CVbh4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-eEnKvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DrNdQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-YwusG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LmpXm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-FAwMyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:20 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)) 20:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:20 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l0pEMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:20 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)) 20:59:20 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)) 20:59:20 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)) 20:59:20 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)) 20:59:20 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)) 20:59:20 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)) 20:59:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:23 INFO - Downloading blessings-1.6.tar.gz 20:59:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:59:23 INFO - Installing collected packages: blessings 20:59:23 INFO - Running setup.py install for blessings 20:59:23 INFO - Successfully installed blessings 20:59:23 INFO - Cleaning up... 20:59:23 INFO - Return code: 0 20:59:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:59:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:24 INFO - Reading from file tmpfile_stdout 20:59:24 INFO - Current package versions: 20:59:24 INFO - blessings == 1.6 20:59:24 INFO - blobuploader == 1.2.4 20:59:24 INFO - docopt == 0.6.1 20:59:24 INFO - functools32 == 3.2.3-2 20:59:24 INFO - jsonschema == 2.5.1 20:59:24 INFO - manifestparser == 1.1 20:59:24 INFO - mozInstall == 1.12 20:59:24 INFO - mozcrash == 1.0 20:59:24 INFO - mozdebug == 0.1 20:59:24 INFO - mozdevice == 0.49 20:59:24 INFO - mozfile == 1.2 20:59:24 INFO - mozhttpd == 0.7 20:59:24 INFO - mozinfo == 0.9 20:59:24 INFO - mozleak == 0.1 20:59:24 INFO - mozlog == 3.4 20:59:24 INFO - moznetwork == 0.27 20:59:24 INFO - mozprocess == 0.25 20:59:24 INFO - mozprofile == 0.28 20:59:24 INFO - mozrunner == 6.13 20:59:24 INFO - mozscreenshot == 0.1 20:59:24 INFO - mozsystemmonitor == 0.3 20:59:24 INFO - moztest == 0.8 20:59:24 INFO - mozversion == 1.4 20:59:24 INFO - psutil == 3.1.1 20:59:24 INFO - requests == 1.2.3 20:59:24 INFO - wsgiref == 0.1.2 20:59:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:24 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 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59:24 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 20:59:24 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 20:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:24 INFO - 'HOME': '/Users/cltbld', 20:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:24 INFO - 'LOGNAME': 'cltbld', 20:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:24 INFO - 'MOZ_NO_REMOTE': '1', 20:59:24 INFO - 'NO_EM_RESTART': '1', 20:59:24 INFO - 'PAGER': '/bin/cat', 20:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:24 INFO - 'PWD': '/builds/slave/test', 20:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:24 INFO - 'SHELL': '/bin/bash', 20:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:24 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:24 INFO - 'USER': 'cltbld', 20:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:24 INFO - 'XPC_FLAGS': '0x0', 20:59:24 INFO - 'XPC_SERVICE_NAME': '0', 20:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 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)) 20:59:24 INFO - Cleaning up... 20:59:24 INFO - Return code: 0 20:59:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a2c7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a2ca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d2ad59670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, '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.74om74APRt/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.e5LUtJ82vk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 20:59: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', 'jsonschema'] in /builds/slave/test/build 20:59: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 jsonschema 20:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:24 INFO - 'HOME': '/Users/cltbld', 20:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:24 INFO - 'LOGNAME': 'cltbld', 20:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:24 INFO - 'MOZ_NO_REMOTE': '1', 20:59:24 INFO - 'NO_EM_RESTART': '1', 20:59:24 INFO - 'PAGER': '/bin/cat', 20:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:24 INFO - 'PWD': '/builds/slave/test', 20:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:24 INFO - 'SHELL': '/bin/bash', 20:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:24 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:24 INFO - 'USER': 'cltbld', 20:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:24 INFO - 'XPC_FLAGS': '0x0', 20:59:24 INFO - 'XPC_SERVICE_NAME': '0', 20:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:59:24 INFO - Cleaning up... 20:59:24 INFO - Return code: 0 20:59:24 INFO - Running post-action listener: _resource_record_post_action 20:59:24 INFO - Running post-action listener: _start_resource_monitoring 20:59:24 INFO - Starting resource monitoring. 20:59:24 INFO - [mozharness: 2017-03-22 03:59:24.695979Z] Finished create-virtualenv step (success) 20:59:24 INFO - [mozharness: 2017-03-22 03:59:24.696926Z] Running install step. 20:59:24 INFO - Running pre-action listener: _resource_record_pre_action 20:59:24 INFO - Running main action method: install 20:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:24 INFO - Reading from file tmpfile_stdout 20:59:24 INFO - Detecting whether we're running mozinstall >=1.0... 20:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:59:25 INFO - Reading from file tmpfile_stdout 20:59:25 INFO - Output received: 20:59:25 INFO - Usage: mozinstall [options] installer 20:59:25 INFO - Options: 20:59:25 INFO - -h, --help show this help message and exit 20:59:25 INFO - -d DEST, --destination=DEST 20:59:25 INFO - Directory to install application into. [default: 20:59:25 INFO - "/builds/slave/test"] 20:59:25 INFO - --app=APP Application being installed. [default: firefox] 20:59:25 INFO - mkdir: /builds/slave/test/build/application 20:59:25 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'] 20:59:25 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 20:59:45 INFO - Reading from file tmpfile_stdout 20:59:45 INFO - Output received: 20:59:45 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:59:45 INFO - Running post-action listener: _resource_record_post_action 20:59:45 INFO - [mozharness: 2017-03-22 03:59:45.262070Z] Finished install step (success) 20:59:45 INFO - [mozharness: 2017-03-22 03:59:45.262215Z] Running run-tests step. 20:59:45 INFO - Running pre-action listener: _resource_record_pre_action 20:59:45 INFO - Running main action method: run_tests 20:59:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:59:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:59:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:59:45 INFO - 2017-03-21 20:59:45.276 screenresolution[1626:7440] starting screenresolution argv=screenresolution get 20:59:45 INFO - 2017-03-21 20:59:45.279 screenresolution[1626:7440] Display 0: 1600x1200x32@60 20:59:45 INFO - 2017-03-21 20:59:45.285 screenresolution[1627:7443] starting screenresolution argv=screenresolution list 20:59:45 INFO - Available Modes on Display 0 20:59:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:59:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:59:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:59:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:59:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:59:45 INFO - Intel Iris: 20:59:45 INFO - Chipset Model: Intel Iris 20:59:45 INFO - Type: GPU 20:59:45 INFO - Bus: Built-In 20:59:45 INFO - VRAM (Dynamic, Max): 1536 MB 20:59:45 INFO - Vendor: Intel (0x8086) 20:59:45 INFO - Device ID: 0x0a2e 20:59:45 INFO - Revision ID: 0x0009 20:59:45 INFO - Displays: 20:59:45 INFO - Display: 20:59:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:59:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:59:45 INFO - Display Serial Number: 1600x1200 60 20:59:45 INFO - Main Display: Yes 20:59:45 INFO - Mirror: Off 20:59:45 INFO - Online: Yes 20:59:45 INFO - Rotation: Supported 20:59:45 INFO - Return code: 0 20:59:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:59:45 INFO - Python 2.7.3 20:59:45 INFO - Return code: 0 20:59:45 INFO - grabbing minidump binary from tooltool 20:59:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:59:45 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 0x10a0a5d30>, '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 0x109fccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a09abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:59:45 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 20:59:45 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 20:59:45 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 20:59:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:59:45 INFO - Return code: 0 20:59:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:59:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:59:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:59:45 INFO - ENV: RUST_BACKTRACE is now 1 20:59:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:59:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:59:45 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/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 20:59:45 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/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 20:59:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.74om74APRt/Render', 20:59:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:59:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:59:45 INFO - 'HOME': '/Users/cltbld', 20:59:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:59:45 INFO - 'LOGNAME': 'cltbld', 20:59:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:59:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:45 INFO - 'MOZ_NO_REMOTE': '1', 20:59:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:59:45 INFO - 'NO_EM_RESTART': '1', 20:59:45 INFO - 'PAGER': '/bin/cat', 20:59:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:45 INFO - 'PWD': '/builds/slave/test', 20:59:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:59:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:59:45 INFO - 'RUST_BACKTRACE': '1', 20:59:45 INFO - 'SHELL': '/bin/bash', 20:59:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5LUtJ82vk/Listeners', 20:59:45 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 20:59:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:59:45 INFO - 'USER': 'cltbld', 20:59:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:59:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:45 INFO - 'XPC_FLAGS': '0x0', 20:59:45 INFO - 'XPC_SERVICE_NAME': '0', 20:59:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:59:45 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/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 20:59:45 INFO - mozversion application_buildid: 20170321200735 20:59:45 INFO - mozversion application_changeset: aa03407e251b883e9034796feb2301b9fb68af6e 20:59:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:59:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:59:45 INFO - mozversion application_name: Firefox 20:59:45 INFO - mozversion application_remotingname: firefox-dev 20:59:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:59:45 INFO - mozversion application_vendor: Mozilla 20:59:45 INFO - mozversion application_version: 54.0a2 20:59:45 INFO - mozversion platform_buildid: 20170321200735 20:59:45 INFO - mozversion platform_changeset: aa03407e251b883e9034796feb2301b9fb68af6e 20:59:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:59:45 INFO - mozversion platform_version: 54.0a2 20:59:45 INFO - using testdate: 1490155185 20:59:45 INFO - actual date: 1490155185 20:59:45 INFO - starting webserver on 'localhost:49249' 20:59:45 INFO - SUITE-START | Running 2 tests 20:59:45 INFO - TEST-START | dromaeo_css 20:59:45 INFO - operating with platform_type : mac_ 20:59:45 INFO - Initialising browser for dromaeo_css test... 20:59:45 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpeZt8oT/profile http://localhost:49249/getInfo.html) 20:59:48 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 20:59:48 INFO - PROCESS | 1637 | colorDepth:24 20:59:48 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 20:59:48 INFO - PROCESS | 1637 | __metrics 20:59:48 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:59:48 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:59:49 INFO - TEST-INFO | 1637: exit 0 20:59:49 INFO - Browser initialized. 20:59:49 INFO - Running cycle 1/1 for dromaeo_css test... 20:59:49 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpeZt8oT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:00:01 INFO - PROCESS | 1639 | RSS: Main: 214704128 21:00:01 INFO - PROCESS | 1639 | 21:03:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 21:03:07 INFO - PROCESS | 1639 | RSS: Main: 377638912 21:03:07 INFO - PROCESS | 1639 | 21:04:50 INFO - PROCESS | 1639 | ************************* 21:04:50 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 21:04:50 INFO - PROCESS | 1639 | 21:04:50 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:04:50 INFO - PROCESS | 1639 | Full stack: 21:04:50 INFO - PROCESS | 1639 | ************************* 21:06:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 21:06:11 INFO - PROCESS | 1639 | RSS: Main: 350810112 21:06:11 INFO - PROCESS | 1639 | 21:09:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 21:09:14 INFO - PROCESS | 1639 | RSS: Main: 334761984 21:09:14 INFO - PROCESS | 1639 | 21:12:16 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 21:12:17 INFO - PROCESS | 1639 | RSS: Main: 314060800 21:12:17 INFO - PROCESS | 1639 | 21:15:21 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 21:15:21 INFO - PROCESS | 1639 | RSS: Main: 324288512 21:15:21 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 21:18:25 INFO - PROCESS | 1639 | RSS: Main: 412086272 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | __start_tp_report 21:18:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 21:18:25 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 21:18:25 INFO - PROCESS | 1639 | |i|pagename|runs| 21:18:25 INFO - PROCESS | 1639 | |0;dojo.html;2922.371690086631;3271.525628783828;3419.623841377449;3449.085992212066;3476.096214984105;6021.879562408754;6054.061620448838;6061.66660833654;6089.573729838913;6092.482139018183;6030.427109424609;6088.908666370008;6112.724927378267;6114.082887566856;6117.2659280886355;5384.946150538503;5411.945880541183;5444;5451.454854514556;5544.251526043993;5315.388730296027;5340.49265319794;5366.543843773284;5518.420565840589;5527.972360138214;5403.243545903577;5405.810796622119;5425.83722488326;5433.755481003344;5439.211314359415;4860.684055536414;5017.7491125443585;5405.243265942771;5422.75597598107;5425.294711687475;5268.394134674485;5351.304330437058;5357.383900851413;5368.114261146906;5389.83830485086;4953.876153096166;5896.498797602209;5981.700914954278;5999.010163323046;6018.789342372996;6267.655278959655;6332.525060620425;6356.14192084072;6358.0462930560325;6358.395952384516;6478.54650174488;6481.962885938275;6483.837904052436;6492.350764923517;6499.740010399579;6083.117947897575;6144;6155.507559395282;6161.7227224775;6182.072689096626;6331.873362532723;6377.617342959437;6626.337366263431;6639.93360066398;6648.33516648341;6329.240491141092;6342.587731797418;6355.459785918156;6355.809325720235;6398.136251606066;6462.095306657072;6466.35336466359;6484.805455836333;6495.090687303781;6506.577072490273;5056.570191533688;6402.199725034371;6418.422341989243;6423.967880160662;6434.067060276234;4927.43334516528;5796.9855275326645;6243.250809902841;6261.405166509175;6348.428641422294;5154.252633368141;5161.896762064813;5164.1995490699;5164.8967020659375;5185.170372740419;4602.861914142581;4605.078984203173;4610.170169369546;4621.584057434779;4642.048380082075;5809.564282678816;5914.615549989237;5971.880562388728;6069.908951365733;6131.202943617302;5471.316085489314;6438.967805160944;6483.805485835433;6489;6493.026046093124;6107.603005804608;6108.75564977396;6112.388761123941;6114.847128821815;6126.908096378558;5448.727563621803;5551.1673249012165;5715.371309155989;5727.165973369421;5759.337676167294;6425.550211485244;6493.805185844432;6514.120593719787;6642.5018123641885;6657.53397262187;6399.072134540559;6400.871982560229;6406.295307516077;6406.295307516262;6412.070249813844;6344.365563443804;6573.5398522103;6575.255544649643;6586.604803711793;6639.734410623521;6328.936710633019;6342.746290148527;6356.300806911144;6358.650274234777;6393.29673735898;6383.39357761012;6401.295857455583;6412.454941330039;6416.615003099829;6425.10048593188;6292.2449306081735;6346.7461301549265;6351.809445716636;6356.300806911328;6374.4263016326895;6131.325554189125;6169.96915015422;6176.969115154575;6270;6368.490520758235;5240.449752775904;6281.623102613858;6305.40098690642;6318.4313411793155;6325.4939604832425;6199.721012554356;6269.717862696099;6333.398327159097;6358.364163583789;6376.9043464349;6080;6241.407066328691;6290.24517057956;6326.304106548184;6335.714892829926 21:18:25 INFO - PROCESS | 1639 | |1;ext.html;747.5365273530408;794.4319811334897;813.0324913353111;872.7556284240414;887.6227603268609;28046.878124875006;39712.60287397125;40382;40396.59603403965;40445.3933191002;41109.58890411095;41304.17391652165;41320.38019429703;41330.58669413305;41338.793306033425;7506.361959233472;9147.039560846099;9306.255499560019;9312.674056408026;9315.580798864034;7487.850242995137;11089.445527723581;11331.490082946246;11415.714607134847;11459.942700286487;11264.155188360864;11270.605528806493;11275.379854108021;11297.322160670345;11304.434778261095;11220;11237.662870113909;11249.66251012471;11271.041961433206;11285.717857053598;7387.482876198668;7559.924400756032;10896.073833724144;11156.274842135235;11175.552977880876;39512;39683.60316396857;39731.60268397337;39734.20531589352;39759.00602484961;3765.3222419964395;3801.8289176986827;3813.199228162089;3832.386818109117;3944.112574670705;27529.31176720578;27630;28509.429811403657;29599.26001849971;29649.555256671167;3063.9888836684063;3112.439760843047;3139.748820094387;3142.1673256587023;3147.1817327495014;279720.6013969917;319573;325432;325567;326740;53244.46755532473;53288;53406.46593534093;53418.46581534135;53518.73240633772;55684.44315556873;55718;55831.72084139553;55845.441545584836;55864;11298.152638552141;13629;14333.64165895861;14456.927715361357;14483.275836208359;10454;12321.199122057038;12341.69145771345;12344.3827808611;12365.75268494643;11056.447177641086;12670.303133327756;12914.67713307156;12989.4154763034;13271.004674649439;4728.125296820031;5440.591955603346;5560.138178582326;5594.608377413542;5601.439856014447;1073.2594509788378;1076.8115579773664;1084.7233955341337;1116.1126904111252;1134.2362079267111;22019.11923523041;27481.86259068692;27944.021959231737;28092.297692557848;28124.43751124966;983.0513554420019;1003.9297249192487;1143.7941170589208;1150.930944143354;1203.7652657731658;13836.169829810244;14193.574192774233;14291;14644;14647.414103435744;439412;440483;441070.5892941094;441189.7940510341;441716.79141604085;45082.54917450783;56091;56174.7191264041;56193;56245;1404.592668126232;1467.4057006912217;1467.4790449390312;1469.8750606198594;1472.2491529320123;26879.731202687723;27021.189364319103;27606.5859012119;28395.574066389432;28459;47498.76250618863;47764.5223547774;47813.760931195124;47831.804204895154;47840.7607961958;461485;465036;466234;466875;467535;24938.501229974936;30168.396632066797;30241.487925603193;30296.242593935327;30297.091087267418;31400;33784.66215337815;38991;41667.58332416637;41756;32362.352752944338;32374.676253238107;33000.50499242562;33928.83035584806;34285.31429371449;32462.675373245966;33094.79345633843;33735;33885.49171762475;33915.830420848724;32507.031652339225;33130.337393252485;33320.1669958253;33496.83251583727;33537;27193.1842044739;30054;30323.696763032087;30364;31192.37615247637;21145.78854211438;22248.88755562183;22843.31470055901;23642.763572364056;23744.050237990286 21:18:25 INFO - PROCESS | 1639 | |2;jquery.html;368.3241252302026;378.249175386857;406.81083296267246;421.90928950275685;446.3639313977581;13071.281079540622;15027.699446011087;21546.245881394174;22046.33860984169;22172;22474.66288005677;22900.427489312777;23061.192858249964;23363.299101026954;23441.29676109715;6286.685665716707;6459.386358295955;6527.608343499405;6569.7700580479695;6597.80206593803;6261.812145635638;6444.80665580031;6483.773067942623;6557.409833115019;6569.572977756455;6547.574407663486;6558.8688226235445;6567.047778072177;6567.3432656734185;6568.047633093199;6394.712237949303;6455.4835613150835;6456.805490984136;6514.771982980573;6565.179352580927;6171.321154672983;6421.743130274784;6422;6428.421442070189;6429.549931504796;27099.593506097423;27218;27236.910523579034;27602.447951040867;27710.722892771017;2943.8086524376063;2950.085473503221;2987.357718090599;3039.4984827503436;3157.8894738684266;16679.583010424714;16989.74515382258;17307;17945.192466339045;18425.907870460564;2062.4328309714797;2126;2143.7534683511285;2154.084514081509;2225.799678028969;131592;138753.3062334692;139049;165102;172991;19609.509762256057;23611.7638823613;23848.64227036596;23942.7605723944;25455.236342909742;43239.78380108142;43513.34729979053;44084.559154408686;44640.77679611581;44710.552894471286;11222.66332010041;11455.198136130392;11488.827667584992;11526;11612.6516204514;8997.100289970951;9002.23481004122;9042.728718138467;9177.403468774508;9220.985691573922;10314.690559283234;10430.582776688847;11555.364454955059;11556.075513958864;11651.30092194471;4458.888527786767;4514.751688657156;4517.2094883395275;4531.954680453219;4571.702839315434;962.3936919740519;966.8114717630135;967.6806653804368;976.4824642939253;1018.3584341864578;16838.494845154666;19743.40769776909;20219;20676.58646827055;21519;992.5880759484877;993.64228877604;997.6857289953641;1005.9899401005896;1021.4943602916455;10660.573577056986;11117.055050320652;11170.664880053611;11183.72040698989;11212.607558735404;609874;678393;683905;795757;796318;159440;166499;170875;171602.14198928926;172057.13971430063;1102.8860850541012;1181.7636472705321;1209.2321375926174;1250.993745031269;1270.1172684983846;18916.054197289806;19444;20192.899035504728;20215.39353819388;20243.797562024192;52440.47559524356;56755;65230;66109.66945165243;67085.66457167683;91255.54372228097;92572;94156.52921735347;94665.52667236619;95261.52369238387;9686.9031309686;11287.943560282474;11594.826077609012;11615.419229038345;11763.353015584225;12723.300218488072;12883.935580322413;13222.4049917752;13257.535986240435;13346.866531334563;11388.94305528467;11431.256968297033;11519.251248669145;11649.776773438667;11668.824967625662;9107.863382049141;11143.944280278547;11197.160212984221;11357.659270221577;11428.771424571629;11412.144089193178;11461.025812806005;11473.139514536277;11665;11788.938995490447;11514.596989105676;11583.305001699924;11826;11897.345645989208;11964.162508624313;11112.444377780917;11355;11492.195546311677;11547.942260288644;11569.247998880046 21:18:25 INFO - PROCESS | 1639 | |3;mootools.html;1482.7331080405522;1501.7897494350786;1525.7024880148376;1533.4939469974909;1549.9535013949583;10585.994330538597;11177.66467005989;11179.552817887296;11186.608468703596;11194.720131996704;10500.894991050087;10879.782404351929;11001.449927503612;11017.228793984425;11041.171912106583;2374.1809075868796;2404.8196385271085;2414.0705828256073;2414.95170096598;2416.565018296706;2351.7413084560685;2389.9880500597474;2399.30420178149;2400.459896523277;2401.711794584652;2354.764523547649;2370.312609343297;2381.999560184718;2385.976140238593;2388.9641655375185;2314.3288446350707;2334.3697201755517;2344.9648255276184;2346.2843832631042;2349.5535848188874;2312.4681323295567;2364.408897775556;2392.473655795722;2393.2939782764124;2396.5446565152565;10657.680269591925;10876.401797901111;10890.564377424893;10894.346339219672;10894.61868834587;4953.925691114636;5671.517920976722;5857.619254748471;5858.794942177046;5863.237779088734;3555;3605.56733192016;3639.490471334015;3673.9081522961874;3688.207035487383;1183.3846399872018;1191.910606704492;1240.2372540887288;1253.5737849131249;1257.3273298785107;13601.795973060413;13927.791083133761;14162.716745665131;15270.236488175658;15485.535433937;4571.314302854598;4742.52574742523;4774.856754297377;4786.16242157621;4796.328514008042;9641.903580964241;11554.537818487335;11563.88436115628;11571.76856462866;11575.479103440366;4861.878453038632;5044.848654540369;5584.497395234448;5754.223179870663;5794.275715535558;5112.565431938253;5329.840104796862;5346.117890548094;5407.161889907071;5429.864253393618;3612.096975756061;3631.7457777955287;3889.8055097245024;3939.763614183158;4001.2597669431248;1036.8341065429495;1037.7353774787382;1044.556063672936;1054.9736256593494;1055.456439933435;892.1168043636753;920.4667014951337;921.2767977137914;926.4672813132476;952.642758965388;6533.967330163414;6579.407853293226;6586.407223349922;6586.8353291168105;6627.37039981201;964.243069190696;968.2060710217695;980.881794753981;995.7311525887969;998.7003898830467;4051.108756073718;4052.77709725962;4093.7953102344763;4124.958750412457;4192.517860446027;13412.262325571992;13868.95982801294;13895.930520347334;13907.652308692364;13951;13446.798298025538;13612;13788.103773254707;13921.860781392057;13922.721545569031;10020.148287395506;10082.949585252027;10153.695389138338;10224.897751022543;10291.382517049002;6091.8781624366375;6357.554971151975;6432.774852880127;6476.676166191577;6578.276389597237;10621.097206737204;11889.762204756029;12096.879031209575;12257.877421225674;12280.140390172959;11696.415179241174;11717.12121590867;12381.876181238073;12476;12895.41970611306;9224.077592240723;9288.72133835986;9322.720318390458;9341.20599749029;9425.764355891157;10209.897901020895;10238.078572928473;10285.228607854291;10318.690439286833;10343.37939723619;7952.920470795218;9085.36402451822;9122.498262595622;9231.215346695606;9393.342466027312;8764.605592748214;8921.643134274556;8925.73222803291;8973.685920992733;8982.955085224532;7644.808879777827;7699.422543309386;7792.61036948139;7802.648880800264;7803.868439076416;5779.682117483579;5789.8552536186935;5806.4193580641595;5873.089671100986;5933.436323549256;5557.916631250454;5654.095344744821;5776.104703770922;5970.731317090828;5970.76116955317 21:18:25 INFO - PROCESS | 1639 | |4;prototype.html;313.5704085402998;373.0133796109291;375.79143575315703;379.5274882770951;380.9561900381455;4324.372965919943;4940.777665005075;5004.448620927515;5193.091209038417;5272.420033796284;4481.46222453306;4586.19741545229;4705.270683044125;4894.486078961711;5170.870728231786;3641.908952276188;4228.682848786338;4278.550752171024;4312.353147027955;4325.5458176891525;3605.314990151876;3998.860039898604;4257.808398622054;4279.261272785404;4280.951166964098;3330.217398911254;3611.801350925698;3784.186399924016;4279.229738647043;4308.676849236304;3682.834272457746;4010.573602970205;4207.747535147901;4244;4344.891377715567;3661;3922.764634121962;3940.4286378474962;3960.960390396088;3991;4558.544145585448;4758.0246049559755;4971.577415919651;5006.199008158677;5050.924236136461;4639.777802199982;4644.86065418038;4810.12409096723;4909.975450122763;4985.725785081819;5499.755144464745;5509.201165830932;5530.446955304477;5537.612367134302;5544.77820887164;4412.646988240933;4435.911281774379;4444.911101777979;4446.622037126848;4461.363988349485;4804.399450068707;5402.567794576425;5534.695591742412;5824.504917082053;5850.473457388855;3804.6385593368586;3965.6629186518894;4278.379634952977;4446.510883802779;4459.175052615276;3817.675497582681;4376.715513491677;4564.475085365226;4595.965907670814;4626.421697287839;4139.379093136054;4395.868123956287;4941.579965702884;4950.9009819803405;4983.775730092155;5238.97380513095;5456.890862182734;5504.889902202013;5523.364813046551;5606.131049687305;1616.9919150404173;1669.5158404062686;1715.4167583021833;1749.0292887447588;1750.719884818423;1273.834401527814;1308.9070626027374;1340.8479390578177;1403.3334166271143;1437.8346490153558;4440.600345968814;4535.888707266741;4552.772361381918;5137.9743101285;5211.530962213419;4963.751812409365;5182.74415817858;5199.922001169985;5572.693501857437;5744.856378590569;4346.369776382407;4592.977035114803;4700.482946875841;4785.258284965836;5137.794488220429;2756.186924857172;2921.284285350103;2944.484715174836;2953.1583498702767;2957.4676558219726;5596.412376700469;5596.48010068274;5856.443637854397;5867.823965281048;5899.557533184942;5136.150985645165;5235.869103272448;5434.412349860079;5497.835064948058;5744.942550574524;4637.837675681402;4720.976395118002;4863.732494712754;5879.737190536826;5917.260342457193;5052.545270925634;5131.307273518028;5278.917821846589;5363.919541206963;5666.490015898589;4660.976695116503;5111.591072714248;5285.656432331886;5360.713428777143;5408.916917357069;5845.298564172326;5863.677497737665;5878.412158784087;5884.764609415575;5895.675737834289;4247.384129301296;4340.84807031765;4912.6561140719805;4967.552920237196;4991.575716064175;4501.549845015472;4853.456976407172;5175.990681817009;5225.477452254744;5579.693116878449;4900.672180714132;5512.944870551403;5530.391656917816;5532.889342213214;5586.52514536269;4533;5093;5197.402298735694;5492.743124078871;5592.412796656293;4807.6394270429155;5362.70505122222;5384.219288203267;5388.703621300866;5391.705990562158;4625.514320996247;4952.603791696728;5203.713795741271;5558;5567.91203298763;4815.446223684321;5011.298418221525;5115.744212789271;5309.150535914235;5411.567074633941 21:18:25 INFO - PROCESS | 1639 | |5;yui.html;714.731975509184;726.2991213478995;750.2872271342226;760.460073347923;862.1335557764446;14677.486287979922;15396.153211573359;15436.845631543682;15438.150901700388;15445.227738613066;14112.858871411283;14285.428582856699;14317.427302907898;14326;14511.129332240072;922.8892532896061;927.7541451515353;950.8763860698134;950.9524523773783;950.9952450237739;921.424109931293;952.9571169297399;954.4654993203793;954.746992047108;955.5413401567251;1003.4882210072878;1005.9798804023915;1006.4062203300051;1006.8691070160905;1007.8790545134594;1001.7846163074973;1005.1054561440324;1005.3615953869272;1005.5625802775816;1006.4766321512845;734.3794493652855;737.6164394514876;737.6975440069546;737.7639155470251;738.8928605352194;15265;15559;15627.218639068114;15890.443834465854;16019.519414417586;12277.570285039981;13976.231307278096;14203.573892783234;14210;14301.070430421989;11278.492467838967;11520.76958460826;11641.35972521511;11955.64133076009;12131.393430328448;3629.256002519477;3654.3604869148057;3675.1363429594026;3822.9869084692577;3823.330917089526;118546;121520.39239803833;122004;122326;125272;10649.787004259872;10810.513526891309;10871.293365931348;11036;11093.5562577496;19206;19249.51876203106;23206.76793232046;23248.76751232466;23272.767272327397;7634.885476717854;7648.235176482419;7726.652300646484;7736.961315193388;7738.148803631596;4074.8997770601773;4104.363823607346;4226.091390351089;4232.661387089025;4535.569120933506;3470.9305813884084;3574.5531808523933;3576.1059735066233;3580.7672501287334;3586.690857836923;613.2763339259716;634.9555531112778;635.758411803521;636.2238069555135;636.5098873867097;599.4544964082751;679.3783687925493;690.3131384272681;698.183125742882;702.5468572770534;9592.568334424968;9783.951080244553;10162.491875406347;10206.540705668263;10509.789804203872;658.2002866517205;697.9581225126509;703.3212949503753;703.6622421237835;711.2922641971272;4781.593564546983;4983.59940938054;4989.62365805963;5020.2720605511995;5083.466236045162;84033;109489;111243;111983.44008279906;112187;56034.15948760772;60092;67868;77309;96432.58918526952;75661.48677026539;76884.61557692288;77953;78189.26337578158;78450.6077469609;10965.835512467478;11100.722481938015;11179.664610061385;11227.27022743519;11273.605423810128;34798.65201347954;48061.75969120132;48501;49114.50885491099;50032;51208.74395627998;60569.394306056376;65458.07251564921;65841.67079164764;66424.33575664375;12846.67883302925;12976.15654982423;12983.935080324538;13002.609921702364;13614.795778063535;13998.580042598738;14138.50515232003;15244.542663720105;15517.22413879279;15572.92213538925;13525.932370338085;14212.21832799206;14217.715645686822;14483.420663173776;14586.562403127924;13143.431768852366;13731.588052358446;14288.785668215192;14302.213378264296;14336.426542938165;13634.386452609855;13651.931740341235;13826;13943.721125577229;13973.301334933009;10690.41202733826;11442.48508817122;11634.476448559666;11687.123465740273;11887.762244754884;10759.114166933012;11169.408182113366;11295.152863535432;11505.769884602429;11528.942355288169 21:18:25 INFO - PROCESS | 1639 | __end_tp_report 21:18:25 INFO - PROCESS | 1639 | __start_cc_report 21:18:25 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1633 21:18:25 INFO - PROCESS | 1639 | __end_cc_report 21:18:25 INFO - PROCESS | 1639 | __startTimestamp1490156305455__endTimestamp 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | ------- Summary: start ------- 21:18:25 INFO - PROCESS | 1639 | Number of tests: 6 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5932.10 Median:6176.97 stddev:692.25 (11.2%) stddev-sans-first:652.87 21:18:25 INFO - PROCESS | 1639 | Values: 2922.4 3271.5 3419.6 3449.1 3476.1 6021.9 6054.1 6061.7 6089.6 6092.5 6030.4 6088.9 6112.7 6114.1 6117.3 5384.9 5411.9 5444.0 5451.5 5544.3 5315.4 5340.5 5366.5 5518.4 5528.0 5403.2 5405.8 5425.8 5433.8 5439.2 4860.7 5017.7 5405.2 5422.8 5425.3 5268.4 5351.3 5357.4 5368.1 5389.8 4953.9 5896.5 5981.7 5999.0 6018.8 6267.7 6332.5 6356.1 6358.0 6358.4 6478.5 6482.0 6483.8 6492.4 6499.7 6083.1 6144.0 6155.5 6161.7 6182.1 6331.9 6377.6 6626.3 6639.9 6648.3 6329.2 6342.6 6355.5 6355.8 6398.1 6462.1 6466.4 6484.8 6495.1 6506.6 5056.6 6402.2 6418.4 6424.0 6434.1 4927.4 5797.0 6243.3 6261.4 6348.4 5154.3 5161.9 5164.2 5164.9 5185.2 4602.9 4605.1 4610.2 4621.6 4642.0 5809.6 5914.6 5971.9 6069.9 6131.2 5471.3 6439.0 6483.8 6489.0 6493.0 6107.6 6108.8 6112.4 6114.8 6126.9 5448.7 5551.2 5715.4 5727.2 5759.3 6425.6 6493.8 6514.1 6642.5 6657.5 6399.1 6400.9 6406.3 6406.3 6412.1 6344.4 6573.5 6575.3 6586.6 6639.7 6328.9 6342.7 6356.3 6358.7 6393.3 6383.4 6401.3 6412.5 6416.6 6425.1 6292.2 6346.7 6351.8 6356.3 6374.4 6131.3 6170.0 6177.0 6270.0 6368.5 5240.4 6281.6 6305.4 6318.4 6325.5 6199.7 6269.7 6333.4 6358.4 6376.9 6080.0 6241.4 6290.2 6326.3 6335.7 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:54840.69 Median:32368.51 stddev:109464.07 (338.2%) stddev-sans-first:109695.80 21:18:25 INFO - PROCESS | 1639 | Values: 747.5 794.4 813.0 872.8 887.6 28046.9 39712.6 40382.0 40396.6 40445.4 41109.6 41304.2 41320.4 41330.6 41338.8 7506.4 9147.0 9306.3 9312.7 9315.6 7487.9 11089.4 11331.5 11415.7 11459.9 11264.2 11270.6 11275.4 11297.3 11304.4 11220.0 11237.7 11249.7 11271.0 11285.7 7387.5 7559.9 10896.1 11156.3 11175.6 39512.0 39683.6 39731.6 39734.2 39759.0 3765.3 3801.8 3813.2 3832.4 3944.1 27529.3 27630.0 28509.4 29599.3 29649.6 3064.0 3112.4 3139.7 3142.2 3147.2 279720.6 319573.0 325432.0 325567.0 326740.0 53244.5 53288.0 53406.5 53418.5 53518.7 55684.4 55718.0 55831.7 55845.4 55864.0 11298.2 13629.0 14333.6 14456.9 14483.3 10454.0 12321.2 12341.7 12344.4 12365.8 11056.4 12670.3 12914.7 12989.4 13271.0 4728.1 5440.6 5560.1 5594.6 5601.4 1073.3 1076.8 1084.7 1116.1 1134.2 22019.1 27481.9 27944.0 28092.3 28124.4 983.1 1003.9 1143.8 1150.9 1203.8 13836.2 14193.6 14291.0 14644.0 14647.4 439412.0 440483.0 441070.6 441189.8 441716.8 45082.5 56091.0 56174.7 56193.0 56245.0 1404.6 1467.4 1467.5 1469.9 1472.2 26879.7 27021.2 27606.6 28395.6 28459.0 47498.8 47764.5 47813.8 47831.8 47840.8 461485.0 465036.0 466234.0 466875.0 467535.0 24938.5 30168.4 30241.5 30296.2 30297.1 31400.0 33784.7 38991.0 41667.6 41756.0 32362.4 32374.7 33000.5 33928.8 34285.3 32462.7 33094.8 33735.0 33885.5 33915.8 32507.0 33130.3 33320.2 33496.8 33537.0 27193.2 30054.0 30323.7 30364.0 31192.4 21145.8 22248.9 22843.3 23642.8 23744.1 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:43024.52 Median:12198.90 stddev:120191.74 (985.3%) stddev-sans-first:120486.24 21:18:25 INFO - PROCESS | 1639 | Values: 368.3 378.2 406.8 421.9 446.4 13071.3 15027.7 21546.2 22046.3 22172.0 22474.7 22900.4 23061.2 23363.3 23441.3 6286.7 6459.4 6527.6 6569.8 6597.8 6261.8 6444.8 6483.8 6557.4 6569.6 6547.6 6558.9 6567.0 6567.3 6568.0 6394.7 6455.5 6456.8 6514.8 6565.2 6171.3 6421.7 6422.0 6428.4 6429.5 27099.6 27218.0 27236.9 27602.4 27710.7 2943.8 2950.1 2987.4 3039.5 3157.9 16679.6 16989.7 17307.0 17945.2 18425.9 2062.4 2126.0 2143.8 2154.1 2225.8 131592.0 138753.3 139049.0 165102.0 172991.0 19609.5 23611.8 23848.6 23942.8 25455.2 43239.8 43513.3 44084.6 44640.8 44710.6 11222.7 11455.2 11488.8 11526.0 11612.7 8997.1 9002.2 9042.7 9177.4 9221.0 10314.7 10430.6 11555.4 11556.1 11651.3 4458.9 4514.8 4517.2 4532.0 4571.7 962.4 966.8 967.7 976.5 1018.4 16838.5 19743.4 20219.0 20676.6 21519.0 992.6 993.6 997.7 1006.0 1021.5 10660.6 11117.1 11170.7 11183.7 11212.6 609874.0 678393.0 683905.0 795757.0 796318.0 159440.0 166499.0 170875.0 171602.1 172057.1 1102.9 1181.8 1209.2 1251.0 1270.1 18916.1 19444.0 20192.9 20215.4 20243.8 52440.5 56755.0 65230.0 66109.7 67085.7 91255.5 92572.0 94156.5 94665.5 95261.5 9686.9 11287.9 11594.8 11615.4 11763.4 12723.3 12883.9 13222.4 13257.5 13346.9 11388.9 11431.3 11519.3 11649.8 11668.8 9107.9 11143.9 11197.2 11357.7 11428.8 11412.1 11461.0 11473.1 11665.0 11788.9 11514.6 11583.3 11826.0 11897.3 11964.2 11112.4 11355.0 11492.2 11547.9 11569.2 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6674.27 Median:2409.45 stddev:4161.05 (172.7%) stddev-sans-first:4154.44 21:18:25 INFO - PROCESS | 1639 | Values: 1482.7 1501.8 1525.7 1533.5 1550.0 10586.0 11177.7 11179.6 11186.6 11194.7 10500.9 10879.8 11001.4 11017.2 11041.2 2374.2 2404.8 2414.1 2415.0 2416.6 2351.7 2390.0 2399.3 2400.5 2401.7 2354.8 2370.3 2382.0 2386.0 2389.0 2314.3 2334.4 2345.0 2346.3 2349.6 2312.5 2364.4 2392.5 2393.3 2396.5 10657.7 10876.4 10890.6 10894.3 10894.6 4953.9 5671.5 5857.6 5858.8 5863.2 3555.0 3605.6 3639.5 3673.9 3688.2 1183.4 1191.9 1240.2 1253.6 1257.3 13601.8 13927.8 14162.7 15270.2 15485.5 4571.3 4742.5 4774.9 4786.2 4796.3 9641.9 11554.5 11563.9 11571.8 11575.5 4861.9 5044.8 5584.5 5754.2 5794.3 5112.6 5329.8 5346.1 5407.2 5429.9 3612.1 3631.7 3889.8 3939.8 4001.3 1036.8 1037.7 1044.6 1055.0 1055.5 892.1 920.5 921.3 926.5 952.6 6534.0 6579.4 6586.4 6586.8 6627.4 964.2 968.2 980.9 995.7 998.7 4051.1 4052.8 4093.8 4125.0 4192.5 13412.3 13869.0 13895.9 13907.7 13951.0 13446.8 13612.0 13788.1 13921.9 13922.7 10020.1 10082.9 10153.7 10224.9 10291.4 6091.9 6357.6 6432.8 6476.7 6578.3 10621.1 11889.8 12096.9 12257.9 12280.1 11696.4 11717.1 12381.9 12476.0 12895.4 9224.1 9288.7 9322.7 9341.2 9425.8 10209.9 10238.1 10285.2 10318.7 10343.4 7952.9 9085.4 9122.5 9231.2 9393.3 8764.6 8921.6 8925.7 8973.7 8983.0 7644.8 7699.4 7792.6 7802.6 7803.9 5779.7 5789.9 5806.4 5873.1 5933.4 5557.9 5654.1 5776.1 5970.7 5970.8 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4540.51 Median:4879.11 stddev:1232.89 (25.3%) stddev-sans-first:1194.83 21:18:25 INFO - PROCESS | 1639 | Values: 313.6 373.0 375.8 379.5 381.0 4324.4 4940.8 5004.4 5193.1 5272.4 4481.5 4586.2 4705.3 4894.5 5170.9 3641.9 4228.7 4278.6 4312.4 4325.5 3605.3 3998.9 4257.8 4279.3 4281.0 3330.2 3611.8 3784.2 4279.2 4308.7 3682.8 4010.6 4207.7 4244.0 4344.9 3661.0 3922.8 3940.4 3961.0 3991.0 4558.5 4758.0 4971.6 5006.2 5050.9 4639.8 4644.9 4810.1 4910.0 4985.7 5499.8 5509.2 5530.4 5537.6 5544.8 4412.6 4435.9 4444.9 4446.6 4461.4 4804.4 5402.6 5534.7 5824.5 5850.5 3804.6 3965.7 4278.4 4446.5 4459.2 3817.7 4376.7 4564.5 4596.0 4626.4 4139.4 4395.9 4941.6 4950.9 4983.8 5239.0 5456.9 5504.9 5523.4 5606.1 1617.0 1669.5 1715.4 1749.0 1750.7 1273.8 1308.9 1340.8 1403.3 1437.8 4440.6 4535.9 4552.8 5138.0 5211.5 4963.8 5182.7 5199.9 5572.7 5744.9 4346.4 4593.0 4700.5 4785.3 5137.8 2756.2 2921.3 2944.5 2953.2 2957.5 5596.4 5596.5 5856.4 5867.8 5899.6 5136.2 5235.9 5434.4 5497.8 5744.9 4637.8 4721.0 4863.7 5879.7 5917.3 5052.5 5131.3 5278.9 5363.9 5666.5 4661.0 5111.6 5285.7 5360.7 5408.9 5845.3 5863.7 5878.4 5884.8 5895.7 4247.4 4340.8 4912.7 4967.6 4991.6 4501.5 4853.5 5176.0 5225.5 5579.7 4900.7 5512.9 5530.4 5532.9 5586.5 4533.0 5093.0 5197.4 5492.7 5592.4 4807.6 5362.7 5384.2 5388.7 5391.7 4625.5 4952.6 5203.7 5558.0 5567.9 4815.4 5011.3 5115.7 5309.2 5411.6 21:18:25 INFO - PROCESS | 1639 | 21:18:25 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20373.36 Median:15954.98 stddev:29797.92 (186.8%) stddev-sans-first:29844.95 21:18:25 INFO - PROCESS | 1639 | Values: 714.7 726.3 750.3 760.5 862.1 14677.5 15396.2 15436.8 15438.2 15445.2 14112.9 14285.4 14317.4 14326.0 14511.1 922.9 927.8 950.9 951.0 951.0 921.4 953.0 954.5 954.7 955.5 1003.5 1006.0 1006.4 1006.9 1007.9 1001.8 1005.1 1005.4 1005.6 1006.5 734.4 737.6 737.7 737.8 738.9 15265.0 15559.0 15627.2 15890.4 16019.5 12277.6 13976.2 14203.6 14210.0 14301.1 11278.5 11520.8 11641.4 11955.6 12131.4 3629.3 3654.4 3675.1 3823.0 3823.3 118546.0 121520.4 122004.0 122326.0 125272.0 10649.8 10810.5 10871.3 11036.0 11093.6 19206.0 19249.5 23206.8 23248.8 23272.8 7634.9 7648.2 7726.7 7737.0 7738.1 4074.9 4104.4 4226.1 4232.7 4535.6 3470.9 3574.6 3576.1 3580.8 3586.7 613.3 635.0 635.8 636.2 636.5 599.5 679.4 690.3 698.2 702.5 9592.6 9784.0 10162.5 10206.5 10509.8 658.2 698.0 703.3 703.7 711.3 4781.6 4983.6 4989.6 5020.3 5083.5 84033.0 109489.0 111243.0 111983.4 112187.0 56034.2 60092.0 67868.0 77309.0 96432.6 75661.5 76884.6 77953.0 78189.3 78450.6 10965.8 11100.7 11179.7 11227.3 11273.6 34798.7 48061.8 48501.0 49114.5 50032.0 51208.7 60569.4 65458.1 65841.7 66424.3 12846.7 12976.2 12983.9 13002.6 13614.8 13998.6 14138.5 15244.5 15517.2 15572.9 13525.9 14212.2 14217.7 14483.4 14586.6 13143.4 13731.6 14288.8 14302.2 14336.4 13634.4 13651.9 13826.0 13943.7 13973.3 10690.4 11442.5 11634.5 11687.1 11887.8 10759.1 11169.4 11295.2 11505.8 11528.9 21:18:25 INFO - PROCESS | 1639 | -------- Summary: end -------- 21:18:25 INFO - PROCESS | 1639 | 21:18:26 INFO - TEST-INFO | 1639: exit 0 21:18:26 INFO - TEST-OK | dromaeo_css | took 1120250ms 21:18:26 INFO - TEST-START | kraken 21:18:26 INFO - operating with platform_type : mac_ 21:18:26 INFO - Initialising browser for kraken test... 21:18:26 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpS5vmBN/profile http://localhost:49249/getInfo.html) 21:18:28 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 21:18:28 INFO - PROCESS | 1649 | colorDepth:24 21:18:28 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 21:18:28 INFO - PROCESS | 1649 | __metrics 21:18:28 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:18:28 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:18:29 INFO - TEST-INFO | 1649: exit 0 21:18:29 INFO - Browser initialized. 21:18:29 INFO - Running cycle 1/1 for kraken test... 21:18:29 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpS5vmBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:41 INFO - PROCESS | 1650 | RSS: Main: 214892544 21:18:41 INFO - PROCESS | 1650 | 21:18:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:45 INFO - PROCESS | 1650 | RSS: Main: 268394496 21:18:45 INFO - PROCESS | 1650 | 21:18:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 21:18:48 INFO - PROCESS | 1650 | RSS: Main: 279797760 21:18:48 INFO - PROCESS | 1650 | 21:18:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 21:18:52 INFO - PROCESS | 1650 | RSS: Main: 375443456 21:18:52 INFO - PROCESS | 1650 | 21:18:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 21:18:54 INFO - PROCESS | 1650 | RSS: Main: 278036480 21:18:54 INFO - PROCESS | 1650 | 21:18:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:18:57 INFO - PROCESS | 1650 | RSS: Main: 280887296 21:18:57 INFO - PROCESS | 1650 | 21:19:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 21:19:01 INFO - PROCESS | 1650 | RSS: Main: 320819200 21:19:01 INFO - PROCESS | 1650 | 21:19:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 21:19:04 INFO - PROCESS | 1650 | RSS: Main: 322715648 21:19:04 INFO - PROCESS | 1650 | 21:19:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 21:19:08 INFO - PROCESS | 1650 | RSS: Main: 317374464 21:19:08 INFO - PROCESS | 1650 | 21:19:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:19:10 INFO - PROCESS | 1650 | RSS: Main: 295047168 21:19:10 INFO - PROCESS | 1650 | 21:19:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:19:12 INFO - PROCESS | 1650 | RSS: Main: 299884544 21:19:12 INFO - PROCESS | 1650 | 21:19:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:19:15 INFO - PROCESS | 1650 | RSS: Main: 307388416 21:19:15 INFO - PROCESS | 1650 | 21:19:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:19:19 INFO - PROCESS | 1650 | RSS: Main: 322125824 21:19:19 INFO - PROCESS | 1650 | 21:19:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:19:23 INFO - PROCESS | 1650 | RSS: Main: 316018688 21:19:23 INFO - PROCESS | 1650 | 21:19:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 21:19:25 INFO - PROCESS | 1650 | RSS: Main: 360624128 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | __start_tp_report 21:19:25 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 21:19:25 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 21:19:25 INFO - PROCESS | 1650 | |i|pagename|runs| 21:19:25 INFO - PROCESS | 1650 | |0;ai-astar;116;114;119;165;171;116;115;115;114;116 21:19:25 INFO - PROCESS | 1650 | |1;audio-beat-detection;142;109;110;142;111;107;108;114;154;134 21:19:25 INFO - PROCESS | 1650 | |2;audio-dft;182;184;185;184;184;185;184;186;181;186 21:19:25 INFO - PROCESS | 1650 | |3;audio-fft;83;60;59;92;59;60;60;61;93;84 21:19:25 INFO - PROCESS | 1650 | |4;audio-oscillator;85;69;87;71;69;69;83;69;69;85 21:19:25 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;87;89;86;87;86;87;86;86;87;86 21:19:25 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;95;95;96;94;95;94;96;95;94 21:19:25 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;83;84;85;85;83;86;84;85;82 21:19:25 INFO - PROCESS | 1650 | |8;json-parse-financial;61;60;61;61;65;66;66;67;65;65 21:19:25 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;55;66;56;65;61;58;58;58;57;57 21:19:25 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;83;87;84;84;83;84;86;87;90;81 21:19:25 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;139;138;137;136;151;141;140;132;192;167 21:19:25 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;213;217;172;162;164;180;216;190;164;164 21:19:25 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;65;67;65;72;74;74;80;81;77 21:19:25 INFO - PROCESS | 1650 | __end_tp_report 21:19:25 INFO - PROCESS | 1650 | __start_cc_report 21:19:25 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2175 21:19:25 INFO - PROCESS | 1650 | __end_cc_report 21:19:25 INFO - PROCESS | 1650 | __startTimestamp1490156365095__endTimestamp 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | ------- Summary: start ------- 21:19:25 INFO - PROCESS | 1650 | Number of tests: 14 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:126.10 Median:116.00 stddev:22.17 (19.1%) stddev-sans-first:23.22 21:19:25 INFO - PROCESS | 1650 | Values: 116.0 114.0 119.0 165.0 171.0 116.0 115.0 115.0 114.0 116.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:124.00 stddev:17.87 (14.4%) stddev-sans-first:17.60 21:19:25 INFO - PROCESS | 1650 | Values: 142.0 109.0 110.0 142.0 111.0 107.0 108.0 114.0 154.0 134.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.60 (0.9%) stddev-sans-first:1.50 21:19:25 INFO - PROCESS | 1650 | Values: 182.0 184.0 185.0 184.0 184.0 185.0 184.0 186.0 181.0 186.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:71.10 Median:72.00 stddev:14.87 (20.6%) stddev-sans-first:15.13 21:19:25 INFO - PROCESS | 1650 | Values: 83.0 60.0 59.0 92.0 59.0 60.0 60.0 61.0 93.0 84.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:75.60 Median:77.00 stddev:8.17 (10.6%) stddev-sans-first:7.92 21:19:25 INFO - PROCESS | 1650 | Values: 85.0 69.0 87.0 71.0 69.0 69.0 83.0 69.0 69.0 85.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:87.00 stddev:0.95 (1.1%) stddev-sans-first:1.00 21:19:25 INFO - PROCESS | 1650 | Values: 87.0 89.0 86.0 87.0 86.0 87.0 86.0 86.0 87.0 86.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 21:19:25 INFO - PROCESS | 1650 | Values: 95.0 95.0 95.0 96.0 94.0 95.0 94.0 96.0 95.0 94.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:1.27 21:19:25 INFO - PROCESS | 1650 | Values: 87.0 83.0 84.0 85.0 85.0 83.0 86.0 84.0 85.0 82.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:65.00 stddev:2.63 (4.0%) stddev-sans-first:2.60 21:19:25 INFO - PROCESS | 1650 | Values: 61.0 60.0 61.0 61.0 65.0 66.0 66.0 67.0 65.0 65.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:58.00 stddev:3.73 (6.4%) stddev-sans-first:3.64 21:19:25 INFO - PROCESS | 1650 | Values: 55.0 66.0 56.0 65.0 61.0 58.0 58.0 58.0 57.0 57.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:2.60 (3.1%) stddev-sans-first:2.67 21:19:25 INFO - PROCESS | 1650 | Values: 83.0 87.0 84.0 84.0 83.0 84.0 86.0 87.0 90.0 81.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:140.50 stddev:18.61 (13.2%) stddev-sans-first:19.49 21:19:25 INFO - PROCESS | 1650 | Values: 139.0 138.0 137.0 136.0 151.0 141.0 140.0 132.0 192.0 167.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.20 Median:185.00 stddev:23.17 (12.5%) stddev-sans-first:22.11 21:19:25 INFO - PROCESS | 1650 | Values: 213.0 217.0 172.0 162.0 164.0 180.0 216.0 190.0 164.0 164.0 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:74.00 stddev:6.01 (8.1%) stddev-sans-first:6.08 21:19:25 INFO - PROCESS | 1650 | Values: 67.0 65.0 67.0 65.0 72.0 74.0 74.0 80.0 81.0 77.0 21:19:25 INFO - PROCESS | 1650 | -------- Summary: end -------- 21:19:25 INFO - PROCESS | 1650 | 21:19:25 INFO - TEST-INFO | 1650: exit 0 21:19:25 INFO - TEST-OK | kraken | took 59866ms 21:19:25 INFO - SUITE-END | took 1180s 21:19:26 INFO - Completed test suite (00:19:40) 21:19:26 INFO - javascript benchmark 21:19:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7731.59752115101, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2922.371690086631, 3271.525628783828, 3419.623841377449, 3449.085992212066, 3476.096214984105, 6021.879562408754, 6054.061620448838, 6061.66660833654, 6089.573729838913, 6092.482139018183, 6030.427109424609, 6088.908666370008, 6112.724927378267, 6114.082887566856, 6117.2659280886355, 5384.946150538503, 5411.945880541183, 5444.0, 5451.454854514556, 5544.251526043993, 5315.388730296027, 5340.49265319794, 5366.543843773284, 5518.420565840589, 5527.972360138214, 5403.243545903577, 5405.810796622119, 5425.83722488326, 5433.755481003344, 5439.211314359415, 4860.684055536414, 5017.7491125443585, 5405.243265942771, 5422.75597598107, 5425.294711687475, 5268.394134674485, 5351.304330437058, 5357.383900851413, 5368.114261146906, 5389.83830485086, 4953.876153096166, 5896.498797602209, 5981.700914954278, 5999.010163323046, 6018.789342372996, 6267.655278959655, 6332.525060620425, 6356.14192084072, 6358.0462930560325, 6358.395952384516, 6478.54650174488, 6481.962885938275, 6483.837904052436, 6492.350764923517, 6499.740010399579, 6083.117947897575, 6144.0, 6155.507559395282, 6161.7227224775, 6182.072689096626, 6331.873362532723, 6377.617342959437, 6626.337366263431, 6639.93360066398, 6648.33516648341, 6329.240491141092, 6342.587731797418, 6355.459785918156, 6355.809325720235, 6398.136251606066, 6462.095306657072, 6466.35336466359, 6484.805455836333, 6495.090687303781, 6506.577072490273, 5056.570191533688, 6402.199725034371, 6418.422341989243, 6423.967880160662, 6434.067060276234, 4927.43334516528, 5796.9855275326645, 6243.250809902841, 6261.405166509175, 6348.428641422294, 5154.252633368141, 5161.896762064813, 5164.1995490699, 5164.8967020659375, 5185.170372740419, 4602.861914142581, 4605.078984203173, 4610.170169369546, 4621.584057434779, 4642.048380082075, 5809.564282678816, 5914.615549989237, 5971.880562388728, 6069.908951365733, 6131.202943617302, 5471.316085489314, 6438.967805160944, 6483.805485835433, 6489.0, 6493.026046093124, 6107.603005804608, 6108.75564977396, 6112.388761123941, 6114.847128821815, 6126.908096378558, 5448.727563621803, 5551.1673249012165, 5715.371309155989, 5727.165973369421, 5759.337676167294, 6425.550211485244, 6493.805185844432, 6514.120593719787, 6642.5018123641885, 6657.53397262187, 6399.072134540559, 6400.871982560229, 6406.295307516077, 6406.295307516262, 6412.070249813844, 6344.365563443804, 6573.5398522103, 6575.255544649643, 6586.604803711793, 6639.734410623521, 6328.936710633019, 6342.746290148527, 6356.300806911144, 6358.650274234777, 6393.29673735898, 6383.39357761012, 6401.295857455583, 6412.454941330039, 6416.615003099829, 6425.10048593188, 6292.2449306081735, 6346.7461301549265, 6351.809445716636, 6356.300806911328, 6374.4263016326895, 6131.325554189125, 6169.96915015422, 6176.969115154575, 6270.0, 6368.490520758235, 5240.449752775904, 6281.623102613858, 6305.40098690642, 6318.4313411793155, 6325.4939604832425, 6199.721012554356, 6269.717862696099, 6333.398327159097, 6358.364163583789, 6376.9043464349, 6080.0, 6241.407066328691, 6290.24517057956, 6326.304106548184, 6335.714892829926], "value": 5886.788384711434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.5365273530408, 794.4319811334897, 813.0324913353111, 872.7556284240414, 887.6227603268609, 28046.878124875006, 39712.60287397125, 40382.0, 40396.59603403965, 40445.3933191002, 41109.58890411095, 41304.17391652165, 41320.38019429703, 41330.58669413305, 41338.793306033425, 7506.361959233472, 9147.039560846099, 9306.255499560019, 9312.674056408026, 9315.580798864034, 7487.850242995137, 11089.445527723581, 11331.490082946246, 11415.714607134847, 11459.942700286487, 11264.155188360864, 11270.605528806493, 11275.379854108021, 11297.322160670345, 11304.434778261095, 11220.0, 11237.662870113909, 11249.66251012471, 11271.041961433206, 11285.717857053598, 7387.482876198668, 7559.924400756032, 10896.073833724144, 11156.274842135235, 11175.552977880876, 39512.0, 39683.60316396857, 39731.60268397337, 39734.20531589352, 39759.00602484961, 3765.3222419964395, 3801.8289176986827, 3813.199228162089, 3832.386818109117, 3944.112574670705, 27529.31176720578, 27630.0, 28509.429811403657, 29599.26001849971, 29649.555256671167, 3063.9888836684063, 3112.439760843047, 3139.748820094387, 3142.1673256587023, 3147.1817327495014, 279720.6013969917, 319573.0, 325432.0, 325567.0, 326740.0, 53244.46755532473, 53288.0, 53406.46593534093, 53418.46581534135, 53518.73240633772, 55684.44315556873, 55718.0, 55831.72084139553, 55845.441545584836, 55864.0, 11298.152638552141, 13629.0, 14333.64165895861, 14456.927715361357, 14483.275836208359, 10454.0, 12321.199122057038, 12341.69145771345, 12344.3827808611, 12365.75268494643, 11056.447177641086, 12670.303133327756, 12914.67713307156, 12989.4154763034, 13271.004674649439, 4728.125296820031, 5440.591955603346, 5560.138178582326, 5594.608377413542, 5601.439856014447, 1073.2594509788378, 1076.8115579773664, 1084.7233955341337, 1116.1126904111252, 1134.2362079267111, 22019.11923523041, 27481.86259068692, 27944.021959231737, 28092.297692557848, 28124.43751124966, 983.0513554420019, 1003.9297249192487, 1143.7941170589208, 1150.930944143354, 1203.7652657731658, 13836.169829810244, 14193.574192774233, 14291.0, 14644.0, 14647.414103435744, 439412.0, 440483.0, 441070.5892941094, 441189.7940510341, 441716.79141604085, 45082.54917450783, 56091.0, 56174.7191264041, 56193.0, 56245.0, 1404.592668126232, 1467.4057006912217, 1467.4790449390312, 1469.8750606198594, 1472.2491529320123, 26879.731202687723, 27021.189364319103, 27606.5859012119, 28395.574066389432, 28459.0, 47498.76250618863, 47764.5223547774, 47813.760931195124, 47831.804204895154, 47840.7607961958, 461485.0, 465036.0, 466234.0, 466875.0, 467535.0, 24938.501229974936, 30168.396632066797, 30241.487925603193, 30296.242593935327, 30297.091087267418, 31400.0, 33784.66215337815, 38991.0, 41667.58332416637, 41756.0, 32362.352752944338, 32374.676253238107, 33000.50499242562, 33928.83035584806, 34285.31429371449, 32462.675373245966, 33094.79345633843, 33735.0, 33885.49171762475, 33915.830420848724, 32507.031652339225, 33130.337393252485, 33320.1669958253, 33496.83251583727, 33537.0, 27193.1842044739, 30054.0, 30323.696763032087, 30364.0, 31192.37615247637, 21145.78854211438, 22248.88755562183, 22843.31470055901, 23642.763572364056, 23744.050237990286], "value": 18655.423258063656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3241252302026, 378.249175386857, 406.81083296267246, 421.90928950275685, 446.3639313977581, 13071.281079540622, 15027.699446011087, 21546.245881394174, 22046.33860984169, 22172.0, 22474.66288005677, 22900.427489312777, 23061.192858249964, 23363.299101026954, 23441.29676109715, 6286.685665716707, 6459.386358295955, 6527.608343499405, 6569.7700580479695, 6597.80206593803, 6261.812145635638, 6444.80665580031, 6483.773067942623, 6557.409833115019, 6569.572977756455, 6547.574407663486, 6558.8688226235445, 6567.047778072177, 6567.3432656734185, 6568.047633093199, 6394.712237949303, 6455.4835613150835, 6456.805490984136, 6514.771982980573, 6565.179352580927, 6171.321154672983, 6421.743130274784, 6422.0, 6428.421442070189, 6429.549931504796, 27099.593506097423, 27218.0, 27236.910523579034, 27602.447951040867, 27710.722892771017, 2943.8086524376063, 2950.085473503221, 2987.357718090599, 3039.4984827503436, 3157.8894738684266, 16679.583010424714, 16989.74515382258, 17307.0, 17945.192466339045, 18425.907870460564, 2062.4328309714797, 2126.0, 2143.7534683511285, 2154.084514081509, 2225.799678028969, 131592.0, 138753.3062334692, 139049.0, 165102.0, 172991.0, 19609.509762256057, 23611.7638823613, 23848.64227036596, 23942.7605723944, 25455.236342909742, 43239.78380108142, 43513.34729979053, 44084.559154408686, 44640.77679611581, 44710.552894471286, 11222.66332010041, 11455.198136130392, 11488.827667584992, 11526.0, 11612.6516204514, 8997.100289970951, 9002.23481004122, 9042.728718138467, 9177.403468774508, 9220.985691573922, 10314.690559283234, 10430.582776688847, 11555.364454955059, 11556.075513958864, 11651.30092194471, 4458.888527786767, 4514.751688657156, 4517.2094883395275, 4531.954680453219, 4571.702839315434, 962.3936919740519, 966.8114717630135, 967.6806653804368, 976.4824642939253, 1018.3584341864578, 16838.494845154666, 19743.40769776909, 20219.0, 20676.58646827055, 21519.0, 992.5880759484877, 993.64228877604, 997.6857289953641, 1005.9899401005896, 1021.4943602916455, 10660.573577056986, 11117.055050320652, 11170.664880053611, 11183.72040698989, 11212.607558735404, 609874.0, 678393.0, 683905.0, 795757.0, 796318.0, 159440.0, 166499.0, 170875.0, 171602.14198928926, 172057.13971430063, 1102.8860850541012, 1181.7636472705321, 1209.2321375926174, 1250.993745031269, 1270.1172684983846, 18916.054197289806, 19444.0, 20192.899035504728, 20215.39353819388, 20243.797562024192, 52440.47559524356, 56755.0, 65230.0, 66109.66945165243, 67085.66457167683, 91255.54372228097, 92572.0, 94156.52921735347, 94665.52667236619, 95261.52369238387, 9686.9031309686, 11287.943560282474, 11594.826077609012, 11615.419229038345, 11763.353015584225, 12723.300218488072, 12883.935580322413, 13222.4049917752, 13257.535986240435, 13346.866531334563, 11388.94305528467, 11431.256968297033, 11519.251248669145, 11649.776773438667, 11668.824967625662, 9107.863382049141, 11143.944280278547, 11197.160212984221, 11357.659270221577, 11428.771424571629, 11412.144089193178, 11461.025812806005, 11473.139514536277, 11665.0, 11788.938995490447, 11514.596989105676, 11583.305001699924, 11826.0, 11897.345645989208, 11964.162508624313, 11112.444377780917, 11355.0, 11492.195546311677, 11547.942260288644, 11569.247998880046], "value": 11882.038874259992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.7331080405522, 1501.7897494350786, 1525.7024880148376, 1533.4939469974909, 1549.9535013949583, 10585.994330538597, 11177.66467005989, 11179.552817887296, 11186.608468703596, 11194.720131996704, 10500.894991050087, 10879.782404351929, 11001.449927503612, 11017.228793984425, 11041.171912106583, 2374.1809075868796, 2404.8196385271085, 2414.0705828256073, 2414.95170096598, 2416.565018296706, 2351.7413084560685, 2389.9880500597474, 2399.30420178149, 2400.459896523277, 2401.711794584652, 2354.764523547649, 2370.312609343297, 2381.999560184718, 2385.976140238593, 2388.9641655375185, 2314.3288446350707, 2334.3697201755517, 2344.9648255276184, 2346.2843832631042, 2349.5535848188874, 2312.4681323295567, 2364.408897775556, 2392.473655795722, 2393.2939782764124, 2396.5446565152565, 10657.680269591925, 10876.401797901111, 10890.564377424893, 10894.346339219672, 10894.61868834587, 4953.925691114636, 5671.517920976722, 5857.619254748471, 5858.794942177046, 5863.237779088734, 3555.0, 3605.56733192016, 3639.490471334015, 3673.9081522961874, 3688.207035487383, 1183.3846399872018, 1191.910606704492, 1240.2372540887288, 1253.5737849131249, 1257.3273298785107, 13601.795973060413, 13927.791083133761, 14162.716745665131, 15270.236488175658, 15485.535433937, 4571.314302854598, 4742.52574742523, 4774.856754297377, 4786.16242157621, 4796.328514008042, 9641.903580964241, 11554.537818487335, 11563.88436115628, 11571.76856462866, 11575.479103440366, 4861.878453038632, 5044.848654540369, 5584.497395234448, 5754.223179870663, 5794.275715535558, 5112.565431938253, 5329.840104796862, 5346.117890548094, 5407.161889907071, 5429.864253393618, 3612.096975756061, 3631.7457777955287, 3889.8055097245024, 3939.763614183158, 4001.2597669431248, 1036.8341065429495, 1037.7353774787382, 1044.556063672936, 1054.9736256593494, 1055.456439933435, 892.1168043636753, 920.4667014951337, 921.2767977137914, 926.4672813132476, 952.642758965388, 6533.967330163414, 6579.407853293226, 6586.407223349922, 6586.8353291168105, 6627.37039981201, 964.243069190696, 968.2060710217695, 980.881794753981, 995.7311525887969, 998.7003898830467, 4051.108756073718, 4052.77709725962, 4093.7953102344763, 4124.958750412457, 4192.517860446027, 13412.262325571992, 13868.95982801294, 13895.930520347334, 13907.652308692364, 13951.0, 13446.798298025538, 13612.0, 13788.103773254707, 13921.860781392057, 13922.721545569031, 10020.148287395506, 10082.949585252027, 10153.695389138338, 10224.897751022543, 10291.382517049002, 6091.8781624366375, 6357.554971151975, 6432.774852880127, 6476.676166191577, 6578.276389597237, 10621.097206737204, 11889.762204756029, 12096.879031209575, 12257.877421225674, 12280.140390172959, 11696.415179241174, 11717.12121590867, 12381.876181238073, 12476.0, 12895.41970611306, 9224.077592240723, 9288.72133835986, 9322.720318390458, 9341.20599749029, 9425.764355891157, 10209.897901020895, 10238.078572928473, 10285.228607854291, 10318.690439286833, 10343.37939723619, 7952.920470795218, 9085.36402451822, 9122.498262595622, 9231.215346695606, 9393.342466027312, 8764.605592748214, 8921.643134274556, 8925.73222803291, 8973.685920992733, 8982.955085224532, 7644.808879777827, 7699.422543309386, 7792.61036948139, 7802.648880800264, 7803.868439076416, 5779.682117483579, 5789.8552536186935, 5806.4193580641595, 5873.089671100986, 5933.436323549256, 5557.916631250454, 5654.095344744821, 5776.104703770922, 5970.731317090828, 5970.76116955317], "value": 5096.97736648641, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.5704085402998, 373.0133796109291, 375.79143575315703, 379.5274882770951, 380.9561900381455, 4324.372965919943, 4940.777665005075, 5004.448620927515, 5193.091209038417, 5272.420033796284, 4481.46222453306, 4586.19741545229, 4705.270683044125, 4894.486078961711, 5170.870728231786, 3641.908952276188, 4228.682848786338, 4278.550752171024, 4312.353147027955, 4325.5458176891525, 3605.314990151876, 3998.860039898604, 4257.808398622054, 4279.261272785404, 4280.951166964098, 3330.217398911254, 3611.801350925698, 3784.186399924016, 4279.229738647043, 4308.676849236304, 3682.834272457746, 4010.573602970205, 4207.747535147901, 4244.0, 4344.891377715567, 3661.0, 3922.764634121962, 3940.4286378474962, 3960.960390396088, 3991.0, 4558.544145585448, 4758.0246049559755, 4971.577415919651, 5006.199008158677, 5050.924236136461, 4639.777802199982, 4644.86065418038, 4810.12409096723, 4909.975450122763, 4985.725785081819, 5499.755144464745, 5509.201165830932, 5530.446955304477, 5537.612367134302, 5544.77820887164, 4412.646988240933, 4435.911281774379, 4444.911101777979, 4446.622037126848, 4461.363988349485, 4804.399450068707, 5402.567794576425, 5534.695591742412, 5824.504917082053, 5850.473457388855, 3804.6385593368586, 3965.6629186518894, 4278.379634952977, 4446.510883802779, 4459.175052615276, 3817.675497582681, 4376.715513491677, 4564.475085365226, 4595.965907670814, 4626.421697287839, 4139.379093136054, 4395.868123956287, 4941.579965702884, 4950.9009819803405, 4983.775730092155, 5238.97380513095, 5456.890862182734, 5504.889902202013, 5523.364813046551, 5606.131049687305, 1616.9919150404173, 1669.5158404062686, 1715.4167583021833, 1749.0292887447588, 1750.719884818423, 1273.834401527814, 1308.9070626027374, 1340.8479390578177, 1403.3334166271143, 1437.8346490153558, 4440.600345968814, 4535.888707266741, 4552.772361381918, 5137.9743101285, 5211.530962213419, 4963.751812409365, 5182.74415817858, 5199.922001169985, 5572.693501857437, 5744.856378590569, 4346.369776382407, 4592.977035114803, 4700.482946875841, 4785.258284965836, 5137.794488220429, 2756.186924857172, 2921.284285350103, 2944.484715174836, 2953.1583498702767, 2957.4676558219726, 5596.412376700469, 5596.48010068274, 5856.443637854397, 5867.823965281048, 5899.557533184942, 5136.150985645165, 5235.869103272448, 5434.412349860079, 5497.835064948058, 5744.942550574524, 4637.837675681402, 4720.976395118002, 4863.732494712754, 5879.737190536826, 5917.260342457193, 5052.545270925634, 5131.307273518028, 5278.917821846589, 5363.919541206963, 5666.490015898589, 4660.976695116503, 5111.591072714248, 5285.656432331886, 5360.713428777143, 5408.916917357069, 5845.298564172326, 5863.677497737665, 5878.412158784087, 5884.764609415575, 5895.675737834289, 4247.384129301296, 4340.84807031765, 4912.6561140719805, 4967.552920237196, 4991.575716064175, 4501.549845015472, 4853.456976407172, 5175.990681817009, 5225.477452254744, 5579.693116878449, 4900.672180714132, 5512.944870551403, 5530.391656917816, 5532.889342213214, 5586.52514536269, 4533.0, 5093.0, 5197.402298735694, 5492.743124078871, 5592.412796656293, 4807.6394270429155, 5362.70505122222, 5384.219288203267, 5388.703621300866, 5391.705990562158, 4625.514320996247, 4952.603791696728, 5203.713795741271, 5558.0, 5567.91203298763, 4815.446223684321, 5011.298418221525, 5115.744212789271, 5309.150535914235, 5411.567074633941], "value": 4194.750072465205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.731975509184, 726.2991213478995, 750.2872271342226, 760.460073347923, 862.1335557764446, 14677.486287979922, 15396.153211573359, 15436.845631543682, 15438.150901700388, 15445.227738613066, 14112.858871411283, 14285.428582856699, 14317.427302907898, 14326.0, 14511.129332240072, 922.8892532896061, 927.7541451515353, 950.8763860698134, 950.9524523773783, 950.9952450237739, 921.424109931293, 952.9571169297399, 954.4654993203793, 954.746992047108, 955.5413401567251, 1003.4882210072878, 1005.9798804023915, 1006.4062203300051, 1006.8691070160905, 1007.8790545134594, 1001.7846163074973, 1005.1054561440324, 1005.3615953869272, 1005.5625802775816, 1006.4766321512845, 734.3794493652855, 737.6164394514876, 737.6975440069546, 737.7639155470251, 738.8928605352194, 15265.0, 15559.0, 15627.218639068114, 15890.443834465854, 16019.519414417586, 12277.570285039981, 13976.231307278096, 14203.573892783234, 14210.0, 14301.070430421989, 11278.492467838967, 11520.76958460826, 11641.35972521511, 11955.64133076009, 12131.393430328448, 3629.256002519477, 3654.3604869148057, 3675.1363429594026, 3822.9869084692577, 3823.330917089526, 118546.0, 121520.39239803833, 122004.0, 122326.0, 125272.0, 10649.787004259872, 10810.513526891309, 10871.293365931348, 11036.0, 11093.5562577496, 19206.0, 19249.51876203106, 23206.76793232046, 23248.76751232466, 23272.767272327397, 7634.885476717854, 7648.235176482419, 7726.652300646484, 7736.961315193388, 7738.148803631596, 4074.8997770601773, 4104.363823607346, 4226.091390351089, 4232.661387089025, 4535.569120933506, 3470.9305813884084, 3574.5531808523933, 3576.1059735066233, 3580.7672501287334, 3586.690857836923, 613.2763339259716, 634.9555531112778, 635.758411803521, 636.2238069555135, 636.5098873867097, 599.4544964082751, 679.3783687925493, 690.3131384272681, 698.183125742882, 702.5468572770534, 9592.568334424968, 9783.951080244553, 10162.491875406347, 10206.540705668263, 10509.789804203872, 658.2002866517205, 697.9581225126509, 703.3212949503753, 703.6622421237835, 711.2922641971272, 4781.593564546983, 4983.59940938054, 4989.62365805963, 5020.2720605511995, 5083.466236045162, 84033.0, 109489.0, 111243.0, 111983.44008279906, 112187.0, 56034.15948760772, 60092.0, 67868.0, 77309.0, 96432.58918526952, 75661.48677026539, 76884.61557692288, 77953.0, 78189.26337578158, 78450.6077469609, 10965.835512467478, 11100.722481938015, 11179.664610061385, 11227.27022743519, 11273.605423810128, 34798.65201347954, 48061.75969120132, 48501.0, 49114.50885491099, 50032.0, 51208.74395627998, 60569.394306056376, 65458.07251564921, 65841.67079164764, 66424.33575664375, 12846.67883302925, 12976.15654982423, 12983.935080324538, 13002.609921702364, 13614.795778063535, 13998.580042598738, 14138.50515232003, 15244.542663720105, 15517.22413879279, 15572.92213538925, 13525.932370338085, 14212.21832799206, 14217.715645686822, 14483.420663173776, 14586.562403127924, 13143.431768852366, 13731.588052358446, 14288.785668215192, 14302.213378264296, 14336.426542938165, 13634.386452609855, 13651.931740341235, 13826.0, 13943.721125577229, 13973.301334933009, 10690.41202733826, 11442.48508817122, 11634.476448559666, 11687.123465740273, 11887.762244754884, 10759.114166933012, 11169.408182113366, 11295.152863535432, 11505.769884602429, 11528.942355288169], "value": 7655.615271566918, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 119.0, 165.0, 171.0, 116.0, 115.0, 115.0, 114.0, 116.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 110.0, 142.0, 111.0, 107.0, 108.0, 114.0, 154.0, 134.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 185.0, 184.0, 184.0, 185.0, 184.0, 186.0, 181.0, 186.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 92.0, 59.0, 60.0, 60.0, 61.0, 93.0, 84.0], "value": 71.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 87.0, 71.0, 69.0, 69.0, 83.0, 69.0, 69.0, 85.0], "value": 75.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 86.0, 87.0, 86.0, 87.0, 86.0, 86.0, 87.0, 86.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 94.0, 96.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 84.0, 85.0, 85.0, 83.0, 86.0, 84.0, 85.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 65.0, 66.0, 66.0, 67.0, 65.0, 65.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 66.0, 56.0, 65.0, 61.0, 58.0, 58.0, 58.0, 57.0, 57.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 84.0, 84.0, 83.0, 84.0, 86.0, 87.0, 90.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 136.0, 151.0, 141.0, 140.0, 132.0, 192.0, 167.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 217.0, 172.0, 162.0, 164.0, 180.0, 216.0, 190.0, 164.0, 164.0], "value": 184.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 72.0, 74.0, 74.0, 80.0, 81.0, 77.0], "value": 72.2, "unit": "score"}]}]} 21:19:26 INFO - Return code: 0 21:19:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:19:26 ERROR - # TBPL SUCCESS # 21:19:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:19:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:19:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:19:26 INFO - 2017-03-21 21:19:26.402 screenresolution[1654:9890] starting screenresolution argv=screenresolution get 21:19:26 INFO - 2017-03-21 21:19:26.404 screenresolution[1654:9890] Display 0: 1600x1200x32@60 21:19:26 INFO - 2017-03-21 21:19:26.411 screenresolution[1655:9893] starting screenresolution argv=screenresolution list 21:19:26 INFO - Available Modes on Display 0 21:19:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:19:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:19:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:19:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:19:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:19:26 INFO - Intel Iris: 21:19:26 INFO - Chipset Model: Intel Iris 21:19:26 INFO - Type: GPU 21:19:26 INFO - Bus: Built-In 21:19:26 INFO - VRAM (Dynamic, Max): 1536 MB 21:19:26 INFO - Vendor: Intel (0x8086) 21:19:26 INFO - Device ID: 0x0a2e 21:19:26 INFO - Revision ID: 0x0009 21:19:26 INFO - Displays: 21:19:26 INFO - Display: 21:19:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:19:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:19:26 INFO - Display Serial Number: 1600x1200 60 21:19:26 INFO - Main Display: Yes 21:19:26 INFO - Mirror: Off 21:19:26 INFO - Online: Yes 21:19:26 INFO - Rotation: Supported 21:19:26 INFO - Return code: 0 21:19:26 INFO - Running post-action listener: _resource_record_post_action 21:19:26 INFO - [mozharness: 2017-03-22 04:19:26.648704Z] Finished run-tests step (success) 21:19:26 INFO - Running post-run listener: _resource_record_post_run 21:19:26 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 36660224; Write bytes: 511789056; Read time: 370; Write time: 2043 21:19:26 INFO - TinderboxPrint: CPU usage
53.7% 21:19:26 INFO - TinderboxPrint: I/O read bytes / time
36,660,224 / 370 21:19:26 INFO - TinderboxPrint: I/O write bytes / time
511,789,056 / 2,043 21:19:26 INFO - TinderboxPrint: CPU idle
2,226.4 (46.3%) 21:19:26 INFO - TinderboxPrint: CPU system
953.3 (19.8%) 21:19:26 INFO - TinderboxPrint: CPU user
1,626.1 (33.8%) 21:19:26 INFO - TinderboxPrint: Swap in / out
245,403,648 / 0 21:19:26 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202330624; Write bytes: 202229760; Read time: 15815; Write time: 549 21:19:26 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34718720; Write bytes: 298799104; Read time: 350; Write time: 1465 21:19:27 INFO - Running post-run listener: _upload_blobber_files 21:19:27 INFO - Blob upload gear active. 21:19:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:19:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:19:27 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'] 21:19:27 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 21:19:27 INFO - (blobuploader) - INFO - Open directory for files ... 21:19:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:19:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:19:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:28 INFO - (blobuploader) - INFO - Done attempting. 21:19:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:19:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:19:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:29 INFO - (blobuploader) - INFO - Done attempting. 21:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:30 INFO - (blobuploader) - INFO - Done attempting. 21:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:32 INFO - (blobuploader) - INFO - Done attempting. 21:19:32 INFO - (blobuploader) - INFO - Iteration through files over. 21:19:32 INFO - Return code: 0 21:19:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:19:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:19:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9302f38994ece559df06346b3ac84423937f8a6657055b85ded41969e1cd762e8b1e68839ad2684fe1fa584bf022bcba180be662c4a5df7bddb7327aff888752", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fef01e2861a6ae737798342cdafb1e1b96e45aec6178c7920e93fa64ce92f417f368c200c364a95f9876a73375ed015237efa74cdf135fcc5fadef0e0c5c3fe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/555aae42f796805de8a525abfdc2912813a5b0121eee056421434263f30bd59cbcf4811b6e2321d4531549909ec50cc5c4dbb595f4517499558e41cc01f21980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a54c975b76bd9ae742db3be62183038b553e26a37cdd76d58d075814a57800ce2cdadcc2b3c64cd55f6d5bca64cf6e2b91cba0e903af8174935c6fde6d311f3d"} 21:19:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:19:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:19:32 INFO - Contents: 21:19:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9302f38994ece559df06346b3ac84423937f8a6657055b85ded41969e1cd762e8b1e68839ad2684fe1fa584bf022bcba180be662c4a5df7bddb7327aff888752", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fef01e2861a6ae737798342cdafb1e1b96e45aec6178c7920e93fa64ce92f417f368c200c364a95f9876a73375ed015237efa74cdf135fcc5fadef0e0c5c3fe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/555aae42f796805de8a525abfdc2912813a5b0121eee056421434263f30bd59cbcf4811b6e2321d4531549909ec50cc5c4dbb595f4517499558e41cc01f21980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a54c975b76bd9ae742db3be62183038b553e26a37cdd76d58d075814a57800ce2cdadcc2b3c64cd55f6d5bca64cf6e2b91cba0e903af8174935c6fde6d311f3d"} 21:19:32 INFO - Running post-run listener: copy_logs_to_upload_dir 21:19:32 INFO - Copying logs to upload dir... 21:19:32 INFO - mkdir: /builds/slave/test/build/upload/logs 21:19:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.059549 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-21 21:19:32.930904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 21:19:32.938598) ========= 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.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/9302f38994ece559df06346b3ac84423937f8a6657055b85ded41969e1cd762e8b1e68839ad2684fe1fa584bf022bcba180be662c4a5df7bddb7327aff888752", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fef01e2861a6ae737798342cdafb1e1b96e45aec6178c7920e93fa64ce92f417f368c200c364a95f9876a73375ed015237efa74cdf135fcc5fadef0e0c5c3fe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/555aae42f796805de8a525abfdc2912813a5b0121eee056421434263f30bd59cbcf4811b6e2321d4531549909ec50cc5c4dbb595f4517499558e41cc01f21980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a54c975b76bd9ae742db3be62183038b553e26a37cdd76d58d075814a57800ce2cdadcc2b3c64cd55f6d5bca64cf6e2b91cba0e903af8174935c6fde6d311f3d"} build_url:https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/OqEyNVKxSHqPR7pkq2SBRw/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/9302f38994ece559df06346b3ac84423937f8a6657055b85ded41969e1cd762e8b1e68839ad2684fe1fa584bf022bcba180be662c4a5df7bddb7327aff888752", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fef01e2861a6ae737798342cdafb1e1b96e45aec6178c7920e93fa64ce92f417f368c200c364a95f9876a73375ed015237efa74cdf135fcc5fadef0e0c5c3fe2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/555aae42f796805de8a525abfdc2912813a5b0121eee056421434263f30bd59cbcf4811b6e2321d4531549909ec50cc5c4dbb595f4517499558e41cc01f21980", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a54c975b76bd9ae742db3be62183038b553e26a37cdd76d58d075814a57800ce2cdadcc2b3c64cd55f6d5bca64cf6e2b91cba0e903af8174935c6fde6d311f3d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 21:19:32.973000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:19:32.976360) ========= 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.74om74APRt/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.e5LUtJ82vk/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 21:19:33.024910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 21:19:33.028269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 21:19:33.028598) ========= ========= Total master_lag: 1.44 =========