builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0233 starttime: 1487156400.7 results: success (0) buildid: 20170209170211 builduid: eadb590b78a6436a8ffabcb183f51b85 revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.697882) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.698358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.698632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.723602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.723979) ========= 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.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-02-15 03:00:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.8M=0.001s 2017-02-15 03:00:00 (19.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.845504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.845828) ========= 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.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.021286 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:00.894496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 03:00:00.894851) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --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 25a94c1047e793ef096d8556fa3c26dd72bd37d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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-02-15 03:00:00,974 truncating revision to first 12 chars 2017-02-15 03:00:00,974 Setting DEBUG logging. 2017-02-15 03:00:00,974 attempt 1/10 2017-02-15 03:00:00,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/25a94c1047e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 03:00:01,957 unpacking tar archive at: mozilla-central-25a94c1047e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-15 03:00:02.174155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.174488) ========= script_repo_revision: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.174887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.175161) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 03:00:02.199165) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 03:00:02.199540) ========= /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.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:02 INFO - MultiFileLogger online at 20170215 03:00:02 in /builds/slave/test 03:00:02 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 03:00:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:02 INFO - {'append_to_log': False, 03:00:02 INFO - 'base_work_dir': '/builds/slave/test', 03:00:02 INFO - 'blob_upload_branch': 'Firefox', 03:00:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:02 INFO - 'branch': 'Firefox', 03:00:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:02 INFO - 'config_files': ('talos/mac_config.py',), 03:00:02 INFO - 'default_actions': ('clobber', 03:00:02 INFO - 'read-buildbot-config', 03:00:02 INFO - 'download-and-extract', 03:00:02 INFO - 'populate-webroot', 03:00:02 INFO - 'create-virtualenv', 03:00:02 INFO - 'install', 03:00:02 INFO - 'run-tests'), 03:00:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:02 INFO - 'download_minidump_stackwalk': True, 03:00:02 INFO - 'download_symbols': 'ondemand', 03:00:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:02 INFO - 'installer_path': 'installer.exe', 03:00:02 INFO - 'log_level': 'info', 03:00:02 INFO - 'log_name': 'talos', 03:00:02 INFO - 'log_to_console': True, 03:00:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:02 INFO - 'opt_config_files': (), 03:00:02 INFO - 'pip_index': False, 03:00:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:02 INFO - 'cmd': ('bash', 03:00:02 INFO - '-c', 03:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:02 INFO - 'enabled': True, 03:00:02 INFO - 'halt_on_failure': False, 03:00:02 INFO - 'name': 'check_screen_resolution'},), 03:00:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:02 INFO - 'cmd': ('bash', 03:00:02 INFO - '-c', 03:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:02 INFO - 'enabled': True, 03:00:02 INFO - 'halt_on_failure': False, 03:00:02 INFO - 'name': 'check_screen_resolution'},), 03:00:02 INFO - 'run_cmd_checks_enabled': True, 03:00:02 INFO - 'sps_profile': False, 03:00:02 INFO - 'sps_profile_interval': 0, 03:00:02 INFO - 'suite': 'dromaeojs', 03:00:02 INFO - 'system_bits': '32', 03:00:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:02 INFO - 'title': 't-yosemite-r7-0233', 03:00:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:02 INFO - 'use_talos_json': True, 03:00:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:02 INFO - 'work_dir': 'build'} 03:00:02 INFO - [mozharness: 2017-02-15 11:00:02.386808Z] Running clobber step. 03:00:02 INFO - Running pre-action listener: _resource_record_pre_action 03:00:02 INFO - Running main action method: clobber 03:00:02 INFO - rmtree: /builds/slave/test/build 03:00:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:04 INFO - Running post-action listener: _resource_record_post_action 03:00:04 INFO - [mozharness: 2017-02-15 11:00:04.559082Z] Finished clobber step (success) 03:00:04 INFO - [mozharness: 2017-02-15 11:00:04.559313Z] Running read-buildbot-config step. 03:00:04 INFO - Running pre-action listener: _resource_record_pre_action 03:00:04 INFO - Running main action method: read_buildbot_config 03:00:04 INFO - Using buildbot properties: 03:00:04 INFO - { 03:00:04 INFO - "project": "", 03:00:04 INFO - "product": "firefox", 03:00:04 INFO - "script_repo_revision": "production", 03:00:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:00:04 INFO - "repository": "", 03:00:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:00:04 INFO - "buildid": "20170209170211", 03:00:04 INFO - "pgo_build": "False", 03:00:04 INFO - "basedir": "/builds/slave/test", 03:00:04 INFO - "buildnumber": 69, 03:00:04 INFO - "slavename": "t-yosemite-r7-0233", 03:00:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:00:04 INFO - "platform": "yosemite_r7", 03:00:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:00:04 INFO - "branch": "mozilla-central", 03:00:04 INFO - "repo_path": "mozilla-central", 03:00:04 INFO - "revision": "25a94c1047e793ef096d8556fa3c26dd72bd37d7", 03:00:04 INFO - "stage_platform": "macosx64", 03:00:04 INFO - "builduid": "eadb590b78a6436a8ffabcb183f51b85", 03:00:04 INFO - "slavebuilddir": "test" 03:00:04 INFO - } 03:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:00:04 INFO - Running post-action listener: _resource_record_post_action 03:00:04 INFO - [mozharness: 2017-02-15 11:00:04.565071Z] Finished read-buildbot-config step (success) 03:00:04 INFO - [mozharness: 2017-02-15 11:00:04.565225Z] Running download-and-extract step. 03:00:04 INFO - Running pre-action listener: _resource_record_pre_action 03:00:04 INFO - Running main action method: download_and_extract 03:00:04 INFO - mkdir: /builds/slave/test/build/tests 03:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:04 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 03:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 03:00:05 INFO - Downloaded 1199 bytes. 03:00:05 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:00:05 INFO - Using the following test package requirements: 03:00:05 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:00:05 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:00:05 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:00:05 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'jsshell-mac.zip'], 03:00:05 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:00:05 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:00:05 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:00:05 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:00:05 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:00:05 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:00:05 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:00:07 INFO - Expected file size: 34949027 03:00:07 INFO - Obtained file size: 34949027 03:00:14 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 03:00:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:00:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:00:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:00:15 INFO - Expected file size: 34949027 03:00:15 INFO - Obtained file size: 34949027 03:00:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:00:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:00:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:00:22 INFO - Expected file size: 14403454 03:00:22 INFO - Obtained file size: 14403454 03:00: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')]} 03:00:23 INFO - trying https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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 03:00:25 INFO - Downloaded 70348678 bytes. 03:00:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:25 INFO - mkdir: /builds/slave/test/properties 03:00:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:25 INFO - Contents: 03:00:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:00:25 INFO - Running post-action listener: _resource_record_post_action 03:00:25 INFO - Running post-action listener: set_extra_try_arguments 03:00:25 INFO - [mozharness: 2017-02-15 11:00:25.898624Z] Finished download-and-extract step (success) 03:00:25 INFO - [mozharness: 2017-02-15 11:00:25.898772Z] Running populate-webroot step. 03:00:25 INFO - Running pre-action listener: _resource_record_pre_action 03:00:25 INFO - Running main action method: populate_webroot 03:00:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:25 INFO - '--tppagecycles', 03:00:25 INFO - '7'], 03:00:25 INFO - 'tests': ['tsvgm']}}, 03:00:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['damp', 'tps']}, 03:00:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'tests': ['damp', 'tps']}, 03:00:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['dromaeo_dom']}, 03:00:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['basic_compositor_video']}, 03:00:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:00:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['a11yr', 03:00:25 INFO - 'ts_paint', 03:00:25 INFO - 'tpaint', 03:00:25 INFO - 'sessionrestore', 03:00:25 INFO - 'sessionrestore_no_auto_restore', 03:00:25 INFO - 'tabpaint']}, 03:00:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['tsvgx', 03:00:25 INFO - 'tsvgr_opacity', 03:00:25 INFO - 'tart', 03:00:25 INFO - 'tscrollx', 03:00:25 INFO - 'cart', 03:00:25 INFO - 'tsvg_static']}, 03:00:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:25 INFO - 'tsvgr_opacity', 03:00:25 INFO - 'tart', 03:00:25 INFO - 'tscrollx', 03:00:25 INFO - 'cart', 03:00:25 INFO - 'tsvg_static']}, 03:00:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'talos_options': ['--disable-e10s'], 03:00:25 INFO - 'tests': ['tp5o']}, 03:00:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'talos_options': ['--disable-e10s', 03:00:25 INFO - '--xperf_path', 03:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:25 INFO - 'tests': ['tp5n']}, 03:00:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:25 INFO - 'talos_options': ['--xperf_path', 03:00:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:25 INFO - 'tests': ['tp5n']}}, 03:00:25 INFO - 'talos.zip': {'path': '', 03:00:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:25 INFO - Running post-action listener: _resource_record_post_action 03:00:25 INFO - [mozharness: 2017-02-15 11:00:25.917637Z] Finished populate-webroot step (success) 03:00:25 INFO - [mozharness: 2017-02-15 11:00:25.917750Z] Running create-virtualenv step. 03:00:25 INFO - Running pre-action listener: _resource_record_pre_action 03:00:25 INFO - Running main action method: create_virtualenv 03:00:25 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:25 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 03:00:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:26 INFO - Using real prefix '/tools/python27' 03:00:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:26 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:29 INFO - Installing pip.................done. 03:00:29 INFO - Return code: 0 03:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:29 INFO - Reading from file tmpfile_stdout 03:00:29 INFO - Output received: 03:00:29 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) 03:00:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00: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', 'pip>=1.5'] in /builds/slave/test/build 03:00: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 pip>=1.5 03:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:29 INFO - 'HOME': '/Users/cltbld', 03:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:29 INFO - 'LOGNAME': 'cltbld', 03:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:29 INFO - 'MOZ_NO_REMOTE': '1', 03:00:29 INFO - 'NO_EM_RESTART': '1', 03:00:29 INFO - 'PAGER': '/bin/cat', 03:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:29 INFO - 'PWD': '/builds/slave/test', 03:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:29 INFO - 'SHELL': '/bin/bash', 03:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:29 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:29 INFO - 'USER': 'cltbld', 03:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:29 INFO - 'XPC_FLAGS': '0x0', 03:00:29 INFO - 'XPC_SERVICE_NAME': '0', 03:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:30 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 03:00:30 INFO - Cleaning up... 03:00:30 INFO - Return code: 0 03:00:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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', '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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:00: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 psutil>=3.1.1 03:00:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:30 INFO - 'HOME': '/Users/cltbld', 03:00:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:30 INFO - 'LOGNAME': 'cltbld', 03:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:30 INFO - 'MOZ_NO_REMOTE': '1', 03:00:30 INFO - 'NO_EM_RESTART': '1', 03:00:30 INFO - 'PAGER': '/bin/cat', 03:00:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:30 INFO - 'PWD': '/builds/slave/test', 03:00:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:30 INFO - 'SHELL': '/bin/bash', 03:00:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:30 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:30 INFO - 'USER': 'cltbld', 03:00:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:30 INFO - 'XPC_FLAGS': '0x0', 03:00:30 INFO - 'XPC_SERVICE_NAME': '0', 03:00:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:30 INFO - Downloading/unpacking psutil>=3.1.1 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:33 INFO - Installing collected packages: psutil 03:00:33 INFO - Running setup.py install for psutil 03:00:34 INFO - building 'psutil._psutil_osx' extension 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 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 03:00:34 INFO - building 'psutil._psutil_posix' extension 03:00:34 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 03:00:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:00:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:00:34 INFO - ^ 03:00:34 INFO - 1 warning generated. 03:00:34 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 03:00:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:34 INFO - Successfully installed psutil 03:00:34 INFO - Cleaning up... 03:00:34 INFO - Return code: 0 03:00:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:34 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')]} 03:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:34 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')]} 03:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:34 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:34 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 03:00:34 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 03:00:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:34 INFO - 'HOME': '/Users/cltbld', 03:00:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:34 INFO - 'LOGNAME': 'cltbld', 03:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:34 INFO - 'MOZ_NO_REMOTE': '1', 03:00:34 INFO - 'NO_EM_RESTART': '1', 03:00:34 INFO - 'PAGER': '/bin/cat', 03:00:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:34 INFO - 'PWD': '/builds/slave/test', 03:00:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:34 INFO - 'SHELL': '/bin/bash', 03:00:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:34 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:34 INFO - 'USER': 'cltbld', 03:00:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:34 INFO - 'XPC_FLAGS': '0x0', 03:00:34 INFO - 'XPC_SERVICE_NAME': '0', 03:00:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:37 INFO - Installing collected packages: mozsystemmonitor 03:00:37 INFO - Running setup.py install for mozsystemmonitor 03:00:37 INFO - Successfully installed mozsystemmonitor 03:00:37 INFO - Cleaning up... 03:00:38 INFO - Return code: 0 03:00:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:38 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')]} 03:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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')]} 03:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:38 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:38 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 03:00:38 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 03:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:38 INFO - 'HOME': '/Users/cltbld', 03:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:38 INFO - 'LOGNAME': 'cltbld', 03:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:38 INFO - 'MOZ_NO_REMOTE': '1', 03:00:38 INFO - 'NO_EM_RESTART': '1', 03:00:38 INFO - 'PAGER': '/bin/cat', 03:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:38 INFO - 'PWD': '/builds/slave/test', 03:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:38 INFO - 'SHELL': '/bin/bash', 03:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:38 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:38 INFO - 'USER': 'cltbld', 03:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:38 INFO - 'XPC_FLAGS': '0x0', 03:00:38 INFO - 'XPC_SERVICE_NAME': '0', 03:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:38 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 03:00:38 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 03:00:38 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 03:00:38 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 03:00:38 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 03:00:38 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 03:00:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:41 INFO - warning: no files found matching '*.txt' 03:00:41 INFO - no previously-included directories found matching 'build' 03:00:41 INFO - no previously-included directories found matching 'dist' 03:00:41 INFO - no previously-included directories found matching '.git*' 03:00:41 INFO - Installing collected packages: jsonschema, functools32 03:00:41 INFO - Running setup.py install for functools32 03:00:41 INFO - warning: no files found matching '*.txt' 03:00:41 INFO - no previously-included directories found matching 'build' 03:00:41 INFO - no previously-included directories found matching 'dist' 03:00:41 INFO - no previously-included directories found matching '.git*' 03:00:41 INFO - Successfully installed jsonschema functools32 03:00:41 INFO - Cleaning up... 03:00:41 INFO - Return code: 0 03:00:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:41 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')]} 03:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 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')]} 03:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:41 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 03:00:41 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 03:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:41 INFO - 'HOME': '/Users/cltbld', 03:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:41 INFO - 'LOGNAME': 'cltbld', 03:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:41 INFO - 'MOZ_NO_REMOTE': '1', 03:00:41 INFO - 'NO_EM_RESTART': '1', 03:00:41 INFO - 'PAGER': '/bin/cat', 03:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:41 INFO - 'PWD': '/builds/slave/test', 03:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:41 INFO - 'SHELL': '/bin/bash', 03:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:41 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:41 INFO - 'USER': 'cltbld', 03:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:41 INFO - 'XPC_FLAGS': '0x0', 03:00:41 INFO - 'XPC_SERVICE_NAME': '0', 03:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:41 INFO - Cleaning up... 03:00:41 INFO - Return code: 0 03:00:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:41 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')]} 03:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 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')]} 03:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:41 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 03:00:41 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 03:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:41 INFO - 'HOME': '/Users/cltbld', 03:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:41 INFO - 'LOGNAME': 'cltbld', 03:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:41 INFO - 'MOZ_NO_REMOTE': '1', 03:00:41 INFO - 'NO_EM_RESTART': '1', 03:00:41 INFO - 'PAGER': '/bin/cat', 03:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:41 INFO - 'PWD': '/builds/slave/test', 03:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:41 INFO - 'SHELL': '/bin/bash', 03:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:41 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:41 INFO - 'USER': 'cltbld', 03:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:41 INFO - 'XPC_FLAGS': '0x0', 03:00:41 INFO - 'XPC_SERVICE_NAME': '0', 03:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:45 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 03:00:45 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 03:00:45 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 03:00:45 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 03:00:45 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 03:00:45 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 03:00:46 INFO - Downloading docopt-0.6.1.tar.gz 03:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:46 INFO - Running setup.py install for blobuploader 03:00:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:46 INFO - Running setup.py install for requests 03:00:46 INFO - Running setup.py install for docopt 03:00:46 INFO - Successfully installed blobuploader requests docopt 03:00:46 INFO - Cleaning up... 03:00:46 INFO - Return code: 0 03:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00: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')]} 03:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00: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')]} 03:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:46 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 03:00:46 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 03:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:46 INFO - 'HOME': '/Users/cltbld', 03:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:46 INFO - 'LOGNAME': 'cltbld', 03:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:46 INFO - 'MOZ_NO_REMOTE': '1', 03:00:46 INFO - 'NO_EM_RESTART': '1', 03:00:46 INFO - 'PAGER': '/bin/cat', 03:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:46 INFO - 'PWD': '/builds/slave/test', 03:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:46 INFO - 'SHELL': '/bin/bash', 03:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:46 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:46 INFO - 'USER': 'cltbld', 03:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:46 INFO - 'XPC_FLAGS': '0x0', 03:00:46 INFO - 'XPC_SERVICE_NAME': '0', 03:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-3mTMZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-fhgxFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-zDUhVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-mbEfQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-IQMgPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-nEgsFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-u0wE1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:47 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-m5nkCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-Fr_l2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-aQ8i2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-m25kv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-trcb5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-kQEuJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-PM0dz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-aXtD2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-HNg_uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:48 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-BXt1S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:49 INFO - Running setup.py install for manifestparser 03:00:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:49 INFO - Running setup.py install for mozcrash 03:00:49 INFO - Running setup.py install for mozdebug 03:00:49 INFO - Running setup.py install for mozdevice 03:00:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:49 INFO - Running setup.py install for mozfile 03:00:49 INFO - Running setup.py install for mozhttpd 03:00:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:49 INFO - Running setup.py install for mozinfo 03:00:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Running setup.py install for mozInstall 03:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Running setup.py install for mozleak 03:00:50 INFO - Running setup.py install for mozlog 03:00:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Running setup.py install for moznetwork 03:00:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Running setup.py install for mozprocess 03:00:50 INFO - Running setup.py install for mozprofile 03:00:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:50 INFO - Running setup.py install for mozrunner 03:00:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:51 INFO - Running setup.py install for mozscreenshot 03:00:51 INFO - Running setup.py install for moztest 03:00:51 INFO - Running setup.py install for mozversion 03:00:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:51 INFO - Cleaning up... 03:00:51 INFO - Return code: 0 03:00:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:51 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:51 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 03:00:51 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 03:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:51 INFO - 'HOME': '/Users/cltbld', 03:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:51 INFO - 'LOGNAME': 'cltbld', 03:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:51 INFO - 'MOZ_NO_REMOTE': '1', 03:00:51 INFO - 'NO_EM_RESTART': '1', 03:00:51 INFO - 'PAGER': '/bin/cat', 03:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:51 INFO - 'PWD': '/builds/slave/test', 03:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:51 INFO - 'SHELL': '/bin/bash', 03:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:51 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:51 INFO - 'USER': 'cltbld', 03:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:51 INFO - 'XPC_FLAGS': '0x0', 03:00:51 INFO - 'XPC_SERVICE_NAME': '0', 03:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:51 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-V9XLj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:51 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)) 03:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:51 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-qls2Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-xlxOdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-pIz70W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-02ubXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-2h327h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-ZePpSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-4AwzJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-CxXVuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-M30a6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:52 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)) 03:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:52 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-axoCTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-30ydmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-5_bCek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-M2b8Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-GbuLS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-czbzql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:53 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)) 03:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:53 INFO - Running setup.py (path:/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/pip-tknva3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:53 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)) 03:00:53 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)) 03:00:53 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)) 03:00:53 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)) 03:00:53 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)) 03:00:53 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)) 03:00:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:56 INFO - Downloading blessings-1.6.tar.gz 03:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:56 INFO - Installing collected packages: blessings 03:00:56 INFO - Running setup.py install for blessings 03:00:56 INFO - Successfully installed blessings 03:00:56 INFO - Cleaning up... 03:00:56 INFO - Return code: 0 03:00:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:56 INFO - Reading from file tmpfile_stdout 03:00:56 INFO - Current package versions: 03:00:56 INFO - blessings == 1.6 03:00:56 INFO - blobuploader == 1.2.4 03:00:56 INFO - docopt == 0.6.1 03:00:56 INFO - functools32 == 3.2.3-2 03:00:56 INFO - jsonschema == 2.5.1 03:00:56 INFO - manifestparser == 1.1 03:00:56 INFO - mozInstall == 1.12 03:00:56 INFO - mozcrash == 1.0 03:00:56 INFO - mozdebug == 0.1 03:00:56 INFO - mozdevice == 0.49 03:00:56 INFO - mozfile == 1.2 03:00:56 INFO - mozhttpd == 0.7 03:00:56 INFO - mozinfo == 0.9 03:00:56 INFO - mozleak == 0.1 03:00:56 INFO - mozlog == 3.4 03:00:56 INFO - moznetwork == 0.27 03:00:56 INFO - mozprocess == 0.24 03:00:56 INFO - mozprofile == 0.28 03:00:56 INFO - mozrunner == 6.13 03:00:56 INFO - mozscreenshot == 0.1 03:00:56 INFO - mozsystemmonitor == 0.3 03:00:56 INFO - moztest == 0.8 03:00:56 INFO - mozversion == 1.4 03:00:56 INFO - psutil == 3.1.1 03:00:56 INFO - requests == 1.2.3 03:00:56 INFO - wsgiref == 0.1.2 03:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:56 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')]} 03:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:58 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:58 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 03:00:58 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 03:00:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:58 INFO - 'HOME': '/Users/cltbld', 03:00:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:58 INFO - 'LOGNAME': 'cltbld', 03:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:58 INFO - 'MOZ_NO_REMOTE': '1', 03:00:58 INFO - 'NO_EM_RESTART': '1', 03:00:58 INFO - 'PAGER': '/bin/cat', 03:00:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:58 INFO - 'PWD': '/builds/slave/test', 03:00:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:58 INFO - 'SHELL': '/bin/bash', 03:00:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:58 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:58 INFO - 'USER': 'cltbld', 03:00:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:58 INFO - 'XPC_FLAGS': '0x0', 03:00:58 INFO - 'XPC_SERVICE_NAME': '0', 03:00:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 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)) 03:00:58 INFO - Cleaning up... 03:00:58 INFO - Return code: 0 03:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:58 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 0x10b81cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b81f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffce0c9f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, '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.DrjwLcMczW/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.ra9T1n3odV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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 03:00:58 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 03:00:58 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 03:00:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:00:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:58 INFO - 'HOME': '/Users/cltbld', 03:00:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:58 INFO - 'LOGNAME': 'cltbld', 03:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:58 INFO - 'MOZ_NO_REMOTE': '1', 03:00:58 INFO - 'NO_EM_RESTART': '1', 03:00:58 INFO - 'PAGER': '/bin/cat', 03:00:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:58 INFO - 'PWD': '/builds/slave/test', 03:00:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:58 INFO - 'SHELL': '/bin/bash', 03:00:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:00:58 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:00:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:58 INFO - 'USER': 'cltbld', 03:00:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:58 INFO - 'XPC_FLAGS': '0x0', 03:00:58 INFO - 'XPC_SERVICE_NAME': '0', 03:00:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:58 INFO - Cleaning up... 03:00:58 INFO - Return code: 0 03:00:58 INFO - Running post-action listener: _resource_record_post_action 03:00:58 INFO - Running post-action listener: _start_resource_monitoring 03:00:59 INFO - Starting resource monitoring. 03:00:59 INFO - [mozharness: 2017-02-15 11:00:59.029903Z] Finished create-virtualenv step (success) 03:00:59 INFO - [mozharness: 2017-02-15 11:00:59.030821Z] Running install step. 03:00:59 INFO - Running pre-action listener: _resource_record_pre_action 03:00:59 INFO - Running main action method: install 03:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:59 INFO - Reading from file tmpfile_stdout 03:00:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:59 INFO - Reading from file tmpfile_stdout 03:00:59 INFO - Output received: 03:00:59 INFO - Usage: mozinstall [options] installer 03:00:59 INFO - Options: 03:00:59 INFO - -h, --help show this help message and exit 03:00:59 INFO - -d DEST, --destination=DEST 03:00:59 INFO - Directory to install application into. [default: 03:00:59 INFO - "/builds/slave/test"] 03:00:59 INFO - --app=APP Application being installed. [default: firefox] 03:00:59 INFO - mkdir: /builds/slave/test/build/application 03:00:59 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'] 03:00:59 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 03:01:21 INFO - Reading from file tmpfile_stdout 03:01:21 INFO - Output received: 03:01:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:01:21 INFO - Running post-action listener: _resource_record_post_action 03:01:21 INFO - [mozharness: 2017-02-15 11:01:21.223915Z] Finished install step (success) 03:01:21 INFO - [mozharness: 2017-02-15 11:01:21.224052Z] Running run-tests step. 03:01:21 INFO - Running pre-action listener: _resource_record_pre_action 03:01:21 INFO - Running main action method: run_tests 03:01:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:21 INFO - 2017-02-15 03:01:21.238 screenresolution[1895:18403] starting screenresolution argv=screenresolution get 03:01:21 INFO - 2017-02-15 03:01:21.241 screenresolution[1895:18403] Display 0: 1600x1200x32@60 03:01:21 INFO - 2017-02-15 03:01:21.247 screenresolution[1896:18406] starting screenresolution argv=screenresolution list 03:01:21 INFO - Available Modes on Display 0 03:01:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:21 INFO - Intel Iris: 03:01:21 INFO - Chipset Model: Intel Iris 03:01:21 INFO - Type: GPU 03:01:21 INFO - Bus: Built-In 03:01:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:21 INFO - Vendor: Intel (0x8086) 03:01:21 INFO - Device ID: 0x0a2e 03:01:21 INFO - Revision ID: 0x0009 03:01:21 INFO - Displays: 03:01:21 INFO - Display: 03:01:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:21 INFO - Display Serial Number: 1600x1200 60 03:01:21 INFO - Main Display: Yes 03:01:21 INFO - Mirror: Off 03:01:21 INFO - Online: Yes 03:01:21 INFO - Rotation: Supported 03:01:21 INFO - Return code: 0 03:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:21 INFO - Python 2.7.3 03:01:21 INFO - Return code: 0 03:01:21 INFO - grabbing minidump binary from tooltool 03:01:21 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')]} 03:01:21 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 0x10b5fad30>, '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 0x10b521db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5efbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:21 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 03:01:21 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 03:01:21 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 03:01:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:21 INFO - Return code: 0 03:01:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:01:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:01:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:21 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/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--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 03:01:21 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/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0233 --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 03:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DrjwLcMczW/Render', 03:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:21 INFO - 'HOME': '/Users/cltbld', 03:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:21 INFO - 'LOGNAME': 'cltbld', 03:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:21 INFO - 'MOZ_NO_REMOTE': '1', 03:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:21 INFO - 'NO_EM_RESTART': '1', 03:01:21 INFO - 'PAGER': '/bin/cat', 03:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:21 INFO - 'PWD': '/builds/slave/test', 03:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:21 INFO - 'SHELL': '/bin/bash', 03:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ra9T1n3odV/Listeners', 03:01:21 INFO - 'TMPDIR': '/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/', 03:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:21 INFO - 'USER': 'cltbld', 03:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:21 INFO - 'XPC_FLAGS': '0x0', 03:01:21 INFO - 'XPC_SERVICE_NAME': '0', 03:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:21 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/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0233', '--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 03:01:21 INFO - mozversion application_buildid: 20170209170211 03:01:21 INFO - mozversion application_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:21 INFO - mozversion application_display_name: Nightly 03:01:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:21 INFO - mozversion application_name: Firefox 03:01:21 INFO - mozversion application_remotingname: firefox 03:01:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:01:21 INFO - mozversion application_vendor: Mozilla 03:01:21 INFO - mozversion application_version: 54.0a1 03:01:21 INFO - mozversion platform_buildid: 20170209170211 03:01:21 INFO - mozversion platform_changeset: 25a94c1047e793ef096d8556fa3c26dd72bd37d7 03:01:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:01:21 INFO - mozversion platform_version: 54.0a1 03:01:21 INFO - using testdate: 1487156481 03:01:21 INFO - actual date: 1487156481 03:01:21 INFO - starting webserver on 'localhost:49636' 03:01:21 INFO - SUITE-START | Running 2 tests 03:01:21 INFO - TEST-START | dromaeo_css 03:01:21 INFO - operating with platform_type : mac_ 03:01:21 INFO - Initialising browser for dromaeo_css test... 03:01:21 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpBkXg5u/profile http://localhost:49636/getInfo.html) 03:01:23 INFO - PROCESS | 1906 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:01:24 INFO - PROCESS | 1906 | __metrics Screen width/height:1600/1200 03:01:24 INFO - PROCESS | 1906 | colorDepth:24 03:01:24 INFO - PROCESS | 1906 | Browser inner width/height: 1024/689 03:01:24 INFO - PROCESS | 1906 | __metrics 03:01:24 INFO - PROCESS | 1906 | 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" 03:01:24 INFO - PROCESS | 1906 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:01:25 INFO - TEST-INFO | 1906: exit 0 03:01:25 INFO - Browser initialized. 03:01:25 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:25 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpBkXg5u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:37 INFO - PROCESS | 1908 | RSS: Main: 237060096 03:01:37 INFO - PROCESS | 1908 | 03:04:40 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49636/tests/dromaeo/cssquery-ext.html) 03:04:42 INFO - PROCESS | 1908 | RSS: Main: 413581312 03:04:42 INFO - PROCESS | 1908 | 03:06:27 INFO - PROCESS | 1908 | ************************* 03:06:27 INFO - PROCESS | 1908 | A coding exception was thrown and uncaught in a Task. 03:06:27 INFO - PROCESS | 1908 | 03:06:27 ERROR - PROCESS | 1908 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:06:27 INFO - PROCESS | 1908 | Full stack: 03:06:27 INFO - PROCESS | 1908 | ************************* 03:07:45 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-ext.html (next: http://localhost:49636/tests/dromaeo/cssquery-jquery.html) 03:07:46 INFO - PROCESS | 1908 | RSS: Main: 370958336 03:07:46 INFO - PROCESS | 1908 | 03:10:48 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49636/tests/dromaeo/cssquery-mootools.html) 03:10:49 INFO - PROCESS | 1908 | RSS: Main: 352141312 03:10:49 INFO - PROCESS | 1908 | 03:13:51 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49636/tests/dromaeo/cssquery-prototype.html) 03:13:52 INFO - PROCESS | 1908 | RSS: Main: 352817152 03:13:52 INFO - PROCESS | 1908 | 03:16:56 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49636/tests/dromaeo/cssquery-yui.html) 03:16:56 INFO - PROCESS | 1908 | RSS: Main: 341229568 03:16:56 INFO - PROCESS | 1908 | 03:19:59 INFO - PROCESS | 1908 | Cycle 1(1): loaded http://localhost:49636/tests/dromaeo/cssquery-yui.html (next: http://localhost:49636/tests/dromaeo/cssquery-dojo.html) 03:20:00 INFO - PROCESS | 1908 | RSS: Main: 541224960 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | __start_tp_report 03:20:00 INFO - PROCESS | 1908 | _x_x_mozilla_page_load 03:20:00 INFO - PROCESS | 1908 | _x_x_mozilla_page_load_details 03:20:00 INFO - PROCESS | 1908 | |i|pagename|runs| 03:20:00 INFO - PROCESS | 1908 | |0;dojo.html;3296.8351582420883;3313;3317.12096294482;3336.8998930032076;3363.5795525559306;5434.130539113743;5560.749766260518;5628.8592785180335;5660.943390566098;5684.090545512719;5521.779128834842;5573.7213139342975;5597.832065038046;5624.3531993820725;5651.886962260753;5058.342415486;5081.517255860687;5124.8975020499565;5149.047426226141;5177;5121.359830021247;5229.790808367661;5236.136037553818;5255.789768409259;5294.232336311233;4990.65065445419;5020.849374518733;5168.3281173447585;5192.922106168392;5193.298904647862;5053.166227572447;5054.74726263689;5058.924116138261;5067.34124563808;5087.669301495428;5022.27177059328;5032.043911656773;5033.295338652591;5033.572146367563;5040.445550989425;5593.552515798727;5678.886422271573;5680.801171958961;5681.801136960228;5707.77168913243;6131.202943617346;6170.660613666247;6189.783357582463;6193.473554747852;6197.597156184834;6172.302616780376;6217.647467933081;6240.344763799781;6243.906341404882;6251.3123556408755;5504.422035686275;5546.278983732089;5567.4432556744005;5572.944270557283;5603.551715862721;6194.969025154845;6211.472024877936;6214.2542894852;6238.937610623926;6289.371062893674;5743.827685169452;5793.188953546507;6019.909701354483;6032.698365081728;6076.422739839708;5989.610675306091;6113.449789518964;6124.258880972529;6146.262448506208;6173.351798061229;6102.496114562096;6115.036322022127;6119.265688117454;6121.910283036266;6127.775088698076;5741.167530708024;5798.507126894261;5809.448102430262;5852.180694702745;5878.412158784087;4787.688800227974;4802.327674125625;4805.543473370024;4855.004724031565;4872.6832755870755;3987.9631295863283;4382.079763249753;4422.29243321067;4424.867253982386;4444.73331600105;5630.127330263816;5637.915431268534;5641.661500309994;5644.209810626516;5654.321481422256;5934.020886553757;6148.508119350441;6193.473554747807;6204.286507051746;6208.50331973441;4681.485036645966;5517.172424136412;5575.275214222206;5661.745221465044;5680.488756011896;5341;5342.198670199501;5374.54316383104;5385.272988146628;5391.137418013099;6319.494440444753;6330.588511746721;6334.5249106317215;6351.237851457855;6354.078658594571;5071.847844564521;5798.82603521895;6208.068789681584;6212.627242365473;6232.127502149793;6204.720787564661;6219.937800622117;6261.5616906816085;6274.372562743689;6305.558610897193;6041.546883983631;6051.33435322123;6051.722852954989;6078.5441091919165;6115.602485838406;6135.754569817157;6145.6927153641245;6169.938300617116;6202.162708034538;6205.379462053758;5212.556932660615;5463.262459567907;5710.3433105193435;5739.2252045973255;5830.854228644318;5251.789928402821;5456.727163641882;5791.594588378773;5803.622764520293;5850;5766.308043034863;5766.826995190151;5776.971115144397;5801.419858014165;5831.329397119385;5820.592558520862;5868.794592189253;5873.735681894411;5874.676892770768;5904.143899134688;5618.410066943075;5661.716914154194;5667.319921609434;5798.449147330997;5808.39011903744 03:20:00 INFO - PROCESS | 1908 | |1;ext.html;434.6262214495533;449.2542379649782;467.50211025258096;489.36627067946984;501.70650169650764;21909.780902190992;36946.07634809131;38674.8066259669;38836.223275534474;38926.02684932878;39821;40238.59761402385;40355;40382.7980860096;40399.59600403995;7773.106092799316;9083.636654533828;9294.163525282724;9309.860352094724;9319.767005824875;7887.96056019722;10777.78444431111;10994.780104397907;11043.171762117832;11188.328700277969;10943.726406839813;11057.50241239146;11058.004779569837;11071.501782419811;11093.33439993599;7832.647530861125;10957.17821163412;11022.527903710306;11027.283226590285;11028.44857757109;7814.921850781477;10648.627298044608;10925.180611454094;10954.726131846688;11029.558817647285;38027.61972380296;38380.61619383798;38413.231735365414;38431.03922401935;38473.42289865654;3747.4940882980723;3762.642548957872;3781.8487260509546;3783.754055986352;3889.824957876874;28096;28284.858575707196;28417;29347.70652293471;29397.559036614468;2988.8804447822063;3064.1267238836826;3146.5437511560694;3155.7790954633183;3182.98408507956;285575;320273.39863300533;323554;325097;327239.7276027209;47352.28971565429;47985.5201447988;57084;57447;57528.71235643879;51877.481225187264;59183;60017.69991150016;60178.097328540105;63335.049974250425;14716.926415367854;14877.553673389815;14887.255637218095;14891.627709307353;14912.403503859725;11439.942800285946;11524.423778811193;11550.59572914944;11551.075913926865;11551.826722599168;15548.533543993699;15665.921670391803;15676.667483263822;15685.274619791813;15723.449679261399;6426.196725409324;6452.483801295885;6452.580582262138;6514.185726784152;6516.120323756327;821.3634433314229;833.3832963606887;843.725789118539;862.1421685422919;862.5035563297673;27529;28230.43539129206;28469.288267793057;28855.56716649252;29218.707812922024;983.5770618634056;992.2954702161546;1014.8224060789332;1022.3712416863575;1029.9742506437399;12928.353582320846;14367.712645747235;15034.774478382833;15146.924265378822;15234.771478427832;558306;565119;565416.1729191327;565537;567206;49961;50371.74814125979;50387.74806125946;50399.496005040215;50426.4872053839;1294.132930936275;1338.2171429713726;1342.5905098944916;1343.1940835498622;1344.0390121063488;23164.07343706233;24911.636929014352;27013;27411.314717131434;27622.033228836895;42941.35587966246;43325.35011974886;43355.78322108369;43373.56626433695;43391.34912976371;453890;455160;457118;457465;460453;20690.17239310471;21219.78780212178;23198.536029279658;23292.650610240522;23732.4066898322;38253.80873095617;38344.80827595844;39215.41176882406;39391;39400.605993939695;28520.57219141673;31078.68921310758;32023.519647205776;32964.835175823966;33395;31780.682193177774;32314.676853232108;32328.515072274404;32381.83809081034;33035;29223.415531689672;29763.06540074888;31406.328303703696;31713;32090;25833.741662583885;26776.19671409861;28976.13071607855;29244;29343.85328073346;22161.1135554576;22226.666600001336;22259.666105008113;22468.88765556162;22805.88597057004 03:20:00 INFO - PROCESS | 1908 | |2;jquery.html;345.2645864309022;361.6997891749848;389.9044734040159;402.8529586700854;422.6154199678293;14149.787753183711;14203.857961420383;16285.837141628595;20131.899340503278;20887;12177.208481448699;15100.773488397683;19485.610287794272;20302.086406111725;20320.187192512283;5046.54581087702;5258.132408152669;5258.342707161605;5263.973680131594;5264.368275806909;4730.385049943503;4944.060628480595;5204.687718736888;5249.685018898859;5262.4474430184855;5255.605829562779;5256.973715131419;5257.211418287249;5258.1849813279005;5267.23625074364;5032.949670503303;5034.421041580192;5177.559907407875;5246.213068039806;5247.134222853225;5125.923111153335;5135.537801597837;5138.537531622172;5139.460356662571;5143.382794064699;13264.867351326557;24177.87911060451;24280.39299017521;24551.508969820683;24625.13812016571;2771.6922094189604;2963.0518234165074;2998.34036511967;3007.624046994126;3024.4555979923607;9713.90286097144;10078.949605252;10145.949270253675;10300.484975751257;10339.534720937576;1733.3153404405316;1742.8692848036449;1753.3162066793961;1791.7411157434956;1849.4359220437761;117597.41201294024;121806.3909680446;122566.77433225643;123851.38074309661;124212;9647.938726740053;11328.716782080513;11562.479688414041;11698.532058717727;11940.462679179458;15629.452969146025;15636.687266254612;15654.9217253913;15676;15691.293891774898;8066.475679080841;8245.464044837066;8357.373197010249;8460.238578527962;8462;7936.928514650564;7948.880766788503;7963.800904977422;8119.147489513634;8124;4736.360591320127;4748.430188377417;4756.286557016475;4821.083994041121;4864.343313652612;1957.67698329774;2012.6980952856895;2019.949501262451;2027.8479114066504;2032.3902829151195;864.8789169516273;974.1427543761586;992.7270000749852;1015.1428783860903;1016.3038318751679;19309;21108.78891211099;21171.364859054254;21173;21288.467788305417;873.3319010956624;922.4972390047441;978.6623614852864;1023.2632504596678;1033;8684.696035638723;9365.344425890258;10075.891651918284;10601.257911946244;10903.236773425942;547720;603029;672433;693363;696520.5521917176;83014;92353.5382323084;134564.12409890146;136353;144417.114117447;982.4989255479757;1018.9796204076025;1035.440861934562;1036.7200855769051;1037.227265687053;19020.42938711841;19273.51816204606;19404;19421.32025379105;19500.804991950467;45993;50713.74643126761;52963.4703652974;54667.453325467824;55250.72374638101;77479;78297.60851195708;78829.60585197266;78917;79965.80051299352;8234.917650823416;8261.09127995932;8384.53885036329;8434.746957591282;8482.279006284534;10055.29612927088;12680.809787853004;12760.74478510443;13029.869701303245;13103.017273704701;10971.890281097087;10997.725056873642;11223.597050368704;11292.887071129513;11431.59989400367;10604.151667866707;11008.064314533354;11078.667639970814;11377.829332559853;11560.884391155982;6076.483498902643;10832.187585931244;11498.25261358009;11704.590339338083;11744.706382340168;8295.460795048302;8337.541435221121;8386.958065209636;8603.139686031347;8670.393072484865;8430.283425908621;10370.481475926324;11257.549698011988;11402.315861048364;11580.305181689126 03:20:00 INFO - PROCESS | 1908 | |3;mootools.html;1402.4670625162437;1412.5338638249377;1428.5642878921924;1429.228216762948;1434.3473719457647;8105.392095592832;8469.983601967773;8475.957620211899;8484.363672724556;8488.108748581402;8073.3137683296845;8238.423310368276;8287.046989596198;8367.037790654076;8452.535110568917;2216.4126506475836;2258.22091378475;2258.3789457899043;2258.480549473622;2260.7739226077424;2172.6306527890297;2259.5932732108213;2266.8073213776847;2271.9659205111852;2278.931632051041;1933.1977229449762;2003.07858385143;2006.187494064906;2176.3035828534876;2240.0703707961175;2160.7191065161505;2175.7715439878903;2176.6408542590534;2181.760006399295;2185.426492925091;2193.363924461904;2198.7471440784357;2198.890055497219;2203.405080628221;2206.360155554887;7198.640067996632;8441.620127094295;8517.233448989558;8528.01927778301;8538.975322961285;4995.700257984533;5155.097857874857;5161.225816127611;5170.793168273264;5179.8446046618665;3278.7868788528667;3420.8973730787866;3442.4336926698293;3477.3566890125408;3478.8782392616135;1162.9069674426025;1195.384377045822;1200.741840504287;1246.5263199984038;1252.8058150986612;10826.079783218436;10886.292390994638;10943.4528273586;10953.616623418142;10962.780744385067;4118.691098167649;4313.784310784448;4367.71609845359;4378.321360189176;4389.670774691911;8577.442466239674;8599.914000860037;8600.139986001475;8602.010768761547;8667.349948753868;5002.724850133278;5028.572571331405;5028.874278143076;5037;5040.143175660147;4529.84145554904;4548.636109111263;4676.953230467651;4732.2428411454;4734.289856521549;3493.6941618531646;3553.8400771965325;3567.108222944264;3587.2736720092917;3618.764780289273;983.3313346924017;1112.1769890281134;1115.0243536905207;1116.0346300450053;1123.4102096399292;744.7318965172534;746.4364404874393;770.3067239484396;776.6078130544039;811.2860682599274;5481.780728770885;5782.681952492653;5909.497692696083;5932.58471906971;6040.244969378828;952.1145334838528;954.9713508594754;963.3304853127149;965.1362030982372;1014.573878970834;3802.7718336899875;3815.931539169037;3918.392649139388;3959.703022273341;3981.1042515433796;8194.262516373556;9339;9625.663101791404;9748.658796942073;9922.107010369102;9586.712398628053;9670.70987870365;9717.708468745808;9923;9928.65249716271;7471.327580517671;7798.855314788479;7800.219978002267;7802;7851.9214807851195;4316.482022157361;4845.224764037737;4868;5298.655587386807;5775.711214439178;8982.86525702102;8993.100689931216;9099.408538444979;9185.402948808307;9277.304202184729;9262.675806346746;9374.390664606779;9406.95296523513;9417.764555886157;9509.429434233969;6572.539922205399;6614.503912206507;6646.83382915431;6757.662116894037;6760.3239676032;7760.534367937942;7843.647035883513;7863.84272314562;7871.252231038042;7890.171531989288;6544.149260596092;7051.788446346618;7066.823329416806;7141.250168732416;7205.531640443564;7000.964995174992;7012.2286548478605;7019.508634395544;7035.050268213726;7091;6204.286507051746;6275.215598050244;6324.905126423016;6410.61536307823;6415.6903514735595;4992.226204938241;5057.8229761958155;5084.313617661568;5110.463401342806;5195.298634684269;4887.755612219304;5025.170846810382;5044.805509603334;5080.923786143137;5090.338256026693 03:20:00 INFO - PROCESS | 1908 | |4;prototype.html;321.7313543191435;334.50159262698577;346.18300810088186;349.4949797542551;367.74625508399185;4812.820858889572;4983.078130545847;5069.822556210534;5133.614978876581;5313.8937221255555;4595.080983803245;4776.173068855999;5234.37187537496;5256.159014557672;5284.2561954555;3679.951213904038;3985.8206380712936;4002.319605667029;4015.714971209214;4022.8591999280106;3730.4963829883027;3746.7939263340504;4014.671490535497;4020.376841589544;4044.4337792709043;3606.6753992140702;3873.4577159197734;3899.6685281750943;3902.590228026059;3936.6457018868296;3444.844981975817;3911.159100793343;3916.4921505220555;3929.410588411761;3929.9214015719526;2641.5773476243903;2868.956965645517;3074.4004919040794;3126.687331266855;3446.672566106216;4460.77696115193;4646.9767651161865;4982.950170498285;5039.546440820343;5083.313752643383;3693.7045036397026;4551.908961820778;4559.658025648089;4559.863204103882;4566.337881007235;4438.0014496738295;4732.881677958044;4876.634252431082;5511.696856672881;5561.749721262553;3555.1823080691584;3696.5564132304294;3726.5528136623507;3775.377062784637;3780.6597406233573;5117.974410127963;5800.622959507618;5841.92611622872;5877.52979761618;5910.438508341657;3811.0853395184954;3816.8473261069803;3818;3841.1741475582885;3859.459675645412;3444.293919746446;3669.743117981769;3826.215625796705;3859;3874.1476875087437;4387.319965405367;4407.4050003249795;4412.985013446861;4424.0709451015;4424.33634954753;4542.545745425431;5305.946940530623;5456.61803673747;5537.750801213955;5547.362053363834;1188.9405529723479;1259.779538580763;1269.949202031927;1277.7444511097817;1279.1877158004734;720.9711611535585;753.7337273380664;830.8130670599188;854.0690647194588;867.7483529776295;4494.73031618104;4503.820606302778;4608.769561521911;4836.879078023007;5003.173207137956;4789.6349540380825;5182.585393168538;5309;5359.544438722674;5476.466589354987;3935.9569714025806;4360.738355698605;4551.681382303207;4599.770011499411;4867.148249056401;2364.859801879302;2878.769698424121;2904.634821633829;2914.781391395654;2921.7078292170613;4812.374391329105;4917.451002934135;5423.430539793344;5760.625559338713;5782.3639399666;4769.734376171291;5206.323177986913;5430.239766432624;5462.426445223274;5699.857503562361;4882.829100981519;5227.503387178212;5228.555572776357;5341.4925582069645;5742.167385729046;4527.404281576925;5058.6206034548295;5462.890742185214;5537.28015358017;5559.694216818114;4569.811848919238;5171.853680722458;5466.414739725594;5480.424555421623;5485.451454854483;4939.851804445872;5204.739763011758;5271.731526453624;5738.655680659173;5781.364049954585;3177.9353916438254;3330.6169790473436;3466.2027733621912;3633.2551826875956;3693.5937046925355;4392.978035109804;5003.874903127451;5381.919271210857;5441.938821929686;5514.834554963358;4941.6293777966075;5394.730263486888;5405.9459405407015;5565;5575.0243707351865;5555.30558680165;5568.855990443627;5577.414371491097;5577.860553486033;5593.440655934537;4966.528179822911;5097.1844504879045;5162.6386152968935;5359.383670877899;5463;4802.6638135330195;5342.6260161788305;5547.8890422192135;5563.360213575329;5597.496225339739;4198.769067701306;4636.582707556201;5000.599592277141;5333.813316533902;5443.836684899459 03:20:00 INFO - PROCESS | 1908 | |5;yui.html;688.1108095682994;716.5593160206474;734.6473692627538;751.2412463411953;791.1337085890949;13718.451261949522;14671.77992330116;14737.705245895075;14743.410263589458;14758.262086895666;13035.087543871932;13159.802602960963;13166.539171129012;13184.60446186616;13221.669458263525;853.4580541356221;861.7802460372612;864.01933805131;871.9171678690515;876.4346996187455;888.6623083228365;889.1153302464057;889.822035592884;890.3011136258039;892.281713220857;941.5668792355525;942.4863449420083;944.8629948657441;945.5272363818091;946.1579194516886;943.9716808495756;944.3200895355333;946.195733626412;946.3186505715873;946.4132238012442;699.2972063076626;699.4544255480682;699.9405050570707;700.5446459801119;703.0368395298423;14492.130472171599;14637.975341726084;14641.560753177422;14645.926770366186;15156;13320.600381988555;13603.982918944821;13610.251436171007;13616.319184040858;13746;9789.987535320719;11024.834627480594;11272.544841323106;11309.264897781617;11747.823782643267;3498.3003399320237;3566.3937130687846;3577.302426026926;3712.016315676348;3723.2925744108534;96049.5197524015;98581.50709246407;98642;99361.99999999927;99500.50249748777;9648.95175524132;9930.255230857714;10258.58965641366;10509.106725928228;10833.02502774754;20546.178152874018;20959;21072.789272107388;21081.472963176042;21108.261210857545;7155.391791697764;7165.856682866313;7218.783436496913;7368.336849683555;7374.151972523121;3989.261986532501;4064.5122585289364;4066.674666026711;4068.877933661995;4070;3379.749492687672;3426.931461370759;3450.8274586270586;3452.4130897747445;3754.3617585010616;717.8923161525709;721.2210812322679;723.5586292361655;736.8931504931755;737.2921994884971;620.4230066038538;630.9400606942334;658.2167221006987;669.1602039440471;670.3129292475252;9788.062348005731;9860.556274967643;9915.553800079013;9989.650362237287;9999.100080992746;541.8130744893006;561.6798424897769;561.9719014049363;564.2270089976677;569.2400645138704;3966.682665386762;4460.665450091256;4584.774657184136;4633.907321853544;4823.107725070873;84284;86635.56682216549;86720.6991895122;87848.56075719709;88757;64247.678761605894;67379.86092711972;76279.23720762832;77098.22901771023;77142;67401;68231.31768682349;68304.3169568308;69082;70320.64839675871;9192.816143677222;9256.583453744463;9267.67563135287;9284.489353085375;9313.25493960495;32634.51048234231;42232;42902.570974289854;42931.35602965896;43044;46103;58515.70742146262;58849;58876;64942.675286623264;10619.30974486656;12297.631071067883;12374.13381063353;13028.348582570645;13613.931930340284;14137.677267935522;14144.929275353557;14187.645308866948;14314.785278220626;14510.274486275433;12578.685532861751;12634.810477842655;12879.935600322313;13048.41282142287;13698.178109313472;13008.21950682962;13059.21644701321;13144.27706476153;13310.401031953392;13736.862631373559;12899.355032248537;13092.429446020378;13221.206727596375;13505.864941350854;13635.590932272047;10928.890711092787;10969.122470202525;10992.230543861853;11100.666979990614;11487.121075874575;7140.46446516503;8736.650533978824;9815.11663950248;10288.176945844465;11543 03:20:00 INFO - PROCESS | 1908 | __end_tp_report 03:20:00 INFO - PROCESS | 1908 | __start_cc_report 03:20:00 INFO - PROCESS | 1908 | _x_x_mozilla_cycle_collect,1874 03:20:00 INFO - PROCESS | 1908 | __end_cc_report 03:20:00 INFO - PROCESS | 1908 | __startTimestamp1487157600201__endTimestamp 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | ------- Summary: start ------- 03:20:00 INFO - PROCESS | 1908 | Number of tests: 6 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#0] dojo.html Cycles:165 Average:5604.70 Median:5707.77 stddev:631.25 (11.1%) stddev-sans-first:606.67 03:20:00 INFO - PROCESS | 1908 | Values: 3296.8 3313.0 3317.1 3336.9 3363.6 5434.1 5560.7 5628.9 5660.9 5684.1 5521.8 5573.7 5597.8 5624.4 5651.9 5058.3 5081.5 5124.9 5149.0 5177.0 5121.4 5229.8 5236.1 5255.8 5294.2 4990.7 5020.8 5168.3 5192.9 5193.3 5053.2 5054.7 5058.9 5067.3 5087.7 5022.3 5032.0 5033.3 5033.6 5040.4 5593.6 5678.9 5680.8 5681.8 5707.8 6131.2 6170.7 6189.8 6193.5 6197.6 6172.3 6217.6 6240.3 6243.9 6251.3 5504.4 5546.3 5567.4 5572.9 5603.6 6195.0 6211.5 6214.3 6238.9 6289.4 5743.8 5793.2 6019.9 6032.7 6076.4 5989.6 6113.4 6124.3 6146.3 6173.4 6102.5 6115.0 6119.3 6121.9 6127.8 5741.2 5798.5 5809.4 5852.2 5878.4 4787.7 4802.3 4805.5 4855.0 4872.7 3988.0 4382.1 4422.3 4424.9 4444.7 5630.1 5637.9 5641.7 5644.2 5654.3 5934.0 6148.5 6193.5 6204.3 6208.5 4681.5 5517.2 5575.3 5661.7 5680.5 5341.0 5342.2 5374.5 5385.3 5391.1 6319.5 6330.6 6334.5 6351.2 6354.1 5071.8 5798.8 6208.1 6212.6 6232.1 6204.7 6219.9 6261.6 6274.4 6305.6 6041.5 6051.3 6051.7 6078.5 6115.6 6135.8 6145.7 6169.9 6202.2 6205.4 5212.6 5463.3 5710.3 5739.2 5830.9 5251.8 5456.7 5791.6 5803.6 5850.0 5766.3 5766.8 5777.0 5801.4 5831.3 5820.6 5868.8 5873.7 5874.7 5904.1 5618.4 5661.7 5667.3 5798.4 5808.4 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#1] ext.html Cycles:180 Average:57542.00 Median:176181.70 stddev:122067.61 (69.3%) stddev-sans-first:122334.74 03:20:00 INFO - PROCESS | 1908 | Values: 434.6 449.3 467.5 489.4 501.7 21909.8 36946.1 38674.8 38836.2 38926.0 39821.0 40238.6 40355.0 40382.8 40399.6 7773.1 9083.6 9294.2 9309.9 9319.8 7888.0 10777.8 10994.8 11043.2 11188.3 10943.7 11057.5 11058.0 11071.5 11093.3 7832.6 10957.2 11022.5 11027.3 11028.4 7814.9 10648.6 10925.2 10954.7 11029.6 38027.6 38380.6 38413.2 38431.0 38473.4 3747.5 3762.6 3781.8 3783.8 3889.8 28096.0 28284.9 28417.0 29347.7 29397.6 2988.9 3064.1 3146.5 3155.8 3183.0 285575.0 320273.4 323554.0 325097.0 327239.7 47352.3 47985.5 57084.0 57447.0 57528.7 51877.5 59183.0 60017.7 60178.1 63335.0 14716.9 14877.6 14887.3 14891.6 14912.4 11439.9 11524.4 11550.6 11551.1 11551.8 15548.5 15665.9 15676.7 15685.3 15723.4 6426.2 6452.5 6452.6 6514.2 6516.1 821.4 833.4 843.7 862.1 862.5 27529.0 28230.4 28469.3 28855.6 29218.7 983.6 992.3 1014.8 1022.4 1030.0 12928.4 14367.7 15034.8 15146.9 15234.8 558306.0 565119.0 565416.2 565537.0 567206.0 49961.0 50371.7 50387.7 50399.5 50426.5 1294.1 1338.2 1342.6 1343.2 1344.0 23164.1 24911.6 27013.0 27411.3 27622.0 42941.4 43325.4 43355.8 43373.6 43391.3 453890.0 455160.0 457118.0 457465.0 460453.0 20690.2 21219.8 23198.5 23292.7 23732.4 38253.8 38344.8 39215.4 39391.0 39400.6 28520.6 31078.7 32023.5 32964.8 33395.0 31780.7 32314.7 32328.5 32381.8 33035.0 29223.4 29763.1 31406.3 31713.0 32090.0 25833.7 26776.2 28976.1 29244.0 29343.9 22161.1 22226.7 22259.7 22468.9 22805.9 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#2] jquery.html Cycles:180 Average:35741.99 Median:2867.37 stddev:107319.70 (3742.8%) stddev-sans-first:107587.85 03:20:00 INFO - PROCESS | 1908 | Values: 345.3 361.7 389.9 402.9 422.6 14149.8 14203.9 16285.8 20131.9 20887.0 12177.2 15100.8 19485.6 20302.1 20320.2 5046.5 5258.1 5258.3 5264.0 5264.4 4730.4 4944.1 5204.7 5249.7 5262.4 5255.6 5257.0 5257.2 5258.2 5267.2 5032.9 5034.4 5177.6 5246.2 5247.1 5125.9 5135.5 5138.5 5139.5 5143.4 13264.9 24177.9 24280.4 24551.5 24625.1 2771.7 2963.1 2998.3 3007.6 3024.5 9713.9 10078.9 10145.9 10300.5 10339.5 1733.3 1742.9 1753.3 1791.7 1849.4 117597.4 121806.4 122566.8 123851.4 124212.0 9647.9 11328.7 11562.5 11698.5 11940.5 15629.5 15636.7 15654.9 15676.0 15691.3 8066.5 8245.5 8357.4 8460.2 8462.0 7936.9 7948.9 7963.8 8119.1 8124.0 4736.4 4748.4 4756.3 4821.1 4864.3 1957.7 2012.7 2019.9 2027.8 2032.4 864.9 974.1 992.7 1015.1 1016.3 19309.0 21108.8 21171.4 21173.0 21288.5 873.3 922.5 978.7 1023.3 1033.0 8684.7 9365.3 10075.9 10601.3 10903.2 547720.0 603029.0 672433.0 693363.0 696520.6 83014.0 92353.5 134564.1 136353.0 144417.1 982.5 1019.0 1035.4 1036.7 1037.2 19020.4 19273.5 19404.0 19421.3 19500.8 45993.0 50713.7 52963.5 54667.5 55250.7 77479.0 78297.6 78829.6 78917.0 79965.8 8234.9 8261.1 8384.5 8434.7 8482.3 10055.3 12680.8 12760.7 13029.9 13103.0 10971.9 10997.7 11223.6 11292.9 11431.6 10604.2 11008.1 11078.7 11377.8 11560.9 6076.5 10832.2 11498.3 11704.6 11744.7 8295.5 8337.5 8387.0 8603.1 8670.4 8430.3 10370.5 11257.5 11402.3 11580.3 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#3] mootools.html Cycles:180 Average:5335.67 Median:5175.32 stddev:2930.65 (56.6%) stddev-sans-first:2923.96 03:20:00 INFO - PROCESS | 1908 | Values: 1402.5 1412.5 1428.6 1429.2 1434.3 8105.4 8470.0 8476.0 8484.4 8488.1 8073.3 8238.4 8287.0 8367.0 8452.5 2216.4 2258.2 2258.4 2258.5 2260.8 2172.6 2259.6 2266.8 2272.0 2278.9 1933.2 2003.1 2006.2 2176.3 2240.1 2160.7 2175.8 2176.6 2181.8 2185.4 2193.4 2198.7 2198.9 2203.4 2206.4 7198.6 8441.6 8517.2 8528.0 8539.0 4995.7 5155.1 5161.2 5170.8 5179.8 3278.8 3420.9 3442.4 3477.4 3478.9 1162.9 1195.4 1200.7 1246.5 1252.8 10826.1 10886.3 10943.5 10953.6 10962.8 4118.7 4313.8 4367.7 4378.3 4389.7 8577.4 8599.9 8600.1 8602.0 8667.3 5002.7 5028.6 5028.9 5037.0 5040.1 4529.8 4548.6 4677.0 4732.2 4734.3 3493.7 3553.8 3567.1 3587.3 3618.8 983.3 1112.2 1115.0 1116.0 1123.4 744.7 746.4 770.3 776.6 811.3 5481.8 5782.7 5909.5 5932.6 6040.2 952.1 955.0 963.3 965.1 1014.6 3802.8 3815.9 3918.4 3959.7 3981.1 8194.3 9339.0 9625.7 9748.7 9922.1 9586.7 9670.7 9717.7 9923.0 9928.7 7471.3 7798.9 7800.2 7802.0 7851.9 4316.5 4845.2 4868.0 5298.7 5775.7 8982.9 8993.1 9099.4 9185.4 9277.3 9262.7 9374.4 9407.0 9417.8 9509.4 6572.5 6614.5 6646.8 6757.7 6760.3 7760.5 7843.6 7863.8 7871.3 7890.2 6544.1 7051.8 7066.8 7141.3 7205.5 7001.0 7012.2 7019.5 7035.1 7091.0 6204.3 6275.2 6324.9 6410.6 6415.7 4992.2 5057.8 5084.3 5110.5 5195.3 4887.8 5025.2 5044.8 5080.9 5090.3 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#4] prototype.html Cycles:180 Average:4333.26 Median:4796.15 stddev:1332.17 (27.8%) stddev-sans-first:1301.43 03:20:00 INFO - PROCESS | 1908 | Values: 321.7 334.5 346.2 349.5 367.7 4812.8 4983.1 5069.8 5133.6 5313.9 4595.1 4776.2 5234.4 5256.2 5284.3 3680.0 3985.8 4002.3 4015.7 4022.9 3730.5 3746.8 4014.7 4020.4 4044.4 3606.7 3873.5 3899.7 3902.6 3936.6 3444.8 3911.2 3916.5 3929.4 3929.9 2641.6 2869.0 3074.4 3126.7 3446.7 4460.8 4647.0 4983.0 5039.5 5083.3 3693.7 4551.9 4559.7 4559.9 4566.3 4438.0 4732.9 4876.6 5511.7 5561.7 3555.2 3696.6 3726.6 3775.4 3780.7 5118.0 5800.6 5841.9 5877.5 5910.4 3811.1 3816.8 3818.0 3841.2 3859.5 3444.3 3669.7 3826.2 3859.0 3874.1 4387.3 4407.4 4413.0 4424.1 4424.3 4542.5 5305.9 5456.6 5537.8 5547.4 1188.9 1259.8 1269.9 1277.7 1279.2 721.0 753.7 830.8 854.1 867.7 4494.7 4503.8 4608.8 4836.9 5003.2 4789.6 5182.6 5309.0 5359.5 5476.5 3936.0 4360.7 4551.7 4599.8 4867.1 2364.9 2878.8 2904.6 2914.8 2921.7 4812.4 4917.5 5423.4 5760.6 5782.4 4769.7 5206.3 5430.2 5462.4 5699.9 4882.8 5227.5 5228.6 5341.5 5742.2 4527.4 5058.6 5462.9 5537.3 5559.7 4569.8 5171.9 5466.4 5480.4 5485.5 4939.9 5204.7 5271.7 5738.7 5781.4 3177.9 3330.6 3466.2 3633.3 3693.6 4393.0 5003.9 5381.9 5441.9 5514.8 4941.6 5394.7 5405.9 5565.0 5575.0 5555.3 5568.9 5577.4 5577.9 5593.4 4966.5 5097.2 5162.6 5359.4 5463.0 4802.7 5342.6 5547.9 5563.4 5597.5 4198.8 4636.6 5000.6 5333.8 5443.8 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - PROCESS | 1908 | [#5] yui.html Cycles:180 Average:18294.76 Median:551.75 stddev:25370.72 (4598.3%) stddev-sans-first:25407.44 03:20:00 INFO - PROCESS | 1908 | Values: 688.1 716.6 734.6 751.2 791.1 13718.5 14671.8 14737.7 14743.4 14758.3 13035.1 13159.8 13166.5 13184.6 13221.7 853.5 861.8 864.0 871.9 876.4 888.7 889.1 889.8 890.3 892.3 941.6 942.5 944.9 945.5 946.2 944.0 944.3 946.2 946.3 946.4 699.3 699.5 699.9 700.5 703.0 14492.1 14638.0 14641.6 14645.9 15156.0 13320.6 13604.0 13610.3 13616.3 13746.0 9790.0 11024.8 11272.5 11309.3 11747.8 3498.3 3566.4 3577.3 3712.0 3723.3 96049.5 98581.5 98642.0 99362.0 99500.5 9649.0 9930.3 10258.6 10509.1 10833.0 20546.2 20959.0 21072.8 21081.5 21108.3 7155.4 7165.9 7218.8 7368.3 7374.2 3989.3 4064.5 4066.7 4068.9 4070.0 3379.7 3426.9 3450.8 3452.4 3754.4 717.9 721.2 723.6 736.9 737.3 620.4 630.9 658.2 669.2 670.3 9788.1 9860.6 9915.6 9989.7 9999.1 541.8 561.7 562.0 564.2 569.2 3966.7 4460.7 4584.8 4633.9 4823.1 84284.0 86635.6 86720.7 87848.6 88757.0 64247.7 67379.9 76279.2 77098.2 77142.0 67401.0 68231.3 68304.3 69082.0 70320.6 9192.8 9256.6 9267.7 9284.5 9313.3 32634.5 42232.0 42902.6 42931.4 43044.0 46103.0 58515.7 58849.0 58876.0 64942.7 10619.3 12297.6 12374.1 13028.3 13613.9 14137.7 14144.9 14187.6 14314.8 14510.3 12578.7 12634.8 12879.9 13048.4 13698.2 13008.2 13059.2 13144.3 13310.4 13736.9 12899.4 13092.4 13221.2 13505.9 13635.6 10928.9 10969.1 10992.2 11100.7 11487.1 7140.5 8736.7 9815.1 10288.2 11543.0 03:20:00 INFO - PROCESS | 1908 | -------- Summary: end -------- 03:20:00 INFO - PROCESS | 1908 | 03:20:00 INFO - TEST-INFO | 1908: exit 0 03:20:00 INFO - TEST-OK | dromaeo_css | took 1119081ms 03:20:00 INFO - TEST-START | kraken 03:20:00 INFO - operating with platform_type : mac_ 03:20:00 INFO - Initialising browser for kraken test... 03:20:00 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpBREynn/profile http://localhost:49636/getInfo.html) 03:20:03 INFO - PROCESS | 1912 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:20:03 INFO - PROCESS | 1912 | __metrics Screen width/height:1600/1200 03:20:03 INFO - PROCESS | 1912 | colorDepth:24 03:20:03 INFO - PROCESS | 1912 | Browser inner width/height: 1024/689 03:20:03 INFO - PROCESS | 1912 | __metrics 03:20:03 INFO - PROCESS | 1912 | 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" 03:20:03 INFO - PROCESS | 1912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:20:04 INFO - TEST-INFO | 1912: exit 0 03:20:04 INFO - Browser initialized. 03:20:04 INFO - Running cycle 1/1 for kraken test... 03:20:04 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/T/tmpBREynn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:16 INFO - PROCESS | 1913 | RSS: Main: 228929536 03:20:16 INFO - PROCESS | 1913 | 03:20:19 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49636/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:20 INFO - PROCESS | 1913 | RSS: Main: 289021952 03:20:20 INFO - PROCESS | 1913 | 03:20:22 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49636/tests/kraken/driver.html?testName=audio-dft) 03:20:23 INFO - PROCESS | 1913 | RSS: Main: 291876864 03:20:23 INFO - PROCESS | 1913 | 03:20:26 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49636/tests/kraken/driver.html?testName=audio-fft) 03:20:27 INFO - PROCESS | 1913 | RSS: Main: 382197760 03:20:27 INFO - PROCESS | 1913 | 03:20:29 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49636/tests/kraken/driver.html?testName=audio-oscillator) 03:20:30 INFO - PROCESS | 1913 | RSS: Main: 284901376 03:20:30 INFO - PROCESS | 1913 | 03:20:32 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:32 INFO - PROCESS | 1913 | RSS: Main: 288407552 03:20:32 INFO - PROCESS | 1913 | 03:20:35 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49636/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:36 INFO - PROCESS | 1913 | RSS: Main: 329543680 03:20:36 INFO - PROCESS | 1913 | 03:20:39 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49636/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:39 INFO - PROCESS | 1913 | RSS: Main: 333242368 03:20:39 INFO - PROCESS | 1913 | 03:20:42 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49636/tests/kraken/driver.html?testName=json-parse-financial) 03:20:43 INFO - PROCESS | 1913 | RSS: Main: 330723328 03:20:43 INFO - PROCESS | 1913 | 03:20:44 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:45 INFO - PROCESS | 1913 | RSS: Main: 306241536 03:20:45 INFO - PROCESS | 1913 | 03:20:47 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:48 INFO - PROCESS | 1913 | RSS: Main: 311439360 03:20:48 INFO - PROCESS | 1913 | 03:20:50 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:51 INFO - PROCESS | 1913 | RSS: Main: 312942592 03:20:51 INFO - PROCESS | 1913 | 03:20:54 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:54 INFO - PROCESS | 1913 | RSS: Main: 330199040 03:20:54 INFO - PROCESS | 1913 | 03:20:57 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:58 INFO - PROCESS | 1913 | RSS: Main: 324173824 03:20:58 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49636/tests/kraken/driver.html?testName=ai-astar) 03:21:00 INFO - PROCESS | 1913 | RSS: Main: 369504256 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | __start_tp_report 03:21:00 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 03:21:00 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 03:21:00 INFO - PROCESS | 1913 | |i|pagename|runs| 03:21:00 INFO - PROCESS | 1913 | |0;ai-astar;111;114;114;114;114;114;113;113;113;114 03:21:00 INFO - PROCESS | 1913 | |1;audio-beat-detection;143;119;138;181;111;113;115;109;133;111 03:21:00 INFO - PROCESS | 1913 | |2;audio-dft;186;184;184;186;187;185;229;183;187;184 03:21:00 INFO - PROCESS | 1913 | |3;audio-fft;82;61;60;89;64;59;57;71;97;58 03:21:00 INFO - PROCESS | 1913 | |4;audio-oscillator;88;72;86;68;70;70;85;69;69;105 03:21:00 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;87;91;88;87;88;87;88;86;88;92 03:21:00 INFO - PROCESS | 1913 | |6;imaging-darkroom;93;95;96;95;94;96;95;101;145;98 03:21:00 INFO - PROCESS | 1913 | |7;imaging-desaturate;87;85;85;85;85;86;87;87;105;137 03:21:00 INFO - PROCESS | 1913 | |8;json-parse-financial;60;58;58;56;59;59;58;58;56;58 03:21:00 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;68;75;74;76;73;70;69;69;69;70 03:21:00 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;90;105;107;90;88;89;88;90;91;87 03:21:00 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;147;146;150;132;149;150;152;140;181;158 03:21:00 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;174;174;173;181;177;173;174;168;174;174 03:21:00 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;67;65;69;66;66;66;67;66;66;67 03:21:00 INFO - PROCESS | 1913 | __end_tp_report 03:21:00 INFO - PROCESS | 1913 | __start_cc_report 03:21:00 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,2020 03:21:00 INFO - PROCESS | 1913 | __end_cc_report 03:21:00 INFO - PROCESS | 1913 | __startTimestamp1487157660324__endTimestamp 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | ------- Summary: start ------- 03:21:00 INFO - PROCESS | 1913 | Number of tests: 14 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:0.50 03:21:00 INFO - PROCESS | 1913 | Values: 111.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:126.00 stddev:22.53 (17.9%) stddev-sans-first:23.17 03:21:00 INFO - PROCESS | 1913 | Values: 143.0 119.0 138.0 181.0 111.0 113.0 115.0 109.0 133.0 111.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:189.50 Median:186.00 stddev:13.95 (7.5%) stddev-sans-first:14.73 03:21:00 INFO - PROCESS | 1913 | Values: 186.0 184.0 184.0 186.0 187.0 185.0 229.0 183.0 187.0 184.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:69.80 Median:67.50 stddev:14.47 (21.4%) stddev-sans-first:14.66 03:21:00 INFO - PROCESS | 1913 | Values: 82.0 61.0 60.0 89.0 64.0 59.0 57.0 71.0 97.0 58.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:71.00 stddev:12.33 (17.4%) stddev-sans-first:12.55 03:21:00 INFO - PROCESS | 1913 | Values: 88.0 72.0 86.0 68.0 70.0 70.0 85.0 69.0 69.0 105.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:88.00 stddev:1.87 (2.1%) stddev-sans-first:1.94 03:21:00 INFO - PROCESS | 1913 | Values: 87.0 91.0 88.0 87.0 88.0 87.0 88.0 86.0 88.0 92.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:95.00 stddev:15.69 (16.5%) stddev-sans-first:16.39 03:21:00 INFO - PROCESS | 1913 | Values: 93.0 95.0 96.0 95.0 94.0 96.0 95.0 101.0 145.0 98.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:92.90 Median:85.50 stddev:16.64 (19.5%) stddev-sans-first:17.52 03:21:00 INFO - PROCESS | 1913 | Values: 87.0 85.0 85.0 85.0 85.0 86.0 87.0 87.0 105.0 137.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.25 (2.2%) stddev-sans-first:1.09 03:21:00 INFO - PROCESS | 1913 | Values: 60.0 58.0 58.0 56.0 59.0 59.0 58.0 58.0 56.0 58.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:2.91 (4.1%) stddev-sans-first:2.83 03:21:00 INFO - PROCESS | 1913 | Values: 68.0 75.0 74.0 76.0 73.0 70.0 69.0 69.0 69.0 70.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:92.50 Median:89.50 stddev:7.23 (8.1%) stddev-sans-first:7.61 03:21:00 INFO - PROCESS | 1913 | Values: 90.0 105.0 107.0 90.0 88.0 89.0 88.0 90.0 91.0 87.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:150.00 stddev:12.81 (8.5%) stddev-sans-first:13.52 03:21:00 INFO - PROCESS | 1913 | Values: 147.0 146.0 150.0 132.0 149.0 150.0 152.0 140.0 181.0 158.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:3.26 (1.9%) stddev-sans-first:3.46 03:21:00 INFO - PROCESS | 1913 | Values: 174.0 174.0 173.0 181.0 177.0 173.0 174.0 168.0 174.0 174.0 03:21:00 INFO - PROCESS | 1913 | 03:21:00 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 03:21:00 INFO - PROCESS | 1913 | Values: 67.0 65.0 69.0 66.0 66.0 66.0 67.0 66.0 66.0 67.0 03:21:00 INFO - PROCESS | 1913 | -------- Summary: end -------- 03:21:00 INFO - PROCESS | 1913 | 03:21:01 INFO - TEST-INFO | 1913: exit 0 03:21:01 INFO - TEST-OK | kraken | took 60361ms 03:21:01 INFO - SUITE-END | took 1179s 03:21:01 INFO - Completed test suite (00:19:39) 03:21:01 INFO - javascript benchmark 03:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6964.011053660089, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.8351582420883, 3313.0, 3317.12096294482, 3336.8998930032076, 3363.5795525559306, 5434.130539113743, 5560.749766260518, 5628.8592785180335, 5660.943390566098, 5684.090545512719, 5521.779128834842, 5573.7213139342975, 5597.832065038046, 5624.3531993820725, 5651.886962260753, 5058.342415486, 5081.517255860687, 5124.8975020499565, 5149.047426226141, 5177.0, 5121.359830021247, 5229.790808367661, 5236.136037553818, 5255.789768409259, 5294.232336311233, 4990.65065445419, 5020.849374518733, 5168.3281173447585, 5192.922106168392, 5193.298904647862, 5053.166227572447, 5054.74726263689, 5058.924116138261, 5067.34124563808, 5087.669301495428, 5022.27177059328, 5032.043911656773, 5033.295338652591, 5033.572146367563, 5040.445550989425, 5593.552515798727, 5678.886422271573, 5680.801171958961, 5681.801136960228, 5707.77168913243, 6131.202943617346, 6170.660613666247, 6189.783357582463, 6193.473554747852, 6197.597156184834, 6172.302616780376, 6217.647467933081, 6240.344763799781, 6243.906341404882, 6251.3123556408755, 5504.422035686275, 5546.278983732089, 5567.4432556744005, 5572.944270557283, 5603.551715862721, 6194.969025154845, 6211.472024877936, 6214.2542894852, 6238.937610623926, 6289.371062893674, 5743.827685169452, 5793.188953546507, 6019.909701354483, 6032.698365081728, 6076.422739839708, 5989.610675306091, 6113.449789518964, 6124.258880972529, 6146.262448506208, 6173.351798061229, 6102.496114562096, 6115.036322022127, 6119.265688117454, 6121.910283036266, 6127.775088698076, 5741.167530708024, 5798.507126894261, 5809.448102430262, 5852.180694702745, 5878.412158784087, 4787.688800227974, 4802.327674125625, 4805.543473370024, 4855.004724031565, 4872.6832755870755, 3987.9631295863283, 4382.079763249753, 4422.29243321067, 4424.867253982386, 4444.73331600105, 5630.127330263816, 5637.915431268534, 5641.661500309994, 5644.209810626516, 5654.321481422256, 5934.020886553757, 6148.508119350441, 6193.473554747807, 6204.286507051746, 6208.50331973441, 4681.485036645966, 5517.172424136412, 5575.275214222206, 5661.745221465044, 5680.488756011896, 5341.0, 5342.198670199501, 5374.54316383104, 5385.272988146628, 5391.137418013099, 6319.494440444753, 6330.588511746721, 6334.5249106317215, 6351.237851457855, 6354.078658594571, 5071.847844564521, 5798.82603521895, 6208.068789681584, 6212.627242365473, 6232.127502149793, 6204.720787564661, 6219.937800622117, 6261.5616906816085, 6274.372562743689, 6305.558610897193, 6041.546883983631, 6051.33435322123, 6051.722852954989, 6078.5441091919165, 6115.602485838406, 6135.754569817157, 6145.6927153641245, 6169.938300617116, 6202.162708034538, 6205.379462053758, 5212.556932660615, 5463.262459567907, 5710.3433105193435, 5739.2252045973255, 5830.854228644318, 5251.789928402821, 5456.727163641882, 5791.594588378773, 5803.622764520293, 5850.0, 5766.308043034863, 5766.826995190151, 5776.971115144397, 5801.419858014165, 5831.329397119385, 5820.592558520862, 5868.794592189253, 5873.735681894411, 5874.676892770768, 5904.143899134688, 5618.410066943075, 5661.716914154194, 5667.319921609434, 5798.449147330997, 5808.39011903744], "value": 5564.914236372214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.6262214495533, 449.2542379649782, 467.50211025258096, 489.36627067946984, 501.70650169650764, 21909.780902190992, 36946.07634809131, 38674.8066259669, 38836.223275534474, 38926.02684932878, 39821.0, 40238.59761402385, 40355.0, 40382.7980860096, 40399.59600403995, 7773.106092799316, 9083.636654533828, 9294.163525282724, 9309.860352094724, 9319.767005824875, 7887.96056019722, 10777.78444431111, 10994.780104397907, 11043.171762117832, 11188.328700277969, 10943.726406839813, 11057.50241239146, 11058.004779569837, 11071.501782419811, 11093.33439993599, 7832.647530861125, 10957.17821163412, 11022.527903710306, 11027.283226590285, 11028.44857757109, 7814.921850781477, 10648.627298044608, 10925.180611454094, 10954.726131846688, 11029.558817647285, 38027.61972380296, 38380.61619383798, 38413.231735365414, 38431.03922401935, 38473.42289865654, 3747.4940882980723, 3762.642548957872, 3781.8487260509546, 3783.754055986352, 3889.824957876874, 28096.0, 28284.858575707196, 28417.0, 29347.70652293471, 29397.559036614468, 2988.8804447822063, 3064.1267238836826, 3146.5437511560694, 3155.7790954633183, 3182.98408507956, 285575.0, 320273.39863300533, 323554.0, 325097.0, 327239.7276027209, 47352.28971565429, 47985.5201447988, 57084.0, 57447.0, 57528.71235643879, 51877.481225187264, 59183.0, 60017.69991150016, 60178.097328540105, 63335.049974250425, 14716.926415367854, 14877.553673389815, 14887.255637218095, 14891.627709307353, 14912.403503859725, 11439.942800285946, 11524.423778811193, 11550.59572914944, 11551.075913926865, 11551.826722599168, 15548.533543993699, 15665.921670391803, 15676.667483263822, 15685.274619791813, 15723.449679261399, 6426.196725409324, 6452.483801295885, 6452.580582262138, 6514.185726784152, 6516.120323756327, 821.3634433314229, 833.3832963606887, 843.725789118539, 862.1421685422919, 862.5035563297673, 27529.0, 28230.43539129206, 28469.288267793057, 28855.56716649252, 29218.707812922024, 983.5770618634056, 992.2954702161546, 1014.8224060789332, 1022.3712416863575, 1029.9742506437399, 12928.353582320846, 14367.712645747235, 15034.774478382833, 15146.924265378822, 15234.771478427832, 558306.0, 565119.0, 565416.1729191327, 565537.0, 567206.0, 49961.0, 50371.74814125979, 50387.74806125946, 50399.496005040215, 50426.4872053839, 1294.132930936275, 1338.2171429713726, 1342.5905098944916, 1343.1940835498622, 1344.0390121063488, 23164.07343706233, 24911.636929014352, 27013.0, 27411.314717131434, 27622.033228836895, 42941.35587966246, 43325.35011974886, 43355.78322108369, 43373.56626433695, 43391.34912976371, 453890.0, 455160.0, 457118.0, 457465.0, 460453.0, 20690.17239310471, 21219.78780212178, 23198.536029279658, 23292.650610240522, 23732.4066898322, 38253.80873095617, 38344.80827595844, 39215.41176882406, 39391.0, 39400.605993939695, 28520.57219141673, 31078.68921310758, 32023.519647205776, 32964.835175823966, 33395.0, 31780.682193177774, 32314.676853232108, 32328.515072274404, 32381.83809081034, 33035.0, 29223.415531689672, 29763.06540074888, 31406.328303703696, 31713.0, 32090.0, 25833.741662583885, 26776.19671409861, 28976.13071607855, 29244.0, 29343.85328073346, 22161.1135554576, 22226.666600001336, 22259.666105008113, 22468.88765556162, 22805.88597057004], "value": 18111.68945908022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2645864309022, 361.6997891749848, 389.9044734040159, 402.8529586700854, 422.6154199678293, 14149.787753183711, 14203.857961420383, 16285.837141628595, 20131.899340503278, 20887.0, 12177.208481448699, 15100.773488397683, 19485.610287794272, 20302.086406111725, 20320.187192512283, 5046.54581087702, 5258.132408152669, 5258.342707161605, 5263.973680131594, 5264.368275806909, 4730.385049943503, 4944.060628480595, 5204.687718736888, 5249.685018898859, 5262.4474430184855, 5255.605829562779, 5256.973715131419, 5257.211418287249, 5258.1849813279005, 5267.23625074364, 5032.949670503303, 5034.421041580192, 5177.559907407875, 5246.213068039806, 5247.134222853225, 5125.923111153335, 5135.537801597837, 5138.537531622172, 5139.460356662571, 5143.382794064699, 13264.867351326557, 24177.87911060451, 24280.39299017521, 24551.508969820683, 24625.13812016571, 2771.6922094189604, 2963.0518234165074, 2998.34036511967, 3007.624046994126, 3024.4555979923607, 9713.90286097144, 10078.949605252, 10145.949270253675, 10300.484975751257, 10339.534720937576, 1733.3153404405316, 1742.8692848036449, 1753.3162066793961, 1791.7411157434956, 1849.4359220437761, 117597.41201294024, 121806.3909680446, 122566.77433225643, 123851.38074309661, 124212.0, 9647.938726740053, 11328.716782080513, 11562.479688414041, 11698.532058717727, 11940.462679179458, 15629.452969146025, 15636.687266254612, 15654.9217253913, 15676.0, 15691.293891774898, 8066.475679080841, 8245.464044837066, 8357.373197010249, 8460.238578527962, 8462.0, 7936.928514650564, 7948.880766788503, 7963.800904977422, 8119.147489513634, 8124.0, 4736.360591320127, 4748.430188377417, 4756.286557016475, 4821.083994041121, 4864.343313652612, 1957.67698329774, 2012.6980952856895, 2019.949501262451, 2027.8479114066504, 2032.3902829151195, 864.8789169516273, 974.1427543761586, 992.7270000749852, 1015.1428783860903, 1016.3038318751679, 19309.0, 21108.78891211099, 21171.364859054254, 21173.0, 21288.467788305417, 873.3319010956624, 922.4972390047441, 978.6623614852864, 1023.2632504596678, 1033.0, 8684.696035638723, 9365.344425890258, 10075.891651918284, 10601.257911946244, 10903.236773425942, 547720.0, 603029.0, 672433.0, 693363.0, 696520.5521917176, 83014.0, 92353.5382323084, 134564.12409890146, 136353.0, 144417.114117447, 982.4989255479757, 1018.9796204076025, 1035.440861934562, 1036.7200855769051, 1037.227265687053, 19020.42938711841, 19273.51816204606, 19404.0, 19421.32025379105, 19500.804991950467, 45993.0, 50713.74643126761, 52963.4703652974, 54667.453325467824, 55250.72374638101, 77479.0, 78297.60851195708, 78829.60585197266, 78917.0, 79965.80051299352, 8234.917650823416, 8261.09127995932, 8384.53885036329, 8434.746957591282, 8482.279006284534, 10055.29612927088, 12680.809787853004, 12760.74478510443, 13029.869701303245, 13103.017273704701, 10971.890281097087, 10997.725056873642, 11223.597050368704, 11292.887071129513, 11431.59989400367, 10604.151667866707, 11008.064314533354, 11078.667639970814, 11377.829332559853, 11560.884391155982, 6076.483498902643, 10832.187585931244, 11498.25261358009, 11704.590339338083, 11744.706382340168, 8295.460795048302, 8337.541435221121, 8386.958065209636, 8603.139686031347, 8670.393072484865, 8430.283425908621, 10370.481475926324, 11257.549698011988, 11402.315861048364, 11580.305181689126], "value": 9375.216381877017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.4670625162437, 1412.5338638249377, 1428.5642878921924, 1429.228216762948, 1434.3473719457647, 8105.392095592832, 8469.983601967773, 8475.957620211899, 8484.363672724556, 8488.108748581402, 8073.3137683296845, 8238.423310368276, 8287.046989596198, 8367.037790654076, 8452.535110568917, 2216.4126506475836, 2258.22091378475, 2258.3789457899043, 2258.480549473622, 2260.7739226077424, 2172.6306527890297, 2259.5932732108213, 2266.8073213776847, 2271.9659205111852, 2278.931632051041, 1933.1977229449762, 2003.07858385143, 2006.187494064906, 2176.3035828534876, 2240.0703707961175, 2160.7191065161505, 2175.7715439878903, 2176.6408542590534, 2181.760006399295, 2185.426492925091, 2193.363924461904, 2198.7471440784357, 2198.890055497219, 2203.405080628221, 2206.360155554887, 7198.640067996632, 8441.620127094295, 8517.233448989558, 8528.01927778301, 8538.975322961285, 4995.700257984533, 5155.097857874857, 5161.225816127611, 5170.793168273264, 5179.8446046618665, 3278.7868788528667, 3420.8973730787866, 3442.4336926698293, 3477.3566890125408, 3478.8782392616135, 1162.9069674426025, 1195.384377045822, 1200.741840504287, 1246.5263199984038, 1252.8058150986612, 10826.079783218436, 10886.292390994638, 10943.4528273586, 10953.616623418142, 10962.780744385067, 4118.691098167649, 4313.784310784448, 4367.71609845359, 4378.321360189176, 4389.670774691911, 8577.442466239674, 8599.914000860037, 8600.139986001475, 8602.010768761547, 8667.349948753868, 5002.724850133278, 5028.572571331405, 5028.874278143076, 5037.0, 5040.143175660147, 4529.84145554904, 4548.636109111263, 4676.953230467651, 4732.2428411454, 4734.289856521549, 3493.6941618531646, 3553.8400771965325, 3567.108222944264, 3587.2736720092917, 3618.764780289273, 983.3313346924017, 1112.1769890281134, 1115.0243536905207, 1116.0346300450053, 1123.4102096399292, 744.7318965172534, 746.4364404874393, 770.3067239484396, 776.6078130544039, 811.2860682599274, 5481.780728770885, 5782.681952492653, 5909.497692696083, 5932.58471906971, 6040.244969378828, 952.1145334838528, 954.9713508594754, 963.3304853127149, 965.1362030982372, 1014.573878970834, 3802.7718336899875, 3815.931539169037, 3918.392649139388, 3959.703022273341, 3981.1042515433796, 8194.262516373556, 9339.0, 9625.663101791404, 9748.658796942073, 9922.107010369102, 9586.712398628053, 9670.70987870365, 9717.708468745808, 9923.0, 9928.65249716271, 7471.327580517671, 7798.855314788479, 7800.219978002267, 7802.0, 7851.9214807851195, 4316.482022157361, 4845.224764037737, 4868.0, 5298.655587386807, 5775.711214439178, 8982.86525702102, 8993.100689931216, 9099.408538444979, 9185.402948808307, 9277.304202184729, 9262.675806346746, 9374.390664606779, 9406.95296523513, 9417.764555886157, 9509.429434233969, 6572.539922205399, 6614.503912206507, 6646.83382915431, 6757.662116894037, 6760.3239676032, 7760.534367937942, 7843.647035883513, 7863.84272314562, 7871.252231038042, 7890.171531989288, 6544.149260596092, 7051.788446346618, 7066.823329416806, 7141.250168732416, 7205.531640443564, 7000.964995174992, 7012.2286548478605, 7019.508634395544, 7035.050268213726, 7091.0, 6204.286507051746, 6275.215598050244, 6324.905126423016, 6410.61536307823, 6415.6903514735595, 4992.226204938241, 5057.8229761958155, 5084.313617661568, 5110.463401342806, 5195.298634684269, 4887.755612219304, 5025.170846810382, 5044.805509603334, 5080.923786143137, 5090.338256026693], "value": 4309.5917108469575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.7313543191435, 334.50159262698577, 346.18300810088186, 349.4949797542551, 367.74625508399185, 4812.820858889572, 4983.078130545847, 5069.822556210534, 5133.614978876581, 5313.8937221255555, 4595.080983803245, 4776.173068855999, 5234.37187537496, 5256.159014557672, 5284.2561954555, 3679.951213904038, 3985.8206380712936, 4002.319605667029, 4015.714971209214, 4022.8591999280106, 3730.4963829883027, 3746.7939263340504, 4014.671490535497, 4020.376841589544, 4044.4337792709043, 3606.6753992140702, 3873.4577159197734, 3899.6685281750943, 3902.590228026059, 3936.6457018868296, 3444.844981975817, 3911.159100793343, 3916.4921505220555, 3929.410588411761, 3929.9214015719526, 2641.5773476243903, 2868.956965645517, 3074.4004919040794, 3126.687331266855, 3446.672566106216, 4460.77696115193, 4646.9767651161865, 4982.950170498285, 5039.546440820343, 5083.313752643383, 3693.7045036397026, 4551.908961820778, 4559.658025648089, 4559.863204103882, 4566.337881007235, 4438.0014496738295, 4732.881677958044, 4876.634252431082, 5511.696856672881, 5561.749721262553, 3555.1823080691584, 3696.5564132304294, 3726.5528136623507, 3775.377062784637, 3780.6597406233573, 5117.974410127963, 5800.622959507618, 5841.92611622872, 5877.52979761618, 5910.438508341657, 3811.0853395184954, 3816.8473261069803, 3818.0, 3841.1741475582885, 3859.459675645412, 3444.293919746446, 3669.743117981769, 3826.215625796705, 3859.0, 3874.1476875087437, 4387.319965405367, 4407.4050003249795, 4412.985013446861, 4424.0709451015, 4424.33634954753, 4542.545745425431, 5305.946940530623, 5456.61803673747, 5537.750801213955, 5547.362053363834, 1188.9405529723479, 1259.779538580763, 1269.949202031927, 1277.7444511097817, 1279.1877158004734, 720.9711611535585, 753.7337273380664, 830.8130670599188, 854.0690647194588, 867.7483529776295, 4494.73031618104, 4503.820606302778, 4608.769561521911, 4836.879078023007, 5003.173207137956, 4789.6349540380825, 5182.585393168538, 5309.0, 5359.544438722674, 5476.466589354987, 3935.9569714025806, 4360.738355698605, 4551.681382303207, 4599.770011499411, 4867.148249056401, 2364.859801879302, 2878.769698424121, 2904.634821633829, 2914.781391395654, 2921.7078292170613, 4812.374391329105, 4917.451002934135, 5423.430539793344, 5760.625559338713, 5782.3639399666, 4769.734376171291, 5206.323177986913, 5430.239766432624, 5462.426445223274, 5699.857503562361, 4882.829100981519, 5227.503387178212, 5228.555572776357, 5341.4925582069645, 5742.167385729046, 4527.404281576925, 5058.6206034548295, 5462.890742185214, 5537.28015358017, 5559.694216818114, 4569.811848919238, 5171.853680722458, 5466.414739725594, 5480.424555421623, 5485.451454854483, 4939.851804445872, 5204.739763011758, 5271.731526453624, 5738.655680659173, 5781.364049954585, 3177.9353916438254, 3330.6169790473436, 3466.2027733621912, 3633.2551826875956, 3693.5937046925355, 4392.978035109804, 5003.874903127451, 5381.919271210857, 5441.938821929686, 5514.834554963358, 4941.6293777966075, 5394.730263486888, 5405.9459405407015, 5565.0, 5575.0243707351865, 5555.30558680165, 5568.855990443627, 5577.414371491097, 5577.860553486033, 5593.440655934537, 4966.528179822911, 5097.1844504879045, 5162.6386152968935, 5359.383670877899, 5463.0, 4802.6638135330195, 5342.6260161788305, 5547.8890422192135, 5563.360213575329, 5597.496225339739, 4198.769067701306, 4636.582707556201, 5000.599592277141, 5333.813316533902, 5443.836684899459], "value": 3920.008893514426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.1108095682994, 716.5593160206474, 734.6473692627538, 751.2412463411953, 791.1337085890949, 13718.451261949522, 14671.77992330116, 14737.705245895075, 14743.410263589458, 14758.262086895666, 13035.087543871932, 13159.802602960963, 13166.539171129012, 13184.60446186616, 13221.669458263525, 853.4580541356221, 861.7802460372612, 864.01933805131, 871.9171678690515, 876.4346996187455, 888.6623083228365, 889.1153302464057, 889.822035592884, 890.3011136258039, 892.281713220857, 941.5668792355525, 942.4863449420083, 944.8629948657441, 945.5272363818091, 946.1579194516886, 943.9716808495756, 944.3200895355333, 946.195733626412, 946.3186505715873, 946.4132238012442, 699.2972063076626, 699.4544255480682, 699.9405050570707, 700.5446459801119, 703.0368395298423, 14492.130472171599, 14637.975341726084, 14641.560753177422, 14645.926770366186, 15156.0, 13320.600381988555, 13603.982918944821, 13610.251436171007, 13616.319184040858, 13746.0, 9789.987535320719, 11024.834627480594, 11272.544841323106, 11309.264897781617, 11747.823782643267, 3498.3003399320237, 3566.3937130687846, 3577.302426026926, 3712.016315676348, 3723.2925744108534, 96049.5197524015, 98581.50709246407, 98642.0, 99361.99999999927, 99500.50249748777, 9648.95175524132, 9930.255230857714, 10258.58965641366, 10509.106725928228, 10833.02502774754, 20546.178152874018, 20959.0, 21072.789272107388, 21081.472963176042, 21108.261210857545, 7155.391791697764, 7165.856682866313, 7218.783436496913, 7368.336849683555, 7374.151972523121, 3989.261986532501, 4064.5122585289364, 4066.674666026711, 4068.877933661995, 4070.0, 3379.749492687672, 3426.931461370759, 3450.8274586270586, 3452.4130897747445, 3754.3617585010616, 717.8923161525709, 721.2210812322679, 723.5586292361655, 736.8931504931755, 737.2921994884971, 620.4230066038538, 630.9400606942334, 658.2167221006987, 669.1602039440471, 670.3129292475252, 9788.062348005731, 9860.556274967643, 9915.553800079013, 9989.650362237287, 9999.100080992746, 541.8130744893006, 561.6798424897769, 561.9719014049363, 564.2270089976677, 569.2400645138704, 3966.682665386762, 4460.665450091256, 4584.774657184136, 4633.907321853544, 4823.107725070873, 84284.0, 86635.56682216549, 86720.6991895122, 87848.56075719709, 88757.0, 64247.678761605894, 67379.86092711972, 76279.23720762832, 77098.22901771023, 77142.0, 67401.0, 68231.31768682349, 68304.3169568308, 69082.0, 70320.64839675871, 9192.816143677222, 9256.583453744463, 9267.67563135287, 9284.489353085375, 9313.25493960495, 32634.51048234231, 42232.0, 42902.570974289854, 42931.35602965896, 43044.0, 46103.0, 58515.70742146262, 58849.0, 58876.0, 64942.675286623264, 10619.30974486656, 12297.631071067883, 12374.13381063353, 13028.348582570645, 13613.931930340284, 14137.677267935522, 14144.929275353557, 14187.645308866948, 14314.785278220626, 14510.274486275433, 12578.685532861751, 12634.810477842655, 12879.935600322313, 13048.41282142287, 13698.178109313472, 13008.21950682962, 13059.21644701321, 13144.27706476153, 13310.401031953392, 13736.862631373559, 12899.355032248537, 13092.429446020378, 13221.206727596375, 13505.864941350854, 13635.590932272047, 10928.890711092787, 10969.122470202525, 10992.230543861853, 11100.666979990614, 11487.121075874575, 7140.46446516503, 8736.650533978824, 9815.11663950248, 10288.176945844465, 11543.0], "value": 7144.770608670035, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1473.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 138.0, 181.0, 111.0, 113.0, 115.0, 109.0, 133.0, 111.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 186.0, 187.0, 185.0, 229.0, 183.0, 187.0, 184.0], "value": 189.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 60.0, 89.0, 64.0, 59.0, 57.0, 71.0, 97.0, 58.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 86.0, 68.0, 70.0, 70.0, 85.0, 69.0, 69.0, 105.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 88.0, 87.0, 88.0, 87.0, 88.0, 86.0, 88.0, 92.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 96.0, 95.0, 94.0, 96.0, 95.0, 101.0, 145.0, 98.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 85.0, 86.0, 87.0, 87.0, 105.0, 137.0], "value": 92.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 58.0, 56.0, 59.0, 59.0, 58.0, 58.0, 56.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 74.0, 76.0, 73.0, 70.0, 69.0, 69.0, 69.0, 70.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 107.0, 90.0, 88.0, 89.0, 88.0, 90.0, 91.0, 87.0], "value": 92.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 150.0, 132.0, 149.0, 150.0, 152.0, 140.0, 181.0, 158.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 173.0, 181.0, 177.0, 173.0, 174.0, 168.0, 174.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 69.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0], "value": 66.5, "unit": "score"}]}]} 03:21:01 INFO - Return code: 0 03:21:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:01 ERROR - # TBPL SUCCESS # 03:21:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:21:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:21:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:21:01 INFO - 2017-02-15 03:21:01.612 screenresolution[1917:20508] starting screenresolution argv=screenresolution get 03:21:01 INFO - 2017-02-15 03:21:01.614 screenresolution[1917:20508] Display 0: 1600x1200x32@60 03:21:01 INFO - 2017-02-15 03:21:01.621 screenresolution[1918:20511] starting screenresolution argv=screenresolution list 03:21:01 INFO - Available Modes on Display 0 03:21:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:21:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:21:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:21:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:01 INFO - Intel Iris: 03:21:01 INFO - Chipset Model: Intel Iris 03:21:01 INFO - Type: GPU 03:21:01 INFO - Bus: Built-In 03:21:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:01 INFO - Vendor: Intel (0x8086) 03:21:01 INFO - Device ID: 0x0a2e 03:21:01 INFO - Revision ID: 0x0009 03:21:01 INFO - Displays: 03:21:01 INFO - Display: 03:21:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:01 INFO - Display Serial Number: 1600x1200 60 03:21:01 INFO - Main Display: Yes 03:21:01 INFO - Mirror: Off 03:21:01 INFO - Online: Yes 03:21:01 INFO - Rotation: Supported 03:21:01 INFO - Return code: 0 03:21:01 INFO - Running post-action listener: _resource_record_post_action 03:21:01 INFO - [mozharness: 2017-02-15 11:21:01.861890Z] Finished run-tests step (success) 03:21:01 INFO - Running post-run listener: _resource_record_post_run 03:21:01 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 118784; Write bytes: 554454528; Read time: 6; Write time: 1656 03:21:01 INFO - TinderboxPrint: CPU usage
53.7% 03:21:01 INFO - TinderboxPrint: I/O read bytes / time
118,784 / 6 03:21:01 INFO - TinderboxPrint: I/O write bytes / time
554,454,528 / 1,656 03:21:01 INFO - TinderboxPrint: CPU idle
2,226.2 (46.3%) 03:21:01 INFO - TinderboxPrint: CPU system
960.0 (20.0%) 03:21:01 INFO - TinderboxPrint: CPU user
1,623.5 (33.8%) 03:21:01 INFO - TinderboxPrint: Swap in / out
252,416,000 / 0 03:21:01 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250534400; Write bytes: 245811200; Read time: 18071; Write time: 522 03:21:01 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 118784; Write bytes: 297330176; Read time: 6; Write time: 1097 03:21:02 INFO - Running post-run listener: _upload_blobber_files 03:21:02 INFO - Blob upload gear active. 03:21:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:02 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 03:21:02 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'] 03:21:02 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 03:21:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:04 INFO - (blobuploader) - INFO - Done attempting. 03:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:05 INFO - (blobuploader) - INFO - Done attempting. 03:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:05 INFO - (blobuploader) - INFO - Done attempting. 03:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:08 INFO - (blobuploader) - INFO - Done attempting. 03:21:08 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:08 INFO - Return code: 0 03:21:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728e77a218d77d5560f266b182d281d1600a4edbc0d1e62ac0234784516431258aed13fa2bcf39bb87470a051513210694c2ad0583232936c0a6ca547993e6fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed7c4d04b7211ba243ffd79deea5cd679c44872e2531fc326ebe2f9010bdc52c70ff6d68a5c80afbb95fb50b16519115e3786d07fdc86afc21a9dd65c2e6b9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/800739d44b5dfd5683353ddfc56c815731efd91c2cbb2cf2ba451c2a7e9c4259c60c90324989ae28b8d20b0716570d00e3673b2cffb74fa01c62c1f4409aee21", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589924dac510dd86f206dcc02436cf177d349e618fcbd2a716a879e6bc46b479d8bc8994af27f36442e6048c3f86f7d50a0cb1b0e8a0f227d94b521b14651c21"} 03:21:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:08 INFO - Contents: 03:21:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728e77a218d77d5560f266b182d281d1600a4edbc0d1e62ac0234784516431258aed13fa2bcf39bb87470a051513210694c2ad0583232936c0a6ca547993e6fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed7c4d04b7211ba243ffd79deea5cd679c44872e2531fc326ebe2f9010bdc52c70ff6d68a5c80afbb95fb50b16519115e3786d07fdc86afc21a9dd65c2e6b9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/800739d44b5dfd5683353ddfc56c815731efd91c2cbb2cf2ba451c2a7e9c4259c60c90324989ae28b8d20b0716570d00e3673b2cffb74fa01c62c1f4409aee21", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589924dac510dd86f206dcc02436cf177d349e618fcbd2a716a879e6bc46b479d8bc8994af27f36442e6048c3f86f7d50a0cb1b0e8a0f227d94b521b14651c21"} 03:21:08 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:08 INFO - Copying logs to upload dir... 03:21:08 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.892049 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-15 03:21:08.142511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:08.147037) ========= 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.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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/728e77a218d77d5560f266b182d281d1600a4edbc0d1e62ac0234784516431258aed13fa2bcf39bb87470a051513210694c2ad0583232936c0a6ca547993e6fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed7c4d04b7211ba243ffd79deea5cd679c44872e2531fc326ebe2f9010bdc52c70ff6d68a5c80afbb95fb50b16519115e3786d07fdc86afc21a9dd65c2e6b9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/800739d44b5dfd5683353ddfc56c815731efd91c2cbb2cf2ba451c2a7e9c4259c60c90324989ae28b8d20b0716570d00e3673b2cffb74fa01c62c1f4409aee21", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589924dac510dd86f206dcc02436cf177d349e618fcbd2a716a879e6bc46b479d8bc8994af27f36442e6048c3f86f7d50a0cb1b0e8a0f227d94b521b14651c21"} build_url:https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/Dvh6ozqSQ2-qEzACRVEIXw/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/728e77a218d77d5560f266b182d281d1600a4edbc0d1e62ac0234784516431258aed13fa2bcf39bb87470a051513210694c2ad0583232936c0a6ca547993e6fa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed7c4d04b7211ba243ffd79deea5cd679c44872e2531fc326ebe2f9010bdc52c70ff6d68a5c80afbb95fb50b16519115e3786d07fdc86afc21a9dd65c2e6b9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/800739d44b5dfd5683353ddfc56c815731efd91c2cbb2cf2ba451c2a7e9c4259c60c90324989ae28b8d20b0716570d00e3673b2cffb74fa01c62c1f4409aee21", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589924dac510dd86f206dcc02436cf177d349e618fcbd2a716a879e6bc46b479d8bc8994af27f36442e6048c3f86f7d50a0cb1b0e8a0f227d94b521b14651c21"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:08.186305) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:08.186589) ========= 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.DrjwLcMczW/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.ra9T1n3odV/Listeners TMPDIR=/var/folders/94/32rsmpvx6xsdqlj3mz5wd0xr00000w/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.005388 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 03:21:08.241374) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:21:08.242024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 03:21:08.243048) ========= ========= Total master_lag: 0.20 =========