builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0223 starttime: 1486655331.35 results: success (0) buildid: 20170209070421 builduid: bf12ec3473b142a98241e4b804d7997c revision: 4dfd0d2d5dd3b640d46ee405af7523e37545c155 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.348551) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.349586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.350804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.376731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.377124) ========= 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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-09 07:48:51-- 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% 8.05M=0.001s 2017-02-09 07:48:51 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125862 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.529859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.530596) ========= 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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.021833 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.581733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:51.582368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4dfd0d2d5dd3b640d46ee405af7523e37545c155 --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 4dfd0d2d5dd3b640d46ee405af7523e37545c155 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-09 07:48:51,680 truncating revision to first 12 chars 2017-02-09 07:48:51,680 Setting DEBUG logging. 2017-02-09 07:48:51,680 attempt 1/10 2017-02-09 07:48:51,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4dfd0d2d5dd3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 07:48:51,965 unpacking tar archive at: mozilla-central-4dfd0d2d5dd3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546353 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:52.156915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:52.157644) ========= script_repo_revision: 4dfd0d2d5dd3b640d46ee405af7523e37545c155 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:52.158588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:52.159253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 07:48:52.180224) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 07:48:52.180902) ========= /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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:48:52 INFO - MultiFileLogger online at 20170209 07:48:52 in /builds/slave/test 07:48:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:48:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:48:52 INFO - {'append_to_log': False, 07:48:52 INFO - 'base_work_dir': '/builds/slave/test', 07:48:52 INFO - 'blob_upload_branch': 'Firefox', 07:48:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:48:52 INFO - 'branch': 'Firefox', 07:48:52 INFO - 'buildbot_json_path': 'buildprops.json', 07:48:52 INFO - 'config_files': ('talos/mac_config.py',), 07:48:52 INFO - 'default_actions': ('clobber', 07:48:52 INFO - 'read-buildbot-config', 07:48:52 INFO - 'download-and-extract', 07:48:52 INFO - 'populate-webroot', 07:48:52 INFO - 'create-virtualenv', 07:48:52 INFO - 'install', 07:48:52 INFO - 'run-tests'), 07:48:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:48:52 INFO - 'download_minidump_stackwalk': True, 07:48:52 INFO - 'download_symbols': 'ondemand', 07:48:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:48:52 INFO - 'tooltool.py': '/tools/tooltool.py', 07:48:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:48:52 INFO - '/tools/misc-python/virtualenv.py')}, 07:48:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:48:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:48:52 INFO - 'installer_path': 'installer.exe', 07:48:52 INFO - 'log_level': 'info', 07:48:52 INFO - 'log_name': 'talos', 07:48:52 INFO - 'log_to_console': True, 07:48:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:48:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:48:52 INFO - 'opt_config_files': (), 07:48:52 INFO - 'pip_index': False, 07:48:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:52 INFO - 'cmd': ('bash', 07:48:52 INFO - '-c', 07:48:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:52 INFO - 'enabled': True, 07:48:52 INFO - 'halt_on_failure': False, 07:48:52 INFO - 'name': 'check_screen_resolution'},), 07:48:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:48:52 INFO - 'cmd': ('bash', 07:48:52 INFO - '-c', 07:48:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:48:52 INFO - 'enabled': True, 07:48:52 INFO - 'halt_on_failure': False, 07:48:52 INFO - 'name': 'check_screen_resolution'},), 07:48:52 INFO - 'run_cmd_checks_enabled': True, 07:48:52 INFO - 'sps_profile': False, 07:48:52 INFO - 'sps_profile_interval': 0, 07:48:52 INFO - 'suite': 'dromaeojs', 07:48:52 INFO - 'system_bits': '32', 07:48:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:48:52 INFO - 'title': 't-yosemite-r7-0223', 07:48:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:48:52 INFO - 'use_talos_json': True, 07:48:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:48:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:48:52 INFO - 'work_dir': 'build'} 07:48:52 INFO - [mozharness: 2017-02-09 15:48:52.395438Z] Running clobber step. 07:48:52 INFO - Running pre-action listener: _resource_record_pre_action 07:48:52 INFO - Running main action method: clobber 07:48:52 INFO - rmtree: /builds/slave/test/build 07:48:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:48:52 INFO - Running post-action listener: _resource_record_post_action 07:48:52 INFO - [mozharness: 2017-02-09 15:48:52.590970Z] Finished clobber step (success) 07:48:52 INFO - [mozharness: 2017-02-09 15:48:52.591250Z] Running read-buildbot-config step. 07:48:52 INFO - Running pre-action listener: _resource_record_pre_action 07:48:52 INFO - Running main action method: read_buildbot_config 07:48:52 INFO - Using buildbot properties: 07:48:52 INFO - { 07:48:52 INFO - "project": "", 07:48:52 INFO - "product": "firefox", 07:48:52 INFO - "script_repo_revision": "production", 07:48:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:48:52 INFO - "repository": "", 07:48:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:48:52 INFO - "buildid": "20170209070421", 07:48:52 INFO - "pgo_build": "False", 07:48:52 INFO - "basedir": "/builds/slave/test", 07:48:52 INFO - "buildnumber": 85, 07:48:52 INFO - "slavename": "t-yosemite-r7-0223", 07:48:52 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:48:52 INFO - "platform": "yosemite_r7", 07:48:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:48:52 INFO - "branch": "mozilla-central", 07:48:52 INFO - "repo_path": "mozilla-central", 07:48:52 INFO - "revision": "4dfd0d2d5dd3b640d46ee405af7523e37545c155", 07:48:52 INFO - "stage_platform": "macosx64", 07:48:52 INFO - "builduid": "bf12ec3473b142a98241e4b804d7997c", 07:48:52 INFO - "slavebuilddir": "test" 07:48:52 INFO - } 07:48:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 07:48:52 INFO - Running post-action listener: _resource_record_post_action 07:48:52 INFO - [mozharness: 2017-02-09 15:48:52.596349Z] Finished read-buildbot-config step (success) 07:48:52 INFO - [mozharness: 2017-02-09 15:48:52.596542Z] Running download-and-extract step. 07:48:52 INFO - Running pre-action listener: _resource_record_pre_action 07:48:52 INFO - Running main action method: download_and_extract 07:48:52 INFO - mkdir: /builds/slave/test/build/tests 07:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:52 INFO - trying https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 07:48:52 INFO - Downloading https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:48:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 07:48:53 INFO - Downloaded 1199 bytes. 07:48:53 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:48:53 INFO - Using the following test package requirements: 07:48:53 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:48:53 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:48:53 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:48:53 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'jsshell-mac.zip'], 07:48:53 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:48:53 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:48:53 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:48:53 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:48:53 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:48:53 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:48:53 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:48:53 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:48:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:48:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:48:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:48:54 INFO - Expected file size: 34943065 07:48:54 INFO - Obtained file size: 34943065 07:49:01 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:49:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:49:01 INFO - Fetch https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:49:02 INFO - Expected file size: 34943065 07:49:02 INFO - Obtained file size: 34943065 07:49:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 07:49:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:49:09 INFO - Fetch https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:49:10 INFO - Expected file size: 14403454 07:49:10 INFO - Obtained file size: 14403454 07:49:10 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')]} 07:49:10 INFO - trying https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:49:10 INFO - Downloading https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 07:49:12 INFO - Downloaded 70290691 bytes. 07:49:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:49:12 INFO - mkdir: /builds/slave/test/properties 07:49:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:49:12 INFO - Writing to file /builds/slave/test/properties/build_url 07:49:12 INFO - Contents: 07:49:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:49:13 INFO - Running post-action listener: _resource_record_post_action 07:49:13 INFO - Running post-action listener: set_extra_try_arguments 07:49:13 INFO - [mozharness: 2017-02-09 15:49:13.415681Z] Finished download-and-extract step (success) 07:49:13 INFO - [mozharness: 2017-02-09 15:49:13.415841Z] Running populate-webroot step. 07:49:13 INFO - Running pre-action listener: _resource_record_pre_action 07:49:13 INFO - Running main action method: populate_webroot 07:49:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:49:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:49:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:49:13 INFO - '--tppagecycles', 07:49:13 INFO - '7'], 07:49:13 INFO - 'tests': ['tsvgm']}}, 07:49:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:49:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:49:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:49:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:49:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['damp', 'tps']}, 07:49:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'tests': ['damp', 'tps']}, 07:49:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['dromaeo_dom']}, 07:49:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:49:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['basic_compositor_video']}, 07:49:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:49:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'other-e10s': {'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['a11yr', 07:49:13 INFO - 'ts_paint', 07:49:13 INFO - 'tpaint', 07:49:13 INFO - 'sessionrestore', 07:49:13 INFO - 'sessionrestore_no_auto_restore', 07:49:13 INFO - 'tabpaint']}, 07:49:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['tsvgx', 07:49:13 INFO - 'tsvgr_opacity', 07:49:13 INFO - 'tart', 07:49:13 INFO - 'tscrollx', 07:49:13 INFO - 'cart', 07:49:13 INFO - 'tsvg_static']}, 07:49:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:49:13 INFO - 'tsvgr_opacity', 07:49:13 INFO - 'tart', 07:49:13 INFO - 'tscrollx', 07:49:13 INFO - 'cart', 07:49:13 INFO - 'tsvg_static']}, 07:49:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'talos_options': ['--disable-e10s'], 07:49:13 INFO - 'tests': ['tp5o']}, 07:49:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:49:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'talos_options': ['--disable-e10s', 07:49:13 INFO - '--xperf_path', 07:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:13 INFO - 'tests': ['tp5n']}, 07:49:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:49:13 INFO - 'talos_options': ['--xperf_path', 07:49:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:13 INFO - 'tests': ['tp5n']}}, 07:49:13 INFO - 'talos.zip': {'path': '', 07:49:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:49:13 INFO - Running post-action listener: _resource_record_post_action 07:49:13 INFO - [mozharness: 2017-02-09 15:49:13.433983Z] Finished populate-webroot step (success) 07:49:13 INFO - [mozharness: 2017-02-09 15:49:13.434105Z] Running create-virtualenv step. 07:49:13 INFO - Running pre-action listener: _resource_record_pre_action 07:49:13 INFO - Running main action method: create_virtualenv 07:49:13 INFO - Creating virtualenv /builds/slave/test/build/venv 07:49:13 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 07:49:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:49:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:49:13 INFO - Using real prefix '/tools/python27' 07:49:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:49:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:49:17 INFO - Installing pip.................done. 07:49:17 INFO - Return code: 0 07:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:49:17 INFO - Reading from file tmpfile_stdout 07:49:17 INFO - Output received: 07:49:17 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) 07:49:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49: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', 'pip>=1.5'] in /builds/slave/test/build 07:49: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 pip>=1.5 07:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:17 INFO - 'HOME': '/Users/cltbld', 07:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:17 INFO - 'LOGNAME': 'cltbld', 07:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:17 INFO - 'MOZ_NO_REMOTE': '1', 07:49:17 INFO - 'NO_EM_RESTART': '1', 07:49:17 INFO - 'PAGER': '/bin/cat', 07:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:17 INFO - 'PWD': '/builds/slave/test', 07:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:17 INFO - 'SHELL': '/bin/bash', 07:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:17 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:17 INFO - 'USER': 'cltbld', 07:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:17 INFO - 'XPC_FLAGS': '0x0', 07:49:17 INFO - 'XPC_SERVICE_NAME': '0', 07:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:17 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 07:49:17 INFO - Cleaning up... 07:49:17 INFO - Return code: 0 07:49:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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', '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 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:49: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 psutil>=3.1.1 07:49:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:17 INFO - 'HOME': '/Users/cltbld', 07:49:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:17 INFO - 'LOGNAME': 'cltbld', 07:49:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:17 INFO - 'MOZ_NO_REMOTE': '1', 07:49:17 INFO - 'NO_EM_RESTART': '1', 07:49:17 INFO - 'PAGER': '/bin/cat', 07:49:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:17 INFO - 'PWD': '/builds/slave/test', 07:49:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:17 INFO - 'SHELL': '/bin/bash', 07:49:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:17 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:17 INFO - 'USER': 'cltbld', 07:49:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:17 INFO - 'XPC_FLAGS': '0x0', 07:49:17 INFO - 'XPC_SERVICE_NAME': '0', 07:49:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:17 INFO - Downloading/unpacking psutil>=3.1.1 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49: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 07:49:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:49:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:21 INFO - Installing collected packages: psutil 07:49:21 INFO - Running setup.py install for psutil 07:49:21 INFO - building 'psutil._psutil_osx' extension 07:49:21 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 07:49:21 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 07:49:21 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 07:49:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:49:22 INFO - building 'psutil._psutil_posix' extension 07:49:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:49:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:49:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:49:22 INFO - ^ 07:49:22 INFO - 1 warning generated. 07:49:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:22 INFO - Successfully installed psutil 07:49:22 INFO - Cleaning up... 07:49:22 INFO - Return code: 0 07:49:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:49:22 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')]} 07:49:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:22 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')]} 07:49:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:22 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 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:22 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 07:49:22 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 07:49:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:22 INFO - 'HOME': '/Users/cltbld', 07:49:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:22 INFO - 'LOGNAME': 'cltbld', 07:49:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:22 INFO - 'MOZ_NO_REMOTE': '1', 07:49:22 INFO - 'NO_EM_RESTART': '1', 07:49:22 INFO - 'PAGER': '/bin/cat', 07:49:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:22 INFO - 'PWD': '/builds/slave/test', 07:49:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:22 INFO - 'SHELL': '/bin/bash', 07:49:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:22 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:22 INFO - 'USER': 'cltbld', 07:49:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:22 INFO - 'XPC_FLAGS': '0x0', 07:49:22 INFO - 'XPC_SERVICE_NAME': '0', 07:49:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:49:22 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 07:49:22 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 07:49:22 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 07:49:22 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 07:49:22 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 07:49:22 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 07:49:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:49:25 INFO - Installing collected packages: mozsystemmonitor 07:49:25 INFO - Running setup.py install for mozsystemmonitor 07:49:25 INFO - Successfully installed mozsystemmonitor 07:49:25 INFO - Cleaning up... 07:49:25 INFO - Return code: 0 07:49:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:25 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 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:25 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 07:49:25 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 07:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:25 INFO - 'HOME': '/Users/cltbld', 07:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:25 INFO - 'LOGNAME': 'cltbld', 07:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:25 INFO - 'MOZ_NO_REMOTE': '1', 07:49:25 INFO - 'NO_EM_RESTART': '1', 07:49:25 INFO - 'PAGER': '/bin/cat', 07:49:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:25 INFO - 'PWD': '/builds/slave/test', 07:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:25 INFO - 'SHELL': '/bin/bash', 07:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:25 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:25 INFO - 'USER': 'cltbld', 07:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:25 INFO - 'XPC_FLAGS': '0x0', 07:49:25 INFO - 'XPC_SERVICE_NAME': '0', 07:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:49:25 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 07:49:25 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 07:49:25 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 07:49:25 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 07:49:25 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 07:49:25 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 07:49:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:49:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:49:28 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 07:49:28 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 07:49:28 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 07:49:28 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 07:49:28 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 07:49:28 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 07:49:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:49:29 INFO - warning: no files found matching '*.txt' 07:49:29 INFO - no previously-included directories found matching 'build' 07:49:29 INFO - no previously-included directories found matching 'dist' 07:49:29 INFO - no previously-included directories found matching '.git*' 07:49:29 INFO - Installing collected packages: jsonschema, functools32 07:49:29 INFO - Running setup.py install for functools32 07:49:29 INFO - warning: no files found matching '*.txt' 07:49:29 INFO - no previously-included directories found matching 'build' 07:49:29 INFO - no previously-included directories found matching 'dist' 07:49:29 INFO - no previously-included directories found matching '.git*' 07:49:29 INFO - Successfully installed jsonschema functools32 07:49:29 INFO - Cleaning up... 07:49:29 INFO - Return code: 0 07:49:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:49:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:29 INFO - 'HOME': '/Users/cltbld', 07:49:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:29 INFO - 'LOGNAME': 'cltbld', 07:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:29 INFO - 'MOZ_NO_REMOTE': '1', 07:49:29 INFO - 'NO_EM_RESTART': '1', 07:49:29 INFO - 'PAGER': '/bin/cat', 07:49:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:29 INFO - 'PWD': '/builds/slave/test', 07:49:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:29 INFO - 'SHELL': '/bin/bash', 07:49:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:29 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:29 INFO - 'USER': 'cltbld', 07:49:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:29 INFO - 'XPC_FLAGS': '0x0', 07:49:29 INFO - 'XPC_SERVICE_NAME': '0', 07:49:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:49:29 INFO - Cleaning up... 07:49:29 INFO - Return code: 0 07:49:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:49:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:29 INFO - 'HOME': '/Users/cltbld', 07:49:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:29 INFO - 'LOGNAME': 'cltbld', 07:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:29 INFO - 'MOZ_NO_REMOTE': '1', 07:49:29 INFO - 'NO_EM_RESTART': '1', 07:49:29 INFO - 'PAGER': '/bin/cat', 07:49:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:29 INFO - 'PWD': '/builds/slave/test', 07:49:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:29 INFO - 'SHELL': '/bin/bash', 07:49:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:29 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:29 INFO - 'USER': 'cltbld', 07:49:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:29 INFO - 'XPC_FLAGS': '0x0', 07:49:29 INFO - 'XPC_SERVICE_NAME': '0', 07:49:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:32 INFO - Downloading blobuploader-1.2.4.tar.gz 07:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:49:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:49:32 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 07:49:32 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 07:49:32 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 07:49:32 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 07:49:32 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 07:49:32 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 07:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:49:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:34 INFO - Downloading docopt-0.6.1.tar.gz 07:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:49:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:49:34 INFO - Running setup.py install for blobuploader 07:49:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:49:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:49:34 INFO - Running setup.py install for requests 07:49:34 INFO - Running setup.py install for docopt 07:49:34 INFO - Successfully installed blobuploader requests docopt 07:49:34 INFO - Cleaning up... 07:49:35 INFO - Return code: 0 07:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:35 INFO - 'HOME': '/Users/cltbld', 07:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:35 INFO - 'LOGNAME': 'cltbld', 07:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:35 INFO - 'MOZ_NO_REMOTE': '1', 07:49:35 INFO - 'NO_EM_RESTART': '1', 07:49:35 INFO - 'PAGER': '/bin/cat', 07:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:35 INFO - 'PWD': '/builds/slave/test', 07:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:35 INFO - 'SHELL': '/bin/bash', 07:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:35 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:35 INFO - 'USER': 'cltbld', 07:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:35 INFO - 'XPC_FLAGS': '0x0', 07:49:35 INFO - 'XPC_SERVICE_NAME': '0', 07:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-q5PGsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Qy_cCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-pnU36S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-SU_dwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-ejmK7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-yLPL72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:49:35 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-yQstJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-IveWaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-3d5sPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Oct7EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-KYDTwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-VORbap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Lkl16a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-TzbKDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-JOv4lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:49:36 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-QUrvac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:49:37 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-UsC43d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:49:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:49:37 INFO - Running setup.py install for manifestparser 07:49:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:49:37 INFO - Running setup.py install for mozcrash 07:49:37 INFO - Running setup.py install for mozdebug 07:49:37 INFO - Running setup.py install for mozdevice 07:49:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:49:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:49:37 INFO - Running setup.py install for mozfile 07:49:37 INFO - Running setup.py install for mozhttpd 07:49:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Running setup.py install for mozinfo 07:49:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Running setup.py install for mozInstall 07:49:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Running setup.py install for mozleak 07:49:38 INFO - Running setup.py install for mozlog 07:49:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Running setup.py install for moznetwork 07:49:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:49:38 INFO - Running setup.py install for mozprocess 07:49:38 INFO - Running setup.py install for mozprofile 07:49:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:49:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:49:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:49:39 INFO - Running setup.py install for mozrunner 07:49:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:49:39 INFO - Running setup.py install for mozscreenshot 07:49:39 INFO - Running setup.py install for moztest 07:49:39 INFO - Running setup.py install for mozversion 07:49:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:49:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:49:39 INFO - Cleaning up... 07:49:39 INFO - Return code: 0 07:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:49:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:49:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:39 INFO - 'HOME': '/Users/cltbld', 07:49:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:39 INFO - 'LOGNAME': 'cltbld', 07:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:39 INFO - 'MOZ_NO_REMOTE': '1', 07:49:39 INFO - 'NO_EM_RESTART': '1', 07:49:39 INFO - 'PAGER': '/bin/cat', 07:49:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:39 INFO - 'PWD': '/builds/slave/test', 07:49:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:39 INFO - 'SHELL': '/bin/bash', 07:49:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:39 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:39 INFO - 'USER': 'cltbld', 07:49:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:39 INFO - 'XPC_FLAGS': '0x0', 07:49:39 INFO - 'XPC_SERVICE_NAME': '0', 07:49:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-UOsJup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-NqnUdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-qVBCtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-XOf_MU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-F74Fu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-hN0AED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-2zMgPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:49:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-bHUfnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:49:40 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)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-WsbKSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:49:40 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)) 07:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:49:40 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-4tRw0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-Dl0FJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-ZNZxCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-IVOyT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-ICmVWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-aAMbpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-G9ASx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:49:41 INFO - Running setup.py (path:/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/pip-6M1N5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:49:41 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)) 07:49:41 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)) 07:49:41 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)) 07:49:41 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)) 07:49:41 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)) 07:49:41 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)) 07:49:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:49:41 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 07:49:41 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 07:49:41 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 07:49:41 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 07:49:41 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 07:49:41 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 07:49:44 INFO - Downloading blessings-1.6.tar.gz 07:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:49:44 INFO - Installing collected packages: blessings 07:49:44 INFO - Running setup.py install for blessings 07:49:44 INFO - Successfully installed blessings 07:49:44 INFO - Cleaning up... 07:49:44 INFO - Return code: 0 07:49:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:45 INFO - Reading from file tmpfile_stdout 07:49:45 INFO - Current package versions: 07:49:45 INFO - blessings == 1.6 07:49:45 INFO - blobuploader == 1.2.4 07:49:45 INFO - docopt == 0.6.1 07:49:45 INFO - functools32 == 3.2.3-2 07:49:45 INFO - jsonschema == 2.5.1 07:49:45 INFO - manifestparser == 1.1 07:49:45 INFO - mozInstall == 1.12 07:49:45 INFO - mozcrash == 1.0 07:49:45 INFO - mozdebug == 0.1 07:49:45 INFO - mozdevice == 0.49 07:49:45 INFO - mozfile == 1.2 07:49:45 INFO - mozhttpd == 0.7 07:49:45 INFO - mozinfo == 0.9 07:49:45 INFO - mozleak == 0.1 07:49:45 INFO - mozlog == 3.4 07:49:45 INFO - moznetwork == 0.27 07:49:45 INFO - mozprocess == 0.24 07:49:45 INFO - mozprofile == 0.28 07:49:45 INFO - mozrunner == 6.13 07:49:45 INFO - mozscreenshot == 0.1 07:49:45 INFO - mozsystemmonitor == 0.3 07:49:45 INFO - moztest == 0.8 07:49:45 INFO - mozversion == 1.4 07:49:45 INFO - psutil == 3.1.1 07:49:45 INFO - requests == 1.2.3 07:49:45 INFO - wsgiref == 0.1.2 07:49:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:45 INFO - 'HOME': '/Users/cltbld', 07:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:45 INFO - 'LOGNAME': 'cltbld', 07:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:45 INFO - 'MOZ_NO_REMOTE': '1', 07:49:45 INFO - 'NO_EM_RESTART': '1', 07:49:45 INFO - 'PAGER': '/bin/cat', 07:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:45 INFO - 'PWD': '/builds/slave/test', 07:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:45 INFO - 'SHELL': '/bin/bash', 07:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:45 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:45 INFO - 'USER': 'cltbld', 07:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:45 INFO - 'XPC_FLAGS': '0x0', 07:49:45 INFO - 'XPC_SERVICE_NAME': '0', 07:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:49:45 INFO - Cleaning up... 07:49:45 INFO - Return code: 0 07:49:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:45 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 0x10d6f5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6f8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc14a586a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, '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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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 07:49:45 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 07:49:45 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 07:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:49:45 INFO - 'HOME': '/Users/cltbld', 07:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:49:45 INFO - 'LOGNAME': 'cltbld', 07:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:45 INFO - 'MOZ_NO_REMOTE': '1', 07:49:45 INFO - 'NO_EM_RESTART': '1', 07:49:45 INFO - 'PAGER': '/bin/cat', 07:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:45 INFO - 'PWD': '/builds/slave/test', 07:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:49:45 INFO - 'SHELL': '/bin/bash', 07:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:49:45 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:49:45 INFO - 'USER': 'cltbld', 07:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:45 INFO - 'XPC_FLAGS': '0x0', 07:49:45 INFO - 'XPC_SERVICE_NAME': '0', 07:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:49:45 INFO - Cleaning up... 07:49:45 INFO - Return code: 0 07:49:45 INFO - Running post-action listener: _resource_record_post_action 07:49:45 INFO - Running post-action listener: _start_resource_monitoring 07:49:45 INFO - Starting resource monitoring. 07:49:45 INFO - [mozharness: 2017-02-09 15:49:45.640025Z] Finished create-virtualenv step (success) 07:49:45 INFO - [mozharness: 2017-02-09 15:49:45.641004Z] Running install step. 07:49:45 INFO - Running pre-action listener: _resource_record_pre_action 07:49:45 INFO - Running main action method: install 07:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:49:45 INFO - Reading from file tmpfile_stdout 07:49:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:49:46 INFO - Reading from file tmpfile_stdout 07:49:46 INFO - Output received: 07:49:46 INFO - Usage: mozinstall [options] installer 07:49:46 INFO - Options: 07:49:46 INFO - -h, --help show this help message and exit 07:49:46 INFO - -d DEST, --destination=DEST 07:49:46 INFO - Directory to install application into. [default: 07:49:46 INFO - "/builds/slave/test"] 07:49:46 INFO - --app=APP Application being installed. [default: firefox] 07:49:46 INFO - mkdir: /builds/slave/test/build/application 07:49:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:50:07 INFO - Reading from file tmpfile_stdout 07:50:07 INFO - Output received: 07:50:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:50:07 INFO - Running post-action listener: _resource_record_post_action 07:50:07 INFO - [mozharness: 2017-02-09 15:50:07.940474Z] Finished install step (success) 07:50:07 INFO - [mozharness: 2017-02-09 15:50:07.940681Z] Running run-tests step. 07:50:07 INFO - Running pre-action listener: _resource_record_pre_action 07:50:07 INFO - Running main action method: run_tests 07:50:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:50:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:50:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:50:07 INFO - 2017-02-09 07:50:07.956 screenresolution[1887:9368] starting screenresolution argv=screenresolution get 07:50:07 INFO - 2017-02-09 07:50:07.958 screenresolution[1887:9368] Display 0: 1600x1200x32@60 07:50:07 INFO - 2017-02-09 07:50:07.964 screenresolution[1888:9370] starting screenresolution argv=screenresolution list 07:50:07 INFO - Available Modes on Display 0 07:50:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:50:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:50:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:50:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:50:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:50:08 INFO - Intel Iris: 07:50:08 INFO - Chipset Model: Intel Iris 07:50:08 INFO - Type: GPU 07:50:08 INFO - Bus: Built-In 07:50:08 INFO - VRAM (Dynamic, Max): 1536 MB 07:50:08 INFO - Vendor: Intel (0x8086) 07:50:08 INFO - Device ID: 0x0a2e 07:50:08 INFO - Revision ID: 0x0009 07:50:08 INFO - Displays: 07:50:08 INFO - Display: 07:50:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:50:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:50:08 INFO - Display Serial Number: 1600x1200 60 07:50:08 INFO - Main Display: Yes 07:50:08 INFO - Mirror: Off 07:50:08 INFO - Online: Yes 07:50:08 INFO - Rotation: Supported 07:50:08 INFO - Return code: 0 07:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:50:08 INFO - Python 2.7.3 07:50:08 INFO - Return code: 0 07:50:08 INFO - grabbing minidump binary from tooltool 07:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:08 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 0x10d4d3d30>, '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 0x10d3fadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4c8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:50:08 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 07:50:08 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 07:50:08 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 07:50:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:50:08 INFO - Return code: 0 07:50:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:50:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:50:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:50:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:50:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--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 07:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0223 --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 07:50:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.B36KZ4ncQ1/Render', 07:50:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:50:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:50:08 INFO - 'HOME': '/Users/cltbld', 07:50:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:50:08 INFO - 'LOGNAME': 'cltbld', 07:50:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:50:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:08 INFO - 'MOZ_NO_REMOTE': '1', 07:50:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:50:08 INFO - 'NO_EM_RESTART': '1', 07:50:08 INFO - 'PAGER': '/bin/cat', 07:50:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:08 INFO - 'PWD': '/builds/slave/test', 07:50:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:50:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:50:08 INFO - 'SHELL': '/bin/bash', 07:50:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nqxNNtCirB/Listeners', 07:50:08 INFO - 'TMPDIR': '/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/', 07:50:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:50:08 INFO - 'USER': 'cltbld', 07:50:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:50:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:08 INFO - 'XPC_FLAGS': '0x0', 07:50:08 INFO - 'XPC_SERVICE_NAME': '0', 07:50:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:50:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0223', '--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 07:50:08 INFO - mozversion application_buildid: 20170209070421 07:50:08 INFO - mozversion application_changeset: 4dfd0d2d5dd3b640d46ee405af7523e37545c155 07:50:08 INFO - mozversion application_display_name: Nightly 07:50:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:50:08 INFO - mozversion application_name: Firefox 07:50:08 INFO - mozversion application_remotingname: firefox 07:50:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:50:08 INFO - mozversion application_vendor: Mozilla 07:50:08 INFO - mozversion application_version: 54.0a1 07:50:08 INFO - mozversion platform_buildid: 20170209070421 07:50:08 INFO - mozversion platform_changeset: 4dfd0d2d5dd3b640d46ee405af7523e37545c155 07:50:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:50:08 INFO - mozversion platform_version: 54.0a1 07:50:08 INFO - using testdate: 1486655408 07:50:08 INFO - actual date: 1486655408 07:50:08 INFO - starting webserver on 'localhost:49379' 07:50:08 INFO - SUITE-START | Running 2 tests 07:50:08 INFO - TEST-START | dromaeo_css 07:50:08 INFO - operating with platform_type : mac_ 07:50:08 INFO - Initialising browser for dromaeo_css test... 07:50:08 INFO - TEST-INFO | started process 1898 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpScTQZD/profile http://localhost:49379/getInfo.html) 07:50:10 INFO - PROCESS | 1898 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 07:50:10 INFO - PROCESS | 1898 | __metrics Screen width/height:1600/1200 07:50:10 INFO - PROCESS | 1898 | colorDepth:24 07:50:10 INFO - PROCESS | 1898 | Browser inner width/height: 1024/689 07:50:10 INFO - PROCESS | 1898 | __metrics 07:50:10 INFO - PROCESS | 1898 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:50:10 INFO - PROCESS | 1898 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:50:11 INFO - TEST-INFO | 1898: exit 0 07:50:11 INFO - Browser initialized. 07:50:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:50:11 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmpScTQZD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:23 INFO - PROCESS | 1900 | RSS: Main: 236556288 07:50:23 INFO - PROCESS | 1900 | 07:53:27 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49379/tests/dromaeo/cssquery-ext.html) 07:53:29 INFO - PROCESS | 1900 | RSS: Main: 428036096 07:53:29 INFO - PROCESS | 1900 | 07:55:13 INFO - PROCESS | 1900 | ************************* 07:55:13 INFO - PROCESS | 1900 | A coding exception was thrown and uncaught in a Task. 07:55:13 INFO - PROCESS | 1900 | 07:55:13 ERROR - PROCESS | 1900 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:55:13 INFO - PROCESS | 1900 | Full stack: 07:55:13 INFO - PROCESS | 1900 | ************************* 07:56:32 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-ext.html (next: http://localhost:49379/tests/dromaeo/cssquery-jquery.html) 07:56:33 INFO - PROCESS | 1900 | RSS: Main: 371830784 07:56:33 INFO - PROCESS | 1900 | 07:59:35 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49379/tests/dromaeo/cssquery-mootools.html) 07:59:36 INFO - PROCESS | 1900 | RSS: Main: 335052800 07:59:36 INFO - PROCESS | 1900 | 08:02:38 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49379/tests/dromaeo/cssquery-prototype.html) 08:02:38 INFO - PROCESS | 1900 | RSS: Main: 333545472 08:02:38 INFO - PROCESS | 1900 | 08:05:41 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49379/tests/dromaeo/cssquery-yui.html) 08:05:42 INFO - PROCESS | 1900 | RSS: Main: 336764928 08:05:42 INFO - PROCESS | 1900 | 08:08:45 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49379/tests/dromaeo/cssquery-yui.html (next: http://localhost:49379/tests/dromaeo/cssquery-dojo.html) 08:08:46 INFO - PROCESS | 1900 | RSS: Main: 473321472 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | __start_tp_report 08:08:46 INFO - PROCESS | 1900 | _x_x_mozilla_page_load 08:08:46 INFO - PROCESS | 1900 | _x_x_mozilla_page_load_details 08:08:46 INFO - PROCESS | 1900 | |i|pagename|runs| 08:08:46 INFO - PROCESS | 1900 | |0;dojo.html;3308.139883630256;3317.651646577109;3322.202671358875;3340.816255105968;3371.8704234081583;5469.179623056543;5545.833624991246;5595.4124816894255;5694.487496125348;5707.771689132435;5520.503154716075;5563.276774019382;5575.749091290892;5686.800961966332;5712.542996560275;5028.2709007193935;5067.037262920052;5090.796368145288;5114.335136432259;5161.122609156452;5224.843254702365;5233.398159211702;5252.133397989327;5253.868653283679;5259.894802103956;4381.101874115799;4749.833755818564;5027.874303142414;5073.7209453480045;5203.531682148625;5101.362329708786;5150.665206761549;5159.071367153911;5164.6384753067305;5218.373795144607;5080.695158290514;5126.641135120543;5142.614303927183;5143.02282566315;5217.713025783581;5630.71846407678;5669.036263835158;5671.489565939085;5682.829515114553;5718.399568045378;5957.940420595782;6031.487323577501;6039.063945088518;6119.441623354662;6244.5316601254635;6193.318734939198;6214.502839772807;6274.874502509924;6280.057991301295;6287.9685601572155;5658.236138121301;5774.047282198432;5786.566007549451;5804.419558044204;5818.5926985111055;6138.878900475427;6200.0699895016105;6218.253809542884;6223.533235007302;6230.376962303824;5949.8215053548465;5974.253218347707;6051.122587224828;6096.359882212392;6123.693815309217;6150.477209437158;6163.075538669235;6163.965891255875;6195.101710252078;6215.720292586844;5946.643201407843;6061.515078793686;6134.110553969649;6147.877042459126;6165.969170154121;6033.276006879202;6112.381899552462;6113.120078789136;6140.416660417253;6166.537509686791;4970.90058198834;4977.004599080198;4983.8504844854715;4984.900301994012;4993.251012348177;3871.477350557695;4455.975125721037;4458.866234012985;4469.10617876426;4474.194644963938;5601.8599535011135;5618.073017952074;5687.232223649754;5693.715314234355;5789.507891829242;6191;6246.593971391845;6249.406306400884;6268.341824108494;6281.497480201573;5756.194132821408;5764.769409223668;5797.984438829064;5814.360420353758;5835.620684655484;5165.302684137669;5189.195674670432;5379.811706590251;5394.109971854678;5410.513053825096;6152.907706384497;6174.104754810617;6209.316975132731;6211.751529938751;6270.592411493239;6079.361667024898;6128.105930682507;6260.68696565179;6267.310595834363;6286.559940804283;6150.815475535741;6156.661383623944;6216.7824126155365;6227.595206311576;6232.314445411092;6184.845378865564;6196.318404975359;6206.193194884636;6213.347598502273;6213.471854892385;5978.432048955342;5978.850528736816;6089.5737298388685;6115.818436018264;6159.076138579249;5931.288245410578;6110.083487476914;6116.694165291628;6117.632942023492;6143.232095988002;4953.975230123826;6052.515798736003;6062.5453091019235;6088.634681919099;6094.542909281733;5695.7436915338085;5724.713764311851;5749.281339832521;5903.085021821625;5916.970415147896;5923.970380148072;5977.491913187428;5978.3423823378525;5989;5989.8203053908455;5723.627964182315;5765.423457654201;5787.536997040311;5791.13133030032;5793.15999180125 08:08:46 INFO - PROCESS | 1900 | |1;ext.html;450.7903824721506;453.20010182028716;467.69132372634067;495.39314339933577;502.69586899925565;36452.45321320179;38747.612523874755;38747.806260968726;39067.21865562687;40281.59718402815;33971.83014084926;39079.80460097695;39153.41269880954;39516;39621;7785.844283114363;8013.839723205532;8974.147455991686;9168.220701240369;9192.448453092802;10645.467726613677;10934.289271197347;10973;11020.795840831866;11038.337699738002;10866.45667716615;10951.685797704287;10965.890341096567;10984.780304393907;11040.834387484194;7714.421418393643;7912;10695.46522673871;10810.081143102807;10891.346519208873;10660.093892019187;10719.303245289031;10752.139828813677;10771.299865508718;10780.43683665864;38061.619383806086;38350.42474362887;38487.807560962014;38510;38518.80740596279;3830.0999265172663;3839.865604703822;3845.653891149782;3858.440526123696;3968.0476685595536;27996.880124794985;28128.296792580146;28308;28776.856115719496;29327.266818329714;3070.5547695584014;3071.1400807773857;3087.691230876917;3131.7024882636115;3194.8242846643425;440849;446225;449070;449871.75064124796;449957;49895.50104498981;50527.49472505302;50686.49313506818;58679.70660146672;59065.70467147637;61991;62660.68669656623;63236.683816580626;66833;67079;14710.63223419423;14885.776713349309;14901.627459313388;14909.956303058898;14916.47792327285;11359.54561817518;11449.885501145049;11450.599229026944;11451.02666273376;11477.885221147848;17107.65784684324;17126.828731712525;17138.228779704943;17142.657146856993;17154.828451715322;6843.555168914005;6863.749888058552;6899.448044156456;6933.826654333581;6943.89584156238;821.4537332673705;825.4881973176549;827.2596026556198;840.9537475438909;854.8546747053016;26726.866365668437;28835.85582072076;28903.855480722883;28906.964768699403;29399.85300073486;982.150439869522;1002.4987506246877;1007.6372505897871;1016.207358260558;1153.135148638521;14253.002289839818;14770.704585908437;14796.70406591862;15139.697206055816;15150.469733559272;494241;580738.6741464029;581221;584892;585430;54535.63660908509;54627.72686136544;54840.45159548433;54983;55084;1309.2210134969869;1342.3087110138092;1344.1934839096464;1346.2797403389336;1352.9255890925897;23854.642180367657;26828.061017864282;27321.86339068292;28494;28808.279793005342;47464;47600.523994760995;47704.52295477001;47784;47796.522034779206;489926;493436;493484.0651593582;495748;496206;31225.531617026216;32099.518507222878;38053.61946380611;38070.61929380671;38844.80577597207;43829.39838496572;44978;45164.54835451603;45375.31937020881;45491.31763023623;34485.13787155341;35015.9495215144;36005.819970899975;36944.63055369412;37343;34015.319693606485;35426.468602971494;35838.46242306315;36774;37078.44382334213;35583;35650.46524302189;35958;36335.81832090823;36555.63444365629;29570.556441652963;31600.209994749395;31975.520367194047;32209.67790322067;32221.20018396711;23997.880010599834;24059.639105413782;24099.879500602387;24379.39051523655;24592.877035614707 08:08:46 INFO - PROCESS | 1900 | |2;jquery.html;384.56736171806716;391.90986073203146;393.6296462705299;397.9045029192994;412.27439706117224;12908.354582270873;13813.240271785047;19303.227870885166;20574.588508229845;20582.073806678716;15528.767068493953;15848.860403845478;19820;19994.20023199074;20083.59832803343;5705.6006079574445;5892.734826932799;5904.261967254093;5957.731902064417;5959.940400595982;5681.488666020057;5805.303363596353;5817.7382017809305;5861.853453663672;5922.2005029321135;5824.796132135376;5831.2419385479825;5844.152597873306;5847.766089356421;5848;5575.972120139414;5747.683877386742;5813.069908814612;5834;5845.298564172284;5129.25625784263;5133.717645529495;5136.357955255593;5141.280220769096;5152.613553983429;23891.641625375632;24094.638580421306;24133.87933060341;25491.362715932064;25834.224973250646;2685.489756946174;2721.863906804652;2735.7948153888337;2745.533259345916;2781.1378472673537;14885.479008234768;15192.392304307814;15241.923790380977;15296.005759625588;15884.426004149089;1408.6760045189562;1615.9192040397934;1629.7881275434236;1634.7629593708964;1686.4856218853245;113501;119993;122930.38534807359;123156.38421807923;123719.76280237173;9400.200982916529;11062.668119956254;11356.659300221007;11366.829497557543;11497.942510287396;14550.927245363706;14558.781618275734;14573.344199511048;14626.049306795025;14630.926845365704;7096.254893236136;7460.925390746023;7473.4021278297605;8023.068696338869;8470.661173553111;7711.807204819925;8025;8115.959420202861;8123.878141827878;8249.133840946733;6898.586084834926;7098.254683258184;7107.822304442327;7135.8572828544175;7140.107486564179;1841.7329487224276;1904.9142788574547;1910.2712045598755;1913.8851569016038;1914.0094301925842;984.4929861121528;990.3711143423977;995.5967833027636;1000.2198285337303;1032.1226957086417;19551.005426425825;21448.356549303546;21490.677639835416;21492.677609835864;21777.673334899988;966.8888077871135;978.8776402949632;1005.5123265216364;1013.690824298596;1018.9592416303265;10924.617638382619;11243.887561124448;11310.943445282886;11327;11464.54141834334;676466;694198;698692;700940;700954;121445;134606;136219;136933.31533342268;140055.5994440063;1029.7168278723261;1034.5499707627357;1036.7356324137447;1052.752603138262;1063.4204358624568;18259.45221643353;18885.811141888957;18900.3384881534;18948.43154705361;18979.43061708151;42970.78514607407;48516;54010.45989540054;54729.726351367986;55715.60710982096;62599.6870015647;77590.22409776055;78009;78862.6056869712;79941.60029199817;8067.636956336862;8115.553644549606;8141.8778718320455;8191.426600137933;8245;13277.66805829862;13325.733485330045;13528.59414217575;13578.32108394596;13598;11347.943260283646;11544.365059921785;11691.240069395462;11699.707507312385;11829.52681892749;10335.431551264752;10884.510197040994;11497.597584084851;11520.596779112691;11760.82358764602;11366.602168924379;11792.70518237051;11902.761944761229;11934.880651193376;11956.880431195925;7107;8023.799405014688;8111.918880811117;8170.673173073248;8279.62741676614;9400.95299523498;11088.445577721242;11191.720206994565;11583.305001699924;11711.414429278673 08:08:46 INFO - PROCESS | 1900 | |3;mootools.html;1260.5021016698404;1405.381632081884;1406.7045920356725;1422.0543338679772;1425.8859291256697;8173.673053077877;8530.829383412343;8583.613737381816;8593.011803642567;8603.225709686127;8116.472429292106;8399.118092600265;8407.991041075064;8409.66361345547;8508.234258916696;2158.460384903774;2260.3219034289727;2298.896549655261;2301.056566807609;2305.5043165719367;2109.48317662173;2200.460887082667;2295.494991101955;2296.9540609187807;2300.8274379421528;1912.3784769949752;1975.0026236750493;1978.1988294740654;2191.9561608767817;2261.2537862505333;2256.435891027243;2274.8407611467205;2281.212981521389;2285.5543169082034;2285.680004799313;2224.5773303072365;2301;2304.6888670029666;2308.9422764431024;2310.5378924215224;8432.83134337316;8505.787355316104;8510.531920744357;8522.48865068098;8528.786780330542;5058.317127187856;5166.819161329373;5217.452167522393;5225.895482090337;5241.030409374278;3295.439775238215;3333.5333053372547;3453.740969427278;3459.688628023465;3521.894343169709;1100.5762781329165;1106.3417266726285;1114.1309778372881;1209.76409600128;1285.3316275536667;10826.296290741077;10896.727581810519;10987.450627468674;11012.119030477463;11013.118950483942;4299.720518166309;4446.73319600825;4530.77346132692;4537.251353526631;4548.204064288736;8788.60451279694;8789.165029322205;8789.208971192624;8799.560021998874;8816.823663526693;5069.417017043087;5097.592192624581;5113.71874546896;5118.462561431071;5131.923021154686;4594.081183763261;4606.378138951266;4668.369770080995;4671.976640116778;4674.95325046752;3610.223801882608;3656.104254457675;3669.5414072571443;3746;3749.1939233065023;1141.577616281981;1141.8058929981923;1145.7192987718063;1152.7348709796793;1158.1834806461425;603.541308605463;757.7575175943645;762.6186906546727;775.9534427934342;778.3656320099101;5378.97310513445;5486.478784515544;5525.668459892339;5840.415958404125;5932.7923522677365;931.7717159296016;952.4713783849892;959.6785076999283;960.3325688646323;977.3842479238176;3257.576515053028;3516.4373700207843;3608.682830766804;3781.716371272166;3880.165764360676;8955.328350373748;9405.43567385959;9531.332806703464;9534.90465095354;9590.184834289024;9292.58183381736;9307.06929307064;9319.906800931903;9469;9527.52362381878;7792.571408572583;8021.197880211932;8026.919730802734;8043.919560804434;8046.114927357986;5515.365732940763;5519.641223320471;5565.944340556543;5634.971825140848;5667.659940403589;9054.456732596065;9171.174594286545;9208.677696280865;9467.763305917408;9490.905090949278;8981.01208867011;9362.95318523403;9394.76513087151;9478.436058050345;9523;7180.425565954607;7360.558366498028;7363.447741419308;7370.336669699538;7379.8155046124275;7915.564643944638;7971.920280797118;7997.440179187401;8068;8073.7577872663915;7024.719011239493;7073.1865835427525;7237.203907570269;7290;7306.342429181399;7194.280571942764;7206.855862882818;7213.953976673458;7232.710691572278;7284.708611655687;6262.467690246198;6408.58344207625;6431.29255781873;6450.580712253689;6501.642409667514;4326.956730432781;4998.600111991104;5020.046191223656;5054.4187418447345;5140.357455318085;4770.713757174581;4805.471398146131;4846.321514987834;4873.439554451142;5006.499350064964 08:08:46 INFO - PROCESS | 1900 | |4;prototype.html;352.8958957107653;355.7545293747314;364.38055305979833;367.9503267058946;371.8215256676797;4139.56534563871;4712.787924543395;4860.63545234108;5000.399952005764;5385.973070134649;4907.012659872748;5041.77312020959;5263.0263401270695;5328.760205790739;5340.866478338044;3572.8749493767723;3583.802890841003;3725.850965961365;4063.2121866378698;4122.546519882825;3615.3673107206264;3825.713071519633;4074.8590394689386;4085.6935729820384;4099.692523060782;3305.834708264589;3548.769329993555;3916.941245881314;3960.6520852604485;4008.639222469977;3522.277933023724;3889.7082718796205;3966.86115985942;3975.1056012397266;4002.599740025974;3229.919252018695;3306.96693033069;3457.878974235915;3463.705585025276;3515.771474854126;4483;5153;5207.244949482341;5231.346081739783;5237.888257717674;3944.112574670676;4178.623923846838;4432.423784907974;4522.304135949019;4547;4820.469253641831;5373.543248823855;5585.636933599303;5687.317521897357;5688.639214725884;3794.4877441545314;3814.008357826985;3820.5606355269224;3828.2152158807376;3853.4797802296894;4762.976185119087;4947.50524947506;5333;5377.924415116992;5721.914171287434;3168.350488149924;3611.8916432507067;3871.496705428276;3884.4561761353434;3991.186213719321;3947.17109407022;3963.2667956428154;3975.396115544323;3991.261616600938;3992.920141597152;4002.3796311571755;4302.633551546637;4564.3838081859185;4619.46876109245;4647.604953578916;5586.888262234733;5612.915806262909;5640.802571909963;5643.758373157899;5689.743961521742;1091.2688498705727;1258.0816004316716;1258.389681004712;1276.7510335484676;1279.366713476835;786.7993661616251;869.3436455476075;871.6818361298081;878.1920633017639;883.5405589093635;4500.762290370174;4693.48371679115;5024.949750502521;5065.6200784941275;5088.389393272757;5523.7790488380815;5577.776888924398;5586.86032849182;5606.775728970795;5623.634463759924;4605.746683932349;4617.307403889444;4711.646626502958;5019.82430614934;5096.413912400121;2612.641426458269;2691;2846.800723949345;2868.0535423310257;2871.4113606710575;4602.286645569942;5567.777288908398;5708.715539003774;5710.971445142831;5723.77104915807;5382.434844341366;5607.299087614048;5622.550195984311;5632.761162331676;5646.410054046464;4547.113312903952;5325.4940780625775;5466.781328746805;5632.732635157057;5667.231291191476;4909.201754999616;5071.239314102914;5337.452138879681;5443.884003779295;5526.949879522877;4410.536893626123;4750.714957102585;4790.401199850019;5077.289179514797;5204.297419848272;5071.163258062378;5174.9482505174465;5335.706536140549;5440.319960004999;5702.00859398431;3587.8877547960215;3646.781193128421;3660.1398671311686;3663.6519530644546;3683.705303575654;4849.854504364875;4905.190643543775;4995.100881841304;5455.8628788447595;5523.364813046551;4516.486976862788;4661.9953420029715;5241.266222728745;5313.468653134656;5349.224362467498;4339.264294282312;5239.790408383622;5264.499872512105;5287.762050707651;5289.603279754111;4391.956080439155;4639.536046395334;4888.291197776373;5252.343457067866;5412.296401467942;5394.926830243141;5474.972625137008;5491.615586908878;5506.944930550803;5520.475554822286;4403.8018289176425;5244.0216070356555;5329.440408757025;5389.541888939484;5475.631092226943 08:08:46 INFO - PROCESS | 1900 | |5;yui.html;711.5872793779608;716.6273537760361;745.2026331824947;793.7896457438779;825.1130035212146;14225;14526.418943242257;14853.40586376545;14889.478868239601;15218.771718424232;13303.800442993339;13703.314834258272;13767.449302027931;13886.166829990208;13920;882.9558522073903;900.3607438718518;903.0472851142042;904.4437670832457;904.868794024866;866.7659731872391;903.3586153830755;906.9818603627923;908.3959167153835;915.4644532948233;945.1446440970932;952.2191802721771;953.6852838563292;954.804265125651;955.6082006377387;946.0823001688385;947.393668052447;947.9573419196118;949.1979277510493;950.8145911547251;691.4295706042535;703;704.2957042957042;704.6441547018774;708.652760147524;14330.92834535831;14793.40826366944;14829.18439485828;14854.331555080047;14870.182139982297;13640.727185456235;13952.441902323997;13994.230317332542;14064.578062658034;14085.225312607803;11335.659930202108;11467.770644587144;11552.826707599394;11995.520179192821;12054.819177712341;3587.461880717887;3654.853805847763;3663.981680091609;3801.9809900950595;3802.99220706513;102951.48524257405;103662.48168759108;103747;104139.47930260301;107198.46400767946;9147.679831205876;10379.84430233547;10414.375137491776;10681.305715128492;10690.679279621623;20389.59220815605;21360.359189224037;21383.67924481134;21446.356609301747;21477.140914363565;7357.5217610855125;7459.010275421007;7477.252274772588;7581.583012934341;7591.089069311607;3673.338799016149;4215.214538513521;4268.274393353137;4316.179925814085;4377.409049778303;3602.3155600435834;3616.8914932552066;3694.907627309285;3695.926081478355;3696.6488183622514;609.7317579434765;650.4113777031794;680.7685386968454;690.0649619765246;698.4901022253783;636.3954243468723;640.1517988665038;689.6310473896441;691.4433880726064;705.4391758551861;9855.408675479493;9856.556454959544;9899.158571521357;10377.429241391645;10416.427096509613;541.490998461445;569.5728203847115;585.6632436349116;601.744258690055;604.1360853978765;4821.951780482221;4888.853334399973;4898.387701537308;4922.556969872729;4929.7781599828095;89299.55350223338;92206.07793921974;98708;99620.50569241468;105952.88094238073;53394;68702.62594748176;85006.57496712476;85567;90195.74510637287;74752.62623686847;76174.61912690401;76412.85380719404;77249.61375193088;77538;10059.69820905374;10192.13366863825;10771.353718776898;10811.56753729842;10839.891601083888;48016.5198348026;48336.03327933351;49105.26342104943;49865.00269994507;50477.73805654888;59130;67273;67675.64648707096;76559.23440765744;79369.4126117486;14136.717265654836;14389.784153237919;14420.617941190936;14626.122432654074;14636.560903172922;14072.226027568173;15064.548063558112;15209;15350.23248837576;15542;13462.326883655975;14040.2979851005;14206.573802785933;14458.493952711604;14534.572940136031;13873.253856872723;14061.367238474499;14103.858961410255;14219.360128794437;14360.425582976564;12996.493876699706;13213.273269970245;13651.317434128056;13660.521881734092;13684.178949263076;11127.332360058423;11195.328280303207;11432.771344573228;11451.828222576502;12048.096392770753;10180.592776289162;10465.68602941913;11229.66311010671;11632.76734465289;11680.415979201176 08:08:46 INFO - PROCESS | 1900 | __end_tp_report 08:08:46 INFO - PROCESS | 1900 | __start_cc_report 08:08:46 INFO - PROCESS | 1900 | _x_x_mozilla_cycle_collect,2107 08:08:46 INFO - PROCESS | 1900 | __end_cc_report 08:08:46 INFO - PROCESS | 1900 | __startTimestamp1486656526232__endTimestamp 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | ------- Summary: start ------- 08:08:46 INFO - PROCESS | 1900 | Number of tests: 6 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#0] dojo.html Cycles:165 Average:5671.81 Median:5818.59 stddev:640.65 (11.0%) stddev-sans-first:615.20 08:08:46 INFO - PROCESS | 1900 | Values: 3308.1 3317.7 3322.2 3340.8 3371.9 5469.2 5545.8 5595.4 5694.5 5707.8 5520.5 5563.3 5575.7 5686.8 5712.5 5028.3 5067.0 5090.8 5114.3 5161.1 5224.8 5233.4 5252.1 5253.9 5259.9 4381.1 4749.8 5027.9 5073.7 5203.5 5101.4 5150.7 5159.1 5164.6 5218.4 5080.7 5126.6 5142.6 5143.0 5217.7 5630.7 5669.0 5671.5 5682.8 5718.4 5957.9 6031.5 6039.1 6119.4 6244.5 6193.3 6214.5 6274.9 6280.1 6288.0 5658.2 5774.0 5786.6 5804.4 5818.6 6138.9 6200.1 6218.3 6223.5 6230.4 5949.8 5974.3 6051.1 6096.4 6123.7 6150.5 6163.1 6164.0 6195.1 6215.7 5946.6 6061.5 6134.1 6147.9 6166.0 6033.3 6112.4 6113.1 6140.4 6166.5 4970.9 4977.0 4983.9 4984.9 4993.3 3871.5 4456.0 4458.9 4469.1 4474.2 5601.9 5618.1 5687.2 5693.7 5789.5 6191.0 6246.6 6249.4 6268.3 6281.5 5756.2 5764.8 5798.0 5814.4 5835.6 5165.3 5189.2 5379.8 5394.1 5410.5 6152.9 6174.1 6209.3 6211.8 6270.6 6079.4 6128.1 6260.7 6267.3 6286.6 6150.8 6156.7 6216.8 6227.6 6232.3 6184.8 6196.3 6206.2 6213.3 6213.5 5978.4 5978.9 6089.6 6115.8 6159.1 5931.3 6110.1 6116.7 6117.6 6143.2 4954.0 6052.5 6062.5 6088.6 6094.5 5695.7 5724.7 5749.3 5903.1 5917.0 5924.0 5977.5 5978.3 5989.0 5989.8 5723.6 5765.4 5787.5 5791.1 5793.2 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#1] ext.html Cycles:180 Average:63809.67 Median:36504.04 stddev:134477.80 (368.4%) stddev-sans-first:134770.90 08:08:46 INFO - PROCESS | 1900 | Values: 450.8 453.2 467.7 495.4 502.7 36452.5 38747.6 38747.8 39067.2 40281.6 33971.8 39079.8 39153.4 39516.0 39621.0 7785.8 8013.8 8974.1 9168.2 9192.4 10645.5 10934.3 10973.0 11020.8 11038.3 10866.5 10951.7 10965.9 10984.8 11040.8 7714.4 7912.0 10695.5 10810.1 10891.3 10660.1 10719.3 10752.1 10771.3 10780.4 38061.6 38350.4 38487.8 38510.0 38518.8 3830.1 3839.9 3845.7 3858.4 3968.0 27996.9 28128.3 28308.0 28776.9 29327.3 3070.6 3071.1 3087.7 3131.7 3194.8 440849.0 446225.0 449070.0 449871.8 449957.0 49895.5 50527.5 50686.5 58679.7 59065.7 61991.0 62660.7 63236.7 66833.0 67079.0 14710.6 14885.8 14901.6 14910.0 14916.5 11359.5 11449.9 11450.6 11451.0 11477.9 17107.7 17126.8 17138.2 17142.7 17154.8 6843.6 6863.7 6899.4 6933.8 6943.9 821.5 825.5 827.3 841.0 854.9 26726.9 28835.9 28903.9 28907.0 29399.9 982.2 1002.5 1007.6 1016.2 1153.1 14253.0 14770.7 14796.7 15139.7 15150.5 494241.0 580738.7 581221.0 584892.0 585430.0 54535.6 54627.7 54840.5 54983.0 55084.0 1309.2 1342.3 1344.2 1346.3 1352.9 23854.6 26828.1 27321.9 28494.0 28808.3 47464.0 47600.5 47704.5 47784.0 47796.5 489926.0 493436.0 493484.1 495748.0 496206.0 31225.5 32099.5 38053.6 38070.6 38844.8 43829.4 44978.0 45164.5 45375.3 45491.3 34485.1 35015.9 36005.8 36944.6 37343.0 34015.3 35426.5 35838.5 36774.0 37078.4 35583.0 35650.5 35958.0 36335.8 36555.6 29570.6 31600.2 31975.5 32209.7 32221.2 23997.9 24059.6 24099.9 24379.4 24592.9 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#2] jquery.html Cycles:180 Average:37884.73 Median:21491.68 stddev:115217.20 (536.1%) stddev-sans-first:115506.00 08:08:46 INFO - PROCESS | 1900 | Values: 384.6 391.9 393.6 397.9 412.3 12908.4 13813.2 19303.2 20574.6 20582.1 15528.8 15848.9 19820.0 19994.2 20083.6 5705.6 5892.7 5904.3 5957.7 5959.9 5681.5 5805.3 5817.7 5861.9 5922.2 5824.8 5831.2 5844.2 5847.8 5848.0 5576.0 5747.7 5813.1 5834.0 5845.3 5129.3 5133.7 5136.4 5141.3 5152.6 23891.6 24094.6 24133.9 25491.4 25834.2 2685.5 2721.9 2735.8 2745.5 2781.1 14885.5 15192.4 15241.9 15296.0 15884.4 1408.7 1615.9 1629.8 1634.8 1686.5 113501.0 119993.0 122930.4 123156.4 123719.8 9400.2 11062.7 11356.7 11366.8 11497.9 14550.9 14558.8 14573.3 14626.0 14630.9 7096.3 7460.9 7473.4 8023.1 8470.7 7711.8 8025.0 8116.0 8123.9 8249.1 6898.6 7098.3 7107.8 7135.9 7140.1 1841.7 1904.9 1910.3 1913.9 1914.0 984.5 990.4 995.6 1000.2 1032.1 19551.0 21448.4 21490.7 21492.7 21777.7 966.9 978.9 1005.5 1013.7 1019.0 10924.6 11243.9 11310.9 11327.0 11464.5 676466.0 694198.0 698692.0 700940.0 700954.0 121445.0 134606.0 136219.0 136933.3 140055.6 1029.7 1034.5 1036.7 1052.8 1063.4 18259.5 18885.8 18900.3 18948.4 18979.4 42970.8 48516.0 54010.5 54729.7 55715.6 62599.7 77590.2 78009.0 78862.6 79941.6 8067.6 8115.6 8141.9 8191.4 8245.0 13277.7 13325.7 13528.6 13578.3 13598.0 11347.9 11544.4 11691.2 11699.7 11829.5 10335.4 10884.5 11497.6 11520.6 11760.8 11366.6 11792.7 11902.8 11934.9 11956.9 7107.0 8023.8 8111.9 8170.7 8279.6 9401.0 11088.4 11191.7 11583.3 11711.4 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#3] mootools.html Cycles:180 Average:5396.82 Median:5432.73 stddev:2963.39 (54.5%) stddev-sans-first:2955.39 08:08:46 INFO - PROCESS | 1900 | Values: 1260.5 1405.4 1406.7 1422.1 1425.9 8173.7 8530.8 8583.6 8593.0 8603.2 8116.5 8399.1 8408.0 8409.7 8508.2 2158.5 2260.3 2298.9 2301.1 2305.5 2109.5 2200.5 2295.5 2297.0 2300.8 1912.4 1975.0 1978.2 2192.0 2261.3 2256.4 2274.8 2281.2 2285.6 2285.7 2224.6 2301.0 2304.7 2308.9 2310.5 8432.8 8505.8 8510.5 8522.5 8528.8 5058.3 5166.8 5217.5 5225.9 5241.0 3295.4 3333.5 3453.7 3459.7 3521.9 1100.6 1106.3 1114.1 1209.8 1285.3 10826.3 10896.7 10987.5 11012.1 11013.1 4299.7 4446.7 4530.8 4537.3 4548.2 8788.6 8789.2 8789.2 8799.6 8816.8 5069.4 5097.6 5113.7 5118.5 5131.9 4594.1 4606.4 4668.4 4672.0 4675.0 3610.2 3656.1 3669.5 3746.0 3749.2 1141.6 1141.8 1145.7 1152.7 1158.2 603.5 757.8 762.6 776.0 778.4 5379.0 5486.5 5525.7 5840.4 5932.8 931.8 952.5 959.7 960.3 977.4 3257.6 3516.4 3608.7 3781.7 3880.2 8955.3 9405.4 9531.3 9534.9 9590.2 9292.6 9307.1 9319.9 9469.0 9527.5 7792.6 8021.2 8026.9 8043.9 8046.1 5515.4 5519.6 5565.9 5635.0 5667.7 9054.5 9171.2 9208.7 9467.8 9490.9 8981.0 9363.0 9394.8 9478.4 9523.0 7180.4 7360.6 7363.4 7370.3 7379.8 7915.6 7971.9 7997.4 8068.0 8073.8 7024.7 7073.2 7237.2 7290.0 7306.3 7194.3 7206.9 7214.0 7232.7 7284.7 6262.5 6408.6 6431.3 6450.6 6501.6 4327.0 4998.6 5020.0 5054.4 5140.4 4770.7 4805.5 4846.3 4873.4 5006.5 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#4] prototype.html Cycles:180 Average:4365.32 Median:4835.16 stddev:1320.68 (27.3%) stddev-sans-first:1289.59 08:08:46 INFO - PROCESS | 1900 | Values: 352.9 355.8 364.4 368.0 371.8 4139.6 4712.8 4860.6 5000.4 5386.0 4907.0 5041.8 5263.0 5328.8 5340.9 3572.9 3583.8 3725.9 4063.2 4122.5 3615.4 3825.7 4074.9 4085.7 4099.7 3305.8 3548.8 3916.9 3960.7 4008.6 3522.3 3889.7 3966.9 3975.1 4002.6 3229.9 3307.0 3457.9 3463.7 3515.8 4483.0 5153.0 5207.2 5231.3 5237.9 3944.1 4178.6 4432.4 4522.3 4547.0 4820.5 5373.5 5585.6 5687.3 5688.6 3794.5 3814.0 3820.6 3828.2 3853.5 4763.0 4947.5 5333.0 5377.9 5721.9 3168.4 3611.9 3871.5 3884.5 3991.2 3947.2 3963.3 3975.4 3991.3 3992.9 4002.4 4302.6 4564.4 4619.5 4647.6 5586.9 5612.9 5640.8 5643.8 5689.7 1091.3 1258.1 1258.4 1276.8 1279.4 786.8 869.3 871.7 878.2 883.5 4500.8 4693.5 5024.9 5065.6 5088.4 5523.8 5577.8 5586.9 5606.8 5623.6 4605.7 4617.3 4711.6 5019.8 5096.4 2612.6 2691.0 2846.8 2868.1 2871.4 4602.3 5567.8 5708.7 5711.0 5723.8 5382.4 5607.3 5622.6 5632.8 5646.4 4547.1 5325.5 5466.8 5632.7 5667.2 4909.2 5071.2 5337.5 5443.9 5526.9 4410.5 4750.7 4790.4 5077.3 5204.3 5071.2 5174.9 5335.7 5440.3 5702.0 3587.9 3646.8 3660.1 3663.7 3683.7 4849.9 4905.2 4995.1 5455.9 5523.4 4516.5 4662.0 5241.3 5313.5 5349.2 4339.3 5239.8 5264.5 5287.8 5289.6 4392.0 4639.5 4888.3 5252.3 5412.3 5394.9 5475.0 5491.6 5506.9 5520.5 4403.8 5244.0 5329.4 5389.5 5475.6 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - PROCESS | 1900 | [#5] yui.html Cycles:180 Average:19979.27 Median:3749.31 stddev:28154.35 (750.9%) stddev-sans-first:28196.16 08:08:46 INFO - PROCESS | 1900 | Values: 711.6 716.6 745.2 793.8 825.1 14225.0 14526.4 14853.4 14889.5 15218.8 13303.8 13703.3 13767.4 13886.2 13920.0 883.0 900.4 903.0 904.4 904.9 866.8 903.4 907.0 908.4 915.5 945.1 952.2 953.7 954.8 955.6 946.1 947.4 948.0 949.2 950.8 691.4 703.0 704.3 704.6 708.7 14330.9 14793.4 14829.2 14854.3 14870.2 13640.7 13952.4 13994.2 14064.6 14085.2 11335.7 11467.8 11552.8 11995.5 12054.8 3587.5 3654.9 3664.0 3802.0 3803.0 102951.5 103662.5 103747.0 104139.5 107198.5 9147.7 10379.8 10414.4 10681.3 10690.7 20389.6 21360.4 21383.7 21446.4 21477.1 7357.5 7459.0 7477.3 7581.6 7591.1 3673.3 4215.2 4268.3 4316.2 4377.4 3602.3 3616.9 3694.9 3695.9 3696.6 609.7 650.4 680.8 690.1 698.5 636.4 640.2 689.6 691.4 705.4 9855.4 9856.6 9899.2 10377.4 10416.4 541.5 569.6 585.7 601.7 604.1 4822.0 4888.9 4898.4 4922.6 4929.8 89299.6 92206.1 98708.0 99620.5 105952.9 53394.0 68702.6 85006.6 85567.0 90195.7 74752.6 76174.6 76412.9 77249.6 77538.0 10059.7 10192.1 10771.4 10811.6 10839.9 48016.5 48336.0 49105.3 49865.0 50477.7 59130.0 67273.0 67675.6 76559.2 79369.4 14136.7 14389.8 14420.6 14626.1 14636.6 14072.2 15064.5 15209.0 15350.2 15542.0 13462.3 14040.3 14206.6 14458.5 14534.6 13873.3 14061.4 14103.9 14219.4 14360.4 12996.5 13213.3 13651.3 13660.5 13684.2 11127.3 11195.3 11432.8 11451.8 12048.1 10180.6 10465.7 11229.7 11632.8 11680.4 08:08:46 INFO - PROCESS | 1900 | -------- Summary: end -------- 08:08:46 INFO - PROCESS | 1900 | 08:08:46 INFO - TEST-INFO | 1900: exit 0 08:08:46 INFO - TEST-OK | dromaeo_css | took 1118322ms 08:08:46 INFO - TEST-START | kraken 08:08:46 INFO - operating with platform_type : mac_ 08:08:46 INFO - Initialising browser for kraken test... 08:08:46 INFO - TEST-INFO | started process 1905 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmp6ZKkTF/profile http://localhost:49379/getInfo.html) 08:08:48 INFO - PROCESS | 1905 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:08:49 INFO - PROCESS | 1905 | __metrics Screen width/height:1600/1200 08:08:49 INFO - PROCESS | 1905 | colorDepth:24 08:08:49 INFO - PROCESS | 1905 | Browser inner width/height: 1024/689 08:08:49 INFO - PROCESS | 1905 | __metrics 08:08:49 INFO - PROCESS | 1905 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:08:49 INFO - PROCESS | 1905 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:50 INFO - TEST-INFO | 1905: exit 0 08:08:50 INFO - Browser initialized. 08:08:50 INFO - Running cycle 1/1 for kraken test... 08:08:50 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/T/tmp6ZKkTF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:02 INFO - PROCESS | 1906 | RSS: Main: 236769280 08:09:02 INFO - PROCESS | 1906 | 08:09:04 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection) 08:09:05 INFO - PROCESS | 1906 | RSS: Main: 288534528 08:09:05 INFO - PROCESS | 1906 | 08:09:08 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-dft) 08:09:09 INFO - PROCESS | 1906 | RSS: Main: 289898496 08:09:09 INFO - PROCESS | 1906 | 08:09:12 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-fft) 08:09:12 INFO - PROCESS | 1906 | RSS: Main: 380678144 08:09:12 INFO - PROCESS | 1906 | 08:09:14 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator) 08:09:15 INFO - PROCESS | 1906 | RSS: Main: 282972160 08:09:15 INFO - PROCESS | 1906 | 08:09:17 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:18 INFO - PROCESS | 1906 | RSS: Main: 285978624 08:09:18 INFO - PROCESS | 1906 | 08:09:21 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom) 08:09:21 INFO - PROCESS | 1906 | RSS: Main: 328597504 08:09:21 INFO - PROCESS | 1906 | 08:09:24 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate) 08:09:25 INFO - PROCESS | 1906 | RSS: Main: 330813440 08:09:25 INFO - PROCESS | 1906 | 08:09:28 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial) 08:09:28 INFO - PROCESS | 1906 | RSS: Main: 328331264 08:09:28 INFO - PROCESS | 1906 | 08:09:30 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:09:30 INFO - PROCESS | 1906 | RSS: Main: 305344512 08:09:30 INFO - PROCESS | 1906 | 08:09:32 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:09:33 INFO - PROCESS | 1906 | RSS: Main: 308117504 08:09:33 INFO - PROCESS | 1906 | 08:09:35 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:09:36 INFO - PROCESS | 1906 | RSS: Main: 310345728 08:09:36 INFO - PROCESS | 1906 | 08:09:39 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:09:40 INFO - PROCESS | 1906 | RSS: Main: 328601600 08:09:40 INFO - PROCESS | 1906 | 08:09:43 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:09:43 INFO - PROCESS | 1906 | RSS: Main: 322424832 08:09:43 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49379/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49379/tests/kraken/driver.html?testName=ai-astar) 08:09:45 INFO - PROCESS | 1906 | RSS: Main: 367431680 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | __start_tp_report 08:09:45 INFO - PROCESS | 1906 | _x_x_mozilla_page_load 08:09:45 INFO - PROCESS | 1906 | _x_x_mozilla_page_load_details 08:09:45 INFO - PROCESS | 1906 | |i|pagename|runs| 08:09:45 INFO - PROCESS | 1906 | |0;ai-astar;115;112;114;114;115;115;114;115;114;114 08:09:45 INFO - PROCESS | 1906 | |1;audio-beat-detection;144;109;110;149;112;113;111;112;132;109 08:09:45 INFO - PROCESS | 1906 | |2;audio-dft;185;182;182;184;190;186;181;183;187;184 08:09:45 INFO - PROCESS | 1906 | |3;audio-fft;81;59;60;87;60;60;58;59;88;81 08:09:45 INFO - PROCESS | 1906 | |4;audio-oscillator;94;73;86;71;71;70;86;69;69;85 08:09:45 INFO - PROCESS | 1906 | |5;imaging-gaussian-blur;89;89;88;87;87;89;89;88;89;88 08:09:45 INFO - PROCESS | 1906 | |6;imaging-darkroom;94;95;94;94;95;94;101;98;95;95 08:09:45 INFO - PROCESS | 1906 | |7;imaging-desaturate;86;86;85;89;88;86;88;86;85;88 08:09:45 INFO - PROCESS | 1906 | |8;json-parse-financial;61;58;60;59;59;60;60;60;60;61 08:09:45 INFO - PROCESS | 1906 | |9;json-stringify-tinderbox;64;64;75;77;72;67;67;74;97;98 08:09:45 INFO - PROCESS | 1906 | |10;stanford-crypto-aes;92;90;91;90;90;90;88;90;94;91 08:09:45 INFO - PROCESS | 1906 | |11;stanford-crypto-ccm;148;145;147;147;145;144;148;146;176;147 08:09:45 INFO - PROCESS | 1906 | |12;stanford-crypto-pbkdf2;183;186;184;182;179;186;181;180;184;182 08:09:45 INFO - PROCESS | 1906 | |13;stanford-crypto-sha256-iterative;69;69;69;69;68;66;67;68;66;67 08:09:45 INFO - PROCESS | 1906 | __end_tp_report 08:09:45 INFO - PROCESS | 1906 | __start_cc_report 08:09:45 INFO - PROCESS | 1906 | _x_x_mozilla_cycle_collect,2015 08:09:45 INFO - PROCESS | 1906 | __end_cc_report 08:09:45 INFO - PROCESS | 1906 | __startTimestamp1486656585747__endTimestamp 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | ------- Summary: start ------- 08:09:45 INFO - PROCESS | 1906 | Number of tests: 14 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.92 (0.8%) stddev-sans-first:0.93 08:09:45 INFO - PROCESS | 1906 | Values: 115.0 112.0 114.0 114.0 115.0 115.0 114.0 115.0 114.0 114.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:112.50 stddev:15.50 (13.8%) stddev-sans-first:13.81 08:09:45 INFO - PROCESS | 1906 | Values: 144.0 109.0 110.0 149.0 112.0 113.0 111.0 112.0 132.0 109.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:2.72 (1.5%) stddev-sans-first:2.87 08:09:45 INFO - PROCESS | 1906 | Values: 185.0 182.0 182.0 184.0 190.0 186.0 181.0 183.0 187.0 184.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#3] audio-fft Cycles:10 Average:69.30 Median:70.50 stddev:13.06 (18.5%) stddev-sans-first:13.15 08:09:45 INFO - PROCESS | 1906 | Values: 81.0 59.0 60.0 87.0 60.0 60.0 58.0 59.0 88.0 81.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.00 stddev:9.30 (11.8%) stddev-sans-first:7.68 08:09:45 INFO - PROCESS | 1906 | Values: 94.0 73.0 86.0 71.0 71.0 70.0 86.0 69.0 69.0 85.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 08:09:45 INFO - PROCESS | 1906 | Values: 89.0 89.0 88.0 87.0 87.0 89.0 89.0 88.0 89.0 88.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.00 stddev:2.27 (2.4%) stddev-sans-first:2.35 08:09:45 INFO - PROCESS | 1906 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 101.0 98.0 95.0 95.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#7] imaging-desaturate Cycles:10 Average:86.70 Median:87.00 stddev:1.42 (1.6%) stddev-sans-first:1.48 08:09:45 INFO - PROCESS | 1906 | Values: 86.0 86.0 85.0 89.0 88.0 86.0 88.0 86.0 85.0 88.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#8] json-parse-financial Cycles:10 Average:59.80 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.87 08:09:45 INFO - PROCESS | 1906 | Values: 61.0 58.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 61.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#9] json-stringify-tinderbox Cycles:10 Average:75.50 Median:74.50 stddev:12.45 (16.7%) stddev-sans-first:12.49 08:09:45 INFO - PROCESS | 1906 | Values: 64.0 64.0 75.0 77.0 72.0 67.0 67.0 74.0 97.0 98.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:90.50 stddev:1.58 (1.7%) stddev-sans-first:1.59 08:09:45 INFO - PROCESS | 1906 | Values: 92.0 90.0 91.0 90.0 90.0 90.0 88.0 90.0 94.0 91.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#11] stanford-crypto-ccm Cycles:10 Average:149.30 Median:147.00 stddev:9.48 (6.4%) stddev-sans-first:10.04 08:09:45 INFO - PROCESS | 1906 | Values: 148.0 145.0 147.0 147.0 145.0 144.0 148.0 146.0 176.0 147.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:183.50 stddev:2.36 (1.3%) stddev-sans-first:2.50 08:09:45 INFO - PROCESS | 1906 | Values: 183.0 186.0 184.0 182.0 179.0 186.0 181.0 180.0 184.0 182.0 08:09:45 INFO - PROCESS | 1906 | 08:09:45 INFO - PROCESS | 1906 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.23 (1.8%) stddev-sans-first:1.22 08:09:45 INFO - PROCESS | 1906 | Values: 69.0 69.0 69.0 69.0 68.0 66.0 67.0 68.0 66.0 67.0 08:09:45 INFO - PROCESS | 1906 | -------- Summary: end -------- 08:09:45 INFO - PROCESS | 1906 | 08:09:46 INFO - TEST-INFO | 1906: exit 0 08:09:46 INFO - TEST-OK | kraken | took 59820ms 08:09:46 INFO - SUITE-END | took 1178s 08:09:46 INFO - Completed test suite (00:19:38) 08:09:46 INFO - javascript benchmark 08:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7184.05545237663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.139883630256, 3317.651646577109, 3322.202671358875, 3340.816255105968, 3371.8704234081583, 5469.179623056543, 5545.833624991246, 5595.4124816894255, 5694.487496125348, 5707.771689132435, 5520.503154716075, 5563.276774019382, 5575.749091290892, 5686.800961966332, 5712.542996560275, 5028.2709007193935, 5067.037262920052, 5090.796368145288, 5114.335136432259, 5161.122609156452, 5224.843254702365, 5233.398159211702, 5252.133397989327, 5253.868653283679, 5259.894802103956, 4381.101874115799, 4749.833755818564, 5027.874303142414, 5073.7209453480045, 5203.531682148625, 5101.362329708786, 5150.665206761549, 5159.071367153911, 5164.6384753067305, 5218.373795144607, 5080.695158290514, 5126.641135120543, 5142.614303927183, 5143.02282566315, 5217.713025783581, 5630.71846407678, 5669.036263835158, 5671.489565939085, 5682.829515114553, 5718.399568045378, 5957.940420595782, 6031.487323577501, 6039.063945088518, 6119.441623354662, 6244.5316601254635, 6193.318734939198, 6214.502839772807, 6274.874502509924, 6280.057991301295, 6287.9685601572155, 5658.236138121301, 5774.047282198432, 5786.566007549451, 5804.419558044204, 5818.5926985111055, 6138.878900475427, 6200.0699895016105, 6218.253809542884, 6223.533235007302, 6230.376962303824, 5949.8215053548465, 5974.253218347707, 6051.122587224828, 6096.359882212392, 6123.693815309217, 6150.477209437158, 6163.075538669235, 6163.965891255875, 6195.101710252078, 6215.720292586844, 5946.643201407843, 6061.515078793686, 6134.110553969649, 6147.877042459126, 6165.969170154121, 6033.276006879202, 6112.381899552462, 6113.120078789136, 6140.416660417253, 6166.537509686791, 4970.90058198834, 4977.004599080198, 4983.8504844854715, 4984.900301994012, 4993.251012348177, 3871.477350557695, 4455.975125721037, 4458.866234012985, 4469.10617876426, 4474.194644963938, 5601.8599535011135, 5618.073017952074, 5687.232223649754, 5693.715314234355, 5789.507891829242, 6191.0, 6246.593971391845, 6249.406306400884, 6268.341824108494, 6281.497480201573, 5756.194132821408, 5764.769409223668, 5797.984438829064, 5814.360420353758, 5835.620684655484, 5165.302684137669, 5189.195674670432, 5379.811706590251, 5394.109971854678, 5410.513053825096, 6152.907706384497, 6174.104754810617, 6209.316975132731, 6211.751529938751, 6270.592411493239, 6079.361667024898, 6128.105930682507, 6260.68696565179, 6267.310595834363, 6286.559940804283, 6150.815475535741, 6156.661383623944, 6216.7824126155365, 6227.595206311576, 6232.314445411092, 6184.845378865564, 6196.318404975359, 6206.193194884636, 6213.347598502273, 6213.471854892385, 5978.432048955342, 5978.850528736816, 6089.5737298388685, 6115.818436018264, 6159.076138579249, 5931.288245410578, 6110.083487476914, 6116.694165291628, 6117.632942023492, 6143.232095988002, 4953.975230123826, 6052.515798736003, 6062.5453091019235, 6088.634681919099, 6094.542909281733, 5695.7436915338085, 5724.713764311851, 5749.281339832521, 5903.085021821625, 5916.970415147896, 5923.970380148072, 5977.491913187428, 5978.3423823378525, 5989.0, 5989.8203053908455, 5723.627964182315, 5765.423457654201, 5787.536997040311, 5791.13133030032, 5793.15999180125], "value": 5630.4183696964965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.7903824721506, 453.20010182028716, 467.69132372634067, 495.39314339933577, 502.69586899925565, 36452.45321320179, 38747.612523874755, 38747.806260968726, 39067.21865562687, 40281.59718402815, 33971.83014084926, 39079.80460097695, 39153.41269880954, 39516.0, 39621.0, 7785.844283114363, 8013.839723205532, 8974.147455991686, 9168.220701240369, 9192.448453092802, 10645.467726613677, 10934.289271197347, 10973.0, 11020.795840831866, 11038.337699738002, 10866.45667716615, 10951.685797704287, 10965.890341096567, 10984.780304393907, 11040.834387484194, 7714.421418393643, 7912.0, 10695.46522673871, 10810.081143102807, 10891.346519208873, 10660.093892019187, 10719.303245289031, 10752.139828813677, 10771.299865508718, 10780.43683665864, 38061.619383806086, 38350.42474362887, 38487.807560962014, 38510.0, 38518.80740596279, 3830.0999265172663, 3839.865604703822, 3845.653891149782, 3858.440526123696, 3968.0476685595536, 27996.880124794985, 28128.296792580146, 28308.0, 28776.856115719496, 29327.266818329714, 3070.5547695584014, 3071.1400807773857, 3087.691230876917, 3131.7024882636115, 3194.8242846643425, 440849.0, 446225.0, 449070.0, 449871.75064124796, 449957.0, 49895.50104498981, 50527.49472505302, 50686.49313506818, 58679.70660146672, 59065.70467147637, 61991.0, 62660.68669656623, 63236.683816580626, 66833.0, 67079.0, 14710.63223419423, 14885.776713349309, 14901.627459313388, 14909.956303058898, 14916.47792327285, 11359.54561817518, 11449.885501145049, 11450.599229026944, 11451.02666273376, 11477.885221147848, 17107.65784684324, 17126.828731712525, 17138.228779704943, 17142.657146856993, 17154.828451715322, 6843.555168914005, 6863.749888058552, 6899.448044156456, 6933.826654333581, 6943.89584156238, 821.4537332673705, 825.4881973176549, 827.2596026556198, 840.9537475438909, 854.8546747053016, 26726.866365668437, 28835.85582072076, 28903.855480722883, 28906.964768699403, 29399.85300073486, 982.150439869522, 1002.4987506246877, 1007.6372505897871, 1016.207358260558, 1153.135148638521, 14253.002289839818, 14770.704585908437, 14796.70406591862, 15139.697206055816, 15150.469733559272, 494241.0, 580738.6741464029, 581221.0, 584892.0, 585430.0, 54535.63660908509, 54627.72686136544, 54840.45159548433, 54983.0, 55084.0, 1309.2210134969869, 1342.3087110138092, 1344.1934839096464, 1346.2797403389336, 1352.9255890925897, 23854.642180367657, 26828.061017864282, 27321.86339068292, 28494.0, 28808.279793005342, 47464.0, 47600.523994760995, 47704.52295477001, 47784.0, 47796.522034779206, 489926.0, 493436.0, 493484.0651593582, 495748.0, 496206.0, 31225.531617026216, 32099.518507222878, 38053.61946380611, 38070.61929380671, 38844.80577597207, 43829.39838496572, 44978.0, 45164.54835451603, 45375.31937020881, 45491.31763023623, 34485.13787155341, 35015.9495215144, 36005.819970899975, 36944.63055369412, 37343.0, 34015.319693606485, 35426.468602971494, 35838.46242306315, 36774.0, 37078.44382334213, 35583.0, 35650.46524302189, 35958.0, 36335.81832090823, 36555.63444365629, 29570.556441652963, 31600.209994749395, 31975.520367194047, 32209.67790322067, 32221.20018396711, 23997.880010599834, 24059.639105413782, 24099.879500602387, 24379.39051523655, 24592.877035614707], "value": 19233.069305052293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.56736171806716, 391.90986073203146, 393.6296462705299, 397.9045029192994, 412.27439706117224, 12908.354582270873, 13813.240271785047, 19303.227870885166, 20574.588508229845, 20582.073806678716, 15528.767068493953, 15848.860403845478, 19820.0, 19994.20023199074, 20083.59832803343, 5705.6006079574445, 5892.734826932799, 5904.261967254093, 5957.731902064417, 5959.940400595982, 5681.488666020057, 5805.303363596353, 5817.7382017809305, 5861.853453663672, 5922.2005029321135, 5824.796132135376, 5831.2419385479825, 5844.152597873306, 5847.766089356421, 5848.0, 5575.972120139414, 5747.683877386742, 5813.069908814612, 5834.0, 5845.298564172284, 5129.25625784263, 5133.717645529495, 5136.357955255593, 5141.280220769096, 5152.613553983429, 23891.641625375632, 24094.638580421306, 24133.87933060341, 25491.362715932064, 25834.224973250646, 2685.489756946174, 2721.863906804652, 2735.7948153888337, 2745.533259345916, 2781.1378472673537, 14885.479008234768, 15192.392304307814, 15241.923790380977, 15296.005759625588, 15884.426004149089, 1408.6760045189562, 1615.9192040397934, 1629.7881275434236, 1634.7629593708964, 1686.4856218853245, 113501.0, 119993.0, 122930.38534807359, 123156.38421807923, 123719.76280237173, 9400.200982916529, 11062.668119956254, 11356.659300221007, 11366.829497557543, 11497.942510287396, 14550.927245363706, 14558.781618275734, 14573.344199511048, 14626.049306795025, 14630.926845365704, 7096.254893236136, 7460.925390746023, 7473.4021278297605, 8023.068696338869, 8470.661173553111, 7711.807204819925, 8025.0, 8115.959420202861, 8123.878141827878, 8249.133840946733, 6898.586084834926, 7098.254683258184, 7107.822304442327, 7135.8572828544175, 7140.107486564179, 1841.7329487224276, 1904.9142788574547, 1910.2712045598755, 1913.8851569016038, 1914.0094301925842, 984.4929861121528, 990.3711143423977, 995.5967833027636, 1000.2198285337303, 1032.1226957086417, 19551.005426425825, 21448.356549303546, 21490.677639835416, 21492.677609835864, 21777.673334899988, 966.8888077871135, 978.8776402949632, 1005.5123265216364, 1013.690824298596, 1018.9592416303265, 10924.617638382619, 11243.887561124448, 11310.943445282886, 11327.0, 11464.54141834334, 676466.0, 694198.0, 698692.0, 700940.0, 700954.0, 121445.0, 134606.0, 136219.0, 136933.31533342268, 140055.5994440063, 1029.7168278723261, 1034.5499707627357, 1036.7356324137447, 1052.752603138262, 1063.4204358624568, 18259.45221643353, 18885.811141888957, 18900.3384881534, 18948.43154705361, 18979.43061708151, 42970.78514607407, 48516.0, 54010.45989540054, 54729.726351367986, 55715.60710982096, 62599.6870015647, 77590.22409776055, 78009.0, 78862.6056869712, 79941.60029199817, 8067.636956336862, 8115.553644549606, 8141.8778718320455, 8191.426600137933, 8245.0, 13277.66805829862, 13325.733485330045, 13528.59414217575, 13578.32108394596, 13598.0, 11347.943260283646, 11544.365059921785, 11691.240069395462, 11699.707507312385, 11829.52681892749, 10335.431551264752, 10884.510197040994, 11497.597584084851, 11520.596779112691, 11760.82358764602, 11366.602168924379, 11792.70518237051, 11902.761944761229, 11934.880651193376, 11956.880431195925, 7107.0, 8023.799405014688, 8111.918880811117, 8170.673173073248, 8279.62741676614, 9400.95299523498, 11088.445577721242, 11191.720206994565, 11583.305001699924, 11711.414429278673], "value": 9801.745573325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1260.5021016698404, 1405.381632081884, 1406.7045920356725, 1422.0543338679772, 1425.8859291256697, 8173.673053077877, 8530.829383412343, 8583.613737381816, 8593.011803642567, 8603.225709686127, 8116.472429292106, 8399.118092600265, 8407.991041075064, 8409.66361345547, 8508.234258916696, 2158.460384903774, 2260.3219034289727, 2298.896549655261, 2301.056566807609, 2305.5043165719367, 2109.48317662173, 2200.460887082667, 2295.494991101955, 2296.9540609187807, 2300.8274379421528, 1912.3784769949752, 1975.0026236750493, 1978.1988294740654, 2191.9561608767817, 2261.2537862505333, 2256.435891027243, 2274.8407611467205, 2281.212981521389, 2285.5543169082034, 2285.680004799313, 2224.5773303072365, 2301.0, 2304.6888670029666, 2308.9422764431024, 2310.5378924215224, 8432.83134337316, 8505.787355316104, 8510.531920744357, 8522.48865068098, 8528.786780330542, 5058.317127187856, 5166.819161329373, 5217.452167522393, 5225.895482090337, 5241.030409374278, 3295.439775238215, 3333.5333053372547, 3453.740969427278, 3459.688628023465, 3521.894343169709, 1100.5762781329165, 1106.3417266726285, 1114.1309778372881, 1209.76409600128, 1285.3316275536667, 10826.296290741077, 10896.727581810519, 10987.450627468674, 11012.119030477463, 11013.118950483942, 4299.720518166309, 4446.73319600825, 4530.77346132692, 4537.251353526631, 4548.204064288736, 8788.60451279694, 8789.165029322205, 8789.208971192624, 8799.560021998874, 8816.823663526693, 5069.417017043087, 5097.592192624581, 5113.71874546896, 5118.462561431071, 5131.923021154686, 4594.081183763261, 4606.378138951266, 4668.369770080995, 4671.976640116778, 4674.95325046752, 3610.223801882608, 3656.104254457675, 3669.5414072571443, 3746.0, 3749.1939233065023, 1141.577616281981, 1141.8058929981923, 1145.7192987718063, 1152.7348709796793, 1158.1834806461425, 603.541308605463, 757.7575175943645, 762.6186906546727, 775.9534427934342, 778.3656320099101, 5378.97310513445, 5486.478784515544, 5525.668459892339, 5840.415958404125, 5932.7923522677365, 931.7717159296016, 952.4713783849892, 959.6785076999283, 960.3325688646323, 977.3842479238176, 3257.576515053028, 3516.4373700207843, 3608.682830766804, 3781.716371272166, 3880.165764360676, 8955.328350373748, 9405.43567385959, 9531.332806703464, 9534.90465095354, 9590.184834289024, 9292.58183381736, 9307.06929307064, 9319.906800931903, 9469.0, 9527.52362381878, 7792.571408572583, 8021.197880211932, 8026.919730802734, 8043.919560804434, 8046.114927357986, 5515.365732940763, 5519.641223320471, 5565.944340556543, 5634.971825140848, 5667.659940403589, 9054.456732596065, 9171.174594286545, 9208.677696280865, 9467.763305917408, 9490.905090949278, 8981.01208867011, 9362.95318523403, 9394.76513087151, 9478.436058050345, 9523.0, 7180.425565954607, 7360.558366498028, 7363.447741419308, 7370.336669699538, 7379.8155046124275, 7915.564643944638, 7971.920280797118, 7997.440179187401, 8068.0, 8073.7577872663915, 7024.719011239493, 7073.1865835427525, 7237.203907570269, 7290.0, 7306.342429181399, 7194.280571942764, 7206.855862882818, 7213.953976673458, 7232.710691572278, 7284.708611655687, 6262.467690246198, 6408.58344207625, 6431.29255781873, 6450.580712253689, 6501.642409667514, 4326.956730432781, 4998.600111991104, 5020.046191223656, 5054.4187418447345, 5140.357455318085, 4770.713757174581, 4805.471398146131, 4846.321514987834, 4873.439554451142, 5006.499350064964], "value": 4344.72536288086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.8958957107653, 355.7545293747314, 364.38055305979833, 367.9503267058946, 371.8215256676797, 4139.56534563871, 4712.787924543395, 4860.63545234108, 5000.399952005764, 5385.973070134649, 4907.012659872748, 5041.77312020959, 5263.0263401270695, 5328.760205790739, 5340.866478338044, 3572.8749493767723, 3583.802890841003, 3725.850965961365, 4063.2121866378698, 4122.546519882825, 3615.3673107206264, 3825.713071519633, 4074.8590394689386, 4085.6935729820384, 4099.692523060782, 3305.834708264589, 3548.769329993555, 3916.941245881314, 3960.6520852604485, 4008.639222469977, 3522.277933023724, 3889.7082718796205, 3966.86115985942, 3975.1056012397266, 4002.599740025974, 3229.919252018695, 3306.96693033069, 3457.878974235915, 3463.705585025276, 3515.771474854126, 4483.0, 5153.0, 5207.244949482341, 5231.346081739783, 5237.888257717674, 3944.112574670676, 4178.623923846838, 4432.423784907974, 4522.304135949019, 4547.0, 4820.469253641831, 5373.543248823855, 5585.636933599303, 5687.317521897357, 5688.639214725884, 3794.4877441545314, 3814.008357826985, 3820.5606355269224, 3828.2152158807376, 3853.4797802296894, 4762.976185119087, 4947.50524947506, 5333.0, 5377.924415116992, 5721.914171287434, 3168.350488149924, 3611.8916432507067, 3871.496705428276, 3884.4561761353434, 3991.186213719321, 3947.17109407022, 3963.2667956428154, 3975.396115544323, 3991.261616600938, 3992.920141597152, 4002.3796311571755, 4302.633551546637, 4564.3838081859185, 4619.46876109245, 4647.604953578916, 5586.888262234733, 5612.915806262909, 5640.802571909963, 5643.758373157899, 5689.743961521742, 1091.2688498705727, 1258.0816004316716, 1258.389681004712, 1276.7510335484676, 1279.366713476835, 786.7993661616251, 869.3436455476075, 871.6818361298081, 878.1920633017639, 883.5405589093635, 4500.762290370174, 4693.48371679115, 5024.949750502521, 5065.6200784941275, 5088.389393272757, 5523.7790488380815, 5577.776888924398, 5586.86032849182, 5606.775728970795, 5623.634463759924, 4605.746683932349, 4617.307403889444, 4711.646626502958, 5019.82430614934, 5096.413912400121, 2612.641426458269, 2691.0, 2846.800723949345, 2868.0535423310257, 2871.4113606710575, 4602.286645569942, 5567.777288908398, 5708.715539003774, 5710.971445142831, 5723.77104915807, 5382.434844341366, 5607.299087614048, 5622.550195984311, 5632.761162331676, 5646.410054046464, 4547.113312903952, 5325.4940780625775, 5466.781328746805, 5632.732635157057, 5667.231291191476, 4909.201754999616, 5071.239314102914, 5337.452138879681, 5443.884003779295, 5526.949879522877, 4410.536893626123, 4750.714957102585, 4790.401199850019, 5077.289179514797, 5204.297419848272, 5071.163258062378, 5174.9482505174465, 5335.706536140549, 5440.319960004999, 5702.00859398431, 3587.8877547960215, 3646.781193128421, 3660.1398671311686, 3663.6519530644546, 3683.705303575654, 4849.854504364875, 4905.190643543775, 4995.100881841304, 5455.8628788447595, 5523.364813046551, 4516.486976862788, 4661.9953420029715, 5241.266222728745, 5313.468653134656, 5349.224362467498, 4339.264294282312, 5239.790408383622, 5264.499872512105, 5287.762050707651, 5289.603279754111, 4391.956080439155, 4639.536046395334, 4888.291197776373, 5252.343457067866, 5412.296401467942, 5394.926830243141, 5474.972625137008, 5491.615586908878, 5506.944930550803, 5520.475554822286, 4403.8018289176425, 5244.0216070356555, 5329.440408757025, 5389.541888939484, 5475.631092226943], "value": 3961.1701082864865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.5872793779608, 716.6273537760361, 745.2026331824947, 793.7896457438779, 825.1130035212146, 14225.0, 14526.418943242257, 14853.40586376545, 14889.478868239601, 15218.771718424232, 13303.800442993339, 13703.314834258272, 13767.449302027931, 13886.166829990208, 13920.0, 882.9558522073903, 900.3607438718518, 903.0472851142042, 904.4437670832457, 904.868794024866, 866.7659731872391, 903.3586153830755, 906.9818603627923, 908.3959167153835, 915.4644532948233, 945.1446440970932, 952.2191802721771, 953.6852838563292, 954.804265125651, 955.6082006377387, 946.0823001688385, 947.393668052447, 947.9573419196118, 949.1979277510493, 950.8145911547251, 691.4295706042535, 703.0, 704.2957042957042, 704.6441547018774, 708.652760147524, 14330.92834535831, 14793.40826366944, 14829.18439485828, 14854.331555080047, 14870.182139982297, 13640.727185456235, 13952.441902323997, 13994.230317332542, 14064.578062658034, 14085.225312607803, 11335.659930202108, 11467.770644587144, 11552.826707599394, 11995.520179192821, 12054.819177712341, 3587.461880717887, 3654.853805847763, 3663.981680091609, 3801.9809900950595, 3802.99220706513, 102951.48524257405, 103662.48168759108, 103747.0, 104139.47930260301, 107198.46400767946, 9147.679831205876, 10379.84430233547, 10414.375137491776, 10681.305715128492, 10690.679279621623, 20389.59220815605, 21360.359189224037, 21383.67924481134, 21446.356609301747, 21477.140914363565, 7357.5217610855125, 7459.010275421007, 7477.252274772588, 7581.583012934341, 7591.089069311607, 3673.338799016149, 4215.214538513521, 4268.274393353137, 4316.179925814085, 4377.409049778303, 3602.3155600435834, 3616.8914932552066, 3694.907627309285, 3695.926081478355, 3696.6488183622514, 609.7317579434765, 650.4113777031794, 680.7685386968454, 690.0649619765246, 698.4901022253783, 636.3954243468723, 640.1517988665038, 689.6310473896441, 691.4433880726064, 705.4391758551861, 9855.408675479493, 9856.556454959544, 9899.158571521357, 10377.429241391645, 10416.427096509613, 541.490998461445, 569.5728203847115, 585.6632436349116, 601.744258690055, 604.1360853978765, 4821.951780482221, 4888.853334399973, 4898.387701537308, 4922.556969872729, 4929.7781599828095, 89299.55350223338, 92206.07793921974, 98708.0, 99620.50569241468, 105952.88094238073, 53394.0, 68702.62594748176, 85006.57496712476, 85567.0, 90195.74510637287, 74752.62623686847, 76174.61912690401, 76412.85380719404, 77249.61375193088, 77538.0, 10059.69820905374, 10192.13366863825, 10771.353718776898, 10811.56753729842, 10839.891601083888, 48016.5198348026, 48336.03327933351, 49105.26342104943, 49865.00269994507, 50477.73805654888, 59130.0, 67273.0, 67675.64648707096, 76559.23440765744, 79369.4126117486, 14136.717265654836, 14389.784153237919, 14420.617941190936, 14626.122432654074, 14636.560903172922, 14072.226027568173, 15064.548063558112, 15209.0, 15350.23248837576, 15542.0, 13462.326883655975, 14040.2979851005, 14206.573802785933, 14458.493952711604, 14534.572940136031, 13873.253856872723, 14061.367238474499, 14103.858961410255, 14219.360128794437, 14360.425582976564, 12996.493876699706, 13213.273269970245, 13651.317434128056, 13660.521881734092, 13684.178949263076, 11127.332360058423, 11195.328280303207, 11432.771344573228, 11451.828222576502, 12048.096392770753, 10180.592776289162, 10465.68602941913, 11229.66311010671, 11632.76734465289, 11680.415979201176], "value": 7524.730310131766, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 110.0, 149.0, 112.0, 113.0, 111.0, 112.0, 132.0, 109.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 182.0, 184.0, 190.0, 186.0, 181.0, 183.0, 187.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 87.0, 60.0, 60.0, 58.0, 59.0, 88.0, 81.0], "value": 69.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 73.0, 86.0, 71.0, 71.0, 70.0, 86.0, 69.0, 69.0, 85.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 87.0, 87.0, 89.0, 89.0, 88.0, 89.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 101.0, 98.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 89.0, 88.0, 86.0, 88.0, 86.0, 85.0, 88.0], "value": 86.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 59.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 75.0, 77.0, 72.0, 67.0, 67.0, 74.0, 97.0, 98.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 90.0, 90.0, 90.0, 88.0, 90.0, 94.0, 91.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 147.0, 147.0, 145.0, 144.0, 148.0, 146.0, 176.0, 147.0], "value": 149.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 184.0, 182.0, 179.0, 186.0, 181.0, 180.0, 184.0, 182.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 66.0, 67.0, 68.0, 66.0, 67.0], "value": 67.8, "unit": "score"}]}]} 08:09:46 INFO - Return code: 0 08:09:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:09:47 ERROR - # TBPL SUCCESS # 08:09:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:09:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:09:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:09:47 INFO - 2017-02-09 08:09:47.065 screenresolution[1910:11561] starting screenresolution argv=screenresolution get 08:09:47 INFO - 2017-02-09 08:09:47.068 screenresolution[1910:11561] Display 0: 1600x1200x32@60 08:09:47 INFO - 2017-02-09 08:09:47.074 screenresolution[1911:11564] starting screenresolution argv=screenresolution list 08:09:47 INFO - Available Modes on Display 0 08:09:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:09:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:09:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:09:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:09:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:09:47 INFO - Intel Iris: 08:09:47 INFO - Chipset Model: Intel Iris 08:09:47 INFO - Type: GPU 08:09:47 INFO - Bus: Built-In 08:09:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:09:47 INFO - Vendor: Intel (0x8086) 08:09:47 INFO - Device ID: 0x0a2e 08:09:47 INFO - Revision ID: 0x0009 08:09:47 INFO - Displays: 08:09:47 INFO - Display: 08:09:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:09:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:09:47 INFO - Display Serial Number: 1600x1200 60 08:09:47 INFO - Main Display: Yes 08:09:47 INFO - Mirror: Off 08:09:47 INFO - Online: Yes 08:09:47 INFO - Rotation: Supported 08:09:47 INFO - Return code: 0 08:09:47 INFO - Running post-action listener: _resource_record_post_action 08:09:47 INFO - [mozharness: 2017-02-09 16:09:47.320470Z] Finished run-tests step (success) 08:09:47 INFO - Running post-run listener: _resource_record_post_run 08:09:47 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 2150400; Write bytes: 553504768; Read time: 19; Write time: 1672 08:09:47 INFO - TinderboxPrint: CPU usage
54.0% 08:09:47 INFO - TinderboxPrint: I/O read bytes / time
2,150,400 / 19 08:09:47 INFO - TinderboxPrint: I/O write bytes / time
553,504,768 / 1,672 08:09:47 INFO - TinderboxPrint: CPU idle
2,210.9 (46.0%) 08:09:47 INFO - TinderboxPrint: CPU system
961.7 (20.0%) 08:09:47 INFO - TinderboxPrint: CPU user
1,633.1 (34.0%) 08:09:47 INFO - TinderboxPrint: Swap in / out
254,545,920 / 0 08:09:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248470016; Write bytes: 243738624; Read time: 17864; Write time: 528 08:09:47 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1245184; Write bytes: 296314880; Read time: 15; Write time: 1100 08:09:47 INFO - Running post-run listener: _upload_blobber_files 08:09:47 INFO - Blob upload gear active. 08:09:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:09:47 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 08:09:47 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'] 08:09:47 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 08:09:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:49 INFO - (blobuploader) - INFO - Done attempting. 08:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:50 INFO - (blobuploader) - INFO - Done attempting. 08:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:51 INFO - (blobuploader) - INFO - Done attempting. 08:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:09:53 INFO - (blobuploader) - INFO - Done attempting. 08:09:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:09:53 INFO - Return code: 0 08:09:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:09:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:09:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976d09de098e0dd125cf43fe00108d8adc8f06b25f8cc3517d1910e7b7b1e974fa95d5ad47a5ef65737942b70610869104e3623d701d8355aa7d643eaccdcb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2c4ca792ab9240f2e042ba3bfe1f72ee0235e55f38733b2723cdec31c399db3d5d71cfae8a97fe4a88f8ceee8089278aa75c6d8e39f7bd53a1e030c8533971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a385311ac156621d88ee0ef724125e655d666f9eef62ca8ec30ea051193b41758a815e3d81a9c3d67d6b1723d9cb1e22e45b1c83d1fee85d78ad975d957bf8a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1131279ed9dbc3b8df783906a989bae2d6bd21065d93d5ea87fda670c25ee9bcbe43a6090549e1abf7860eabae737e6d1b6d99b5836462354f89c2d21eb958d"} 08:09:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:09:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:09:53 INFO - Contents: 08:09:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976d09de098e0dd125cf43fe00108d8adc8f06b25f8cc3517d1910e7b7b1e974fa95d5ad47a5ef65737942b70610869104e3623d701d8355aa7d643eaccdcb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2c4ca792ab9240f2e042ba3bfe1f72ee0235e55f38733b2723cdec31c399db3d5d71cfae8a97fe4a88f8ceee8089278aa75c6d8e39f7bd53a1e030c8533971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a385311ac156621d88ee0ef724125e655d666f9eef62ca8ec30ea051193b41758a815e3d81a9c3d67d6b1723d9cb1e22e45b1c83d1fee85d78ad975d957bf8a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1131279ed9dbc3b8df783906a989bae2d6bd21065d93d5ea87fda670c25ee9bcbe43a6090549e1abf7860eabae737e6d1b6d99b5836462354f89c2d21eb958d"} 08:09:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:09:53 INFO - Copying logs to upload dir... 08:09:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:09:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.333787 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-09 08:09:53.555489) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 08:09:53.559542) ========= 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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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/976d09de098e0dd125cf43fe00108d8adc8f06b25f8cc3517d1910e7b7b1e974fa95d5ad47a5ef65737942b70610869104e3623d701d8355aa7d643eaccdcb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2c4ca792ab9240f2e042ba3bfe1f72ee0235e55f38733b2723cdec31c399db3d5d71cfae8a97fe4a88f8ceee8089278aa75c6d8e39f7bd53a1e030c8533971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a385311ac156621d88ee0ef724125e655d666f9eef62ca8ec30ea051193b41758a815e3d81a9c3d67d6b1723d9cb1e22e45b1c83d1fee85d78ad975d957bf8a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1131279ed9dbc3b8df783906a989bae2d6bd21065d93d5ea87fda670c25ee9bcbe43a6090549e1abf7860eabae737e6d1b6d99b5836462354f89c2d21eb958d"} build_url:https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/TibBZE7OTGuh3-B_5xlFLA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976d09de098e0dd125cf43fe00108d8adc8f06b25f8cc3517d1910e7b7b1e974fa95d5ad47a5ef65737942b70610869104e3623d701d8355aa7d643eaccdcb46", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2c4ca792ab9240f2e042ba3bfe1f72ee0235e55f38733b2723cdec31c399db3d5d71cfae8a97fe4a88f8ceee8089278aa75c6d8e39f7bd53a1e030c8533971", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a385311ac156621d88ee0ef724125e655d666f9eef62ca8ec30ea051193b41758a815e3d81a9c3d67d6b1723d9cb1e22e45b1c83d1fee85d78ad975d957bf8a7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1131279ed9dbc3b8df783906a989bae2d6bd21065d93d5ea87fda670c25ee9bcbe43a6090549e1abf7860eabae737e6d1b6d99b5836462354f89c2d21eb958d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 08:09:53.593740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:09:53.594117) ========= 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.B36KZ4ncQ1/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.nqxNNtCirB/Listeners TMPDIR=/var/folders/k2/9jjq6xks3qn82q_w7h2c5zq000000w/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.005444 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 08:09:53.642920) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 08:09:53.643279) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 08:09:53.643625) ========= ========= Total master_lag: 0.19 =========