builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0277 starttime: 1486692067.02 results: success (0) buildid: 20170209163711 builduid: 48609584f3bd489685b31d41ba05a535 revision: 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.019558) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.020570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.021266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.046883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.047295) ========= 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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:07-- 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 18:01:07 (8.05 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.167768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.168160) ========= 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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.020302 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:07.217696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 18:01:07.218130) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 --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 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:07,300 truncating revision to first 12 chars 2017-02-09 18:01:07,300 Setting DEBUG logging. 2017-02-09 18:01:07,300 attempt 1/10 2017-02-09 18:01:07,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00beaa76c5b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 18:01:08,891 unpacking tar archive at: mozilla-central-00beaa76c5b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.846625 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 18:01:09.090146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:09.090704) ========= script_repo_revision: 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:09.091518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:09.091850) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 18:01:09.112411) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 18:01:09.113098) ========= /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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:09 INFO - MultiFileLogger online at 20170209 18:01:09 in /builds/slave/test 18:01:09 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 18:01:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:01:09 INFO - {'append_to_log': False, 18:01:09 INFO - 'base_work_dir': '/builds/slave/test', 18:01:09 INFO - 'blob_upload_branch': 'Firefox', 18:01:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:01:09 INFO - 'branch': 'Firefox', 18:01:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:01:09 INFO - 'config_files': ('talos/mac_config.py',), 18:01:09 INFO - 'default_actions': ('clobber', 18:01:09 INFO - 'read-buildbot-config', 18:01:09 INFO - 'download-and-extract', 18:01:09 INFO - 'populate-webroot', 18:01:09 INFO - 'create-virtualenv', 18:01:09 INFO - 'install', 18:01:09 INFO - 'run-tests'), 18:01:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:01:09 INFO - 'download_minidump_stackwalk': True, 18:01:09 INFO - 'download_symbols': 'ondemand', 18:01:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:01:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:01:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:01:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:01:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:01:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:01:09 INFO - 'installer_path': 'installer.exe', 18:01:09 INFO - 'log_level': 'info', 18:01:09 INFO - 'log_name': 'talos', 18:01:09 INFO - 'log_to_console': True, 18:01:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:01:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:01:09 INFO - 'opt_config_files': (), 18:01:09 INFO - 'pip_index': False, 18:01:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:01:09 INFO - 'cmd': ('bash', 18:01:09 INFO - '-c', 18:01:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:01:09 INFO - 'enabled': True, 18:01:09 INFO - 'halt_on_failure': False, 18:01:09 INFO - 'name': 'check_screen_resolution'},), 18:01:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:01:09 INFO - 'cmd': ('bash', 18:01:09 INFO - '-c', 18:01:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:01:09 INFO - 'enabled': True, 18:01:09 INFO - 'halt_on_failure': False, 18:01:09 INFO - 'name': 'check_screen_resolution'},), 18:01:09 INFO - 'run_cmd_checks_enabled': True, 18:01:09 INFO - 'sps_profile': False, 18:01:09 INFO - 'sps_profile_interval': 0, 18:01:09 INFO - 'suite': 'dromaeojs', 18:01:09 INFO - 'system_bits': '32', 18:01:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:01:09 INFO - 'title': 't-yosemite-r7-0277', 18:01:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:01:09 INFO - 'use_talos_json': True, 18:01:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:01:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:01:09 INFO - 'work_dir': 'build'} 18:01:09 INFO - [mozharness: 2017-02-10 02:01:09.315355Z] Running clobber step. 18:01:09 INFO - Running pre-action listener: _resource_record_pre_action 18:01:09 INFO - Running main action method: clobber 18:01:09 INFO - rmtree: /builds/slave/test/build 18:01:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:01:10 INFO - Running post-action listener: _resource_record_post_action 18:01:10 INFO - [mozharness: 2017-02-10 02:01:10.011447Z] Finished clobber step (success) 18:01:10 INFO - [mozharness: 2017-02-10 02:01:10.011718Z] Running read-buildbot-config step. 18:01:10 INFO - Running pre-action listener: _resource_record_pre_action 18:01:10 INFO - Running main action method: read_buildbot_config 18:01:10 INFO - Using buildbot properties: 18:01:10 INFO - { 18:01:10 INFO - "project": "", 18:01:10 INFO - "product": "firefox", 18:01:10 INFO - "script_repo_revision": "production", 18:01:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:01:10 INFO - "repository": "", 18:01:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:01:10 INFO - "buildid": "20170209163711", 18:01:10 INFO - "pgo_build": "False", 18:01:10 INFO - "basedir": "/builds/slave/test", 18:01:10 INFO - "buildnumber": 47, 18:01:10 INFO - "slavename": "t-yosemite-r7-0277", 18:01:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:01:10 INFO - "platform": "yosemite_r7", 18:01:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:01:10 INFO - "branch": "mozilla-central", 18:01:10 INFO - "repo_path": "mozilla-central", 18:01:10 INFO - "revision": "00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447", 18:01:10 INFO - "stage_platform": "macosx64", 18:01:10 INFO - "builduid": "48609584f3bd489685b31d41ba05a535", 18:01:10 INFO - "slavebuilddir": "test" 18:01:10 INFO - } 18:01:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:01:10 INFO - Running post-action listener: _resource_record_post_action 18:01:10 INFO - [mozharness: 2017-02-10 02:01:10.017375Z] Finished read-buildbot-config step (success) 18:01:10 INFO - [mozharness: 2017-02-10 02:01:10.017636Z] Running download-and-extract step. 18:01:10 INFO - Running pre-action listener: _resource_record_pre_action 18:01:10 INFO - Running main action method: download_and_extract 18:01:10 INFO - mkdir: /builds/slave/test/build/tests 18:01: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')]} 18:01:10 INFO - trying https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:01:10 INFO - Downloading https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/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 18:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/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 18:01:11 INFO - Downloaded 1199 bytes. 18:01:11 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:01:11 INFO - Using the following test package requirements: 18:01:11 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:01:11 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:01:11 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:01:11 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'jsshell-mac.zip'], 18:01:11 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:01:11 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:01:11 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:01:11 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:01:11 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:01:11 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:01:11 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:01:11 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:01:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:01:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:01:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:01:12 INFO - Expected file size: 34942007 18:01:12 INFO - Obtained file size: 34942007 18:01:19 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 18:01:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:01:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:01:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:01:20 INFO - Expected file size: 34942007 18:01:20 INFO - Obtained file size: 34942007 18:01:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:01:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:01:27 INFO - Fetch https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:01:28 INFO - Expected file size: 14403454 18:01:28 INFO - Obtained file size: 14403454 18:01:28 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')]} 18:01:28 INFO - trying https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:01:28 INFO - Downloading https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/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 18:01:30 INFO - Downloaded 70359156 bytes. 18:01:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:01:30 INFO - mkdir: /builds/slave/test/properties 18:01:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:01:30 INFO - Writing to file /builds/slave/test/properties/build_url 18:01:30 INFO - Contents: 18:01:30 INFO - build_url:https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:01:31 INFO - Running post-action listener: _resource_record_post_action 18:01:31 INFO - Running post-action listener: set_extra_try_arguments 18:01:31 INFO - [mozharness: 2017-02-10 02:01:31.074287Z] Finished download-and-extract step (success) 18:01:31 INFO - [mozharness: 2017-02-10 02:01:31.074438Z] Running populate-webroot step. 18:01:31 INFO - Running pre-action listener: _resource_record_pre_action 18:01:31 INFO - Running main action method: populate_webroot 18:01:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:01:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:01:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:01:31 INFO - '--tppagecycles', 18:01:31 INFO - '7'], 18:01:31 INFO - 'tests': ['tsvgm']}}, 18:01:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:01:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:01:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:01:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:01:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:01:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['damp', 'tps']}, 18:01:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'tests': ['damp', 'tps']}, 18:01:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['dromaeo_dom']}, 18:01:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:01:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['basic_compositor_video']}, 18:01:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:01:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'other-e10s': {'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['a11yr', 18:01:31 INFO - 'ts_paint', 18:01:31 INFO - 'tpaint', 18:01:31 INFO - 'sessionrestore', 18:01:31 INFO - 'sessionrestore_no_auto_restore', 18:01:31 INFO - 'tabpaint']}, 18:01:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['tsvgx', 18:01:31 INFO - 'tsvgr_opacity', 18:01:31 INFO - 'tart', 18:01:31 INFO - 'tscrollx', 18:01:31 INFO - 'cart', 18:01:31 INFO - 'tsvg_static']}, 18:01:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:01:31 INFO - 'tsvgr_opacity', 18:01:31 INFO - 'tart', 18:01:31 INFO - 'tscrollx', 18:01:31 INFO - 'cart', 18:01:31 INFO - 'tsvg_static']}, 18:01:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'talos_options': ['--disable-e10s'], 18:01:31 INFO - 'tests': ['tp5o']}, 18:01:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:01:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'talos_options': ['--disable-e10s', 18:01:31 INFO - '--xperf_path', 18:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:31 INFO - 'tests': ['tp5n']}, 18:01:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:01:31 INFO - 'talos_options': ['--xperf_path', 18:01:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:01:31 INFO - 'tests': ['tp5n']}}, 18:01:31 INFO - 'talos.zip': {'path': '', 18:01:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:01:31 INFO - Running post-action listener: _resource_record_post_action 18:01:31 INFO - [mozharness: 2017-02-10 02:01:31.092973Z] Finished populate-webroot step (success) 18:01:31 INFO - [mozharness: 2017-02-10 02:01:31.093107Z] Running create-virtualenv step. 18:01:31 INFO - Running pre-action listener: _resource_record_pre_action 18:01:31 INFO - Running main action method: create_virtualenv 18:01:31 INFO - Creating virtualenv /builds/slave/test/build/venv 18:01:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:01:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:01:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:01:31 INFO - Using real prefix '/tools/python27' 18:01:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:01:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:01:34 INFO - Installing pip.................done. 18:01:34 INFO - Return code: 0 18:01:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:01:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:01:35 INFO - Reading from file tmpfile_stdout 18:01:35 INFO - Output received: 18:01:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:01:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:35 INFO - 'HOME': '/Users/cltbld', 18:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:35 INFO - 'LOGNAME': 'cltbld', 18:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:35 INFO - 'MOZ_NO_REMOTE': '1', 18:01:35 INFO - 'NO_EM_RESTART': '1', 18:01:35 INFO - 'PAGER': '/bin/cat', 18:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:35 INFO - 'PWD': '/builds/slave/test', 18:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:35 INFO - 'SHELL': '/bin/bash', 18:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:35 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:35 INFO - 'USER': 'cltbld', 18:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:35 INFO - 'XPC_FLAGS': '0x0', 18:01:35 INFO - 'XPC_SERVICE_NAME': '0', 18:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:01:35 INFO - Cleaning up... 18:01:35 INFO - Return code: 0 18:01:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:01:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:35 INFO - 'HOME': '/Users/cltbld', 18:01:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:35 INFO - 'LOGNAME': 'cltbld', 18:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:35 INFO - 'MOZ_NO_REMOTE': '1', 18:01:35 INFO - 'NO_EM_RESTART': '1', 18:01:35 INFO - 'PAGER': '/bin/cat', 18:01:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:35 INFO - 'PWD': '/builds/slave/test', 18:01:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:35 INFO - 'SHELL': '/bin/bash', 18:01:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:35 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:35 INFO - 'USER': 'cltbld', 18:01:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:35 INFO - 'XPC_FLAGS': '0x0', 18:01:35 INFO - 'XPC_SERVICE_NAME': '0', 18:01:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:35 INFO - Downloading/unpacking psutil>=3.1.1 18:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:39 INFO - Installing collected packages: psutil 18:01:39 INFO - Running setup.py install for psutil 18:01:39 INFO - building 'psutil._psutil_osx' extension 18:01:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:01:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:01:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:01:39 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 18:01:39 INFO - building 'psutil._psutil_posix' extension 18:01:39 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 18:01:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:01:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:01:39 INFO - ^ 18:01:39 INFO - 1 warning generated. 18:01:39 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 18:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:01:39 INFO - Successfully installed psutil 18:01:39 INFO - Cleaning up... 18:01:39 INFO - Return code: 0 18:01:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:01:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:39 INFO - 'HOME': '/Users/cltbld', 18:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:39 INFO - 'LOGNAME': 'cltbld', 18:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:39 INFO - 'MOZ_NO_REMOTE': '1', 18:01:39 INFO - 'NO_EM_RESTART': '1', 18:01:39 INFO - 'PAGER': '/bin/cat', 18:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:39 INFO - 'PWD': '/builds/slave/test', 18:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:39 INFO - 'SHELL': '/bin/bash', 18:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:39 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:39 INFO - 'USER': 'cltbld', 18:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:39 INFO - 'XPC_FLAGS': '0x0', 18:01:39 INFO - 'XPC_SERVICE_NAME': '0', 18:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:01:42 INFO - Installing collected packages: mozsystemmonitor 18:01:42 INFO - Running setup.py install for mozsystemmonitor 18:01:43 INFO - Successfully installed mozsystemmonitor 18:01:43 INFO - Cleaning up... 18:01:43 INFO - Return code: 0 18:01:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:43 INFO - 'HOME': '/Users/cltbld', 18:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:43 INFO - 'LOGNAME': 'cltbld', 18:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:43 INFO - 'MOZ_NO_REMOTE': '1', 18:01:43 INFO - 'NO_EM_RESTART': '1', 18:01:43 INFO - 'PAGER': '/bin/cat', 18:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:43 INFO - 'PWD': '/builds/slave/test', 18:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:43 INFO - 'SHELL': '/bin/bash', 18:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:43 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:43 INFO - 'USER': 'cltbld', 18:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:43 INFO - 'XPC_FLAGS': '0x0', 18:01:43 INFO - 'XPC_SERVICE_NAME': '0', 18:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:43 INFO - Downloading/unpacking jsonschema==2.5.1 18:01:43 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 18:01:43 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 18:01:43 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 18:01:43 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 18:01:43 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 18:01:43 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 18:01:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:01:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:01:46 INFO - warning: no files found matching '*.txt' 18:01:46 INFO - no previously-included directories found matching 'build' 18:01:46 INFO - no previously-included directories found matching 'dist' 18:01:46 INFO - no previously-included directories found matching '.git*' 18:01:46 INFO - Installing collected packages: jsonschema, functools32 18:01:46 INFO - Running setup.py install for functools32 18:01:46 INFO - warning: no files found matching '*.txt' 18:01:46 INFO - no previously-included directories found matching 'build' 18:01:46 INFO - no previously-included directories found matching 'dist' 18:01:46 INFO - no previously-included directories found matching '.git*' 18:01:46 INFO - Successfully installed jsonschema functools32 18:01:46 INFO - Cleaning up... 18:01:46 INFO - Return code: 0 18:01:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:01:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:01:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:46 INFO - 'HOME': '/Users/cltbld', 18:01:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:46 INFO - 'LOGNAME': 'cltbld', 18:01:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:46 INFO - 'MOZ_NO_REMOTE': '1', 18:01:46 INFO - 'NO_EM_RESTART': '1', 18:01:46 INFO - 'PAGER': '/bin/cat', 18:01:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:46 INFO - 'PWD': '/builds/slave/test', 18:01:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:46 INFO - 'SHELL': '/bin/bash', 18:01:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:46 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:46 INFO - 'USER': 'cltbld', 18:01:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:46 INFO - 'XPC_FLAGS': '0x0', 18:01:46 INFO - 'XPC_SERVICE_NAME': '0', 18:01:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:01:47 INFO - Cleaning up... 18:01:47 INFO - Return code: 0 18:01:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:47 INFO - 'HOME': '/Users/cltbld', 18:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:47 INFO - 'LOGNAME': 'cltbld', 18:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:47 INFO - 'MOZ_NO_REMOTE': '1', 18:01:47 INFO - 'NO_EM_RESTART': '1', 18:01:47 INFO - 'PAGER': '/bin/cat', 18:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:47 INFO - 'PWD': '/builds/slave/test', 18:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:47 INFO - 'SHELL': '/bin/bash', 18:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:47 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:47 INFO - 'USER': 'cltbld', 18:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:47 INFO - 'XPC_FLAGS': '0x0', 18:01:47 INFO - 'XPC_SERVICE_NAME': '0', 18:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:01:47 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 18:01:47 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 18:01:47 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 18:01:47 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 18:01:47 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 18:01:47 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 18:01:49 INFO - Downloading blobuploader-1.2.4.tar.gz 18:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:01:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:01:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:51 INFO - Downloading docopt-0.6.1.tar.gz 18:01:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:01:51 INFO - Running setup.py install for blobuploader 18:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:01:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:01:51 INFO - Running setup.py install for requests 18:01:51 INFO - Running setup.py install for docopt 18:01:52 INFO - Successfully installed blobuploader requests docopt 18:01:52 INFO - Cleaning up... 18:01:52 INFO - Return code: 0 18:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01: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')]} 18:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01: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')]} 18:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:52 INFO - 'HOME': '/Users/cltbld', 18:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:52 INFO - 'LOGNAME': 'cltbld', 18:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:52 INFO - 'MOZ_NO_REMOTE': '1', 18:01:52 INFO - 'NO_EM_RESTART': '1', 18:01:52 INFO - 'PAGER': '/bin/cat', 18:01:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:52 INFO - 'PWD': '/builds/slave/test', 18:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:52 INFO - 'SHELL': '/bin/bash', 18:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:52 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:52 INFO - 'USER': 'cltbld', 18:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:52 INFO - 'XPC_FLAGS': '0x0', 18:01:52 INFO - 'XPC_SERVICE_NAME': '0', 18:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qcN4NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AWx9Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5GcoBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gB9IPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-R2VOyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Fu0wev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HK49Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-9vxJJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-iOQ1kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Mk0orA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-I90EL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-LbbZqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QCw21F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-K9fKFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-V3g5Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-LrxlOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wUfEPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:01:54 INFO - Running setup.py install for manifestparser 18:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:01:54 INFO - Running setup.py install for mozcrash 18:01:54 INFO - Running setup.py install for mozdebug 18:01:54 INFO - Running setup.py install for mozdevice 18:01:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:01:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:01:54 INFO - Running setup.py install for mozfile 18:01:54 INFO - Running setup.py install for mozhttpd 18:01:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Running setup.py install for mozinfo 18:01:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Running setup.py install for mozInstall 18:01:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Running setup.py install for mozleak 18:01:55 INFO - Running setup.py install for mozlog 18:01:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Running setup.py install for moznetwork 18:01:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:01:55 INFO - Running setup.py install for mozprocess 18:01:55 INFO - Running setup.py install for mozprofile 18:01:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:01:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:01:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:01:56 INFO - Running setup.py install for mozrunner 18:01:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:01:56 INFO - Running setup.py install for mozscreenshot 18:01:56 INFO - Running setup.py install for moztest 18:01:56 INFO - Running setup.py install for mozversion 18:01:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:01:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:01:56 INFO - Cleaning up... 18:01:56 INFO - Return code: 0 18:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:56 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 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:01:56 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 18:01:56 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 18:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:56 INFO - 'HOME': '/Users/cltbld', 18:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:56 INFO - 'LOGNAME': 'cltbld', 18:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:56 INFO - 'MOZ_NO_REMOTE': '1', 18:01:56 INFO - 'NO_EM_RESTART': '1', 18:01:56 INFO - 'PAGER': '/bin/cat', 18:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:56 INFO - 'PWD': '/builds/slave/test', 18:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:56 INFO - 'SHELL': '/bin/bash', 18:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:01:56 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:56 INFO - 'USER': 'cltbld', 18:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:56 INFO - 'XPC_FLAGS': '0x0', 18:01:56 INFO - 'XPC_SERVICE_NAME': '0', 18:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-NUXd7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-gmN7DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-kgy2_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-7lmi31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-5qZMrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-rPgHaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-xYQ9bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-CA8Phv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Di0qml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:57 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)) 18:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-3n3V8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-g8RxWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VYh3Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wyWtmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-PIsw_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-q7KWbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-UTvu5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:58 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)) 18:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-LGKdHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:58 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)) 18:01:58 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)) 18:01:58 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)) 18:01:58 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)) 18:01:58 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)) 18:01:58 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)) 18:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:58 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 18:01:58 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 18:01:58 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 18:01:58 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 18:01:58 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 18:01:58 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 18:02:01 INFO - Downloading blessings-1.6.tar.gz 18:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:02:01 INFO - Installing collected packages: blessings 18:02:01 INFO - Running setup.py install for blessings 18:02:01 INFO - Successfully installed blessings 18:02:01 INFO - Cleaning up... 18:02:01 INFO - Return code: 0 18:02:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:02:02 INFO - Reading from file tmpfile_stdout 18:02:02 INFO - Current package versions: 18:02:02 INFO - blessings == 1.6 18:02:02 INFO - blobuploader == 1.2.4 18:02:02 INFO - docopt == 0.6.1 18:02:02 INFO - functools32 == 3.2.3-2 18:02:02 INFO - jsonschema == 2.5.1 18:02:02 INFO - manifestparser == 1.1 18:02:02 INFO - mozInstall == 1.12 18:02:02 INFO - mozcrash == 1.0 18:02:02 INFO - mozdebug == 0.1 18:02:02 INFO - mozdevice == 0.49 18:02:02 INFO - mozfile == 1.2 18:02:02 INFO - mozhttpd == 0.7 18:02:02 INFO - mozinfo == 0.9 18:02:02 INFO - mozleak == 0.1 18:02:02 INFO - mozlog == 3.4 18:02:02 INFO - moznetwork == 0.27 18:02:02 INFO - mozprocess == 0.24 18:02:02 INFO - mozprofile == 0.28 18:02:02 INFO - mozrunner == 6.13 18:02:02 INFO - mozscreenshot == 0.1 18:02:02 INFO - mozsystemmonitor == 0.3 18:02:02 INFO - moztest == 0.8 18:02:02 INFO - mozversion == 1.4 18:02:02 INFO - psutil == 3.1.1 18:02:02 INFO - requests == 1.2.3 18:02:02 INFO - wsgiref == 0.1.2 18:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:02:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:02:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:02 INFO - 'HOME': '/Users/cltbld', 18:02:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:02 INFO - 'LOGNAME': 'cltbld', 18:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:02 INFO - 'MOZ_NO_REMOTE': '1', 18:02:02 INFO - 'NO_EM_RESTART': '1', 18:02:02 INFO - 'PAGER': '/bin/cat', 18:02:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:02 INFO - 'PWD': '/builds/slave/test', 18:02:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:02 INFO - 'SHELL': '/bin/bash', 18:02:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:02:02 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:02:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:02 INFO - 'USER': 'cltbld', 18:02:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:02 INFO - 'XPC_FLAGS': '0x0', 18:02:02 INFO - 'XPC_SERVICE_NAME': '0', 18:02:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 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)) 18:02:02 INFO - Cleaning up... 18:02:02 INFO - Return code: 0 18:02:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1105e2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105e5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa63bcbe7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, '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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 18:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:03 INFO - 'HOME': '/Users/cltbld', 18:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:03 INFO - 'LOGNAME': 'cltbld', 18:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:03 INFO - 'MOZ_NO_REMOTE': '1', 18:02:03 INFO - 'NO_EM_RESTART': '1', 18:02:03 INFO - 'PAGER': '/bin/cat', 18:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:03 INFO - 'PWD': '/builds/slave/test', 18:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:03 INFO - 'SHELL': '/bin/bash', 18:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:02:03 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:03 INFO - 'USER': 'cltbld', 18:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:03 INFO - 'XPC_FLAGS': '0x0', 18:02:03 INFO - 'XPC_SERVICE_NAME': '0', 18:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:02:03 INFO - Cleaning up... 18:02:03 INFO - Return code: 0 18:02:03 INFO - Running post-action listener: _resource_record_post_action 18:02:03 INFO - Running post-action listener: _start_resource_monitoring 18:02:03 INFO - Starting resource monitoring. 18:02:03 INFO - [mozharness: 2017-02-10 02:02:03.521825Z] Finished create-virtualenv step (success) 18:02:03 INFO - [mozharness: 2017-02-10 02:02:03.522758Z] Running install step. 18:02:03 INFO - Running pre-action listener: _resource_record_pre_action 18:02:03 INFO - Running main action method: install 18:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:02:03 INFO - Reading from file tmpfile_stdout 18:02:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:02:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:02:03 INFO - Reading from file tmpfile_stdout 18:02:03 INFO - Output received: 18:02:03 INFO - Usage: mozinstall [options] installer 18:02:03 INFO - Options: 18:02:03 INFO - -h, --help show this help message and exit 18:02:03 INFO - -d DEST, --destination=DEST 18:02:03 INFO - Directory to install application into. [default: 18:02:03 INFO - "/builds/slave/test"] 18:02:03 INFO - --app=APP Application being installed. [default: firefox] 18:02:03 INFO - mkdir: /builds/slave/test/build/application 18:02:03 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'] 18:02:03 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 18:02:25 INFO - Reading from file tmpfile_stdout 18:02:25 INFO - Output received: 18:02:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:02:25 INFO - Running post-action listener: _resource_record_post_action 18:02:25 INFO - [mozharness: 2017-02-10 02:02:25.966041Z] Finished install step (success) 18:02:25 INFO - [mozharness: 2017-02-10 02:02:25.966178Z] Running run-tests step. 18:02:25 INFO - Running pre-action listener: _resource_record_pre_action 18:02:25 INFO - Running main action method: run_tests 18:02:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:02:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:02:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:02:25 INFO - 2017-02-09 18:02:25.980 screenresolution[29717:271593] starting screenresolution argv=screenresolution get 18:02:25 INFO - 2017-02-09 18:02:25.983 screenresolution[29717:271593] Display 0: 1600x1200x32@60 18:02:25 INFO - 2017-02-09 18:02:25.988 screenresolution[29718:271595] starting screenresolution argv=screenresolution list 18:02:25 INFO - Available Modes on Display 0 18:02:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:02:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:02:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:02:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:02:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:02:26 INFO - Intel Iris: 18:02:26 INFO - Chipset Model: Intel Iris 18:02:26 INFO - Type: GPU 18:02:26 INFO - Bus: Built-In 18:02:26 INFO - VRAM (Dynamic, Max): 1536 MB 18:02:26 INFO - Vendor: Intel (0x8086) 18:02:26 INFO - Device ID: 0x0a2e 18:02:26 INFO - Revision ID: 0x0009 18:02:26 INFO - Displays: 18:02:26 INFO - Display: 18:02:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:02:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:02:26 INFO - Display Serial Number: 1600x1200 60 18:02:26 INFO - Main Display: Yes 18:02:26 INFO - Mirror: Off 18:02:26 INFO - Online: Yes 18:02:26 INFO - Rotation: Supported 18:02:26 INFO - Return code: 0 18:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:02:26 INFO - Python 2.7.3 18:02:26 INFO - Return code: 0 18:02:26 INFO - grabbing minidump binary from tooltool 18:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:02:26 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 0x1103c0d30>, '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 0x1102e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103b5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:02:26 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 18:02:26 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 18:02:26 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 18:02:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:02:26 INFO - Return code: 0 18:02:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:02:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:02:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:02:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:02:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 18:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 18:02:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0Z8NQdBupj/Render', 18:02:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:02:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:02:26 INFO - 'HOME': '/Users/cltbld', 18:02:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:02:26 INFO - 'LOGNAME': 'cltbld', 18:02:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:02:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:02:26 INFO - 'MOZ_NO_REMOTE': '1', 18:02:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:02:26 INFO - 'NO_EM_RESTART': '1', 18:02:26 INFO - 'PAGER': '/bin/cat', 18:02:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:02:26 INFO - 'PWD': '/builds/slave/test', 18:02:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:02:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:02:26 INFO - 'SHELL': '/bin/bash', 18:02:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FdSYEmSnnA/Listeners', 18:02:26 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 18:02:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:02:26 INFO - 'USER': 'cltbld', 18:02:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:02:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:02:26 INFO - 'XPC_FLAGS': '0x0', 18:02:26 INFO - 'XPC_SERVICE_NAME': '0', 18:02:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:02:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 18:02:26 INFO - mozversion application_buildid: 20170209163711 18:02:26 INFO - mozversion application_changeset: 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 18:02:26 INFO - mozversion application_display_name: Nightly 18:02:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:02:26 INFO - mozversion application_name: Firefox 18:02:26 INFO - mozversion application_remotingname: firefox 18:02:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:02:26 INFO - mozversion application_vendor: Mozilla 18:02:26 INFO - mozversion application_version: 54.0a1 18:02:26 INFO - mozversion platform_buildid: 20170209163711 18:02:26 INFO - mozversion platform_changeset: 00beaa76c5b155d249bc26ab6f2c9dcf6b5d7447 18:02:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:02:26 INFO - mozversion platform_version: 54.0a1 18:02:26 INFO - using testdate: 1486692146 18:02:26 INFO - actual date: 1486692146 18:02:26 INFO - starting webserver on 'localhost:49293' 18:02:26 INFO - SUITE-START | Running 2 tests 18:02:26 INFO - TEST-START | dromaeo_css 18:02:26 INFO - operating with platform_type : mac_ 18:02:26 INFO - Initialising browser for dromaeo_css test... 18:02:26 INFO - TEST-INFO | started process 29728 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp2BJNXp/profile http://localhost:49293/getInfo.html) 18:02:28 INFO - PROCESS | 29728 | 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] 18:02:29 INFO - PROCESS | 29728 | __metrics Screen width/height:1600/1200 18:02:29 INFO - PROCESS | 29728 | colorDepth:24 18:02:29 INFO - PROCESS | 29728 | Browser inner width/height: 1024/689 18:02:29 INFO - PROCESS | 29728 | __metrics 18:02:29 INFO - PROCESS | 29728 | 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" 18:02:29 INFO - PROCESS | 29728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:02:29 INFO - TEST-INFO | 29728: exit 0 18:02:29 INFO - Browser initialized. 18:02:29 INFO - Running cycle 1/1 for dromaeo_css test... 18:02:29 INFO - TEST-INFO | started process 29731 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmp2BJNXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:02:42 INFO - PROCESS | 29731 | RSS: Main: 236462080 18:02:42 INFO - PROCESS | 29731 | 18:05:45 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49293/tests/dromaeo/cssquery-ext.html) 18:05:47 INFO - PROCESS | 29731 | RSS: Main: 379383808 18:05:47 INFO - PROCESS | 29731 | 18:07:31 INFO - PROCESS | 29731 | ************************* 18:07:31 INFO - PROCESS | 29731 | A coding exception was thrown and uncaught in a Task. 18:07:31 INFO - PROCESS | 29731 | 18:07:31 ERROR - PROCESS | 29731 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:07:31 INFO - PROCESS | 29731 | Full stack: 18:07:31 INFO - PROCESS | 29731 | ************************* 18:08:50 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-ext.html (next: http://localhost:49293/tests/dromaeo/cssquery-jquery.html) 18:08:51 INFO - PROCESS | 29731 | RSS: Main: 372785152 18:08:51 INFO - PROCESS | 29731 | 18:11:53 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49293/tests/dromaeo/cssquery-mootools.html) 18:11:54 INFO - PROCESS | 29731 | RSS: Main: 345612288 18:11:54 INFO - PROCESS | 29731 | 18:14:56 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49293/tests/dromaeo/cssquery-prototype.html) 18:14:57 INFO - PROCESS | 29731 | RSS: Main: 345513984 18:14:57 INFO - PROCESS | 29731 | 18:18:00 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49293/tests/dromaeo/cssquery-yui.html) 18:18:01 INFO - PROCESS | 29731 | RSS: Main: 331825152 18:18:01 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | Cycle 1(1): loaded http://localhost:49293/tests/dromaeo/cssquery-yui.html (next: http://localhost:49293/tests/dromaeo/cssquery-dojo.html) 18:21:04 INFO - PROCESS | 29731 | RSS: Main: 432664576 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | __start_tp_report 18:21:04 INFO - PROCESS | 29731 | _x_x_mozilla_page_load 18:21:04 INFO - PROCESS | 29731 | _x_x_mozilla_page_load_details 18:21:04 INFO - PROCESS | 29731 | |i|pagename|runs| 18:21:04 INFO - PROCESS | 29731 | |0;dojo.html;3183.506556483746;3189.2345836999125;3229.2411283348424;3244.529543216234;3260.9510857337136;5460.754266058027;5501.779928802848;5547.639403438784;5548.556115510754;5576.9163462548095;4703.412073490814;5557.166425036246;5576.832695019156;5664.5468362531;5697.373288938214;5045.268436076767;5057.468965758598;5106.4382917879;5125.333706618153;5159.76781044852;5193.428722840485;5193.558547523465;5217.269582258468;5230.686158830464;5233.973830130844;5016.548510634024;5022.146235140017;5040.823571175028;5047.268146118829;5164.535191832734;4970.304157417964;5058.595312375001;5069.467705890866;5134.383873935114;5139.049275883936;4373.934390984138;4740.810367585293;5007.599392048627;5013.122703526905;5014.373203349582;5433.891322173535;5480.123180291174;5509.283793106911;5533.197686335499;5535.529479994206;5056.469070747556;5091.643584949055;6063.636181829061;6138.386161383871;6167.691615419256;6159.076138579204;6244.812655620339;6251.187345645082;6256.718447669866;6256.749730010794;5537.501624853782;5727.2268243787385;5735.627184233053;5738.569607279471;5794.159846822229;6143.266246520256;6233.96883015582;6241.531885108635;6246.906791311502;6248.250209974741;5841.386654401226;5914.112883067574;5921.082232253922;5923.585349025613;5923.733431995571;5047.4447810740785;6081.391860813883;6082.635041897501;6090.269167699905;6157.9384206158265;6159.23009623797;6167.5682702210415;6169.722362493699;6180.690965451709;6190.164327815687;6193.349698281706;6207.131001659771;6211.192544969125;6224.097505861625;6224.346443623445;4819.084373968934;4852.296417019513;4943.060818444556;4943.233798761198;4985.227289770091;4314.697971142053;4361;4411.228035093845;4429.734215946989;4432.180046691373;4558.202314594999;5522.337319521683;5523.28197334344;5534.972325138348;5569.805056822992;5444.700541470178;5927.140564618193;5936.257967754031;5938.346781853993;5943.286805583271;5177.689338639693;5571;5626.35296940857;5628.240187574625;5713.143028545668;4504.3919070925;5391.81128660495;5405.702686352289;5427.511523962783;5428.348598168245;6269.46709529686;6272.372762723691;6286.465650419766;6287.497000240061;6287.528435367274;5976.372480889444;6091.695415229132;6206.348333424925;6209.068639704081;6233.940230160974;6211.254649442096;6238.937610623836;6256.124142620128;6258.405451482102;6273.37266273369;5885.3820348862755;5918.260217472816;5927.496162826208;6081.300650425258;6153.84615384619;6158.261008678987;6196.783112591038;6229.345918678474;6241.063840423973;6252.437280644764;4644.674872758875;5948.691287916651;6057;6063.363346848694;6090.147379366981;5228.816991405282;5733.827985160452;5804.21643078179;5805.883882322414;5969.835882002968;5830.067189249699;5903.2325797646035;5909;5918.2898052234;5944.49471794885;6050.334463209131;6065.969670151621;6067.514598832171;6071.848203794941;6074.392560744067;5670;5679.914801278067;5857.502112320501;5865.501432378295;5866.823995280149 18:21:04 INFO - PROCESS | 29731 | |1;ext.html;425.48516295282707;446.6270663995563;468.718768738757;480.7980648127786;492.5173330136465;28317.575236371445;37656.870293891196;39488;39491.21017579647;39499.63002219869;39829;40194;40204.59795402045;40208.79895600525;40210.59789402112;7715.845683086335;8821.51481668508;9015.098490150998;9034.277257819358;9064.909350906506;7779.727709530168;10673.146148308155;10922.508487118099;10929.234953553254;11047.447627618627;11030.28303160292;11094.1124710023;11095.167862410311;11107.389093599848;11113.166512511554;7695.461317707763;7890.092639346434;10854;10954.726131846688;10957.06864916483;7806.0632724073475;7855.764327070197;7856.567888766115;10736.677899663022;10877.292975956616;38191.618083819085;38567.228655426734;38605.8418247453;38640.22719545622;38767.836964891096;3757.849686012556;3773.3592465241495;3785.299719551892;3827.7320587558884;3910.687145028391;22518;29484.705152948623;29684.406311873856;29785.851070744724;30208;3041.635003799558;3116.3923035008183;3206.134343727204;3207.3745619604188;3212.0363890832655;348226;354368.4563154361;354538;354757.22621386725;355193;49192.26211606829;49670.75164624154;51111;59684;60029;52615.473845261055;60274.39725602688;61168.694156529826;61232;64989.025164622566;14943.327550260265;15093.39626414931;15096.622584435258;15096.867734919924;15108.622284442978;11484.598039068593;11519.48162332697;11613.825792613117;11640.94179529097;11663.76672466546;16350.509484715478;16361;16394.426195083113;16399.754003689955;16436.6712665746;5854.297484301911;6835.760748373883;6895.379415852597;6929.826754331182;6930.099087118743;826.5536610230529;842.7850898020965;849.4775712936623;864.4251572704208;879.9296056315479;27393.31516712058;28423.57364639532;28590.428191436054;28846.855765721037;29970.400591988473;1009.2380252909006;1016.2733645443395;1032.2722480651123;1048.8688913885765;1173.8004539228182;11119;13464.394102265422;13564.186148831102;14862.70274594502;15156.545303640909;583801;587313.5074597053;588149;588719;588757;55645.72177139169;55675;55716.442835571936;55730.442695573336;55797;1287.2212311551564;1339.8794108530278;1342.9865701343058;1346.4614154338342;1353.07314489573;26481.71752768004;26989.59515607307;27886;28628.713712862605;28733.13800585986;42319.94200145021;42633;42688.932776680835;42729.145417092106;42761;464253;507963;511304;511806;514105;31021.379572408878;31325.771020911885;35436;35537.466937995436;38082.809585951894;42248.36627450529;43215.56784432241;43390.69827905168;43448.13103737971;43870;28268.717312826608;33298.833505832314;35953.460698089024;37315.62684373122;37468.43797342988;35242.47136293009;35467.645323546436;35605.1098722534;36264.456033159;36595.634043660284;35481;35527.64472355243;35854.64145358513;36067.81966090153;36267;29416.55875161917;31553.368932621677;32019.519707203945;32095.358092837545;32162;23122;23293.208722741434;23578;23921;24159.51680966406 18:21:04 INFO - PROCESS | 29731 | |2;jquery.html;305.28715449425596;392.96659783918363;397.25118152282937;410.15303398482115;420.7853994462823;14584.562463126096;14863;18309.72535411968;20739.688904666444;20900.477488062807;15935.52193434196;17174.914125429354;20716.792832071675;21565.13739450424;21630.35108946734;5521.696306703119;5763.049096899028;5768.019436695772;5772.971135144318;5776.826695199151;5438.401775804658;5723.255976723041;5803.883922321551;5828.0675091985295;5833.358330583633;3629.511900120951;3843.500344955152;5533;5799.391063938289;5825.980453420634;5760.74076666551;5852.034414321632;5858.091995740667;5868.178455016301;5872.941270587282;5688.516476099537;6868.7252509899545;7203.315685009916;7259.056322678018;7264.128304603481;27612.309692257655;27717.307067323276;28062;28165.85917070422;28295.292617684518;2719.0619236363623;2752.7935404844516;2777.291790593406;2796.6364372631633;2800.3979144484033;16377.672446551001;16643.583910402216;16801.66396672072;16886.98678079319;17039.744403833953;1885.9811401885943;1944.1640094759248;1972.8224459798687;1976.6046790641929;1991.601679664073;106688;109272.06283026224;109611.90388096176;114927.85072149255;151827.2408637961;18493.90753046226;20377.388678339674;23216.7678323218;23268.230012847664;23327.18354857572;40085.79957100196;40146.79926600348;40258.39612405816;40299.59700403017;40335.79832100821;9846.852297215548;10039.799204015879;10268.794624107475;10412.635557755442;10556.313839600554;8067.273945344947;8107.675692972333;8118.066422361386;8128.065272493621;8283.461574997606;9246.751688521963;9892.208623310118;10660.243468527064;10800.567977280822;10839.349639021684;3929.5088113985753;4032.5564187939303;4057.5739547347694;4058.411530328145;4061.7156799024374;964.5948701545368;971.3249291742312;972.547765289144;976.4629453800524;996.0885789502524;19355.61288774245;19866.60266794685;20440;20645.96770161486;20692.86189259575;941.3128416256171;945.4043952310138;954.665866946577;980.8970058143935;980.9705708828747;10783.167592790747;10885.945570272257;10916.699880430546;11016.283941543774;11019.83470247947;672085;678707;686034;713868;716773.416132916;139784.01079945962;140722;141454.2927285357;142236;146128;942.3356533643764;1012.2307046644456;1018.2922868606396;1020.9285350025575;1022.3967858963248;19241.807581924;20082.96110389077;20206;20267.391978240677;20313.390598282076;54644.45355546553;56643.71678141583;57958.55103622443;58809.11786323294;60040.69979650074;82872;83820.7426888585;84297.57851210705;85165.57417212875;85732.14017897366;6652.767153149616;7632.580208088609;8018.8396232073865;8266.834663306821;8332;10290.536925838205;12246.693832654255;12645.683857903627;12700.428480718574;12764.106512544404;10533.210009249184;10572.629957951434;10980.286281391684;11009.559617615527;11118.054965327714;10418.479076046318;10811.783584365343;10858.077063449695;10936.671899843017;10943.343399396063;9333.439993600134;10792.244542881923;11290.717732056764;11333.093352531612;11363.204575679623;8073.273405393543;8136.1863813618165;8162.918370816215;8224.547649879314;8241.711540096068;9077.863832042656;10737.248392612442;10786.622468213574;11073.50169242402;11108.50011749457 18:21:04 INFO - PROCESS | 29731 | |3;mootools.html;1271.6502961685535;1406.008763821506;1415.3206460898762;1430.3706369197553;1431.0555033677774;8048.4366094373345;8472.152784721524;8487.448315859465;8487.490750554956;8499.447535910162;8030.397720170996;8365.330773538117;8388.286995605366;8462.873056904136;8478.703245386412;2237.85453945493;2275.374272075176;2278.1798552521163;2278.7493375728654;2279.9886000569973;1981.7423734914441;2226.6548684953777;2278.1912421090524;2283.5204607032542;2286.90852365906;2001.3995801259637;2028.8174064334207;2194.297824696098;2263.864168149916;2271.1937262271904;2216.601011817872;2235.61994460942;2240.339099965514;2247.842651014413;2247.9438014049615;2208.6686996950425;2279.4757205842748;2280.1221529711015;2281.498070424504;2283.0981762203837;8372.790680233044;8475.830483390358;8479.109693482218;8479.406441549094;8486.151384861527;5056.266841308026;5221.347331583552;5223.869403264911;5231.267622532849;5231.686098834082;3248.8791366978353;3329.7336213102894;3466.185446420089;3509.631488693676;3517.4899639552377;1064.8722153341648;1083.7344850511674;1189.6787867275873;1196.7187710887933;1225.1730082194483;10752.354858708424;10797.622083227128;10852.782944341068;10871.45642717861;10890.183236257233;4204.3693445983345;4400.295952647561;4477.015056687524;4478.664100192498;4492.5507449255465;8618.224359807647;8665.43674661145;8706.825863482822;8752.693655722147;8753;4327.961289290611;5074.974625126851;5077.213031980049;5077.289179514871;5091.719955402488;4560.475545312332;4597.7241365518175;4710.199266124767;4747.145513807548;4751.596114330251;3054.4501989641635;3632.891013269606;3647.8176091195332;3673.081729567608;3696.1683621185557;1143.3140115930375;1148.1618418554335;1155.8439610652622;1162.2387336294742;1168.707823044239;630.8769789890928;692.4218277738045;735.3602365941665;740.9147947985942;742.7400409856507;4732.929006064912;5477.287952566141;5572.3034620672415;5627.155926611041;5630.746616402272;561.1694691856076;563.1861959468611;575.9164921086419;586.8943590153727;690.5235387582552;3636.8545258189374;3740.36413809653;3786.4888240087234;3843.1545060086737;3881.573026967031;9359.438433694;9870.950645246729;9887.406755594688;9971.551280192409;10023.398596084258;9875.209983201326;9924.404535727735;10097.899021009844;10110.039546243095;10136.493175341351;7623.542587444771;7825.491343062569;7829.64766585505;7832.412569057344;7835.921640783633;4277.443932288783;5394.190871369326;5472.315960504937;5529.281193444826;5701.6864072474755;9163.129502697233;9262.44425334482;9268.814623707623;9292.442453452815;9300.813983720423;8797.956010219908;9200.309976751903;9218.078192180728;9298.95350523243;9304.860427093734;6173.9073913892225;7072.3634872861685;7223.855522889407;7229.277072292729;7234.16807067194;7703.268189521987;7759.961200193963;7790.766277011699;7848.332891704269;7852.725154619561;7092.786387602043;7135.108111486064;7174.3184397482155;7196.712131514891;7277.090363704537;6853.828654283483;6944.791656250321;7013.368796808311;7077.363037326665;7083.5041547091205;6287.2769631492965;6313.305536391085;6345.333739957238;6426.228852537725;6456.6771661415805;4856;4856.368672072608;4936.703797772145;4992.201247800334;5133.820316288912;4915.95084049155;4960.255961605643;5034.270030845433;5042.571381432619;5126.128558145049 18:21:04 INFO - PROCESS | 29731 | |4;prototype.html;297.28058099399453;352.63908135035945;369.3997254461501;371.31863031337497;374.5318352059927;4357.455318085239;4891.1195984722735;4932.950670493298;4986.950130498703;5348.849997250591;5027.547520723134;5223.25778966043;5254.789808407659;5298.973505132469;5344.706041167734;3994.4407782910416;3996.920061598766;4008.218397412491;4013.719039667217;4032.1935612877396;3342.632310445849;3345.2807646356027;4037.1521980384155;4038.0914294283843;4052.9392059119136;3028.757699384044;3893.9610603894025;4031.21391328691;4034.9798251008706;4038.7374820636564;3992.301347264246;3994.580569040267;4012.2376748418;4024.879253622396;4028.4158796974566;3045.4365942300747;3181.6977387148418;3465.826708664582;3482;3504.4918486819524;4789.832355867528;4904.75191545047;4982.551570358685;5025.874353141201;5176.275321454999;4180;4436.3567282743825;4482.394876691637;4572.199865023607;4614.723116613014;4487.057717879249;4553.043860789238;5582.385937546866;5612.915806262909;5616.719164041822;3259.1200375898375;3858.2669292834553;3862.1696335288048;3866.7679939203736;3881.5342158941107;5743.224664670258;5911.615744976562;5978.432048955342;5983.700814959235;6005.44768473397;3905.4337121117846;3916.1971795782365;3935.665468435158;3936.193080418507;3957.881263562098;3979.2439436507548;3983.0440694233175;3984.9003774905277;4010.47863777707;4018.618231268025;4430.224710675619;4586.243269860503;4607.262837945913;4655.6973796703105;4683.929741053818;5002.324686167393;5127.487531109729;5209.7916083356995;5673.716314184274;5681.57388195887;1170.6488053584062;1227.5028613411582;1278.5972418688084;1288.84533855936;1292.7931530955002;780.5472825761045;851.6891334662804;853.9794945040741;861.0313397427893;871.5772850167664;4454.5990860822685;4555.656081455979;5079.644424890223;5080.872978175576;5081.21241207606;4809.879753006203;5075.751519027825;5377.682467795337;5617.9719101404235;5641.943580564224;4348.869533913988;4550.567696068868;4822.855314340575;5080.49195080489;5106.846794596168;2597.4805038992276;2729.921680936019;2826.321682796155;2827.9112541671607;2878.3811480531785;5034.572061374751;5036.899262014813;5669;5778.306603207642;5829.650220986754;5316.9202461963105;5509.283793106871;5561.555075593943;5608.46719561641;5729.627574207663;5080.6790234539285;5327.934413117392;5789.971050144806;5867.9413205867395;5977.3424923257535;5178.844634660966;5732.942670573241;5773.653580785166;5786.768529258951;5790.420957904176;5512.298973503035;5614.85962850932;5646.802361917313;5657.43425657431;5751.7411716472025;5079.44126146131;5624.606277560531;5714.342850572238;6009.869932668741;6043.3352331244405;3841.4045822897497;3864.343061679465;3884.514435695538;3887.183691424719;3896.3960586109197;4996.550310472075;5055;5111.463296353978;5331.466853314638;5771.5759381059215;5603.831885043455;5606.290081525174;5611.466910643482;5619.499322801477;5631.324241091095;4782.187028205283;5317.448215137775;5353.732313384393;5544.556435485232;5565.471280228372;5309.787608495617;5411.972940135274;5424.7558859850615;5464.262324586289;5465.234867118686;5425.4500384819075;5516.310461192351;5530.313254457429;5548.167774833646;5549.528290095225;4114.979425102855;4440.955590444054;5148.653375306081;5438.945610543844;5454.29094217765 18:21:04 INFO - PROCESS | 29731 | |5;yui.html;705.122122956918;708.592559278415;752.6199269368972;780.9726659566916;820.5363969357313;14243.501477448292;14329.498467553625;14846;15251.847481525181;15260.847391526082;13752.518661846838;13839.30803459828;13858.792118118236;13878.028538002343;13886.583402497941;859.6991053131417;862.8662557303628;865.2688478235912;869.3523325122792;870.6996086350231;864.0711235421946;865.126222515261;868.7480630617114;869.3088994249555;870.0299166429418;821.8658251612766;871.5250188647202;912.5528491039377;932.3799673217336;933.5845548730817;789.5381201996839;912.4981260306805;913.0458670689146;913.6939125393035;914.4330515080626;678.864227154571;679.1883698979722;681.9011243369733;681.990653832331;684.5003147702205;14636.268186590734;14944.551663450115;15082.170480623561;15088.094714317176;15105.39578416862;13508.594742157653;13721.176729396268;13743.244121573309;13847.169169849842;13875.098118622258;11284.32294062359;11536.369850369438;11546.960773530423;11596;12104.87895121055;3559.181388280684;3588.577710045735;3595.352836489431;3641.550928219051;3668.706503479715;87632;97094.51452742761;100875;104559.47720261426;104867;9486;9938.900610993798;10044.648437304806;10178.338408003456;10322.48387580618;20167.697484537744;20185;20256.696149557767;20285.59428811445;20301.898490507454;7219.747308844166;7327.891944813522;7355.852882942311;7432.554046757212;7584.658690358947;4030.334994725896;4127.360259159835;4128.772917489507;4152.335626299778;4293.97853010733;3547.609762926076;3669.9082522936606;3671.173985853215;3672.3022625701565;3677.595464498903;656.5437021270171;664.6045602866287;669.7254125808493;677.3260605697362;683.1153656015472;648.2998361769278;652.7030201258416;673.3132205150816;699.597731304502;725.5247812682701;8719.302455803521;9915.20678345745;9929.751756206153;10130.797384052277;10190.388576685422;639.7217210513442;641.2145122225237;681.7818298144646;698.584342316321;698.8567343694531;4729.314249433882;4827.227643577011;4829.572301830864;4897.559219670246;4933;73872.63063684755;76320.61839690767;80114.59942700366;80376.59811700904;85996.57001714951;48626;73968.26031739722;77472.61263693759;79349.60325198337;84512.15487845166;56676.449559769906;69694.65152674205;70511;70943;71259;10198.694039178836;10453.059224669816;10521.579136834442;10666.253362264568;10866.565337386732;45714;47503.52496475129;47929.76035119802;49168;49828;59921.70039149776;62347.6882615584;63308;63466;64570.67714661397;10078.992100790156;11868.406579671155;12273.815892761437;12546.623601291976;12757.744845103232;14094.577162685136;14170.291485425481;14459.277036148362;14492.130472171704;14711.3379897907;13091.345432728516;13130;13134.934325328311;13257.469701212229;13649.522266720616;12571.811422828481;12957.093003490043;12959.611211663665;12987.480500779862;13130.16177735137;10540;10700.983406576363;12808.615741527768;13262.20426774358;13487.797683034958;10541.156707463231;10951.890481095086;11345.262557933707;11371.658850234506;11385.601503947322;8733.458791112726;10206.387616743019;10285.485725713834;10517.263791534519;10532.420716860646 18:21:04 INFO - PROCESS | 29731 | __end_tp_report 18:21:04 INFO - PROCESS | 29731 | __start_cc_report 18:21:04 INFO - PROCESS | 29731 | _x_x_mozilla_cycle_collect,1457 18:21:04 INFO - PROCESS | 29731 | __end_cc_report 18:21:04 INFO - PROCESS | 29731 | __startTimestamp1486693264322__endTimestamp 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | ------- Summary: start ------- 18:21:04 INFO - PROCESS | 29731 | Number of tests: 6 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#0] dojo.html Cycles:165 Average:5586.93 Median:5738.57 stddev:669.30 (11.7%) stddev-sans-first:644.25 18:21:04 INFO - PROCESS | 29731 | Values: 3183.5 3189.2 3229.2 3244.5 3261.0 5460.8 5501.8 5547.6 5548.6 5576.9 4703.4 5557.2 5576.8 5664.5 5697.4 5045.3 5057.5 5106.4 5125.3 5159.8 5193.4 5193.6 5217.3 5230.7 5234.0 5016.5 5022.1 5040.8 5047.3 5164.5 4970.3 5058.6 5069.5 5134.4 5139.0 4373.9 4740.8 5007.6 5013.1 5014.4 5433.9 5480.1 5509.3 5533.2 5535.5 5056.5 5091.6 6063.6 6138.4 6167.7 6159.1 6244.8 6251.2 6256.7 6256.7 5537.5 5727.2 5735.6 5738.6 5794.2 6143.3 6234.0 6241.5 6246.9 6248.3 5841.4 5914.1 5921.1 5923.6 5923.7 5047.4 6081.4 6082.6 6090.3 6157.9 6159.2 6167.6 6169.7 6180.7 6190.2 6193.3 6207.1 6211.2 6224.1 6224.3 4819.1 4852.3 4943.1 4943.2 4985.2 4314.7 4361.0 4411.2 4429.7 4432.2 4558.2 5522.3 5523.3 5535.0 5569.8 5444.7 5927.1 5936.3 5938.3 5943.3 5177.7 5571.0 5626.4 5628.2 5713.1 4504.4 5391.8 5405.7 5427.5 5428.3 6269.5 6272.4 6286.5 6287.5 6287.5 5976.4 6091.7 6206.3 6209.1 6233.9 6211.3 6238.9 6256.1 6258.4 6273.4 5885.4 5918.3 5927.5 6081.3 6153.8 6158.3 6196.8 6229.3 6241.1 6252.4 4644.7 5948.7 6057.0 6063.4 6090.1 5228.8 5733.8 5804.2 5805.9 5969.8 5830.1 5903.2 5909.0 5918.3 5944.5 6050.3 6066.0 6067.5 6071.8 6074.4 5670.0 5679.9 5857.5 5865.5 5866.8 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#1] ext.html Cycles:180 Average:61578.33 Median:35729.88 stddev:130932.73 (366.5%) stddev-sans-first:131219.52 18:21:04 INFO - PROCESS | 29731 | Values: 425.5 446.6 468.7 480.8 492.5 28317.6 37656.9 39488.0 39491.2 39499.6 39829.0 40194.0 40204.6 40208.8 40210.6 7715.8 8821.5 9015.1 9034.3 9064.9 7779.7 10673.1 10922.5 10929.2 11047.4 11030.3 11094.1 11095.2 11107.4 11113.2 7695.5 7890.1 10854.0 10954.7 10957.1 7806.1 7855.8 7856.6 10736.7 10877.3 38191.6 38567.2 38605.8 38640.2 38767.8 3757.8 3773.4 3785.3 3827.7 3910.7 22518.0 29484.7 29684.4 29785.9 30208.0 3041.6 3116.4 3206.1 3207.4 3212.0 348226.0 354368.5 354538.0 354757.2 355193.0 49192.3 49670.8 51111.0 59684.0 60029.0 52615.5 60274.4 61168.7 61232.0 64989.0 14943.3 15093.4 15096.6 15096.9 15108.6 11484.6 11519.5 11613.8 11640.9 11663.8 16350.5 16361.0 16394.4 16399.8 16436.7 5854.3 6835.8 6895.4 6929.8 6930.1 826.6 842.8 849.5 864.4 879.9 27393.3 28423.6 28590.4 28846.9 29970.4 1009.2 1016.3 1032.3 1048.9 1173.8 11119.0 13464.4 13564.2 14862.7 15156.5 583801.0 587313.5 588149.0 588719.0 588757.0 55645.7 55675.0 55716.4 55730.4 55797.0 1287.2 1339.9 1343.0 1346.5 1353.1 26481.7 26989.6 27886.0 28628.7 28733.1 42319.9 42633.0 42688.9 42729.1 42761.0 464253.0 507963.0 511304.0 511806.0 514105.0 31021.4 31325.8 35436.0 35537.5 38082.8 42248.4 43215.6 43390.7 43448.1 43870.0 28268.7 33298.8 35953.5 37315.6 37468.4 35242.5 35467.6 35605.1 36264.5 36595.6 35481.0 35527.6 35854.6 36067.8 36267.0 29416.6 31553.4 32019.5 32095.4 32162.0 23122.0 23293.2 23578.0 23921.0 24159.5 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#2] jquery.html Cycles:180 Average:39778.59 Median:15431.20 stddev:115220.58 (746.7%) stddev-sans-first:115505.68 18:21:04 INFO - PROCESS | 29731 | Values: 305.3 393.0 397.3 410.2 420.8 14584.6 14863.0 18309.7 20739.7 20900.5 15935.5 17174.9 20716.8 21565.1 21630.4 5521.7 5763.0 5768.0 5773.0 5776.8 5438.4 5723.3 5803.9 5828.1 5833.4 3629.5 3843.5 5533.0 5799.4 5826.0 5760.7 5852.0 5858.1 5868.2 5872.9 5688.5 6868.7 7203.3 7259.1 7264.1 27612.3 27717.3 28062.0 28165.9 28295.3 2719.1 2752.8 2777.3 2796.6 2800.4 16377.7 16643.6 16801.7 16887.0 17039.7 1886.0 1944.2 1972.8 1976.6 1991.6 106688.0 109272.1 109611.9 114927.9 151827.2 18493.9 20377.4 23216.8 23268.2 23327.2 40085.8 40146.8 40258.4 40299.6 40335.8 9846.9 10039.8 10268.8 10412.6 10556.3 8067.3 8107.7 8118.1 8128.1 8283.5 9246.8 9892.2 10660.2 10800.6 10839.3 3929.5 4032.6 4057.6 4058.4 4061.7 964.6 971.3 972.5 976.5 996.1 19355.6 19866.6 20440.0 20646.0 20692.9 941.3 945.4 954.7 980.9 981.0 10783.2 10885.9 10916.7 11016.3 11019.8 672085.0 678707.0 686034.0 713868.0 716773.4 139784.0 140722.0 141454.3 142236.0 146128.0 942.3 1012.2 1018.3 1020.9 1022.4 19241.8 20083.0 20206.0 20267.4 20313.4 54644.5 56643.7 57958.6 58809.1 60040.7 82872.0 83820.7 84297.6 85165.6 85732.1 6652.8 7632.6 8018.8 8266.8 8332.0 10290.5 12246.7 12645.7 12700.4 12764.1 10533.2 10572.6 10980.3 11009.6 11118.1 10418.5 10811.8 10858.1 10936.7 10943.3 9333.4 10792.2 11290.7 11333.1 11363.2 8073.3 8136.2 8162.9 8224.5 8241.7 9077.9 10737.2 10786.6 11073.5 11108.5 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#3] mootools.html Cycles:180 Average:5356.78 Median:5129.97 stddev:2983.53 (58.2%) stddev-sans-first:2976.10 18:21:04 INFO - PROCESS | 29731 | Values: 1271.7 1406.0 1415.3 1430.4 1431.1 8048.4 8472.2 8487.4 8487.5 8499.4 8030.4 8365.3 8388.3 8462.9 8478.7 2237.9 2275.4 2278.2 2278.7 2280.0 1981.7 2226.7 2278.2 2283.5 2286.9 2001.4 2028.8 2194.3 2263.9 2271.2 2216.6 2235.6 2240.3 2247.8 2247.9 2208.7 2279.5 2280.1 2281.5 2283.1 8372.8 8475.8 8479.1 8479.4 8486.2 5056.3 5221.3 5223.9 5231.3 5231.7 3248.9 3329.7 3466.2 3509.6 3517.5 1064.9 1083.7 1189.7 1196.7 1225.2 10752.4 10797.6 10852.8 10871.5 10890.2 4204.4 4400.3 4477.0 4478.7 4492.6 8618.2 8665.4 8706.8 8752.7 8753.0 4328.0 5075.0 5077.2 5077.3 5091.7 4560.5 4597.7 4710.2 4747.1 4751.6 3054.5 3632.9 3647.8 3673.1 3696.2 1143.3 1148.2 1155.8 1162.2 1168.7 630.9 692.4 735.4 740.9 742.7 4732.9 5477.3 5572.3 5627.2 5630.7 561.2 563.2 575.9 586.9 690.5 3636.9 3740.4 3786.5 3843.2 3881.6 9359.4 9871.0 9887.4 9971.6 10023.4 9875.2 9924.4 10097.9 10110.0 10136.5 7623.5 7825.5 7829.6 7832.4 7835.9 4277.4 5394.2 5472.3 5529.3 5701.7 9163.1 9262.4 9268.8 9292.4 9300.8 8798.0 9200.3 9218.1 9299.0 9304.9 6173.9 7072.4 7223.9 7229.3 7234.2 7703.3 7760.0 7790.8 7848.3 7852.7 7092.8 7135.1 7174.3 7196.7 7277.1 6853.8 6944.8 7013.4 7077.4 7083.5 6287.3 6313.3 6345.3 6426.2 6456.7 4856.0 4856.4 4936.7 4992.2 5133.8 4916.0 4960.3 5034.3 5042.6 5126.1 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#4] prototype.html Cycles:180 Average:4468.24 Median:5026.71 stddev:1371.57 (27.3%) stddev-sans-first:1339.22 18:21:04 INFO - PROCESS | 29731 | Values: 297.3 352.6 369.4 371.3 374.5 4357.5 4891.1 4933.0 4987.0 5348.8 5027.5 5223.3 5254.8 5299.0 5344.7 3994.4 3996.9 4008.2 4013.7 4032.2 3342.6 3345.3 4037.2 4038.1 4052.9 3028.8 3894.0 4031.2 4035.0 4038.7 3992.3 3994.6 4012.2 4024.9 4028.4 3045.4 3181.7 3465.8 3482.0 3504.5 4789.8 4904.8 4982.6 5025.9 5176.3 4180.0 4436.4 4482.4 4572.2 4614.7 4487.1 4553.0 5582.4 5612.9 5616.7 3259.1 3858.3 3862.2 3866.8 3881.5 5743.2 5911.6 5978.4 5983.7 6005.4 3905.4 3916.2 3935.7 3936.2 3957.9 3979.2 3983.0 3984.9 4010.5 4018.6 4430.2 4586.2 4607.3 4655.7 4683.9 5002.3 5127.5 5209.8 5673.7 5681.6 1170.6 1227.5 1278.6 1288.8 1292.8 780.5 851.7 854.0 861.0 871.6 4454.6 4555.7 5079.6 5080.9 5081.2 4809.9 5075.8 5377.7 5618.0 5641.9 4348.9 4550.6 4822.9 5080.5 5106.8 2597.5 2729.9 2826.3 2827.9 2878.4 5034.6 5036.9 5669.0 5778.3 5829.7 5316.9 5509.3 5561.6 5608.5 5729.6 5080.7 5327.9 5790.0 5867.9 5977.3 5178.8 5732.9 5773.7 5786.8 5790.4 5512.3 5614.9 5646.8 5657.4 5751.7 5079.4 5624.6 5714.3 6009.9 6043.3 3841.4 3864.3 3884.5 3887.2 3896.4 4996.6 5055.0 5111.5 5331.5 5771.6 5603.8 5606.3 5611.5 5619.5 5631.3 4782.2 5317.4 5353.7 5544.6 5565.5 5309.8 5412.0 5424.8 5464.3 5465.2 5425.5 5516.3 5530.3 5548.2 5549.5 4115.0 4441.0 5148.7 5438.9 5454.3 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - PROCESS | 29731 | [#5] yui.html Cycles:180 Average:18489.03 Median:4223.16 stddev:25372.95 (600.8%) stddev-sans-first:25408.99 18:21:04 INFO - PROCESS | 29731 | Values: 705.1 708.6 752.6 781.0 820.5 14243.5 14329.5 14846.0 15251.8 15260.8 13752.5 13839.3 13858.8 13878.0 13886.6 859.7 862.9 865.3 869.4 870.7 864.1 865.1 868.7 869.3 870.0 821.9 871.5 912.6 932.4 933.6 789.5 912.5 913.0 913.7 914.4 678.9 679.2 681.9 682.0 684.5 14636.3 14944.6 15082.2 15088.1 15105.4 13508.6 13721.2 13743.2 13847.2 13875.1 11284.3 11536.4 11547.0 11596.0 12104.9 3559.2 3588.6 3595.4 3641.6 3668.7 87632.0 97094.5 100875.0 104559.5 104867.0 9486.0 9938.9 10044.6 10178.3 10322.5 20167.7 20185.0 20256.7 20285.6 20301.9 7219.7 7327.9 7355.9 7432.6 7584.7 4030.3 4127.4 4128.8 4152.3 4294.0 3547.6 3669.9 3671.2 3672.3 3677.6 656.5 664.6 669.7 677.3 683.1 648.3 652.7 673.3 699.6 725.5 8719.3 9915.2 9929.8 10130.8 10190.4 639.7 641.2 681.8 698.6 698.9 4729.3 4827.2 4829.6 4897.6 4933.0 73872.6 76320.6 80114.6 80376.6 85996.6 48626.0 73968.3 77472.6 79349.6 84512.2 56676.4 69694.7 70511.0 70943.0 71259.0 10198.7 10453.1 10521.6 10666.3 10866.6 45714.0 47503.5 47929.8 49168.0 49828.0 59921.7 62347.7 63308.0 63466.0 64570.7 10079.0 11868.4 12273.8 12546.6 12757.7 14094.6 14170.3 14459.3 14492.1 14711.3 13091.3 13130.0 13134.9 13257.5 13649.5 12571.8 12957.1 12959.6 12987.5 13130.2 10540.0 10701.0 12808.6 13262.2 13487.8 10541.2 10951.9 11345.3 11371.7 11385.6 8733.5 10206.4 10285.5 10517.3 10532.4 18:21:04 INFO - PROCESS | 29731 | -------- Summary: end -------- 18:21:04 INFO - PROCESS | 29731 | 18:21:04 INFO - TEST-INFO | 29731: exit 0 18:21:04 INFO - TEST-OK | dromaeo_css | took 1118391ms 18:21:04 INFO - TEST-START | kraken 18:21:04 INFO - operating with platform_type : mac_ 18:21:04 INFO - Initialising browser for kraken test... 18:21:04 INFO - TEST-INFO | started process 29737 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpUJUwpH/profile http://localhost:49293/getInfo.html) 18:21:07 INFO - PROCESS | 29737 | 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] 18:21:07 INFO - PROCESS | 29737 | __metrics Screen width/height:1600/1200 18:21:07 INFO - PROCESS | 29737 | colorDepth:24 18:21:07 INFO - PROCESS | 29737 | Browser inner width/height: 1024/689 18:21:07 INFO - PROCESS | 29737 | __metrics 18:21:07 INFO - PROCESS | 29737 | 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" 18:21:07 INFO - PROCESS | 29737 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:21:08 INFO - TEST-INFO | 29737: exit 0 18:21:08 INFO - Browser initialized. 18:21:08 INFO - Running cycle 1/1 for kraken test... 18:21:08 INFO - TEST-INFO | started process 29738 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpUJUwpH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:20 INFO - PROCESS | 29738 | RSS: Main: 238010368 18:21:20 INFO - PROCESS | 29738 | 18:21:23 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection) 18:21:24 INFO - PROCESS | 29738 | RSS: Main: 290484224 18:21:24 INFO - PROCESS | 29738 | 18:21:26 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-dft) 18:21:27 INFO - PROCESS | 29738 | RSS: Main: 292077568 18:21:27 INFO - PROCESS | 29738 | 18:21:30 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-fft) 18:21:31 INFO - PROCESS | 29738 | RSS: Main: 380706816 18:21:31 INFO - PROCESS | 29738 | 18:21:33 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator) 18:21:34 INFO - PROCESS | 29738 | RSS: Main: 283545600 18:21:34 INFO - PROCESS | 29738 | 18:21:36 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:21:36 INFO - PROCESS | 29738 | RSS: Main: 287772672 18:21:36 INFO - PROCESS | 29738 | 18:21:39 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom) 18:21:40 INFO - PROCESS | 29738 | RSS: Main: 331436032 18:21:40 INFO - PROCESS | 29738 | 18:21:43 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate) 18:21:43 INFO - PROCESS | 29738 | RSS: Main: 331956224 18:21:43 INFO - PROCESS | 29738 | 18:21:46 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial) 18:21:47 INFO - PROCESS | 29738 | RSS: Main: 327557120 18:21:47 INFO - PROCESS | 29738 | 18:21:48 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:21:49 INFO - PROCESS | 29738 | RSS: Main: 304062464 18:21:49 INFO - PROCESS | 29738 | 18:21:51 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:21:52 INFO - PROCESS | 29738 | RSS: Main: 308203520 18:21:52 INFO - PROCESS | 29738 | 18:21:54 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:55 INFO - PROCESS | 29738 | RSS: Main: 311390208 18:21:55 INFO - PROCESS | 29738 | 18:21:57 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:58 INFO - PROCESS | 29738 | RSS: Main: 328523776 18:21:58 INFO - PROCESS | 29738 | 18:22:01 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:22:02 INFO - PROCESS | 29738 | RSS: Main: 322269184 18:22:02 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | Cycle 1(1): loaded http://localhost:49293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49293/tests/kraken/driver.html?testName=ai-astar) 18:22:04 INFO - PROCESS | 29738 | RSS: Main: 367427584 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | __start_tp_report 18:22:04 INFO - PROCESS | 29738 | _x_x_mozilla_page_load 18:22:04 INFO - PROCESS | 29738 | _x_x_mozilla_page_load_details 18:22:04 INFO - PROCESS | 29738 | |i|pagename|runs| 18:22:04 INFO - PROCESS | 29738 | |0;ai-astar;115;116;114;112;117;122;172;99;163;169 18:22:04 INFO - PROCESS | 29738 | |1;audio-beat-detection;170;140;143;149;111;112;110;110;131;140 18:22:04 INFO - PROCESS | 29738 | |2;audio-dft;185;187;183;186;177;181;185;182;186;184 18:22:04 INFO - PROCESS | 29738 | |3;audio-fft;81;79;61;90;69;72;60;59;76;58 18:22:04 INFO - PROCESS | 29738 | |4;audio-oscillator;87;71;87;68;70;71;86;68;68;86 18:22:04 INFO - PROCESS | 29738 | |5;imaging-gaussian-blur;87;86;87;87;95;136;103;86;88;90 18:22:04 INFO - PROCESS | 29738 | |6;imaging-darkroom;95;96;95;93;95;93;96;94;94;95 18:22:04 INFO - PROCESS | 29738 | |7;imaging-desaturate;88;88;85;86;85;87;89;88;86;88 18:22:04 INFO - PROCESS | 29738 | |8;json-parse-financial;62;59;59;60;60;60;61;59;59;58 18:22:04 INFO - PROCESS | 29738 | |9;json-stringify-tinderbox;65;72;69;78;73;69;72;70;71;70 18:22:04 INFO - PROCESS | 29738 | |10;stanford-crypto-aes;90;90;87;89;86;80;90;99;110;110 18:22:04 INFO - PROCESS | 29738 | |11;stanford-crypto-ccm;148;123;137;131;142;143;145;151;197;181 18:22:04 INFO - PROCESS | 29738 | |12;stanford-crypto-pbkdf2;168;174;176;172;172;172;171;175;173;172 18:22:04 INFO - PROCESS | 29738 | |13;stanford-crypto-sha256-iterative;68;69;68;68;68;68;67;66;65;68 18:22:04 INFO - PROCESS | 29738 | __end_tp_report 18:22:04 INFO - PROCESS | 29738 | __start_cc_report 18:22:04 INFO - PROCESS | 29738 | _x_x_mozilla_cycle_collect,2075 18:22:04 INFO - PROCESS | 29738 | __end_cc_report 18:22:04 INFO - PROCESS | 29738 | __startTimestamp1486693324305__endTimestamp 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | ------- Summary: start ------- 18:22:04 INFO - PROCESS | 29738 | Number of tests: 14 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#0] ai-astar Cycles:10 Average:129.90 Median:142.50 stddev:27.02 (19.0%) stddev-sans-first:28.11 18:22:04 INFO - PROCESS | 29738 | Values: 115.0 116.0 114.0 112.0 117.0 122.0 172.0 99.0 163.0 169.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:140.00 stddev:20.52 (14.7%) stddev-sans-first:16.40 18:22:04 INFO - PROCESS | 29738 | Values: 170.0 140.0 143.0 149.0 111.0 112.0 110.0 110.0 131.0 140.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#2] audio-dft Cycles:10 Average:183.60 Median:185.00 stddev:2.99 (1.6%) stddev-sans-first:3.13 18:22:04 INFO - PROCESS | 29738 | Values: 185.0 187.0 183.0 186.0 177.0 181.0 185.0 182.0 186.0 184.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#3] audio-fft Cycles:10 Average:70.50 Median:74.00 stddev:10.99 (14.8%) stddev-sans-first:10.98 18:22:04 INFO - PROCESS | 29738 | Values: 81.0 79.0 61.0 90.0 69.0 72.0 60.0 59.0 76.0 58.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:78.50 stddev:8.94 (11.4%) stddev-sans-first:8.59 18:22:04 INFO - PROCESS | 29738 | Values: 87.0 71.0 87.0 68.0 70.0 71.0 86.0 68.0 68.0 86.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:87.00 stddev:15.53 (17.9%) stddev-sans-first:16.23 18:22:04 INFO - PROCESS | 29738 | Values: 87.0 86.0 87.0 87.0 95.0 136.0 103.0 86.0 88.0 90.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:1.07 (1.1%) stddev-sans-first:1.13 18:22:04 INFO - PROCESS | 29738 | Values: 95.0 96.0 95.0 93.0 95.0 93.0 96.0 94.0 94.0 95.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:88.00 stddev:1.41 (1.6%) stddev-sans-first:1.45 18:22:04 INFO - PROCESS | 29738 | Values: 88.0 88.0 85.0 86.0 85.0 87.0 89.0 88.0 86.0 88.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:60.00 stddev:1.16 (1.9%) stddev-sans-first:0.88 18:22:04 INFO - PROCESS | 29738 | Values: 62.0 59.0 59.0 60.0 60.0 60.0 61.0 59.0 59.0 58.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:3.35 (4.7%) stddev-sans-first:2.79 18:22:04 INFO - PROCESS | 29738 | Values: 65.0 72.0 69.0 78.0 73.0 69.0 72.0 70.0 71.0 70.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:89.50 stddev:10.06 (11.2%) stddev-sans-first:10.61 18:22:04 INFO - PROCESS | 29738 | Values: 90.0 90.0 87.0 89.0 86.0 80.0 90.0 99.0 110.0 110.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.50 stddev:22.54 (15.4%) stddev-sans-first:23.90 18:22:04 INFO - PROCESS | 29738 | Values: 148.0 123.0 137.0 131.0 142.0 143.0 145.0 151.0 197.0 181.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:172.50 stddev:2.22 (1.3%) stddev-sans-first:1.66 18:22:04 INFO - PROCESS | 29738 | Values: 168.0 174.0 176.0 172.0 172.0 172.0 171.0 175.0 173.0 172.0 18:22:04 INFO - PROCESS | 29738 | 18:22:04 INFO - PROCESS | 29738 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 18:22:04 INFO - PROCESS | 29738 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 67.0 66.0 65.0 68.0 18:22:04 INFO - PROCESS | 29738 | -------- Summary: end -------- 18:22:04 INFO - PROCESS | 29738 | 18:22:05 INFO - TEST-INFO | 29738: exit 0 18:22:05 INFO - TEST-OK | kraken | took 60282ms 18:22:05 INFO - SUITE-END | took 1178s 18:22:05 INFO - Completed test suite (00:19:38) 18:22:05 INFO - javascript benchmark 18:22:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.931675926999, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.506556483746, 3189.2345836999125, 3229.2411283348424, 3244.529543216234, 3260.9510857337136, 5460.754266058027, 5501.779928802848, 5547.639403438784, 5548.556115510754, 5576.9163462548095, 4703.412073490814, 5557.166425036246, 5576.832695019156, 5664.5468362531, 5697.373288938214, 5045.268436076767, 5057.468965758598, 5106.4382917879, 5125.333706618153, 5159.76781044852, 5193.428722840485, 5193.558547523465, 5217.269582258468, 5230.686158830464, 5233.973830130844, 5016.548510634024, 5022.146235140017, 5040.823571175028, 5047.268146118829, 5164.535191832734, 4970.304157417964, 5058.595312375001, 5069.467705890866, 5134.383873935114, 5139.049275883936, 4373.934390984138, 4740.810367585293, 5007.599392048627, 5013.122703526905, 5014.373203349582, 5433.891322173535, 5480.123180291174, 5509.283793106911, 5533.197686335499, 5535.529479994206, 5056.469070747556, 5091.643584949055, 6063.636181829061, 6138.386161383871, 6167.691615419256, 6159.076138579204, 6244.812655620339, 6251.187345645082, 6256.718447669866, 6256.749730010794, 5537.501624853782, 5727.2268243787385, 5735.627184233053, 5738.569607279471, 5794.159846822229, 6143.266246520256, 6233.96883015582, 6241.531885108635, 6246.906791311502, 6248.250209974741, 5841.386654401226, 5914.112883067574, 5921.082232253922, 5923.585349025613, 5923.733431995571, 5047.4447810740785, 6081.391860813883, 6082.635041897501, 6090.269167699905, 6157.9384206158265, 6159.23009623797, 6167.5682702210415, 6169.722362493699, 6180.690965451709, 6190.164327815687, 6193.349698281706, 6207.131001659771, 6211.192544969125, 6224.097505861625, 6224.346443623445, 4819.084373968934, 4852.296417019513, 4943.060818444556, 4943.233798761198, 4985.227289770091, 4314.697971142053, 4361.0, 4411.228035093845, 4429.734215946989, 4432.180046691373, 4558.202314594999, 5522.337319521683, 5523.28197334344, 5534.972325138348, 5569.805056822992, 5444.700541470178, 5927.140564618193, 5936.257967754031, 5938.346781853993, 5943.286805583271, 5177.689338639693, 5571.0, 5626.35296940857, 5628.240187574625, 5713.143028545668, 4504.3919070925, 5391.81128660495, 5405.702686352289, 5427.511523962783, 5428.348598168245, 6269.46709529686, 6272.372762723691, 6286.465650419766, 6287.497000240061, 6287.528435367274, 5976.372480889444, 6091.695415229132, 6206.348333424925, 6209.068639704081, 6233.940230160974, 6211.254649442096, 6238.937610623836, 6256.124142620128, 6258.405451482102, 6273.37266273369, 5885.3820348862755, 5918.260217472816, 5927.496162826208, 6081.300650425258, 6153.84615384619, 6158.261008678987, 6196.783112591038, 6229.345918678474, 6241.063840423973, 6252.437280644764, 4644.674872758875, 5948.691287916651, 6057.0, 6063.363346848694, 6090.147379366981, 5228.816991405282, 5733.827985160452, 5804.21643078179, 5805.883882322414, 5969.835882002968, 5830.067189249699, 5903.2325797646035, 5909.0, 5918.2898052234, 5944.49471794885, 6050.334463209131, 6065.969670151621, 6067.514598832171, 6071.848203794941, 6074.392560744067, 5670.0, 5679.914801278067, 5857.502112320501, 5865.501432378295, 5866.823995280149], "value": 5544.405544787089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.48516295282707, 446.6270663995563, 468.718768738757, 480.7980648127786, 492.5173330136465, 28317.575236371445, 37656.870293891196, 39488.0, 39491.21017579647, 39499.63002219869, 39829.0, 40194.0, 40204.59795402045, 40208.79895600525, 40210.59789402112, 7715.845683086335, 8821.51481668508, 9015.098490150998, 9034.277257819358, 9064.909350906506, 7779.727709530168, 10673.146148308155, 10922.508487118099, 10929.234953553254, 11047.447627618627, 11030.28303160292, 11094.1124710023, 11095.167862410311, 11107.389093599848, 11113.166512511554, 7695.461317707763, 7890.092639346434, 10854.0, 10954.726131846688, 10957.06864916483, 7806.0632724073475, 7855.764327070197, 7856.567888766115, 10736.677899663022, 10877.292975956616, 38191.618083819085, 38567.228655426734, 38605.8418247453, 38640.22719545622, 38767.836964891096, 3757.849686012556, 3773.3592465241495, 3785.299719551892, 3827.7320587558884, 3910.687145028391, 22518.0, 29484.705152948623, 29684.406311873856, 29785.851070744724, 30208.0, 3041.635003799558, 3116.3923035008183, 3206.134343727204, 3207.3745619604188, 3212.0363890832655, 348226.0, 354368.4563154361, 354538.0, 354757.22621386725, 355193.0, 49192.26211606829, 49670.75164624154, 51111.0, 59684.0, 60029.0, 52615.473845261055, 60274.39725602688, 61168.694156529826, 61232.0, 64989.025164622566, 14943.327550260265, 15093.39626414931, 15096.622584435258, 15096.867734919924, 15108.622284442978, 11484.598039068593, 11519.48162332697, 11613.825792613117, 11640.94179529097, 11663.76672466546, 16350.509484715478, 16361.0, 16394.426195083113, 16399.754003689955, 16436.6712665746, 5854.297484301911, 6835.760748373883, 6895.379415852597, 6929.826754331182, 6930.099087118743, 826.5536610230529, 842.7850898020965, 849.4775712936623, 864.4251572704208, 879.9296056315479, 27393.31516712058, 28423.57364639532, 28590.428191436054, 28846.855765721037, 29970.400591988473, 1009.2380252909006, 1016.2733645443395, 1032.2722480651123, 1048.8688913885765, 1173.8004539228182, 11119.0, 13464.394102265422, 13564.186148831102, 14862.70274594502, 15156.545303640909, 583801.0, 587313.5074597053, 588149.0, 588719.0, 588757.0, 55645.72177139169, 55675.0, 55716.442835571936, 55730.442695573336, 55797.0, 1287.2212311551564, 1339.8794108530278, 1342.9865701343058, 1346.4614154338342, 1353.07314489573, 26481.71752768004, 26989.59515607307, 27886.0, 28628.713712862605, 28733.13800585986, 42319.94200145021, 42633.0, 42688.932776680835, 42729.145417092106, 42761.0, 464253.0, 507963.0, 511304.0, 511806.0, 514105.0, 31021.379572408878, 31325.771020911885, 35436.0, 35537.466937995436, 38082.809585951894, 42248.36627450529, 43215.56784432241, 43390.69827905168, 43448.13103737971, 43870.0, 28268.717312826608, 33298.833505832314, 35953.460698089024, 37315.62684373122, 37468.43797342988, 35242.47136293009, 35467.645323546436, 35605.1098722534, 36264.456033159, 36595.634043660284, 35481.0, 35527.64472355243, 35854.64145358513, 36067.81966090153, 36267.0, 29416.55875161917, 31553.368932621677, 32019.519707203945, 32095.358092837545, 32162.0, 23122.0, 23293.208722741434, 23578.0, 23921.0, 24159.51680966406], "value": 18815.937448522236, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.28715449425596, 392.96659783918363, 397.25118152282937, 410.15303398482115, 420.7853994462823, 14584.562463126096, 14863.0, 18309.72535411968, 20739.688904666444, 20900.477488062807, 15935.52193434196, 17174.914125429354, 20716.792832071675, 21565.13739450424, 21630.35108946734, 5521.696306703119, 5763.049096899028, 5768.019436695772, 5772.971135144318, 5776.826695199151, 5438.401775804658, 5723.255976723041, 5803.883922321551, 5828.0675091985295, 5833.358330583633, 3629.511900120951, 3843.500344955152, 5533.0, 5799.391063938289, 5825.980453420634, 5760.74076666551, 5852.034414321632, 5858.091995740667, 5868.178455016301, 5872.941270587282, 5688.516476099537, 6868.7252509899545, 7203.315685009916, 7259.056322678018, 7264.128304603481, 27612.309692257655, 27717.307067323276, 28062.0, 28165.85917070422, 28295.292617684518, 2719.0619236363623, 2752.7935404844516, 2777.291790593406, 2796.6364372631633, 2800.3979144484033, 16377.672446551001, 16643.583910402216, 16801.66396672072, 16886.98678079319, 17039.744403833953, 1885.9811401885943, 1944.1640094759248, 1972.8224459798687, 1976.6046790641929, 1991.601679664073, 106688.0, 109272.06283026224, 109611.90388096176, 114927.85072149255, 151827.2408637961, 18493.90753046226, 20377.388678339674, 23216.7678323218, 23268.230012847664, 23327.18354857572, 40085.79957100196, 40146.79926600348, 40258.39612405816, 40299.59700403017, 40335.79832100821, 9846.852297215548, 10039.799204015879, 10268.794624107475, 10412.635557755442, 10556.313839600554, 8067.273945344947, 8107.675692972333, 8118.066422361386, 8128.065272493621, 8283.461574997606, 9246.751688521963, 9892.208623310118, 10660.243468527064, 10800.567977280822, 10839.349639021684, 3929.5088113985753, 4032.5564187939303, 4057.5739547347694, 4058.411530328145, 4061.7156799024374, 964.5948701545368, 971.3249291742312, 972.547765289144, 976.4629453800524, 996.0885789502524, 19355.61288774245, 19866.60266794685, 20440.0, 20645.96770161486, 20692.86189259575, 941.3128416256171, 945.4043952310138, 954.665866946577, 980.8970058143935, 980.9705708828747, 10783.167592790747, 10885.945570272257, 10916.699880430546, 11016.283941543774, 11019.83470247947, 672085.0, 678707.0, 686034.0, 713868.0, 716773.416132916, 139784.01079945962, 140722.0, 141454.2927285357, 142236.0, 146128.0, 942.3356533643764, 1012.2307046644456, 1018.2922868606396, 1020.9285350025575, 1022.3967858963248, 19241.807581924, 20082.96110389077, 20206.0, 20267.391978240677, 20313.390598282076, 54644.45355546553, 56643.71678141583, 57958.55103622443, 58809.11786323294, 60040.69979650074, 82872.0, 83820.7426888585, 84297.57851210705, 85165.57417212875, 85732.14017897366, 6652.767153149616, 7632.580208088609, 8018.8396232073865, 8266.834663306821, 8332.0, 10290.536925838205, 12246.693832654255, 12645.683857903627, 12700.428480718574, 12764.106512544404, 10533.210009249184, 10572.629957951434, 10980.286281391684, 11009.559617615527, 11118.054965327714, 10418.479076046318, 10811.783584365343, 10858.077063449695, 10936.671899843017, 10943.343399396063, 9333.439993600134, 10792.244542881923, 11290.717732056764, 11333.093352531612, 11363.204575679623, 8073.273405393543, 8136.1863813618165, 8162.918370816215, 8224.547649879314, 8241.711540096068, 9077.863832042656, 10737.248392612442, 10786.622468213574, 11073.50169242402, 11108.50011749457], "value": 10803.520756931373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.6502961685535, 1406.008763821506, 1415.3206460898762, 1430.3706369197553, 1431.0555033677774, 8048.4366094373345, 8472.152784721524, 8487.448315859465, 8487.490750554956, 8499.447535910162, 8030.397720170996, 8365.330773538117, 8388.286995605366, 8462.873056904136, 8478.703245386412, 2237.85453945493, 2275.374272075176, 2278.1798552521163, 2278.7493375728654, 2279.9886000569973, 1981.7423734914441, 2226.6548684953777, 2278.1912421090524, 2283.5204607032542, 2286.90852365906, 2001.3995801259637, 2028.8174064334207, 2194.297824696098, 2263.864168149916, 2271.1937262271904, 2216.601011817872, 2235.61994460942, 2240.339099965514, 2247.842651014413, 2247.9438014049615, 2208.6686996950425, 2279.4757205842748, 2280.1221529711015, 2281.498070424504, 2283.0981762203837, 8372.790680233044, 8475.830483390358, 8479.109693482218, 8479.406441549094, 8486.151384861527, 5056.266841308026, 5221.347331583552, 5223.869403264911, 5231.267622532849, 5231.686098834082, 3248.8791366978353, 3329.7336213102894, 3466.185446420089, 3509.631488693676, 3517.4899639552377, 1064.8722153341648, 1083.7344850511674, 1189.6787867275873, 1196.7187710887933, 1225.1730082194483, 10752.354858708424, 10797.622083227128, 10852.782944341068, 10871.45642717861, 10890.183236257233, 4204.3693445983345, 4400.295952647561, 4477.015056687524, 4478.664100192498, 4492.5507449255465, 8618.224359807647, 8665.43674661145, 8706.825863482822, 8752.693655722147, 8753.0, 4327.961289290611, 5074.974625126851, 5077.213031980049, 5077.289179514871, 5091.719955402488, 4560.475545312332, 4597.7241365518175, 4710.199266124767, 4747.145513807548, 4751.596114330251, 3054.4501989641635, 3632.891013269606, 3647.8176091195332, 3673.081729567608, 3696.1683621185557, 1143.3140115930375, 1148.1618418554335, 1155.8439610652622, 1162.2387336294742, 1168.707823044239, 630.8769789890928, 692.4218277738045, 735.3602365941665, 740.9147947985942, 742.7400409856507, 4732.929006064912, 5477.287952566141, 5572.3034620672415, 5627.155926611041, 5630.746616402272, 561.1694691856076, 563.1861959468611, 575.9164921086419, 586.8943590153727, 690.5235387582552, 3636.8545258189374, 3740.36413809653, 3786.4888240087234, 3843.1545060086737, 3881.573026967031, 9359.438433694, 9870.950645246729, 9887.406755594688, 9971.551280192409, 10023.398596084258, 9875.209983201326, 9924.404535727735, 10097.899021009844, 10110.039546243095, 10136.493175341351, 7623.542587444771, 7825.491343062569, 7829.64766585505, 7832.412569057344, 7835.921640783633, 4277.443932288783, 5394.190871369326, 5472.315960504937, 5529.281193444826, 5701.6864072474755, 9163.129502697233, 9262.44425334482, 9268.814623707623, 9292.442453452815, 9300.813983720423, 8797.956010219908, 9200.309976751903, 9218.078192180728, 9298.95350523243, 9304.860427093734, 6173.9073913892225, 7072.3634872861685, 7223.855522889407, 7229.277072292729, 7234.16807067194, 7703.268189521987, 7759.961200193963, 7790.766277011699, 7848.332891704269, 7852.725154619561, 7092.786387602043, 7135.108111486064, 7174.3184397482155, 7196.712131514891, 7277.090363704537, 6853.828654283483, 6944.791656250321, 7013.368796808311, 7077.363037326665, 7083.5041547091205, 6287.2769631492965, 6313.305536391085, 6345.333739957238, 6426.228852537725, 6456.6771661415805, 4856.0, 4856.368672072608, 4936.703797772145, 4992.201247800334, 5133.820316288912, 4915.95084049155, 4960.255961605643, 5034.270030845433, 5042.571381432619, 5126.128558145049], "value": 4262.195871006485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.28058099399453, 352.63908135035945, 369.3997254461501, 371.31863031337497, 374.5318352059927, 4357.455318085239, 4891.1195984722735, 4932.950670493298, 4986.950130498703, 5348.849997250591, 5027.547520723134, 5223.25778966043, 5254.789808407659, 5298.973505132469, 5344.706041167734, 3994.4407782910416, 3996.920061598766, 4008.218397412491, 4013.719039667217, 4032.1935612877396, 3342.632310445849, 3345.2807646356027, 4037.1521980384155, 4038.0914294283843, 4052.9392059119136, 3028.757699384044, 3893.9610603894025, 4031.21391328691, 4034.9798251008706, 4038.7374820636564, 3992.301347264246, 3994.580569040267, 4012.2376748418, 4024.879253622396, 4028.4158796974566, 3045.4365942300747, 3181.6977387148418, 3465.826708664582, 3482.0, 3504.4918486819524, 4789.832355867528, 4904.75191545047, 4982.551570358685, 5025.874353141201, 5176.275321454999, 4180.0, 4436.3567282743825, 4482.394876691637, 4572.199865023607, 4614.723116613014, 4487.057717879249, 4553.043860789238, 5582.385937546866, 5612.915806262909, 5616.719164041822, 3259.1200375898375, 3858.2669292834553, 3862.1696335288048, 3866.7679939203736, 3881.5342158941107, 5743.224664670258, 5911.615744976562, 5978.432048955342, 5983.700814959235, 6005.44768473397, 3905.4337121117846, 3916.1971795782365, 3935.665468435158, 3936.193080418507, 3957.881263562098, 3979.2439436507548, 3983.0440694233175, 3984.9003774905277, 4010.47863777707, 4018.618231268025, 4430.224710675619, 4586.243269860503, 4607.262837945913, 4655.6973796703105, 4683.929741053818, 5002.324686167393, 5127.487531109729, 5209.7916083356995, 5673.716314184274, 5681.57388195887, 1170.6488053584062, 1227.5028613411582, 1278.5972418688084, 1288.84533855936, 1292.7931530955002, 780.5472825761045, 851.6891334662804, 853.9794945040741, 861.0313397427893, 871.5772850167664, 4454.5990860822685, 4555.656081455979, 5079.644424890223, 5080.872978175576, 5081.21241207606, 4809.879753006203, 5075.751519027825, 5377.682467795337, 5617.9719101404235, 5641.943580564224, 4348.869533913988, 4550.567696068868, 4822.855314340575, 5080.49195080489, 5106.846794596168, 2597.4805038992276, 2729.921680936019, 2826.321682796155, 2827.9112541671607, 2878.3811480531785, 5034.572061374751, 5036.899262014813, 5669.0, 5778.306603207642, 5829.650220986754, 5316.9202461963105, 5509.283793106871, 5561.555075593943, 5608.46719561641, 5729.627574207663, 5080.6790234539285, 5327.934413117392, 5789.971050144806, 5867.9413205867395, 5977.3424923257535, 5178.844634660966, 5732.942670573241, 5773.653580785166, 5786.768529258951, 5790.420957904176, 5512.298973503035, 5614.85962850932, 5646.802361917313, 5657.43425657431, 5751.7411716472025, 5079.44126146131, 5624.606277560531, 5714.342850572238, 6009.869932668741, 6043.3352331244405, 3841.4045822897497, 3864.343061679465, 3884.514435695538, 3887.183691424719, 3896.3960586109197, 4996.550310472075, 5055.0, 5111.463296353978, 5331.466853314638, 5771.5759381059215, 5603.831885043455, 5606.290081525174, 5611.466910643482, 5619.499322801477, 5631.324241091095, 4782.187028205283, 5317.448215137775, 5353.732313384393, 5544.556435485232, 5565.471280228372, 5309.787608495617, 5411.972940135274, 5424.7558859850615, 5464.262324586289, 5465.234867118686, 5425.4500384819075, 5516.310461192351, 5530.313254457429, 5548.167774833646, 5549.528290095225, 4114.979425102855, 4440.955590444054, 5148.653375306081, 5438.945610543844, 5454.29094217765], "value": 4040.314663931317, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.122122956918, 708.592559278415, 752.6199269368972, 780.9726659566916, 820.5363969357313, 14243.501477448292, 14329.498467553625, 14846.0, 15251.847481525181, 15260.847391526082, 13752.518661846838, 13839.30803459828, 13858.792118118236, 13878.028538002343, 13886.583402497941, 859.6991053131417, 862.8662557303628, 865.2688478235912, 869.3523325122792, 870.6996086350231, 864.0711235421946, 865.126222515261, 868.7480630617114, 869.3088994249555, 870.0299166429418, 821.8658251612766, 871.5250188647202, 912.5528491039377, 932.3799673217336, 933.5845548730817, 789.5381201996839, 912.4981260306805, 913.0458670689146, 913.6939125393035, 914.4330515080626, 678.864227154571, 679.1883698979722, 681.9011243369733, 681.990653832331, 684.5003147702205, 14636.268186590734, 14944.551663450115, 15082.170480623561, 15088.094714317176, 15105.39578416862, 13508.594742157653, 13721.176729396268, 13743.244121573309, 13847.169169849842, 13875.098118622258, 11284.32294062359, 11536.369850369438, 11546.960773530423, 11596.0, 12104.87895121055, 3559.181388280684, 3588.577710045735, 3595.352836489431, 3641.550928219051, 3668.706503479715, 87632.0, 97094.51452742761, 100875.0, 104559.47720261426, 104867.0, 9486.0, 9938.900610993798, 10044.648437304806, 10178.338408003456, 10322.48387580618, 20167.697484537744, 20185.0, 20256.696149557767, 20285.59428811445, 20301.898490507454, 7219.747308844166, 7327.891944813522, 7355.852882942311, 7432.554046757212, 7584.658690358947, 4030.334994725896, 4127.360259159835, 4128.772917489507, 4152.335626299778, 4293.97853010733, 3547.609762926076, 3669.9082522936606, 3671.173985853215, 3672.3022625701565, 3677.595464498903, 656.5437021270171, 664.6045602866287, 669.7254125808493, 677.3260605697362, 683.1153656015472, 648.2998361769278, 652.7030201258416, 673.3132205150816, 699.597731304502, 725.5247812682701, 8719.302455803521, 9915.20678345745, 9929.751756206153, 10130.797384052277, 10190.388576685422, 639.7217210513442, 641.2145122225237, 681.7818298144646, 698.584342316321, 698.8567343694531, 4729.314249433882, 4827.227643577011, 4829.572301830864, 4897.559219670246, 4933.0, 73872.63063684755, 76320.61839690767, 80114.59942700366, 80376.59811700904, 85996.57001714951, 48626.0, 73968.26031739722, 77472.61263693759, 79349.60325198337, 84512.15487845166, 56676.449559769906, 69694.65152674205, 70511.0, 70943.0, 71259.0, 10198.694039178836, 10453.059224669816, 10521.579136834442, 10666.253362264568, 10866.565337386732, 45714.0, 47503.52496475129, 47929.76035119802, 49168.0, 49828.0, 59921.70039149776, 62347.6882615584, 63308.0, 63466.0, 64570.67714661397, 10078.992100790156, 11868.406579671155, 12273.815892761437, 12546.623601291976, 12757.744845103232, 14094.577162685136, 14170.291485425481, 14459.277036148362, 14492.130472171704, 14711.3379897907, 13091.345432728516, 13130.0, 13134.934325328311, 13257.469701212229, 13649.522266720616, 12571.811422828481, 12957.093003490043, 12959.611211663665, 12987.480500779862, 13130.16177735137, 10540.0, 10700.983406576363, 12808.615741527768, 13262.20426774358, 13487.797683034958, 10541.156707463231, 10951.890481095086, 11345.262557933707, 11371.658850234506, 11385.601503947322, 8733.458791112726, 10206.387616743019, 10285.485725713834, 10517.263791534519, 10532.420716860646], "value": 7236.733178097103, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 112.0, 117.0, 122.0, 172.0, 99.0, 163.0, 169.0], "value": 129.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 140.0, 143.0, 149.0, 111.0, 112.0, 110.0, 110.0, 131.0, 140.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 183.0, 186.0, 177.0, 181.0, 185.0, 182.0, 186.0, 184.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 61.0, 90.0, 69.0, 72.0, 60.0, 59.0, 76.0, 58.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 87.0, 68.0, 70.0, 71.0, 86.0, 68.0, 68.0, 86.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 95.0, 136.0, 103.0, 86.0, 88.0, 90.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 93.0, 95.0, 93.0, 96.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 85.0, 86.0, 85.0, 87.0, 89.0, 88.0, 86.0, 88.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 59.0, 60.0, 60.0, 60.0, 61.0, 59.0, 59.0, 58.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 69.0, 78.0, 73.0, 69.0, 72.0, 70.0, 71.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 87.0, 89.0, 86.0, 80.0, 90.0, 99.0, 110.0, 110.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 137.0, 131.0, 142.0, 143.0, 145.0, 151.0, 197.0, 181.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 174.0, 176.0, 172.0, 172.0, 172.0, 171.0, 175.0, 173.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0, 65.0, 68.0], "value": 67.5, "unit": "score"}]}]} 18:22:05 INFO - Return code: 0 18:22:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:22:05 ERROR - # TBPL SUCCESS # 18:22:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:22:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:22:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:22:05 INFO - 2017-02-09 18:22:05.611 screenresolution[29742:273813] starting screenresolution argv=screenresolution get 18:22:05 INFO - 2017-02-09 18:22:05.613 screenresolution[29742:273813] Display 0: 1600x1200x32@60 18:22:05 INFO - 2017-02-09 18:22:05.620 screenresolution[29743:273816] starting screenresolution argv=screenresolution list 18:22:05 INFO - Available Modes on Display 0 18:22:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:22:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:22:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:22:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:22:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:22:05 INFO - Intel Iris: 18:22:05 INFO - Chipset Model: Intel Iris 18:22:05 INFO - Type: GPU 18:22:05 INFO - Bus: Built-In 18:22:05 INFO - VRAM (Dynamic, Max): 1536 MB 18:22:05 INFO - Vendor: Intel (0x8086) 18:22:05 INFO - Device ID: 0x0a2e 18:22:05 INFO - Revision ID: 0x0009 18:22:05 INFO - Displays: 18:22:05 INFO - Display: 18:22:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:22:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:22:05 INFO - Display Serial Number: 1600x1200 60 18:22:05 INFO - Main Display: Yes 18:22:05 INFO - Mirror: Off 18:22:05 INFO - Online: Yes 18:22:05 INFO - Rotation: Supported 18:22:05 INFO - Return code: 0 18:22:05 INFO - Running post-action listener: _resource_record_post_action 18:22:05 INFO - [mozharness: 2017-02-10 02:22:05.856783Z] Finished run-tests step (success) 18:22:05 INFO - Running post-run listener: _resource_record_post_run 18:22:05 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 30723072; Write bytes: 552546304; Read time: 181; Write time: 1649 18:22:05 INFO - TinderboxPrint: CPU usage
53.8% 18:22:05 INFO - TinderboxPrint: I/O read bytes / time
30,723,072 / 181 18:22:05 INFO - TinderboxPrint: I/O write bytes / time
552,546,304 / 1,649 18:22:05 INFO - TinderboxPrint: CPU idle
2,219.8 (46.2%) 18:22:05 INFO - TinderboxPrint: CPU system
961.1 (20.0%) 18:22:05 INFO - TinderboxPrint: CPU user
1,624.7 (33.8%) 18:22:05 INFO - TinderboxPrint: Swap in / out
277,708,800 / 0 18:22:05 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 244261376; Write bytes: 239929344; Read time: 17622; Write time: 507 18:22:05 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30542848; Write bytes: 295303168; Read time: 178; Write time: 1093 18:22:06 INFO - Running post-run listener: _upload_blobber_files 18:22:06 INFO - Blob upload gear active. 18:22:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:22:06 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 18:22:06 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'] 18:22:06 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 18:22:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:22:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:22:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:22:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:08 INFO - (blobuploader) - INFO - Done attempting. 18:22:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:22:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:22:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:09 INFO - (blobuploader) - INFO - Done attempting. 18:22:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:22:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:22:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:10 INFO - (blobuploader) - INFO - Done attempting. 18:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:22:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:22:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:22:12 INFO - (blobuploader) - INFO - Done attempting. 18:22:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:22:12 INFO - Return code: 0 18:22:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:22:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:22:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/277b46483a71aec918cca4ca0a789f8c59365a09c64d72cbfd4660cad20be1fc1da01d0f84e93ba102bc550af60490bf21c8983db73e9ef2e3daa352b7eef8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db04053e5703b8a3170ecdc029a26806d39b6c4a5fe98b14a6f23ab227792b7fc1c1f736f313c8fb22adf77a83370081db4ea3f7388f607fc52172d45803f997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e20ea91a9ba0e9823fe399a9fce307293f96cd320fddf6ff9a59469822054f3a3dc2237196e8f05640366eee440db83dcd7b7ba87212eb53d110327d7d87e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c4ed3bd0ead1b84db187605c1bf38905a8dcea97d11697a3576637aac940bfec547a1c02645dfdedfec6428dc47c4fa384c86783a28fc0b3bc1585aeba499b"} 18:22:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:22:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:22:12 INFO - Contents: 18:22:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/277b46483a71aec918cca4ca0a789f8c59365a09c64d72cbfd4660cad20be1fc1da01d0f84e93ba102bc550af60490bf21c8983db73e9ef2e3daa352b7eef8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db04053e5703b8a3170ecdc029a26806d39b6c4a5fe98b14a6f23ab227792b7fc1c1f736f313c8fb22adf77a83370081db4ea3f7388f607fc52172d45803f997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e20ea91a9ba0e9823fe399a9fce307293f96cd320fddf6ff9a59469822054f3a3dc2237196e8f05640366eee440db83dcd7b7ba87212eb53d110327d7d87e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c4ed3bd0ead1b84db187605c1bf38905a8dcea97d11697a3576637aac940bfec547a1c02645dfdedfec6428dc47c4fa384c86783a28fc0b3bc1585aeba499b"} 18:22:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:22:12 INFO - Copying logs to upload dir... 18:22:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:22:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.668885 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 18:22:12.831022) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 18:22:12.835002) ========= 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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/277b46483a71aec918cca4ca0a789f8c59365a09c64d72cbfd4660cad20be1fc1da01d0f84e93ba102bc550af60490bf21c8983db73e9ef2e3daa352b7eef8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db04053e5703b8a3170ecdc029a26806d39b6c4a5fe98b14a6f23ab227792b7fc1c1f736f313c8fb22adf77a83370081db4ea3f7388f607fc52172d45803f997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e20ea91a9ba0e9823fe399a9fce307293f96cd320fddf6ff9a59469822054f3a3dc2237196e8f05640366eee440db83dcd7b7ba87212eb53d110327d7d87e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c4ed3bd0ead1b84db187605c1bf38905a8dcea97d11697a3576637aac940bfec547a1c02645dfdedfec6428dc47c4fa384c86783a28fc0b3bc1585aeba499b"} build_url:https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/SXvgBXmhR5u0epHFB3AAIw/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/277b46483a71aec918cca4ca0a789f8c59365a09c64d72cbfd4660cad20be1fc1da01d0f84e93ba102bc550af60490bf21c8983db73e9ef2e3daa352b7eef8ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db04053e5703b8a3170ecdc029a26806d39b6c4a5fe98b14a6f23ab227792b7fc1c1f736f313c8fb22adf77a83370081db4ea3f7388f607fc52172d45803f997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84e20ea91a9ba0e9823fe399a9fce307293f96cd320fddf6ff9a59469822054f3a3dc2237196e8f05640366eee440db83dcd7b7ba87212eb53d110327d7d87e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63c4ed3bd0ead1b84db187605c1bf38905a8dcea97d11697a3576637aac940bfec547a1c02645dfdedfec6428dc47c4fa384c86783a28fc0b3bc1585aeba499b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 18:22:12.872200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:22:12.872730) ========= 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.0Z8NQdBupj/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.FdSYEmSnnA/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 18:22:12.922721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 18:22:12.923093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 18:22:12.923501) ========= ========= Total master_lag: 0.20 =========