builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0288 starttime: 1485232309.91 results: success (0) buildid: 20170123185543 builduid: 611871aa6b594d2e8495165d82eac291 revision: 8ff550409e1d1f8b54f6f7f115545dbef857be0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:49.905700) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:49.906157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:49.906446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:49.931042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:49.931332) ========= 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.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-23 20:31:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.97M=0.001s 2017-01-23 20:31:50 (9.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:50.069572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:50.069880) ========= 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.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.022407 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:50.117878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 20:31:50.118192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ff550409e1d1f8b54f6f7f115545dbef857be0b --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 8ff550409e1d1f8b54f6f7f115545dbef857be0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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-23 20:31:50,208 truncating revision to first 12 chars 2017-01-23 20:31:50,208 Setting DEBUG logging. 2017-01-23 20:31:50,208 attempt 1/10 2017-01-23 20:31:50,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ff550409e1d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 20:31:51,788 unpacking tar archive at: mozilla-central-8ff550409e1d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.844529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 20:31:51.986336) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:51.986673) ========= script_repo_revision: 8ff550409e1d1f8b54f6f7f115545dbef857be0b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:51.987062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:51.987330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 20:31:52.006669) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-23 20:31:52.006963) ========= /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.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:31:52 INFO - MultiFileLogger online at 20170123 20:31:52 in /builds/slave/test 20:31:52 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 20:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:31:52 INFO - {'append_to_log': False, 20:31:52 INFO - 'base_work_dir': '/builds/slave/test', 20:31:52 INFO - 'blob_upload_branch': 'Firefox', 20:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:31:52 INFO - 'branch': 'Firefox', 20:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 20:31:52 INFO - 'config_files': ('talos/mac_config.py',), 20:31:52 INFO - 'default_actions': ('clobber', 20:31:52 INFO - 'read-buildbot-config', 20:31:52 INFO - 'download-and-extract', 20:31:52 INFO - 'populate-webroot', 20:31:52 INFO - 'create-virtualenv', 20:31:52 INFO - 'install', 20:31:52 INFO - 'run-tests'), 20:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:31:52 INFO - 'download_minidump_stackwalk': True, 20:31:52 INFO - 'download_symbols': 'ondemand', 20:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 20:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 20:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:31:52 INFO - 'installer_path': 'installer.exe', 20:31:52 INFO - 'log_level': 'info', 20:31:52 INFO - 'log_name': 'talos', 20:31:52 INFO - 'log_to_console': True, 20:31:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:31:52 INFO - 'opt_config_files': (), 20:31:52 INFO - 'pip_index': False, 20:31:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:31:52 INFO - 'cmd': ('bash', 20:31:52 INFO - '-c', 20:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:31:52 INFO - 'enabled': True, 20:31:52 INFO - 'halt_on_failure': False, 20:31:52 INFO - 'name': 'check_screen_resolution'},), 20:31:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:31:52 INFO - 'cmd': ('bash', 20:31:52 INFO - '-c', 20:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:31:52 INFO - 'enabled': True, 20:31:52 INFO - 'halt_on_failure': False, 20:31:52 INFO - 'name': 'check_screen_resolution'},), 20:31:52 INFO - 'run_cmd_checks_enabled': True, 20:31:52 INFO - 'sps_profile': False, 20:31:52 INFO - 'sps_profile_interval': 0, 20:31:52 INFO - 'suite': 'dromaeojs', 20:31:52 INFO - 'system_bits': '32', 20:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:31:52 INFO - 'title': 't-yosemite-r7-0288', 20:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:31:52 INFO - 'use_talos_json': True, 20:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:31:52 INFO - 'work_dir': 'build'} 20:31:52 INFO - [mozharness: 2017-01-24 04:31:52.216511Z] Running clobber step. 20:31:52 INFO - Running pre-action listener: _resource_record_pre_action 20:31:52 INFO - Running main action method: clobber 20:31:52 INFO - rmtree: /builds/slave/test/build 20:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:31:54 INFO - Running post-action listener: _resource_record_post_action 20:31:54 INFO - [mozharness: 2017-01-24 04:31:54.382485Z] Finished clobber step (success) 20:31:54 INFO - [mozharness: 2017-01-24 04:31:54.382721Z] Running read-buildbot-config step. 20:31:54 INFO - Running pre-action listener: _resource_record_pre_action 20:31:54 INFO - Running main action method: read_buildbot_config 20:31:54 INFO - Using buildbot properties: 20:31:54 INFO - { 20:31:54 INFO - "project": "", 20:31:54 INFO - "product": "firefox", 20:31:54 INFO - "script_repo_revision": "production", 20:31:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:31:54 INFO - "repository": "", 20:31:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:31:54 INFO - "buildid": "20170123185543", 20:31:54 INFO - "pgo_build": "False", 20:31:54 INFO - "basedir": "/builds/slave/test", 20:31:54 INFO - "buildnumber": 36, 20:31:54 INFO - "slavename": "t-yosemite-r7-0288", 20:31:54 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:31:54 INFO - "platform": "yosemite_r7", 20:31:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:31:54 INFO - "branch": "mozilla-central", 20:31:54 INFO - "repo_path": "mozilla-central", 20:31:54 INFO - "revision": "8ff550409e1d1f8b54f6f7f115545dbef857be0b", 20:31:54 INFO - "stage_platform": "macosx64", 20:31:54 INFO - "builduid": "611871aa6b594d2e8495165d82eac291", 20:31:54 INFO - "slavebuilddir": "test" 20:31:54 INFO - } 20:31:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 20:31:54 INFO - Running post-action listener: _resource_record_post_action 20:31:54 INFO - [mozharness: 2017-01-24 04:31:54.388521Z] Finished read-buildbot-config step (success) 20:31:54 INFO - [mozharness: 2017-01-24 04:31:54.388759Z] Running download-and-extract step. 20:31:54 INFO - Running pre-action listener: _resource_record_pre_action 20:31:54 INFO - Running main action method: download_and_extract 20:31:54 INFO - mkdir: /builds/slave/test/build/tests 20:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:31:54 INFO - trying https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 20:31:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 20:31:55 INFO - Downloaded 1199 bytes. 20:31:55 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:31:55 INFO - Using the following test package requirements: 20:31:55 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:31:55 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 20:31:55 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 20:31:55 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'jsshell-mac.zip'], 20:31:55 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 20:31:55 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:31:55 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 20:31:55 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 20:31:55 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 20:31:55 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:31:55 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 20:31:55 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:31:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:31:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:31:55 INFO - Fetch https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:31:56 INFO - Expected file size: 16351082 20:31:56 INFO - Obtained file size: 16351082 20:32:03 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:32:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:32:04 INFO - Expected file size: 16351082 20:32:04 INFO - Obtained file size: 16351082 20:32:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 20:32:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:32:10 INFO - Fetch https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 20:32:11 INFO - Expected file size: 14403485 20:32:11 INFO - Obtained file size: 14403485 20:32:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:11 INFO - trying https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 20:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 20:32:13 INFO - Downloaded 69975369 bytes. 20:32:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:32:13 INFO - mkdir: /builds/slave/test/properties 20:32:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:32:13 INFO - Writing to file /builds/slave/test/properties/build_url 20:32:13 INFO - Contents: 20:32:13 INFO - build_url:https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:32:14 INFO - Running post-action listener: _resource_record_post_action 20:32:14 INFO - Running post-action listener: set_extra_try_arguments 20:32:14 INFO - [mozharness: 2017-01-24 04:32:14.240310Z] Finished download-and-extract step (success) 20:32:14 INFO - [mozharness: 2017-01-24 04:32:14.240460Z] Running populate-webroot step. 20:32:14 INFO - Running pre-action listener: _resource_record_pre_action 20:32:14 INFO - Running main action method: populate_webroot 20:32:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:32:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:32:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:32:14 INFO - '--tppagecycles', 20:32:14 INFO - '7'], 20:32:14 INFO - 'tests': ['tsvgm']}}, 20:32:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:32:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:32:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:32:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:32:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:32:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:32:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['damp', 'tps']}, 20:32:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'tests': ['damp', 'tps']}, 20:32:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['dromaeo_dom']}, 20:32:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:32:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['basic_compositor_video']}, 20:32:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:32:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'other-e10s': {'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['a11yr', 20:32:14 INFO - 'ts_paint', 20:32:14 INFO - 'tpaint', 20:32:14 INFO - 'sessionrestore', 20:32:14 INFO - 'sessionrestore_no_auto_restore', 20:32:14 INFO - 'tabpaint']}, 20:32:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['tsvgx', 20:32:14 INFO - 'tsvgr_opacity', 20:32:14 INFO - 'tart', 20:32:14 INFO - 'tscrollx', 20:32:14 INFO - 'cart', 20:32:14 INFO - 'tsvg_static']}, 20:32:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:32:14 INFO - 'tsvgr_opacity', 20:32:14 INFO - 'tart', 20:32:14 INFO - 'tscrollx', 20:32:14 INFO - 'cart', 20:32:14 INFO - 'tsvg_static']}, 20:32:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'talos_options': ['--disable-e10s'], 20:32:14 INFO - 'tests': ['tp5o']}, 20:32:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:32:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'talos_options': ['--disable-e10s', 20:32:14 INFO - '--xperf_path', 20:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:32:14 INFO - 'tests': ['tp5n']}, 20:32:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:32:14 INFO - 'talos_options': ['--xperf_path', 20:32:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:32:14 INFO - 'tests': ['tp5n']}}, 20:32:14 INFO - 'talos.zip': {'path': '', 20:32:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:32:14 INFO - Running post-action listener: _resource_record_post_action 20:32:14 INFO - [mozharness: 2017-01-24 04:32:14.258794Z] Finished populate-webroot step (success) 20:32:14 INFO - [mozharness: 2017-01-24 04:32:14.258929Z] Running create-virtualenv step. 20:32:14 INFO - Running pre-action listener: _resource_record_pre_action 20:32:14 INFO - Running main action method: create_virtualenv 20:32:14 INFO - Creating virtualenv /builds/slave/test/build/venv 20:32:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:32:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:32:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:32:14 INFO - Using real prefix '/tools/python27' 20:32:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:32:15 INFO - Installing distribute.............................................................................................................................................................................................done. 20:32:17 INFO - Installing pip.................done. 20:32:17 INFO - Return code: 0 20:32:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:32:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:32:18 INFO - Reading from file tmpfile_stdout 20:32:18 INFO - Output received: 20:32:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 20:32:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:18 INFO - 'HOME': '/Users/cltbld', 20:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:18 INFO - 'LOGNAME': 'cltbld', 20:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:18 INFO - 'MOZ_NO_REMOTE': '1', 20:32:18 INFO - 'NO_EM_RESTART': '1', 20:32:18 INFO - 'PAGER': '/bin/cat', 20:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:18 INFO - 'PWD': '/builds/slave/test', 20:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:18 INFO - 'SHELL': '/bin/bash', 20:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:18 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:18 INFO - 'USER': 'cltbld', 20:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:18 INFO - 'XPC_FLAGS': '0x0', 20:32:18 INFO - 'XPC_SERVICE_NAME': '0', 20:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:32:18 INFO - Cleaning up... 20:32:18 INFO - Return code: 0 20:32:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:18 INFO - 'HOME': '/Users/cltbld', 20:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:18 INFO - 'LOGNAME': 'cltbld', 20:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:18 INFO - 'MOZ_NO_REMOTE': '1', 20:32:18 INFO - 'NO_EM_RESTART': '1', 20:32:18 INFO - 'PAGER': '/bin/cat', 20:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:18 INFO - 'PWD': '/builds/slave/test', 20:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:18 INFO - 'SHELL': '/bin/bash', 20:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:18 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:18 INFO - 'USER': 'cltbld', 20:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:18 INFO - 'XPC_FLAGS': '0x0', 20:32:18 INFO - 'XPC_SERVICE_NAME': '0', 20:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:18 INFO - Downloading/unpacking psutil>=3.1.1 20:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:32:22 INFO - Installing collected packages: psutil 20:32:22 INFO - Running setup.py install for psutil 20:32:22 INFO - building 'psutil._psutil_osx' extension 20:32:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:32:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:32:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:32:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:32:22 INFO - building 'psutil._psutil_posix' extension 20:32:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:32:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:32:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:32:22 INFO - ^ 20:32:22 INFO - 1 warning generated. 20:32:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:32:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:32:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:32:22 INFO - Successfully installed psutil 20:32:22 INFO - Cleaning up... 20:32:23 INFO - Return code: 0 20:32:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:23 INFO - 'HOME': '/Users/cltbld', 20:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:23 INFO - 'LOGNAME': 'cltbld', 20:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:23 INFO - 'MOZ_NO_REMOTE': '1', 20:32:23 INFO - 'NO_EM_RESTART': '1', 20:32:23 INFO - 'PAGER': '/bin/cat', 20:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:23 INFO - 'PWD': '/builds/slave/test', 20:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:23 INFO - 'SHELL': '/bin/bash', 20:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:23 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:23 INFO - 'USER': 'cltbld', 20:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:23 INFO - 'XPC_FLAGS': '0x0', 20:32:23 INFO - 'XPC_SERVICE_NAME': '0', 20:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:32:25 INFO - Installing collected packages: mozsystemmonitor 20:32:25 INFO - Running setup.py install for mozsystemmonitor 20:32:26 INFO - Successfully installed mozsystemmonitor 20:32:26 INFO - Cleaning up... 20:32:26 INFO - Return code: 0 20:32:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:26 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:26 INFO - 'HOME': '/Users/cltbld', 20:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:26 INFO - 'LOGNAME': 'cltbld', 20:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:26 INFO - 'MOZ_NO_REMOTE': '1', 20:32:26 INFO - 'NO_EM_RESTART': '1', 20:32:26 INFO - 'PAGER': '/bin/cat', 20:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:26 INFO - 'PWD': '/builds/slave/test', 20:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:26 INFO - 'SHELL': '/bin/bash', 20:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:26 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:26 INFO - 'USER': 'cltbld', 20:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:26 INFO - 'XPC_FLAGS': '0x0', 20:32:26 INFO - 'XPC_SERVICE_NAME': '0', 20:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:26 INFO - Downloading/unpacking jsonschema==2.5.1 20:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:29 INFO - Downloading functools32-3.2.3-2.tar.gz 20:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:32:29 INFO - warning: no files found matching '*.txt' 20:32:29 INFO - no previously-included directories found matching 'build' 20:32:29 INFO - no previously-included directories found matching 'dist' 20:32:29 INFO - no previously-included directories found matching '.git*' 20:32:29 INFO - Installing collected packages: jsonschema, functools32 20:32:29 INFO - Running setup.py install for functools32 20:32:29 INFO - warning: no files found matching '*.txt' 20:32:29 INFO - no previously-included directories found matching 'build' 20:32:29 INFO - no previously-included directories found matching 'dist' 20:32:29 INFO - no previously-included directories found matching '.git*' 20:32:29 INFO - Successfully installed jsonschema functools32 20:32:29 INFO - Cleaning up... 20:32:29 INFO - Return code: 0 20:32:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:29 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:29 INFO - 'HOME': '/Users/cltbld', 20:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:29 INFO - 'LOGNAME': 'cltbld', 20:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:29 INFO - 'MOZ_NO_REMOTE': '1', 20:32:29 INFO - 'NO_EM_RESTART': '1', 20:32:29 INFO - 'PAGER': '/bin/cat', 20:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:29 INFO - 'PWD': '/builds/slave/test', 20:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:29 INFO - 'SHELL': '/bin/bash', 20:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:29 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:29 INFO - 'USER': 'cltbld', 20:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:29 INFO - 'XPC_FLAGS': '0x0', 20:32:29 INFO - 'XPC_SERVICE_NAME': '0', 20:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:32:30 INFO - Cleaning up... 20:32:30 INFO - Return code: 0 20:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:30 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:32:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:30 INFO - 'HOME': '/Users/cltbld', 20:32:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:30 INFO - 'LOGNAME': 'cltbld', 20:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:30 INFO - 'MOZ_NO_REMOTE': '1', 20:32:30 INFO - 'NO_EM_RESTART': '1', 20:32:30 INFO - 'PAGER': '/bin/cat', 20:32:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:30 INFO - 'PWD': '/builds/slave/test', 20:32:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:30 INFO - 'SHELL': '/bin/bash', 20:32:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:30 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:30 INFO - 'USER': 'cltbld', 20:32:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:30 INFO - 'XPC_FLAGS': '0x0', 20:32:30 INFO - 'XPC_SERVICE_NAME': '0', 20:32:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 20:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:33 INFO - Downloading blobuploader-1.2.4.tar.gz 20:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:32:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:32:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:34 INFO - Downloading docopt-0.6.1.tar.gz 20:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:32:34 INFO - Installing collected packages: blobuploader, requests, docopt 20:32:34 INFO - Running setup.py install for blobuploader 20:32:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:32:34 INFO - Running setup.py install for requests 20:32:35 INFO - Running setup.py install for docopt 20:32:35 INFO - Successfully installed blobuploader requests docopt 20:32:35 INFO - Cleaning up... 20:32:35 INFO - Return code: 0 20:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:32: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')]} 20:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32: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')]} 20:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:35 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:35 INFO - 'HOME': '/Users/cltbld', 20:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:35 INFO - 'LOGNAME': 'cltbld', 20:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:35 INFO - 'MOZ_NO_REMOTE': '1', 20:32:35 INFO - 'NO_EM_RESTART': '1', 20:32:35 INFO - 'PAGER': '/bin/cat', 20:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:35 INFO - 'PWD': '/builds/slave/test', 20:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:35 INFO - 'SHELL': '/bin/bash', 20:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:35 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:35 INFO - 'USER': 'cltbld', 20:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:35 INFO - 'XPC_FLAGS': '0x0', 20:32:35 INFO - 'XPC_SERVICE_NAME': '0', 20:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:32:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-v_uaN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:32:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-H8bAvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:32:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-B14Ikh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:32:35 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-9oxK1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-Sc96sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-2l1vfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-tblXC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-sADQng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-meRGAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-MaXsbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-giJvSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-e6VWYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-sBYZYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:32:36 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-JeHj95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:32:37 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-12yOzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:32:37 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-SfYD9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:32:37 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-1jGOQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:32:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:32:37 INFO - Running setup.py install for manifestparser 20:32:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:32:37 INFO - Running setup.py install for mozcrash 20:32:37 INFO - Running setup.py install for mozdebug 20:32:37 INFO - Running setup.py install for mozdevice 20:32:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:32:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Running setup.py install for mozfile 20:32:38 INFO - Running setup.py install for mozhttpd 20:32:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Running setup.py install for mozinfo 20:32:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Running setup.py install for mozInstall 20:32:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Running setup.py install for mozleak 20:32:38 INFO - Running setup.py install for mozlog 20:32:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:32:38 INFO - Running setup.py install for moznetwork 20:32:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Running setup.py install for mozprocess 20:32:39 INFO - Running setup.py install for mozprofile 20:32:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Running setup.py install for mozrunner 20:32:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Running setup.py install for mozscreenshot 20:32:39 INFO - Running setup.py install for moztest 20:32:39 INFO - Running setup.py install for mozversion 20:32:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:32:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:32:39 INFO - Cleaning up... 20:32:39 INFO - Return code: 0 20:32:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:39 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:39 INFO - 'HOME': '/Users/cltbld', 20:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:39 INFO - 'LOGNAME': 'cltbld', 20:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:39 INFO - 'MOZ_NO_REMOTE': '1', 20:32:39 INFO - 'NO_EM_RESTART': '1', 20:32:39 INFO - 'PAGER': '/bin/cat', 20:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:39 INFO - 'PWD': '/builds/slave/test', 20:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:39 INFO - 'SHELL': '/bin/bash', 20:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:39 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:39 INFO - 'USER': 'cltbld', 20:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:39 INFO - 'XPC_FLAGS': '0x0', 20:32:39 INFO - 'XPC_SERVICE_NAME': '0', 20:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qFvSkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-S85NCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-G5K437-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-qWJLPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-nCTnin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-7aMJLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-b28ZFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:32:40 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-jOqwr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-pY_xoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-UoOxCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-DEU0pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-8jcfTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:32:41 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)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-0NZRHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-NhDAfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-daCSam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-RxwgwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:32:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:32:41 INFO - Running setup.py (path:/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/pip-sxhdx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:32:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:32:44 INFO - Downloading blessings-1.6.tar.gz 20:32:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:32:44 INFO - Installing collected packages: blessings 20:32:44 INFO - Running setup.py install for blessings 20:32:44 INFO - Successfully installed blessings 20:32:44 INFO - Cleaning up... 20:32:45 INFO - Return code: 0 20:32:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:32:45 INFO - Reading from file tmpfile_stdout 20:32:45 INFO - Current package versions: 20:32:45 INFO - blessings == 1.6 20:32:45 INFO - blobuploader == 1.2.4 20:32:45 INFO - docopt == 0.6.1 20:32:45 INFO - functools32 == 3.2.3-2 20:32:45 INFO - jsonschema == 2.5.1 20:32:45 INFO - manifestparser == 1.1 20:32:45 INFO - mozInstall == 1.12 20:32:45 INFO - mozcrash == 1.0 20:32:45 INFO - mozdebug == 0.1 20:32:45 INFO - mozdevice == 0.49 20:32:45 INFO - mozfile == 1.2 20:32:45 INFO - mozhttpd == 0.7 20:32:45 INFO - mozinfo == 0.9 20:32:45 INFO - mozleak == 0.1 20:32:45 INFO - mozlog == 3.4 20:32:45 INFO - moznetwork == 0.27 20:32:45 INFO - mozprocess == 0.24 20:32:45 INFO - mozprofile == 0.28 20:32:45 INFO - mozrunner == 6.13 20:32:45 INFO - mozscreenshot == 0.1 20:32:45 INFO - mozsystemmonitor == 0.3 20:32:45 INFO - moztest == 0.8 20:32:45 INFO - mozversion == 1.4 20:32:45 INFO - psutil == 3.1.1 20:32:45 INFO - requests == 1.2.3 20:32:45 INFO - wsgiref == 0.1.2 20:32:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:45 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 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:45 INFO - 'HOME': '/Users/cltbld', 20:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:45 INFO - 'LOGNAME': 'cltbld', 20:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:45 INFO - 'MOZ_NO_REMOTE': '1', 20:32:45 INFO - 'NO_EM_RESTART': '1', 20:32:45 INFO - 'PAGER': '/bin/cat', 20:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:45 INFO - 'PWD': '/builds/slave/test', 20:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:45 INFO - 'SHELL': '/bin/bash', 20:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:45 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:45 INFO - 'USER': 'cltbld', 20:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:45 INFO - 'XPC_FLAGS': '0x0', 20:32:45 INFO - 'XPC_SERVICE_NAME': '0', 20:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:32:45 INFO - Cleaning up... 20:32:45 INFO - Return code: 0 20:32:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:32:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c59c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa873da14e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, '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.dkaJpaCobd/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.iiNxv8iTug/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:32:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:32:46 INFO - 'HOME': '/Users/cltbld', 20:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:32:46 INFO - 'LOGNAME': 'cltbld', 20:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:32:46 INFO - 'MOZ_NO_REMOTE': '1', 20:32:46 INFO - 'NO_EM_RESTART': '1', 20:32:46 INFO - 'PAGER': '/bin/cat', 20:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:32:46 INFO - 'PWD': '/builds/slave/test', 20:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:32:46 INFO - 'SHELL': '/bin/bash', 20:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:32:46 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:32:46 INFO - 'USER': 'cltbld', 20:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:32:46 INFO - 'XPC_FLAGS': '0x0', 20:32:46 INFO - 'XPC_SERVICE_NAME': '0', 20:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:32:46 INFO - Cleaning up... 20:32:46 INFO - Return code: 0 20:32:46 INFO - Running post-action listener: _resource_record_post_action 20:32:46 INFO - Running post-action listener: _start_resource_monitoring 20:32:46 INFO - Starting resource monitoring. 20:32:46 INFO - [mozharness: 2017-01-24 04:32:46.714297Z] Finished create-virtualenv step (success) 20:32:46 INFO - [mozharness: 2017-01-24 04:32:46.715315Z] Running install step. 20:32:46 INFO - Running pre-action listener: _resource_record_pre_action 20:32:46 INFO - Running main action method: install 20:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:32:46 INFO - Reading from file tmpfile_stdout 20:32:46 INFO - Detecting whether we're running mozinstall >=1.0... 20:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:32:47 INFO - Reading from file tmpfile_stdout 20:32:47 INFO - Output received: 20:32:47 INFO - Usage: mozinstall [options] installer 20:32:47 INFO - Options: 20:32:47 INFO - -h, --help show this help message and exit 20:32:47 INFO - -d DEST, --destination=DEST 20:32:47 INFO - Directory to install application into. [default: 20:32:47 INFO - "/builds/slave/test"] 20:32:47 INFO - --app=APP Application being installed. [default: firefox] 20:32:47 INFO - mkdir: /builds/slave/test/build/application 20:32:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:33:09 INFO - Reading from file tmpfile_stdout 20:33:09 INFO - Output received: 20:33:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:33:09 INFO - Running post-action listener: _resource_record_post_action 20:33:09 INFO - [mozharness: 2017-01-24 04:33:09.269014Z] Finished install step (success) 20:33:09 INFO - [mozharness: 2017-01-24 04:33:09.269179Z] Running run-tests step. 20:33:09 INFO - Running pre-action listener: _resource_record_pre_action 20:33:09 INFO - Running main action method: run_tests 20:33:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:33:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:33:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:33:09 INFO - 2017-01-23 20:33:09.283 screenresolution[1962:10009] starting screenresolution argv=screenresolution get 20:33:09 INFO - 2017-01-23 20:33:09.286 screenresolution[1962:10009] Display 0: 1600x1200x32@60 20:33:09 INFO - 2017-01-23 20:33:09.292 screenresolution[1963:10012] starting screenresolution argv=screenresolution list 20:33:09 INFO - Available Modes on Display 0 20:33:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:33:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:33:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:33:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:33:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:33:09 INFO - Intel Iris: 20:33:09 INFO - Chipset Model: Intel Iris 20:33:09 INFO - Type: GPU 20:33:09 INFO - Bus: Built-In 20:33:09 INFO - VRAM (Dynamic, Max): 1536 MB 20:33:09 INFO - Vendor: Intel (0x8086) 20:33:09 INFO - Device ID: 0x0a2e 20:33:09 INFO - Revision ID: 0x0009 20:33:09 INFO - Displays: 20:33:09 INFO - Display: 20:33:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:33:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:33:09 INFO - Display Serial Number: 1600x1200 60 20:33:09 INFO - Main Display: Yes 20:33:09 INFO - Mirror: Off 20:33:09 INFO - Online: Yes 20:33:09 INFO - Rotation: Supported 20:33:09 INFO - Return code: 0 20:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:33:09 INFO - Python 2.7.3 20:33:09 INFO - Return code: 0 20:33:09 INFO - grabbing minidump binary from tooltool 20:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:33:09 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 0x10c377d30>, '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 0x10c29edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c36cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:33:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:33:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:33:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:33:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:33:09 INFO - Return code: 0 20:33:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:33:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:33:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:33:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:33:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:33:09 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/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:33:09 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/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0288 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dkaJpaCobd/Render', 20:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:33:09 INFO - 'HOME': '/Users/cltbld', 20:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:33:09 INFO - 'LOGNAME': 'cltbld', 20:33:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:33:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:33:09 INFO - 'MOZ_NO_REMOTE': '1', 20:33:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:33:09 INFO - 'NO_EM_RESTART': '1', 20:33:09 INFO - 'PAGER': '/bin/cat', 20:33:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:33:09 INFO - 'PWD': '/builds/slave/test', 20:33:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:33:09 INFO - 'SHELL': '/bin/bash', 20:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iiNxv8iTug/Listeners', 20:33:09 INFO - 'TMPDIR': '/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/', 20:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:33:09 INFO - 'USER': 'cltbld', 20:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:33:09 INFO - 'XPC_FLAGS': '0x0', 20:33:09 INFO - 'XPC_SERVICE_NAME': '0', 20:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:33:09 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/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0288', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:33:09 INFO - mozversion application_buildid: 20170123185543 20:33:09 INFO - mozversion application_changeset: 8ff550409e1d1f8b54f6f7f115545dbef857be0b 20:33:09 INFO - mozversion application_display_name: Nightly 20:33:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:33:09 INFO - mozversion application_name: Firefox 20:33:09 INFO - mozversion application_remotingname: firefox 20:33:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:33:09 INFO - mozversion application_vendor: Mozilla 20:33:09 INFO - mozversion application_version: 54.0a1 20:33:09 INFO - mozversion platform_buildid: 20170123185543 20:33:09 INFO - mozversion platform_changeset: 8ff550409e1d1f8b54f6f7f115545dbef857be0b 20:33:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:33:09 INFO - mozversion platform_version: 54.0a1 20:33:09 INFO - using testdate: 1485232389 20:33:09 INFO - actual date: 1485232389 20:33:09 INFO - starting webserver on 'localhost:49334' 20:33:09 INFO - SUITE-START | Running 2 tests 20:33:09 INFO - TEST-START | dromaeo_css 20:33:09 INFO - operating with platform_type : mac_ 20:33:09 INFO - Initialising browser for dromaeo_css test... 20:33:09 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpveAq_P/profile http://localhost:49334/getInfo.html) 20:33:12 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 20:33:12 INFO - PROCESS | 1973 | colorDepth:24 20:33:12 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 20:33:12 INFO - PROCESS | 1973 | __metrics 20:33:12 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 20:33:12 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:33:12 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:33:13 INFO - TEST-INFO | 1973: exit 0 20:33:13 INFO - Browser initialized. 20:33:13 INFO - Running cycle 1/1 for dromaeo_css test... 20:33:13 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpveAq_P/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:33:25 INFO - PROCESS | 1975 | RSS: Main: 234815488 20:33:25 INFO - PROCESS | 1975 | 20:36:29 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49334/tests/dromaeo/cssquery-ext.html) 20:36:31 INFO - PROCESS | 1975 | RSS: Main: 364445696 20:36:31 INFO - PROCESS | 1975 | 20:38:15 INFO - PROCESS | 1975 | ************************* 20:38:15 INFO - PROCESS | 1975 | A coding exception was thrown and uncaught in a Task. 20:38:15 INFO - PROCESS | 1975 | 20:38:15 ERROR - PROCESS | 1975 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:38:15 INFO - PROCESS | 1975 | Full stack: 20:38:15 INFO - PROCESS | 1975 | ************************* 20:39:34 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-ext.html (next: http://localhost:49334/tests/dromaeo/cssquery-jquery.html) 20:39:34 INFO - PROCESS | 1975 | RSS: Main: 369160192 20:39:34 INFO - PROCESS | 1975 | 20:42:37 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49334/tests/dromaeo/cssquery-mootools.html) 20:42:37 INFO - PROCESS | 1975 | RSS: Main: 344444928 20:42:37 INFO - PROCESS | 1975 | 20:45:40 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49334/tests/dromaeo/cssquery-prototype.html) 20:45:40 INFO - PROCESS | 1975 | RSS: Main: 350322688 20:45:40 INFO - PROCESS | 1975 | 20:48:44 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49334/tests/dromaeo/cssquery-yui.html) 20:48:44 INFO - PROCESS | 1975 | RSS: Main: 329744384 20:48:44 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49334/tests/dromaeo/cssquery-yui.html (next: http://localhost:49334/tests/dromaeo/cssquery-dojo.html) 20:51:48 INFO - PROCESS | 1975 | RSS: Main: 436756480 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | __start_tp_report 20:51:48 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 20:51:48 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 20:51:48 INFO - PROCESS | 1975 | |i|pagename|runs| 20:51:48 INFO - PROCESS | 1975 | |0;dojo.html;3339.6326404095553;3344.4314466540686;3358.177246574588;3385.678360555746;3430.296789158221;5648.406917273689;5717.199592057115;5729.541636669067;5734.025215713328;5803.883922321551;5738.254026976487;5765.423457654243;5853.8829223415505;5859.238299021132;5897.879402913443;5151.6908985461;5167.534921857032;5194.246834209038;5252.553532949704;5294.258803767476;5330.600204984622;5352.866178345553;5368.275282836806;5371.5165635092835;5404.540614047811;5149;5294.655847369947;5319.813806516753;5327.7336133193185;5356.812511562096;4218.535961044283;5179.585633149339;5204.739763011834;5241.0042092002395;5264.894702105937;4745.572898439123;4822.758862056919;5188.9881473112755;5243.868903277448;5265.736713164365;5758.88482230353;5795.3045634523705;5799.797007104731;5822.563307751893;5823.417658234185;6139.461473530676;6209.16176316196;6225.8132256032395;6306.716197771111;6312;6221.657808820513;6245.500359971192;6280.560360774748;6283.7800676976085;6299.307076221612;5971.134185543072;5976.760929562855;5981.252343457024;5991.55063370249;6002.789902353396;6220.129181914535;6308.621482711052;6309.14826498426;6362.331955144643;6387.329330420332;5497.917531237034;6146.139540464339;6156.476699480505;6170.784022559189;6208.968955155286;6167.352427995085;6284.622922624657;6292.182016337847;6299.559030867796;6305.180326557518;5677.460641239076;6100.72546735398;6229.2524897012645;6252.280987686383;6270.968645156745;6312.905306420407;6327.272363678144;6329.651869147149;6335.049742538564;6338.334474880164;4997.30037794709;5061.493850614983;5062.569681577033;5063.696178229318;5088.465711100355;4452.265376212953;4477.798499067485;4497.64018878489;4515.864524064284;4548.658850586219;5865.530757539472;5866.823995280149;5874.32445268791;5874.765009399662;5888.882222355529;6167.167432396569;6291.9685401573615;6295.150154729145;6298.307186209513;6298.937010629927;5728.513076388554;5770.16332631766;5803.88392232153;5837.708114594253;5909.881802363929;5456.099743542271;5477.7261136943;5523.337199536081;5535.086710692691;5536.723163841792;6428.325025872403;6469.126667899867;6473.255575608865;6474.125992990886;6490.578112422678;6186.443220110212;6201.720922558586;6257.4681152102585;6264.968675156595;6275.811725648238;6448.806535803933;6467.417932386108;6469.482441404771;6470.094186813756;6486.675666216576;6268.122462855295;6280.560360774702;6295.622262664255;6301.558890877594;6302.905456418066;6119.07606531266;6129.325774164928;6165.198524191826;6222.657753823583;6288.11966324724;6112.473085128157;6212.937870621417;6223.315435302204;6235.625862448268;6236.563440559299;6008.369121242382;6020.87958240824;6028.638281703112;6219.222597175353;6238.189035425366;5876;5927.673977931083;5986;5987.251593550806;5998;6100.853682747526;6105.035213716015;6150.354212807591;6185.226846644169;6245.437910588069;6045.758169673164;6113.480612940582;6122.897878381934;6136.693165341804;6140.263168419639 20:51:48 INFO - PROCESS | 1975 | |1;ext.html;429.3602532226982;493.1493174274377;495.98760030999233;498.9925151122736;525.5664077136363;30487.93292234772;32069.19827004326;32072;32106.67893321066;40487.39268910961;40802;41174.38238426419;41180.17639647205;41194.176116477654;41288.58711412885;8562.529060901648;9086.682431047495;9325.673601423969;9544.427334359925;9556.522173891313;8432.241098301152;8621.439606425594;9388.906110938906;9480.383775054599;9505.382150160252;11170.218084734071;11409.600663976762;11433;11599.420028998558;11636.592719254828;11323.20737548372;11367.545298188063;11384.601538946097;11420.973442037866;11426.657200284004;8276.29651479619;8509.787255318604;9497.382670126488;11354.772904541864;11394.54421823126;38543.42184867201;40155.3976690347;40173.59826401757;40195.19609607821;40288.194236115116;3974.006498375406;3999.5000624921886;4009.939850902239;4040.656544193747;4062.4921884764403;29789.553156702666;30460.54309185364;31083.844580776953;31154.688453115632;31156;3165.5251712243116;3291.96708032919;3313.155145437922;3358.932821343584;3363.831808409594;335401;336547.31726341456;340010;340438;343845;60283;60683;60764;60810.69594651998;60917.69541152266;61962.69018654878;62043;62167;62186.689066555286;62217.68891155515;14154.36305366261;14414.495492657916;15972.920135399248;16020.038797672178;16060.875738698413;12326.137170397986;12365.814512782315;12382.75234495305;12383.071269654813;12390.380480975915;13666.316684165951;13969.301534923214;14630.26848657563;14673.559793206221;15735.741140708717;5827.067669172912;7051.1891132519395;7176.820579485555;7223.89164162538;7236.819079523054;875.5859287251171;876.2814492116403;882.4881568690145;903.7830920579014;919.2278486071732;29481;29625;29928.70071299259;30154.84922575417;30302;998.8823693769256;1052.5894900988621;1086.9673909782719;1093.2074246171462;1097.8298363753472;14945.178015209269;15446.227688615525;15576.532704018897;15593.610159746097;15824.367025319088;570893;574860;575852;576214;577246;58928.41071589229;59208.7039564808;59312.11031834526;59352.703236484405;59435.70282148562;1261.7350356425254;1417.3834382043844;1444.8844092472577;1452.7239824433325;1470.5514817980618;24224.273271801874;24739.463983261645;29153.271168220115;29777.702222977492;30115.69884301129;48395;51167.744161278955;51290.974180516925;51293;51361;511016;514565;516333;516571;517099;24047.797610119775;24262.514749704555;24530.264092077265;24547.631785522874;24660.630090549013;34730.479042814884;36549.81725091358;43051.784741076095;43599.34600981051;44288.11423771442;35192.64807351996;35345;35570;36122.63877361298;36997.81501092477;35126.29747404986;35529.28941421105;35986.4602030975;36154.8192259037;37143.62856371402;33837;34091.97724068282;34434.139146521535;34602.82698586491;35881.64118358887;24563.87718061398;30583;32187.87342443097;32229.033129006166;32284.83857580697;20883.582328353652;23409.41476463102;23825.642615361132;23889.64165537553;24398.146064887645 20:51:48 INFO - PROCESS | 1975 | |2;jquery.html;367.4121405750797;384.6749496675308;388.28749245135174;396.8134976561015;420.67187593676925;14936.626584335398;15357.846421535794;17923.10384480774;20693.896530517326;21120;21233.256836010743;21259.893700531476;21594.234635981746;21708.56582868342;21894.78105218947;5563.916541251884;5710.5717071219615;6020.638761674313;6028.216331876872;6125.540584456161;6021.72902219399;6097.298810636767;6098.908516372258;6102.420270074336;6121.357257487966;3918.6473217410426;4109.732867363627;5664.291963504562;5919.023361145406;5984.9401505984815;5930.406959304079;5971.4327138921735;5985.5810093293485;5998.9700051499685;6382.712777925005;4877.853664390074;5786.710664466802;5839.649621022752;5840.977828879929;5857.6778277194735;13405.262710550916;22652.980615872326;24859.502809943882;25387.74612253891;25887.22338329853;2558.5650439425344;2564.269183282774;2579.1778808433633;2580.264624581985;2621.4101827088944;9908.851367229498;9979.15177209938;10403.323783954018;10487.213458990529;11911.880881191164;1836.173721825184;1853.3420635674277;1864.4593068010397;1880.4922670878923;1924.595834874678;125812.37093814473;130891.24467958183;131800.34099829535;132805.3359733195;133404.33297833547;11295.830562541569;11686.824697629543;11714.824277635842;11720.648380548597;11970.880291196976;15344.002639828375;15359.923200383926;15368.308426120851;15379.00036497624;15401.691966160839;8233.50598964064;8489.872651910226;8520.829583408296;8612;8624.913750862537;6685.465162786965;8042.638081286356;8192.879763900708;8239.588020599065;8562.871556926651;4600.102979918951;4688.038952014829;4695.131400690883;4772.7136371817805;4795.6163506919365;1726.9034163306392;1937.4575118966711;1985.0919593850288;1994.5811379610154;2003.6293285742183;974.2303580171726;998.1964518562627;1005.8491226315965;1018.1193267823279;1051.148569658579;20755.066022029045;21323.893380532998;21329.573408532055;21411.571768564852;21425.571488570455;972.6352617768337;1020.2195320579763;1028.1671845804922;1044.2011860926398;1055.466989170464;10332.648215034078;10999.835002474969;11084.778304433867;11144.832827507595;11157.776844463227;584619;600564;614022;616456;620424.5915081763;120093;141893.45266368423;146154;149719;152412;1014.0265345268477;1024.702836177515;1035.3632516002754;1050.4275170032504;1055.883852776194;17699;18233;18340.633187336447;18393.540161495534;18441.72337414913;58076;58614.534636634424;59290;59546.40453595408;59884.90978266896;80478.59760701159;80819.3836123286;81707.32317045867;84269.31461370862;84546.73179902183;5554.750036248298;7155.749548765768;7207.5675459472595;7408.925910740823;8172.959135204286;10212.642557510451;10312.226583006455;12581.056420768662;12859.549915752903;12877.484900603871;8647.870281945901;10923.945380273048;10965.342079475256;11019.944900275448;11115.888841111486;10535.736606584896;10765.515551800345;10880.182168645617;11050.889491104987;11117.833232501358;10936.015758581447;11065.391403472886;11251.831222531504;11293.661190164308;11354.274974006345;7103.431725461847;7378.926210737824;7399.371053460516;7479.364254038468;7509;10429.426381549089;10617.203709721956;10656.14750819917;11008.339499630049;11136.832947505956 20:51:48 INFO - PROCESS | 1975 | |3;mootools.html;1447.8262608486982;1467.6477645365117;1475.741745194591;1490.7987421698072;1491.7911492391067;6952.791416257508;7925.4055945804075;8277.172282771735;8320.58397080146;8353.20644538768;7315.670794814233;7592.696292148307;7622.961885190566;7677.769666909988;7679.232076792318;1662.7921509811274;2256.199049337486;2323.8838058097026;2327.860328380294;2339.1111377676543;2336.147306233221;2336.1823361823394;2338.485533182697;2340.6137987232173;2344.3318654183563;2271.897764600597;2306.08909480755;2309.3418375762913;2309.9769002310013;2312.7687231276905;2090.8709296979614;2156.2668692644575;2158.0720290275176;2158.417227348607;2293.048384920256;2169.240765731997;2189.255653077961;2291.301153148289;2318.6406107053435;2322.1640209524558;8167.060788009336;8234.588270586446;8250.958745206235;8251.422400431971;8266.256036956642;4955.826546070906;5110.5400513953555;5110.872228194325;5117.078925793356;5120.871978200537;3235.3044095519576;3336.4494858348344;3373.3590617782543;3407.165244515085;3502.509648649191;1177.1524502358288;1219.9756004879853;1244.0918129765323;1259.8803113704184;1271.6248706631566;10677.305975111592;10684.252102352915;10714.928507149301;10806.891931080667;10819.350838949687;3895.3962135868987;4451.087527056946;4556.521565235669;4635.907281854344;4656.185167595657;9177.495237761854;9388.014258502895;9461.24310055194;9487.478188699688;9490.335676502578;5198.870028249248;5205.73971301441;5208.427073021964;5208.609354298443;5215.113430716711;4490.708103973231;4671.229247174246;4711.95288047122;4768.332433459318;4776.426828780569;3476.904774995868;3609.729270304738;3622.5109610202812;3623.836927338276;3632.54593175853;1047.738065483629;1172.5778719660916;1220.3471142938486;1245.1284101129245;1247.5508816825936;865.2558799432483;884.893812742475;909.7952960583816;911.2254583603884;950.7337945375306;5143.974280128576;5318;5412.188171774265;5453.718376181594;5462.371827239839;821.3593397150232;975.9411039022598;978.4862946952765;1008.5965613754557;1016.3190662256159;3771.6039815819495;3777.1690228149764;3817.530250853386;3884.0484081400236;3890.9416358754643;9652.27607929408;9988.800223995624;10014.24893133018;10021.549030293654;10023.448710320856;9780.706578802647;9885.456299903575;9893.802123957481;9905.653302134391;9966.551505182138;7529.4729368944745;7599.696012159452;7715.57564333967;7813.492123011986;7814.53112813233;5356.919646205232;5501.284832971688;5528.226048353154;5531.529819965187;5625.662460252398;9174.67888623895;9279.164875161268;9301.348905576544;9321.953390233006;9390.342676012613;8857.867131993155;9127.589258483516;9259.074092590956;9292.513197888306;9476.715698529055;7066.328698773608;7103.289671032855;7190.424766018601;7192.31672991065;7216.206217316196;7664.271894170045;7736.574488403192;7832.725854595062;7837.255460731221;7850.018747656543;5831.475167234969;6926.272741362286;7041.881292291453;7070.257622949722;7176.067111275501;6541.476681865534;6752.763653272112;6873.587584744731;6921.307869213239;7107;6018.428249316308;6333.20834895638;6428.742850286123;6436.742530298736;6437.195350581177;4948.901021979468;4960.355153829979;5019.698818070928;5033.874153146201;5135.306733590917;4971.900561988812;5018.573421259088;5170.250313704417;5191.61062920275;5274.89450210986 20:51:48 INFO - PROCESS | 1975 | |4;prototype.html;347.53777475956974;353.3921654753824;357.3692432856008;369.3388833987163;370.6053053498023;4083.060546240534;4931.1617025105725;5237.162054071349;5259.526642602165;5285.339332583422;4590.196715574778;5000.97499512502;5061.822836200734;5077.314562534057;5154.5103215194595;4084.775337356444;4087.894734211883;4117.485314335708;4126.938095928564;4140.861263152627;3706.4625629283737;3884.4367566702813;3898.688104951597;4076.5311989121333;4135.338345864662;4069.511658600972;4085.22380747657;4092.403962454645;4093.5497095319492;4115.333290017533;4029.49631296088;4037.939430908524;4064.947201663141;4071.755694658315;4086.836526538965;3328.48408496681;3611.837467313977;3612.819359032038;3629.7277704172293;3633.400488919325;4453.151941944089;4907.411110666707;5058.494150584949;5098.821541246039;5136.409312929024;3943.3296339622334;4155.355919832401;4703.670743047988;4711.128441238382;4735.337052812609;4624.537546245382;5490.396056433789;5504.4495550445035;5522.696251706155;5533;3218.9678103218903;3855.4795102661064;3861.8262178201767;3980.8009599520196;4047.4535937648334;4819.59033482151;4822.903541929142;4841.588464980481;5054.570361519312;5059.772310246048;3824.6749026333073;3957.2283404736377;4100.580657412142;4120.979395103065;4134.359174327984;3659.7309668006005;3981.8009099544906;4159.043420013414;4170.72890262132;4183.581641835853;4645.628349732014;4666.510016448292;4708.529147085264;4718.504557021463;4763.309320148559;5493.066178749622;5505.862353441196;5522.5581953443625;5536.197251398606;5540.501354878081;1103.586155191803;1249.6875781054737;1267.854196767365;1292.6556381363278;1334.486222804208;880.6257340630207;907.8470342664779;936.784539555906;946.6497395963538;948.8576713492894;4342.782860857008;4643.30519360431;4772.809087636456;4837.298591704253;4849.515048495122;4498.288856896579;4705.858824235278;4862.902741945141;5233.4243233244315;5366.597505187048;4587.472440669299;4603.654725895572;4606.723596584216;4646.23654839581;4840.733759643183;2528.633348164506;2800.2719292983566;2808.9859550702527;2818.0832838012557;2832.8441935693736;4773.64197685175;5379.596530260246;5492.203630473638;5522.502974732213;5601.80393686219;4621.353010578522;5410.48600382963;5667.744951477193;5799.710014499258;5836.562257830679;4690.108879312919;5359.249705041298;5829;5848;5947.553933455095;4380.496242932104;4388.868333949987;5588.580856435702;5606.6544029431825;5672.979413219413;5153.072446959583;5593.608447408642;5619.8198378341;5626.396477004034;5643.294588176478;4883.877903052452;5268.920966185587;5412.917416516633;5730.389854391707;5872.882542349214;3417.6582341765625;3426.4860270959557;3776.546814382292;3804.3532599457603;3831.7892515910776;4962.404511458648;5210.505002024802;5413.264847255381;5652.85867853307;5663.5469162467725;4871.90256194867;5110.693358398508;5526.269767906567;5530;5595.384507704068;5179.975094380527;5458.399576046552;5487.75305111263;5508.6779172998995;5533.501984821385;4928.581070608895;5147.845564633067;5258.553022993088;5302.496262855023;5374.785008599612;5332.706701131475;5457.762317449827;5466.480684334982;5475.890482190413;5493.23094766741;4781.641376896677;4889.804407823647;5367.275417818544;5398.46015398457;5404.459554044564 20:51:48 INFO - PROCESS | 1975 | |5;yui.html;613.4908026338139;697.7313734212329;726.220024771067;778.8870613761005;816.7549735079476;14857.40570377185;15869;15918.04491730497;15919.124448155362;15919.283632236547;14508.419663213484;14675.97268191227;14680.045797023186;14700.705985880302;14716;675.3786516404895;693.7918624412681;697.166885571742;849.337516736943;869.0136694851326;848.0671261612208;868.6916144768611;870.4081224767187;885.8051228729669;886.7871710789428;775.2828633514005;932.9923682423001;933.4119504712022;935.2704890185666;936.180841763457;708.0335342257832;927.5408672706985;927.6984979881531;929.549168653206;933.2254228989922;542.6120323968381;548.5967813656958;548.6516062300428;552.988031901619;662.8011596521072;14947.850521494755;15357.846421535753;15423.305951232222;15428.305726242346;15480.071195728293;9638.75903102421;13756.862431375659;13905.374258158306;13908.93045534776;13994;12452.813207801799;12814.55149069778;12935.87064129356;13013.024023198299;13167.275799831006;4347.586979236968;4482.148391805546;4487.439070116236;4527.592516673515;4612.492625811158;112467.43766281198;117824.41087794592;118866.4056679711;119023;119026;10997;11264.211505194722;11280.041196498225;11398.430078496041;11604.187706860439;22094.447638809157;22275.554488910457;22309.776902231093;22653.320400388016;22675.773242267696;7584;7596.3922886168975;7645.350145237606;7875.369970402354;7988.201179882081;4253.128108737701;4326.37571157494;4334.436523251957;4448.5773851484055;4509.503954564995;3598.3522965865873;3664.908377290589;3665.651763082556;3706.425504046877;3709.703223742148;659.5251418978328;663.8141320430287;680.8876535371708;687.2783577243874;691.4675699711195;661.9834504137435;689.1282527602586;698.1482591238681;698.8637215742983;717.5622870049266;10315.329503582243;10350.637727679496;10383.584656613652;10385.409224418416;10437.791244175225;610.9480694141048;640.2317219336815;643.797203880776;649.0815496073099;649.3084864619166;4867.464578896319;5062.696238225718;5074.974625126924;5076.670016448919;5081.2378143278065;102932;103900;105005;105267;110888.4455577717;93670;95194;96134.9999999986;98348.01651983532;98825.50587247018;65056.349436505974;67324.6535069296;68502.65748671225;70887.6455617729;75990.24009760053;9544.618215271588;10186;10404.427756473468;11027.72430689207;11058.22592418523;49055.75472122616;49611.503884960686;50559.49440505695;50567.65633670403;50614;63384.36615633785;65092;66058.33941660522;66541.66729166324;66741;12921.676958076123;13056.608301750963;13082.803757943448;13273.800892986419;13320.800187996994;14673.119612823264;14699.191544465157;14846.777298340317;14896.478623248568;15232.847671523143;13535.932320338336;13798.379072941541;13906.443742250602;13939;14354.641133971316;13500.93249533746;13813.86186138166;14112.50606228777;14131.15213087218;14374.137551746928;13114.540991065267;13277.535286264934;13295.335233238106;13933.442662293395;14293.070950388192;10745.24783265164;11052.778944420907;11293.774124517628;11632.069434445393;11656.125790565911;10678.199135065057;10799.460026998775;10859.945700271448;10889;10923.836142458029 20:51:48 INFO - PROCESS | 1975 | __end_tp_report 20:51:48 INFO - PROCESS | 1975 | __start_cc_report 20:51:48 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,1755 20:51:48 INFO - PROCESS | 1975 | __end_cc_report 20:51:48 INFO - PROCESS | 1975 | __startTimestamp1485233508672__endTimestamp 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | ------- Summary: start ------- 20:51:48 INFO - PROCESS | 1975 | Number of tests: 6 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5800.10 Median:6008.37 stddev:656.97 (10.9%) stddev-sans-first:629.99 20:51:48 INFO - PROCESS | 1975 | Values: 3339.6 3344.4 3358.2 3385.7 3430.3 5648.4 5717.2 5729.5 5734.0 5803.9 5738.3 5765.4 5853.9 5859.2 5897.9 5151.7 5167.5 5194.2 5252.6 5294.3 5330.6 5352.9 5368.3 5371.5 5404.5 5149.0 5294.7 5319.8 5327.7 5356.8 4218.5 5179.6 5204.7 5241.0 5264.9 4745.6 4822.8 5189.0 5243.9 5265.7 5758.9 5795.3 5799.8 5822.6 5823.4 6139.5 6209.2 6225.8 6306.7 6312.0 6221.7 6245.5 6280.6 6283.8 6299.3 5971.1 5976.8 5981.3 5991.6 6002.8 6220.1 6308.6 6309.1 6362.3 6387.3 5497.9 6146.1 6156.5 6170.8 6209.0 6167.4 6284.6 6292.2 6299.6 6305.2 5677.5 6100.7 6229.3 6252.3 6271.0 6312.9 6327.3 6329.7 6335.0 6338.3 4997.3 5061.5 5062.6 5063.7 5088.5 4452.3 4477.8 4497.6 4515.9 4548.7 5865.5 5866.8 5874.3 5874.8 5888.9 6167.2 6292.0 6295.2 6298.3 6298.9 5728.5 5770.2 5803.9 5837.7 5909.9 5456.1 5477.7 5523.3 5535.1 5536.7 6428.3 6469.1 6473.3 6474.1 6490.6 6186.4 6201.7 6257.5 6265.0 6275.8 6448.8 6467.4 6469.5 6470.1 6486.7 6268.1 6280.6 6295.6 6301.6 6302.9 6119.1 6129.3 6165.2 6222.7 6288.1 6112.5 6212.9 6223.3 6235.6 6236.6 6008.4 6020.9 6028.6 6219.2 6238.2 5876.0 5927.7 5986.0 5987.3 5998.0 6100.9 6105.0 6150.4 6185.2 6245.4 6045.8 6113.5 6122.9 6136.7 6140.3 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:61567.72 Median:35159.47 stddev:129914.13 (369.5%) stddev-sans-first:130197.47 20:51:48 INFO - PROCESS | 1975 | Values: 429.4 493.1 496.0 499.0 525.6 30487.9 32069.2 32072.0 32106.7 40487.4 40802.0 41174.4 41180.2 41194.2 41288.6 8562.5 9086.7 9325.7 9544.4 9556.5 8432.2 8621.4 9388.9 9480.4 9505.4 11170.2 11409.6 11433.0 11599.4 11636.6 11323.2 11367.5 11384.6 11421.0 11426.7 8276.3 8509.8 9497.4 11354.8 11394.5 38543.4 40155.4 40173.6 40195.2 40288.2 3974.0 3999.5 4009.9 4040.7 4062.5 29789.6 30460.5 31083.8 31154.7 31156.0 3165.5 3292.0 3313.2 3358.9 3363.8 335401.0 336547.3 340010.0 340438.0 343845.0 60283.0 60683.0 60764.0 60810.7 60917.7 61962.7 62043.0 62167.0 62186.7 62217.7 14154.4 14414.5 15972.9 16020.0 16060.9 12326.1 12365.8 12382.8 12383.1 12390.4 13666.3 13969.3 14630.3 14673.6 15735.7 5827.1 7051.2 7176.8 7223.9 7236.8 875.6 876.3 882.5 903.8 919.2 29481.0 29625.0 29928.7 30154.8 30302.0 998.9 1052.6 1087.0 1093.2 1097.8 14945.2 15446.2 15576.5 15593.6 15824.4 570893.0 574860.0 575852.0 576214.0 577246.0 58928.4 59208.7 59312.1 59352.7 59435.7 1261.7 1417.4 1444.9 1452.7 1470.6 24224.3 24739.5 29153.3 29777.7 30115.7 48395.0 51167.7 51291.0 51293.0 51361.0 511016.0 514565.0 516333.0 516571.0 517099.0 24047.8 24262.5 24530.3 24547.6 24660.6 34730.5 36549.8 43051.8 43599.3 44288.1 35192.6 35345.0 35570.0 36122.6 36997.8 35126.3 35529.3 35986.5 36154.8 37143.6 33837.0 34092.0 34434.1 34602.8 35881.6 24563.9 30583.0 32187.9 32229.0 32284.8 20883.6 23409.4 23825.6 23889.6 24398.1 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:36139.68 Median:21418.57 stddev:102125.04 (476.8%) stddev-sans-first:102376.20 20:51:48 INFO - PROCESS | 1975 | Values: 367.4 384.7 388.3 396.8 420.7 14936.6 15357.8 17923.1 20693.9 21120.0 21233.3 21259.9 21594.2 21708.6 21894.8 5563.9 5710.6 6020.6 6028.2 6125.5 6021.7 6097.3 6098.9 6102.4 6121.4 3918.6 4109.7 5664.3 5919.0 5984.9 5930.4 5971.4 5985.6 5999.0 6382.7 4877.9 5786.7 5839.6 5841.0 5857.7 13405.3 22653.0 24859.5 25387.7 25887.2 2558.6 2564.3 2579.2 2580.3 2621.4 9908.9 9979.2 10403.3 10487.2 11911.9 1836.2 1853.3 1864.5 1880.5 1924.6 125812.4 130891.2 131800.3 132805.3 133404.3 11295.8 11686.8 11714.8 11720.6 11970.9 15344.0 15359.9 15368.3 15379.0 15401.7 8233.5 8489.9 8520.8 8612.0 8624.9 6685.5 8042.6 8192.9 8239.6 8562.9 4600.1 4688.0 4695.1 4772.7 4795.6 1726.9 1937.5 1985.1 1994.6 2003.6 974.2 998.2 1005.8 1018.1 1051.1 20755.1 21323.9 21329.6 21411.6 21425.6 972.6 1020.2 1028.2 1044.2 1055.5 10332.6 10999.8 11084.8 11144.8 11157.8 584619.0 600564.0 614022.0 616456.0 620424.6 120093.0 141893.5 146154.0 149719.0 152412.0 1014.0 1024.7 1035.4 1050.4 1055.9 17699.0 18233.0 18340.6 18393.5 18441.7 58076.0 58614.5 59290.0 59546.4 59884.9 80478.6 80819.4 81707.3 84269.3 84546.7 5554.8 7155.7 7207.6 7408.9 8173.0 10212.6 10312.2 12581.1 12859.5 12877.5 8647.9 10923.9 10965.3 11019.9 11115.9 10535.7 10765.5 10880.2 11050.9 11117.8 10936.0 11065.4 11251.8 11293.7 11354.3 7103.4 7378.9 7399.4 7479.4 7509.0 10429.4 10617.2 10656.1 11008.3 11136.8 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5363.44 Median:5202.30 stddev:2922.71 (56.2%) stddev-sans-first:2916.09 20:51:48 INFO - PROCESS | 1975 | Values: 1447.8 1467.6 1475.7 1490.8 1491.8 6952.8 7925.4 8277.2 8320.6 8353.2 7315.7 7592.7 7623.0 7677.8 7679.2 1662.8 2256.2 2323.9 2327.9 2339.1 2336.1 2336.2 2338.5 2340.6 2344.3 2271.9 2306.1 2309.3 2310.0 2312.8 2090.9 2156.3 2158.1 2158.4 2293.0 2169.2 2189.3 2291.3 2318.6 2322.2 8167.1 8234.6 8251.0 8251.4 8266.3 4955.8 5110.5 5110.9 5117.1 5120.9 3235.3 3336.4 3373.4 3407.2 3502.5 1177.2 1220.0 1244.1 1259.9 1271.6 10677.3 10684.3 10714.9 10806.9 10819.4 3895.4 4451.1 4556.5 4635.9 4656.2 9177.5 9388.0 9461.2 9487.5 9490.3 5198.9 5205.7 5208.4 5208.6 5215.1 4490.7 4671.2 4712.0 4768.3 4776.4 3476.9 3609.7 3622.5 3623.8 3632.5 1047.7 1172.6 1220.3 1245.1 1247.6 865.3 884.9 909.8 911.2 950.7 5144.0 5318.0 5412.2 5453.7 5462.4 821.4 975.9 978.5 1008.6 1016.3 3771.6 3777.2 3817.5 3884.0 3890.9 9652.3 9988.8 10014.2 10021.5 10023.4 9780.7 9885.5 9893.8 9905.7 9966.6 7529.5 7599.7 7715.6 7813.5 7814.5 5356.9 5501.3 5528.2 5531.5 5625.7 9174.7 9279.2 9301.3 9322.0 9390.3 8857.9 9127.6 9259.1 9292.5 9476.7 7066.3 7103.3 7190.4 7192.3 7216.2 7664.3 7736.6 7832.7 7837.3 7850.0 5831.5 6926.3 7041.9 7070.3 7176.1 6541.5 6752.8 6873.6 6921.3 7107.0 6018.4 6333.2 6428.7 6436.7 6437.2 4948.9 4960.4 5019.7 5033.9 5135.3 4971.9 5018.6 5170.3 5191.6 5274.9 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:4417.53 Median:4830.10 stddev:1304.89 (27.0%) stddev-sans-first:1272.29 20:51:48 INFO - PROCESS | 1975 | Values: 347.5 353.4 357.4 369.3 370.6 4083.1 4931.2 5237.2 5259.5 5285.3 4590.2 5001.0 5061.8 5077.3 5154.5 4084.8 4087.9 4117.5 4126.9 4140.9 3706.5 3884.4 3898.7 4076.5 4135.3 4069.5 4085.2 4092.4 4093.5 4115.3 4029.5 4037.9 4064.9 4071.8 4086.8 3328.5 3611.8 3612.8 3629.7 3633.4 4453.2 4907.4 5058.5 5098.8 5136.4 3943.3 4155.4 4703.7 4711.1 4735.3 4624.5 5490.4 5504.4 5522.7 5533.0 3219.0 3855.5 3861.8 3980.8 4047.5 4819.6 4822.9 4841.6 5054.6 5059.8 3824.7 3957.2 4100.6 4121.0 4134.4 3659.7 3981.8 4159.0 4170.7 4183.6 4645.6 4666.5 4708.5 4718.5 4763.3 5493.1 5505.9 5522.6 5536.2 5540.5 1103.6 1249.7 1267.9 1292.7 1334.5 880.6 907.8 936.8 946.6 948.9 4342.8 4643.3 4772.8 4837.3 4849.5 4498.3 4705.9 4862.9 5233.4 5366.6 4587.5 4603.7 4606.7 4646.2 4840.7 2528.6 2800.3 2809.0 2818.1 2832.8 4773.6 5379.6 5492.2 5522.5 5601.8 4621.4 5410.5 5667.7 5799.7 5836.6 4690.1 5359.2 5829.0 5848.0 5947.6 4380.5 4388.9 5588.6 5606.7 5673.0 5153.1 5593.6 5619.8 5626.4 5643.3 4883.9 5268.9 5412.9 5730.4 5872.9 3417.7 3426.5 3776.5 3804.4 3831.8 4962.4 5210.5 5413.3 5652.9 5663.5 4871.9 5110.7 5526.3 5530.0 5595.4 5180.0 5458.4 5487.8 5508.7 5533.5 4928.6 5147.8 5258.6 5302.5 5374.8 5332.7 5457.8 5466.5 5475.9 5493.2 4781.6 4889.8 5367.3 5398.5 5404.5 20:51:48 INFO - PROCESS | 1975 | 20:51:48 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:20955.84 Median:3686.04 stddev:30521.07 (828.0%) stddev-sans-first:30568.47 20:51:48 INFO - PROCESS | 1975 | Values: 613.5 697.7 726.2 778.9 816.8 14857.4 15869.0 15918.0 15919.1 15919.3 14508.4 14676.0 14680.0 14700.7 14716.0 675.4 693.8 697.2 849.3 869.0 848.1 868.7 870.4 885.8 886.8 775.3 933.0 933.4 935.3 936.2 708.0 927.5 927.7 929.5 933.2 542.6 548.6 548.7 553.0 662.8 14947.9 15357.8 15423.3 15428.3 15480.1 9638.8 13756.9 13905.4 13908.9 13994.0 12452.8 12814.6 12935.9 13013.0 13167.3 4347.6 4482.1 4487.4 4527.6 4612.5 112467.4 117824.4 118866.4 119023.0 119026.0 10997.0 11264.2 11280.0 11398.4 11604.2 22094.4 22275.6 22309.8 22653.3 22675.8 7584.0 7596.4 7645.4 7875.4 7988.2 4253.1 4326.4 4334.4 4448.6 4509.5 3598.4 3664.9 3665.7 3706.4 3709.7 659.5 663.8 680.9 687.3 691.5 662.0 689.1 698.1 698.9 717.6 10315.3 10350.6 10383.6 10385.4 10437.8 610.9 640.2 643.8 649.1 649.3 4867.5 5062.7 5075.0 5076.7 5081.2 102932.0 103900.0 105005.0 105267.0 110888.4 93670.0 95194.0 96135.0 98348.0 98825.5 65056.3 67324.7 68502.7 70887.6 75990.2 9544.6 10186.0 10404.4 11027.7 11058.2 49055.8 49611.5 50559.5 50567.7 50614.0 63384.4 65092.0 66058.3 66541.7 66741.0 12921.7 13056.6 13082.8 13273.8 13320.8 14673.1 14699.2 14846.8 14896.5 15232.8 13535.9 13798.4 13906.4 13939.0 14354.6 13500.9 13813.9 14112.5 14131.2 14374.1 13114.5 13277.5 13295.3 13933.4 14293.1 10745.2 11052.8 11293.8 11632.1 11656.1 10678.2 10799.5 10859.9 10889.0 10923.8 20:51:48 INFO - PROCESS | 1975 | -------- Summary: end -------- 20:51:48 INFO - PROCESS | 1975 | 20:51:49 INFO - TEST-INFO | 1975: exit 0 20:51:49 INFO - TEST-OK | dromaeo_css | took 1119437ms 20:51:49 INFO - TEST-START | kraken 20:51:49 INFO - operating with platform_type : mac_ 20:51:49 INFO - Initialising browser for kraken test... 20:51:49 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpaWujNm/profile http://localhost:49334/getInfo.html) 20:51:51 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 20:51:51 INFO - PROCESS | 1977 | colorDepth:24 20:51:51 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 20:51:51 INFO - PROCESS | 1977 | __metrics 20:51:51 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 20:51:51 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:51:51 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:51:52 INFO - TEST-INFO | 1977: exit 0 20:51:52 INFO - Browser initialized. 20:51:52 INFO - Running cycle 1/1 for kraken test... 20:51:52 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/T/tmpaWujNm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:52:04 INFO - PROCESS | 1978 | RSS: Main: 234729472 20:52:04 INFO - PROCESS | 1978 | 20:52:07 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49334/tests/kraken/driver.html?testName=audio-beat-detection) 20:52:08 INFO - PROCESS | 1978 | RSS: Main: 287821824 20:52:08 INFO - PROCESS | 1978 | 20:52:11 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49334/tests/kraken/driver.html?testName=audio-dft) 20:52:11 INFO - PROCESS | 1978 | RSS: Main: 288653312 20:52:11 INFO - PROCESS | 1978 | 20:52:15 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49334/tests/kraken/driver.html?testName=audio-fft) 20:52:15 INFO - PROCESS | 1978 | RSS: Main: 377516032 20:52:15 INFO - PROCESS | 1978 | 20:52:17 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49334/tests/kraken/driver.html?testName=audio-oscillator) 20:52:18 INFO - PROCESS | 1978 | RSS: Main: 281665536 20:52:18 INFO - PROCESS | 1978 | 20:52:20 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:52:20 INFO - PROCESS | 1978 | RSS: Main: 285310976 20:52:20 INFO - PROCESS | 1978 | 20:52:23 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49334/tests/kraken/driver.html?testName=imaging-darkroom) 20:52:24 INFO - PROCESS | 1978 | RSS: Main: 328142848 20:52:24 INFO - PROCESS | 1978 | 20:52:27 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49334/tests/kraken/driver.html?testName=imaging-desaturate) 20:52:27 INFO - PROCESS | 1978 | RSS: Main: 330244096 20:52:27 INFO - PROCESS | 1978 | 20:52:30 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49334/tests/kraken/driver.html?testName=json-parse-financial) 20:52:31 INFO - PROCESS | 1978 | RSS: Main: 328425472 20:52:31 INFO - PROCESS | 1978 | 20:52:32 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:52:33 INFO - PROCESS | 1978 | RSS: Main: 302862336 20:52:33 INFO - PROCESS | 1978 | 20:52:35 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:52:36 INFO - PROCESS | 1978 | RSS: Main: 306999296 20:52:36 INFO - PROCESS | 1978 | 20:52:38 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:52:39 INFO - PROCESS | 1978 | RSS: Main: 308883456 20:52:39 INFO - PROCESS | 1978 | 20:52:42 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:52:42 INFO - PROCESS | 1978 | RSS: Main: 328921088 20:52:42 INFO - PROCESS | 1978 | 20:52:45 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:52:46 INFO - PROCESS | 1978 | RSS: Main: 322961408 20:52:46 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:49334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49334/tests/kraken/driver.html?testName=ai-astar) 20:52:48 INFO - PROCESS | 1978 | RSS: Main: 367476736 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | __start_tp_report 20:52:48 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 20:52:48 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 20:52:48 INFO - PROCESS | 1978 | |i|pagename|runs| 20:52:48 INFO - PROCESS | 1978 | |0;ai-astar;114;111;113;112;112;114;112;112;113;112 20:52:48 INFO - PROCESS | 1978 | |1;audio-beat-detection;146;117;141;148;119;141;143;114;131;115 20:52:48 INFO - PROCESS | 1978 | |2;audio-dft;184;185;186;185;187;181;183;180;185;183 20:52:48 INFO - PROCESS | 1978 | |3;audio-fft;80;59;59;87;61;59;61;59;75;59 20:52:48 INFO - PROCESS | 1978 | |4;audio-oscillator;87;71;88;70;68;69;83;69;70;83 20:52:48 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;93;132;89;84;91;123;88;84;89;84 20:52:48 INFO - PROCESS | 1978 | |6;imaging-darkroom;94;95;94;98;94;95;95;95;94;94 20:52:48 INFO - PROCESS | 1978 | |7;imaging-desaturate;86;85;87;95;86;85;88;85;85;85 20:52:48 INFO - PROCESS | 1978 | |8;json-parse-financial;57;53;54;53;55;55;54;53;54;54 20:52:48 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;67;78;83;78;102;106;108;77;74;74 20:52:48 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;88;88;86;87;90;85;85;84;90;81 20:52:48 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;152;157;135;151;149;156;153;150;209;155 20:52:48 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;175;174;173;175;176;177;173;175;172;175 20:52:48 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;67;68;68;67;67;67;67;67;66;67 20:52:48 INFO - PROCESS | 1978 | __end_tp_report 20:52:48 INFO - PROCESS | 1978 | __start_cc_report 20:52:48 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,1937 20:52:48 INFO - PROCESS | 1978 | __end_cc_report 20:52:48 INFO - PROCESS | 1978 | __startTimestamp1485233568431__endTimestamp 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | ------- Summary: start ------- 20:52:48 INFO - PROCESS | 1978 | Number of tests: 14 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:0.97 (0.9%) stddev-sans-first:0.87 20:52:48 INFO - PROCESS | 1978 | Values: 114.0 111.0 113.0 112.0 112.0 114.0 112.0 112.0 113.0 112.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:141.00 stddev:13.91 (9.9%) stddev-sans-first:13.72 20:52:48 INFO - PROCESS | 1978 | Values: 146.0 117.0 141.0 148.0 119.0 141.0 143.0 114.0 131.0 115.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:183.90 Median:185.00 stddev:2.18 (1.2%) stddev-sans-first:2.32 20:52:48 INFO - PROCESS | 1978 | Values: 184.0 185.0 186.0 185.0 187.0 181.0 183.0 180.0 185.0 183.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:65.90 Median:61.00 stddev:10.61 (17.4%) stddev-sans-first:9.95 20:52:48 INFO - PROCESS | 1978 | Values: 80.0 59.0 59.0 87.0 61.0 59.0 61.0 59.0 75.0 59.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:77.00 stddev:8.31 (10.8%) stddev-sans-first:7.76 20:52:48 INFO - PROCESS | 1978 | Values: 87.0 71.0 88.0 70.0 68.0 69.0 83.0 69.0 70.0 83.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:88.50 stddev:17.17 (19.4%) stddev-sans-first:18.18 20:52:48 INFO - PROCESS | 1978 | Values: 93.0 132.0 89.0 84.0 91.0 123.0 88.0 84.0 89.0 84.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:94.80 Median:95.00 stddev:1.23 (1.3%) stddev-sans-first:1.27 20:52:48 INFO - PROCESS | 1978 | Values: 94.0 95.0 94.0 98.0 94.0 95.0 95.0 95.0 94.0 94.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:86.00 stddev:3.09 (3.6%) stddev-sans-first:3.27 20:52:48 INFO - PROCESS | 1978 | Values: 86.0 85.0 87.0 95.0 86.0 85.0 88.0 85.0 85.0 85.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:0.78 20:52:48 INFO - PROCESS | 1978 | Values: 57.0 53.0 54.0 53.0 55.0 55.0 54.0 53.0 54.0 54.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:84.70 Median:75.50 stddev:14.87 (19.7%) stddev-sans-first:14.33 20:52:48 INFO - PROCESS | 1978 | Values: 67.0 78.0 83.0 78.0 102.0 106.0 108.0 77.0 74.0 74.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:87.50 stddev:2.80 (3.2%) stddev-sans-first:2.91 20:52:48 INFO - PROCESS | 1978 | Values: 88.0 88.0 86.0 87.0 90.0 85.0 85.0 84.0 90.0 81.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:156.70 Median:154.00 stddev:19.39 (12.6%) stddev-sans-first:20.49 20:52:48 INFO - PROCESS | 1978 | Values: 152.0 157.0 135.0 151.0 149.0 156.0 153.0 150.0 209.0 155.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 20:52:48 INFO - PROCESS | 1978 | Values: 175.0 174.0 173.0 175.0 176.0 177.0 173.0 175.0 172.0 175.0 20:52:48 INFO - PROCESS | 1978 | 20:52:48 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 20:52:48 INFO - PROCESS | 1978 | Values: 67.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 20:52:48 INFO - PROCESS | 1978 | -------- Summary: end -------- 20:52:48 INFO - PROCESS | 1978 | 20:52:49 INFO - TEST-INFO | 1978: exit 0 20:52:49 INFO - TEST-OK | kraken | took 60064ms 20:52:49 INFO - SUITE-END | took 1179s 20:52:49 INFO - Completed test suite (00:19:39) 20:52:49 INFO - javascript benchmark 20:52:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.6326404095553, 3344.4314466540686, 3358.177246574588, 3385.678360555746, 3430.296789158221, 5648.406917273689, 5717.199592057115, 5729.541636669067, 5734.025215713328, 5803.883922321551, 5738.254026976487, 5765.423457654243, 5853.8829223415505, 5859.238299021132, 5897.879402913443, 5151.6908985461, 5167.534921857032, 5194.246834209038, 5252.553532949704, 5294.258803767476, 5330.600204984622, 5352.866178345553, 5368.275282836806, 5371.5165635092835, 5404.540614047811, 5149.0, 5294.655847369947, 5319.813806516753, 5327.7336133193185, 5356.812511562096, 4218.535961044283, 5179.585633149339, 5204.739763011834, 5241.0042092002395, 5264.894702105937, 4745.572898439123, 4822.758862056919, 5188.9881473112755, 5243.868903277448, 5265.736713164365, 5758.88482230353, 5795.3045634523705, 5799.797007104731, 5822.563307751893, 5823.417658234185, 6139.461473530676, 6209.16176316196, 6225.8132256032395, 6306.716197771111, 6312.0, 6221.657808820513, 6245.500359971192, 6280.560360774748, 6283.7800676976085, 6299.307076221612, 5971.134185543072, 5976.760929562855, 5981.252343457024, 5991.55063370249, 6002.789902353396, 6220.129181914535, 6308.621482711052, 6309.14826498426, 6362.331955144643, 6387.329330420332, 5497.917531237034, 6146.139540464339, 6156.476699480505, 6170.784022559189, 6208.968955155286, 6167.352427995085, 6284.622922624657, 6292.182016337847, 6299.559030867796, 6305.180326557518, 5677.460641239076, 6100.72546735398, 6229.2524897012645, 6252.280987686383, 6270.968645156745, 6312.905306420407, 6327.272363678144, 6329.651869147149, 6335.049742538564, 6338.334474880164, 4997.30037794709, 5061.493850614983, 5062.569681577033, 5063.696178229318, 5088.465711100355, 4452.265376212953, 4477.798499067485, 4497.64018878489, 4515.864524064284, 4548.658850586219, 5865.530757539472, 5866.823995280149, 5874.32445268791, 5874.765009399662, 5888.882222355529, 6167.167432396569, 6291.9685401573615, 6295.150154729145, 6298.307186209513, 6298.937010629927, 5728.513076388554, 5770.16332631766, 5803.88392232153, 5837.708114594253, 5909.881802363929, 5456.099743542271, 5477.7261136943, 5523.337199536081, 5535.086710692691, 5536.723163841792, 6428.325025872403, 6469.126667899867, 6473.255575608865, 6474.125992990886, 6490.578112422678, 6186.443220110212, 6201.720922558586, 6257.4681152102585, 6264.968675156595, 6275.811725648238, 6448.806535803933, 6467.417932386108, 6469.482441404771, 6470.094186813756, 6486.675666216576, 6268.122462855295, 6280.560360774702, 6295.622262664255, 6301.558890877594, 6302.905456418066, 6119.07606531266, 6129.325774164928, 6165.198524191826, 6222.657753823583, 6288.11966324724, 6112.473085128157, 6212.937870621417, 6223.315435302204, 6235.625862448268, 6236.563440559299, 6008.369121242382, 6020.87958240824, 6028.638281703112, 6219.222597175353, 6238.189035425366, 5876.0, 5927.673977931083, 5986.0, 5987.251593550806, 5998.0, 6100.853682747526, 6105.035213716015, 6150.354212807591, 6185.226846644169, 6245.437910588069, 6045.758169673164, 6113.480612940582, 6122.897878381934, 6136.693165341804, 6140.263168419639], "value": 5757.095709687585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.3602532226982, 493.1493174274377, 495.98760030999233, 498.9925151122736, 525.5664077136363, 30487.93292234772, 32069.19827004326, 32072.0, 32106.67893321066, 40487.39268910961, 40802.0, 41174.38238426419, 41180.17639647205, 41194.176116477654, 41288.58711412885, 8562.529060901648, 9086.682431047495, 9325.673601423969, 9544.427334359925, 9556.522173891313, 8432.241098301152, 8621.439606425594, 9388.906110938906, 9480.383775054599, 9505.382150160252, 11170.218084734071, 11409.600663976762, 11433.0, 11599.420028998558, 11636.592719254828, 11323.20737548372, 11367.545298188063, 11384.601538946097, 11420.973442037866, 11426.657200284004, 8276.29651479619, 8509.787255318604, 9497.382670126488, 11354.772904541864, 11394.54421823126, 38543.42184867201, 40155.3976690347, 40173.59826401757, 40195.19609607821, 40288.194236115116, 3974.006498375406, 3999.5000624921886, 4009.939850902239, 4040.656544193747, 4062.4921884764403, 29789.553156702666, 30460.54309185364, 31083.844580776953, 31154.688453115632, 31156.0, 3165.5251712243116, 3291.96708032919, 3313.155145437922, 3358.932821343584, 3363.831808409594, 335401.0, 336547.31726341456, 340010.0, 340438.0, 343845.0, 60283.0, 60683.0, 60764.0, 60810.69594651998, 60917.69541152266, 61962.69018654878, 62043.0, 62167.0, 62186.689066555286, 62217.68891155515, 14154.36305366261, 14414.495492657916, 15972.920135399248, 16020.038797672178, 16060.875738698413, 12326.137170397986, 12365.814512782315, 12382.75234495305, 12383.071269654813, 12390.380480975915, 13666.316684165951, 13969.301534923214, 14630.26848657563, 14673.559793206221, 15735.741140708717, 5827.067669172912, 7051.1891132519395, 7176.820579485555, 7223.89164162538, 7236.819079523054, 875.5859287251171, 876.2814492116403, 882.4881568690145, 903.7830920579014, 919.2278486071732, 29481.0, 29625.0, 29928.70071299259, 30154.84922575417, 30302.0, 998.8823693769256, 1052.5894900988621, 1086.9673909782719, 1093.2074246171462, 1097.8298363753472, 14945.178015209269, 15446.227688615525, 15576.532704018897, 15593.610159746097, 15824.367025319088, 570893.0, 574860.0, 575852.0, 576214.0, 577246.0, 58928.41071589229, 59208.7039564808, 59312.11031834526, 59352.703236484405, 59435.70282148562, 1261.7350356425254, 1417.3834382043844, 1444.8844092472577, 1452.7239824433325, 1470.5514817980618, 24224.273271801874, 24739.463983261645, 29153.271168220115, 29777.702222977492, 30115.69884301129, 48395.0, 51167.744161278955, 51290.974180516925, 51293.0, 51361.0, 511016.0, 514565.0, 516333.0, 516571.0, 517099.0, 24047.797610119775, 24262.514749704555, 24530.264092077265, 24547.631785522874, 24660.630090549013, 34730.479042814884, 36549.81725091358, 43051.784741076095, 43599.34600981051, 44288.11423771442, 35192.64807351996, 35345.0, 35570.0, 36122.63877361298, 36997.81501092477, 35126.29747404986, 35529.28941421105, 35986.4602030975, 36154.8192259037, 37143.62856371402, 33837.0, 34091.97724068282, 34434.139146521535, 34602.82698586491, 35881.64118358887, 24563.87718061398, 30583.0, 32187.87342443097, 32229.033129006166, 32284.83857580697, 20883.582328353652, 23409.41476463102, 23825.642615361132, 23889.64165537553, 24398.146064887645], "value": 19117.058448330517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4121405750797, 384.6749496675308, 388.28749245135174, 396.8134976561015, 420.67187593676925, 14936.626584335398, 15357.846421535794, 17923.10384480774, 20693.896530517326, 21120.0, 21233.256836010743, 21259.893700531476, 21594.234635981746, 21708.56582868342, 21894.78105218947, 5563.916541251884, 5710.5717071219615, 6020.638761674313, 6028.216331876872, 6125.540584456161, 6021.72902219399, 6097.298810636767, 6098.908516372258, 6102.420270074336, 6121.357257487966, 3918.6473217410426, 4109.732867363627, 5664.291963504562, 5919.023361145406, 5984.9401505984815, 5930.406959304079, 5971.4327138921735, 5985.5810093293485, 5998.9700051499685, 6382.712777925005, 4877.853664390074, 5786.710664466802, 5839.649621022752, 5840.977828879929, 5857.6778277194735, 13405.262710550916, 22652.980615872326, 24859.502809943882, 25387.74612253891, 25887.22338329853, 2558.5650439425344, 2564.269183282774, 2579.1778808433633, 2580.264624581985, 2621.4101827088944, 9908.851367229498, 9979.15177209938, 10403.323783954018, 10487.213458990529, 11911.880881191164, 1836.173721825184, 1853.3420635674277, 1864.4593068010397, 1880.4922670878923, 1924.595834874678, 125812.37093814473, 130891.24467958183, 131800.34099829535, 132805.3359733195, 133404.33297833547, 11295.830562541569, 11686.824697629543, 11714.824277635842, 11720.648380548597, 11970.880291196976, 15344.002639828375, 15359.923200383926, 15368.308426120851, 15379.00036497624, 15401.691966160839, 8233.50598964064, 8489.872651910226, 8520.829583408296, 8612.0, 8624.913750862537, 6685.465162786965, 8042.638081286356, 8192.879763900708, 8239.588020599065, 8562.871556926651, 4600.102979918951, 4688.038952014829, 4695.131400690883, 4772.7136371817805, 4795.6163506919365, 1726.9034163306392, 1937.4575118966711, 1985.0919593850288, 1994.5811379610154, 2003.6293285742183, 974.2303580171726, 998.1964518562627, 1005.8491226315965, 1018.1193267823279, 1051.148569658579, 20755.066022029045, 21323.893380532998, 21329.573408532055, 21411.571768564852, 21425.571488570455, 972.6352617768337, 1020.2195320579763, 1028.1671845804922, 1044.2011860926398, 1055.466989170464, 10332.648215034078, 10999.835002474969, 11084.778304433867, 11144.832827507595, 11157.776844463227, 584619.0, 600564.0, 614022.0, 616456.0, 620424.5915081763, 120093.0, 141893.45266368423, 146154.0, 149719.0, 152412.0, 1014.0265345268477, 1024.702836177515, 1035.3632516002754, 1050.4275170032504, 1055.883852776194, 17699.0, 18233.0, 18340.633187336447, 18393.540161495534, 18441.72337414913, 58076.0, 58614.534636634424, 59290.0, 59546.40453595408, 59884.90978266896, 80478.59760701159, 80819.3836123286, 81707.32317045867, 84269.31461370862, 84546.73179902183, 5554.750036248298, 7155.749548765768, 7207.5675459472595, 7408.925910740823, 8172.959135204286, 10212.642557510451, 10312.226583006455, 12581.056420768662, 12859.549915752903, 12877.484900603871, 8647.870281945901, 10923.945380273048, 10965.342079475256, 11019.944900275448, 11115.888841111486, 10535.736606584896, 10765.515551800345, 10880.182168645617, 11050.889491104987, 11117.833232501358, 10936.015758581447, 11065.391403472886, 11251.831222531504, 11293.661190164308, 11354.274974006345, 7103.431725461847, 7378.926210737824, 7399.371053460516, 7479.364254038468, 7509.0, 10429.426381549089, 10617.203709721956, 10656.14750819917, 11008.339499630049, 11136.832947505956], "value": 9627.818127073822, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.8262608486982, 1467.6477645365117, 1475.741745194591, 1490.7987421698072, 1491.7911492391067, 6952.791416257508, 7925.4055945804075, 8277.172282771735, 8320.58397080146, 8353.20644538768, 7315.670794814233, 7592.696292148307, 7622.961885190566, 7677.769666909988, 7679.232076792318, 1662.7921509811274, 2256.199049337486, 2323.8838058097026, 2327.860328380294, 2339.1111377676543, 2336.147306233221, 2336.1823361823394, 2338.485533182697, 2340.6137987232173, 2344.3318654183563, 2271.897764600597, 2306.08909480755, 2309.3418375762913, 2309.9769002310013, 2312.7687231276905, 2090.8709296979614, 2156.2668692644575, 2158.0720290275176, 2158.417227348607, 2293.048384920256, 2169.240765731997, 2189.255653077961, 2291.301153148289, 2318.6406107053435, 2322.1640209524558, 8167.060788009336, 8234.588270586446, 8250.958745206235, 8251.422400431971, 8266.256036956642, 4955.826546070906, 5110.5400513953555, 5110.872228194325, 5117.078925793356, 5120.871978200537, 3235.3044095519576, 3336.4494858348344, 3373.3590617782543, 3407.165244515085, 3502.509648649191, 1177.1524502358288, 1219.9756004879853, 1244.0918129765323, 1259.8803113704184, 1271.6248706631566, 10677.305975111592, 10684.252102352915, 10714.928507149301, 10806.891931080667, 10819.350838949687, 3895.3962135868987, 4451.087527056946, 4556.521565235669, 4635.907281854344, 4656.185167595657, 9177.495237761854, 9388.014258502895, 9461.24310055194, 9487.478188699688, 9490.335676502578, 5198.870028249248, 5205.73971301441, 5208.427073021964, 5208.609354298443, 5215.113430716711, 4490.708103973231, 4671.229247174246, 4711.95288047122, 4768.332433459318, 4776.426828780569, 3476.904774995868, 3609.729270304738, 3622.5109610202812, 3623.836927338276, 3632.54593175853, 1047.738065483629, 1172.5778719660916, 1220.3471142938486, 1245.1284101129245, 1247.5508816825936, 865.2558799432483, 884.893812742475, 909.7952960583816, 911.2254583603884, 950.7337945375306, 5143.974280128576, 5318.0, 5412.188171774265, 5453.718376181594, 5462.371827239839, 821.3593397150232, 975.9411039022598, 978.4862946952765, 1008.5965613754557, 1016.3190662256159, 3771.6039815819495, 3777.1690228149764, 3817.530250853386, 3884.0484081400236, 3890.9416358754643, 9652.27607929408, 9988.800223995624, 10014.24893133018, 10021.549030293654, 10023.448710320856, 9780.706578802647, 9885.456299903575, 9893.802123957481, 9905.653302134391, 9966.551505182138, 7529.4729368944745, 7599.696012159452, 7715.57564333967, 7813.492123011986, 7814.53112813233, 5356.919646205232, 5501.284832971688, 5528.226048353154, 5531.529819965187, 5625.662460252398, 9174.67888623895, 9279.164875161268, 9301.348905576544, 9321.953390233006, 9390.342676012613, 8857.867131993155, 9127.589258483516, 9259.074092590956, 9292.513197888306, 9476.715698529055, 7066.328698773608, 7103.289671032855, 7190.424766018601, 7192.31672991065, 7216.206217316196, 7664.271894170045, 7736.574488403192, 7832.725854595062, 7837.255460731221, 7850.018747656543, 5831.475167234969, 6926.272741362286, 7041.881292291453, 7070.257622949722, 7176.067111275501, 6541.476681865534, 6752.763653272112, 6873.587584744731, 6921.307869213239, 7107.0, 6018.428249316308, 6333.20834895638, 6428.742850286123, 6436.742530298736, 6437.195350581177, 4948.901021979468, 4960.355153829979, 5019.698818070928, 5033.874153146201, 5135.306733590917, 4971.900561988812, 5018.573421259088, 5170.250313704417, 5191.61062920275, 5274.89450210986], "value": 4367.621164554064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.53777475956974, 353.3921654753824, 357.3692432856008, 369.3388833987163, 370.6053053498023, 4083.060546240534, 4931.1617025105725, 5237.162054071349, 5259.526642602165, 5285.339332583422, 4590.196715574778, 5000.97499512502, 5061.822836200734, 5077.314562534057, 5154.5103215194595, 4084.775337356444, 4087.894734211883, 4117.485314335708, 4126.938095928564, 4140.861263152627, 3706.4625629283737, 3884.4367566702813, 3898.688104951597, 4076.5311989121333, 4135.338345864662, 4069.511658600972, 4085.22380747657, 4092.403962454645, 4093.5497095319492, 4115.333290017533, 4029.49631296088, 4037.939430908524, 4064.947201663141, 4071.755694658315, 4086.836526538965, 3328.48408496681, 3611.837467313977, 3612.819359032038, 3629.7277704172293, 3633.400488919325, 4453.151941944089, 4907.411110666707, 5058.494150584949, 5098.821541246039, 5136.409312929024, 3943.3296339622334, 4155.355919832401, 4703.670743047988, 4711.128441238382, 4735.337052812609, 4624.537546245382, 5490.396056433789, 5504.4495550445035, 5522.696251706155, 5533.0, 3218.9678103218903, 3855.4795102661064, 3861.8262178201767, 3980.8009599520196, 4047.4535937648334, 4819.59033482151, 4822.903541929142, 4841.588464980481, 5054.570361519312, 5059.772310246048, 3824.6749026333073, 3957.2283404736377, 4100.580657412142, 4120.979395103065, 4134.359174327984, 3659.7309668006005, 3981.8009099544906, 4159.043420013414, 4170.72890262132, 4183.581641835853, 4645.628349732014, 4666.510016448292, 4708.529147085264, 4718.504557021463, 4763.309320148559, 5493.066178749622, 5505.862353441196, 5522.5581953443625, 5536.197251398606, 5540.501354878081, 1103.586155191803, 1249.6875781054737, 1267.854196767365, 1292.6556381363278, 1334.486222804208, 880.6257340630207, 907.8470342664779, 936.784539555906, 946.6497395963538, 948.8576713492894, 4342.782860857008, 4643.30519360431, 4772.809087636456, 4837.298591704253, 4849.515048495122, 4498.288856896579, 4705.858824235278, 4862.902741945141, 5233.4243233244315, 5366.597505187048, 4587.472440669299, 4603.654725895572, 4606.723596584216, 4646.23654839581, 4840.733759643183, 2528.633348164506, 2800.2719292983566, 2808.9859550702527, 2818.0832838012557, 2832.8441935693736, 4773.64197685175, 5379.596530260246, 5492.203630473638, 5522.502974732213, 5601.80393686219, 4621.353010578522, 5410.48600382963, 5667.744951477193, 5799.710014499258, 5836.562257830679, 4690.108879312919, 5359.249705041298, 5829.0, 5848.0, 5947.553933455095, 4380.496242932104, 4388.868333949987, 5588.580856435702, 5606.6544029431825, 5672.979413219413, 5153.072446959583, 5593.608447408642, 5619.8198378341, 5626.396477004034, 5643.294588176478, 4883.877903052452, 5268.920966185587, 5412.917416516633, 5730.389854391707, 5872.882542349214, 3417.6582341765625, 3426.4860270959557, 3776.546814382292, 3804.3532599457603, 3831.7892515910776, 4962.404511458648, 5210.505002024802, 5413.264847255381, 5652.85867853307, 5663.5469162467725, 4871.90256194867, 5110.693358398508, 5526.269767906567, 5530.0, 5595.384507704068, 5179.975094380527, 5458.399576046552, 5487.75305111263, 5508.6779172998995, 5533.501984821385, 4928.581070608895, 5147.845564633067, 5258.553022993088, 5302.496262855023, 5374.785008599612, 5332.706701131475, 5457.762317449827, 5466.480684334982, 5475.890482190413, 5493.23094766741, 4781.641376896677, 4889.804407823647, 5367.275417818544, 5398.46015398457, 5404.459554044564], "value": 4018.8804257814077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.4908026338139, 697.7313734212329, 726.220024771067, 778.8870613761005, 816.7549735079476, 14857.40570377185, 15869.0, 15918.04491730497, 15919.124448155362, 15919.283632236547, 14508.419663213484, 14675.97268191227, 14680.045797023186, 14700.705985880302, 14716.0, 675.3786516404895, 693.7918624412681, 697.166885571742, 849.337516736943, 869.0136694851326, 848.0671261612208, 868.6916144768611, 870.4081224767187, 885.8051228729669, 886.7871710789428, 775.2828633514005, 932.9923682423001, 933.4119504712022, 935.2704890185666, 936.180841763457, 708.0335342257832, 927.5408672706985, 927.6984979881531, 929.549168653206, 933.2254228989922, 542.6120323968381, 548.5967813656958, 548.6516062300428, 552.988031901619, 662.8011596521072, 14947.850521494755, 15357.846421535753, 15423.305951232222, 15428.305726242346, 15480.071195728293, 9638.75903102421, 13756.862431375659, 13905.374258158306, 13908.93045534776, 13994.0, 12452.813207801799, 12814.55149069778, 12935.87064129356, 13013.024023198299, 13167.275799831006, 4347.586979236968, 4482.148391805546, 4487.439070116236, 4527.592516673515, 4612.492625811158, 112467.43766281198, 117824.41087794592, 118866.4056679711, 119023.0, 119026.0, 10997.0, 11264.211505194722, 11280.041196498225, 11398.430078496041, 11604.187706860439, 22094.447638809157, 22275.554488910457, 22309.776902231093, 22653.320400388016, 22675.773242267696, 7584.0, 7596.3922886168975, 7645.350145237606, 7875.369970402354, 7988.201179882081, 4253.128108737701, 4326.37571157494, 4334.436523251957, 4448.5773851484055, 4509.503954564995, 3598.3522965865873, 3664.908377290589, 3665.651763082556, 3706.425504046877, 3709.703223742148, 659.5251418978328, 663.8141320430287, 680.8876535371708, 687.2783577243874, 691.4675699711195, 661.9834504137435, 689.1282527602586, 698.1482591238681, 698.8637215742983, 717.5622870049266, 10315.329503582243, 10350.637727679496, 10383.584656613652, 10385.409224418416, 10437.791244175225, 610.9480694141048, 640.2317219336815, 643.797203880776, 649.0815496073099, 649.3084864619166, 4867.464578896319, 5062.696238225718, 5074.974625126924, 5076.670016448919, 5081.2378143278065, 102932.0, 103900.0, 105005.0, 105267.0, 110888.4455577717, 93670.0, 95194.0, 96134.9999999986, 98348.01651983532, 98825.50587247018, 65056.349436505974, 67324.6535069296, 68502.65748671225, 70887.6455617729, 75990.24009760053, 9544.618215271588, 10186.0, 10404.427756473468, 11027.72430689207, 11058.22592418523, 49055.75472122616, 49611.503884960686, 50559.49440505695, 50567.65633670403, 50614.0, 63384.36615633785, 65092.0, 66058.33941660522, 66541.66729166324, 66741.0, 12921.676958076123, 13056.608301750963, 13082.803757943448, 13273.800892986419, 13320.800187996994, 14673.119612823264, 14699.191544465157, 14846.777298340317, 14896.478623248568, 15232.847671523143, 13535.932320338336, 13798.379072941541, 13906.443742250602, 13939.0, 14354.641133971316, 13500.93249533746, 13813.86186138166, 14112.50606228777, 14131.15213087218, 14374.137551746928, 13114.540991065267, 13277.535286264934, 13295.335233238106, 13933.442662293395, 14293.070950388192, 10745.24783265164, 11052.778944420907, 11293.774124517628, 11632.069434445393, 11656.125790565911, 10678.199135065057, 10799.460026998775, 10859.945700271448, 10889.0, 10923.836142458029], "value": 7603.157953445383, "unit": "score"}], "name": "dromaeo_css", "value": 7218.1164874254, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 117.0, 141.0, 148.0, 119.0, 141.0, 143.0, 114.0, 131.0, 115.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 186.0, 185.0, 187.0, 181.0, 183.0, 180.0, 185.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 87.0, 61.0, 59.0, 61.0, 59.0, 75.0, 59.0], "value": 65.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 88.0, 70.0, 68.0, 69.0, 83.0, 69.0, 70.0, 83.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 132.0, 89.0, 84.0, 91.0, 123.0, 88.0, 84.0, 89.0, 84.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 98.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 95.0, 86.0, 85.0, 88.0, 85.0, 85.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 55.0, 55.0, 54.0, 53.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 83.0, 78.0, 102.0, 106.0, 108.0, 77.0, 74.0, 74.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 87.0, 90.0, 85.0, 85.0, 84.0, 90.0, 81.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 157.0, 135.0, 151.0, 149.0, 156.0, 153.0, 150.0, 209.0, 155.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 173.0, 175.0, 176.0, 177.0, 173.0, 175.0, 172.0, 175.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1470.4, "alertThreshold": 2.0}]} 20:52:49 INFO - Return code: 0 20:52:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:52:49 ERROR - # TBPL SUCCESS # 20:52:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:52:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:52:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:52:49 INFO - 2017-01-23 20:52:49.749 screenresolution[1982:11958] starting screenresolution argv=screenresolution get 20:52:49 INFO - 2017-01-23 20:52:49.751 screenresolution[1982:11958] Display 0: 1600x1200x32@60 20:52:49 INFO - 2017-01-23 20:52:49.758 screenresolution[1983:11961] starting screenresolution argv=screenresolution list 20:52:49 INFO - Available Modes on Display 0 20:52:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:52:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:52:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:52:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:52:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:52:49 INFO - Intel Iris: 20:52:49 INFO - Chipset Model: Intel Iris 20:52:49 INFO - Type: GPU 20:52:49 INFO - Bus: Built-In 20:52:49 INFO - VRAM (Dynamic, Max): 1536 MB 20:52:49 INFO - Vendor: Intel (0x8086) 20:52:49 INFO - Device ID: 0x0a2e 20:52:49 INFO - Revision ID: 0x0009 20:52:49 INFO - Displays: 20:52:49 INFO - Display: 20:52:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:52:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:52:49 INFO - Display Serial Number: 1600x1200 60 20:52:49 INFO - Main Display: Yes 20:52:49 INFO - Mirror: Off 20:52:49 INFO - Online: Yes 20:52:49 INFO - Rotation: Supported 20:52:49 INFO - Return code: 0 20:52:49 INFO - Running post-action listener: _resource_record_post_action 20:52:49 INFO - [mozharness: 2017-01-24 04:52:49.999898Z] Finished run-tests step (success) 20:52:50 INFO - Running post-run listener: _resource_record_post_run 20:52:50 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 139264; Write bytes: 549606400; Read time: 2; Write time: 1725 20:52:50 INFO - TinderboxPrint: CPU usage
53.5% 20:52:50 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 2 20:52:50 INFO - TinderboxPrint: I/O write bytes / time
549,606,400 / 1,725 20:52:50 INFO - TinderboxPrint: CPU idle
2,234.7 (46.5%) 20:52:50 INFO - TinderboxPrint: CPU system
957.8 (19.9%) 20:52:50 INFO - TinderboxPrint: CPU user
1,617.2 (33.6%) 20:52:50 INFO - TinderboxPrint: Swap in / out
250,650,624 / 0 20:52:50 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 240818688; Write bytes: 235349504; Read time: 17431; Write time: 526 20:52:50 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 139264; Write bytes: 294698496; Read time: 2; Write time: 1147 20:52:50 INFO - Running post-run listener: _upload_blobber_files 20:52:50 INFO - Blob upload gear active. 20:52:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:52:50 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 20:52:50 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'] 20:52:50 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 20:52:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:52:51 INFO - (blobuploader) - INFO - Done attempting. 20:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:52:52 INFO - (blobuploader) - INFO - Done attempting. 20:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:52:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:52:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:52:53 INFO - (blobuploader) - INFO - Done attempting. 20:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:52:55 INFO - (blobuploader) - INFO - Done attempting. 20:52:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:52:55 INFO - Return code: 0 20:52:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:52:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:52:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a161f7ae5747c9e9aaffa898f911ad065615487a82389f890063c6b9f2fc3538cf49543a7c3cb5d55a9710d83ffb85e391bca92a62b7813bbbcf7a1f3f4f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832b0ce380457d81e909324ef1d02da8538393aa9f91f72985ee575caeb5b3b1cbb128947a62ed21cb52bc6a9a8903260ec1e332fbe243dfcfa2b44d0c6abb10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d14a00ae2c4a347d1dc5c7b60d014ed9a76db733a5b83660e08b5be23e86c9237f107d17e4cda450e27b3f80edd4d64d9cbaa9bc5cfe7ba27501bb3c526f5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6903ad8264c05e05981cc5b19f4030d78fdd1a932b2b7ff9416431309b07ad86c3a48c242cf7b441c91b54da3ae6edfb9206f583502a8f62203e7226d5e27dc3"} 20:52:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:52:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:52:55 INFO - Contents: 20:52:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a161f7ae5747c9e9aaffa898f911ad065615487a82389f890063c6b9f2fc3538cf49543a7c3cb5d55a9710d83ffb85e391bca92a62b7813bbbcf7a1f3f4f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832b0ce380457d81e909324ef1d02da8538393aa9f91f72985ee575caeb5b3b1cbb128947a62ed21cb52bc6a9a8903260ec1e332fbe243dfcfa2b44d0c6abb10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d14a00ae2c4a347d1dc5c7b60d014ed9a76db733a5b83660e08b5be23e86c9237f107d17e4cda450e27b3f80edd4d64d9cbaa9bc5cfe7ba27501bb3c526f5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6903ad8264c05e05981cc5b19f4030d78fdd1a932b2b7ff9416431309b07ad86c3a48c242cf7b441c91b54da3ae6edfb9206f583502a8f62203e7226d5e27dc3"} 20:52:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:52:55 INFO - Copying logs to upload dir... 20:52:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:52:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.900155 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-23 20:52:55.945481) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 20:52:55.948777) ========= 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.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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/a9a161f7ae5747c9e9aaffa898f911ad065615487a82389f890063c6b9f2fc3538cf49543a7c3cb5d55a9710d83ffb85e391bca92a62b7813bbbcf7a1f3f4f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832b0ce380457d81e909324ef1d02da8538393aa9f91f72985ee575caeb5b3b1cbb128947a62ed21cb52bc6a9a8903260ec1e332fbe243dfcfa2b44d0c6abb10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d14a00ae2c4a347d1dc5c7b60d014ed9a76db733a5b83660e08b5be23e86c9237f107d17e4cda450e27b3f80edd4d64d9cbaa9bc5cfe7ba27501bb3c526f5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6903ad8264c05e05981cc5b19f4030d78fdd1a932b2b7ff9416431309b07ad86c3a48c242cf7b441c91b54da3ae6edfb9206f583502a8f62203e7226d5e27dc3"} build_url:https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/RGUtacITR4mkzh_14Lo5zQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9a161f7ae5747c9e9aaffa898f911ad065615487a82389f890063c6b9f2fc3538cf49543a7c3cb5d55a9710d83ffb85e391bca92a62b7813bbbcf7a1f3f4f48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/832b0ce380457d81e909324ef1d02da8538393aa9f91f72985ee575caeb5b3b1cbb128947a62ed21cb52bc6a9a8903260ec1e332fbe243dfcfa2b44d0c6abb10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d14a00ae2c4a347d1dc5c7b60d014ed9a76db733a5b83660e08b5be23e86c9237f107d17e4cda450e27b3f80edd4d64d9cbaa9bc5cfe7ba27501bb3c526f5c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6903ad8264c05e05981cc5b19f4030d78fdd1a932b2b7ff9416431309b07ad86c3a48c242cf7b441c91b54da3ae6edfb9206f583502a8f62203e7226d5e27dc3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 20:52:55.982283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:52:55.982623) ========= 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.dkaJpaCobd/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.iiNxv8iTug/Listeners TMPDIR=/var/folders/pk/mm46htfn0fj4m947xrvc5yh400000w/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.005335 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 20:52:56.030882) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 20:52:56.031153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 20:52:56.031466) ========= ========= Total master_lag: 0.18 =========