builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0348 starttime: 1491393856.21 results: success (0) buildid: 20170405030213 builduid: 5513eb0b7f1b449db1bac2fa8493c592 revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:16.206184) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:16.206615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:16.206906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:16.335182) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 05:04:16.335473) ========= 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.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-04-05 05:04:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2017-04-05 05:04:16 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134212 ========= master_lag: 3.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 05:04:19.745880) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 05:04:19.746176) ========= 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.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.026928 ========= master_lag: 3.38 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 05:04:23.156096) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 05:04:23.156398) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b043233ec04f06768d59dcdfb9e928142280f3cc --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 b043233ec04f06768d59dcdfb9e928142280f3cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-04-05 05:04:23,263 truncating revision to first 12 chars 2017-04-05 05:04:23,263 Setting DEBUG logging. 2017-04-05 05:04:23,263 attempt 1/10 2017-04-05 05:04:23,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b043233ec04f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 05:04:23,898 unpacking tar archive at: mozilla-central-b043233ec04f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157965 ========= master_lag: 0.47 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 05:04:24.786718) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:24.786986) ========= script_repo_revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:24.787355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:24.787629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 05:04:24.807695) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-05 05:04:24.808082) ========= /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.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:04:25 INFO - MultiFileLogger online at 20170405 05:04:25 in /builds/slave/test 05:04:25 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 05:04:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:25 INFO - {'append_to_log': False, 05:04:25 INFO - 'base_work_dir': '/builds/slave/test', 05:04:25 INFO - 'blob_upload_branch': 'Firefox', 05:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:25 INFO - 'branch': 'Firefox', 05:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:25 INFO - 'config_files': ('talos/mac_config.py',), 05:04:25 INFO - 'default_actions': ('clobber', 05:04:25 INFO - 'read-buildbot-config', 05:04:25 INFO - 'download-and-extract', 05:04:25 INFO - 'populate-webroot', 05:04:25 INFO - 'create-virtualenv', 05:04:25 INFO - 'install', 05:04:25 INFO - 'run-tests'), 05:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:25 INFO - 'download_minidump_stackwalk': True, 05:04:25 INFO - 'download_symbols': 'ondemand', 05:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:25 INFO - 'gecko_profile': False, 05:04:25 INFO - 'gecko_profile_interval': 0, 05:04:25 INFO - 'installer_path': 'installer.exe', 05:04:25 INFO - 'log_level': 'info', 05:04:25 INFO - 'log_name': 'talos', 05:04:25 INFO - 'log_to_console': True, 05:04:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:04:25 INFO - 'opt_config_files': (), 05:04:25 INFO - 'pip_index': False, 05:04:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:25 INFO - 'cmd': ('bash', 05:04:25 INFO - '-c', 05:04:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:25 INFO - 'enabled': True, 05:04:25 INFO - 'halt_on_failure': False, 05:04:25 INFO - 'name': 'check_screen_resolution'},), 05:04:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:04:25 INFO - 'cmd': ('bash', 05:04:25 INFO - '-c', 05:04:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:04:25 INFO - 'enabled': True, 05:04:25 INFO - 'halt_on_failure': False, 05:04:25 INFO - 'name': 'check_screen_resolution'},), 05:04:25 INFO - 'run_cmd_checks_enabled': True, 05:04:25 INFO - 'suite': 'dromaeojs', 05:04:25 INFO - 'system_bits': '32', 05:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:25 INFO - 'title': 't-yosemite-r7-0348', 05:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:25 INFO - 'use_talos_json': True, 05:04:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:25 INFO - 'work_dir': 'build'} 05:04:25 INFO - [mozharness: 2017-04-05 12:04:25.022059Z] Running clobber step. 05:04:25 INFO - Running pre-action listener: _resource_record_pre_action 05:04:25 INFO - Running main action method: clobber 05:04:25 INFO - rmtree: /builds/slave/test/build 05:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:27 INFO - Running post-action listener: _resource_record_post_action 05:04:27 INFO - [mozharness: 2017-04-05 12:04:27.536182Z] Finished clobber step (success) 05:04:27 INFO - [mozharness: 2017-04-05 12:04:27.536377Z] Running read-buildbot-config step. 05:04:27 INFO - Running pre-action listener: _resource_record_pre_action 05:04:27 INFO - Running main action method: read_buildbot_config 05:04:27 INFO - Using buildbot properties: 05:04:27 INFO - { 05:04:27 INFO - "project": "", 05:04:27 INFO - "product": "firefox", 05:04:27 INFO - "script_repo_revision": "production", 05:04:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:04:27 INFO - "repository": "", 05:04:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:04:27 INFO - "buildid": "20170405030213", 05:04:27 INFO - "stage_platform": "macosx64", 05:04:27 INFO - "basedir": "/builds/slave/test", 05:04:27 INFO - "nightly_build": "True", 05:04:27 INFO - "buildnumber": 3, 05:04:27 INFO - "slavename": "t-yosemite-r7-0348", 05:04:27 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:04:27 INFO - "platform": "yosemite_r7", 05:04:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:04:27 INFO - "branch": "mozilla-central", 05:04:27 INFO - "repo_path": "mozilla-central", 05:04:27 INFO - "revision": "b043233ec04f06768d59dcdfb9e928142280f3cc", 05:04:27 INFO - "pgo_build": "False", 05:04:27 INFO - "builduid": "5513eb0b7f1b449db1bac2fa8493c592", 05:04:27 INFO - "slavebuilddir": "test" 05:04:27 INFO - } 05:04:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:04:27 INFO - Running post-action listener: _resource_record_post_action 05:04:27 INFO - [mozharness: 2017-04-05 12:04:27.539868Z] Finished read-buildbot-config step (success) 05:04:27 INFO - [mozharness: 2017-04-05 12:04:27.539985Z] Running download-and-extract step. 05:04:27 INFO - Running pre-action listener: _resource_record_pre_action 05:04:27 INFO - Running main action method: download_and_extract 05:04:27 INFO - mkdir: /builds/slave/test/build/tests 05:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:27 INFO - trying https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:04:27 INFO - Downloading https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:04:28 INFO - Downloaded 1325 bytes. 05:04:28 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:04:28 INFO - Using the following test package requirements: 05:04:28 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:04:28 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:04:28 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:04:28 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:04:28 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'jsshell-mac.zip'], 05:04:28 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:04:28 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:04:28 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:04:28 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:04:28 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:04:28 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:04:28 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:04:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:04:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:04:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:04:28 INFO - Fetch https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:04:30 INFO - Expected file size: 52517991 05:04:30 INFO - Obtained file size: 52517991 05:04:46 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:04:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:04:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:04:46 INFO - Fetch https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:04:48 INFO - Expected file size: 52517991 05:04:48 INFO - Obtained file size: 52517991 05:05:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:05:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:05:03 INFO - Fetch https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:05:04 INFO - Expected file size: 14404152 05:05:04 INFO - Obtained file size: 14404152 05:05:05 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')]} 05:05:05 INFO - trying https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:05:05 INFO - Downloading https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:05:07 INFO - Downloaded 70769078 bytes. 05:05:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:05:07 INFO - mkdir: /builds/slave/test/properties 05:05:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:07 INFO - Contents: 05:05:07 INFO - build_url:https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:05:07 INFO - Running post-action listener: _resource_record_post_action 05:05:07 INFO - Running post-action listener: set_extra_try_arguments 05:05:07 INFO - [mozharness: 2017-04-05 12:05:07.730633Z] Finished download-and-extract step (success) 05:05:07 INFO - [mozharness: 2017-04-05 12:05:07.730806Z] Running populate-webroot step. 05:05:07 INFO - Running pre-action listener: _resource_record_pre_action 05:05:07 INFO - Running main action method: populate_webroot 05:05:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:07 INFO - '--tppagecycles', 05:05:07 INFO - '7'], 05:05:07 INFO - 'tests': ['tsvgm']}}, 05:05:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['damp', 'tps']}, 05:05:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'tests': ['damp', 'tps']}, 05:05:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['dromaeo_dom']}, 05:05:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['basic_compositor_video']}, 05:05:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['a11yr', 05:05:07 INFO - 'ts_paint', 05:05:07 INFO - 'tpaint', 05:05:07 INFO - 'sessionrestore', 05:05:07 INFO - 'sessionrestore_no_auto_restore', 05:05:07 INFO - 'tabpaint']}, 05:05:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['tsvgx', 05:05:07 INFO - 'tsvgr_opacity', 05:05:07 INFO - 'tart', 05:05:07 INFO - 'tscrollx', 05:05:07 INFO - 'cart', 05:05:07 INFO - 'tsvg_static']}, 05:05:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:07 INFO - 'tsvgr_opacity', 05:05:07 INFO - 'tart', 05:05:07 INFO - 'tscrollx', 05:05:07 INFO - 'cart', 05:05:07 INFO - 'tsvg_static']}, 05:05:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'talos_options': ['--disable-e10s'], 05:05:07 INFO - 'tests': ['tp5o']}, 05:05:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:05:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'talos_options': ['--disable-e10s', 05:05:07 INFO - '--xperf_path', 05:05:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:07 INFO - 'tests': ['tp5n']}, 05:05:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:05:07 INFO - 'talos_options': ['--xperf_path', 05:05:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:07 INFO - 'tests': ['tp5n']}}, 05:05:07 INFO - 'talos.zip': {'path': '', 05:05:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:07 INFO - Running post-action listener: _resource_record_post_action 05:05:07 INFO - [mozharness: 2017-04-05 12:05:07.749217Z] Finished populate-webroot step (success) 05:05:07 INFO - [mozharness: 2017-04-05 12:05:07.749352Z] Running create-virtualenv step. 05:05:07 INFO - Running pre-action listener: _resource_record_pre_action 05:05:07 INFO - Running main action method: create_virtualenv 05:05:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:07 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 05:05:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:07 INFO - Using real prefix '/tools/python27' 05:05:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:11 INFO - Installing pip.................done. 05:05:11 INFO - Return code: 0 05:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:05:11 INFO - Reading from file tmpfile_stdout 05:05:11 INFO - Output received: 05:05:11 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) 05:05:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:11 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 05:05:11 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 05:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:11 INFO - 'HOME': '/Users/cltbld', 05:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:11 INFO - 'LOGNAME': 'cltbld', 05:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:11 INFO - 'MOZ_NO_REMOTE': '1', 05:05:11 INFO - 'NO_EM_RESTART': '1', 05:05:11 INFO - 'PAGER': '/bin/cat', 05:05:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:11 INFO - 'PWD': '/builds/slave/test', 05:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:11 INFO - 'SHELL': '/bin/bash', 05:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:11 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:11 INFO - 'USER': 'cltbld', 05:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:11 INFO - 'XPC_FLAGS': '0x0', 05:05:11 INFO - 'XPC_SERVICE_NAME': '0', 05:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:12 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 05:05:12 INFO - Cleaning up... 05:05:12 INFO - Return code: 0 05:05:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:12 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')]} 05:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:12 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')]} 05:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:12 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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:12 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 05:05:12 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 05:05:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:12 INFO - 'HOME': '/Users/cltbld', 05:05:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:12 INFO - 'LOGNAME': 'cltbld', 05:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:12 INFO - 'MOZ_NO_REMOTE': '1', 05:05:12 INFO - 'NO_EM_RESTART': '1', 05:05:12 INFO - 'PAGER': '/bin/cat', 05:05:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:12 INFO - 'PWD': '/builds/slave/test', 05:05:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:12 INFO - 'SHELL': '/bin/bash', 05:05:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:12 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:12 INFO - 'USER': 'cltbld', 05:05:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:12 INFO - 'XPC_FLAGS': '0x0', 05:05:12 INFO - 'XPC_SERVICE_NAME': '0', 05:05:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:12 INFO - Downloading/unpacking psutil>=3.1.1 05:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:16 INFO - Installing collected packages: psutil 05:05:16 INFO - Running setup.py install for psutil 05:05:16 INFO - building 'psutil._psutil_osx' extension 05:05:16 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 05:05:16 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 05:05:16 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 05:05:16 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 05:05:17 INFO - building 'psutil._psutil_posix' extension 05:05:17 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 05:05:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:05:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:05:17 INFO - ^ 05:05:17 INFO - 1 warning generated. 05:05:17 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 05:05:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:17 INFO - Successfully installed psutil 05:05:17 INFO - Cleaning up... 05:05:17 INFO - Return code: 0 05:05:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05:17 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')]} 05:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:17 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')]} 05:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:17 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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:17 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 05:05:17 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 05:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:17 INFO - 'HOME': '/Users/cltbld', 05:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:17 INFO - 'LOGNAME': 'cltbld', 05:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:17 INFO - 'MOZ_NO_REMOTE': '1', 05:05:17 INFO - 'NO_EM_RESTART': '1', 05:05:17 INFO - 'PAGER': '/bin/cat', 05:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:17 INFO - 'PWD': '/builds/slave/test', 05:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:17 INFO - 'SHELL': '/bin/bash', 05:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:17 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:17 INFO - 'USER': 'cltbld', 05:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:17 INFO - 'XPC_FLAGS': '0x0', 05:05:17 INFO - 'XPC_SERVICE_NAME': '0', 05:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:17 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 05:05:17 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 05:05:17 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 05:05:17 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 05:05:17 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 05:05:17 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 05:05:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:20 INFO - Installing collected packages: mozsystemmonitor 05:05:20 INFO - Running setup.py install for mozsystemmonitor 05:05:20 INFO - Successfully installed mozsystemmonitor 05:05:20 INFO - Cleaning up... 05:05:20 INFO - Return code: 0 05:05:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:20 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')]} 05:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:20 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')]} 05:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:20 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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:20 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 05:05:20 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 05:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:20 INFO - 'HOME': '/Users/cltbld', 05:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:20 INFO - 'LOGNAME': 'cltbld', 05:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:20 INFO - 'MOZ_NO_REMOTE': '1', 05:05:20 INFO - 'NO_EM_RESTART': '1', 05:05:20 INFO - 'PAGER': '/bin/cat', 05:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:20 INFO - 'PWD': '/builds/slave/test', 05:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:20 INFO - 'SHELL': '/bin/bash', 05:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:20 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:20 INFO - 'USER': 'cltbld', 05:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:20 INFO - 'XPC_FLAGS': '0x0', 05:05:20 INFO - 'XPC_SERVICE_NAME': '0', 05:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:20 INFO - Downloading/unpacking jsonschema==2.5.1 05:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:23 INFO - warning: no files found matching '*.txt' 05:05:23 INFO - no previously-included directories found matching 'build' 05:05:23 INFO - no previously-included directories found matching 'dist' 05:05:23 INFO - no previously-included directories found matching '.git*' 05:05:23 INFO - Installing collected packages: jsonschema, functools32 05:05:23 INFO - Running setup.py install for functools32 05:05:24 INFO - warning: no files found matching '*.txt' 05:05:24 INFO - no previously-included directories found matching 'build' 05:05:24 INFO - no previously-included directories found matching 'dist' 05:05:24 INFO - no previously-included directories found matching '.git*' 05:05:24 INFO - Successfully installed jsonschema functools32 05:05:24 INFO - Cleaning up... 05:05:24 INFO - Return code: 0 05:05:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:24 INFO - 'HOME': '/Users/cltbld', 05:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:24 INFO - 'LOGNAME': 'cltbld', 05:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:24 INFO - 'MOZ_NO_REMOTE': '1', 05:05:24 INFO - 'NO_EM_RESTART': '1', 05:05:24 INFO - 'PAGER': '/bin/cat', 05:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:24 INFO - 'PWD': '/builds/slave/test', 05:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:24 INFO - 'SHELL': '/bin/bash', 05:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:24 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:24 INFO - 'USER': 'cltbld', 05:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:24 INFO - 'XPC_FLAGS': '0x0', 05:05:24 INFO - 'XPC_SERVICE_NAME': '0', 05:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:24 INFO - Cleaning up... 05:05:24 INFO - Return code: 0 05:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:05:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:24 INFO - 'HOME': '/Users/cltbld', 05:05:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:24 INFO - 'LOGNAME': 'cltbld', 05:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:24 INFO - 'MOZ_NO_REMOTE': '1', 05:05:24 INFO - 'NO_EM_RESTART': '1', 05:05:24 INFO - 'PAGER': '/bin/cat', 05:05:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:24 INFO - 'PWD': '/builds/slave/test', 05:05:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:24 INFO - 'SHELL': '/bin/bash', 05:05:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:24 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:24 INFO - 'USER': 'cltbld', 05:05:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:24 INFO - 'XPC_FLAGS': '0x0', 05:05:24 INFO - 'XPC_SERVICE_NAME': '0', 05:05:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:28 INFO - Downloading docopt-0.6.1.tar.gz 05:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:28 INFO - Running setup.py install for blobuploader 05:05:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:28 INFO - Running setup.py install for requests 05:05:29 INFO - Running setup.py install for docopt 05:05:29 INFO - Successfully installed blobuploader requests docopt 05:05:29 INFO - Cleaning up... 05:05:29 INFO - Return code: 0 05:05:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:29 INFO - 'HOME': '/Users/cltbld', 05:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:29 INFO - 'LOGNAME': 'cltbld', 05:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:29 INFO - 'MOZ_NO_REMOTE': '1', 05:05:29 INFO - 'NO_EM_RESTART': '1', 05:05:29 INFO - 'PAGER': '/bin/cat', 05:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:29 INFO - 'PWD': '/builds/slave/test', 05:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:29 INFO - 'SHELL': '/bin/bash', 05:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:29 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:29 INFO - 'USER': 'cltbld', 05:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:29 INFO - 'XPC_FLAGS': '0x0', 05:05:29 INFO - 'XPC_SERVICE_NAME': '0', 05:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:29 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Zx8D7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:29 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-yxERaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:29 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-eh2Abk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-3Z1PXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-0xKZ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-OgJce1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-pXyrBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-blkz8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-dT402h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-ytpf7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-NAR22Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-gHU7F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-CyIiFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-6naIVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-yRFiwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-FpZXLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-jQZcph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:31 INFO - Running setup.py install for manifestparser 05:05:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:31 INFO - Running setup.py install for mozcrash 05:05:31 INFO - Running setup.py install for mozdebug 05:05:31 INFO - Running setup.py install for mozdevice 05:05:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozfile 05:05:32 INFO - Running setup.py install for mozhttpd 05:05:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozinfo 05:05:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozInstall 05:05:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for mozleak 05:05:32 INFO - Running setup.py install for mozlog 05:05:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:32 INFO - Running setup.py install for moznetwork 05:05:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Running setup.py install for mozprocess 05:05:33 INFO - Running setup.py install for mozprofile 05:05:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Running setup.py install for mozrunner 05:05:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:33 INFO - Running setup.py install for mozscreenshot 05:05:33 INFO - Running setup.py install for moztest 05:05:33 INFO - Running setup.py install for mozversion 05:05:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:34 INFO - Cleaning up... 05:05:34 INFO - Return code: 0 05:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05: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')]} 05:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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')]} 05:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:34 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 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:34 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 05:05:34 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 05:05:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:34 INFO - 'HOME': '/Users/cltbld', 05:05:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:34 INFO - 'LOGNAME': 'cltbld', 05:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:34 INFO - 'MOZ_NO_REMOTE': '1', 05:05:34 INFO - 'NO_EM_RESTART': '1', 05:05:34 INFO - 'PAGER': '/bin/cat', 05:05:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:34 INFO - 'PWD': '/builds/slave/test', 05:05:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:34 INFO - 'SHELL': '/bin/bash', 05:05:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:34 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:34 INFO - 'USER': 'cltbld', 05:05:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:34 INFO - 'XPC_FLAGS': '0x0', 05:05:34 INFO - 'XPC_SERVICE_NAME': '0', 05:05:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-0W9_tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Za1nmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-_B28Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-57JyGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-BXjFr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Cc72LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:34 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-kqVA0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:35 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)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-597dP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-iAn8kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-guRhAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-PwlloC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Aj1_EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-auWQXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-kAMtyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-CekmD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-SyZWO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-8a94UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:38 INFO - Downloading blessings-1.6.tar.gz 05:05:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:38 INFO - Installing collected packages: blessings 05:05:38 INFO - Running setup.py install for blessings 05:05:39 INFO - Successfully installed blessings 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:39 INFO - Reading from file tmpfile_stdout 05:05:39 INFO - Current package versions: 05:05:39 INFO - blessings == 1.6 05:05:39 INFO - blobuploader == 1.2.4 05:05:39 INFO - docopt == 0.6.1 05:05:39 INFO - functools32 == 3.2.3-2 05:05:39 INFO - jsonschema == 2.5.1 05:05:39 INFO - manifestparser == 1.1 05:05:39 INFO - mozInstall == 1.12 05:05:39 INFO - mozcrash == 1.0 05:05:39 INFO - mozdebug == 0.1 05:05:39 INFO - mozdevice == 0.49 05:05:39 INFO - mozfile == 1.2 05:05:39 INFO - mozhttpd == 0.7 05:05:39 INFO - mozinfo == 0.9 05:05:39 INFO - mozleak == 0.1 05:05:39 INFO - mozlog == 3.4 05:05:39 INFO - moznetwork == 0.27 05:05:39 INFO - mozprocess == 0.25 05:05:39 INFO - mozprofile == 0.28 05:05:39 INFO - mozrunner == 6.13 05:05:39 INFO - mozscreenshot == 0.1 05:05:39 INFO - mozsystemmonitor == 0.3 05:05:39 INFO - moztest == 0.8 05:05:39 INFO - mozversion == 1.4 05:05:39 INFO - psutil == 3.1.1 05:05:39 INFO - requests == 1.2.3 05:05:39 INFO - wsgiref == 0.1.2 05:05:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:39 INFO - 'HOME': '/Users/cltbld', 05:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:39 INFO - 'LOGNAME': 'cltbld', 05:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:39 INFO - 'MOZ_NO_REMOTE': '1', 05:05:39 INFO - 'NO_EM_RESTART': '1', 05:05:39 INFO - 'PAGER': '/bin/cat', 05:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:39 INFO - 'PWD': '/builds/slave/test', 05:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:39 INFO - 'SHELL': '/bin/bash', 05:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:39 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:39 INFO - 'USER': 'cltbld', 05:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:39 INFO - 'XPC_FLAGS': '0x0', 05:05:39 INFO - 'XPC_SERVICE_NAME': '0', 05:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c85708e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, '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.0YUlZiXemc/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.IxK88AWR3v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 05:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:05:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:05:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:05:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:05:39 INFO - 'HOME': '/Users/cltbld', 05:05:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:05:39 INFO - 'LOGNAME': 'cltbld', 05:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:39 INFO - 'MOZ_NO_REMOTE': '1', 05:05:39 INFO - 'NO_EM_RESTART': '1', 05:05:39 INFO - 'PAGER': '/bin/cat', 05:05:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:39 INFO - 'PWD': '/builds/slave/test', 05:05:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:05:39 INFO - 'SHELL': '/bin/bash', 05:05:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:05:39 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:05:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:05:39 INFO - 'USER': 'cltbld', 05:05:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:05:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:39 INFO - 'XPC_FLAGS': '0x0', 05:05:39 INFO - 'XPC_SERVICE_NAME': '0', 05:05:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:39 INFO - Cleaning up... 05:05:39 INFO - Return code: 0 05:05:39 INFO - Running post-action listener: _resource_record_post_action 05:05:39 INFO - Running post-action listener: _start_resource_monitoring 05:05:39 INFO - Starting resource monitoring. 05:05:39 INFO - [mozharness: 2017-04-05 12:05:39.953831Z] Finished create-virtualenv step (success) 05:05:39 INFO - [mozharness: 2017-04-05 12:05:39.954796Z] Running install step. 05:05:39 INFO - Running pre-action listener: _resource_record_pre_action 05:05:39 INFO - Running main action method: install 05:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:40 INFO - Reading from file tmpfile_stdout 05:05:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:40 INFO - Reading from file tmpfile_stdout 05:05:40 INFO - Output received: 05:05:40 INFO - Usage: mozinstall [options] installer 05:05:40 INFO - Options: 05:05:40 INFO - -h, --help show this help message and exit 05:05:40 INFO - -d DEST, --destination=DEST 05:05:40 INFO - Directory to install application into. [default: 05:05:40 INFO - "/builds/slave/test"] 05:05:40 INFO - --app=APP Application being installed. [default: firefox] 05:05:40 INFO - mkdir: /builds/slave/test/build/application 05:05:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:05:59 INFO - Reading from file tmpfile_stdout 05:05:59 INFO - Output received: 05:05:59 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:05:59 INFO - Running post-action listener: _resource_record_post_action 05:05:59 INFO - [mozharness: 2017-04-05 12:05:59.673049Z] Finished install step (success) 05:05:59 INFO - [mozharness: 2017-04-05 12:05:59.673193Z] Running run-tests step. 05:05:59 INFO - Running pre-action listener: _resource_record_pre_action 05:05:59 INFO - Running main action method: run_tests 05:05:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:59 INFO - 2017-04-05 05:05:59.687 screenresolution[1630:7838] starting screenresolution argv=screenresolution get 05:05:59 INFO - 2017-04-05 05:05:59.690 screenresolution[1630:7838] Display 0: 1600x1200x32@60 05:05:59 INFO - 2017-04-05 05:05:59.696 screenresolution[1631:7840] starting screenresolution argv=screenresolution list 05:05:59 INFO - Available Modes on Display 0 05:05:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:59 INFO - Intel Iris: 05:05:59 INFO - Chipset Model: Intel Iris 05:05:59 INFO - Type: GPU 05:05:59 INFO - Bus: Built-In 05:05:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:59 INFO - Vendor: Intel (0x8086) 05:05:59 INFO - Device ID: 0x0a2e 05:05:59 INFO - Revision ID: 0x0009 05:05:59 INFO - Displays: 05:05:59 INFO - Display: 05:05:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:59 INFO - Display Serial Number: 1600x1200 60 05:05:59 INFO - Main Display: Yes 05:05:59 INFO - Mirror: Off 05:05:59 INFO - Online: Yes 05:05:59 INFO - Rotation: Supported 05:05:59 INFO - Return code: 0 05:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:59 INFO - Python 2.7.3 05:05:59 INFO - Return code: 0 05:05:59 INFO - grabbing minidump binary from tooltool 05:05:59 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')]} 05:05:59 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 0x104b0ad30>, '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 0x104a31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104affbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:59 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 05:05:59 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 05:05:59 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 05:06:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:00 INFO - Return code: 0 05:06:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:06:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:00 INFO - ENV: RUST_BACKTRACE is now 1 05:06:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:06:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--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 05:06:00 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0348 --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 05:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0YUlZiXemc/Render', 05:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:06:00 INFO - 'HOME': '/Users/cltbld', 05:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:06:00 INFO - 'LOGNAME': 'cltbld', 05:06:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:00 INFO - 'MOZ_NO_REMOTE': '1', 05:06:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:00 INFO - 'NO_EM_RESTART': '1', 05:06:00 INFO - 'PAGER': '/bin/cat', 05:06:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:00 INFO - 'PWD': '/builds/slave/test', 05:06:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:06:00 INFO - 'RUST_BACKTRACE': '1', 05:06:00 INFO - 'SHELL': '/bin/bash', 05:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IxK88AWR3v/Listeners', 05:06:00 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 05:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:06:00 INFO - 'USER': 'cltbld', 05:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:00 INFO - 'XPC_FLAGS': '0x0', 05:06:00 INFO - 'XPC_SERVICE_NAME': '0', 05:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:06:00 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--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 05:06:00 INFO - mozversion application_buildid: 20170405030213 05:06:00 INFO - mozversion application_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 05:06:00 INFO - mozversion application_display_name: Nightly 05:06:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:00 INFO - mozversion application_name: Firefox 05:06:00 INFO - mozversion application_remotingname: firefox 05:06:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:06:00 INFO - mozversion application_vendor: Mozilla 05:06:00 INFO - mozversion application_version: 55.0a1 05:06:00 INFO - mozversion platform_buildid: 20170405030213 05:06:00 INFO - mozversion platform_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 05:06:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:06:00 INFO - mozversion platform_version: 55.0a1 05:06:00 INFO - using testdate: 1491393960 05:06:00 INFO - actual date: 1491393960 05:06:00 INFO - starting webserver on 'localhost:49248' 05:06:00 INFO - SUITE-START | Running 2 tests 05:06:00 INFO - TEST-START | dromaeo_css 05:06:00 INFO - operating with platform_type : mac_ 05:06:00 INFO - Initialising browser for dromaeo_css test... 05:06:00 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpkuUXcM/profile http://localhost:49248/getInfo.html) 05:06:03 INFO - PID 1641 | __metrics Screen width/height:1600/1200 05:06:03 INFO - PID 1641 | colorDepth:24 05:06:03 INFO - PID 1641 | Browser inner width/height: 1024/689 05:06:03 INFO - PID 1641 | __metrics 05:06:03 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:06:03 INFO - PID 1641 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:04 INFO - TEST-INFO | 1641: exit 0 05:06:04 INFO - Browser initialized. 05:06:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:04 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpkuUXcM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:16 INFO - PID 1644 | RSS: Main: 239546368 05:06:16 INFO - PID 1644 | 05:09:21 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 05:09:23 INFO - PID 1644 | RSS: Main: 380350464 05:09:23 INFO - PID 1644 | 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:11:05 INFO - PID 1644 | 05:11:05 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:11:05 INFO - PID 1644 | Full stack: 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:11:05 INFO - PID 1644 | 05:11:05 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:11:05 INFO - PID 1644 | Full stack: 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:11:05 INFO - PID 1644 | 05:11:05 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:11:05 INFO - PID 1644 | Full stack: 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | ************************* 05:11:05 INFO - PID 1644 | A coding exception was thrown and uncaught in a Task. 05:11:05 INFO - PID 1644 | 05:11:05 ERROR - PID 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:11:05 INFO - PID 1644 | Full stack: 05:11:05 INFO - PID 1644 | ************************* 05:12:25 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 05:12:26 INFO - PID 1644 | RSS: Main: 365600768 05:12:26 INFO - PID 1644 | 05:15:28 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 05:15:29 INFO - PID 1644 | RSS: Main: 340140032 05:15:29 INFO - PID 1644 | 05:18:31 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 05:18:32 INFO - PID 1644 | RSS: Main: 326946816 05:18:32 INFO - PID 1644 | 05:21:36 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 05:21:36 INFO - PID 1644 | RSS: Main: 338018304 05:21:36 INFO - PID 1644 | 05:24:39 INFO - PID 1644 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 05:24:40 INFO - PID 1644 | RSS: Main: 537272320 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | __start_tp_report 05:24:40 INFO - PID 1644 | _x_x_mozilla_page_load 05:24:40 INFO - PID 1644 | _x_x_mozilla_page_load_details 05:24:40 INFO - PID 1644 | |i|pagename|runs| 05:24:40 INFO - PID 1644 | |0;dojo.html;3461.5846098468187;3465.948010779837;3477.5479187705596;3504.3341765064642;3526.4710293455996;6000.789972350969;6092.990978487157;6239.6880155992185;6248.781292654758;6266.749330026799;6108.099244189802;6125.327021303102;6214.06788981653;6216.84457888553;6218.12946187533;4884.609231261508;5202.7658755355915;5290.894182116355;5363.785448582052;5461.5357694596005;5392.2181283713835;5431.4840090191365;5434.945650543484;5440.809571664992;5448.264484294629;5202.479752024786;5285.418603953562;5292.603054770869;5330.200469929503;5418.620696551243;5319.707416092114;5370.9731451342495;5371.328583927009;5435.42927992563;5448.482394172547;5331.973340133313;5337;5339.225812257201;5356.785728570852;5427.402985671573;5998.25021872266;6047.78832740852;6177.356007894892;6178.752849886044;6240.344763799826;6326.557141000132;6453.83865403364;6566.376194261586;6569.704363303663;6570.605763654196;6660.367265109807;6671.93328066718;6672.666366681695;6687.030380594835;6689.565178263398;6154.7230374633245;6300.590461620026;6304.243490781136;6318;6323.81028569139;5836.328822185418;6531.640759758259;6631.469482441393;6727.899081513781;6859.828504287433;5497.752601132958;6400.679966001681;6402.743890244431;6451.064595633607;6460.580062295936;5464.562834973192;6631.502637302222;6633.668316584151;6641.236257830411;6670.866582668319;6287.937120628827;6319.273283572448;6525.738970441129;6531.0529973153625;6536.346365363521;5576.776928922879;6471;6519.348065193442;6572.178477690289;6583.80248592543;5299.099153143975;5299.920501192485;5302.072137376021;5305.65513241638;5315.309009828775;4658.883527911829;4691.7888695008805;4706.976465117721;4718.339432479455;4769.618430525619;6234.064890266496;6244.687765611701;6245.594036387621;6248.218972628421;6252;5751.309842818889;6386.137871387304;6594.670266486753;6682.665866706645;6707.0610114584;6364.904526432108;6374.713137908805;6375.521835862329;6379.936200638027;6384.968075159594;5815.389384114692;5851.428571428572;5861.032929566573;5866.208061911672;5908.527317814564;6554.901676474761;6662.433693136138;6663.433608143168;6799.966000169968;6827.01008353776;6660.200775906728;6707.061011458497;6708.664566771544;6725.9663701681175;6750.696218670073;6873.175218973755;6886.655667216519;6887.827804304932;6898.586084834926;6899.448044156556;6265.843353916189;6339.96830015847;6453.193350831146;6488.610683359014;6490.772822951174;6471.902921456276;6529.379708927644;6529.444997175104;6605.603663780189;6617.338266173344;6378.107065010995;6388.744450221939;6390.073439351175;6392.968035159794;6402.071699603624;6243.43809057187;6289.465395441439;6377.362263773585;6383.744650214126;6394.104825324552;5884.529237661062;6249.78125765596;6254.21822272216;6282.434580887742;6287.434130928238;6380.553361264667;6414.775482858077;6418.679066046586;6424.710888009958;6427.55007149495;6265;6308.179936608211;6310.905336420049;6321.5258855586935;6331.335209803088 05:24:40 INFO - PID 1644 | |1;ext.html;722.7578761115026;764.5030730025483;822.4571782623468;1136.852209212802;1157.8842115788416;28542.28644283894;31060.689393106062;38328.23343533131;39028.99999999996;39029.21941561174;41062.58937410625;41414.96462588437;41509.58490415095;41557.58442415575;41579;8516.31869450444;8667.95666021669;8677.913220867773;8688.261497772697;8724.607392667345;6128.172696685935;6308.653024083674;8670.436421632605;8897.976732675761;8898.688545900895;8680.479171249714;8765.211130998208;8787.121287871194;8787.989381221178;8809.251213646849;8676.999999999969;8736.912630873674;8753.99329077158;8755.343349248831;8803.075677053945;8596.140385961417;8632.309415246766;8644.222020018165;8652.005019422784;8666.480011199284;39504.40743388851;39556.82437465938;39667.20665586701;39778.60221397807;39938.60061399378;3492.59835118962;3528.929421411583;3530.5586801649793;3537.2218112015316;3542.8405721742583;30689.69310306913;30810.84594577013;30873.845630771928;30911.07266782;30925.22686932822;3093.1184612385364;3117.1427857339413;3135.498320268746;3145.418097651942;3157.715805577509;259980;337275;337321;337518;337878.3106084478;50499;50785.20681362486;50882.745586271834;50962.49037509652;50994.72513187126;53893.191602126;53913;53997.92004159895;54023.729881350344;54051;13980;14396.712065758626;14400.711985760227;14401.639959000899;14428.567142985727;11667.299962002136;11673.066154707603;11673.241239319586;11692.47383867728;11746.119041071954;10630.149588032938;10860.294080884718;10883.67348979532;10896.564137434572;10897.891021089688;4836.854894353175;4875.731834749052;5295.749306544703;5451.672899626035;5467.425920278393;928.5218112671979;976.99023009769;984.5913945712592;985.8022502659303;1017.730301470111;24364.390890227533;24373.29734323075;24387;24410.633840492406;24423.023079076993;1085.4572713643179;1087.429099722652;1088.7169335972546;1125.4879030041475;1137.5222406589253;9911.603535858629;11808.232464889754;12464.81302780459;12487.938525225458;12491.812622810665;435653;440356;441528.79235603614;441746;442152;55632.443675562725;55718;55743.721281394144;55815.60460988508;55870.441295587334;1477.2023107522032;1506.5028540581582;1511.2972467802306;1516.5071351810705;1538.100211376335;23790.048398063882;26912.461750765266;28917.132486025454;28938.84244630191;29763.55354669725;51741;51888.443346699656;51945.740271298404;51961.96076078533;52179.47820521746;400952;401242;401660;402177;402291;32418.83790581032;32787.672123279415;33118.5032224512;33852.83073584616;33871;43317;43921.78039109784;44678.553214467436;44714.776426118966;44771.880702982686;28668.856655716587;29811.850940745157;30565.388692225588;30844.38311233718;31011;28578;29214.853925730236;30005.249868753457;30241.546376804807;30617.23456913595;34876.30247394987;35310.47034294539;35814.64185358113;36292.09269768277;36295.818520907225;30107.096787095546;30176.54735179018;31062.53406198954;31259.341461342116;31288.843555782074;23908.282751517483;23957.640635390133;23960.40098997539;24233.151839685528;24478.87760561257 05:24:40 INFO - PID 1644 | |2;jquery.html;386.0503162220936;428.8677890369423;437.5187293976625;441.62682533259397;456.0821744564108;17950.640987180264;21675.783242167574;22346.21788237412;23212.41968950777;23404.54252303505;22769.203077892278;23306;23404.180853670125;23731.406714832137;23770.40573985647;5454.181872719084;6050.939490605082;6058.6061905976085;6214.440700336969;6279.183706118199;6112.908306375408;6240.282367527724;6249.656268905208;6259.99840025596;6263.530235232353;5457.727113644321;6199.504039676837;6241.500679945593;6248.562600617958;6268;5981.431763982415;6123.908141377883;6135.631862088289;6195.783147589836;6206.317305096436;5499.780008799643;5509.256250406184;5509.421510741355;5509.559235261169;5510.421405752379;26952.59571106435;27183.320416989536;27665.446691066067;28612.284692882637;29125.708742912513;2135.5622097470136;2178.6949827024227;2225.63277059285;2226.3877433705698;2226.610343189935;17619.647607047915;17973;18172.90913545437;18173.091345432807;18389.90805045966;2092.5187206942337;2105.2421128393767;2116.3333549931876;2117.1637203304763;2118.269197127004;139654;144573;146584.99999999892;146931.53068469392;148596.2570187142;11230;11594.05802027298;11692.064634829194;12113.515459381702;12124.333161676192;14960.251987400587;16068.919655401649;16429.67140657204;16590.50228493147;16629.334826607042;7702.114256860533;8615.870761938577;8825.646974121091;8900.243479304203;9080.091990800867;8484.19400156984;8491.278241349431;8500.44747091437;8649.740507784776;8677.479351238946;7633.198514156044;7778.377729781604;7782.2995930365405;7788.376929845599;7812.765617031499;2053.4968932611605;2064.6386882295537;2068.079704531499;2071.2854065347433;2233.1848875160777;907.5598334807613;908.42315129893;921.953902304882;943.3208090175063;947.7109481608176;18743;19394.5151371214;20102.69845952312;20180.798192017894;20380.898095509427;881.3037700216885;947.8341290274175;967.6081187119228;988.8714467119372;990.9454979976026;8768.868466973001;9654.951725241328;10487;10493.370397776158;10565.683029509128;629343;667794;679341;690581;690896;102107;131159.4094206698;132181;135011.32494337467;135571;1162.203890335123;1184.9170558060853;1197.22180582622;1206.2280140710127;1207.8912897839236;16807.579810504834;17478.30086796565;17689.38087166943;18077.819221807615;18214.54103695984;49400;58960.70519647374;59923;59964.700176500584;60650;79073;79557.60221198857;80013;81659;81885.59057204676;8429.704960326604;8547.188017138362;8594.097619749837;8615.526146061777;8693.782655433664;13159.60521184366;13293.601191964257;13447.932760336136;13481.932590336986;13492.325383730971;10123.835758887823;11224.831627525757;11262.605808796652;11495.77008459843;11582.305061696325;10387.324823886423;10556.788864222826;10572.524236409534;10834.837477438003;10837.783244335227;11591.942040289745;11768;11821.172517923662;11851.466683999413;11898.821517677416;8385.95807020961;8440.324774017941;8445.746627601182;8450.112738162405;8490.9621690795;9322.627094916128;11047.447627618747;11419.371934543347;11428.085753139896;11511.42442877836 05:24:40 INFO - PID 1644 | |3;mootools.html;1363.8499765025847;1420.5439424589795;1444.0108525659928;1444.862738039886;1458.3801884199213;10640.733981650454;11045.668629941094;11079.667609971704;11083.168762342826;11090.057345125673;10847.837282440769;11307.604233851816;11319.547218111265;11322.886771132286;11358.03456706179;2449.9510009799747;2500.4249022724784;2503.6244563315468;2504.536660717764;2509.6611957385703;2061.7628972668185;2337.742848286687;2408.6868707068056;2457.7910877575428;2458.91393801217;1992.9536993078605;2111.546017606222;2147.9785202147937;2415.130553000918;2417.7098748150247;2413.4690368118986;2424.248482970285;2426.0780903256828;2426.7694569015916;2437.9878100609562;2393.317904397256;2423.866687332196;2424.478737071538;2426.0417135231482;2430.064425196312;11045.447727613588;11212.495437705324;11218.27081239725;11221.102311815035;11247.381394023325;6205.689715514206;6434.260060093103;6437.83905402364;6441.871162576722;6446.871062578769;3797.1266608680157;3989.580477104456;4075.8981025474304;4135.462389889295;4142.813573389205;1122.4107343644653;1181.80500217464;1214.1015648420193;1223.4188760338857;1262.4129779652505;15255.313510892036;15329;15333.156676382794;15336.309866056054;15372.846271537253;5116.437191908887;5285.894282114413;5393.8112166074;5395.595330350239;5399.271098401744;11549;11551.826722599168;11560.884391155982;11565.306081635128;11574.421278936019;6288.182536270256;6298.937010629927;6301;6304.873902521924;6305.139983704818;5769.307683078057;5893.116032595145;5947.910781338283;6031.155638210654;6044.425779550936;3515.7187425005936;3578.5169002184894;4038.495188101487;4192.601702838226;4248.426462427595;1262.3120399382358;1263.3241215949422;1263.7977923532192;1283.3839756916732;1285.3265208366574;573.8078773522418;724.995880705227;735.8123678462065;755.4107795919192;787.2796391301895;6369;6437.130987316652;6538.1500404948;6598.274189839114;6662.533622646368;563.2818156849967;586.7301041520948;596.7284885377143;603.4900509069829;694.7464175575878;3941.921161576752;4070.409790580349;4146.979265103655;4182.790860456965;4353.151135528541;11822.822657660143;13681.931590341985;14391.208483533506;14422.206778627276;14427.711445771236;14145.646358841112;14159.362828672734;14204.076735012191;14363.56909292723;14389.78415323771;10257.640982565574;10546.998035186645;10605.734856628646;10606.621139251847;10624.468776561142;4641.907161856677;6616.816450571396;6644.900326495203;6784.626845523544;6851.760188393382;12495.187812792139;12534.435950382072;12796.680082998;12799.80800288015;12827.42276597574;12722.936385318015;13187.736245275233;13215.867841321848;13218.339083045617;13252.668683282995;7475.36459400957;9319;9335.206507446672;9336.859947100664;9345.766355840886;9963.850542241727;10130.037646423578;10180.185585153022;10268.589256429957;10288.948555257175;8505.95747021261;8648.610812513327;8663.176998185414;8895.154960278764;8902.643894244158;8315.168483151878;8606.913930860612;8660.78348041304;8669.306455483673;8674;7596.772096837104;7673.386129109546;7738.961305193438;7803.609819509115;7809;5723.570732195185;5882.470577648032;5883.441073098049;5948.345681974893;5989.371116032754;4896.608271338213;5817.563682723728;5918.697886464971;5957.91063134062;6029.668368239789 05:24:40 INFO - PID 1644 | |4;prototype.html;337.868231389758;385.3064483928927;393.3058152361081;397.46540902486146;398.50585274259925;5901.32134804497;5936.643801371921;5956;5965.612235204709;5974.731137098841;5036.445990940993;5371.274877891484;5492.846502234525;5835.970820145904;5860;3929.5657085163853;4211.347241177622;4449.599536041764;4451.176532341511;4491.842785502508;4441.600255976961;4461.442319710036;4470.508244093147;4483.170613436525;4494.865154045384;4097.119119389331;4300.440942677447;4428.136513379892;4431.822727090913;4435.401220835194;4237.025484138635;4249.851255206053;4303.074838909633;4314.870553883388;4316.956830431687;3722.4602432647384;3747.4191500317493;3749.3813520769313;3756.0609847538117;3758.642928921748;5351.357837059539;5671.914921276184;5707.573106723319;5719.399463056361;5738.254026976508;5042.495750424965;5061.886384995295;5066.974665126688;5097;5121.385433747974;5244.190754189798;6071.998120310143;6187.381261873822;6200.193974783295;6217.222847144107;3251.837408129584;4121.775180440043;4188.769617671027;4195.160967806421;4215.957840421618;6301.6219026858535;6399.8080057598345;6470.385313395267;6538.6730663467115;6649.534532582721;4192.876307151192;4267.698352002669;4271.423357846713;4282.721623094489;4296.720713153635;4344.219699392392;4352.368906508602;4354.368616550582;4360.454943132108;4373;4429.889252768642;4744.8375148088935;4840.370751802243;4992.8751781205765;5039.420466646309;5072.365954255718;6134.263888333428;6196.132541444112;6254.778788923708;6303.684815759194;1261.4512686981009;1270.371166272701;1460.0582624207327;1473.4455149816831;1475.3066058952274;963.7879666473365;974.8050389922043;977.9902200978041;987.0820137272262;987.6493844685033;5290.709011004432;5306.522412982773;5562.637153897321;5708.571857110734;5880.382559831241;5626.634268772516;6026.258052586063;6487.6756162191705;6493.25327587324;6507.967460162668;5562.499375056264;5566.272526462086;5900;5934.347221805598;5942.533848452844;3339.231976645385;3362.680545348188;3385.1875549867855;3385.610654774683;3402.2988505747126;6394.26465956421;6752.3922846944015;6755.256921738604;6794.45644348451;6812.931870681329;6143.784967526115;6463.9334509806295;6739.966300168468;6748.358905903931;6763.560368576125;6041.426064523863;6179.598326108789;6371.585846919936;6650.467962562983;6760.335368595654;6462.256840463407;6570.211574611078;6577.243616983917;6581.934180658323;6668.266490685924;6123.84690382744;6385.744570217139;6443.903341449975;6454.451371633464;6474.870502589828;5702.37273899879;6375.139356186855;6550;6571.967140164268;6731.52879298464;4492.303692927601;4523.208438523311;4535.773211339354;4644.58198762113;4680.251159814414;5263.9210411844615;5521.337439507124;6380.808575742735;6514.771982980573;6549.96725016391;6123.775244951116;6204.5036397089025;6272.114827179366;6273.647382231663;6304.905426418516;4968.378952630921;6192.287886892885;6273.306207323905;6280.780172694116;6295.622262664255;5063.974680126576;5835.2122463466885;6014.789482368096;6156.322804491413;6162.414570615784;6287.748490060347;6299.748010079546;6303.4642055423965;6311.96844015777;6312.526560508072;5247.475252474722;5846.4799152219875;5925.288965324189;6100.511959043177;6116.26604807426 05:24:40 INFO - PID 1644 | |5;yui.html;813.4712436916008;813.6379311206512;827.6441130313966;844.8141408890042;850.5959669157149;13830.170189788607;16300.510984670478;16367.918160409212;16389.18054097295;16389.836101638994;13507.411995045351;14095.083819551723;14682.486112986047;14840.406383744637;14853.257337133155;988.629264025992;1002.3484734922285;1016.7305663999047;1019.9286049976505;1020;999.9050090241416;1001.6594357918307;1001.7595777013537;1002.3584905660383;1005.15566923784;1077.4397313397028;1081.5457507846722;1082.2640604389012;1082.826747720365;1086.1419478611888;1075.4891426572356;1076.3488089705693;1080.7460246841986;1082.1451053667593;1082.4533610526712;797.4656979823532;799.0890384961149;801.9157988411249;803.5419810707899;810.0441479054713;13877.930610346884;14048.43806247749;14593.124412535175;14742.189179595118;14837.925810370987;11823.586174483851;11903.523859045628;11990.400479975966;11999.46002429884;12229.571964981184;11813.468393922294;12455;12554.937225313906;12556.811647825198;12560.43478043481;3231.96768032319;3263.9836800816083;3269.8038117713013;3307.7849939753837;3310.966890331114;89830;113228;113546;113992;115502;9051.094890510896;9085.591148398338;9216.677416290531;9283.48940808262;9488.00375960528;20204.494887627632;20394;20512.79487205139;20562.28032018872;20836.895815520824;6596.7315921130885;7649.38804895607;7845.882311765328;7891.408144389079;8102.797430064295;4097.221527909747;4209.431726716854;4214.831406743757;4221.261279276115;4221.282381995007;4085.611866872642;4167.166566686614;4195.077083041726;4197.349410841324;4198.874033778991;778.2995304226129;828.5318794880873;847.635516727813;882.373514804496;942.1473566422399;619.1363048547341;627.1314229791681;642.4410762636443;651.4397618048474;661.4311691944923;9195.494247816301;9710.126088652056;9930.547637578677;10394.324368915995;10452.790944181226;605.276694350256;614.1878382870173;620.5190976992776;630.3129588748286;654.0548906829681;4404.625606823456;4525.818967241274;4528.388667529841;4566.1552612766745;4609.654275929319;98638.52042219373;99341.50329248307;99958;103768;106061;72231.6388418065;88929.55535222283;90131;90802;91885.54057229671;51158.74420627873;80042.19957800464;80448.59775701084;81204.59397702974;83412.58293708492;9018.684346047858;9061.954690226507;9093.727188184364;9148.862767058632;9163.221126204347;37481;38721.41917871178;39084.41373379459;39154.4126838092;40141.1971760569;51460.22809657933;51554;51760.22359664533;52641.7367913158;52649.21026184687;11652.53389864396;11761.529538818351;11882.28706277626;12239.32683702405;12324.938375308066;12696.936515317364;12751.553695620609;12873.356332183166;13224.867751322749;13277.800832987707;10155;11435.313881166823;12129;12155.513779449077;12327.383630818602;11579.247348922294;11598.11798480839;11720.413979301171;11797.410129493319;12229.816552751538;11138.33170009802;11610.6516804496;11625.18623696367;11633.41832908368;12025.63923082309;8572.05707372176;8593.69922052725;8678.78303042429;8701.738947831574;9096.181343678836;8214.424990250625;8868.600912959062;8884.511351875708;10052.095311422006;10182.847257291294 05:24:40 INFO - PID 1644 | __end_tp_report 05:24:40 INFO - PID 1644 | __start_cc_report 05:24:40 INFO - PID 1644 | _x_x_mozilla_cycle_collect,1549 05:24:40 INFO - PID 1644 | __end_cc_report 05:24:40 INFO - PID 1644 | __startTimestamp1491395080006__endTimestamp 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | ------- Summary: start ------- 05:24:40 INFO - PID 1644 | Number of tests: 6 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#0] dojo.html Cycles:165 Average:6057.94 Median:6304.24 stddev:705.54 (11.2%) stddev-sans-first:677.67 05:24:40 INFO - PID 1644 | Values: 3461.6 3465.9 3477.5 3504.3 3526.5 6000.8 6093.0 6239.7 6248.8 6266.7 6108.1 6125.3 6214.1 6216.8 6218.1 4884.6 5202.8 5290.9 5363.8 5461.5 5392.2 5431.5 5434.9 5440.8 5448.3 5202.5 5285.4 5292.6 5330.2 5418.6 5319.7 5371.0 5371.3 5435.4 5448.5 5332.0 5337.0 5339.2 5356.8 5427.4 5998.3 6047.8 6177.4 6178.8 6240.3 6326.6 6453.8 6566.4 6569.7 6570.6 6660.4 6671.9 6672.7 6687.0 6689.6 6154.7 6300.6 6304.2 6318.0 6323.8 5836.3 6531.6 6631.5 6727.9 6859.8 5497.8 6400.7 6402.7 6451.1 6460.6 5464.6 6631.5 6633.7 6641.2 6670.9 6287.9 6319.3 6525.7 6531.1 6536.3 5576.8 6471.0 6519.3 6572.2 6583.8 5299.1 5299.9 5302.1 5305.7 5315.3 4658.9 4691.8 4707.0 4718.3 4769.6 6234.1 6244.7 6245.6 6248.2 6252.0 5751.3 6386.1 6594.7 6682.7 6707.1 6364.9 6374.7 6375.5 6379.9 6385.0 5815.4 5851.4 5861.0 5866.2 5908.5 6554.9 6662.4 6663.4 6800.0 6827.0 6660.2 6707.1 6708.7 6726.0 6750.7 6873.2 6886.7 6887.8 6898.6 6899.4 6265.8 6340.0 6453.2 6488.6 6490.8 6471.9 6529.4 6529.4 6605.6 6617.3 6378.1 6388.7 6390.1 6393.0 6402.1 6243.4 6289.5 6377.4 6383.7 6394.1 5884.5 6249.8 6254.2 6282.4 6287.4 6380.6 6414.8 6418.7 6424.7 6427.6 6265.0 6308.2 6310.9 6321.5 6331.3 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#1] ext.html Cycles:180 Average:53091.18 Median:19678.74 stddev:103731.73 (527.1%) stddev-sans-first:103948.21 05:24:40 INFO - PID 1644 | Values: 722.8 764.5 822.5 1136.9 1157.9 28542.3 31060.7 38328.2 39029.0 39029.2 41062.6 41415.0 41509.6 41557.6 41579.0 8516.3 8668.0 8677.9 8688.3 8724.6 6128.2 6308.7 8670.4 8898.0 8898.7 8680.5 8765.2 8787.1 8788.0 8809.3 8677.0 8736.9 8754.0 8755.3 8803.1 8596.1 8632.3 8644.2 8652.0 8666.5 39504.4 39556.8 39667.2 39778.6 39938.6 3492.6 3528.9 3530.6 3537.2 3542.8 30689.7 30810.8 30873.8 30911.1 30925.2 3093.1 3117.1 3135.5 3145.4 3157.7 259980.0 337275.0 337321.0 337518.0 337878.3 50499.0 50785.2 50882.7 50962.5 50994.7 53893.2 53913.0 53997.9 54023.7 54051.0 13980.0 14396.7 14400.7 14401.6 14428.6 11667.3 11673.1 11673.2 11692.5 11746.1 10630.1 10860.3 10883.7 10896.6 10897.9 4836.9 4875.7 5295.7 5451.7 5467.4 928.5 977.0 984.6 985.8 1017.7 24364.4 24373.3 24387.0 24410.6 24423.0 1085.5 1087.4 1088.7 1125.5 1137.5 9911.6 11808.2 12464.8 12487.9 12491.8 435653.0 440356.0 441528.8 441746.0 442152.0 55632.4 55718.0 55743.7 55815.6 55870.4 1477.2 1506.5 1511.3 1516.5 1538.1 23790.0 26912.5 28917.1 28938.8 29763.6 51741.0 51888.4 51945.7 51962.0 52179.5 400952.0 401242.0 401660.0 402177.0 402291.0 32418.8 32787.7 33118.5 33852.8 33871.0 43317.0 43921.8 44678.6 44714.8 44771.9 28668.9 29811.9 30565.4 30844.4 31011.0 28578.0 29214.9 30005.2 30241.5 30617.2 34876.3 35310.5 35814.6 36292.1 36295.8 30107.1 30176.5 31062.5 31259.3 31288.8 23908.3 23957.6 23960.4 24233.2 24478.9 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#2] jquery.html Cycles:180 Average:38566.00 Median:23750.91 stddev:112096.28 (472.0%) stddev-sans-first:112374.08 05:24:40 INFO - PID 1644 | Values: 386.1 428.9 437.5 441.6 456.1 17950.6 21675.8 22346.2 23212.4 23404.5 22769.2 23306.0 23404.2 23731.4 23770.4 5454.2 6050.9 6058.6 6214.4 6279.2 6112.9 6240.3 6249.7 6260.0 6263.5 5457.7 6199.5 6241.5 6248.6 6268.0 5981.4 6123.9 6135.6 6195.8 6206.3 5499.8 5509.3 5509.4 5509.6 5510.4 26952.6 27183.3 27665.4 28612.3 29125.7 2135.6 2178.7 2225.6 2226.4 2226.6 17619.6 17973.0 18172.9 18173.1 18389.9 2092.5 2105.2 2116.3 2117.2 2118.3 139654.0 144573.0 146585.0 146931.5 148596.3 11230.0 11594.1 11692.1 12113.5 12124.3 14960.3 16068.9 16429.7 16590.5 16629.3 7702.1 8615.9 8825.6 8900.2 9080.1 8484.2 8491.3 8500.4 8649.7 8677.5 7633.2 7778.4 7782.3 7788.4 7812.8 2053.5 2064.6 2068.1 2071.3 2233.2 907.6 908.4 922.0 943.3 947.7 18743.0 19394.5 20102.7 20180.8 20380.9 881.3 947.8 967.6 988.9 990.9 8768.9 9655.0 10487.0 10493.4 10565.7 629343.0 667794.0 679341.0 690581.0 690896.0 102107.0 131159.4 132181.0 135011.3 135571.0 1162.2 1184.9 1197.2 1206.2 1207.9 16807.6 17478.3 17689.4 18077.8 18214.5 49400.0 58960.7 59923.0 59964.7 60650.0 79073.0 79557.6 80013.0 81659.0 81885.6 8429.7 8547.2 8594.1 8615.5 8693.8 13159.6 13293.6 13447.9 13481.9 13492.3 10123.8 11224.8 11262.6 11495.8 11582.3 10387.3 10556.8 10572.5 10834.8 10837.8 11591.9 11768.0 11821.2 11851.5 11898.8 8386.0 8440.3 8445.7 8450.1 8491.0 9322.6 11047.4 11419.4 11428.1 11511.4 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#3] mootools.html Cycles:180 Average:6844.12 Median:2502.02 stddev:4304.57 (172.0%) stddev-sans-first:4296.94 05:24:40 INFO - PID 1644 | Values: 1363.8 1420.5 1444.0 1444.9 1458.4 10640.7 11045.7 11079.7 11083.2 11090.1 10847.8 11307.6 11319.5 11322.9 11358.0 2450.0 2500.4 2503.6 2504.5 2509.7 2061.8 2337.7 2408.7 2457.8 2458.9 1993.0 2111.5 2148.0 2415.1 2417.7 2413.5 2424.2 2426.1 2426.8 2438.0 2393.3 2423.9 2424.5 2426.0 2430.1 11045.4 11212.5 11218.3 11221.1 11247.4 6205.7 6434.3 6437.8 6441.9 6446.9 3797.1 3989.6 4075.9 4135.5 4142.8 1122.4 1181.8 1214.1 1223.4 1262.4 15255.3 15329.0 15333.2 15336.3 15372.8 5116.4 5285.9 5393.8 5395.6 5399.3 11549.0 11551.8 11560.9 11565.3 11574.4 6288.2 6298.9 6301.0 6304.9 6305.1 5769.3 5893.1 5947.9 6031.2 6044.4 3515.7 3578.5 4038.5 4192.6 4248.4 1262.3 1263.3 1263.8 1283.4 1285.3 573.8 725.0 735.8 755.4 787.3 6369.0 6437.1 6538.2 6598.3 6662.5 563.3 586.7 596.7 603.5 694.7 3941.9 4070.4 4147.0 4182.8 4353.2 11822.8 13681.9 14391.2 14422.2 14427.7 14145.6 14159.4 14204.1 14363.6 14389.8 10257.6 10547.0 10605.7 10606.6 10624.5 4641.9 6616.8 6644.9 6784.6 6851.8 12495.2 12534.4 12796.7 12799.8 12827.4 12722.9 13187.7 13215.9 13218.3 13252.7 7475.4 9319.0 9335.2 9336.9 9345.8 9963.9 10130.0 10180.2 10268.6 10288.9 8506.0 8648.6 8663.2 8895.2 8902.6 8315.2 8606.9 8660.8 8669.3 8674.0 7596.8 7673.4 7739.0 7803.6 7809.0 5723.6 5882.5 5883.4 5948.3 5989.4 4896.6 5817.6 5918.7 5957.9 6029.7 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#4] prototype.html Cycles:180 Average:5076.36 Median:5713.99 stddev:1577.04 (27.6%) stddev-sans-first:1540.84 05:24:40 INFO - PID 1644 | Values: 337.9 385.3 393.3 397.5 398.5 5901.3 5936.6 5956.0 5965.6 5974.7 5036.4 5371.3 5492.8 5836.0 5860.0 3929.6 4211.3 4449.6 4451.2 4491.8 4441.6 4461.4 4470.5 4483.2 4494.9 4097.1 4300.4 4428.1 4431.8 4435.4 4237.0 4249.9 4303.1 4314.9 4317.0 3722.5 3747.4 3749.4 3756.1 3758.6 5351.4 5671.9 5707.6 5719.4 5738.3 5042.5 5061.9 5067.0 5097.0 5121.4 5244.2 6072.0 6187.4 6200.2 6217.2 3251.8 4121.8 4188.8 4195.2 4216.0 6301.6 6399.8 6470.4 6538.7 6649.5 4192.9 4267.7 4271.4 4282.7 4296.7 4344.2 4352.4 4354.4 4360.5 4373.0 4429.9 4744.8 4840.4 4992.9 5039.4 5072.4 6134.3 6196.1 6254.8 6303.7 1261.5 1270.4 1460.1 1473.4 1475.3 963.8 974.8 978.0 987.1 987.6 5290.7 5306.5 5562.6 5708.6 5880.4 5626.6 6026.3 6487.7 6493.3 6508.0 5562.5 5566.3 5900.0 5934.3 5942.5 3339.2 3362.7 3385.2 3385.6 3402.3 6394.3 6752.4 6755.3 6794.5 6812.9 6143.8 6463.9 6740.0 6748.4 6763.6 6041.4 6179.6 6371.6 6650.5 6760.3 6462.3 6570.2 6577.2 6581.9 6668.3 6123.8 6385.7 6443.9 6454.5 6474.9 5702.4 6375.1 6550.0 6572.0 6731.5 4492.3 4523.2 4535.8 4644.6 4680.3 5263.9 5521.3 6380.8 6514.8 6550.0 6123.8 6204.5 6272.1 6273.6 6304.9 4968.4 6192.3 6273.3 6280.8 6295.6 5064.0 5835.2 6014.8 6156.3 6162.4 6287.7 6299.7 6303.5 6312.0 6312.5 5247.5 5846.5 5925.3 6100.5 6116.3 05:24:40 INFO - PID 1644 | 05:24:40 INFO - PID 1644 | [#5] yui.html Cycles:180 Average:19200.25 Median:39119.41 stddev:28637.23 (73.2%) stddev-sans-first:28684.29 05:24:40 INFO - PID 1644 | Values: 813.5 813.6 827.6 844.8 850.6 13830.2 16300.5 16367.9 16389.2 16389.8 13507.4 14095.1 14682.5 14840.4 14853.3 988.6 1002.3 1016.7 1019.9 1020.0 999.9 1001.7 1001.8 1002.4 1005.2 1077.4 1081.5 1082.3 1082.8 1086.1 1075.5 1076.3 1080.7 1082.1 1082.5 797.5 799.1 801.9 803.5 810.0 13877.9 14048.4 14593.1 14742.2 14837.9 11823.6 11903.5 11990.4 11999.5 12229.6 11813.5 12455.0 12554.9 12556.8 12560.4 3232.0 3264.0 3269.8 3307.8 3311.0 89830.0 113228.0 113546.0 113992.0 115502.0 9051.1 9085.6 9216.7 9283.5 9488.0 20204.5 20394.0 20512.8 20562.3 20836.9 6596.7 7649.4 7845.9 7891.4 8102.8 4097.2 4209.4 4214.8 4221.3 4221.3 4085.6 4167.2 4195.1 4197.3 4198.9 778.3 828.5 847.6 882.4 942.1 619.1 627.1 642.4 651.4 661.4 9195.5 9710.1 9930.5 10394.3 10452.8 605.3 614.2 620.5 630.3 654.1 4404.6 4525.8 4528.4 4566.2 4609.7 98638.5 99341.5 99958.0 103768.0 106061.0 72231.6 88929.6 90131.0 90802.0 91885.5 51158.7 80042.2 80448.6 81204.6 83412.6 9018.7 9062.0 9093.7 9148.9 9163.2 37481.0 38721.4 39084.4 39154.4 40141.2 51460.2 51554.0 51760.2 52641.7 52649.2 11652.5 11761.5 11882.3 12239.3 12324.9 12696.9 12751.6 12873.4 13224.9 13277.8 10155.0 11435.3 12129.0 12155.5 12327.4 11579.2 11598.1 11720.4 11797.4 12229.8 11138.3 11610.7 11625.2 11633.4 12025.6 8572.1 8593.7 8678.8 8701.7 9096.2 8214.4 8868.6 8884.5 10052.1 10182.8 05:24:40 INFO - PID 1644 | -------- Summary: end -------- 05:24:40 INFO - PID 1644 | 05:24:40 INFO - TEST-INFO | 1644: exit 0 05:24:40 INFO - TEST-OK | dromaeo_css | took 1120475ms 05:24:40 INFO - TEST-START | kraken 05:24:40 INFO - operating with platform_type : mac_ 05:24:40 INFO - Initialising browser for kraken test... 05:24:40 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmp6JXK5v/profile http://localhost:49248/getInfo.html) 05:24:43 INFO - PID 1651 | __metrics Screen width/height:1600/1200 05:24:43 INFO - PID 1651 | colorDepth:24 05:24:43 INFO - PID 1651 | Browser inner width/height: 1024/689 05:24:43 INFO - PID 1651 | __metrics 05:24:43 INFO - PID 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:24:43 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:44 INFO - TEST-INFO | 1651: exit 0 05:24:44 INFO - Browser initialized. 05:24:44 INFO - Running cycle 1/1 for kraken test... 05:24:44 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmp6JXK5v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:56 INFO - PID 1653 | RSS: Main: 238944256 05:24:56 INFO - PID 1653 | 05:24:59 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:00 INFO - PID 1653 | RSS: Main: 290885632 05:25:00 INFO - PID 1653 | 05:25:03 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 05:25:04 INFO - PID 1653 | RSS: Main: 291282944 05:25:04 INFO - PID 1653 | 05:25:07 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 05:25:08 INFO - PID 1653 | RSS: Main: 385282048 05:25:08 INFO - PID 1653 | 05:25:10 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 05:25:11 INFO - PID 1653 | RSS: Main: 288890880 05:25:11 INFO - PID 1653 | 05:25:13 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:25:13 INFO - PID 1653 | RSS: Main: 291393536 05:25:13 INFO - PID 1653 | 05:25:16 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 05:25:17 INFO - PID 1653 | RSS: Main: 331829248 05:25:17 INFO - PID 1653 | 05:25:20 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 05:25:21 INFO - PID 1653 | RSS: Main: 345288704 05:25:21 INFO - PID 1653 | 05:25:24 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 05:25:24 INFO - PID 1653 | RSS: Main: 356245504 05:25:24 INFO - PID 1653 | 05:25:26 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:27 INFO - PID 1653 | RSS: Main: 308850688 05:25:27 INFO - PID 1653 | 05:25:29 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:29 INFO - PID 1653 | RSS: Main: 311189504 05:25:29 INFO - PID 1653 | 05:25:32 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:32 INFO - PID 1653 | RSS: Main: 313008128 05:25:32 INFO - PID 1653 | 05:25:35 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:36 INFO - PID 1653 | RSS: Main: 330551296 05:25:36 INFO - PID 1653 | 05:25:40 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:40 INFO - PID 1653 | RSS: Main: 313704448 05:25:40 INFO - PID 1653 | 05:25:42 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 05:25:43 INFO - PID 1653 | RSS: Main: 379650048 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | __start_tp_report 05:25:43 INFO - PID 1653 | _x_x_mozilla_page_load 05:25:43 INFO - PID 1653 | _x_x_mozilla_page_load_details 05:25:43 INFO - PID 1653 | |i|pagename|runs| 05:25:43 INFO - PID 1653 | |0;ai-astar;112;121;123;122;122;119;122;121;122;121 05:25:43 INFO - PID 1653 | |1;audio-beat-detection;155;121;154;188;141;118;119;116;142;119 05:25:43 INFO - PID 1653 | |2;audio-dft;208;213;213;207;208;211;210;213;210;218 05:25:43 INFO - PID 1653 | |3;audio-fft;84;62;65;99;68;66;62;62;84;65 05:25:43 INFO - PID 1653 | |4;audio-oscillator;97;74;94;77;76;73;89;74;73;90 05:25:43 INFO - PID 1653 | |5;imaging-gaussian-blur;92;94;92;91;90;90;93;90;92;90 05:25:43 INFO - PID 1653 | |6;imaging-darkroom;98;99;99;99;98;98;98;99;98;99 05:25:43 INFO - PID 1653 | |7;imaging-desaturate;103;104;99;102;101;100;101;101;103;101 05:25:43 INFO - PID 1653 | |8;json-parse-financial;53;50;51;52;51;51;51;51;52;51 05:25:43 INFO - PID 1653 | |9;json-stringify-tinderbox;58;69;60;67;69;70;95;93;95;70 05:25:43 INFO - PID 1653 | |10;stanford-crypto-aes;91;89;90;92;88;91;93;90;95;108 05:25:43 INFO - PID 1653 | |11;stanford-crypto-ccm;150;165;174;145;162;170;163;169;219;176 05:25:43 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;202;209;202;209;201;203;204;203;202;206 05:25:43 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;64;100;94;102;74;76;75;71;72;88 05:25:43 INFO - PID 1653 | __end_tp_report 05:25:43 INFO - PID 1653 | __start_cc_report 05:25:43 INFO - PID 1653 | _x_x_mozilla_cycle_collect,2274 05:25:43 INFO - PID 1653 | __end_cc_report 05:25:43 INFO - PID 1653 | __startTimestamp1491395143010__endTimestamp 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | ------- Summary: start ------- 05:25:43 INFO - PID 1653 | Number of tests: 14 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:120.50 Median:122.00 stddev:3.17 (2.6%) stddev-sans-first:1.13 05:25:43 INFO - PID 1653 | Values: 112.0 121.0 123.0 122.0 122.0 119.0 122.0 121.0 122.0 121.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:141.50 stddev:23.48 (16.6%) stddev-sans-first:24.01 05:25:43 INFO - PID 1653 | Values: 155.0 121.0 154.0 188.0 141.0 118.0 119.0 116.0 142.0 119.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:211.10 Median:212.00 stddev:3.28 (1.5%) stddev-sans-first:3.28 05:25:43 INFO - PID 1653 | Values: 208.0 213.0 213.0 207.0 208.0 211.0 210.0 213.0 210.0 218.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:71.70 Median:67.00 stddev:12.76 (19.0%) stddev-sans-first:12.74 05:25:43 INFO - PID 1653 | Values: 84.0 62.0 65.0 99.0 68.0 66.0 62.0 62.0 84.0 65.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:81.70 Median:83.00 stddev:9.62 (11.6%) stddev-sans-first:8.46 05:25:43 INFO - PID 1653 | Values: 97.0 74.0 94.0 77.0 76.0 73.0 89.0 74.0 73.0 90.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:92.00 stddev:1.43 (1.6%) stddev-sans-first:1.50 05:25:43 INFO - PID 1653 | Values: 92.0 94.0 92.0 91.0 90.0 90.0 93.0 90.0 92.0 90.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:98.50 Median:99.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:25:43 INFO - PID 1653 | Values: 98.0 99.0 99.0 99.0 98.0 98.0 98.0 99.0 98.0 99.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:102.50 stddev:1.51 (1.5%) stddev-sans-first:1.50 05:25:43 INFO - PID 1653 | Values: 103.0 104.0 99.0 102.0 101.0 100.0 101.0 101.0 103.0 101.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.82 (1.6%) stddev-sans-first:0.60 05:25:43 INFO - PID 1653 | Values: 53.0 50.0 51.0 52.0 51.0 51.0 51.0 51.0 52.0 51.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:74.60 Median:70.00 stddev:14.23 (20.3%) stddev-sans-first:13.77 05:25:43 INFO - PID 1653 | Values: 58.0 69.0 60.0 67.0 69.0 70.0 95.0 93.0 95.0 70.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:91.00 stddev:5.74 (6.3%) stddev-sans-first:6.05 05:25:43 INFO - PID 1653 | Values: 91.0 89.0 90.0 92.0 88.0 91.0 93.0 90.0 95.0 108.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:169.30 Median:169.50 stddev:20.03 (11.8%) stddev-sans-first:19.99 05:25:43 INFO - PID 1653 | Values: 150.0 165.0 174.0 145.0 162.0 170.0 163.0 169.0 219.0 176.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.10 Median:203.50 stddev:2.92 (1.4%) stddev-sans-first:3.00 05:25:43 INFO - PID 1653 | Values: 202.0 209.0 202.0 209.0 201.0 203.0 204.0 203.0 202.0 206.0 05:25:43 INFO - PID 1653 | 05:25:43 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.60 Median:74.50 stddev:13.32 (17.9%) stddev-sans-first:12.51 05:25:43 INFO - PID 1653 | Values: 64.0 100.0 94.0 102.0 74.0 76.0 75.0 71.0 72.0 88.0 05:25:43 INFO - PID 1653 | -------- Summary: end -------- 05:25:43 INFO - PID 1653 | 05:25:44 INFO - TEST-INFO | 1653: exit 0 05:25:44 INFO - TEST-OK | kraken | took 63433ms 05:25:44 INFO - SUITE-END | took 1183s 05:25:44 INFO - Completed test suite (00:19:44) 05:25:44 INFO - javascript benchmark 05:25:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7592.93075967782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.5846098468187, 3465.948010779837, 3477.5479187705596, 3504.3341765064642, 3526.4710293455996, 6000.789972350969, 6092.990978487157, 6239.6880155992185, 6248.781292654758, 6266.749330026799, 6108.099244189802, 6125.327021303102, 6214.06788981653, 6216.84457888553, 6218.12946187533, 4884.609231261508, 5202.7658755355915, 5290.894182116355, 5363.785448582052, 5461.5357694596005, 5392.2181283713835, 5431.4840090191365, 5434.945650543484, 5440.809571664992, 5448.264484294629, 5202.479752024786, 5285.418603953562, 5292.603054770869, 5330.200469929503, 5418.620696551243, 5319.707416092114, 5370.9731451342495, 5371.328583927009, 5435.42927992563, 5448.482394172547, 5331.973340133313, 5337.0, 5339.225812257201, 5356.785728570852, 5427.402985671573, 5998.25021872266, 6047.78832740852, 6177.356007894892, 6178.752849886044, 6240.344763799826, 6326.557141000132, 6453.83865403364, 6566.376194261586, 6569.704363303663, 6570.605763654196, 6660.367265109807, 6671.93328066718, 6672.666366681695, 6687.030380594835, 6689.565178263398, 6154.7230374633245, 6300.590461620026, 6304.243490781136, 6318.0, 6323.81028569139, 5836.328822185418, 6531.640759758259, 6631.469482441393, 6727.899081513781, 6859.828504287433, 5497.752601132958, 6400.679966001681, 6402.743890244431, 6451.064595633607, 6460.580062295936, 5464.562834973192, 6631.502637302222, 6633.668316584151, 6641.236257830411, 6670.866582668319, 6287.937120628827, 6319.273283572448, 6525.738970441129, 6531.0529973153625, 6536.346365363521, 5576.776928922879, 6471.0, 6519.348065193442, 6572.178477690289, 6583.80248592543, 5299.099153143975, 5299.920501192485, 5302.072137376021, 5305.65513241638, 5315.309009828775, 4658.883527911829, 4691.7888695008805, 4706.976465117721, 4718.339432479455, 4769.618430525619, 6234.064890266496, 6244.687765611701, 6245.594036387621, 6248.218972628421, 6252.0, 5751.309842818889, 6386.137871387304, 6594.670266486753, 6682.665866706645, 6707.0610114584, 6364.904526432108, 6374.713137908805, 6375.521835862329, 6379.936200638027, 6384.968075159594, 5815.389384114692, 5851.428571428572, 5861.032929566573, 5866.208061911672, 5908.527317814564, 6554.901676474761, 6662.433693136138, 6663.433608143168, 6799.966000169968, 6827.01008353776, 6660.200775906728, 6707.061011458497, 6708.664566771544, 6725.9663701681175, 6750.696218670073, 6873.175218973755, 6886.655667216519, 6887.827804304932, 6898.586084834926, 6899.448044156556, 6265.843353916189, 6339.96830015847, 6453.193350831146, 6488.610683359014, 6490.772822951174, 6471.902921456276, 6529.379708927644, 6529.444997175104, 6605.603663780189, 6617.338266173344, 6378.107065010995, 6388.744450221939, 6390.073439351175, 6392.968035159794, 6402.071699603624, 6243.43809057187, 6289.465395441439, 6377.362263773585, 6383.744650214126, 6394.104825324552, 5884.529237661062, 6249.78125765596, 6254.21822272216, 6282.434580887742, 6287.434130928238, 6380.553361264667, 6414.775482858077, 6418.679066046586, 6424.710888009958, 6427.55007149495, 6265.0, 6308.179936608211, 6310.905336420049, 6321.5258855586935, 6331.335209803088], "value": 6011.642518005168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.7578761115026, 764.5030730025483, 822.4571782623468, 1136.852209212802, 1157.8842115788416, 28542.28644283894, 31060.689393106062, 38328.23343533131, 39028.99999999996, 39029.21941561174, 41062.58937410625, 41414.96462588437, 41509.58490415095, 41557.58442415575, 41579.0, 8516.31869450444, 8667.95666021669, 8677.913220867773, 8688.261497772697, 8724.607392667345, 6128.172696685935, 6308.653024083674, 8670.436421632605, 8897.976732675761, 8898.688545900895, 8680.479171249714, 8765.211130998208, 8787.121287871194, 8787.989381221178, 8809.251213646849, 8676.999999999969, 8736.912630873674, 8753.99329077158, 8755.343349248831, 8803.075677053945, 8596.140385961417, 8632.309415246766, 8644.222020018165, 8652.005019422784, 8666.480011199284, 39504.40743388851, 39556.82437465938, 39667.20665586701, 39778.60221397807, 39938.60061399378, 3492.59835118962, 3528.929421411583, 3530.5586801649793, 3537.2218112015316, 3542.8405721742583, 30689.69310306913, 30810.84594577013, 30873.845630771928, 30911.07266782, 30925.22686932822, 3093.1184612385364, 3117.1427857339413, 3135.498320268746, 3145.418097651942, 3157.715805577509, 259980.0, 337275.0, 337321.0, 337518.0, 337878.3106084478, 50499.0, 50785.20681362486, 50882.745586271834, 50962.49037509652, 50994.72513187126, 53893.191602126, 53913.0, 53997.92004159895, 54023.729881350344, 54051.0, 13980.0, 14396.712065758626, 14400.711985760227, 14401.639959000899, 14428.567142985727, 11667.299962002136, 11673.066154707603, 11673.241239319586, 11692.47383867728, 11746.119041071954, 10630.149588032938, 10860.294080884718, 10883.67348979532, 10896.564137434572, 10897.891021089688, 4836.854894353175, 4875.731834749052, 5295.749306544703, 5451.672899626035, 5467.425920278393, 928.5218112671979, 976.99023009769, 984.5913945712592, 985.8022502659303, 1017.730301470111, 24364.390890227533, 24373.29734323075, 24387.0, 24410.633840492406, 24423.023079076993, 1085.4572713643179, 1087.429099722652, 1088.7169335972546, 1125.4879030041475, 1137.5222406589253, 9911.603535858629, 11808.232464889754, 12464.81302780459, 12487.938525225458, 12491.812622810665, 435653.0, 440356.0, 441528.79235603614, 441746.0, 442152.0, 55632.443675562725, 55718.0, 55743.721281394144, 55815.60460988508, 55870.441295587334, 1477.2023107522032, 1506.5028540581582, 1511.2972467802306, 1516.5071351810705, 1538.100211376335, 23790.048398063882, 26912.461750765266, 28917.132486025454, 28938.84244630191, 29763.55354669725, 51741.0, 51888.443346699656, 51945.740271298404, 51961.96076078533, 52179.47820521746, 400952.0, 401242.0, 401660.0, 402177.0, 402291.0, 32418.83790581032, 32787.672123279415, 33118.5032224512, 33852.83073584616, 33871.0, 43317.0, 43921.78039109784, 44678.553214467436, 44714.776426118966, 44771.880702982686, 28668.856655716587, 29811.850940745157, 30565.388692225588, 30844.38311233718, 31011.0, 28578.0, 29214.853925730236, 30005.249868753457, 30241.546376804807, 30617.23456913595, 34876.30247394987, 35310.47034294539, 35814.64185358113, 36292.09269768277, 36295.818520907225, 30107.096787095546, 30176.54735179018, 31062.53406198954, 31259.341461342116, 31288.843555782074, 23908.282751517483, 23957.640635390133, 23960.40098997539, 24233.151839685528, 24478.87760561257], "value": 18008.82373564088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.0503162220936, 428.8677890369423, 437.5187293976625, 441.62682533259397, 456.0821744564108, 17950.640987180264, 21675.783242167574, 22346.21788237412, 23212.41968950777, 23404.54252303505, 22769.203077892278, 23306.0, 23404.180853670125, 23731.406714832137, 23770.40573985647, 5454.181872719084, 6050.939490605082, 6058.6061905976085, 6214.440700336969, 6279.183706118199, 6112.908306375408, 6240.282367527724, 6249.656268905208, 6259.99840025596, 6263.530235232353, 5457.727113644321, 6199.504039676837, 6241.500679945593, 6248.562600617958, 6268.0, 5981.431763982415, 6123.908141377883, 6135.631862088289, 6195.783147589836, 6206.317305096436, 5499.780008799643, 5509.256250406184, 5509.421510741355, 5509.559235261169, 5510.421405752379, 26952.59571106435, 27183.320416989536, 27665.446691066067, 28612.284692882637, 29125.708742912513, 2135.5622097470136, 2178.6949827024227, 2225.63277059285, 2226.3877433705698, 2226.610343189935, 17619.647607047915, 17973.0, 18172.90913545437, 18173.091345432807, 18389.90805045966, 2092.5187206942337, 2105.2421128393767, 2116.3333549931876, 2117.1637203304763, 2118.269197127004, 139654.0, 144573.0, 146584.99999999892, 146931.53068469392, 148596.2570187142, 11230.0, 11594.05802027298, 11692.064634829194, 12113.515459381702, 12124.333161676192, 14960.251987400587, 16068.919655401649, 16429.67140657204, 16590.50228493147, 16629.334826607042, 7702.114256860533, 8615.870761938577, 8825.646974121091, 8900.243479304203, 9080.091990800867, 8484.19400156984, 8491.278241349431, 8500.44747091437, 8649.740507784776, 8677.479351238946, 7633.198514156044, 7778.377729781604, 7782.2995930365405, 7788.376929845599, 7812.765617031499, 2053.4968932611605, 2064.6386882295537, 2068.079704531499, 2071.2854065347433, 2233.1848875160777, 907.5598334807613, 908.42315129893, 921.953902304882, 943.3208090175063, 947.7109481608176, 18743.0, 19394.5151371214, 20102.69845952312, 20180.798192017894, 20380.898095509427, 881.3037700216885, 947.8341290274175, 967.6081187119228, 988.8714467119372, 990.9454979976026, 8768.868466973001, 9654.951725241328, 10487.0, 10493.370397776158, 10565.683029509128, 629343.0, 667794.0, 679341.0, 690581.0, 690896.0, 102107.0, 131159.4094206698, 132181.0, 135011.32494337467, 135571.0, 1162.203890335123, 1184.9170558060853, 1197.22180582622, 1206.2280140710127, 1207.8912897839236, 16807.579810504834, 17478.30086796565, 17689.38087166943, 18077.819221807615, 18214.54103695984, 49400.0, 58960.70519647374, 59923.0, 59964.700176500584, 60650.0, 79073.0, 79557.60221198857, 80013.0, 81659.0, 81885.59057204676, 8429.704960326604, 8547.188017138362, 8594.097619749837, 8615.526146061777, 8693.782655433664, 13159.60521184366, 13293.601191964257, 13447.932760336136, 13481.932590336986, 13492.325383730971, 10123.835758887823, 11224.831627525757, 11262.605808796652, 11495.77008459843, 11582.305061696325, 10387.324823886423, 10556.788864222826, 10572.524236409534, 10834.837477438003, 10837.783244335227, 11591.942040289745, 11768.0, 11821.172517923662, 11851.466683999413, 11898.821517677416, 8385.95807020961, 8440.324774017941, 8445.746627601182, 8450.112738162405, 8490.9621690795, 9322.627094916128, 11047.447627618747, 11419.371934543347, 11428.085753139896, 11511.42442877836], "value": 10292.524886375077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.8499765025847, 1420.5439424589795, 1444.0108525659928, 1444.862738039886, 1458.3801884199213, 10640.733981650454, 11045.668629941094, 11079.667609971704, 11083.168762342826, 11090.057345125673, 10847.837282440769, 11307.604233851816, 11319.547218111265, 11322.886771132286, 11358.03456706179, 2449.9510009799747, 2500.4249022724784, 2503.6244563315468, 2504.536660717764, 2509.6611957385703, 2061.7628972668185, 2337.742848286687, 2408.6868707068056, 2457.7910877575428, 2458.91393801217, 1992.9536993078605, 2111.546017606222, 2147.9785202147937, 2415.130553000918, 2417.7098748150247, 2413.4690368118986, 2424.248482970285, 2426.0780903256828, 2426.7694569015916, 2437.9878100609562, 2393.317904397256, 2423.866687332196, 2424.478737071538, 2426.0417135231482, 2430.064425196312, 11045.447727613588, 11212.495437705324, 11218.27081239725, 11221.102311815035, 11247.381394023325, 6205.689715514206, 6434.260060093103, 6437.83905402364, 6441.871162576722, 6446.871062578769, 3797.1266608680157, 3989.580477104456, 4075.8981025474304, 4135.462389889295, 4142.813573389205, 1122.4107343644653, 1181.80500217464, 1214.1015648420193, 1223.4188760338857, 1262.4129779652505, 15255.313510892036, 15329.0, 15333.156676382794, 15336.309866056054, 15372.846271537253, 5116.437191908887, 5285.894282114413, 5393.8112166074, 5395.595330350239, 5399.271098401744, 11549.0, 11551.826722599168, 11560.884391155982, 11565.306081635128, 11574.421278936019, 6288.182536270256, 6298.937010629927, 6301.0, 6304.873902521924, 6305.139983704818, 5769.307683078057, 5893.116032595145, 5947.910781338283, 6031.155638210654, 6044.425779550936, 3515.7187425005936, 3578.5169002184894, 4038.495188101487, 4192.601702838226, 4248.426462427595, 1262.3120399382358, 1263.3241215949422, 1263.7977923532192, 1283.3839756916732, 1285.3265208366574, 573.8078773522418, 724.995880705227, 735.8123678462065, 755.4107795919192, 787.2796391301895, 6369.0, 6437.130987316652, 6538.1500404948, 6598.274189839114, 6662.533622646368, 563.2818156849967, 586.7301041520948, 596.7284885377143, 603.4900509069829, 694.7464175575878, 3941.921161576752, 4070.409790580349, 4146.979265103655, 4182.790860456965, 4353.151135528541, 11822.822657660143, 13681.931590341985, 14391.208483533506, 14422.206778627276, 14427.711445771236, 14145.646358841112, 14159.362828672734, 14204.076735012191, 14363.56909292723, 14389.78415323771, 10257.640982565574, 10546.998035186645, 10605.734856628646, 10606.621139251847, 10624.468776561142, 4641.907161856677, 6616.816450571396, 6644.900326495203, 6784.626845523544, 6851.760188393382, 12495.187812792139, 12534.435950382072, 12796.680082998, 12799.80800288015, 12827.42276597574, 12722.936385318015, 13187.736245275233, 13215.867841321848, 13218.339083045617, 13252.668683282995, 7475.36459400957, 9319.0, 9335.206507446672, 9336.859947100664, 9345.766355840886, 9963.850542241727, 10130.037646423578, 10180.185585153022, 10268.589256429957, 10288.948555257175, 8505.95747021261, 8648.610812513327, 8663.176998185414, 8895.154960278764, 8902.643894244158, 8315.168483151878, 8606.913930860612, 8660.78348041304, 8669.306455483673, 8674.0, 7596.772096837104, 7673.386129109546, 7738.961305193438, 7803.609819509115, 7809.0, 5723.570732195185, 5882.470577648032, 5883.441073098049, 5948.345681974893, 5989.371116032754, 4896.608271338213, 5817.563682723728, 5918.697886464971, 5957.91063134062, 6029.668368239789], "value": 5131.036386338546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.868231389758, 385.3064483928927, 393.3058152361081, 397.46540902486146, 398.50585274259925, 5901.32134804497, 5936.643801371921, 5956.0, 5965.612235204709, 5974.731137098841, 5036.445990940993, 5371.274877891484, 5492.846502234525, 5835.970820145904, 5860.0, 3929.5657085163853, 4211.347241177622, 4449.599536041764, 4451.176532341511, 4491.842785502508, 4441.600255976961, 4461.442319710036, 4470.508244093147, 4483.170613436525, 4494.865154045384, 4097.119119389331, 4300.440942677447, 4428.136513379892, 4431.822727090913, 4435.401220835194, 4237.025484138635, 4249.851255206053, 4303.074838909633, 4314.870553883388, 4316.956830431687, 3722.4602432647384, 3747.4191500317493, 3749.3813520769313, 3756.0609847538117, 3758.642928921748, 5351.357837059539, 5671.914921276184, 5707.573106723319, 5719.399463056361, 5738.254026976508, 5042.495750424965, 5061.886384995295, 5066.974665126688, 5097.0, 5121.385433747974, 5244.190754189798, 6071.998120310143, 6187.381261873822, 6200.193974783295, 6217.222847144107, 3251.837408129584, 4121.775180440043, 4188.769617671027, 4195.160967806421, 4215.957840421618, 6301.6219026858535, 6399.8080057598345, 6470.385313395267, 6538.6730663467115, 6649.534532582721, 4192.876307151192, 4267.698352002669, 4271.423357846713, 4282.721623094489, 4296.720713153635, 4344.219699392392, 4352.368906508602, 4354.368616550582, 4360.454943132108, 4373.0, 4429.889252768642, 4744.8375148088935, 4840.370751802243, 4992.8751781205765, 5039.420466646309, 5072.365954255718, 6134.263888333428, 6196.132541444112, 6254.778788923708, 6303.684815759194, 1261.4512686981009, 1270.371166272701, 1460.0582624207327, 1473.4455149816831, 1475.3066058952274, 963.7879666473365, 974.8050389922043, 977.9902200978041, 987.0820137272262, 987.6493844685033, 5290.709011004432, 5306.522412982773, 5562.637153897321, 5708.571857110734, 5880.382559831241, 5626.634268772516, 6026.258052586063, 6487.6756162191705, 6493.25327587324, 6507.967460162668, 5562.499375056264, 5566.272526462086, 5900.0, 5934.347221805598, 5942.533848452844, 3339.231976645385, 3362.680545348188, 3385.1875549867855, 3385.610654774683, 3402.2988505747126, 6394.26465956421, 6752.3922846944015, 6755.256921738604, 6794.45644348451, 6812.931870681329, 6143.784967526115, 6463.9334509806295, 6739.966300168468, 6748.358905903931, 6763.560368576125, 6041.426064523863, 6179.598326108789, 6371.585846919936, 6650.467962562983, 6760.335368595654, 6462.256840463407, 6570.211574611078, 6577.243616983917, 6581.934180658323, 6668.266490685924, 6123.84690382744, 6385.744570217139, 6443.903341449975, 6454.451371633464, 6474.870502589828, 5702.37273899879, 6375.139356186855, 6550.0, 6571.967140164268, 6731.52879298464, 4492.303692927601, 4523.208438523311, 4535.773211339354, 4644.58198762113, 4680.251159814414, 5263.9210411844615, 5521.337439507124, 6380.808575742735, 6514.771982980573, 6549.96725016391, 6123.775244951116, 6204.5036397089025, 6272.114827179366, 6273.647382231663, 6304.905426418516, 4968.378952630921, 6192.287886892885, 6273.306207323905, 6280.780172694116, 6295.622262664255, 5063.974680126576, 5835.2122463466885, 6014.789482368096, 6156.322804491413, 6162.414570615784, 6287.748490060347, 6299.748010079546, 6303.4642055423965, 6311.96844015777, 6312.526560508072, 5247.475252474722, 5846.4799152219875, 5925.288965324189, 6100.511959043177, 6116.26604807426], "value": 4579.701531656085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.4712436916008, 813.6379311206512, 827.6441130313966, 844.8141408890042, 850.5959669157149, 13830.170189788607, 16300.510984670478, 16367.918160409212, 16389.18054097295, 16389.836101638994, 13507.411995045351, 14095.083819551723, 14682.486112986047, 14840.406383744637, 14853.257337133155, 988.629264025992, 1002.3484734922285, 1016.7305663999047, 1019.9286049976505, 1020.0, 999.9050090241416, 1001.6594357918307, 1001.7595777013537, 1002.3584905660383, 1005.15566923784, 1077.4397313397028, 1081.5457507846722, 1082.2640604389012, 1082.826747720365, 1086.1419478611888, 1075.4891426572356, 1076.3488089705693, 1080.7460246841986, 1082.1451053667593, 1082.4533610526712, 797.4656979823532, 799.0890384961149, 801.9157988411249, 803.5419810707899, 810.0441479054713, 13877.930610346884, 14048.43806247749, 14593.124412535175, 14742.189179595118, 14837.925810370987, 11823.586174483851, 11903.523859045628, 11990.400479975966, 11999.46002429884, 12229.571964981184, 11813.468393922294, 12455.0, 12554.937225313906, 12556.811647825198, 12560.43478043481, 3231.96768032319, 3263.9836800816083, 3269.8038117713013, 3307.7849939753837, 3310.966890331114, 89830.0, 113228.0, 113546.0, 113992.0, 115502.0, 9051.094890510896, 9085.591148398338, 9216.677416290531, 9283.48940808262, 9488.00375960528, 20204.494887627632, 20394.0, 20512.79487205139, 20562.28032018872, 20836.895815520824, 6596.7315921130885, 7649.38804895607, 7845.882311765328, 7891.408144389079, 8102.797430064295, 4097.221527909747, 4209.431726716854, 4214.831406743757, 4221.261279276115, 4221.282381995007, 4085.611866872642, 4167.166566686614, 4195.077083041726, 4197.349410841324, 4198.874033778991, 778.2995304226129, 828.5318794880873, 847.635516727813, 882.373514804496, 942.1473566422399, 619.1363048547341, 627.1314229791681, 642.4410762636443, 651.4397618048474, 661.4311691944923, 9195.494247816301, 9710.126088652056, 9930.547637578677, 10394.324368915995, 10452.790944181226, 605.276694350256, 614.1878382870173, 620.5190976992776, 630.3129588748286, 654.0548906829681, 4404.625606823456, 4525.818967241274, 4528.388667529841, 4566.1552612766745, 4609.654275929319, 98638.52042219373, 99341.50329248307, 99958.0, 103768.0, 106061.0, 72231.6388418065, 88929.55535222283, 90131.0, 90802.0, 91885.54057229671, 51158.74420627873, 80042.19957800464, 80448.59775701084, 81204.59397702974, 83412.58293708492, 9018.684346047858, 9061.954690226507, 9093.727188184364, 9148.862767058632, 9163.221126204347, 37481.0, 38721.41917871178, 39084.41373379459, 39154.4126838092, 40141.1971760569, 51460.22809657933, 51554.0, 51760.22359664533, 52641.7367913158, 52649.21026184687, 11652.53389864396, 11761.529538818351, 11882.28706277626, 12239.32683702405, 12324.938375308066, 12696.936515317364, 12751.553695620609, 12873.356332183166, 13224.867751322749, 13277.800832987707, 10155.0, 11435.313881166823, 12129.0, 12155.513779449077, 12327.383630818602, 11579.247348922294, 11598.11798480839, 11720.413979301171, 11797.410129493319, 12229.816552751538, 11138.33170009802, 11610.6516804496, 11625.18623696367, 11633.41832908368, 12025.63923082309, 8572.05707372176, 8593.69922052725, 8678.78303042429, 8701.738947831574, 9096.181343678836, 8214.424990250625, 8868.600912959062, 8884.511351875708, 10052.095311422006, 10182.847257291294], "value": 7317.787054581474, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 121.0, 123.0, 122.0, 122.0, 119.0, 122.0, 121.0, 122.0, 121.0], "value": 120.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 154.0, 188.0, 141.0, 118.0, 119.0, 116.0, 142.0, 119.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 213.0, 213.0, 207.0, 208.0, 211.0, 210.0, 213.0, 210.0, 218.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 62.0, 65.0, 99.0, 68.0, 66.0, 62.0, 62.0, 84.0, 65.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 74.0, 94.0, 77.0, 76.0, 73.0, 89.0, 74.0, 73.0, 90.0], "value": 81.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 92.0, 91.0, 90.0, 90.0, 93.0, 90.0, 92.0, 90.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 99.0, 99.0, 98.0, 98.0, 98.0, 99.0, 98.0, 99.0], "value": 98.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 99.0, 102.0, 101.0, 100.0, 101.0, 101.0, 103.0, 101.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0, 52.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 69.0, 60.0, 67.0, 69.0, 70.0, 95.0, 93.0, 95.0, 70.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 90.0, 92.0, 88.0, 91.0, 93.0, 90.0, 95.0, 108.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 165.0, 174.0, 145.0, 162.0, 170.0, 163.0, 169.0, 219.0, 176.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 209.0, 202.0, 209.0, 201.0, 203.0, 204.0, 203.0, 202.0, 206.0], "value": 204.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 100.0, 94.0, 102.0, 74.0, 76.0, 75.0, 71.0, 72.0, 88.0], "value": 81.6, "unit": "score"}]}]} 05:25:44 INFO - Return code: 0 05:25:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:44 ERROR - # TBPL SUCCESS # 05:25:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:25:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:25:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:25:44 INFO - 2017-04-05 05:25:44.793 screenresolution[1657:10259] starting screenresolution argv=screenresolution get 05:25:44 INFO - 2017-04-05 05:25:44.796 screenresolution[1657:10259] Display 0: 1600x1200x32@60 05:25:44 INFO - 2017-04-05 05:25:44.802 screenresolution[1658:10262] starting screenresolution argv=screenresolution list 05:25:44 INFO - Available Modes on Display 0 05:25:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:25:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:25:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:25:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:25:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:25:45 INFO - Intel Iris: 05:25:45 INFO - Chipset Model: Intel Iris 05:25:45 INFO - Type: GPU 05:25:45 INFO - Bus: Built-In 05:25:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:25:45 INFO - Vendor: Intel (0x8086) 05:25:45 INFO - Device ID: 0x0a2e 05:25:45 INFO - Revision ID: 0x0009 05:25:45 INFO - Displays: 05:25:45 INFO - Display: 05:25:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:25:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:25:45 INFO - Display Serial Number: 1600x1200 60 05:25:45 INFO - Main Display: Yes 05:25:45 INFO - Mirror: Off 05:25:45 INFO - Online: Yes 05:25:45 INFO - Rotation: Supported 05:25:45 INFO - Return code: 0 05:25:45 INFO - Running post-action listener: _resource_record_post_action 05:25:45 INFO - [mozharness: 2017-04-05 12:25:45.046830Z] Finished run-tests step (success) 05:25:45 INFO - Running post-run listener: _resource_record_post_run 05:25:45 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 38159360; Write bytes: 518175232; Read time: 379; Write time: 1593 05:25:45 INFO - TinderboxPrint: CPU usage
53.6% 05:25:45 INFO - TinderboxPrint: I/O read bytes / time
38,159,360 / 379 05:25:45 INFO - TinderboxPrint: I/O write bytes / time
518,175,232 / 1,593 05:25:45 INFO - TinderboxPrint: CPU idle
2,234.6 (46.4%) 05:25:45 INFO - TinderboxPrint: CPU system
962.3 (20.0%) 05:25:45 INFO - TinderboxPrint: CPU user
1,620.7 (33.6%) 05:25:45 INFO - TinderboxPrint: Swap in / out
244,854,784 / 0 05:25:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 202770944; Write bytes: 190824448; Read time: 14931; Write time: 408 05:25:45 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 31898624; Write bytes: 310508032; Read time: 325; Write time: 1135 05:25:45 INFO - Running post-run listener: _upload_blobber_files 05:25:45 INFO - Blob upload gear active. 05:25:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:45 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 05:25:45 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'] 05:25:45 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 05:25:45 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:46 INFO - (blobuploader) - INFO - Done attempting. 05:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:49 INFO - (blobuploader) - INFO - Done attempting. 05:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:25:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:49 INFO - (blobuploader) - INFO - Done attempting. 05:25:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:52 INFO - (blobuploader) - INFO - Done attempting. 05:25:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:52 INFO - Return code: 0 05:25:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9637e4b5931875f6b149cf3b2c59262d5d1a7b4f81317dd7dd35d50d29e5c24bffb72ea66d063a25beb07b5a13cd5ee2347407fe9b7b2bb6e82d8ad80404fff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1b45ad3544fecb7599c06ab8b39db51978f7f4f0c3fb1fbf50dbc296c43791c55b4e1798814835ea2a0eb50ca8dea27c9fb45e5735fb7c72ab45b199df02596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4df8d8f6044cd23e2883ef1ff295b6ec4388ac6cb11bea42baed6453ce2901aac4b739891e9cbdfd814459c5b9ab90ce1749fd5e4bffd08cf357df0e6953653d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57d24b06a045f209e654fa79d6fd10ffc1cc9d12c4a7ab36a92b44050324b5dc84baed4d3c02ae25b4b0d58711f4988427013f541d11ce057a0b5e4f896acf90"} 05:25:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:52 INFO - Contents: 05:25:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9637e4b5931875f6b149cf3b2c59262d5d1a7b4f81317dd7dd35d50d29e5c24bffb72ea66d063a25beb07b5a13cd5ee2347407fe9b7b2bb6e82d8ad80404fff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1b45ad3544fecb7599c06ab8b39db51978f7f4f0c3fb1fbf50dbc296c43791c55b4e1798814835ea2a0eb50ca8dea27c9fb45e5735fb7c72ab45b199df02596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4df8d8f6044cd23e2883ef1ff295b6ec4388ac6cb11bea42baed6453ce2901aac4b739891e9cbdfd814459c5b9ab90ce1749fd5e4bffd08cf357df0e6953653d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57d24b06a045f209e654fa79d6fd10ffc1cc9d12c4a7ab36a92b44050324b5dc84baed4d3c02ae25b4b0d58711f4988427013f541d11ce057a0b5e4f896acf90"} 05:25:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:52 INFO - Copying logs to upload dir... 05:25:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.331122 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-04-05 05:25:52.181036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 05:25:52.185123) ========= 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.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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/e9637e4b5931875f6b149cf3b2c59262d5d1a7b4f81317dd7dd35d50d29e5c24bffb72ea66d063a25beb07b5a13cd5ee2347407fe9b7b2bb6e82d8ad80404fff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1b45ad3544fecb7599c06ab8b39db51978f7f4f0c3fb1fbf50dbc296c43791c55b4e1798814835ea2a0eb50ca8dea27c9fb45e5735fb7c72ab45b199df02596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4df8d8f6044cd23e2883ef1ff295b6ec4388ac6cb11bea42baed6453ce2901aac4b739891e9cbdfd814459c5b9ab90ce1749fd5e4bffd08cf357df0e6953653d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57d24b06a045f209e654fa79d6fd10ffc1cc9d12c4a7ab36a92b44050324b5dc84baed4d3c02ae25b4b0d58711f4988427013f541d11ce057a0b5e4f896acf90"} build_url:https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010944 build_url: 'https://queue.taskcluster.net/v1/task/WYJ9lRJKQhOL-qrPKwgpiQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9637e4b5931875f6b149cf3b2c59262d5d1a7b4f81317dd7dd35d50d29e5c24bffb72ea66d063a25beb07b5a13cd5ee2347407fe9b7b2bb6e82d8ad80404fff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1b45ad3544fecb7599c06ab8b39db51978f7f4f0c3fb1fbf50dbc296c43791c55b4e1798814835ea2a0eb50ca8dea27c9fb45e5735fb7c72ab45b199df02596", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4df8d8f6044cd23e2883ef1ff295b6ec4388ac6cb11bea42baed6453ce2901aac4b739891e9cbdfd814459c5b9ab90ce1749fd5e4bffd08cf357df0e6953653d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57d24b06a045f209e654fa79d6fd10ffc1cc9d12c4a7ab36a92b44050324b5dc84baed4d3c02ae25b4b0d58711f4988427013f541d11ce057a0b5e4f896acf90"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 05:25:52.222686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 05:25:52.223058) ========= 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.0YUlZiXemc/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.IxK88AWR3v/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.005208 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 05:25:52.272883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 05:25:52.273255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 05:25:52.273643) ========= ========= Total master_lag: 7.24 =========