builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0274 starttime: 1485045306.84 results: success (0) buildid: 20170121152525 builduid: fa07e65659e04500be54c4a020e00953 revision: d5343b0f7e6a9619dfdf333d259cff6b4f773bff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:06.843537) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:06.843969) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:06.844293) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:06.913800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:06.914233) ========= 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.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-01-21 16:35: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% 70.0M=0s 2017-01-21 16:35:07 (70.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.584904 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:07.524332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:07.524671) ========= 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.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.024780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:07.583007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:07.583416) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5343b0f7e6a9619dfdf333d259cff6b4f773bff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d5343b0f7e6a9619dfdf333d259cff6b4f773bff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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-01-21 16:35:07,691 truncating revision to first 12 chars 2017-01-21 16:35:07,691 Setting DEBUG logging. 2017-01-21 16:35:07,691 attempt 1/10 2017-01-21 16:35:07,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5343b0f7e6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-21 16:35:08,307 unpacking tar archive at: mozilla-central-d5343b0f7e6a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:08.500521) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:08.500919) ========= script_repo_revision: d5343b0f7e6a9619dfdf333d259cff6b4f773bff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:08.501405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:08.502330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-21 16:35:08.522748) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-21 16:35:08.523051) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:08 INFO - MultiFileLogger online at 20170121 16:35:08 in /builds/slave/test 16:35:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:35:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:35:08 INFO - {'append_to_log': False, 16:35:08 INFO - 'base_work_dir': '/builds/slave/test', 16:35:08 INFO - 'blob_upload_branch': 'Firefox', 16:35:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:35:08 INFO - 'branch': 'Firefox', 16:35:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:35:08 INFO - 'config_files': ('talos/mac_config.py',), 16:35:08 INFO - 'default_actions': ('clobber', 16:35:08 INFO - 'read-buildbot-config', 16:35:08 INFO - 'download-and-extract', 16:35:08 INFO - 'populate-webroot', 16:35:08 INFO - 'create-virtualenv', 16:35:08 INFO - 'install', 16:35:08 INFO - 'run-tests'), 16:35:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:35:08 INFO - 'download_minidump_stackwalk': True, 16:35:08 INFO - 'download_symbols': 'ondemand', 16:35:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:35:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:35:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:35:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:35:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:35:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:35:08 INFO - 'installer_path': 'installer.exe', 16:35:08 INFO - 'log_level': 'info', 16:35:08 INFO - 'log_name': 'talos', 16:35:08 INFO - 'log_to_console': True, 16:35:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:35:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:35:08 INFO - 'opt_config_files': (), 16:35:08 INFO - 'pip_index': False, 16:35:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:08 INFO - 'cmd': ('bash', 16:35:08 INFO - '-c', 16:35:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:08 INFO - 'enabled': True, 16:35:08 INFO - 'halt_on_failure': False, 16:35:08 INFO - 'name': 'check_screen_resolution'},), 16:35:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:35:08 INFO - 'cmd': ('bash', 16:35:08 INFO - '-c', 16:35:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:35:08 INFO - 'enabled': True, 16:35:08 INFO - 'halt_on_failure': False, 16:35:08 INFO - 'name': 'check_screen_resolution'},), 16:35:08 INFO - 'run_cmd_checks_enabled': True, 16:35:08 INFO - 'sps_profile': False, 16:35:08 INFO - 'sps_profile_interval': 0, 16:35:08 INFO - 'suite': 'dromaeojs', 16:35:08 INFO - 'system_bits': '32', 16:35:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:35:08 INFO - 'title': 't-yosemite-r7-0274', 16:35:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:35:08 INFO - 'use_talos_json': True, 16:35:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:35:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:35:08 INFO - 'work_dir': 'build'} 16:35:08 INFO - [mozharness: 2017-01-22 00:35:08.733871Z] Running clobber step. 16:35:08 INFO - Running pre-action listener: _resource_record_pre_action 16:35:08 INFO - Running main action method: clobber 16:35:08 INFO - rmtree: /builds/slave/test/build 16:35:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:35:11 INFO - Running post-action listener: _resource_record_post_action 16:35:11 INFO - [mozharness: 2017-01-22 00:35:11.167189Z] Finished clobber step (success) 16:35:11 INFO - [mozharness: 2017-01-22 00:35:11.167338Z] Running read-buildbot-config step. 16:35:11 INFO - Running pre-action listener: _resource_record_pre_action 16:35:11 INFO - Running main action method: read_buildbot_config 16:35:11 INFO - Using buildbot properties: 16:35:11 INFO - { 16:35:11 INFO - "project": "", 16:35:11 INFO - "product": "firefox", 16:35:11 INFO - "script_repo_revision": "production", 16:35:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:35:11 INFO - "repository": "", 16:35:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:35:11 INFO - "buildid": "20170121152525", 16:35:11 INFO - "pgo_build": "False", 16:35:11 INFO - "basedir": "/builds/slave/test", 16:35:11 INFO - "buildnumber": 22, 16:35:11 INFO - "slavename": "t-yosemite-r7-0274", 16:35:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:35:11 INFO - "platform": "yosemite_r7", 16:35:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:35:11 INFO - "branch": "mozilla-central", 16:35:11 INFO - "repo_path": "mozilla-central", 16:35:11 INFO - "revision": "d5343b0f7e6a9619dfdf333d259cff6b4f773bff", 16:35:11 INFO - "stage_platform": "macosx64", 16:35:11 INFO - "builduid": "fa07e65659e04500be54c4a020e00953", 16:35:11 INFO - "slavebuilddir": "test" 16:35:11 INFO - } 16:35:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 16:35:11 INFO - Running post-action listener: _resource_record_post_action 16:35:11 INFO - [mozharness: 2017-01-22 00:35:11.170794Z] Finished read-buildbot-config step (success) 16:35:11 INFO - [mozharness: 2017-01-22 00:35:11.170908Z] Running download-and-extract step. 16:35:11 INFO - Running pre-action listener: _resource_record_pre_action 16:35:11 INFO - Running main action method: download_and_extract 16:35:11 INFO - mkdir: /builds/slave/test/build/tests 16:35: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')]} 16:35:11 INFO - trying https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 16:35:11 INFO - Downloading https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 16:35:11 INFO - Downloaded 1199 bytes. 16:35:11 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 16:35:11 INFO - Using the following test package requirements: 16:35:11 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:35:11 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 16:35:11 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 16:35:11 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'jsshell-mac.zip'], 16:35:11 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 16:35:11 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 16:35:11 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 16:35:11 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 16:35:11 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 16:35:11 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 16:35:11 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 16:35:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:35:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:35:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:11 INFO - Fetch https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:35:12 INFO - Expected file size: 16350813 16:35:12 INFO - Obtained file size: 16350813 16:35:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:35:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 16:35:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:35:19 INFO - Fetch https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 16:35:20 INFO - Expected file size: 16350813 16:35:20 INFO - Obtained file size: 16350813 16:35:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 16:35:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:35:26 INFO - Fetch https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 16:35:27 INFO - Expected file size: 14403485 16:35:27 INFO - Obtained file size: 14403485 16:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:27 INFO - trying https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:35:27 INFO - Downloading https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 16:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 16:35:29 INFO - Downloaded 69940205 bytes. 16:35:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:35:29 INFO - mkdir: /builds/slave/test/properties 16:35:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:35:29 INFO - Writing to file /builds/slave/test/properties/build_url 16:35:29 INFO - Contents: 16:35:29 INFO - build_url:https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 16:35:31 INFO - Running post-action listener: _resource_record_post_action 16:35:31 INFO - Running post-action listener: set_extra_try_arguments 16:35:31 INFO - [mozharness: 2017-01-22 00:35:31.018878Z] Finished download-and-extract step (success) 16:35:31 INFO - [mozharness: 2017-01-22 00:35:31.019018Z] Running populate-webroot step. 16:35:31 INFO - Running pre-action listener: _resource_record_pre_action 16:35:31 INFO - Running main action method: populate_webroot 16:35:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:35:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:35:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:35:31 INFO - '--tppagecycles', 16:35:31 INFO - '7'], 16:35:31 INFO - 'tests': ['tsvgm']}}, 16:35:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:35:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:35:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:35:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:35:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:35:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['damp', 'tps']}, 16:35:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'tests': ['damp', 'tps']}, 16:35:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['dromaeo_dom']}, 16:35:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:35:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['basic_compositor_video']}, 16:35:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:35:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'other-e10s': {'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['a11yr', 16:35:31 INFO - 'ts_paint', 16:35:31 INFO - 'tpaint', 16:35:31 INFO - 'sessionrestore', 16:35:31 INFO - 'sessionrestore_no_auto_restore', 16:35:31 INFO - 'tabpaint']}, 16:35:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['tsvgx', 16:35:31 INFO - 'tsvgr_opacity', 16:35:31 INFO - 'tart', 16:35:31 INFO - 'tscrollx', 16:35:31 INFO - 'cart', 16:35:31 INFO - 'tsvg_static']}, 16:35:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:35:31 INFO - 'tsvgr_opacity', 16:35:31 INFO - 'tart', 16:35:31 INFO - 'tscrollx', 16:35:31 INFO - 'cart', 16:35:31 INFO - 'tsvg_static']}, 16:35:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'talos_options': ['--disable-e10s'], 16:35:31 INFO - 'tests': ['tp5o']}, 16:35:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:35:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'talos_options': ['--disable-e10s', 16:35:31 INFO - '--xperf_path', 16:35:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:31 INFO - 'tests': ['tp5n']}, 16:35:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:35:31 INFO - 'talos_options': ['--xperf_path', 16:35:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:35:31 INFO - 'tests': ['tp5n']}}, 16:35:31 INFO - 'talos.zip': {'path': '', 16:35:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:35:31 INFO - Running post-action listener: _resource_record_post_action 16:35:31 INFO - [mozharness: 2017-01-22 00:35:31.037232Z] Finished populate-webroot step (success) 16:35:31 INFO - [mozharness: 2017-01-22 00:35:31.037359Z] Running create-virtualenv step. 16:35:31 INFO - Running pre-action listener: _resource_record_pre_action 16:35:31 INFO - Running main action method: create_virtualenv 16:35:31 INFO - Creating virtualenv /builds/slave/test/build/venv 16:35:31 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 16:35:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:35:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:35:31 INFO - Using real prefix '/tools/python27' 16:35:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:35:31 INFO - Installing distribute.............................................................................................................................................................................................done. 16:35:34 INFO - Installing pip.................done. 16:35:34 INFO - Return code: 0 16:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:35:35 INFO - Reading from file tmpfile_stdout 16:35:35 INFO - Output received: 16:35:35 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) 16:35:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:35 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:35 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 16:35:35 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 16:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:35 INFO - 'HOME': '/Users/cltbld', 16:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:35 INFO - 'LOGNAME': 'cltbld', 16:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:35 INFO - 'MOZ_NO_REMOTE': '1', 16:35:35 INFO - 'NO_EM_RESTART': '1', 16:35:35 INFO - 'PAGER': '/bin/cat', 16:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:35 INFO - 'PWD': '/builds/slave/test', 16:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:35 INFO - 'SHELL': '/bin/bash', 16:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:35 INFO - 'USER': 'cltbld', 16:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:35 INFO - 'XPC_FLAGS': '0x0', 16:35:35 INFO - 'XPC_SERVICE_NAME': '0', 16:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:35 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 16:35:35 INFO - Cleaning up... 16:35:35 INFO - Return code: 0 16:35:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:35 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:35 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 16:35:35 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 16:35:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:35 INFO - 'HOME': '/Users/cltbld', 16:35:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:35 INFO - 'LOGNAME': 'cltbld', 16:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:35 INFO - 'MOZ_NO_REMOTE': '1', 16:35:35 INFO - 'NO_EM_RESTART': '1', 16:35:35 INFO - 'PAGER': '/bin/cat', 16:35:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:35 INFO - 'PWD': '/builds/slave/test', 16:35:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:35 INFO - 'SHELL': '/bin/bash', 16:35:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:35 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:35 INFO - 'USER': 'cltbld', 16:35:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:35 INFO - 'XPC_FLAGS': '0x0', 16:35:35 INFO - 'XPC_SERVICE_NAME': '0', 16:35:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:35 INFO - Downloading/unpacking psutil>=3.1.1 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:35 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 16:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:35:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:39 INFO - Installing collected packages: psutil 16:35:39 INFO - Running setup.py install for psutil 16:35:39 INFO - building 'psutil._psutil_osx' extension 16:35:39 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 INFO - building 'psutil._psutil_posix' extension 16:35:40 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 16:35:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:35:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:35:40 INFO - ^ 16:35:40 INFO - 1 warning generated. 16:35:40 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 16:35:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:35:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:35:40 INFO - Successfully installed psutil 16:35:40 INFO - Cleaning up... 16:35:40 INFO - Return code: 0 16:35:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:40 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:40 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 16:35:40 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 16:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:40 INFO - 'HOME': '/Users/cltbld', 16:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:40 INFO - 'LOGNAME': 'cltbld', 16:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:40 INFO - 'MOZ_NO_REMOTE': '1', 16:35:40 INFO - 'NO_EM_RESTART': '1', 16:35:40 INFO - 'PAGER': '/bin/cat', 16:35:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:40 INFO - 'PWD': '/builds/slave/test', 16:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:40 INFO - 'SHELL': '/bin/bash', 16:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:40 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:40 INFO - 'USER': 'cltbld', 16:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:40 INFO - 'XPC_FLAGS': '0x0', 16:35:40 INFO - 'XPC_SERVICE_NAME': '0', 16:35:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:40 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 16:35:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:35:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:35:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:35:43 INFO - Installing collected packages: mozsystemmonitor 16:35:43 INFO - Running setup.py install for mozsystemmonitor 16:35:43 INFO - Successfully installed mozsystemmonitor 16:35:43 INFO - Cleaning up... 16:35:43 INFO - Return code: 0 16:35:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:35:43 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')]} 16:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:43 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')]} 16:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:43 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:43 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 16:35:43 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 16:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:43 INFO - 'HOME': '/Users/cltbld', 16:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:43 INFO - 'LOGNAME': 'cltbld', 16:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:43 INFO - 'MOZ_NO_REMOTE': '1', 16:35:43 INFO - 'NO_EM_RESTART': '1', 16:35:43 INFO - 'PAGER': '/bin/cat', 16:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:43 INFO - 'PWD': '/builds/slave/test', 16:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:43 INFO - 'SHELL': '/bin/bash', 16:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:43 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:43 INFO - 'USER': 'cltbld', 16:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:43 INFO - 'XPC_FLAGS': '0x0', 16:35:43 INFO - 'XPC_SERVICE_NAME': '0', 16:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:44 INFO - Downloading/unpacking jsonschema==2.5.1 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:44 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 16:35:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:35:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:35:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:35:47 INFO - warning: no files found matching '*.txt' 16:35:47 INFO - no previously-included directories found matching 'build' 16:35:47 INFO - no previously-included directories found matching 'dist' 16:35:47 INFO - no previously-included directories found matching '.git*' 16:35:47 INFO - Installing collected packages: jsonschema, functools32 16:35:47 INFO - Running setup.py install for functools32 16:35:47 INFO - warning: no files found matching '*.txt' 16:35:47 INFO - no previously-included directories found matching 'build' 16:35:47 INFO - no previously-included directories found matching 'dist' 16:35:47 INFO - no previously-included directories found matching '.git*' 16:35:47 INFO - Successfully installed jsonschema functools32 16:35:47 INFO - Cleaning up... 16:35:47 INFO - Return code: 0 16:35:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:35:47 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')]} 16:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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')]} 16:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:47 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 16:35:47 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 16:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:47 INFO - 'HOME': '/Users/cltbld', 16:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:47 INFO - 'LOGNAME': 'cltbld', 16:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:47 INFO - 'MOZ_NO_REMOTE': '1', 16:35:47 INFO - 'NO_EM_RESTART': '1', 16:35:47 INFO - 'PAGER': '/bin/cat', 16:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:47 INFO - 'PWD': '/builds/slave/test', 16:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:47 INFO - 'SHELL': '/bin/bash', 16:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:47 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:47 INFO - 'USER': 'cltbld', 16:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:47 INFO - 'XPC_FLAGS': '0x0', 16:35:47 INFO - 'XPC_SERVICE_NAME': '0', 16:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:35:47 INFO - Cleaning up... 16:35:47 INFO - Return code: 0 16:35:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:35:47 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')]} 16:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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')]} 16:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:47 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:47 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 16:35:47 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 16:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:47 INFO - 'HOME': '/Users/cltbld', 16:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:47 INFO - 'LOGNAME': 'cltbld', 16:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:47 INFO - 'MOZ_NO_REMOTE': '1', 16:35:47 INFO - 'NO_EM_RESTART': '1', 16:35:47 INFO - 'PAGER': '/bin/cat', 16:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:47 INFO - 'PWD': '/builds/slave/test', 16:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:47 INFO - 'SHELL': '/bin/bash', 16:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:47 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:47 INFO - 'USER': 'cltbld', 16:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:47 INFO - 'XPC_FLAGS': '0x0', 16:35:47 INFO - 'XPC_SERVICE_NAME': '0', 16:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:35:48 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 16:35:48 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 16:35:48 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 16:35:48 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 16:35:48 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 16:35:48 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 16:35:50 INFO - Downloading blobuploader-1.2.4.tar.gz 16:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:35:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:35:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:35:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:35:51 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 16:35:51 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 16:35:51 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 16:35:51 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 16:35:51 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 16:35:51 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 16:35:51 INFO - Downloading docopt-0.6.1.tar.gz 16:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:35:52 INFO - Installing collected packages: blobuploader, requests, docopt 16:35:52 INFO - Running setup.py install for blobuploader 16:35:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:35:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:35:52 INFO - Running setup.py install for requests 16:35:52 INFO - Running setup.py install for docopt 16:35:52 INFO - Successfully installed blobuploader requests docopt 16:35:52 INFO - Cleaning up... 16:35:52 INFO - Return code: 0 16:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:52 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')]} 16:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 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')]} 16:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:52 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:52 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 16:35:52 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 16:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:52 INFO - 'HOME': '/Users/cltbld', 16:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:52 INFO - 'LOGNAME': 'cltbld', 16:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:52 INFO - 'MOZ_NO_REMOTE': '1', 16:35:52 INFO - 'NO_EM_RESTART': '1', 16:35:52 INFO - 'PAGER': '/bin/cat', 16:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:52 INFO - 'PWD': '/builds/slave/test', 16:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:52 INFO - 'SHELL': '/bin/bash', 16:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:52 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:52 INFO - 'USER': 'cltbld', 16:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:52 INFO - 'XPC_FLAGS': '0x0', 16:35:53 INFO - 'XPC_SERVICE_NAME': '0', 16:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-r0XveU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-XbFJHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-moRFR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-iO4hWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-3P2x2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-YDbwe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lQixfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:53 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1CtCLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-g5mFVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lS3zN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8DjCx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-fqBpOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-pYZTHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-Y3kir0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-OU0KgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-8eT1JV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:54 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-VVqJpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:35:55 INFO - Running setup.py install for manifestparser 16:35:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:35:55 INFO - Running setup.py install for mozcrash 16:35:55 INFO - Running setup.py install for mozdebug 16:35:55 INFO - Running setup.py install for mozdevice 16:35:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:35:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:35:55 INFO - Running setup.py install for mozfile 16:35:55 INFO - Running setup.py install for mozhttpd 16:35:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:35:55 INFO - Running setup.py install for mozinfo 16:35:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Running setup.py install for mozInstall 16:35:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Running setup.py install for mozleak 16:35:56 INFO - Running setup.py install for mozlog 16:35:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Running setup.py install for moznetwork 16:35:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Running setup.py install for mozprocess 16:35:56 INFO - Running setup.py install for mozprofile 16:35:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:35:56 INFO - Running setup.py install for mozrunner 16:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Running setup.py install for mozscreenshot 16:35:57 INFO - Running setup.py install for moztest 16:35:57 INFO - Running setup.py install for mozversion 16:35:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:35:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:35:57 INFO - Cleaning up... 16:35:57 INFO - Return code: 0 16:35:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:35:57 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:35:57 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 16:35:57 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 16:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:35:57 INFO - 'HOME': '/Users/cltbld', 16:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:35:57 INFO - 'LOGNAME': 'cltbld', 16:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:35:57 INFO - 'MOZ_NO_REMOTE': '1', 16:35:57 INFO - 'NO_EM_RESTART': '1', 16:35:57 INFO - 'PAGER': '/bin/cat', 16:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:35:57 INFO - 'PWD': '/builds/slave/test', 16:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:35:57 INFO - 'SHELL': '/bin/bash', 16:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:35:57 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:35:57 INFO - 'USER': 'cltbld', 16:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:35:57 INFO - 'XPC_FLAGS': '0x0', 16:35:57 INFO - 'XPC_SERVICE_NAME': '0', 16:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:35:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:35:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-v8ljop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:35:57 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)) 16:35:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:35:57 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-ueF2k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MrYgHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-H7tUjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-cgwtxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-MeoVT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-J9FbQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-sx0ZD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-1BkfQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-wOZpC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:35:58 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)) 16:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:35:58 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-9LExdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-gSIQ94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-lcIaT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-EKV0If-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-0drfrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-v33wGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:35:59 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)) 16:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:35:59 INFO - Running setup.py (path:/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/pip-UHCdgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:35:59 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)) 16:35:59 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)) 16:35:59 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)) 16:35:59 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)) 16:35:59 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)) 16:35:59 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)) 16:35:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:35:59 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 16:35:59 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 16:35:59 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 16:35:59 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 16:35:59 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 16:35:59 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 16:36:02 INFO - Downloading blessings-1.6.tar.gz 16:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:36:02 INFO - Installing collected packages: blessings 16:36:02 INFO - Running setup.py install for blessings 16:36:02 INFO - Successfully installed blessings 16:36:02 INFO - Cleaning up... 16:36:02 INFO - Return code: 0 16:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:02 INFO - Reading from file tmpfile_stdout 16:36:02 INFO - Current package versions: 16:36:02 INFO - blessings == 1.6 16:36:02 INFO - blobuploader == 1.2.4 16:36:02 INFO - docopt == 0.6.1 16:36:02 INFO - functools32 == 3.2.3-2 16:36:02 INFO - jsonschema == 2.5.1 16:36:02 INFO - manifestparser == 1.1 16:36:02 INFO - mozInstall == 1.12 16:36:02 INFO - mozcrash == 1.0 16:36:02 INFO - mozdebug == 0.1 16:36:02 INFO - mozdevice == 0.49 16:36:02 INFO - mozfile == 1.2 16:36:02 INFO - mozhttpd == 0.7 16:36:02 INFO - mozinfo == 0.9 16:36:02 INFO - mozleak == 0.1 16:36:02 INFO - mozlog == 3.4 16:36:02 INFO - moznetwork == 0.27 16:36:02 INFO - mozprocess == 0.24 16:36:02 INFO - mozprofile == 0.28 16:36:02 INFO - mozrunner == 6.13 16:36:02 INFO - mozscreenshot == 0.1 16:36:02 INFO - mozsystemmonitor == 0.3 16:36:02 INFO - moztest == 0.8 16:36:02 INFO - mozversion == 1.4 16:36:02 INFO - psutil == 3.1.1 16:36:02 INFO - requests == 1.2.3 16:36:02 INFO - wsgiref == 0.1.2 16:36:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:02 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:36:02 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 16:36:02 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 16:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:02 INFO - 'HOME': '/Users/cltbld', 16:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:02 INFO - 'LOGNAME': 'cltbld', 16:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:02 INFO - 'MOZ_NO_REMOTE': '1', 16:36:02 INFO - 'NO_EM_RESTART': '1', 16:36:02 INFO - 'PAGER': '/bin/cat', 16:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:02 INFO - 'PWD': '/builds/slave/test', 16:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:02 INFO - 'SHELL': '/bin/bash', 16:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:36:02 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:02 INFO - 'USER': 'cltbld', 16:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:02 INFO - 'XPC_FLAGS': '0x0', 16:36:02 INFO - 'XPC_SERVICE_NAME': '0', 16:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 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)) 16:36:03 INFO - Cleaning up... 16:36:03 INFO - Return code: 0 16:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:36: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')]} 16:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36: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')]} 16:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:03 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 0x10b8d8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe43da4fd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, '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.FAj5AREiZ8/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.eGEIEomiAb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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 16:36:03 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 16:36:03 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 16:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:03 INFO - 'HOME': '/Users/cltbld', 16:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:03 INFO - 'LOGNAME': 'cltbld', 16:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:03 INFO - 'MOZ_NO_REMOTE': '1', 16:36:03 INFO - 'NO_EM_RESTART': '1', 16:36:03 INFO - 'PAGER': '/bin/cat', 16:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:03 INFO - 'PWD': '/builds/slave/test', 16:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:03 INFO - 'SHELL': '/bin/bash', 16:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:36:03 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:03 INFO - 'USER': 'cltbld', 16:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:03 INFO - 'XPC_FLAGS': '0x0', 16:36:03 INFO - 'XPC_SERVICE_NAME': '0', 16:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:36:03 INFO - Cleaning up... 16:36:03 INFO - Return code: 0 16:36:03 INFO - Running post-action listener: _resource_record_post_action 16:36:03 INFO - Running post-action listener: _start_resource_monitoring 16:36:03 INFO - Starting resource monitoring. 16:36:03 INFO - [mozharness: 2017-01-22 00:36:03.510701Z] Finished create-virtualenv step (success) 16:36:03 INFO - [mozharness: 2017-01-22 00:36:03.511700Z] Running install step. 16:36:03 INFO - Running pre-action listener: _resource_record_pre_action 16:36:03 INFO - Running main action method: install 16:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:36:03 INFO - Reading from file tmpfile_stdout 16:36:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:36:03 INFO - Reading from file tmpfile_stdout 16:36:03 INFO - Output received: 16:36:03 INFO - Usage: mozinstall [options] installer 16:36:03 INFO - Options: 16:36:03 INFO - -h, --help show this help message and exit 16:36:03 INFO - -d DEST, --destination=DEST 16:36:03 INFO - Directory to install application into. [default: 16:36:03 INFO - "/builds/slave/test"] 16:36:03 INFO - --app=APP Application being installed. [default: firefox] 16:36:03 INFO - mkdir: /builds/slave/test/build/application 16:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:36:25 INFO - Reading from file tmpfile_stdout 16:36:25 INFO - Output received: 16:36:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:36:25 INFO - Running post-action listener: _resource_record_post_action 16:36:25 INFO - [mozharness: 2017-01-22 00:36:25.709464Z] Finished install step (success) 16:36:25 INFO - [mozharness: 2017-01-22 00:36:25.709604Z] Running run-tests step. 16:36:25 INFO - Running pre-action listener: _resource_record_pre_action 16:36:25 INFO - Running main action method: run_tests 16:36:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:25 INFO - 2017-01-21 16:36:25.724 screenresolution[1638:8044] starting screenresolution argv=screenresolution get 16:36:25 INFO - 2017-01-21 16:36:25.727 screenresolution[1638:8044] Display 0: 1600x1200x32@60 16:36:25 INFO - 2017-01-21 16:36:25.732 screenresolution[1639:8047] starting screenresolution argv=screenresolution list 16:36:25 INFO - Available Modes on Display 0 16:36:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:25 INFO - Intel Iris: 16:36:25 INFO - Chipset Model: Intel Iris 16:36:25 INFO - Type: GPU 16:36:25 INFO - Bus: Built-In 16:36:25 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:25 INFO - Vendor: Intel (0x8086) 16:36:25 INFO - Device ID: 0x0a2e 16:36:25 INFO - Revision ID: 0x0009 16:36:25 INFO - Displays: 16:36:25 INFO - Display: 16:36:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:25 INFO - Display Serial Number: 1600x1200 60 16:36:25 INFO - Main Display: Yes 16:36:25 INFO - Mirror: Off 16:36:25 INFO - Online: Yes 16:36:25 INFO - Rotation: Supported 16:36:25 INFO - Return code: 0 16:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:36:25 INFO - Python 2.7.3 16:36:25 INFO - Return code: 0 16:36:25 INFO - grabbing minidump binary from tooltool 16:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:36:25 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 0x10b6b6d30>, '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 0x10b5dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6abbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:36:25 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 16:36:25 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 16:36:25 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 16:36:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:36:26 INFO - Return code: 0 16:36:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:36:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:36:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:36:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:36:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 16:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0274 --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 16:36:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FAj5AREiZ8/Render', 16:36:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:36:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:36:26 INFO - 'HOME': '/Users/cltbld', 16:36:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:36:26 INFO - 'LOGNAME': 'cltbld', 16:36:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:36:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:26 INFO - 'MOZ_NO_REMOTE': '1', 16:36:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:36:26 INFO - 'NO_EM_RESTART': '1', 16:36:26 INFO - 'PAGER': '/bin/cat', 16:36:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:26 INFO - 'PWD': '/builds/slave/test', 16:36:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:36:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:36:26 INFO - 'SHELL': '/bin/bash', 16:36:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eGEIEomiAb/Listeners', 16:36:26 INFO - 'TMPDIR': '/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/', 16:36:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:36:26 INFO - 'USER': 'cltbld', 16:36:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:36:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:26 INFO - 'XPC_FLAGS': '0x0', 16:36:26 INFO - 'XPC_SERVICE_NAME': '0', 16:36:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:36:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0274', '--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 16:36:26 INFO - mozversion application_buildid: 20170121152525 16:36:26 INFO - mozversion application_changeset: d5343b0f7e6a9619dfdf333d259cff6b4f773bff 16:36:26 INFO - mozversion application_display_name: Nightly 16:36:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:36:26 INFO - mozversion application_name: Firefox 16:36:26 INFO - mozversion application_remotingname: firefox 16:36:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:36:26 INFO - mozversion application_vendor: Mozilla 16:36:26 INFO - mozversion application_version: 53.0a1 16:36:26 INFO - mozversion platform_buildid: 20170121152525 16:36:26 INFO - mozversion platform_changeset: d5343b0f7e6a9619dfdf333d259cff6b4f773bff 16:36:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:36:26 INFO - mozversion platform_version: 53.0a1 16:36:26 INFO - using testdate: 1485045386 16:36:26 INFO - actual date: 1485045386 16:36:26 INFO - starting webserver on 'localhost:49243' 16:36:26 INFO - SUITE-START | Running 2 tests 16:36:26 INFO - TEST-START | dromaeo_css 16:36:26 INFO - operating with platform_type : mac_ 16:36:26 INFO - Initialising browser for dromaeo_css test... 16:36:26 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpWnSv4d/profile http://localhost:49243/getInfo.html) 16:36:28 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 16:36:28 INFO - PROCESS | 1649 | colorDepth:24 16:36:28 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 16:36:28 INFO - PROCESS | 1649 | __metrics 16:36:28 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 16:36: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" 16:36: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] 16:36:29 INFO - TEST-INFO | 1649: exit 0 16:36:29 INFO - Browser initialized. 16:36:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:36:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpWnSv4d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:36:41 INFO - PROCESS | 1652 | RSS: Main: 235954176 16:36:41 INFO - PROCESS | 1652 | 16:39:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 16:39:46 INFO - PROCESS | 1652 | RSS: Main: 360423424 16:39:46 INFO - PROCESS | 1652 | 16:41:31 INFO - PROCESS | 1652 | ************************* 16:41:31 INFO - PROCESS | 1652 | A coding exception was thrown and uncaught in a Task. 16:41:31 INFO - PROCESS | 1652 | 16:41:31 ERROR - PROCESS | 1652 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:41:31 INFO - PROCESS | 1652 | Full stack: 16:41:31 INFO - PROCESS | 1652 | ************************* 16:42:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 16:42:50 INFO - PROCESS | 1652 | RSS: Main: 365346816 16:42:50 INFO - PROCESS | 1652 | 16:45:52 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 16:45:53 INFO - PROCESS | 1652 | RSS: Main: 339648512 16:45:53 INFO - PROCESS | 1652 | 16:48:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 16:48:56 INFO - PROCESS | 1652 | RSS: Main: 353959936 16:48:56 INFO - PROCESS | 1652 | 16:51:59 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 16:52:00 INFO - PROCESS | 1652 | RSS: Main: 330735616 16:52:00 INFO - PROCESS | 1652 | 16:55:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 16:55:04 INFO - PROCESS | 1652 | RSS: Main: 517210112 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | __start_tp_report 16:55:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 16:55:04 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 16:55:04 INFO - PROCESS | 1652 | |i|pagename|runs| 16:55:04 INFO - PROCESS | 1652 | |0;dojo.html;3295.1267914002788;3352.580927384077;3353.6478669739663;3381.5773028371455;3406.50605662179;5606.383297837245;5664.688442135686;5693.174489698991;5719.256496655429;5757.683327416996;5682.829515114553;5699.430056994299;5780.843831233759;5796.985527532686;5835.59150859439;5093.108705976458;5122.052420302238;5127.871803204913;5187.4034486034025;5231.2937753403185;5270.472952704718;5285.339332583427;5292.10034294169;5292.391374991887;5312.840614781563;5117.769700363456;5279.128943724281;5285.7357132143625;5296.046711591912;5315.255864179018;5151.304573882516;5156.252343410185;5213.244079608436;5216.113260745682;5230.08473517133;5155.664881782672;5223.2165175223645;5226.477352264781;5235.764390602432;5262.210668399733;5661.7735290588325;5679.630823996427;5715.571332150105;5741.8564535886935;5785.913211301834;6155.661438620874;6198.535109866778;6200.3179650238435;6246.344133865924;6307.05394190875;6250;6297.118403423525;6310.463610593105;6320.652364119972;6331.2085989251345;5884.735186916599;5887;5895.616784908967;5911.586188966817;5954.37479064692;6186.443220110212;6214.9067763982675;6253.468455181361;6257.030160325156;6317.1156038154695;6172.475339596095;6194.876102477925;6236.282827474808;6237;6244.968775156095;6162.845928851814;6291.370862913764;6298.874022519524;6299.118123462719;6301;6109.26082417852;6163.722632481549;6181.381861813873;6222.595531290452;6235.064740288993;6277.937220627735;6285.685715714196;6288.811335659938;6291.087792270187;6300.21247344082;4949.7030178189425;5045.318881950963;5047.293378926953;5061.114304996611;5074.898502029939;4429.446319210098;4432.246518091933;4453.821847126143;4456.264716321771;4522.841700540531;5852.970735146297;5914.615549989237;5914.792982245601;5927.2590926134235;5929.792457263975;6260.092286618506;6274.560780745304;6284.340144284784;6317.431431171125;6331.588446750947;5611.6352437091455;5734.111212762028;5880.147378630075;5887.646741195542;5908.261467316585;5260.710660913686;5431.131019036935;5438.945610543844;5444.020076386209;5448.373437054789;6243.250809902841;6248.4376406123665;6265.467435268053;6274.654893980693;6276.278228003838;6214.4407003369915;6224.315325314303;6244.406781355764;6260.561760676709;6309.3690630936535;6321.96839015802;6345;6347.428731414195;6353.7140828661895;6358;6276.1213430118905;6284.968575157095;6295.968520157553;6298.527610429144;6306.779262725782;6115.757578772925;6191.5665903388135;6222.408871157233;6229.56393052482;6238.844028899314;5604.439556044526;6213.65824879636;6215.906761398493;6221.346758590283;6235.501159907106;6170.043643235305;6182.845428864314;6188.535859810622;6188.752449901954;6191.721372538156;5808.796692115756;5840.8247752567495;5853.1805547222575;5881.705914704162;6045.093236014633;6103.450689437972;6104.20645316106;6112.144299798121;6120.724567394389;6127.264728232641;5927.4665280125;5931;5933.673647949404;5934.910976335272;5934.9109763354445 16:55:04 INFO - PROCESS | 1652 | |1;ext.html;445.22308571542663;490.46539272193303;497.5174081141294;504.64170438988305;513.2737176894694;30863.537046944286;32461.67538324616;32496.83751581239;32588.1852953676;40111;33673;39548.81353559391;41224.175516489726;41457.7927110364;42995.78502107485;9225.354225204239;9435.481048542328;9442.575084121198;9461;9471.194948429391;8352.16478352166;8572.057073721917;9325.95337023314;9468.195203407719;9477.431354118775;11195.552177912914;11449.828252576219;11456.770864582704;11621.709457263552;11676.1826672133;11312.264702794291;11392.487338069806;11404.54381824726;11437.313761174315;11437.771244575062;8309.418340716153;8536.70121545743;11272.98543131114;11328.546858125665;11373.294005899099;33421;39781.60218397808;40461.59538404608;42412.57587424148;42527.7873610633;4049.6152865477734;4052.4790054092755;4095.4675892133832;4104.261232978063;4105.507339119295;30311.393772124433;30502;30868.382632347228;31189.84405077983;31262;3220.5008223725126;3221.7100460958627;3261.9347613047844;3289.3750187464307;3343.8328083595725;479100;485752;485976;487634;487644;63160.684196578724;63425.68287158535;63476;63522;63545.36454635487;66529.00206496907;66676.33323666798;66709.6658066836;66710.66644666746;67027.66486167538;15832.525024249291;16258;16321.83678163227;16327.591810204602;16353.672926541403;12549.87450125487;12627.810582841264;12628.305443200712;12634.368281586068;12634.873651263553;15613.219339033003;16008.919955400148;16019.599510012344;17675.82324176742;17867.927924324584;6910.585364878123;7053.153621565342;7134.57656253116;7165.09813525523;7279.41764658826;866.2030931542996;866.445474896067;873.3188113271658;874.3180319350917;906.723449347942;29509.032561208784;29534.409311813644;29921.409430868436;30317.848410757804;30359.392812143633;1034.6895931220604;1078.487718333785;1080.400377790334;1086;1139.2993309114834;15066.849331506764;15505.534833955;15521.844781552265;15533;15950.441734539236;587634;591061;591685;591857;592386;61096.69451652713;61450.69274653688;61482.0777688335;61518;61546;1216.9817452738216;1396.9092009019382;1450.0139904864793;1456.89801713879;1457.4024649893493;28949;29051.854740727005;29134.7086529132;29789.702102978692;29816.254593634465;52249.47750522446;52723;52723.47276527339;52731.73634131805;52976;358115;430346;430807;431001;431236;24343.14798982027;24845.006199751806;25069.49861002733;25762.742372576784;40726.79636601917;34765.116081723645;42734.57265427306;43553.56446435622;44782;45045;33819.830900845336;35906.8204658975;36918.815405922796;37032.25935481329;37252;35322.646773532964;35412;35427.82286088553;36498.27003459969;36737.81631091827;35188.47217291794;35567.46648800322;35740.28519429649;35950;35955.280894381445;29668.703312966594;29769.25576860596;31754.841225793723;31892.5216121763;31924.8403757989;23632;23646.527069458858;23863.403414914766;24044.27867163988;24278 16:55:04 INFO - PROCESS | 1652 | |2;jquery.html;390.3403248510018;391.21951706345834;396.1087553005737;401.7067540695292;423.7097588152116;19886.70169947452;20803.791962080373;21213.939303034844;21225.57548849022;21567.568648627017;21570.56858862822;21826.781732182673;22055.676659400448;22483.775162248414;22721.431964200903;5725.656460612367;6042.546808989343;6044.184035155264;6049.425304596057;6053.727582258787;5733.885322293551;5889.352171261158;5916.083007133901;5919.644821310713;5985.132155837401;5939.109133629947;5940.316863560681;5942;5943.583949123563;5946.702664866761;4837.443693975185;5255.9750848584545;5777.740001699934;5903.645781253139;5923.792667256647;5158.200478925773;5163.845084647466;5172.379314482248;5174.896502069975;5178.352705911761;24547.509049818902;25504;26113;26663.466730665277;26848.865755671097;2595;2619.2011436511857;2680.3567143885325;2692.4480481501246;2692.8384296942245;10099.040591143903;10102.898971010269;10172.94913525435;10535.209859260509;10656.413897235649;1763.7001709709252;1864.7109697996832;1870.3173341730308;1872.1668857358482;1893.3751861885544;90037;100697;101643.49178254136;102070.4896475513;133596;11265.887341126483;11514.654560363202;11527.48126334317;11544.88455115455;11547.018503427134;14769.489186838264;15736.134512601688;15770.60573485649;15777.526674199793;15801.446949356718;7608.2011388804485;7992.682122184501;8638.17937295956;8666.480011199223;8772;7182.270737119861;7616.8476630467085;7773.494722842997;7783.260590243918;7975.2423519765525;4568.383268258743;4803.735794531334;4808.951910480921;4875.122477953932;4891.1685013547785;1970.8521860860492;2001.4095841726726;2006.4081096076693;2009.8593098482966;2023.4840115770385;1006.1447769395954;1007.6322142418111;1012.529428195216;1017.8524114003428;1051.4427353502656;21262.83054432021;21668.78331216699;21701.891490542763;21791.12835486563;21794.782052179275;956.268454632207;999.7300728803328;1002.3434650304063;1040.958361665525;1045.1168762395764;10610.57557697699;10974.615888443866;10991.285566438157;11344.43277836105;11350.09199264057;641039;689138;708122;719189;731137;136211;139853;143816;144521;149903.25048374906;1027.2603725317758;1046.2467023742893;1098.4343063322394;1103.3545375954996;1103.7461383881753;17666;20082.09630566657;20343.084561194486;20543.691844622044;20622.793772062087;57119.71440142773;59044.819103618545;60840.69579652251;61277.38722612895;61551.384486156356;88015.55992219997;89688;89940.55029724809;90014.64978025467;91778.08221917962;6311.463525600376;7029.859402811813;7524.360429363565;7545.962270188614;7731.34283585879;10195.949020254851;12655.683607909876;13240.874525665426;13308.46766129344;13911.304434778423;9635.518224088908;10367.94816025915;10688.679339619825;10983.231173818076;12003.219790713576;11155.665330040112;11316.321020738782;11564.42177891119;11624.302541847515;11738.29570225755;10709.143268538654;11238.719032024264;11378.886211137782;11877.168598198043;11918.463669135082;6596.934030659632;7456.813579660552;7687.88468172989;7711.26742959418;7839.529628222325;10069.446180460145;11526.654200374001;11729.061675065803;11855.229410088317;11897.940510297392 16:55:04 INFO - PROCESS | 1652 | |3;mootools.html;1475.1591592792106;1480.7778833175016;1485.517206907755;1500.0474698566413;1505.7515509940856;8020.077691065522;8402.033766116898;8408.24325810677;8425.747227583168;8427.789305267364;7410.740174170391;7624.961875190616;7937.2459616336355;8169.101398846122;8209.425340226186;2294.1511640692925;2339.087755775249;2339.801116905065;2342.402687314741;2348.9647655285185;2279.2136712834044;2310.699609050821;2322.0479603362623;2337.55586438577;2346.9178578749747;2298.482841360697;2310.595645761993;2312.236961802601;2336.485973085927;2349.3304408243653;2283.0297123722435;2308.53408085865;2308.6421604651223;2315.7568455312116;2318.5826551220775;2254.0983606557343;2320.048780000209;2325.2559181062065;2326.6975293211945;2334.2880421471446;8271.875921861178;8336.166383361677;8342.749717508485;8344.749657510285;8357.916420835774;5024.422191447994;5188.507091826271;5199.662021968597;5204.505571970657;5208.401033881114;3283.8522266498067;3334.5164951081956;3508.596511401196;3561.216532362902;3562.3765840977985;1247.950081996719;1258.1884684378615;1407.6340151560566;1747.309812624019;1821.571930596309;10463.633772817915;10487.685369438928;10597.364158150458;10605.257631965766;10611.522481488351;3649.9635003649623;4365.934510982338;4377.255866502702;4419.20197515134;4453.064856380196;8575.914240857512;8639.481631102153;8641.351898607629;8649.524276164871;8659.09079546651;4497.550244975541;4931.0630980113665;5017.992802878877;5083.262926875583;5085.262636917626;4121.093359460914;4122.814473348706;4798.352222449995;4802.495737947535;4813.326134341195;3544.8227588620466;3570.250247448065;3622.673959343672;3647.544056992876;3649.434337677664;1114.7213196700825;1120.5853834081279;1121.103117505992;1125.482278152043;1129.1644183304295;783.1346362269724;826.2192228344157;886.9822603548022;894.3337213775778;934.0985948559672;5188.584913206934;5507.972460137754;5608.242887210175;5621.100623900156;5794.246747922743;852.7441767469734;935.4751754639893;951.4481600671594;959.467495539982;1024.3546565663733;3503.1067077894972;3579.1767893384667;3716.349638813197;3745.5879853216125;3824.9808750956067;9594.280428967855;9781;9914.305998580174;9917.355371900803;9925.255605829447;9820;9845.360051596623;9848.409095454295;9858.704238872846;9869.555869985868;7204.783856484314;7549.9245007549225;7556.848863022708;7580.507267027736;7717.073951125789;5222.660527065728;5462.6995515247045;5587.892898719448;5616.410276921028;5683.204351390726;8534.402591818513;8754.47473151613;8794.340424468062;8833.277510885315;9291.117343852324;8760.956195218983;9042.457452552868;9266.351355405057;9369.437833729999;9404.012578679414;6528.771492997722;6740.966295168493;6743.325667433218;6927.272636373108;7133.251008644225;7534.962325188559;7804.726834560764;7843;7921.564313962787;7930.36557075421;6905.516613836983;6983.022376867141;6983.860322793414;7051.541649792747;7060.188078371053;6792.728290868507;6855.725770969106;6868.725250989904;6881;6930.584164950119;6206.193194884636;6257.624542527463;6345.333739957238;6345.365463453618;6365.331640177715;4882.170031094794;4903.26451032348;4946.975265123651;4978.178600530872;5050.3434553507805;4886;4904.583110435653;4968.751562421937;4996.200607902718;5070.315507406601 16:55:04 INFO - PROCESS | 1652 | |4;prototype.html;358.84569635056926;360.18238598381674;369.9019759763662;382.44354464254513;382.7320875387226;4770.475247722748;4818.2299523471775;5142.842860356418;5233.738313084345;5375.704336261504;4456.844010459635;4522.706024108439;4813.772488015551;4937.629677774173;5187.351581052369;3102.3795240951786;3544.4227318843127;4034.6368826805583;4073.9388909166237;4093.6520395766397;4119.258533463975;4131.0085579460865;4145.647619952292;4183.6653067754505;4221.804661575979;3405.7615966882327;3706.721995850322;4008.098177909976;4108;4117.938230926538;3930.941035884464;3968.543617483969;3984.94775190777;3990.0623353512046;3993.1614360984227;2883.480973424783;3441.984614538717;3443.328550932569;3447.4311738563106;3467.8959631211105;4384.693071484998;4997.400311962551;5100.260462232955;5126.71803050832;5136.5377116059735;3843.1929294848114;3912.7652340859354;4554.908901821978;4568.817247310104;4587.3348364486965;4689.226277664181;5149.613778966593;5249.8975215204855;5548.6948217848;5574.58190635704;3282.6553211912883;3372.291818718072;3815.893390916631;3862.439946207812;3872.9806350968347;5643.294588176478;5740.655560666331;5798.623089499169;5798.768049277982;5864.413558644102;3636.0000999724757;3816.709974015624;3855.4024126260474;3861.961380386216;3922.705507182623;3876.5850464580226;3924.548676902136;3925.548561915359;3926.823292951824;3961.6830653547645;3730.757500762442;3953.715042611163;4303.311470164821;4547.1815073287125;4609.654275929319;4624.791884365211;4692;5468.781248750085;5595.146475297627;5728.854229154186;1119.7032786311634;1133.3143448213877;1176.3471273443322;1196.8623608284984;1259.8614152443224;708.373089815517;765.3494529649864;823.5264722784423;831.6651773902798;858.656537385051;4240.872773816791;4662.137504561667;4798.592119669867;4835.274708793709;4883.902321953541;5295.152775555893;5378.489043540857;5421.376541697677;5432.076546987022;5453.945460545423;3874.7093967952515;4226.894327641833;4492.663050271242;4821.011692603008;4889.193283108319;2531.6455696202547;2798.174538511144;2813.8452385118608;2823.7035111313426;2834.2489240351324;4937.469384490748;5129.9743501282255;5497.47773961473;5503.091989821714;5621.943780562224;4450.992633287551;4564.748938808331;4635.745034023161;5137.897242055213;5556.749946252347;4796.35249241348;5442.020436321421;5593.4338385252195;5658.717064146858;5664.037113690682;4427.69006169565;4778.658457355801;5293.550048245942;5323.3878104016985;5402.405735369185;4684.2597080708165;4700.576948074689;5181;5215.087359711959;5304.60215483848;5141.126008578625;5236.967534997954;5432.728363581726;5535.750891209825;5537.280153580009;3293.2590167212184;3651.707863370977;3665.541807274091;3665.87169449068;3666.8182431453242;5257.237700533477;5396.892062158813;5517.613767036269;5648.8084232408555;5744.013113181206;5101.923471147861;5579.13523403873;5582.8325150245555;5584.553235741212;5590.580706446952;4834.685745426536;5248.6325957182635;5509.090999984957;5566.805161819317;5605.32736071674;4985.376827896513;5186.351706036746;5428.67427954324;5457.536109430743;5490.588205884655;4587.357769912148;4834.734089625104;5471.945280547303;5486.488647265833;5522.085344043724;4303.806328715153;4622.075584882969;4797.832075877328;5320.989012087691;5514.2004409359615 16:55:04 INFO - PROCESS | 1652 | |5;yui.html;705.7071315404107;725.303708439898;728.9125304963405;789.8657228271194;842.0947481457434;14823.851761482381;15405.306761195745;15609.297581608813;15614;15639.687206255869;14281.642958926006;14395.92802035991;14402.783958240609;14410.06334588251;14422;598.0461164442729;612.8529153003269;847.1867007672641;852.8209076094013;873.1137895036543;861.3238607692962;861.7371701631;867.5141920524495;873.6418068591847;874.5583480342418;925.5233554719325;925.763930197802;926.1155596405416;928.6842473558988;928.9396189247711;716.8996340512281;737.4505993035223;915.9816803663923;919.9816003679956;921.3228277216274;662.5329142954206;682.5631595778706;684.3293572299175;684.7295318349225;686.5606012152226;14815.333310001075;14832.703345933021;14838.925805371013;14855.331510082073;14857.628559285997;13132.6716832079;13158.934205328913;13258.138221015699;13434.261115638636;13475.66310842227;11559.78622244669;13051.15167514118;13059.347032648424;13084.149530280501;13348.799768003488;4474.910501789978;4520.3219517072375;4531.682782205247;4606.401167848192;4710.552497512731;105334;106805.46597267041;106899.46550267277;107209;109677;11014;11025.44872756359;11130.833037504444;11143.888561114447;11414.42927853604;21059.36821895315;21958.560828783335;22021.889890550443;22033.669494957587;22333;6932.826679333057;7857;7859.764207073797;7864.4888082274465;7936.444448888522;3701.5627491628106;4296.699231053859;4374.10584781714;4376.846810361622;4421.314696222091;3512.613612502623;3564.3405969895653;3569.3218288525095;3607.026102952188;3617.113807117273;563.6927874308429;664.1333060356185;668.3750693101965;682.8327059870264;683.255251775567;569.3054473542272;646.5732616473106;675.7026908160394;703.4372501998483;711.8042538301905;10007.899921000697;10270.229732770073;10329.793404131875;10367;10442.112420444348;679.2629996453903;699.8950157476419;710.761894765249;716.4662326566742;719.899214110025;4669.813207471731;4994.650374473752;5019.949800502021;5045.990027216534;5061;100346;101823;102173;102398;102647.46028809574;71446.64276678584;88727;88912;89817;91876;60944.476388090654;63742.6812865942;63967;64309.67845160744;75028.87456688263;8363.289120424832;9405.85891211646;10347.27569070188;10829.079528240189;11076.612318569134;41286.58713412828;45272.32091518564;50048.49951500438;50052.998940021724;50935.23597145972;50522.7473862643;63672.36327636665;64283.67858160679;64546.35453645403;64936.675316623114;12676.985841132502;12805.615831525069;12864.935675321563;13238.470461181445;13433.865661343652;14206.573802785933;14318.882390135897;14335.584806020595;14347;14467.85532144665;13217.537386191438;13224.272665003133;13385.330733463483;13470.730585388434;13970.580882573538;13345.532906348231;13349.399277032751;13654.726905461637;13941.512047078304;14054.01621886499;13133.212007279593;13339.799903001269;13350.865176460109;13512.324383780575;13798.310084495533;9380.95309523448;9441.433513989183;10845.240833141605;10910.180238653826;11270.464145567183;7146.857062858818;8760.44658367484;9830.164436023018;10257.562144354479;10475.790484190426 16:55:04 INFO - PROCESS | 1652 | __end_tp_report 16:55:04 INFO - PROCESS | 1652 | __start_cc_report 16:55:04 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1294 16:55:04 INFO - PROCESS | 1652 | __end_cc_report 16:55:04 INFO - PROCESS | 1652 | __startTimestamp1485046504025__endTimestamp 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | ------- Summary: start ------- 16:55:04 INFO - PROCESS | 1652 | Number of tests: 6 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5780.06 Median:5934.91 stddev:640.68 (10.8%) stddev-sans-first:612.27 16:55:04 INFO - PROCESS | 1652 | Values: 3295.1 3352.6 3353.6 3381.6 3406.5 5606.4 5664.7 5693.2 5719.3 5757.7 5682.8 5699.4 5780.8 5797.0 5835.6 5093.1 5122.1 5127.9 5187.4 5231.3 5270.5 5285.3 5292.1 5292.4 5312.8 5117.8 5279.1 5285.7 5296.0 5315.3 5151.3 5156.3 5213.2 5216.1 5230.1 5155.7 5223.2 5226.5 5235.8 5262.2 5661.8 5679.6 5715.6 5741.9 5785.9 6155.7 6198.5 6200.3 6246.3 6307.1 6250.0 6297.1 6310.5 6320.7 6331.2 5884.7 5887.0 5895.6 5911.6 5954.4 6186.4 6214.9 6253.5 6257.0 6317.1 6172.5 6194.9 6236.3 6237.0 6245.0 6162.8 6291.4 6298.9 6299.1 6301.0 6109.3 6163.7 6181.4 6222.6 6235.1 6277.9 6285.7 6288.8 6291.1 6300.2 4949.7 5045.3 5047.3 5061.1 5074.9 4429.4 4432.2 4453.8 4456.3 4522.8 5853.0 5914.6 5914.8 5927.3 5929.8 6260.1 6274.6 6284.3 6317.4 6331.6 5611.6 5734.1 5880.1 5887.6 5908.3 5260.7 5431.1 5438.9 5444.0 5448.4 6243.3 6248.4 6265.5 6274.7 6276.3 6214.4 6224.3 6244.4 6260.6 6309.4 6322.0 6345.0 6347.4 6353.7 6358.0 6276.1 6285.0 6296.0 6298.5 6306.8 6115.8 6191.6 6222.4 6229.6 6238.8 5604.4 6213.7 6215.9 6221.3 6235.5 6170.0 6182.8 6188.5 6188.8 6191.7 5808.8 5840.8 5853.2 5881.7 6045.1 6103.5 6104.2 6112.1 6120.7 6127.3 5927.5 5931.0 5933.7 5934.9 5934.9 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:63993.22 Median:196927.64 stddev:134020.65 (68.1%) stddev-sans-first:134311.69 16:55:04 INFO - PROCESS | 1652 | Values: 445.2 490.5 497.5 504.6 513.3 30863.5 32461.7 32496.8 32588.2 40111.0 33673.0 39548.8 41224.2 41457.8 42995.8 9225.4 9435.5 9442.6 9461.0 9471.2 8352.2 8572.1 9326.0 9468.2 9477.4 11195.6 11449.8 11456.8 11621.7 11676.2 11312.3 11392.5 11404.5 11437.3 11437.8 8309.4 8536.7 11273.0 11328.5 11373.3 33421.0 39781.6 40461.6 42412.6 42527.8 4049.6 4052.5 4095.5 4104.3 4105.5 30311.4 30502.0 30868.4 31189.8 31262.0 3220.5 3221.7 3261.9 3289.4 3343.8 479100.0 485752.0 485976.0 487634.0 487644.0 63160.7 63425.7 63476.0 63522.0 63545.4 66529.0 66676.3 66709.7 66710.7 67027.7 15832.5 16258.0 16321.8 16327.6 16353.7 12549.9 12627.8 12628.3 12634.4 12634.9 15613.2 16008.9 16019.6 17675.8 17867.9 6910.6 7053.2 7134.6 7165.1 7279.4 866.2 866.4 873.3 874.3 906.7 29509.0 29534.4 29921.4 30317.8 30359.4 1034.7 1078.5 1080.4 1086.0 1139.3 15066.8 15505.5 15521.8 15533.0 15950.4 587634.0 591061.0 591685.0 591857.0 592386.0 61096.7 61450.7 61482.1 61518.0 61546.0 1217.0 1396.9 1450.0 1456.9 1457.4 28949.0 29051.9 29134.7 29789.7 29816.3 52249.5 52723.0 52723.5 52731.7 52976.0 358115.0 430346.0 430807.0 431001.0 431236.0 24343.1 24845.0 25069.5 25762.7 40726.8 34765.1 42734.6 43553.6 44782.0 45045.0 33819.8 35906.8 36918.8 37032.3 37252.0 35322.6 35412.0 35427.8 36498.3 36737.8 35188.5 35567.5 35740.3 35950.0 35955.3 29668.7 29769.3 31754.8 31892.5 31924.8 23632.0 23646.5 23863.4 24044.3 24278.0 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:38519.58 Median:21792.96 stddev:116040.36 (532.5%) stddev-sans-first:116330.56 16:55:04 INFO - PROCESS | 1652 | Values: 390.3 391.2 396.1 401.7 423.7 19886.7 20803.8 21213.9 21225.6 21567.6 21570.6 21826.8 22055.7 22483.8 22721.4 5725.7 6042.5 6044.2 6049.4 6053.7 5733.9 5889.4 5916.1 5919.6 5985.1 5939.1 5940.3 5942.0 5943.6 5946.7 4837.4 5256.0 5777.7 5903.6 5923.8 5158.2 5163.8 5172.4 5174.9 5178.4 24547.5 25504.0 26113.0 26663.5 26848.9 2595.0 2619.2 2680.4 2692.4 2692.8 10099.0 10102.9 10172.9 10535.2 10656.4 1763.7 1864.7 1870.3 1872.2 1893.4 90037.0 100697.0 101643.5 102070.5 133596.0 11265.9 11514.7 11527.5 11544.9 11547.0 14769.5 15736.1 15770.6 15777.5 15801.4 7608.2 7992.7 8638.2 8666.5 8772.0 7182.3 7616.8 7773.5 7783.3 7975.2 4568.4 4803.7 4809.0 4875.1 4891.2 1970.9 2001.4 2006.4 2009.9 2023.5 1006.1 1007.6 1012.5 1017.9 1051.4 21262.8 21668.8 21701.9 21791.1 21794.8 956.3 999.7 1002.3 1041.0 1045.1 10610.6 10974.6 10991.3 11344.4 11350.1 641039.0 689138.0 708122.0 719189.0 731137.0 136211.0 139853.0 143816.0 144521.0 149903.3 1027.3 1046.2 1098.4 1103.4 1103.7 17666.0 20082.1 20343.1 20543.7 20622.8 57119.7 59044.8 60840.7 61277.4 61551.4 88015.6 89688.0 89940.6 90014.6 91778.1 6311.5 7029.9 7524.4 7546.0 7731.3 10195.9 12655.7 13240.9 13308.5 13911.3 9635.5 10367.9 10688.7 10983.2 12003.2 11155.7 11316.3 11564.4 11624.3 11738.3 10709.1 11238.7 11378.9 11877.2 11918.5 6596.9 7456.8 7687.9 7711.3 7839.5 10069.4 11526.7 11729.1 11855.2 11897.9 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5328.03 Median:5206.45 stddev:2864.07 (55.0%) stddev-sans-first:2857.47 16:55:04 INFO - PROCESS | 1652 | Values: 1475.2 1480.8 1485.5 1500.0 1505.8 8020.1 8402.0 8408.2 8425.7 8427.8 7410.7 7625.0 7937.2 8169.1 8209.4 2294.2 2339.1 2339.8 2342.4 2349.0 2279.2 2310.7 2322.0 2337.6 2346.9 2298.5 2310.6 2312.2 2336.5 2349.3 2283.0 2308.5 2308.6 2315.8 2318.6 2254.1 2320.0 2325.3 2326.7 2334.3 8271.9 8336.2 8342.7 8344.7 8357.9 5024.4 5188.5 5199.7 5204.5 5208.4 3283.9 3334.5 3508.6 3561.2 3562.4 1248.0 1258.2 1407.6 1747.3 1821.6 10463.6 10487.7 10597.4 10605.3 10611.5 3650.0 4365.9 4377.3 4419.2 4453.1 8575.9 8639.5 8641.4 8649.5 8659.1 4497.6 4931.1 5018.0 5083.3 5085.3 4121.1 4122.8 4798.4 4802.5 4813.3 3544.8 3570.3 3622.7 3647.5 3649.4 1114.7 1120.6 1121.1 1125.5 1129.2 783.1 826.2 887.0 894.3 934.1 5188.6 5508.0 5608.2 5621.1 5794.2 852.7 935.5 951.4 959.5 1024.4 3503.1 3579.2 3716.3 3745.6 3825.0 9594.3 9781.0 9914.3 9917.4 9925.3 9820.0 9845.4 9848.4 9858.7 9869.6 7204.8 7549.9 7556.8 7580.5 7717.1 5222.7 5462.7 5587.9 5616.4 5683.2 8534.4 8754.5 8794.3 8833.3 9291.1 8761.0 9042.5 9266.4 9369.4 9404.0 6528.8 6741.0 6743.3 6927.3 7133.3 7535.0 7804.7 7843.0 7921.6 7930.4 6905.5 6983.0 6983.9 7051.5 7060.2 6792.7 6855.7 6868.7 6881.0 6930.6 6206.2 6257.6 6345.3 6345.4 6365.3 4882.2 4903.3 4947.0 4978.2 5050.3 4886.0 4904.6 4968.8 4996.2 5070.3 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4336.61 Median:4774.57 stddev:1323.45 (27.7%) stddev-sans-first:1293.05 16:55:04 INFO - PROCESS | 1652 | Values: 358.8 360.2 369.9 382.4 382.7 4770.5 4818.2 5142.8 5233.7 5375.7 4456.8 4522.7 4813.8 4937.6 5187.4 3102.4 3544.4 4034.6 4073.9 4093.7 4119.3 4131.0 4145.6 4183.7 4221.8 3405.8 3706.7 4008.1 4108.0 4117.9 3930.9 3968.5 3984.9 3990.1 3993.2 2883.5 3442.0 3443.3 3447.4 3467.9 4384.7 4997.4 5100.3 5126.7 5136.5 3843.2 3912.8 4554.9 4568.8 4587.3 4689.2 5149.6 5249.9 5548.7 5574.6 3282.7 3372.3 3815.9 3862.4 3873.0 5643.3 5740.7 5798.6 5798.8 5864.4 3636.0 3816.7 3855.4 3862.0 3922.7 3876.6 3924.5 3925.5 3926.8 3961.7 3730.8 3953.7 4303.3 4547.2 4609.7 4624.8 4692.0 5468.8 5595.1 5728.9 1119.7 1133.3 1176.3 1196.9 1259.9 708.4 765.3 823.5 831.7 858.7 4240.9 4662.1 4798.6 4835.3 4883.9 5295.2 5378.5 5421.4 5432.1 5453.9 3874.7 4226.9 4492.7 4821.0 4889.2 2531.6 2798.2 2813.8 2823.7 2834.2 4937.5 5130.0 5497.5 5503.1 5621.9 4451.0 4564.7 4635.7 5137.9 5556.7 4796.4 5442.0 5593.4 5658.7 5664.0 4427.7 4778.7 5293.6 5323.4 5402.4 4684.3 4700.6 5181.0 5215.1 5304.6 5141.1 5237.0 5432.7 5535.8 5537.3 3293.3 3651.7 3665.5 3665.9 3666.8 5257.2 5396.9 5517.6 5648.8 5744.0 5101.9 5579.1 5582.8 5584.6 5590.6 4834.7 5248.6 5509.1 5566.8 5605.3 4985.4 5186.4 5428.7 5457.5 5490.6 4587.4 4834.7 5471.9 5486.5 5522.1 4303.8 4622.1 4797.8 5321.0 5514.2 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:19817.39 Median:4335.40 stddev:28318.62 (653.2%) stddev-sans-first:28361.70 16:55:04 INFO - PROCESS | 1652 | Values: 705.7 725.3 728.9 789.9 842.1 14823.9 15405.3 15609.3 15614.0 15639.7 14281.6 14395.9 14402.8 14410.1 14422.0 598.0 612.9 847.2 852.8 873.1 861.3 861.7 867.5 873.6 874.6 925.5 925.8 926.1 928.7 928.9 716.9 737.5 916.0 920.0 921.3 662.5 682.6 684.3 684.7 686.6 14815.3 14832.7 14838.9 14855.3 14857.6 13132.7 13158.9 13258.1 13434.3 13475.7 11559.8 13051.2 13059.3 13084.1 13348.8 4474.9 4520.3 4531.7 4606.4 4710.6 105334.0 106805.5 106899.5 107209.0 109677.0 11014.0 11025.4 11130.8 11143.9 11414.4 21059.4 21958.6 22021.9 22033.7 22333.0 6932.8 7857.0 7859.8 7864.5 7936.4 3701.6 4296.7 4374.1 4376.8 4421.3 3512.6 3564.3 3569.3 3607.0 3617.1 563.7 664.1 668.4 682.8 683.3 569.3 646.6 675.7 703.4 711.8 10007.9 10270.2 10329.8 10367.0 10442.1 679.3 699.9 710.8 716.5 719.9 4669.8 4994.7 5019.9 5046.0 5061.0 100346.0 101823.0 102173.0 102398.0 102647.5 71446.6 88727.0 88912.0 89817.0 91876.0 60944.5 63742.7 63967.0 64309.7 75028.9 8363.3 9405.9 10347.3 10829.1 11076.6 41286.6 45272.3 50048.5 50053.0 50935.2 50522.7 63672.4 64283.7 64546.4 64936.7 12677.0 12805.6 12864.9 13238.5 13433.9 14206.6 14318.9 14335.6 14347.0 14467.9 13217.5 13224.3 13385.3 13470.7 13970.6 13345.5 13349.4 13654.7 13941.5 14054.0 13133.2 13339.8 13350.9 13512.3 13798.3 9381.0 9441.4 10845.2 10910.2 11270.5 7146.9 8760.4 9830.2 10257.6 10475.8 16:55:04 INFO - PROCESS | 1652 | -------- Summary: end -------- 16:55:04 INFO - PROCESS | 1652 | 16:55:04 INFO - TEST-INFO | 1652: exit 0 16:55:04 INFO - TEST-OK | dromaeo_css | took 1118389ms 16:55:04 INFO - TEST-START | kraken 16:55:04 INFO - operating with platform_type : mac_ 16:55:04 INFO - Initialising browser for kraken test... 16:55:04 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpNdlTlh/profile http://localhost:49243/getInfo.html) 16:55:07 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 16:55:07 INFO - PROCESS | 1657 | colorDepth:24 16:55:07 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 16:55:07 INFO - PROCESS | 1657 | __metrics 16:55:07 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 16:55:07 INFO - PROCESS | 1657 | 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" 16:55:07 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:08 INFO - TEST-INFO | 1657: exit 0 16:55:08 INFO - Browser initialized. 16:55:08 INFO - Running cycle 1/1 for kraken test... 16:55:08 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/T/tmpNdlTlh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:20 INFO - PROCESS | 1659 | RSS: Main: 235360256 16:55:20 INFO - PROCESS | 1659 | 16:55:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 16:55:23 INFO - PROCESS | 1659 | RSS: Main: 289226752 16:55:23 INFO - PROCESS | 1659 | 16:55:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 16:55:26 INFO - PROCESS | 1659 | RSS: Main: 289878016 16:55:26 INFO - PROCESS | 1659 | 16:55:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 16:55:30 INFO - PROCESS | 1659 | RSS: Main: 379928576 16:55:30 INFO - PROCESS | 1659 | 16:55:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 16:55:33 INFO - PROCESS | 1659 | RSS: Main: 281468928 16:55:33 INFO - PROCESS | 1659 | 16:55:35 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:55:36 INFO - PROCESS | 1659 | RSS: Main: 285376512 16:55:36 INFO - PROCESS | 1659 | 16:55:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 16:55:39 INFO - PROCESS | 1659 | RSS: Main: 325582848 16:55:39 INFO - PROCESS | 1659 | 16:55:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 16:55:42 INFO - PROCESS | 1659 | RSS: Main: 327901184 16:55:42 INFO - PROCESS | 1659 | 16:55:45 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 16:55:46 INFO - PROCESS | 1659 | RSS: Main: 326184960 16:55:46 INFO - PROCESS | 1659 | 16:55:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:55:48 INFO - PROCESS | 1659 | RSS: Main: 302764032 16:55:48 INFO - PROCESS | 1659 | 16:55:50 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:55:51 INFO - PROCESS | 1659 | RSS: Main: 307089408 16:55:51 INFO - PROCESS | 1659 | 16:55:53 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:55:53 INFO - PROCESS | 1659 | RSS: Main: 310980608 16:55:53 INFO - PROCESS | 1659 | 16:55:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:55:57 INFO - PROCESS | 1659 | RSS: Main: 327847936 16:55:57 INFO - PROCESS | 1659 | 16:56:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:01 INFO - PROCESS | 1659 | RSS: Main: 321347584 16:56:01 INFO - PROCESS | 1659 | 16:56:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 16:56:03 INFO - PROCESS | 1659 | RSS: Main: 364986368 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | __start_tp_report 16:56:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 16:56:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 16:56:03 INFO - PROCESS | 1659 | |i|pagename|runs| 16:56:03 INFO - PROCESS | 1659 | |0;ai-astar;113;114;114;113;162;136;112;112;113;114 16:56:03 INFO - PROCESS | 1659 | |1;audio-beat-detection;139;108;109;145;112;109;109;109;128;111 16:56:03 INFO - PROCESS | 1659 | |2;audio-dft;183;182;182;182;182;182;177;183;181;185 16:56:03 INFO - PROCESS | 1659 | |3;audio-fft;81;59;59;89;60;59;59;58;73;57 16:56:03 INFO - PROCESS | 1659 | |4;audio-oscillator;84;72;85;70;67;67;82;68;68;82 16:56:03 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;85;86;84;87;87;89;85;87;85 16:56:03 INFO - PROCESS | 1659 | |6;imaging-darkroom;96;97;96;97;106;95;97;97;97;100 16:56:03 INFO - PROCESS | 1659 | |7;imaging-desaturate;83;85;84;86;85;84;85;87;87;84 16:56:03 INFO - PROCESS | 1659 | |8;json-parse-financial;56;53;54;54;54;56;55;54;54;54 16:56:03 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;74;83;77;73;71;75;72;72;74 16:56:03 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;85;88;90;86;90;87;88;86;87;87 16:56:03 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;144;150;152;137;139;157;143;133;183;151 16:56:03 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;173;173;173;230;222;169;171;173;173;173 16:56:03 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;66;68;70;68;66;67;67;67;66;68 16:56:03 INFO - PROCESS | 1659 | __end_tp_report 16:56:03 INFO - PROCESS | 1659 | __start_cc_report 16:56:03 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1957 16:56:03 INFO - PROCESS | 1659 | __end_cc_report 16:56:03 INFO - PROCESS | 1659 | __startTimestamp1485046563101__endTimestamp 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | ------- Summary: start ------- 16:56:03 INFO - PROCESS | 1659 | Number of tests: 14 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:120.30 Median:114.00 stddev:16.34 (14.3%) stddev-sans-first:17.11 16:56:03 INFO - PROCESS | 1659 | Values: 113.0 114.0 114.0 113.0 162.0 136.0 112.0 112.0 113.0 114.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:111.50 stddev:14.06 (12.6%) stddev-sans-first:12.67 16:56:03 INFO - PROCESS | 1659 | Values: 139.0 108.0 109.0 145.0 112.0 109.0 109.0 109.0 128.0 111.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:181.90 Median:182.00 stddev:2.02 (1.1%) stddev-sans-first:2.11 16:56:03 INFO - PROCESS | 1659 | Values: 183.0 182.0 182.0 182.0 182.0 182.0 177.0 183.0 181.0 185.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.50 stddev:11.43 (19.2%) stddev-sans-first:10.64 16:56:03 INFO - PROCESS | 1659 | Values: 81.0 59.0 59.0 89.0 60.0 59.0 59.0 58.0 73.0 57.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:74.50 Median:77.00 stddev:7.72 (10.0%) stddev-sans-first:7.38 16:56:03 INFO - PROCESS | 1659 | Values: 84.0 72.0 85.0 70.0 67.0 67.0 82.0 68.0 68.0 82.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.48 (1.7%) stddev-sans-first:1.54 16:56:03 INFO - PROCESS | 1659 | Values: 87.0 85.0 86.0 84.0 87.0 87.0 89.0 85.0 87.0 85.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:97.00 stddev:3.16 (3.3%) stddev-sans-first:3.28 16:56:03 INFO - PROCESS | 1659 | Values: 96.0 97.0 96.0 97.0 106.0 95.0 97.0 97.0 97.0 100.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.33 (1.6%) stddev-sans-first:1.20 16:56:03 INFO - PROCESS | 1659 | Values: 83.0 85.0 84.0 86.0 85.0 84.0 85.0 87.0 87.0 84.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:0.83 16:56:03 INFO - PROCESS | 1659 | Values: 56.0 53.0 54.0 54.0 54.0 56.0 55.0 54.0 54.0 54.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:74.00 stddev:4.37 (5.9%) stddev-sans-first:3.64 16:56:03 INFO - PROCESS | 1659 | Values: 66.0 74.0 83.0 77.0 73.0 71.0 75.0 72.0 72.0 74.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:1.65 (1.9%) stddev-sans-first:1.50 16:56:03 INFO - PROCESS | 1659 | Values: 85.0 88.0 90.0 86.0 90.0 87.0 88.0 86.0 87.0 87.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:150.50 stddev:14.12 (9.4%) stddev-sans-first:14.87 16:56:03 INFO - PROCESS | 1659 | Values: 144.0 150.0 152.0 137.0 139.0 157.0 143.0 133.0 183.0 151.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:173.00 stddev:22.78 (13.2%) stddev-sans-first:23.87 16:56:03 INFO - PROCESS | 1659 | Values: 173.0 173.0 173.0 230.0 222.0 169.0 171.0 173.0 173.0 173.0 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.25 (1.9%) stddev-sans-first:1.24 16:56:03 INFO - PROCESS | 1659 | Values: 66.0 68.0 70.0 68.0 66.0 67.0 67.0 67.0 66.0 68.0 16:56:03 INFO - PROCESS | 1659 | -------- Summary: end -------- 16:56:03 INFO - PROCESS | 1659 | 16:56:03 INFO - TEST-INFO | 1659: exit 0 16:56:04 INFO - TEST-OK | kraken | took 59332ms 16:56:04 INFO - SUITE-END | took 1177s 16:56:04 INFO - Completed test suite (00:19:37) 16:56:04 INFO - javascript benchmark 16:56:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.1267914002788, 3352.580927384077, 3353.6478669739663, 3381.5773028371455, 3406.50605662179, 5606.383297837245, 5664.688442135686, 5693.174489698991, 5719.256496655429, 5757.683327416996, 5682.829515114553, 5699.430056994299, 5780.843831233759, 5796.985527532686, 5835.59150859439, 5093.108705976458, 5122.052420302238, 5127.871803204913, 5187.4034486034025, 5231.2937753403185, 5270.472952704718, 5285.339332583427, 5292.10034294169, 5292.391374991887, 5312.840614781563, 5117.769700363456, 5279.128943724281, 5285.7357132143625, 5296.046711591912, 5315.255864179018, 5151.304573882516, 5156.252343410185, 5213.244079608436, 5216.113260745682, 5230.08473517133, 5155.664881782672, 5223.2165175223645, 5226.477352264781, 5235.764390602432, 5262.210668399733, 5661.7735290588325, 5679.630823996427, 5715.571332150105, 5741.8564535886935, 5785.913211301834, 6155.661438620874, 6198.535109866778, 6200.3179650238435, 6246.344133865924, 6307.05394190875, 6250.0, 6297.118403423525, 6310.463610593105, 6320.652364119972, 6331.2085989251345, 5884.735186916599, 5887.0, 5895.616784908967, 5911.586188966817, 5954.37479064692, 6186.443220110212, 6214.9067763982675, 6253.468455181361, 6257.030160325156, 6317.1156038154695, 6172.475339596095, 6194.876102477925, 6236.282827474808, 6237.0, 6244.968775156095, 6162.845928851814, 6291.370862913764, 6298.874022519524, 6299.118123462719, 6301.0, 6109.26082417852, 6163.722632481549, 6181.381861813873, 6222.595531290452, 6235.064740288993, 6277.937220627735, 6285.685715714196, 6288.811335659938, 6291.087792270187, 6300.21247344082, 4949.7030178189425, 5045.318881950963, 5047.293378926953, 5061.114304996611, 5074.898502029939, 4429.446319210098, 4432.246518091933, 4453.821847126143, 4456.264716321771, 4522.841700540531, 5852.970735146297, 5914.615549989237, 5914.792982245601, 5927.2590926134235, 5929.792457263975, 6260.092286618506, 6274.560780745304, 6284.340144284784, 6317.431431171125, 6331.588446750947, 5611.6352437091455, 5734.111212762028, 5880.147378630075, 5887.646741195542, 5908.261467316585, 5260.710660913686, 5431.131019036935, 5438.945610543844, 5444.020076386209, 5448.373437054789, 6243.250809902841, 6248.4376406123665, 6265.467435268053, 6274.654893980693, 6276.278228003838, 6214.4407003369915, 6224.315325314303, 6244.406781355764, 6260.561760676709, 6309.3690630936535, 6321.96839015802, 6345.0, 6347.428731414195, 6353.7140828661895, 6358.0, 6276.1213430118905, 6284.968575157095, 6295.968520157553, 6298.527610429144, 6306.779262725782, 6115.757578772925, 6191.5665903388135, 6222.408871157233, 6229.56393052482, 6238.844028899314, 5604.439556044526, 6213.65824879636, 6215.906761398493, 6221.346758590283, 6235.501159907106, 6170.043643235305, 6182.845428864314, 6188.535859810622, 6188.752449901954, 6191.721372538156, 5808.796692115756, 5840.8247752567495, 5853.1805547222575, 5881.705914704162, 6045.093236014633, 6103.450689437972, 6104.20645316106, 6112.144299798121, 6120.724567394389, 6127.264728232641, 5927.4665280125, 5931.0, 5933.673647949404, 5934.910976335272, 5934.9109763354445], "value": 5738.082735674801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.22308571542663, 490.46539272193303, 497.5174081141294, 504.64170438988305, 513.2737176894694, 30863.537046944286, 32461.67538324616, 32496.83751581239, 32588.1852953676, 40111.0, 33673.0, 39548.81353559391, 41224.175516489726, 41457.7927110364, 42995.78502107485, 9225.354225204239, 9435.481048542328, 9442.575084121198, 9461.0, 9471.194948429391, 8352.16478352166, 8572.057073721917, 9325.95337023314, 9468.195203407719, 9477.431354118775, 11195.552177912914, 11449.828252576219, 11456.770864582704, 11621.709457263552, 11676.1826672133, 11312.264702794291, 11392.487338069806, 11404.54381824726, 11437.313761174315, 11437.771244575062, 8309.418340716153, 8536.70121545743, 11272.98543131114, 11328.546858125665, 11373.294005899099, 33421.0, 39781.60218397808, 40461.59538404608, 42412.57587424148, 42527.7873610633, 4049.6152865477734, 4052.4790054092755, 4095.4675892133832, 4104.261232978063, 4105.507339119295, 30311.393772124433, 30502.0, 30868.382632347228, 31189.84405077983, 31262.0, 3220.5008223725126, 3221.7100460958627, 3261.9347613047844, 3289.3750187464307, 3343.8328083595725, 479100.0, 485752.0, 485976.0, 487634.0, 487644.0, 63160.684196578724, 63425.68287158535, 63476.0, 63522.0, 63545.36454635487, 66529.00206496907, 66676.33323666798, 66709.6658066836, 66710.66644666746, 67027.66486167538, 15832.525024249291, 16258.0, 16321.83678163227, 16327.591810204602, 16353.672926541403, 12549.87450125487, 12627.810582841264, 12628.305443200712, 12634.368281586068, 12634.873651263553, 15613.219339033003, 16008.919955400148, 16019.599510012344, 17675.82324176742, 17867.927924324584, 6910.585364878123, 7053.153621565342, 7134.57656253116, 7165.09813525523, 7279.41764658826, 866.2030931542996, 866.445474896067, 873.3188113271658, 874.3180319350917, 906.723449347942, 29509.032561208784, 29534.409311813644, 29921.409430868436, 30317.848410757804, 30359.392812143633, 1034.6895931220604, 1078.487718333785, 1080.400377790334, 1086.0, 1139.2993309114834, 15066.849331506764, 15505.534833955, 15521.844781552265, 15533.0, 15950.441734539236, 587634.0, 591061.0, 591685.0, 591857.0, 592386.0, 61096.69451652713, 61450.69274653688, 61482.0777688335, 61518.0, 61546.0, 1216.9817452738216, 1396.9092009019382, 1450.0139904864793, 1456.89801713879, 1457.4024649893493, 28949.0, 29051.854740727005, 29134.7086529132, 29789.702102978692, 29816.254593634465, 52249.47750522446, 52723.0, 52723.47276527339, 52731.73634131805, 52976.0, 358115.0, 430346.0, 430807.0, 431001.0, 431236.0, 24343.14798982027, 24845.006199751806, 25069.49861002733, 25762.742372576784, 40726.79636601917, 34765.116081723645, 42734.57265427306, 43553.56446435622, 44782.0, 45045.0, 33819.830900845336, 35906.8204658975, 36918.815405922796, 37032.25935481329, 37252.0, 35322.646773532964, 35412.0, 35427.82286088553, 36498.27003459969, 36737.81631091827, 35188.47217291794, 35567.46648800322, 35740.28519429649, 35950.0, 35955.280894381445, 29668.703312966594, 29769.25576860596, 31754.841225793723, 31892.5216121763, 31924.8403757989, 23632.0, 23646.527069458858, 23863.403414914766, 24044.27867163988, 24278.0], "value": 19637.08916982145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3403248510018, 391.21951706345834, 396.1087553005737, 401.7067540695292, 423.7097588152116, 19886.70169947452, 20803.791962080373, 21213.939303034844, 21225.57548849022, 21567.568648627017, 21570.56858862822, 21826.781732182673, 22055.676659400448, 22483.775162248414, 22721.431964200903, 5725.656460612367, 6042.546808989343, 6044.184035155264, 6049.425304596057, 6053.727582258787, 5733.885322293551, 5889.352171261158, 5916.083007133901, 5919.644821310713, 5985.132155837401, 5939.109133629947, 5940.316863560681, 5942.0, 5943.583949123563, 5946.702664866761, 4837.443693975185, 5255.9750848584545, 5777.740001699934, 5903.645781253139, 5923.792667256647, 5158.200478925773, 5163.845084647466, 5172.379314482248, 5174.896502069975, 5178.352705911761, 24547.509049818902, 25504.0, 26113.0, 26663.466730665277, 26848.865755671097, 2595.0, 2619.2011436511857, 2680.3567143885325, 2692.4480481501246, 2692.8384296942245, 10099.040591143903, 10102.898971010269, 10172.94913525435, 10535.209859260509, 10656.413897235649, 1763.7001709709252, 1864.7109697996832, 1870.3173341730308, 1872.1668857358482, 1893.3751861885544, 90037.0, 100697.0, 101643.49178254136, 102070.4896475513, 133596.0, 11265.887341126483, 11514.654560363202, 11527.48126334317, 11544.88455115455, 11547.018503427134, 14769.489186838264, 15736.134512601688, 15770.60573485649, 15777.526674199793, 15801.446949356718, 7608.2011388804485, 7992.682122184501, 8638.17937295956, 8666.480011199223, 8772.0, 7182.270737119861, 7616.8476630467085, 7773.494722842997, 7783.260590243918, 7975.2423519765525, 4568.383268258743, 4803.735794531334, 4808.951910480921, 4875.122477953932, 4891.1685013547785, 1970.8521860860492, 2001.4095841726726, 2006.4081096076693, 2009.8593098482966, 2023.4840115770385, 1006.1447769395954, 1007.6322142418111, 1012.529428195216, 1017.8524114003428, 1051.4427353502656, 21262.83054432021, 21668.78331216699, 21701.891490542763, 21791.12835486563, 21794.782052179275, 956.268454632207, 999.7300728803328, 1002.3434650304063, 1040.958361665525, 1045.1168762395764, 10610.57557697699, 10974.615888443866, 10991.285566438157, 11344.43277836105, 11350.09199264057, 641039.0, 689138.0, 708122.0, 719189.0, 731137.0, 136211.0, 139853.0, 143816.0, 144521.0, 149903.25048374906, 1027.2603725317758, 1046.2467023742893, 1098.4343063322394, 1103.3545375954996, 1103.7461383881753, 17666.0, 20082.09630566657, 20343.084561194486, 20543.691844622044, 20622.793772062087, 57119.71440142773, 59044.819103618545, 60840.69579652251, 61277.38722612895, 61551.384486156356, 88015.55992219997, 89688.0, 89940.55029724809, 90014.64978025467, 91778.08221917962, 6311.463525600376, 7029.859402811813, 7524.360429363565, 7545.962270188614, 7731.34283585879, 10195.949020254851, 12655.683607909876, 13240.874525665426, 13308.46766129344, 13911.304434778423, 9635.518224088908, 10367.94816025915, 10688.679339619825, 10983.231173818076, 12003.219790713576, 11155.665330040112, 11316.321020738782, 11564.42177891119, 11624.302541847515, 11738.29570225755, 10709.143268538654, 11238.719032024264, 11378.886211137782, 11877.168598198043, 11918.463669135082, 6596.934030659632, 7456.813579660552, 7687.88468172989, 7711.26742959418, 7839.529628222325, 10069.446180460145, 11526.654200374001, 11729.061675065803, 11855.229410088317, 11897.940510297392], "value": 9824.224784340762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.1591592792106, 1480.7778833175016, 1485.517206907755, 1500.0474698566413, 1505.7515509940856, 8020.077691065522, 8402.033766116898, 8408.24325810677, 8425.747227583168, 8427.789305267364, 7410.740174170391, 7624.961875190616, 7937.2459616336355, 8169.101398846122, 8209.425340226186, 2294.1511640692925, 2339.087755775249, 2339.801116905065, 2342.402687314741, 2348.9647655285185, 2279.2136712834044, 2310.699609050821, 2322.0479603362623, 2337.55586438577, 2346.9178578749747, 2298.482841360697, 2310.595645761993, 2312.236961802601, 2336.485973085927, 2349.3304408243653, 2283.0297123722435, 2308.53408085865, 2308.6421604651223, 2315.7568455312116, 2318.5826551220775, 2254.0983606557343, 2320.048780000209, 2325.2559181062065, 2326.6975293211945, 2334.2880421471446, 8271.875921861178, 8336.166383361677, 8342.749717508485, 8344.749657510285, 8357.916420835774, 5024.422191447994, 5188.507091826271, 5199.662021968597, 5204.505571970657, 5208.401033881114, 3283.8522266498067, 3334.5164951081956, 3508.596511401196, 3561.216532362902, 3562.3765840977985, 1247.950081996719, 1258.1884684378615, 1407.6340151560566, 1747.309812624019, 1821.571930596309, 10463.633772817915, 10487.685369438928, 10597.364158150458, 10605.257631965766, 10611.522481488351, 3649.9635003649623, 4365.934510982338, 4377.255866502702, 4419.20197515134, 4453.064856380196, 8575.914240857512, 8639.481631102153, 8641.351898607629, 8649.524276164871, 8659.09079546651, 4497.550244975541, 4931.0630980113665, 5017.992802878877, 5083.262926875583, 5085.262636917626, 4121.093359460914, 4122.814473348706, 4798.352222449995, 4802.495737947535, 4813.326134341195, 3544.8227588620466, 3570.250247448065, 3622.673959343672, 3647.544056992876, 3649.434337677664, 1114.7213196700825, 1120.5853834081279, 1121.103117505992, 1125.482278152043, 1129.1644183304295, 783.1346362269724, 826.2192228344157, 886.9822603548022, 894.3337213775778, 934.0985948559672, 5188.584913206934, 5507.972460137754, 5608.242887210175, 5621.100623900156, 5794.246747922743, 852.7441767469734, 935.4751754639893, 951.4481600671594, 959.467495539982, 1024.3546565663733, 3503.1067077894972, 3579.1767893384667, 3716.349638813197, 3745.5879853216125, 3824.9808750956067, 9594.280428967855, 9781.0, 9914.305998580174, 9917.355371900803, 9925.255605829447, 9820.0, 9845.360051596623, 9848.409095454295, 9858.704238872846, 9869.555869985868, 7204.783856484314, 7549.9245007549225, 7556.848863022708, 7580.507267027736, 7717.073951125789, 5222.660527065728, 5462.6995515247045, 5587.892898719448, 5616.410276921028, 5683.204351390726, 8534.402591818513, 8754.47473151613, 8794.340424468062, 8833.277510885315, 9291.117343852324, 8760.956195218983, 9042.457452552868, 9266.351355405057, 9369.437833729999, 9404.012578679414, 6528.771492997722, 6740.966295168493, 6743.325667433218, 6927.272636373108, 7133.251008644225, 7534.962325188559, 7804.726834560764, 7843.0, 7921.564313962787, 7930.36557075421, 6905.516613836983, 6983.022376867141, 6983.860322793414, 7051.541649792747, 7060.188078371053, 6792.728290868507, 6855.725770969106, 6868.725250989904, 6881.0, 6930.584164950119, 6206.193194884636, 6257.624542527463, 6345.333739957238, 6345.365463453618, 6365.331640177715, 4882.170031094794, 4903.26451032348, 4946.975265123651, 4978.178600530872, 5050.3434553507805, 4886.0, 4904.583110435653, 4968.751562421937, 4996.200607902718, 5070.315507406601], "value": 4364.979484849935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.84569635056926, 360.18238598381674, 369.9019759763662, 382.44354464254513, 382.7320875387226, 4770.475247722748, 4818.2299523471775, 5142.842860356418, 5233.738313084345, 5375.704336261504, 4456.844010459635, 4522.706024108439, 4813.772488015551, 4937.629677774173, 5187.351581052369, 3102.3795240951786, 3544.4227318843127, 4034.6368826805583, 4073.9388909166237, 4093.6520395766397, 4119.258533463975, 4131.0085579460865, 4145.647619952292, 4183.6653067754505, 4221.804661575979, 3405.7615966882327, 3706.721995850322, 4008.098177909976, 4108.0, 4117.938230926538, 3930.941035884464, 3968.543617483969, 3984.94775190777, 3990.0623353512046, 3993.1614360984227, 2883.480973424783, 3441.984614538717, 3443.328550932569, 3447.4311738563106, 3467.8959631211105, 4384.693071484998, 4997.400311962551, 5100.260462232955, 5126.71803050832, 5136.5377116059735, 3843.1929294848114, 3912.7652340859354, 4554.908901821978, 4568.817247310104, 4587.3348364486965, 4689.226277664181, 5149.613778966593, 5249.8975215204855, 5548.6948217848, 5574.58190635704, 3282.6553211912883, 3372.291818718072, 3815.893390916631, 3862.439946207812, 3872.9806350968347, 5643.294588176478, 5740.655560666331, 5798.623089499169, 5798.768049277982, 5864.413558644102, 3636.0000999724757, 3816.709974015624, 3855.4024126260474, 3861.961380386216, 3922.705507182623, 3876.5850464580226, 3924.548676902136, 3925.548561915359, 3926.823292951824, 3961.6830653547645, 3730.757500762442, 3953.715042611163, 4303.311470164821, 4547.1815073287125, 4609.654275929319, 4624.791884365211, 4692.0, 5468.781248750085, 5595.146475297627, 5728.854229154186, 1119.7032786311634, 1133.3143448213877, 1176.3471273443322, 1196.8623608284984, 1259.8614152443224, 708.373089815517, 765.3494529649864, 823.5264722784423, 831.6651773902798, 858.656537385051, 4240.872773816791, 4662.137504561667, 4798.592119669867, 4835.274708793709, 4883.902321953541, 5295.152775555893, 5378.489043540857, 5421.376541697677, 5432.076546987022, 5453.945460545423, 3874.7093967952515, 4226.894327641833, 4492.663050271242, 4821.011692603008, 4889.193283108319, 2531.6455696202547, 2798.174538511144, 2813.8452385118608, 2823.7035111313426, 2834.2489240351324, 4937.469384490748, 5129.9743501282255, 5497.47773961473, 5503.091989821714, 5621.943780562224, 4450.992633287551, 4564.748938808331, 4635.745034023161, 5137.897242055213, 5556.749946252347, 4796.35249241348, 5442.020436321421, 5593.4338385252195, 5658.717064146858, 5664.037113690682, 4427.69006169565, 4778.658457355801, 5293.550048245942, 5323.3878104016985, 5402.405735369185, 4684.2597080708165, 4700.576948074689, 5181.0, 5215.087359711959, 5304.60215483848, 5141.126008578625, 5236.967534997954, 5432.728363581726, 5535.750891209825, 5537.280153580009, 3293.2590167212184, 3651.707863370977, 3665.541807274091, 3665.87169449068, 3666.8182431453242, 5257.237700533477, 5396.892062158813, 5517.613767036269, 5648.8084232408555, 5744.013113181206, 5101.923471147861, 5579.13523403873, 5582.8325150245555, 5584.553235741212, 5590.580706446952, 4834.685745426536, 5248.6325957182635, 5509.090999984957, 5566.805161819317, 5605.32736071674, 4985.376827896513, 5186.351706036746, 5428.67427954324, 5457.536109430743, 5490.588205884655, 4587.357769912148, 4834.734089625104, 5471.945280547303, 5486.488647265833, 5522.085344043724, 4303.806328715153, 4622.075584882969, 4797.832075877328, 5320.989012087691, 5514.2004409359615], "value": 3928.880715135711, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.7071315404107, 725.303708439898, 728.9125304963405, 789.8657228271194, 842.0947481457434, 14823.851761482381, 15405.306761195745, 15609.297581608813, 15614.0, 15639.687206255869, 14281.642958926006, 14395.92802035991, 14402.783958240609, 14410.06334588251, 14422.0, 598.0461164442729, 612.8529153003269, 847.1867007672641, 852.8209076094013, 873.1137895036543, 861.3238607692962, 861.7371701631, 867.5141920524495, 873.6418068591847, 874.5583480342418, 925.5233554719325, 925.763930197802, 926.1155596405416, 928.6842473558988, 928.9396189247711, 716.8996340512281, 737.4505993035223, 915.9816803663923, 919.9816003679956, 921.3228277216274, 662.5329142954206, 682.5631595778706, 684.3293572299175, 684.7295318349225, 686.5606012152226, 14815.333310001075, 14832.703345933021, 14838.925805371013, 14855.331510082073, 14857.628559285997, 13132.6716832079, 13158.934205328913, 13258.138221015699, 13434.261115638636, 13475.66310842227, 11559.78622244669, 13051.15167514118, 13059.347032648424, 13084.149530280501, 13348.799768003488, 4474.910501789978, 4520.3219517072375, 4531.682782205247, 4606.401167848192, 4710.552497512731, 105334.0, 106805.46597267041, 106899.46550267277, 107209.0, 109677.0, 11014.0, 11025.44872756359, 11130.833037504444, 11143.888561114447, 11414.42927853604, 21059.36821895315, 21958.560828783335, 22021.889890550443, 22033.669494957587, 22333.0, 6932.826679333057, 7857.0, 7859.764207073797, 7864.4888082274465, 7936.444448888522, 3701.5627491628106, 4296.699231053859, 4374.10584781714, 4376.846810361622, 4421.314696222091, 3512.613612502623, 3564.3405969895653, 3569.3218288525095, 3607.026102952188, 3617.113807117273, 563.6927874308429, 664.1333060356185, 668.3750693101965, 682.8327059870264, 683.255251775567, 569.3054473542272, 646.5732616473106, 675.7026908160394, 703.4372501998483, 711.8042538301905, 10007.899921000697, 10270.229732770073, 10329.793404131875, 10367.0, 10442.112420444348, 679.2629996453903, 699.8950157476419, 710.761894765249, 716.4662326566742, 719.899214110025, 4669.813207471731, 4994.650374473752, 5019.949800502021, 5045.990027216534, 5061.0, 100346.0, 101823.0, 102173.0, 102398.0, 102647.46028809574, 71446.64276678584, 88727.0, 88912.0, 89817.0, 91876.0, 60944.476388090654, 63742.6812865942, 63967.0, 64309.67845160744, 75028.87456688263, 8363.289120424832, 9405.85891211646, 10347.27569070188, 10829.079528240189, 11076.612318569134, 41286.58713412828, 45272.32091518564, 50048.49951500438, 50052.998940021724, 50935.23597145972, 50522.7473862643, 63672.36327636665, 64283.67858160679, 64546.35453645403, 64936.675316623114, 12676.985841132502, 12805.615831525069, 12864.935675321563, 13238.470461181445, 13433.865661343652, 14206.573802785933, 14318.882390135897, 14335.584806020595, 14347.0, 14467.85532144665, 13217.537386191438, 13224.272665003133, 13385.330733463483, 13470.730585388434, 13970.580882573538, 13345.532906348231, 13349.399277032751, 13654.726905461637, 13941.512047078304, 14054.01621886499, 13133.212007279593, 13339.799903001269, 13350.865176460109, 13512.324383780575, 13798.310084495533, 9380.95309523448, 9441.433513989183, 10845.240833141605, 10910.180238653826, 11270.464145567183, 7146.857062858818, 8760.44658367484, 9830.164436023018, 10257.562144354479, 10475.790484190426], "value": 7443.0436823870195, "unit": "score"}], "name": "dromaeo_css", "value": 7217.14657382869, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 162.0, 136.0, 112.0, 112.0, 113.0, 114.0], "value": 120.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 109.0, 145.0, 112.0, 109.0, 109.0, 109.0, 128.0, 111.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 182.0, 182.0, 182.0, 182.0, 177.0, 183.0, 181.0, 185.0], "value": 181.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 60.0, 59.0, 59.0, 58.0, 73.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 85.0, 70.0, 67.0, 67.0, 82.0, 68.0, 68.0, 82.0], "value": 74.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 87.0, 87.0, 89.0, 85.0, 87.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 106.0, 95.0, 97.0, 97.0, 97.0, 100.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 86.0, 85.0, 84.0, 85.0, 87.0, 87.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 54.0, 54.0, 56.0, 55.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 83.0, 77.0, 73.0, 71.0, 75.0, 72.0, 72.0, 74.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 90.0, 86.0, 90.0, 87.0, 88.0, 86.0, 87.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 152.0, 137.0, 139.0, 157.0, 143.0, 133.0, 183.0, 151.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 173.0, 230.0, 222.0, 169.0, 171.0, 173.0, 173.0, 173.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 70.0, 68.0, 66.0, 67.0, 67.0, 67.0, 66.0, 68.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1443.7, "alertThreshold": 2.0}]} 16:56:04 INFO - Return code: 0 16:56:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:56:04 ERROR - # TBPL SUCCESS # 16:56:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:56:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:56:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:56:04 INFO - 2017-01-21 16:56:04.403 screenresolution[1663:10261] starting screenresolution argv=screenresolution get 16:56:04 INFO - 2017-01-21 16:56:04.406 screenresolution[1663:10261] Display 0: 1600x1200x32@60 16:56:04 INFO - 2017-01-21 16:56:04.412 screenresolution[1664:10264] starting screenresolution argv=screenresolution list 16:56:04 INFO - Available Modes on Display 0 16:56:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:56:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:56:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:56:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:56:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:56:04 INFO - Intel Iris: 16:56:04 INFO - Chipset Model: Intel Iris 16:56:04 INFO - Type: GPU 16:56:04 INFO - Bus: Built-In 16:56:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:56:04 INFO - Vendor: Intel (0x8086) 16:56:04 INFO - Device ID: 0x0a2e 16:56:04 INFO - Revision ID: 0x0009 16:56:04 INFO - Displays: 16:56:04 INFO - Display: 16:56:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:56:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:56:04 INFO - Display Serial Number: 1600x1200 60 16:56:04 INFO - Main Display: Yes 16:56:04 INFO - Mirror: Off 16:56:04 INFO - Online: Yes 16:56:04 INFO - Rotation: Supported 16:56:04 INFO - Return code: 0 16:56:04 INFO - Running post-action listener: _resource_record_post_action 16:56:04 INFO - [mozharness: 2017-01-22 00:56:04.649582Z] Finished run-tests step (success) 16:56:04 INFO - Running post-run listener: _resource_record_post_run 16:56:04 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 32365568; Write bytes: 553330176; Read time: 198; Write time: 1667 16:56:04 INFO - TinderboxPrint: CPU usage
53.6% 16:56:04 INFO - TinderboxPrint: I/O read bytes / time
32,365,568 / 198 16:56:04 INFO - TinderboxPrint: I/O write bytes / time
553,330,176 / 1,667 16:56:04 INFO - TinderboxPrint: CPU idle
2,226.0 (46.4%) 16:56:04 INFO - TinderboxPrint: CPU system
959.4 (20.0%) 16:56:04 INFO - TinderboxPrint: CPU user
1,616.4 (33.7%) 16:56:04 INFO - TinderboxPrint: Swap in / out
279,805,952 / 0 16:56:04 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249356800; Write bytes: 241741824; Read time: 17977; Write time: 516 16:56:04 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29002752; Write bytes: 299984384; Read time: 177; Write time: 1113 16:56:05 INFO - Running post-run listener: _upload_blobber_files 16:56:05 INFO - Blob upload gear active. 16:56:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:56:05 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 16:56:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:56:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:56:05 INFO - (blobuploader) - INFO - Open directory for files ... 16:56:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:56:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:56:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:06 INFO - (blobuploader) - INFO - Done attempting. 16:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:07 INFO - (blobuploader) - INFO - Done attempting. 16:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:56:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:08 INFO - (blobuploader) - INFO - Done attempting. 16:56:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:56:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:56:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:56:10 INFO - (blobuploader) - INFO - Done attempting. 16:56:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:56:10 INFO - Return code: 0 16:56:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:56:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:56:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f06fcd9d59f72746cdf680bb575c3b03519a0af528dc11f83e836493b9b70bf4e0d765ff78123683de9eee3e1d31ef11fa15c3c5377106325e1d80d7720e4348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9fb587f9ca7deaf4b659aa8f75e594b3b8035188834eebe1f1bf9f3be57932862d929f04db58d530e303abbd11fcd56b7b0be42c0abc7652fb701174d7c0994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c6f7b0dd8e8ebb37979824ad858356c4ce992eaccdb1e9fa3f9a1555c95817ac0f1dfa819a0036a67163e3f571b1b33cd57e5c40a775808508cadfa60599ab8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b9cfb9a3373173cf6cd93c6a3507f0b37ff4f1815b851452eda983267639d30cc2c7ab7478a9cdd408fd259ef65b5a3b584ce79e61178ecb5ca2438e55b7ff"} 16:56:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:56:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:56:10 INFO - Contents: 16:56:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f06fcd9d59f72746cdf680bb575c3b03519a0af528dc11f83e836493b9b70bf4e0d765ff78123683de9eee3e1d31ef11fa15c3c5377106325e1d80d7720e4348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9fb587f9ca7deaf4b659aa8f75e594b3b8035188834eebe1f1bf9f3be57932862d929f04db58d530e303abbd11fcd56b7b0be42c0abc7652fb701174d7c0994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c6f7b0dd8e8ebb37979824ad858356c4ce992eaccdb1e9fa3f9a1555c95817ac0f1dfa819a0036a67163e3f571b1b33cd57e5c40a775808508cadfa60599ab8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b9cfb9a3373173cf6cd93c6a3507f0b37ff4f1815b851452eda983267639d30cc2c7ab7478a9cdd408fd259ef65b5a3b584ce79e61178ecb5ca2438e55b7ff"} 16:56:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:56:10 INFO - Copying logs to upload dir... 16:56:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:56:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.953917 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-21 16:56:10.521115) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 16:56:10.524955) ========= 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.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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/Firefox/sha512/f06fcd9d59f72746cdf680bb575c3b03519a0af528dc11f83e836493b9b70bf4e0d765ff78123683de9eee3e1d31ef11fa15c3c5377106325e1d80d7720e4348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9fb587f9ca7deaf4b659aa8f75e594b3b8035188834eebe1f1bf9f3be57932862d929f04db58d530e303abbd11fcd56b7b0be42c0abc7652fb701174d7c0994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c6f7b0dd8e8ebb37979824ad858356c4ce992eaccdb1e9fa3f9a1555c95817ac0f1dfa819a0036a67163e3f571b1b33cd57e5c40a775808508cadfa60599ab8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b9cfb9a3373173cf6cd93c6a3507f0b37ff4f1815b851452eda983267639d30cc2c7ab7478a9cdd408fd259ef65b5a3b584ce79e61178ecb5ca2438e55b7ff"} build_url:https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011154 build_url: 'https://queue.taskcluster.net/v1/task/e12cblBESMSsVmIkLykVUQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f06fcd9d59f72746cdf680bb575c3b03519a0af528dc11f83e836493b9b70bf4e0d765ff78123683de9eee3e1d31ef11fa15c3c5377106325e1d80d7720e4348", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9fb587f9ca7deaf4b659aa8f75e594b3b8035188834eebe1f1bf9f3be57932862d929f04db58d530e303abbd11fcd56b7b0be42c0abc7652fb701174d7c0994", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0c6f7b0dd8e8ebb37979824ad858356c4ce992eaccdb1e9fa3f9a1555c95817ac0f1dfa819a0036a67163e3f571b1b33cd57e5c40a775808508cadfa60599ab8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b9cfb9a3373173cf6cd93c6a3507f0b37ff4f1815b851452eda983267639d30cc2c7ab7478a9cdd408fd259ef65b5a3b584ce79e61178ecb5ca2438e55b7ff"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-21 16:56:10.564222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:56:10.565009) ========= 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.FAj5AREiZ8/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.eGEIEomiAb/Listeners TMPDIR=/var/folders/pm/th83h8l52qd0r5qqq2qsg_g400000w/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.004775 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-21 16:56:10.616539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 16:56:10.617324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-21 16:56:10.618065) ========= ========= Total master_lag: 0.20 =========