builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0263 starttime: 1485087935.64 results: success (0) buildid: 20170122030212 builduid: 8c60b7db2f6e43389731a7a90935e5f2 revision: d5343b0f7e6a9619dfdf333d259cff6b4f773bff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:35.638774) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:35.639157) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:35.639448) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:35.663642) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:35.663936) ========= 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.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-22 04:25:35-- 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% 61.5M=0s 2017-01-22 04:25:36 (61.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.585034 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:36.274119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:36.274456) ========= 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.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.024496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:36.330754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-22 04:25:36.331069) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5343b0f7e6a9619dfdf333d259cff6b4f773bff --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 d5343b0f7e6a9619dfdf333d259cff6b4f773bff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-22 04:25:36,440 truncating revision to first 12 chars 2017-01-22 04:25:36,441 Setting DEBUG logging. 2017-01-22 04:25:36,441 attempt 1/10 2017-01-22 04:25:36,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5343b0f7e6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-22 04:25:38,073 unpacking tar archive at: mozilla-central-d5343b0f7e6a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.378010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-22 04:25:38.732091) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:38.732403) ========= script_repo_revision: d5343b0f7e6a9619dfdf333d259cff6b4f773bff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:38.732801) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:38.733117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-22 04:25:38.752583) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-01-22 04:25:38.752862) ========= /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.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:25:38 INFO - MultiFileLogger online at 20170122 04:25:38 in /builds/slave/test 04:25:38 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 04:25:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:38 INFO - {'append_to_log': False, 04:25:38 INFO - 'base_work_dir': '/builds/slave/test', 04:25:38 INFO - 'blob_upload_branch': 'Firefox', 04:25:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:38 INFO - 'branch': 'Firefox', 04:25:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:38 INFO - 'config_files': ('talos/mac_config.py',), 04:25:38 INFO - 'default_actions': ('clobber', 04:25:38 INFO - 'read-buildbot-config', 04:25:38 INFO - 'download-and-extract', 04:25:38 INFO - 'populate-webroot', 04:25:38 INFO - 'create-virtualenv', 04:25:38 INFO - 'install', 04:25:38 INFO - 'run-tests'), 04:25:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:38 INFO - 'download_minidump_stackwalk': True, 04:25:38 INFO - 'download_symbols': 'ondemand', 04:25:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:38 INFO - 'installer_path': 'installer.exe', 04:25:38 INFO - 'log_level': 'info', 04:25:38 INFO - 'log_name': 'talos', 04:25:38 INFO - 'log_to_console': True, 04:25:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:38 INFO - 'opt_config_files': (), 04:25:38 INFO - 'pip_index': False, 04:25:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:38 INFO - 'cmd': ('bash', 04:25:38 INFO - '-c', 04:25:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:38 INFO - 'enabled': True, 04:25:38 INFO - 'halt_on_failure': False, 04:25:38 INFO - 'name': 'check_screen_resolution'},), 04:25:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:38 INFO - 'cmd': ('bash', 04:25:38 INFO - '-c', 04:25:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:38 INFO - 'enabled': True, 04:25:38 INFO - 'halt_on_failure': False, 04:25:38 INFO - 'name': 'check_screen_resolution'},), 04:25:38 INFO - 'run_cmd_checks_enabled': True, 04:25:38 INFO - 'sps_profile': False, 04:25:38 INFO - 'sps_profile_interval': 0, 04:25:38 INFO - 'suite': 'dromaeojs', 04:25:38 INFO - 'system_bits': '32', 04:25:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:38 INFO - 'title': 't-yosemite-r7-0263', 04:25:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:38 INFO - 'use_talos_json': True, 04:25:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:38 INFO - 'work_dir': 'build'} 04:25:38 INFO - [mozharness: 2017-01-22 12:25:38.971868Z] Running clobber step. 04:25:38 INFO - Running pre-action listener: _resource_record_pre_action 04:25:38 INFO - Running main action method: clobber 04:25:38 INFO - rmtree: /builds/slave/test/build 04:25:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:41 INFO - Running post-action listener: _resource_record_post_action 04:25:41 INFO - [mozharness: 2017-01-22 12:25:41.201238Z] Finished clobber step (success) 04:25:41 INFO - [mozharness: 2017-01-22 12:25:41.201403Z] Running read-buildbot-config step. 04:25:41 INFO - Running pre-action listener: _resource_record_pre_action 04:25:41 INFO - Running main action method: read_buildbot_config 04:25:41 INFO - Using buildbot properties: 04:25:41 INFO - { 04:25:41 INFO - "project": "", 04:25:41 INFO - "product": "firefox", 04:25:41 INFO - "script_repo_revision": "production", 04:25:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:25:41 INFO - "repository": "", 04:25:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:25:41 INFO - "buildid": "20170122030212", 04:25:41 INFO - "stage_platform": "macosx64", 04:25:41 INFO - "basedir": "/builds/slave/test", 04:25:41 INFO - "nightly_build": "True", 04:25:41 INFO - "buildnumber": 29, 04:25:41 INFO - "slavename": "t-yosemite-r7-0263", 04:25:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:25:41 INFO - "platform": "yosemite_r7", 04:25:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:25:41 INFO - "branch": "mozilla-central", 04:25:41 INFO - "repo_path": "mozilla-central", 04:25:41 INFO - "revision": "d5343b0f7e6a9619dfdf333d259cff6b4f773bff", 04:25:41 INFO - "pgo_build": "False", 04:25:41 INFO - "builduid": "8c60b7db2f6e43389731a7a90935e5f2", 04:25:41 INFO - "slavebuilddir": "test" 04:25:41 INFO - } 04:25:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:25:41 INFO - Running post-action listener: _resource_record_post_action 04:25:41 INFO - [mozharness: 2017-01-22 12:25:41.204904Z] Finished read-buildbot-config step (success) 04:25:41 INFO - [mozharness: 2017-01-22 12:25:41.205005Z] Running download-and-extract step. 04:25:41 INFO - Running pre-action listener: _resource_record_pre_action 04:25:41 INFO - Running main action method: download_and_extract 04:25:41 INFO - mkdir: /builds/slave/test/build/tests 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:41 INFO - trying https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:25:42 INFO - Downloaded 1199 bytes. 04:25:42 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:42 INFO - Using the following test package requirements: 04:25:42 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:42 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:25:42 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:25:42 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'jsshell-mac.zip'], 04:25:42 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:25:42 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:42 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:25:42 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:25:42 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:25:42 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:42 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:25:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:25:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:42 INFO - Fetch https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:43 INFO - Expected file size: 16350994 04:25:43 INFO - Obtained file size: 16350994 04:25:49 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:25:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:49 INFO - Fetch https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:50 INFO - Expected file size: 16350994 04:25:50 INFO - Obtained file size: 16350994 04:25:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:25:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:25:57 INFO - Fetch https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:25:58 INFO - Expected file size: 14403485 04:25:58 INFO - Obtained file size: 14403485 04:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:58 INFO - trying https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:58 INFO - Downloading https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:26:16 INFO - Downloaded 70020538 bytes. 04:26:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:26:16 INFO - mkdir: /builds/slave/test/properties 04:26:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:26:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:26:16 INFO - Contents: 04:26:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:26:19 INFO - Running post-action listener: _resource_record_post_action 04:26:19 INFO - Running post-action listener: set_extra_try_arguments 04:26:19 INFO - [mozharness: 2017-01-22 12:26:19.338424Z] Finished download-and-extract step (success) 04:26:19 INFO - [mozharness: 2017-01-22 12:26:19.338580Z] Running populate-webroot step. 04:26:19 INFO - Running pre-action listener: _resource_record_pre_action 04:26:19 INFO - Running main action method: populate_webroot 04:26:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:26:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:26:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:26:19 INFO - '--tppagecycles', 04:26:19 INFO - '7'], 04:26:19 INFO - 'tests': ['tsvgm']}}, 04:26:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:26:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:26:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:26:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:26:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:26:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['damp', 'tps']}, 04:26:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'tests': ['damp', 'tps']}, 04:26:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['dromaeo_dom']}, 04:26:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:26:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['basic_compositor_video']}, 04:26:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:26:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['a11yr', 04:26:19 INFO - 'ts_paint', 04:26:19 INFO - 'tpaint', 04:26:19 INFO - 'sessionrestore', 04:26:19 INFO - 'sessionrestore_no_auto_restore', 04:26:19 INFO - 'tabpaint']}, 04:26:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['tsvgx', 04:26:19 INFO - 'tsvgr_opacity', 04:26:19 INFO - 'tart', 04:26:19 INFO - 'tscrollx', 04:26:19 INFO - 'cart', 04:26:19 INFO - 'tsvg_static']}, 04:26:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:26:19 INFO - 'tsvgr_opacity', 04:26:19 INFO - 'tart', 04:26:19 INFO - 'tscrollx', 04:26:19 INFO - 'cart', 04:26:19 INFO - 'tsvg_static']}, 04:26:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'talos_options': ['--disable-e10s'], 04:26:19 INFO - 'tests': ['tp5o']}, 04:26:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:26:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'talos_options': ['--disable-e10s', 04:26:19 INFO - '--xperf_path', 04:26:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:19 INFO - 'tests': ['tp5n']}, 04:26:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:26:19 INFO - 'talos_options': ['--xperf_path', 04:26:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:26:19 INFO - 'tests': ['tp5n']}}, 04:26:19 INFO - 'talos.zip': {'path': '', 04:26:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:26:19 INFO - Running post-action listener: _resource_record_post_action 04:26:19 INFO - [mozharness: 2017-01-22 12:26:19.356802Z] Finished populate-webroot step (success) 04:26:19 INFO - [mozharness: 2017-01-22 12:26:19.356929Z] Running create-virtualenv step. 04:26:19 INFO - Running pre-action listener: _resource_record_pre_action 04:26:19 INFO - Running main action method: create_virtualenv 04:26:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:26:19 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 04:26:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:26:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:26:19 INFO - Using real prefix '/tools/python27' 04:26:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:26:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:26:23 INFO - Installing pip.................done. 04:26:23 INFO - Return code: 0 04:26:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:26:23 INFO - Reading from file tmpfile_stdout 04:26:23 INFO - Output received: 04:26:23 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) 04:26:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:24 INFO - 'HOME': '/Users/cltbld', 04:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:24 INFO - 'LOGNAME': 'cltbld', 04:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:24 INFO - 'MOZ_NO_REMOTE': '1', 04:26:24 INFO - 'NO_EM_RESTART': '1', 04:26:24 INFO - 'PAGER': '/bin/cat', 04:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:24 INFO - 'PWD': '/builds/slave/test', 04:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:24 INFO - 'SHELL': '/bin/bash', 04:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:24 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:24 INFO - 'USER': 'cltbld', 04:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:24 INFO - 'XPC_FLAGS': '0x0', 04:26:24 INFO - 'XPC_SERVICE_NAME': '0', 04:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:24 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 04:26:24 INFO - Cleaning up... 04:26:24 INFO - Return code: 0 04:26:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:24 INFO - 'HOME': '/Users/cltbld', 04:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:24 INFO - 'LOGNAME': 'cltbld', 04:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:24 INFO - 'MOZ_NO_REMOTE': '1', 04:26:24 INFO - 'NO_EM_RESTART': '1', 04:26:24 INFO - 'PAGER': '/bin/cat', 04:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:24 INFO - 'PWD': '/builds/slave/test', 04:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:24 INFO - 'SHELL': '/bin/bash', 04:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:24 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:24 INFO - 'USER': 'cltbld', 04:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:24 INFO - 'XPC_FLAGS': '0x0', 04:26:24 INFO - 'XPC_SERVICE_NAME': '0', 04:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:24 INFO - Downloading/unpacking psutil>=3.1.1 04:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:26:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:33 INFO - Installing collected packages: psutil 04:26:33 INFO - Running setup.py install for psutil 04:26:34 INFO - building 'psutil._psutil_osx' extension 04:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:26:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:26:34 INFO - building 'psutil._psutil_posix' extension 04:26:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:26:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:26:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:26:34 INFO - ^ 04:26:34 INFO - 1 warning generated. 04:26:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:26:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:26:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:26:35 INFO - Successfully installed psutil 04:26:35 INFO - Cleaning up... 04:26:35 INFO - Return code: 0 04:26:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:26: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 mozsystemmonitor==0.3 04:26:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:35 INFO - 'HOME': '/Users/cltbld', 04:26:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:35 INFO - 'LOGNAME': 'cltbld', 04:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:35 INFO - 'MOZ_NO_REMOTE': '1', 04:26:35 INFO - 'NO_EM_RESTART': '1', 04:26:35 INFO - 'PAGER': '/bin/cat', 04:26:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:35 INFO - 'PWD': '/builds/slave/test', 04:26:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:35 INFO - 'SHELL': '/bin/bash', 04:26:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:35 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:35 INFO - 'USER': 'cltbld', 04:26:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:35 INFO - 'XPC_FLAGS': '0x0', 04:26:35 INFO - 'XPC_SERVICE_NAME': '0', 04:26:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:26:38 INFO - Installing collected packages: mozsystemmonitor 04:26:38 INFO - Running setup.py install for mozsystemmonitor 04:26:38 INFO - Successfully installed mozsystemmonitor 04:26:38 INFO - Cleaning up... 04:26:38 INFO - Return code: 0 04:26:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:38 INFO - 'HOME': '/Users/cltbld', 04:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:38 INFO - 'LOGNAME': 'cltbld', 04:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:38 INFO - 'MOZ_NO_REMOTE': '1', 04:26:38 INFO - 'NO_EM_RESTART': '1', 04:26:38 INFO - 'PAGER': '/bin/cat', 04:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:38 INFO - 'PWD': '/builds/slave/test', 04:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:38 INFO - 'SHELL': '/bin/bash', 04:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:38 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:38 INFO - 'USER': 'cltbld', 04:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:38 INFO - 'XPC_FLAGS': '0x0', 04:26:38 INFO - 'XPC_SERVICE_NAME': '0', 04:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:26:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:26:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:26:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:26:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:26:45 INFO - warning: no files found matching '*.txt' 04:26:45 INFO - no previously-included directories found matching 'build' 04:26:45 INFO - no previously-included directories found matching 'dist' 04:26:45 INFO - no previously-included directories found matching '.git*' 04:26:45 INFO - Installing collected packages: jsonschema, functools32 04:26:45 INFO - Running setup.py install for functools32 04:26:45 INFO - warning: no files found matching '*.txt' 04:26:45 INFO - no previously-included directories found matching 'build' 04:26:45 INFO - no previously-included directories found matching 'dist' 04:26:45 INFO - no previously-included directories found matching '.git*' 04:26:45 INFO - Successfully installed jsonschema functools32 04:26:45 INFO - Cleaning up... 04:26:45 INFO - Return code: 0 04:26:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:45 INFO - 'HOME': '/Users/cltbld', 04:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PAGER': '/bin/cat', 04:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:45 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - 'XPC_FLAGS': '0x0', 04:26:45 INFO - 'XPC_SERVICE_NAME': '0', 04:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:26:45 INFO - Cleaning up... 04:26:45 INFO - Return code: 0 04:26:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:45 INFO - 'HOME': '/Users/cltbld', 04:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:45 INFO - 'LOGNAME': 'cltbld', 04:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:45 INFO - 'MOZ_NO_REMOTE': '1', 04:26:45 INFO - 'NO_EM_RESTART': '1', 04:26:45 INFO - 'PAGER': '/bin/cat', 04:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:45 INFO - 'PWD': '/builds/slave/test', 04:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:45 INFO - 'SHELL': '/bin/bash', 04:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:45 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:45 INFO - 'USER': 'cltbld', 04:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:45 INFO - 'XPC_FLAGS': '0x0', 04:26:45 INFO - 'XPC_SERVICE_NAME': '0', 04:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:26: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 04:26: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 04:26: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 04:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:26: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 04:26: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 04:26:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:26:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26: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 04:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:26:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:26:51 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 04:26:51 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 04:26:51 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 04:26:51 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 04:26:51 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 04:26:51 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 04:26:51 INFO - Downloading docopt-0.6.1.tar.gz 04:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:26:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:26:51 INFO - Running setup.py install for blobuploader 04:26:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:26:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:26:51 INFO - Running setup.py install for requests 04:26:52 INFO - Running setup.py install for docopt 04:26:52 INFO - Successfully installed blobuploader requests docopt 04:26:52 INFO - Cleaning up... 04:26:52 INFO - Return code: 0 04:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26: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')]} 04:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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')]} 04:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26: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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26: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 04:26: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 04:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:52 INFO - 'HOME': '/Users/cltbld', 04:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:52 INFO - 'LOGNAME': 'cltbld', 04:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:52 INFO - 'MOZ_NO_REMOTE': '1', 04:26:52 INFO - 'NO_EM_RESTART': '1', 04:26:52 INFO - 'PAGER': '/bin/cat', 04:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:52 INFO - 'PWD': '/builds/slave/test', 04:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:52 INFO - 'SHELL': '/bin/bash', 04:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:52 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:52 INFO - 'USER': 'cltbld', 04:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:52 INFO - 'XPC_FLAGS': '0x0', 04:26:52 INFO - 'XPC_SERVICE_NAME': '0', 04:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:52 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vAPGx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-bySYB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-J8xRxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-FEkB5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GIS0Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-fhFCkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-0VX81s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GI_OOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-mXI4fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Fununy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:53 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-7z6tGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-jzuS8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-LSEbMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-F7jQQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-tigm9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-EAvWPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:54 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-4Sh4QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:26:54 INFO - Running setup.py install for manifestparser 04:26:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:26:54 INFO - Running setup.py install for mozcrash 04:26:54 INFO - Running setup.py install for mozdebug 04:26:55 INFO - Running setup.py install for mozdevice 04:26:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Running setup.py install for mozfile 04:26:55 INFO - Running setup.py install for mozhttpd 04:26:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Running setup.py install for mozinfo 04:26:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Running setup.py install for mozInstall 04:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:26:55 INFO - Running setup.py install for mozleak 04:26:56 INFO - Running setup.py install for mozlog 04:26:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Running setup.py install for moznetwork 04:26:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Running setup.py install for mozprocess 04:26:56 INFO - Running setup.py install for mozprofile 04:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Running setup.py install for mozrunner 04:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:26:56 INFO - Running setup.py install for mozscreenshot 04:26:57 INFO - Running setup.py install for moztest 04:26:57 INFO - Running setup.py install for mozversion 04:26:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:26:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:26:57 INFO - Cleaning up... 04:26:57 INFO - Return code: 0 04:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:26:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:26:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:26:57 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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:26:57 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 04:26:57 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 04:26:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:26:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:57 INFO - 'HOME': '/Users/cltbld', 04:26:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:57 INFO - 'LOGNAME': 'cltbld', 04:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:57 INFO - 'MOZ_NO_REMOTE': '1', 04:26:57 INFO - 'NO_EM_RESTART': '1', 04:26:57 INFO - 'PAGER': '/bin/cat', 04:26:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:57 INFO - 'PWD': '/builds/slave/test', 04:26:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:57 INFO - 'SHELL': '/bin/bash', 04:26:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:26:57 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:26:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:57 INFO - 'USER': 'cltbld', 04:26:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:57 INFO - 'XPC_FLAGS': '0x0', 04:26:57 INFO - 'XPC_SERVICE_NAME': '0', 04:26:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:26:57 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-ya9Fhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:26: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)) 04:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:26:57 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-omzsH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:26: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)) 04:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:26:57 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-L_DN94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:26: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)) 04:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:26:57 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-vt6ggY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-VB36x5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-_qRqal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-gHnpXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-kzni6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-0lk9T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:26:58 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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-d45Zbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:26: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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-wO0RO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:26: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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-Mu1DrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:26: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)) 04:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:26:58 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-0LE6Md-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:26:59 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)) 04:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:26:59 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GZbnnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:26:59 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)) 04:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:59 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-iV86U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:26:59 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)) 04:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:26:59 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-g5OKA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:26:59 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)) 04:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:26:59 INFO - Running setup.py (path:/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/pip-GjNQI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:26:59 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)) 04:26:59 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)) 04:26:59 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)) 04:26:59 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)) 04:26:59 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)) 04:26:59 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)) 04:26:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:26:59 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 04:26:59 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 04:26:59 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 04:26:59 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 04:26:59 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 04:26:59 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 04:27:02 INFO - Downloading blessings-1.6.tar.gz 04:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:02 INFO - Installing collected packages: blessings 04:27:02 INFO - Running setup.py install for blessings 04:27:02 INFO - Successfully installed blessings 04:27:02 INFO - Cleaning up... 04:27:02 INFO - Return code: 0 04:27:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:02 INFO - Reading from file tmpfile_stdout 04:27:02 INFO - Current package versions: 04:27:02 INFO - blessings == 1.6 04:27:02 INFO - blobuploader == 1.2.4 04:27:02 INFO - docopt == 0.6.1 04:27:02 INFO - functools32 == 3.2.3-2 04:27:02 INFO - jsonschema == 2.5.1 04:27:02 INFO - manifestparser == 1.1 04:27:02 INFO - mozInstall == 1.12 04:27:02 INFO - mozcrash == 1.0 04:27:02 INFO - mozdebug == 0.1 04:27:02 INFO - mozdevice == 0.49 04:27:02 INFO - mozfile == 1.2 04:27:02 INFO - mozhttpd == 0.7 04:27:02 INFO - mozinfo == 0.9 04:27:02 INFO - mozleak == 0.1 04:27:02 INFO - mozlog == 3.4 04:27:02 INFO - moznetwork == 0.27 04:27:02 INFO - mozprocess == 0.24 04:27:02 INFO - mozprofile == 0.28 04:27:02 INFO - mozrunner == 6.13 04:27:02 INFO - mozscreenshot == 0.1 04:27:02 INFO - mozsystemmonitor == 0.3 04:27:02 INFO - moztest == 0.8 04:27:02 INFO - mozversion == 1.4 04:27:02 INFO - psutil == 3.1.1 04:27:02 INFO - requests == 1.2.3 04:27:02 INFO - wsgiref == 0.1.2 04:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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')]} 04:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:27: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 04:27: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 04:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:02 INFO - 'HOME': '/Users/cltbld', 04:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:02 INFO - 'LOGNAME': 'cltbld', 04:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:02 INFO - 'MOZ_NO_REMOTE': '1', 04:27:02 INFO - 'NO_EM_RESTART': '1', 04:27:02 INFO - 'PAGER': '/bin/cat', 04:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:02 INFO - 'PWD': '/builds/slave/test', 04:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:02 INFO - 'SHELL': '/bin/bash', 04:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:27:02 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:02 INFO - 'USER': 'cltbld', 04:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:02 INFO - 'XPC_FLAGS': '0x0', 04:27:02 INFO - 'XPC_SERVICE_NAME': '0', 04:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 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)) 04:27:03 INFO - Cleaning up... 04:27:03 INFO - Return code: 0 04:27:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:03 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')]} 04:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:03 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')]} 04:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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 0x108127b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10812a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc9635707c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, '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.0x8SaTREm6/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.xAF85LUSqD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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 04:27: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 04:27: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 04:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:03 INFO - 'HOME': '/Users/cltbld', 04:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:03 INFO - 'LOGNAME': 'cltbld', 04:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:03 INFO - 'MOZ_NO_REMOTE': '1', 04:27:03 INFO - 'NO_EM_RESTART': '1', 04:27:03 INFO - 'PAGER': '/bin/cat', 04:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:03 INFO - 'PWD': '/builds/slave/test', 04:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:03 INFO - 'SHELL': '/bin/bash', 04:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:27:03 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:03 INFO - 'USER': 'cltbld', 04:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:03 INFO - 'XPC_FLAGS': '0x0', 04:27:03 INFO - 'XPC_SERVICE_NAME': '0', 04:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:03 INFO - Cleaning up... 04:27:03 INFO - Return code: 0 04:27:03 INFO - Running post-action listener: _resource_record_post_action 04:27:03 INFO - Running post-action listener: _start_resource_monitoring 04:27:03 INFO - Starting resource monitoring. 04:27:03 INFO - [mozharness: 2017-01-22 12:27:03.328287Z] Finished create-virtualenv step (success) 04:27:03 INFO - [mozharness: 2017-01-22 12:27:03.329254Z] Running install step. 04:27:03 INFO - Running pre-action listener: _resource_record_pre_action 04:27:03 INFO - Running main action method: install 04:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:03 INFO - Reading from file tmpfile_stdout 04:27:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:03 INFO - Reading from file tmpfile_stdout 04:27:03 INFO - Output received: 04:27:03 INFO - Usage: mozinstall [options] installer 04:27:03 INFO - Options: 04:27:03 INFO - -h, --help show this help message and exit 04:27:03 INFO - -d DEST, --destination=DEST 04:27:03 INFO - Directory to install application into. [default: 04:27:03 INFO - "/builds/slave/test"] 04:27:03 INFO - --app=APP Application being installed. [default: firefox] 04:27:03 INFO - mkdir: /builds/slave/test/build/application 04:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:27:25 INFO - Reading from file tmpfile_stdout 04:27:25 INFO - Output received: 04:27:25 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:27:25 INFO - Running post-action listener: _resource_record_post_action 04:27:25 INFO - [mozharness: 2017-01-22 12:27:25.771360Z] Finished install step (success) 04:27:25 INFO - [mozharness: 2017-01-22 12:27:25.771519Z] Running run-tests step. 04:27:25 INFO - Running pre-action listener: _resource_record_pre_action 04:27:25 INFO - Running main action method: run_tests 04:27:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:27:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:27:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:27:25 INFO - 2017-01-22 04:27:25.786 screenresolution[1673:12368] starting screenresolution argv=screenresolution get 04:27:25 INFO - 2017-01-22 04:27:25.789 screenresolution[1673:12368] Display 0: 1600x1200x32@60 04:27:25 INFO - 2017-01-22 04:27:25.795 screenresolution[1674:12370] starting screenresolution argv=screenresolution list 04:27:25 INFO - Available Modes on Display 0 04:27:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:27:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:27:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:27:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:27:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:27:26 INFO - Intel Iris: 04:27:26 INFO - Chipset Model: Intel Iris 04:27:26 INFO - Type: GPU 04:27:26 INFO - Bus: Built-In 04:27:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:27:26 INFO - Vendor: Intel (0x8086) 04:27:26 INFO - Device ID: 0x0a2e 04:27:26 INFO - Revision ID: 0x0009 04:27:26 INFO - Displays: 04:27:26 INFO - Display: 04:27:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:27:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:27:26 INFO - Display Serial Number: 1600x1200 60 04:27:26 INFO - Main Display: Yes 04:27:26 INFO - Mirror: Off 04:27:26 INFO - Online: Yes 04:27:26 INFO - Rotation: Supported 04:27:26 INFO - Return code: 0 04:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:27:26 INFO - Python 2.7.3 04:27:26 INFO - Return code: 0 04:27:26 INFO - grabbing minidump binary from tooltool 04:27: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')]} 04:27: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 0x107f05d30>, '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 0x107e2cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107efabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:27: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 04:27: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 04:27: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 04:27:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:27:26 INFO - Return code: 0 04:27:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:27: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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:27: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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0263 --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 04:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0x8SaTREm6/Render', 04:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:27:26 INFO - 'HOME': '/Users/cltbld', 04:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:27:26 INFO - 'LOGNAME': 'cltbld', 04:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:26 INFO - 'MOZ_NO_REMOTE': '1', 04:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:27:26 INFO - 'NO_EM_RESTART': '1', 04:27:26 INFO - 'PAGER': '/bin/cat', 04:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:26 INFO - 'PWD': '/builds/slave/test', 04:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:27:26 INFO - 'SHELL': '/bin/bash', 04:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xAF85LUSqD/Listeners', 04:27:26 INFO - 'TMPDIR': '/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/', 04:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:27:26 INFO - 'USER': 'cltbld', 04:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:26 INFO - 'XPC_FLAGS': '0x0', 04:27:26 INFO - 'XPC_SERVICE_NAME': '0', 04:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:27: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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0263', '--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 04:27:26 INFO - mozversion application_buildid: 20170122030212 04:27:26 INFO - mozversion application_changeset: d5343b0f7e6a9619dfdf333d259cff6b4f773bff 04:27:26 INFO - mozversion application_display_name: Nightly 04:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:27:26 INFO - mozversion application_name: Firefox 04:27:26 INFO - mozversion application_remotingname: firefox 04:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:27:26 INFO - mozversion application_vendor: Mozilla 04:27:26 INFO - mozversion application_version: 53.0a1 04:27:26 INFO - mozversion platform_buildid: 20170122030212 04:27:26 INFO - mozversion platform_changeset: d5343b0f7e6a9619dfdf333d259cff6b4f773bff 04:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:27:26 INFO - mozversion platform_version: 53.0a1 04:27:26 INFO - using testdate: 1485088046 04:27:26 INFO - actual date: 1485088046 04:27:26 INFO - starting webserver on 'localhost:49245' 04:27:26 INFO - SUITE-START | Running 2 tests 04:27:26 INFO - TEST-START | dromaeo_css 04:27:26 INFO - operating with platform_type : mac_ 04:27:26 INFO - Initialising browser for dromaeo_css test... 04:27:26 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpLDe7G9/profile http://localhost:49245/getInfo.html) 04:27:29 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 04:27:29 INFO - PROCESS | 1684 | colorDepth:24 04:27:29 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 04:27:29 INFO - PROCESS | 1684 | __metrics 04:27:29 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 04:27:29 INFO - PROCESS | 1684 | 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" 04:27:29 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:27:29 INFO - TEST-INFO | 1684: exit 0 04:27:29 INFO - Browser initialized. 04:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:27:29 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpLDe7G9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:27:41 INFO - PROCESS | 1688 | RSS: Main: 235073536 04:27:41 INFO - PROCESS | 1688 | 04:30:45 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 04:30:47 INFO - PROCESS | 1688 | RSS: Main: 363311104 04:30:47 INFO - PROCESS | 1688 | 04:32:31 INFO - PROCESS | 1688 | ************************* 04:32:31 INFO - PROCESS | 1688 | A coding exception was thrown and uncaught in a Task. 04:32:31 INFO - PROCESS | 1688 | 04:32:31 ERROR - PROCESS | 1688 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:32:31 INFO - PROCESS | 1688 | Full stack: 04:32:31 INFO - PROCESS | 1688 | ************************* 04:33:50 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 04:33:50 INFO - PROCESS | 1688 | RSS: Main: 369115136 04:33:50 INFO - PROCESS | 1688 | 04:36:53 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 04:36:54 INFO - PROCESS | 1688 | RSS: Main: 359055360 04:36:54 INFO - PROCESS | 1688 | 04:39:56 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 04:39:57 INFO - PROCESS | 1688 | RSS: Main: 356397056 04:39:57 INFO - PROCESS | 1688 | 04:43:00 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 04:43:01 INFO - PROCESS | 1688 | RSS: Main: 330911744 04:43:01 INFO - PROCESS | 1688 | 04:46:04 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 04:46:05 INFO - PROCESS | 1688 | RSS: Main: 402149376 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | __start_tp_report 04:46:05 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 04:46:05 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 04:46:05 INFO - PROCESS | 1688 | |i|pagename|runs| 04:46:05 INFO - PROCESS | 1688 | |0;dojo.html;3276.0990727549915;3280.1963518937864;3316.1709572606865;3345.882894098707;3378.1048022274103;5548.6948217848;5552.056150454422;5589.161625756138;5610.551155907528;5621.83134505965;5477.397486276506;5514.503694667479;5543.1408131739545;5584.497395234428;5586.10622300432;5084;5089.312942752718;5109.821156259532;5135;5168.767405466763;5156.510131537498;5240.44975277596;5245.632805703603;5260.184671375943;5282.260483532308;5051.747412629391;5195;5227.555657769094;5238.8690282742855;5279.524842764151;5099.643024988252;5107.770150343244;5140.7172605506685;5154.871128221825;5169.172932330809;5097.847064588068;5141.562967147797;5152.562032227265;5162.432132465426;5195.376554813409;5669.971650141764;5679.318481782213;5683.886322273573;5690.800821971253;5713.257276554022;5395;6053.848653783691;6092;6101.542384321194;6190.876182476371;5098.209777484496;6128.422616821487;6159.045347971071;6214;6250.562460627758;5789.797357092523;5804.303483581997;5807.941920580824;5825.213596164548;5847.386024467455;6080.847978800477;6236.095766113979;6242.812715618538;6257.624542527463;6261.96869015652;5963.821085367446;6013.909791353133;6033.095035744674;6038.516918646497;6148.1392605035335;6109.816705498843;6171.444569988723;6211.223597050369;6223.284322302902;6230.937690623126;6050.6672133032225;6078.179445774852;6106.9157392686275;6107.674343494518;6108.683874366847;6135.2326666699655;6146.6004709693725;6183.072539119168;6197.752089916443;6248.968755156195;4954.256861470736;4960.925586116211;4965.379327584052;4974.228994505857;4989.476105008995;4383.9342409863875;4394.956050439519;4396;4472.9552704472535;4488.955110448854;5740.827775166752;5741.770329186869;5776.653400795965;5852.122181672783;5911.113333000085;6212.254529456494;6238.875222495525;6243.094751261042;6268.059791031382;6273.7176827042895;5599.412061733541;5815;5848.3274423441;5849.532037436995;5858.707064646751;5324.946750532445;5394.0290747665795;5400.270963419966;5404.783808647689;5410.83767486976;6116.396640261158;6156.907646385218;6191.411815877575;6195.256569211723;6220.564560480904;6209.689515524296;6217.4715149212825;6240.188775459343;6256.217972753406;6259.96870015647;6231.532635052298;6302.1492098566105;6308.08532762756;6311.968440157953;6319.96840015797;6054.8183554493435;6103.115048318058;6202.28673702512;6206.10011548332;6217.782377616762;5116.7441627917715;6040.6304308743265;6161.5686901918225;6191.473724733448;6243.313235544178;6096.420840020191;6097.878042439215;6108;6123.84690382744;6127.877442451037;6088.756449742138;6106.603070800384;6137.60105593135;6143.56995010345;6152.907706384497;5714.771409143587;5776.277965254343;5818.94181058184;5861.384554621874;5877.382874798255;6059.72731227087;6084.421979911901;6086.6348019119;6087.147799308189;6113.480354169946;5406.648567843077;5421.1055175895535;5834.7082645866685;5884.293884733688;5894.705264736832 04:46:05 INFO - PROCESS | 1688 | |1;ext.html;485.6867320578225;488.8948875991661;490.4751915450469;499.453098856752;501.62879469192796;30759.846200768992;40118;42108.368374474405;42213.944651383696;42344;43169;43612.78193609027;43681.56318436815;43698.907527311836;43766.68699939007;9435.669751558697;9634;9634.807303853919;9639.903600963971;9649.807003859918;8430.072692003874;8633.438826476258;11417.600383986563;11662.708432289175;11692.766144677102;11500.367479788609;11560.826587601192;11604.129690273221;11606.303621782678;11617.709557261094;9713.805723885518;11617.477213525412;11627.011704005085;11630.592929247478;11638.243514171552;8416.537090460022;8661.610227539775;8666.6100025499;8754.47473151613;8775.561221938877;40564.594354056375;41289.96775080617;41409.378859317134;43339;43474.13051738947;3355.2282974915906;3804.2011177652726;3920.7255492115564;3967.583403742623;4028.6575641070544;30163.69836301631;30649.387012259853;31249.53125703116;31401.842990785128;31527;3182.9363412731614;3237.902862914116;3336.3160552086765;3356.1274068742305;3358.076528954557;462328;462584;467121;468676;471506.99999999657;62227.688861555405;62590.687046564475;62622.68688656527;62664.68667656633;62844;66456.33543664501;66593;66626;66650;66858;15453.072815631098;15911.681766364607;15981.520554383387;16063.67872642564;16087.541178646647;11197.832032519518;11539.423028848523;12458.563950261698;12556.246625202517;12586.685332866751;15183.848161518465;15329.31018104188;15337.233138343037;15351.539453816404;17357.13214339278;5870.53839082292;6432.324605916311;6452.0967064610995;6464.450521705614;6469.191351081115;859.2610355094614;862.4127617148554;863.2360361080489;868.5396739727954;890.5636238243214;29808.956686515867;29819.552706709415;29838;30504.694953050628;30644.84677576598;1034.3483605328595;1039.8232300508932;1065.1265961911158;1084.1110289562641;1151.1366475143643;15080.095194288158;15270.31283592241;15439;15501.84498155004;15812.525624231292;583834;583952;586239;588911;589744;60589.09116363258;60892.39107608867;60948.39051609516;61124.083138752954;61251.77496450046;1164.7554013657057;1386.6186798630256;1441.5819412370504;1443.8483959184555;1445.913245205291;29023.839046437904;29144.7085529142;29493.410131797675;29992.700072998992;30056.549151762305;51268.487315126375;51520.74239628778;51541.742291288305;51741;51833.22250166175;407514;408908;409670;410473;411908;39111;39596.2080758389;40155;40509.1898162041;40532.13614366295;45918.540814592765;47143.528564715285;47245;47409.28886066781;47471;27589.862050690423;37330.25339493249;37667.623323767504;38957.6104238954;39070.80464597659;34946.65053349434;35711.46432803562;36321.27357452889;36648.60026851019;37156.44265335968;35181.82409087938;35970.64029359673;36008.81995590005;36293.72971945969;36363;28778.856105719336;30442;30880.382392352476;31729.04812855618;32667.509987350684;23520.41198969971;23703.40741481408;24029.918653660978;24351;24556.386090347885 04:46:05 INFO - PROCESS | 1688 | |2;jquery.html;318.39822735030793;361.98552057917686;377.6619925166976;384.571203108534;392.3780807420239;15251.542453726392;15469.535913922586;16358.836411635895;20739.688904666404;21393.893030534826;21263.36209913701;22053.558928821414;22215.777842221574;22598.322050338476;22856.857157142116;4962.156433406311;5914.940850591493;5945.970270148643;6165.290991535963;6175.301792007212;4282.657387409015;5980.252468441445;6101.145839582462;6108.358622344656;6109.205803245572;4462.330650402433;6360.55476116672;6657.234418041939;6676.19885613727;6768.153980752406;6507.479401647857;6686.331366863324;6713.99290106483;6740.595564266159;6768.69540870662;5895.4694077532795;5912.290525136968;5913.2608423947;5930.1401296812155;5931.436513531207;22001.559968800695;26063.73936260632;26661.600075998875;26714.73285267142;26971.786269617915;2231.7991380775807;2393.6529203265427;2406.6750988616486;2418.9274321770376;2476.9752302477104;8564.528950907697;9775.266854985905;10245.129164021067;10465.47672616366;10496.527656255486;1611.7340638794585;1800.1809176824645;1822.7812662480455;1853.073463268366;1905.4378958207362;125985.99999999908;139612;141518;142041.28979355036;142215;11319.717007074725;11563.88436115645;11762.5883094093;11768.470418831173;11971.700707482383;15703.293351798968;15705.057696538244;15710.293036813371;15710.9214453927;15801.13093779853;8363.498190108612;8382.958085209535;8635.525046122399;8639.568021598894;8794.053991912653;8300.70947516834;8352;8359.414840961195;8457.746267611981;8505.787355316166;4103.733257338264;4690.95309046912;4768.594669453066;4782.115308667908;4896.387951506062;1617.7896873406382;1958.7845337012918;1966.783653798081;1991.163711241282;2017.7982201779998;725.9528130671595;832.1636755061124;847.9872801907976;875.3478658399533;885.4642941020719;17036.48890533286;21606.243781467572;21855.29751680455;21863.04419115387;21901.601500504763;847.809242920338;885.3625389719392;904.2810965282616;917.4082716647724;919.4161707315902;9848.901510984942;11238.38188899602;11239.550417983353;11288.774224515464;11303.86961303863;681431;692228;693928;696390;708673.4566327136;111898;119461;122352;135158;137585;941.8634298026885;977.3451787302524;991.3407583956588;994.4641165029146;995.0745806400117;20480.487987800425;20762.896185518977;20802.479938001066;20921.476963076046;21071.894640526698;44609.77695111504;57430.13854792265;57633.13550296665;57801;59047.40952590419;80696.59651701704;88390.55804720936;88656;89597.55201223952;90176;7069.469789765685;8333.583320833814;8508.234258916727;8604;8670.479771213748;13110.147840390344;13263.867361326264;13630;13634.522791702242;13696.31518424055;11018.559257629926;11437.370944598128;11729.648110556696;11738.823917641072;11780.941095294469;10730.302530335503;11035.944820275847;11414.885851141382;11697.707557311136;11911.642650720492;11205.71985700364;11534.538618455503;11857.881421185677;11863;11960.342181180118;7453.180150183367;8437.156284371515;8593.8710919335;8671.262942649693;8885.378023538291;10882.455877206266;11206.887931120584;11414.600488982845;11839.76320473603;11852 04:46:05 INFO - PROCESS | 1688 | |3;mootools.html;1280.699035726604;1415.7097794952035;1422.1964590006646;1440.0567628203523;1443.0475885915298;7827.804304892381;8221.177882211783;8234.505929644225;8249.175082491747;8254.42219044667;7302.707891684339;7499.700011999514;7835.33399661028;7992.760217193479;8123.309518690904;1912.7800302965163;2278.646809744484;2282.109977108929;2283.4063143582707;2292.885355732215;1971.5563998100383;2261.525079733258;2293.3005433342823;2307.1694190091553;2311.780380863815;2002.3292197113985;2032.959340813183;2051.4871282179456;2075.2321640992777;2183.3340831046526;2265.592193405186;2281.0191617604423;2281.863088214696;2285.1430713482528;2290.896909639054;2065.5455799724036;2067.080149333547;2067.286786058807;2131.2007997001124;2132.424245453719;8222.054463736687;8288.005439347256;8288.005439347256;8297.585120744;8298.336133109397;4964;5121.2318152277085;5127.692338459704;5137.765072193608;5138.563222126124;3246.3345014272254;3404.3701915145775;3467.514547963262;3498.510208570802;3525.2596954639557;1049.9842502362394;1168.8480497535352;1182.603827717707;1238.4612693478275;1250.4435526190757;10508.632197873114;10542.36745795247;10547.472626368728;10552.736181595445;10580.682579522627;4486.820527178941;4524.5927866492175;4535.274356103007;4559.886002849889;4598.655100867381;9251.953740231256;9252.028537003653;9257;9266.768330791649;9331.766705832408;5136.8715782105;5153.5361817436615;5155.97422012895;5159.896802063938;5162.328897243335;3708.1131445082196;4589.2657174851865;4662.137504561667;4750.857474275708;4751.358566593465;3735.6824669903363;3755.6995440364703;3814.0655539392474;3851.441540976599;3854.8650797221962;1240.1814802230485;1242.9683362808846;1247.3513772838073;1257.3336131850135;1261.6971926737701;788.6727008291609;844.2654890245526;896.9551522423983;899.9550022498848;936.7049379445452;5277.076511610453;5381.273528073738;5538;5662.348829884533;5690.459406356389;869.2654706772767;922.9815403691889;960.4632587859369;961.2502248246379;994.880614326271;3531.7576159399196;3683.3922402803237;3732.720045996561;3803.7527560708463;3812.370958791824;8141.877871831927;9587.089226523469;9684.903150968541;9780.364276322016;9822.950885245671;8249.670013199524;9629.277804164716;9703.417794932328;9779.168770654574;9805.558749856273;7433.070866141732;7511.173770885198;7616.200298968639;7642.541447513056;7672.923270767221;5293.682379057115;5354.143337066206;5362.973185134049;5399.892002160013;5553.194786755978;8784.604692788967;8833.249173820297;9061.728148155566;9130.041345658876;9140.588673509576;8577.313814894918;8865.955670221607;8944.418612790148;9157.633694652139;9245.260379169516;6836.589804611739;7097.46768992338;7220.8916866246;7221.566705997657;7234.059572255573;7724.0731112266885;7728.652210650646;7788.454808163374;7792.961035194788;7797.92202077972;6954.860902782018;6981.685824137824;7040.0847889774;7144.571325720473;7162.820929476805;6829;6920.861582768417;6938.306169383021;6953.478489113438;6971.477139214478;6240.687965601793;6384.712687928962;6390.392912673475;6400.71196796136;6408.61548307103;4788.880277993078;4912.361393018885;4946.777395017305;4965.751712414437;5022.045811295989;4902.436219834764;4917.311576379238;5019;5148.2020286855595;5170.095233334227 04:46:05 INFO - PROCESS | 1688 | |4;prototype.html;339.8521643085258;345.8339996801535;356.1576870700792;364.675438859415;368.9557253129625;4530.886727831806;5142;5213.139831927737;5215.6349055566125;5232.816851410202;5148.768305426255;5155.690658560489;5170.819021334245;5173.818916337929;5179.19722443021;3851.345271303885;4084.611961863618;4090.97954510227;4112.876613701594;4123.989622542466;3338.7162483863563;3629.782213067211;3777.7511340247365;3959.148783011652;4099.672026237894;3646.869470464165;3996.8832102934025;4057.235102730307;4069.7151199416053;4088.7955602219918;3444.7254515829054;3895.2014836958356;4065.6340929316357;4075.0643444363986;4079.1841631673487;3398.9490157647656;3507.9649203508147;3537.2939701128657;3625.966599519151;3632.364336241147;4552.746390536672;4856.17445034345;4929.035866601416;4935.087008903364;5051.3433253676785;4102.917941641181;4656.95343046572;4668.883277918046;4674.789634466457;4676.976615116902;5032.47159048302;5198.2722418861385;5438.809641662523;5456.699881506515;5510.283663123809;3375.611804642473;3950.8419663213435;3967.682585393162;3975.3043217436834;3988.521377434726;5484.670919744828;5623.550115990711;5646.520045796154;5732.5127364174095;5777.768889244425;3912.7065470089856;4061.5329237137516;4078.5936297584567;4082.2243773682903;4086.9386959195635;3671.889843304705;3949;4130.958690413057;4132.603090207673;4142.937855932163;4432.778361081933;4656.674032817738;4686.648501362343;4713.976430117896;4723.7874295656775;5546.722663866871;5547.55619550435;5555.472230138131;5569.526590239794;5574.080276754371;1179.3926128044063;1332.7867541193364;1342.16785592933;1345.9461621535224;1349.730053989206;868.8522951098329;936.840737074699;948.9003654616304;953.7567920180448;961.2694352292308;4069.5408902432696;4262.765547894834;4833.782479788418;4870;4898.975505122452;5285.859227013066;5320.334958130234;5326.866828329323;5330.668332292317;5331.840044798662;4017.252495164613;4747.83382581608;4794.640401969867;4894.853154405374;4941.925871111936;2559.8592077435546;2730.30377253799;2798.874050667725;2821.548552231633;2840.843753593531;4505.175403961401;4929.482404347564;5537.010014592156;5586.91619625706;5646.898854723289;4796.448408433005;4893.6329775266995;5299.284596579412;5362.785488580491;5404.648697834628;4555.40779698637;4965.354503914468;5254.710990895537;5586.24585680936;5608.411116832755;4809.663323567317;5302.70835104073;5322.148456246982;5326.147816349366;5349.331333583302;5053.545180933586;5306.363236411501;5309.283246761638;5375.16684913839;5386.973065134649;5129.948700512947;5497.120460726424;5546.75039623226;5698.31620205578;5856.590038697421;3228.8547015383892;3592.323718829489;3792.715546333981;3801;3803.3724435468944;5042.546170844642;5612.596850787303;5641.110228073641;5641.746121424464;5654.6889921054735;5406.648567843077;5414.485623865727;5447.918281225864;5487.75305111279;5504.91742623869;5408.729563521887;5435.836924892102;5437.184422336682;5442.564594832483;5470.15551912995;4517.322401639781;4657.5575320344515;4971.906180640253;5289.7355132242465;5341.7062061586985;4871.780769865293;5422.728863556727;5442.945570544244;5444.8638784029135;5447.256877799225;5294.49702278283;5300.496452836975;5314.041039425652;5318.813841515528;5323.281357016753 04:46:05 INFO - PROCESS | 1688 | |5;yui.html;702.8524009957908;703.5743375257972;760.8097975506123;811.111832543365;818.64388990789;14610.634734131652;15504.922475387635;15534;15549;15660.530184094481;14275.78586321206;14406;14416.783748243759;14453.494127705533;14461.855381446183;681.3425044831737;704.8343639244773;856.7001549457672;867.7570280321504;884.6594061286419;884.8672699095155;887.7336798960287;888.138505649519;889.7775556110972;890.0076414797486;934.2806039349697;935.7613808478828;936.6206686292029;936.6955739384694;937.9015203403646;934.4486752815803;935.0836180543106;935.6210734652477;936.798588303518;937.4469063252714;531.4021725558746;546.8332158691597;681.2574294019493;693.6739732325849;699.3006993006993;14526.564203073818;14573.417063317454;14811.555653330417;14876.404943802236;14923.776143357858;13336.799948000787;13462;13519.932400337935;13521.459141634323;13573.660658483519;11344.546218151265;11354.318740875491;11438.370889601068;11461.484233209525;11565.190436669436;4365.236083685342;4393.406890069864;4394.4287242658565;4572.491077944271;4578.88552786183;69487.65256173737;95327;97398;99456.50271748594;100177.4991125047;10567.207459440573;10713.517891694892;10829.783404332027;10854.077403420797;11211.159163062803;18096.90951545234;20258.290959816335;20701.792982069986;21199;21246.362609121752;7712.074551053797;7905;7911.090224624127;7993.440459167919;8113.350931925432;3719.9814000929823;4345.956540434555;4436.0906014267;4550.044490656999;4566.155261276608;3448.8792892248653;3506.2111025019676;3535.734819888519;3546.343926373629;3556.822158892045;655.6493623136355;656.8850451171025;671.8790617688863;672.515788632184;677.0588881454781;659.8086554899121;703.521605308385;715.8174665460274;721.4372789224414;759.5746382026083;9736.853947190797;10403.42781147029;10414.635487758043;10452.843207351896;10613.097886679565;655.1712084213474;660.7191943424026;682.382443888272;708.2174197511779;709.9563641447064;4925.415281569056;4935.437874790693;4999.775010124553;5010.67430617016;5027.195648696191;83193.45300319642;92842;95657;99612.00387996028;100033.99932001319;85590.71613925796;86627.70058449128;87875.12124878797;88727.66908496378;89988.5500572506;69547.95678064832;70600;70612.29387706057;77317;79493.20506794858;10686.57253709874;10857.154184672894;10950.288231264942;11000;11264.324140551593;47802.521974779804;49451;49644.503554965435;49675.50324496853;49945.25082123699;61882.381176187664;63936.68031659812;63974.36025639684;64918;65888.68222635616;12859.357032148542;12979.286139262054;12999.350032498527;13140.80288795688;13177;14552.49066282675;14742.189179595225;15072.24638768079;15246.542603721906;15254.389824406899;13515.86484135146;13761.862381376059;13777.862221377658;13966.720665586834;14272.857271427152;13328.666783330495;13733.107348022746;13745.931270343985;14015.929920350332;14209.50266740659;13249.867501325249;13492.325383730578;13501.257430841399;13504.594862154152;13992.510262140777;10351;11167.832482512606;11342;11343.376114313793;11366.829497557377;9123.635054598008;10912;10927.945360273148;10987.61543345979;11026.283291586022 04:46:05 INFO - PROCESS | 1688 | __end_tp_report 04:46:05 INFO - PROCESS | 1688 | __start_cc_report 04:46:05 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1362 04:46:05 INFO - PROCESS | 1688 | __end_cc_report 04:46:05 INFO - PROCESS | 1688 | __startTimestamp1485089165010__endTimestamp 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | ------- Summary: start ------- 04:46:05 INFO - PROCESS | 1688 | Number of tests: 6 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5688.00 Median:5858.71 stddev:631.42 (10.8%) stddev-sans-first:604.35 04:46:05 INFO - PROCESS | 1688 | Values: 3276.1 3280.2 3316.2 3345.9 3378.1 5548.7 5552.1 5589.2 5610.6 5621.8 5477.4 5514.5 5543.1 5584.5 5586.1 5084.0 5089.3 5109.8 5135.0 5168.8 5156.5 5240.4 5245.6 5260.2 5282.3 5051.7 5195.0 5227.6 5238.9 5279.5 5099.6 5107.8 5140.7 5154.9 5169.2 5097.8 5141.6 5152.6 5162.4 5195.4 5670.0 5679.3 5683.9 5690.8 5713.3 5395.0 6053.8 6092.0 6101.5 6190.9 5098.2 6128.4 6159.0 6214.0 6250.6 5789.8 5804.3 5807.9 5825.2 5847.4 6080.8 6236.1 6242.8 6257.6 6262.0 5963.8 6013.9 6033.1 6038.5 6148.1 6109.8 6171.4 6211.2 6223.3 6230.9 6050.7 6078.2 6106.9 6107.7 6108.7 6135.2 6146.6 6183.1 6197.8 6249.0 4954.3 4960.9 4965.4 4974.2 4989.5 4383.9 4395.0 4396.0 4473.0 4489.0 5740.8 5741.8 5776.7 5852.1 5911.1 6212.3 6238.9 6243.1 6268.1 6273.7 5599.4 5815.0 5848.3 5849.5 5858.7 5324.9 5394.0 5400.3 5404.8 5410.8 6116.4 6156.9 6191.4 6195.3 6220.6 6209.7 6217.5 6240.2 6256.2 6260.0 6231.5 6302.1 6308.1 6312.0 6320.0 6054.8 6103.1 6202.3 6206.1 6217.8 5116.7 6040.6 6161.6 6191.5 6243.3 6096.4 6097.9 6108.0 6123.8 6127.9 6088.8 6106.6 6137.6 6143.6 6152.9 5714.8 5776.3 5818.9 5861.4 5877.4 6059.7 6084.4 6086.6 6087.1 6113.5 5406.6 5421.1 5834.7 5884.3 5894.7 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:63839.31 Median:21515.86 stddev:131199.26 (609.8%) stddev-sans-first:131481.08 04:46:05 INFO - PROCESS | 1688 | Values: 485.7 488.9 490.5 499.5 501.6 30759.8 40118.0 42108.4 42213.9 42344.0 43169.0 43612.8 43681.6 43698.9 43766.7 9435.7 9634.0 9634.8 9639.9 9649.8 8430.1 8633.4 11417.6 11662.7 11692.8 11500.4 11560.8 11604.1 11606.3 11617.7 9713.8 11617.5 11627.0 11630.6 11638.2 8416.5 8661.6 8666.6 8754.5 8775.6 40564.6 41290.0 41409.4 43339.0 43474.1 3355.2 3804.2 3920.7 3967.6 4028.7 30163.7 30649.4 31249.5 31401.8 31527.0 3182.9 3237.9 3336.3 3356.1 3358.1 462328.0 462584.0 467121.0 468676.0 471507.0 62227.7 62590.7 62622.7 62664.7 62844.0 66456.3 66593.0 66626.0 66650.0 66858.0 15453.1 15911.7 15981.5 16063.7 16087.5 11197.8 11539.4 12458.6 12556.2 12586.7 15183.8 15329.3 15337.2 15351.5 17357.1 5870.5 6432.3 6452.1 6464.5 6469.2 859.3 862.4 863.2 868.5 890.6 29809.0 29819.6 29838.0 30504.7 30644.8 1034.3 1039.8 1065.1 1084.1 1151.1 15080.1 15270.3 15439.0 15501.8 15812.5 583834.0 583952.0 586239.0 588911.0 589744.0 60589.1 60892.4 60948.4 61124.1 61251.8 1164.8 1386.6 1441.6 1443.8 1445.9 29023.8 29144.7 29493.4 29992.7 30056.5 51268.5 51520.7 51541.7 51741.0 51833.2 407514.0 408908.0 409670.0 410473.0 411908.0 39111.0 39596.2 40155.0 40509.2 40532.1 45918.5 47143.5 47245.0 47409.3 47471.0 27589.9 37330.3 37667.6 38957.6 39070.8 34946.7 35711.5 36321.3 36648.6 37156.4 35181.8 35970.6 36008.8 36293.7 36363.0 28778.9 30442.0 30880.4 31729.0 32667.5 23520.4 23703.4 24029.9 24351.0 24556.4 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:38717.45 Median:26843.26 stddev:115594.56 (430.6%) stddev-sans-first:115882.87 04:46:05 INFO - PROCESS | 1688 | Values: 318.4 362.0 377.7 384.6 392.4 15251.5 15469.5 16358.8 20739.7 21393.9 21263.4 22053.6 22215.8 22598.3 22856.9 4962.2 5914.9 5946.0 6165.3 6175.3 4282.7 5980.3 6101.1 6108.4 6109.2 4462.3 6360.6 6657.2 6676.2 6768.2 6507.5 6686.3 6714.0 6740.6 6768.7 5895.5 5912.3 5913.3 5930.1 5931.4 22001.6 26063.7 26661.6 26714.7 26971.8 2231.8 2393.7 2406.7 2418.9 2477.0 8564.5 9775.3 10245.1 10465.5 10496.5 1611.7 1800.2 1822.8 1853.1 1905.4 125986.0 139612.0 141518.0 142041.3 142215.0 11319.7 11563.9 11762.6 11768.5 11971.7 15703.3 15705.1 15710.3 15710.9 15801.1 8363.5 8383.0 8635.5 8639.6 8794.1 8300.7 8352.0 8359.4 8457.7 8505.8 4103.7 4691.0 4768.6 4782.1 4896.4 1617.8 1958.8 1966.8 1991.2 2017.8 726.0 832.2 848.0 875.3 885.5 17036.5 21606.2 21855.3 21863.0 21901.6 847.8 885.4 904.3 917.4 919.4 9848.9 11238.4 11239.6 11288.8 11303.9 681431.0 692228.0 693928.0 696390.0 708673.5 111898.0 119461.0 122352.0 135158.0 137585.0 941.9 977.3 991.3 994.5 995.1 20480.5 20762.9 20802.5 20921.5 21071.9 44609.8 57430.1 57633.1 57801.0 59047.4 80696.6 88390.6 88656.0 89597.6 90176.0 7069.5 8333.6 8508.2 8604.0 8670.5 13110.1 13263.9 13630.0 13634.5 13696.3 11018.6 11437.4 11729.6 11738.8 11780.9 10730.3 11035.9 11414.9 11697.7 11911.6 11205.7 11534.5 11857.9 11863.0 11960.3 7453.2 8437.2 8593.9 8671.3 8885.4 10882.5 11206.9 11414.6 11839.8 11852.0 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5311.48 Median:5285.38 stddev:2874.59 (54.4%) stddev-sans-first:2866.69 04:46:05 INFO - PROCESS | 1688 | Values: 1280.7 1415.7 1422.2 1440.1 1443.0 7827.8 8221.2 8234.5 8249.2 8254.4 7302.7 7499.7 7835.3 7992.8 8123.3 1912.8 2278.6 2282.1 2283.4 2292.9 1971.6 2261.5 2293.3 2307.2 2311.8 2002.3 2033.0 2051.5 2075.2 2183.3 2265.6 2281.0 2281.9 2285.1 2290.9 2065.5 2067.1 2067.3 2131.2 2132.4 8222.1 8288.0 8288.0 8297.6 8298.3 4964.0 5121.2 5127.7 5137.8 5138.6 3246.3 3404.4 3467.5 3498.5 3525.3 1050.0 1168.8 1182.6 1238.5 1250.4 10508.6 10542.4 10547.5 10552.7 10580.7 4486.8 4524.6 4535.3 4559.9 4598.7 9252.0 9252.0 9257.0 9266.8 9331.8 5136.9 5153.5 5156.0 5159.9 5162.3 3708.1 4589.3 4662.1 4750.9 4751.4 3735.7 3755.7 3814.1 3851.4 3854.9 1240.2 1243.0 1247.4 1257.3 1261.7 788.7 844.3 897.0 900.0 936.7 5277.1 5381.3 5538.0 5662.3 5690.5 869.3 923.0 960.5 961.3 994.9 3531.8 3683.4 3732.7 3803.8 3812.4 8141.9 9587.1 9684.9 9780.4 9823.0 8249.7 9629.3 9703.4 9779.2 9805.6 7433.1 7511.2 7616.2 7642.5 7672.9 5293.7 5354.1 5363.0 5399.9 5553.2 8784.6 8833.2 9061.7 9130.0 9140.6 8577.3 8866.0 8944.4 9157.6 9245.3 6836.6 7097.5 7220.9 7221.6 7234.1 7724.1 7728.7 7788.5 7793.0 7797.9 6954.9 6981.7 7040.1 7144.6 7162.8 6829.0 6920.9 6938.3 6953.5 6971.5 6240.7 6384.7 6390.4 6400.7 6408.6 4788.9 4912.4 4946.8 4965.8 5022.0 4902.4 4917.3 5019.0 5148.2 5170.1 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:4422.09 Median:4929.26 stddev:1307.25 (26.5%) stddev-sans-first:1274.51 04:46:05 INFO - PROCESS | 1688 | Values: 339.9 345.8 356.2 364.7 369.0 4530.9 5142.0 5213.1 5215.6 5232.8 5148.8 5155.7 5170.8 5173.8 5179.2 3851.3 4084.6 4091.0 4112.9 4124.0 3338.7 3629.8 3777.8 3959.1 4099.7 3646.9 3996.9 4057.2 4069.7 4088.8 3444.7 3895.2 4065.6 4075.1 4079.2 3398.9 3508.0 3537.3 3626.0 3632.4 4552.7 4856.2 4929.0 4935.1 5051.3 4102.9 4657.0 4668.9 4674.8 4677.0 5032.5 5198.3 5438.8 5456.7 5510.3 3375.6 3950.8 3967.7 3975.3 3988.5 5484.7 5623.6 5646.5 5732.5 5777.8 3912.7 4061.5 4078.6 4082.2 4086.9 3671.9 3949.0 4131.0 4132.6 4142.9 4432.8 4656.7 4686.6 4714.0 4723.8 5546.7 5547.6 5555.5 5569.5 5574.1 1179.4 1332.8 1342.2 1345.9 1349.7 868.9 936.8 948.9 953.8 961.3 4069.5 4262.8 4833.8 4870.0 4899.0 5285.9 5320.3 5326.9 5330.7 5331.8 4017.3 4747.8 4794.6 4894.9 4941.9 2559.9 2730.3 2798.9 2821.5 2840.8 4505.2 4929.5 5537.0 5586.9 5646.9 4796.4 4893.6 5299.3 5362.8 5404.6 4555.4 4965.4 5254.7 5586.2 5608.4 4809.7 5302.7 5322.1 5326.1 5349.3 5053.5 5306.4 5309.3 5375.2 5387.0 5129.9 5497.1 5546.8 5698.3 5856.6 3228.9 3592.3 3792.7 3801.0 3803.4 5042.5 5612.6 5641.1 5641.7 5654.7 5406.6 5414.5 5447.9 5487.8 5504.9 5408.7 5435.8 5437.2 5442.6 5470.2 4517.3 4657.6 4971.9 5289.7 5341.7 4871.8 5422.7 5442.9 5444.9 5447.3 5294.5 5300.5 5314.0 5318.8 5323.3 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:19620.29 Median:4493.07 stddev:27193.82 (605.2%) stddev-sans-first:27233.01 04:46:05 INFO - PROCESS | 1688 | Values: 702.9 703.6 760.8 811.1 818.6 14610.6 15504.9 15534.0 15549.0 15660.5 14275.8 14406.0 14416.8 14453.5 14461.9 681.3 704.8 856.7 867.8 884.7 884.9 887.7 888.1 889.8 890.0 934.3 935.8 936.6 936.7 937.9 934.4 935.1 935.6 936.8 937.4 531.4 546.8 681.3 693.7 699.3 14526.6 14573.4 14811.6 14876.4 14923.8 13336.8 13462.0 13519.9 13521.5 13573.7 11344.5 11354.3 11438.4 11461.5 11565.2 4365.2 4393.4 4394.4 4572.5 4578.9 69487.7 95327.0 97398.0 99456.5 100177.5 10567.2 10713.5 10829.8 10854.1 11211.2 18096.9 20258.3 20701.8 21199.0 21246.4 7712.1 7905.0 7911.1 7993.4 8113.4 3720.0 4346.0 4436.1 4550.0 4566.2 3448.9 3506.2 3535.7 3546.3 3556.8 655.6 656.9 671.9 672.5 677.1 659.8 703.5 715.8 721.4 759.6 9736.9 10403.4 10414.6 10452.8 10613.1 655.2 660.7 682.4 708.2 710.0 4925.4 4935.4 4999.8 5010.7 5027.2 83193.5 92842.0 95657.0 99612.0 100034.0 85590.7 86627.7 87875.1 88727.7 89988.6 69548.0 70600.0 70612.3 77317.0 79493.2 10686.6 10857.2 10950.3 11000.0 11264.3 47802.5 49451.0 49644.5 49675.5 49945.3 61882.4 63936.7 63974.4 64918.0 65888.7 12859.4 12979.3 12999.4 13140.8 13177.0 14552.5 14742.2 15072.2 15246.5 15254.4 13515.9 13761.9 13777.9 13966.7 14272.9 13328.7 13733.1 13745.9 14015.9 14209.5 13249.9 13492.3 13501.3 13504.6 13992.5 10351.0 11167.8 11342.0 11343.4 11366.8 9123.6 10912.0 10927.9 10987.6 11026.3 04:46:05 INFO - PROCESS | 1688 | -------- Summary: end -------- 04:46:05 INFO - PROCESS | 1688 | 04:46:05 INFO - TEST-INFO | 1688: exit 0 04:46:05 INFO - TEST-OK | dromaeo_css | took 1119260ms 04:46:05 INFO - TEST-START | kraken 04:46:05 INFO - operating with platform_type : mac_ 04:46:05 INFO - Initialising browser for kraken test... 04:46:05 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpPtzuGM/profile http://localhost:49245/getInfo.html) 04:46:08 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 04:46:08 INFO - PROCESS | 1694 | colorDepth:24 04:46:08 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 04:46:08 INFO - PROCESS | 1694 | __metrics 04:46:08 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 04:46:08 INFO - PROCESS | 1694 | 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" 04:46:08 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:08 INFO - TEST-INFO | 1694: exit 0 04:46:08 INFO - Browser initialized. 04:46:08 INFO - Running cycle 1/1 for kraken test... 04:46:08 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/T/tmpPtzuGM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:46:20 INFO - PROCESS | 1696 | RSS: Main: 234881024 04:46:20 INFO - PROCESS | 1696 | 04:46:23 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 04:46:24 INFO - PROCESS | 1696 | RSS: Main: 289468416 04:46:24 INFO - PROCESS | 1696 | 04:46:27 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 04:46:28 INFO - PROCESS | 1696 | RSS: Main: 290213888 04:46:28 INFO - PROCESS | 1696 | 04:46:31 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 04:46:32 INFO - PROCESS | 1696 | RSS: Main: 382513152 04:46:32 INFO - PROCESS | 1696 | 04:46:34 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 04:46:34 INFO - PROCESS | 1696 | RSS: Main: 282107904 04:46:34 INFO - PROCESS | 1696 | 04:46:36 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:46:37 INFO - PROCESS | 1696 | RSS: Main: 286367744 04:46:37 INFO - PROCESS | 1696 | 04:46:40 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 04:46:40 INFO - PROCESS | 1696 | RSS: Main: 327143424 04:46:40 INFO - PROCESS | 1696 | 04:46:43 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 04:46:44 INFO - PROCESS | 1696 | RSS: Main: 329453568 04:46:44 INFO - PROCESS | 1696 | 04:46:47 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 04:46:48 INFO - PROCESS | 1696 | RSS: Main: 328048640 04:46:48 INFO - PROCESS | 1696 | 04:46:49 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:46:50 INFO - PROCESS | 1696 | RSS: Main: 302477312 04:46:50 INFO - PROCESS | 1696 | 04:46:52 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:46:52 INFO - PROCESS | 1696 | RSS: Main: 308477952 04:46:52 INFO - PROCESS | 1696 | 04:46:54 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:46:55 INFO - PROCESS | 1696 | RSS: Main: 309583872 04:46:55 INFO - PROCESS | 1696 | 04:46:58 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:46:59 INFO - PROCESS | 1696 | RSS: Main: 328097792 04:46:59 INFO - PROCESS | 1696 | 04:47:02 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:02 INFO - PROCESS | 1696 | RSS: Main: 322318336 04:47:02 INFO - PROCESS | 1696 | 04:47:04 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 04:47:05 INFO - PROCESS | 1696 | RSS: Main: 365821952 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | __start_tp_report 04:47:05 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 04:47:05 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 04:47:05 INFO - PROCESS | 1696 | |i|pagename|runs| 04:47:05 INFO - PROCESS | 1696 | |0;ai-astar;114;115;113;121;168;154;113;114;112;114 04:47:05 INFO - PROCESS | 1696 | |1;audio-beat-detection;144;110;109;161;141;140;97;137;160;136 04:47:05 INFO - PROCESS | 1696 | |2;audio-dft;182;185;182;184;185;179;181;180;194;261 04:47:05 INFO - PROCESS | 1696 | |3;audio-fft;78;50;75;104;86;77;59;58;73;59 04:47:05 INFO - PROCESS | 1696 | |4;audio-oscillator;85;71;86;71;69;70;83;67;70;83 04:47:05 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;94;91;90;91;93;91;94;90;93;86 04:47:05 INFO - PROCESS | 1696 | |6;imaging-darkroom;95;96;95;95;95;100;145;96;95;99 04:47:05 INFO - PROCESS | 1696 | |7;imaging-desaturate;87;83;84;84;84;84;85;86;106;135 04:47:05 INFO - PROCESS | 1696 | |8;json-parse-financial;57;55;55;55;55;56;56;56;55;55 04:47:05 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;65;73;74;75;73;71;68;70;70;70 04:47:05 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;86;86;87;90;90;87;87;86;87;82 04:47:05 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;141;141;152;143;143;144;132;142;198;177 04:47:05 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;176;173;174;173;231;182;174;173;177;177 04:47:05 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;68;68;68;76;84;84;84;79;66;67 04:47:05 INFO - PROCESS | 1696 | __end_tp_report 04:47:05 INFO - PROCESS | 1696 | __start_cc_report 04:47:05 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,2042 04:47:05 INFO - PROCESS | 1696 | __end_cc_report 04:47:05 INFO - PROCESS | 1696 | __startTimestamp1485089225066__endTimestamp 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | ------- Summary: start ------- 04:47:05 INFO - PROCESS | 1696 | Number of tests: 14 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:123.80 Median:114.50 stddev:20.03 (17.5%) stddev-sans-first:20.93 04:47:05 INFO - PROCESS | 1696 | Values: 114.0 115.0 113.0 121.0 168.0 154.0 113.0 114.0 112.0 114.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:142.50 stddev:21.53 (15.1%) stddev-sans-first:22.49 04:47:05 INFO - PROCESS | 1696 | Values: 144.0 110.0 109.0 161.0 141.0 140.0 97.0 137.0 160.0 136.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:191.30 Median:184.50 stddev:24.85 (13.5%) stddev-sans-first:26.12 04:47:05 INFO - PROCESS | 1696 | Values: 182.0 185.0 182.0 184.0 185.0 179.0 181.0 180.0 194.0 261.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:71.90 Median:74.00 stddev:16.02 (21.6%) stddev-sans-first:16.84 04:47:05 INFO - PROCESS | 1696 | Values: 78.0 50.0 75.0 104.0 86.0 77.0 59.0 58.0 73.0 59.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.00 stddev:7.66 (10.0%) stddev-sans-first:7.32 04:47:05 INFO - PROCESS | 1696 | Values: 85.0 71.0 86.0 71.0 69.0 70.0 83.0 67.0 70.0 83.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:92.00 stddev:2.41 (2.6%) stddev-sans-first:2.35 04:47:05 INFO - PROCESS | 1696 | Values: 94.0 91.0 90.0 91.0 93.0 91.0 94.0 90.0 93.0 86.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:101.10 Median:95.00 stddev:15.53 (16.3%) stddev-sans-first:16.32 04:47:05 INFO - PROCESS | 1696 | Values: 95.0 96.0 95.0 95.0 95.0 100.0 145.0 96.0 95.0 99.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:84.00 stddev:16.64 (19.8%) stddev-sans-first:17.56 04:47:05 INFO - PROCESS | 1696 | Values: 87.0 83.0 84.0 84.0 84.0 84.0 85.0 86.0 106.0 135.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:0.71 (1.3%) stddev-sans-first:0.50 04:47:05 INFO - PROCESS | 1696 | Values: 57.0 55.0 55.0 55.0 55.0 56.0 56.0 56.0 55.0 55.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:72.00 stddev:3.00 (4.2%) stddev-sans-first:2.30 04:47:05 INFO - PROCESS | 1696 | Values: 65.0 73.0 74.0 75.0 73.0 71.0 68.0 70.0 70.0 70.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:87.00 stddev:2.25 (2.6%) stddev-sans-first:2.37 04:47:05 INFO - PROCESS | 1696 | Values: 86.0 86.0 87.0 90.0 90.0 87.0 87.0 86.0 87.0 82.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:143.50 stddev:20.29 (14.1%) stddev-sans-first:21.17 04:47:05 INFO - PROCESS | 1696 | Values: 141.0 141.0 152.0 143.0 143.0 144.0 132.0 142.0 198.0 177.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:176.50 stddev:17.79 (10.1%) stddev-sans-first:18.78 04:47:05 INFO - PROCESS | 1696 | Values: 176.0 173.0 174.0 173.0 231.0 182.0 174.0 173.0 177.0 177.0 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:77.50 stddev:7.81 (10.1%) stddev-sans-first:7.93 04:47:05 INFO - PROCESS | 1696 | Values: 68.0 68.0 68.0 76.0 84.0 84.0 84.0 79.0 66.0 67.0 04:47:05 INFO - PROCESS | 1696 | -------- Summary: end -------- 04:47:05 INFO - PROCESS | 1696 | 04:47:05 INFO - TEST-INFO | 1696: exit 0 04:47:05 INFO - TEST-OK | kraken | took 60341ms 04:47:05 INFO - SUITE-END | took 1179s 04:47:06 INFO - Completed test suite (00:19:39) 04:47:06 INFO - javascript benchmark 04:47:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.0990727549915, 3280.1963518937864, 3316.1709572606865, 3345.882894098707, 3378.1048022274103, 5548.6948217848, 5552.056150454422, 5589.161625756138, 5610.551155907528, 5621.83134505965, 5477.397486276506, 5514.503694667479, 5543.1408131739545, 5584.497395234428, 5586.10622300432, 5084.0, 5089.312942752718, 5109.821156259532, 5135.0, 5168.767405466763, 5156.510131537498, 5240.44975277596, 5245.632805703603, 5260.184671375943, 5282.260483532308, 5051.747412629391, 5195.0, 5227.555657769094, 5238.8690282742855, 5279.524842764151, 5099.643024988252, 5107.770150343244, 5140.7172605506685, 5154.871128221825, 5169.172932330809, 5097.847064588068, 5141.562967147797, 5152.562032227265, 5162.432132465426, 5195.376554813409, 5669.971650141764, 5679.318481782213, 5683.886322273573, 5690.800821971253, 5713.257276554022, 5395.0, 6053.848653783691, 6092.0, 6101.542384321194, 6190.876182476371, 5098.209777484496, 6128.422616821487, 6159.045347971071, 6214.0, 6250.562460627758, 5789.797357092523, 5804.303483581997, 5807.941920580824, 5825.213596164548, 5847.386024467455, 6080.847978800477, 6236.095766113979, 6242.812715618538, 6257.624542527463, 6261.96869015652, 5963.821085367446, 6013.909791353133, 6033.095035744674, 6038.516918646497, 6148.1392605035335, 6109.816705498843, 6171.444569988723, 6211.223597050369, 6223.284322302902, 6230.937690623126, 6050.6672133032225, 6078.179445774852, 6106.9157392686275, 6107.674343494518, 6108.683874366847, 6135.2326666699655, 6146.6004709693725, 6183.072539119168, 6197.752089916443, 6248.968755156195, 4954.256861470736, 4960.925586116211, 4965.379327584052, 4974.228994505857, 4989.476105008995, 4383.9342409863875, 4394.956050439519, 4396.0, 4472.9552704472535, 4488.955110448854, 5740.827775166752, 5741.770329186869, 5776.653400795965, 5852.122181672783, 5911.113333000085, 6212.254529456494, 6238.875222495525, 6243.094751261042, 6268.059791031382, 6273.7176827042895, 5599.412061733541, 5815.0, 5848.3274423441, 5849.532037436995, 5858.707064646751, 5324.946750532445, 5394.0290747665795, 5400.270963419966, 5404.783808647689, 5410.83767486976, 6116.396640261158, 6156.907646385218, 6191.411815877575, 6195.256569211723, 6220.564560480904, 6209.689515524296, 6217.4715149212825, 6240.188775459343, 6256.217972753406, 6259.96870015647, 6231.532635052298, 6302.1492098566105, 6308.08532762756, 6311.968440157953, 6319.96840015797, 6054.8183554493435, 6103.115048318058, 6202.28673702512, 6206.10011548332, 6217.782377616762, 5116.7441627917715, 6040.6304308743265, 6161.5686901918225, 6191.473724733448, 6243.313235544178, 6096.420840020191, 6097.878042439215, 6108.0, 6123.84690382744, 6127.877442451037, 6088.756449742138, 6106.603070800384, 6137.60105593135, 6143.56995010345, 6152.907706384497, 5714.771409143587, 5776.277965254343, 5818.94181058184, 5861.384554621874, 5877.382874798255, 6059.72731227087, 6084.421979911901, 6086.6348019119, 6087.147799308189, 6113.480354169946, 5406.648567843077, 5421.1055175895535, 5834.7082645866685, 5884.293884733688, 5894.705264736832], "value": 5648.0281585150415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.6867320578225, 488.8948875991661, 490.4751915450469, 499.453098856752, 501.62879469192796, 30759.846200768992, 40118.0, 42108.368374474405, 42213.944651383696, 42344.0, 43169.0, 43612.78193609027, 43681.56318436815, 43698.907527311836, 43766.68699939007, 9435.669751558697, 9634.0, 9634.807303853919, 9639.903600963971, 9649.807003859918, 8430.072692003874, 8633.438826476258, 11417.600383986563, 11662.708432289175, 11692.766144677102, 11500.367479788609, 11560.826587601192, 11604.129690273221, 11606.303621782678, 11617.709557261094, 9713.805723885518, 11617.477213525412, 11627.011704005085, 11630.592929247478, 11638.243514171552, 8416.537090460022, 8661.610227539775, 8666.6100025499, 8754.47473151613, 8775.561221938877, 40564.594354056375, 41289.96775080617, 41409.378859317134, 43339.0, 43474.13051738947, 3355.2282974915906, 3804.2011177652726, 3920.7255492115564, 3967.583403742623, 4028.6575641070544, 30163.69836301631, 30649.387012259853, 31249.53125703116, 31401.842990785128, 31527.0, 3182.9363412731614, 3237.902862914116, 3336.3160552086765, 3356.1274068742305, 3358.076528954557, 462328.0, 462584.0, 467121.0, 468676.0, 471506.99999999657, 62227.688861555405, 62590.687046564475, 62622.68688656527, 62664.68667656633, 62844.0, 66456.33543664501, 66593.0, 66626.0, 66650.0, 66858.0, 15453.072815631098, 15911.681766364607, 15981.520554383387, 16063.67872642564, 16087.541178646647, 11197.832032519518, 11539.423028848523, 12458.563950261698, 12556.246625202517, 12586.685332866751, 15183.848161518465, 15329.31018104188, 15337.233138343037, 15351.539453816404, 17357.13214339278, 5870.53839082292, 6432.324605916311, 6452.0967064610995, 6464.450521705614, 6469.191351081115, 859.2610355094614, 862.4127617148554, 863.2360361080489, 868.5396739727954, 890.5636238243214, 29808.956686515867, 29819.552706709415, 29838.0, 30504.694953050628, 30644.84677576598, 1034.3483605328595, 1039.8232300508932, 1065.1265961911158, 1084.1110289562641, 1151.1366475143643, 15080.095194288158, 15270.31283592241, 15439.0, 15501.84498155004, 15812.525624231292, 583834.0, 583952.0, 586239.0, 588911.0, 589744.0, 60589.09116363258, 60892.39107608867, 60948.39051609516, 61124.083138752954, 61251.77496450046, 1164.7554013657057, 1386.6186798630256, 1441.5819412370504, 1443.8483959184555, 1445.913245205291, 29023.839046437904, 29144.7085529142, 29493.410131797675, 29992.700072998992, 30056.549151762305, 51268.487315126375, 51520.74239628778, 51541.742291288305, 51741.0, 51833.22250166175, 407514.0, 408908.0, 409670.0, 410473.0, 411908.0, 39111.0, 39596.2080758389, 40155.0, 40509.1898162041, 40532.13614366295, 45918.540814592765, 47143.528564715285, 47245.0, 47409.28886066781, 47471.0, 27589.862050690423, 37330.25339493249, 37667.623323767504, 38957.6104238954, 39070.80464597659, 34946.65053349434, 35711.46432803562, 36321.27357452889, 36648.60026851019, 37156.44265335968, 35181.82409087938, 35970.64029359673, 36008.81995590005, 36293.72971945969, 36363.0, 28778.856105719336, 30442.0, 30880.382392352476, 31729.04812855618, 32667.509987350684, 23520.41198969971, 23703.40741481408, 24029.918653660978, 24351.0, 24556.386090347885], "value": 19834.192936959153, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.39822735030793, 361.98552057917686, 377.6619925166976, 384.571203108534, 392.3780807420239, 15251.542453726392, 15469.535913922586, 16358.836411635895, 20739.688904666404, 21393.893030534826, 21263.36209913701, 22053.558928821414, 22215.777842221574, 22598.322050338476, 22856.857157142116, 4962.156433406311, 5914.940850591493, 5945.970270148643, 6165.290991535963, 6175.301792007212, 4282.657387409015, 5980.252468441445, 6101.145839582462, 6108.358622344656, 6109.205803245572, 4462.330650402433, 6360.55476116672, 6657.234418041939, 6676.19885613727, 6768.153980752406, 6507.479401647857, 6686.331366863324, 6713.99290106483, 6740.595564266159, 6768.69540870662, 5895.4694077532795, 5912.290525136968, 5913.2608423947, 5930.1401296812155, 5931.436513531207, 22001.559968800695, 26063.73936260632, 26661.600075998875, 26714.73285267142, 26971.786269617915, 2231.7991380775807, 2393.6529203265427, 2406.6750988616486, 2418.9274321770376, 2476.9752302477104, 8564.528950907697, 9775.266854985905, 10245.129164021067, 10465.47672616366, 10496.527656255486, 1611.7340638794585, 1800.1809176824645, 1822.7812662480455, 1853.073463268366, 1905.4378958207362, 125985.99999999908, 139612.0, 141518.0, 142041.28979355036, 142215.0, 11319.717007074725, 11563.88436115645, 11762.5883094093, 11768.470418831173, 11971.700707482383, 15703.293351798968, 15705.057696538244, 15710.293036813371, 15710.9214453927, 15801.13093779853, 8363.498190108612, 8382.958085209535, 8635.525046122399, 8639.568021598894, 8794.053991912653, 8300.70947516834, 8352.0, 8359.414840961195, 8457.746267611981, 8505.787355316166, 4103.733257338264, 4690.95309046912, 4768.594669453066, 4782.115308667908, 4896.387951506062, 1617.7896873406382, 1958.7845337012918, 1966.783653798081, 1991.163711241282, 2017.7982201779998, 725.9528130671595, 832.1636755061124, 847.9872801907976, 875.3478658399533, 885.4642941020719, 17036.48890533286, 21606.243781467572, 21855.29751680455, 21863.04419115387, 21901.601500504763, 847.809242920338, 885.3625389719392, 904.2810965282616, 917.4082716647724, 919.4161707315902, 9848.901510984942, 11238.38188899602, 11239.550417983353, 11288.774224515464, 11303.86961303863, 681431.0, 692228.0, 693928.0, 696390.0, 708673.4566327136, 111898.0, 119461.0, 122352.0, 135158.0, 137585.0, 941.8634298026885, 977.3451787302524, 991.3407583956588, 994.4641165029146, 995.0745806400117, 20480.487987800425, 20762.896185518977, 20802.479938001066, 20921.476963076046, 21071.894640526698, 44609.77695111504, 57430.13854792265, 57633.13550296665, 57801.0, 59047.40952590419, 80696.59651701704, 88390.55804720936, 88656.0, 89597.55201223952, 90176.0, 7069.469789765685, 8333.583320833814, 8508.234258916727, 8604.0, 8670.479771213748, 13110.147840390344, 13263.867361326264, 13630.0, 13634.522791702242, 13696.31518424055, 11018.559257629926, 11437.370944598128, 11729.648110556696, 11738.823917641072, 11780.941095294469, 10730.302530335503, 11035.944820275847, 11414.885851141382, 11697.707557311136, 11911.642650720492, 11205.71985700364, 11534.538618455503, 11857.881421185677, 11863.0, 11960.342181180118, 7453.180150183367, 8437.156284371515, 8593.8710919335, 8671.262942649693, 8885.378023538291, 10882.455877206266, 11206.887931120584, 11414.600488982845, 11839.76320473603, 11852.0], "value": 9812.655528299154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.699035726604, 1415.7097794952035, 1422.1964590006646, 1440.0567628203523, 1443.0475885915298, 7827.804304892381, 8221.177882211783, 8234.505929644225, 8249.175082491747, 8254.42219044667, 7302.707891684339, 7499.700011999514, 7835.33399661028, 7992.760217193479, 8123.309518690904, 1912.7800302965163, 2278.646809744484, 2282.109977108929, 2283.4063143582707, 2292.885355732215, 1971.5563998100383, 2261.525079733258, 2293.3005433342823, 2307.1694190091553, 2311.780380863815, 2002.3292197113985, 2032.959340813183, 2051.4871282179456, 2075.2321640992777, 2183.3340831046526, 2265.592193405186, 2281.0191617604423, 2281.863088214696, 2285.1430713482528, 2290.896909639054, 2065.5455799724036, 2067.080149333547, 2067.286786058807, 2131.2007997001124, 2132.424245453719, 8222.054463736687, 8288.005439347256, 8288.005439347256, 8297.585120744, 8298.336133109397, 4964.0, 5121.2318152277085, 5127.692338459704, 5137.765072193608, 5138.563222126124, 3246.3345014272254, 3404.3701915145775, 3467.514547963262, 3498.510208570802, 3525.2596954639557, 1049.9842502362394, 1168.8480497535352, 1182.603827717707, 1238.4612693478275, 1250.4435526190757, 10508.632197873114, 10542.36745795247, 10547.472626368728, 10552.736181595445, 10580.682579522627, 4486.820527178941, 4524.5927866492175, 4535.274356103007, 4559.886002849889, 4598.655100867381, 9251.953740231256, 9252.028537003653, 9257.0, 9266.768330791649, 9331.766705832408, 5136.8715782105, 5153.5361817436615, 5155.97422012895, 5159.896802063938, 5162.328897243335, 3708.1131445082196, 4589.2657174851865, 4662.137504561667, 4750.857474275708, 4751.358566593465, 3735.6824669903363, 3755.6995440364703, 3814.0655539392474, 3851.441540976599, 3854.8650797221962, 1240.1814802230485, 1242.9683362808846, 1247.3513772838073, 1257.3336131850135, 1261.6971926737701, 788.6727008291609, 844.2654890245526, 896.9551522423983, 899.9550022498848, 936.7049379445452, 5277.076511610453, 5381.273528073738, 5538.0, 5662.348829884533, 5690.459406356389, 869.2654706772767, 922.9815403691889, 960.4632587859369, 961.2502248246379, 994.880614326271, 3531.7576159399196, 3683.3922402803237, 3732.720045996561, 3803.7527560708463, 3812.370958791824, 8141.877871831927, 9587.089226523469, 9684.903150968541, 9780.364276322016, 9822.950885245671, 8249.670013199524, 9629.277804164716, 9703.417794932328, 9779.168770654574, 9805.558749856273, 7433.070866141732, 7511.173770885198, 7616.200298968639, 7642.541447513056, 7672.923270767221, 5293.682379057115, 5354.143337066206, 5362.973185134049, 5399.892002160013, 5553.194786755978, 8784.604692788967, 8833.249173820297, 9061.728148155566, 9130.041345658876, 9140.588673509576, 8577.313814894918, 8865.955670221607, 8944.418612790148, 9157.633694652139, 9245.260379169516, 6836.589804611739, 7097.46768992338, 7220.8916866246, 7221.566705997657, 7234.059572255573, 7724.0731112266885, 7728.652210650646, 7788.454808163374, 7792.961035194788, 7797.92202077972, 6954.860902782018, 6981.685824137824, 7040.0847889774, 7144.571325720473, 7162.820929476805, 6829.0, 6920.861582768417, 6938.306169383021, 6953.478489113438, 6971.477139214478, 6240.687965601793, 6384.712687928962, 6390.392912673475, 6400.71196796136, 6408.61548307103, 4788.880277993078, 4912.361393018885, 4946.777395017305, 4965.751712414437, 5022.045811295989, 4902.436219834764, 4917.311576379238, 5019.0, 5148.2020286855595, 5170.095233334227], "value": 4319.859874696822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8521643085258, 345.8339996801535, 356.1576870700792, 364.675438859415, 368.9557253129625, 4530.886727831806, 5142.0, 5213.139831927737, 5215.6349055566125, 5232.816851410202, 5148.768305426255, 5155.690658560489, 5170.819021334245, 5173.818916337929, 5179.19722443021, 3851.345271303885, 4084.611961863618, 4090.97954510227, 4112.876613701594, 4123.989622542466, 3338.7162483863563, 3629.782213067211, 3777.7511340247365, 3959.148783011652, 4099.672026237894, 3646.869470464165, 3996.8832102934025, 4057.235102730307, 4069.7151199416053, 4088.7955602219918, 3444.7254515829054, 3895.2014836958356, 4065.6340929316357, 4075.0643444363986, 4079.1841631673487, 3398.9490157647656, 3507.9649203508147, 3537.2939701128657, 3625.966599519151, 3632.364336241147, 4552.746390536672, 4856.17445034345, 4929.035866601416, 4935.087008903364, 5051.3433253676785, 4102.917941641181, 4656.95343046572, 4668.883277918046, 4674.789634466457, 4676.976615116902, 5032.47159048302, 5198.2722418861385, 5438.809641662523, 5456.699881506515, 5510.283663123809, 3375.611804642473, 3950.8419663213435, 3967.682585393162, 3975.3043217436834, 3988.521377434726, 5484.670919744828, 5623.550115990711, 5646.520045796154, 5732.5127364174095, 5777.768889244425, 3912.7065470089856, 4061.5329237137516, 4078.5936297584567, 4082.2243773682903, 4086.9386959195635, 3671.889843304705, 3949.0, 4130.958690413057, 4132.603090207673, 4142.937855932163, 4432.778361081933, 4656.674032817738, 4686.648501362343, 4713.976430117896, 4723.7874295656775, 5546.722663866871, 5547.55619550435, 5555.472230138131, 5569.526590239794, 5574.080276754371, 1179.3926128044063, 1332.7867541193364, 1342.16785592933, 1345.9461621535224, 1349.730053989206, 868.8522951098329, 936.840737074699, 948.9003654616304, 953.7567920180448, 961.2694352292308, 4069.5408902432696, 4262.765547894834, 4833.782479788418, 4870.0, 4898.975505122452, 5285.859227013066, 5320.334958130234, 5326.866828329323, 5330.668332292317, 5331.840044798662, 4017.252495164613, 4747.83382581608, 4794.640401969867, 4894.853154405374, 4941.925871111936, 2559.8592077435546, 2730.30377253799, 2798.874050667725, 2821.548552231633, 2840.843753593531, 4505.175403961401, 4929.482404347564, 5537.010014592156, 5586.91619625706, 5646.898854723289, 4796.448408433005, 4893.6329775266995, 5299.284596579412, 5362.785488580491, 5404.648697834628, 4555.40779698637, 4965.354503914468, 5254.710990895537, 5586.24585680936, 5608.411116832755, 4809.663323567317, 5302.70835104073, 5322.148456246982, 5326.147816349366, 5349.331333583302, 5053.545180933586, 5306.363236411501, 5309.283246761638, 5375.16684913839, 5386.973065134649, 5129.948700512947, 5497.120460726424, 5546.75039623226, 5698.31620205578, 5856.590038697421, 3228.8547015383892, 3592.323718829489, 3792.715546333981, 3801.0, 3803.3724435468944, 5042.546170844642, 5612.596850787303, 5641.110228073641, 5641.746121424464, 5654.6889921054735, 5406.648567843077, 5414.485623865727, 5447.918281225864, 5487.75305111279, 5504.91742623869, 5408.729563521887, 5435.836924892102, 5437.184422336682, 5442.564594832483, 5470.15551912995, 4517.322401639781, 4657.5575320344515, 4971.906180640253, 5289.7355132242465, 5341.7062061586985, 4871.780769865293, 5422.728863556727, 5442.945570544244, 5444.8638784029135, 5447.256877799225, 5294.49702278283, 5300.496452836975, 5314.041039425652, 5318.813841515528, 5323.281357016753], "value": 4022.7127327902945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.8524009957908, 703.5743375257972, 760.8097975506123, 811.111832543365, 818.64388990789, 14610.634734131652, 15504.922475387635, 15534.0, 15549.0, 15660.530184094481, 14275.78586321206, 14406.0, 14416.783748243759, 14453.494127705533, 14461.855381446183, 681.3425044831737, 704.8343639244773, 856.7001549457672, 867.7570280321504, 884.6594061286419, 884.8672699095155, 887.7336798960287, 888.138505649519, 889.7775556110972, 890.0076414797486, 934.2806039349697, 935.7613808478828, 936.6206686292029, 936.6955739384694, 937.9015203403646, 934.4486752815803, 935.0836180543106, 935.6210734652477, 936.798588303518, 937.4469063252714, 531.4021725558746, 546.8332158691597, 681.2574294019493, 693.6739732325849, 699.3006993006993, 14526.564203073818, 14573.417063317454, 14811.555653330417, 14876.404943802236, 14923.776143357858, 13336.799948000787, 13462.0, 13519.932400337935, 13521.459141634323, 13573.660658483519, 11344.546218151265, 11354.318740875491, 11438.370889601068, 11461.484233209525, 11565.190436669436, 4365.236083685342, 4393.406890069864, 4394.4287242658565, 4572.491077944271, 4578.88552786183, 69487.65256173737, 95327.0, 97398.0, 99456.50271748594, 100177.4991125047, 10567.207459440573, 10713.517891694892, 10829.783404332027, 10854.077403420797, 11211.159163062803, 18096.90951545234, 20258.290959816335, 20701.792982069986, 21199.0, 21246.362609121752, 7712.074551053797, 7905.0, 7911.090224624127, 7993.440459167919, 8113.350931925432, 3719.9814000929823, 4345.956540434555, 4436.0906014267, 4550.044490656999, 4566.155261276608, 3448.8792892248653, 3506.2111025019676, 3535.734819888519, 3546.343926373629, 3556.822158892045, 655.6493623136355, 656.8850451171025, 671.8790617688863, 672.515788632184, 677.0588881454781, 659.8086554899121, 703.521605308385, 715.8174665460274, 721.4372789224414, 759.5746382026083, 9736.853947190797, 10403.42781147029, 10414.635487758043, 10452.843207351896, 10613.097886679565, 655.1712084213474, 660.7191943424026, 682.382443888272, 708.2174197511779, 709.9563641447064, 4925.415281569056, 4935.437874790693, 4999.775010124553, 5010.67430617016, 5027.195648696191, 83193.45300319642, 92842.0, 95657.0, 99612.00387996028, 100033.99932001319, 85590.71613925796, 86627.70058449128, 87875.12124878797, 88727.66908496378, 89988.5500572506, 69547.95678064832, 70600.0, 70612.29387706057, 77317.0, 79493.20506794858, 10686.57253709874, 10857.154184672894, 10950.288231264942, 11000.0, 11264.324140551593, 47802.521974779804, 49451.0, 49644.503554965435, 49675.50324496853, 49945.25082123699, 61882.381176187664, 63936.68031659812, 63974.36025639684, 64918.0, 65888.68222635616, 12859.357032148542, 12979.286139262054, 12999.350032498527, 13140.80288795688, 13177.0, 14552.49066282675, 14742.189179595225, 15072.24638768079, 15246.542603721906, 15254.389824406899, 13515.86484135146, 13761.862381376059, 13777.862221377658, 13966.720665586834, 14272.857271427152, 13328.666783330495, 13733.107348022746, 13745.931270343985, 14015.929920350332, 14209.50266740659, 13249.867501325249, 13492.325383730578, 13501.257430841399, 13504.594862154152, 13992.510262140777, 10351.0, 11167.832482512606, 11342.0, 11343.376114313793, 11366.829497557377, 9123.635054598008, 10912.0, 10927.945360273148, 10987.61543345979, 11026.283291586022], "value": 7517.550405032343, "unit": "score"}], "name": "dromaeo_css", "value": 7236.613276265636, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 121.0, 168.0, 154.0, 113.0, 114.0, 112.0, 114.0], "value": 123.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 109.0, 161.0, 141.0, 140.0, 97.0, 137.0, 160.0, 136.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 182.0, 184.0, 185.0, 179.0, 181.0, 180.0, 194.0, 261.0], "value": 191.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 50.0, 75.0, 104.0, 86.0, 77.0, 59.0, 58.0, 73.0, 59.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 86.0, 71.0, 69.0, 70.0, 83.0, 67.0, 70.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 90.0, 91.0, 93.0, 91.0, 94.0, 90.0, 93.0, 86.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 100.0, 145.0, 96.0, 95.0, 99.0], "value": 101.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 84.0, 84.0, 84.0, 84.0, 85.0, 86.0, 106.0, 135.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 74.0, 75.0, 73.0, 71.0, 68.0, 70.0, 70.0, 70.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 90.0, 90.0, 87.0, 87.0, 86.0, 87.0, 82.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 152.0, 143.0, 143.0, 144.0, 132.0, 142.0, 198.0, 177.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 174.0, 173.0, 231.0, 182.0, 174.0, 173.0, 177.0, 177.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 76.0, 84.0, 84.0, 84.0, 79.0, 66.0, 67.0], "value": 74.4, "unit": "score"}], "name": "kraken", "value": 1500.1, "alertThreshold": 2.0}]} 04:47:06 INFO - Return code: 0 04:47:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:06 ERROR - # TBPL SUCCESS # 04:47:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:06 INFO - 2017-01-22 04:47:06.367 screenresolution[1700:14462] starting screenresolution argv=screenresolution get 04:47:06 INFO - 2017-01-22 04:47:06.371 screenresolution[1700:14462] Display 0: 1600x1200x32@60 04:47:06 INFO - 2017-01-22 04:47:06.377 screenresolution[1701:14465] starting screenresolution argv=screenresolution list 04:47:06 INFO - Available Modes on Display 0 04:47:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:06 INFO - Intel Iris: 04:47:06 INFO - Chipset Model: Intel Iris 04:47:06 INFO - Type: GPU 04:47:06 INFO - Bus: Built-In 04:47:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:06 INFO - Vendor: Intel (0x8086) 04:47:06 INFO - Device ID: 0x0a2e 04:47:06 INFO - Revision ID: 0x0009 04:47:06 INFO - Displays: 04:47:06 INFO - Display: 04:47:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:06 INFO - Display Serial Number: 1600x1200 60 04:47:06 INFO - Main Display: Yes 04:47:06 INFO - Mirror: Off 04:47:06 INFO - Online: Yes 04:47:06 INFO - Rotation: Supported 04:47:06 INFO - Return code: 0 04:47:06 INFO - Running post-action listener: _resource_record_post_action 04:47:06 INFO - [mozharness: 2017-01-22 12:47:06.617270Z] Finished run-tests step (success) 04:47:06 INFO - Running post-run listener: _resource_record_post_run 04:47:06 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32451584; Write bytes: 551307776; Read time: 197; Write time: 1666 04:47:06 INFO - TinderboxPrint: CPU usage
53.9% 04:47:06 INFO - TinderboxPrint: I/O read bytes / time
32,451,584 / 197 04:47:06 INFO - TinderboxPrint: I/O write bytes / time
551,307,776 / 1,666 04:47:06 INFO - TinderboxPrint: CPU idle
2,216.8 (46.1%) 04:47:06 INFO - TinderboxPrint: CPU system
962.0 (20.0%) 04:47:06 INFO - TinderboxPrint: CPU user
1,630.9 (33.9%) 04:47:06 INFO - TinderboxPrint: Swap in / out
278,974,464 / 0 04:47:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243028480; Write bytes: 238188032; Read time: 17718; Write time: 543 04:47:06 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30469120; Write bytes: 295588864; Read time: 178; Write time: 1076 04:47:07 INFO - Running post-run listener: _upload_blobber_files 04:47:07 INFO - Blob upload gear active. 04:47:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:07 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 04:47:07 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'] 04:47:07 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 04:47:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:08 INFO - (blobuploader) - INFO - Done attempting. 04:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:09 INFO - (blobuploader) - INFO - Done attempting. 04:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:10 INFO - (blobuploader) - INFO - Done attempting. 04:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:12 INFO - (blobuploader) - INFO - Done attempting. 04:47:12 INFO - (blobuploader) - INFO - Iteration through files over. 04:47:12 INFO - Return code: 0 04:47:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:47:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:47:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e9135f77bb67eacb9719e320f2eff5c1fe534b6a48180947c84d0dcb031b922bad88101bc8a5d3203389a7f2dc5e28f8162141f6155b6af3b1abbc8c4d29ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/122c9a6804a8660b7fb3fd742d1afed8f067a0085ea4315a1ebdd31e0023b4a5e495313dd65afa1dfd18f540503bcc8348a80bcd7c7e43ab71977e7db8a0b293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17bf277a65c9aae794a1eec66ed9178f3b62e7e8a7facf92d53a1174e5c34fa8e2f45875fe72f23b738c2aac2cd558ddd1d6c62ec78738a3f3a496d9a05bd9c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01fa6e4f18fd69f786dd1a6ba7ac01ae332b5255e70286cbf0f1287094d33db4e95e08796b22ddf5894577a6198d888631c11442f9697603622dd85e714ba7f"} 04:47:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:47:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:47:12 INFO - Contents: 04:47:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e9135f77bb67eacb9719e320f2eff5c1fe534b6a48180947c84d0dcb031b922bad88101bc8a5d3203389a7f2dc5e28f8162141f6155b6af3b1abbc8c4d29ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/122c9a6804a8660b7fb3fd742d1afed8f067a0085ea4315a1ebdd31e0023b4a5e495313dd65afa1dfd18f540503bcc8348a80bcd7c7e43ab71977e7db8a0b293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17bf277a65c9aae794a1eec66ed9178f3b62e7e8a7facf92d53a1174e5c34fa8e2f45875fe72f23b738c2aac2cd558ddd1d6c62ec78738a3f3a496d9a05bd9c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01fa6e4f18fd69f786dd1a6ba7ac01ae332b5255e70286cbf0f1287094d33db4e95e08796b22ddf5894577a6198d888631c11442f9697603622dd85e714ba7f"} 04:47:12 INFO - Running post-run listener: copy_logs_to_upload_dir 04:47:12 INFO - Copying logs to upload dir... 04:47:12 INFO - mkdir: /builds/slave/test/build/upload/logs 04:47:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.053763 ========= master_lag: 1.28 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-01-22 04:47:14.091144) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 04:47:14.096944) ========= 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.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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/82e9135f77bb67eacb9719e320f2eff5c1fe534b6a48180947c84d0dcb031b922bad88101bc8a5d3203389a7f2dc5e28f8162141f6155b6af3b1abbc8c4d29ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/122c9a6804a8660b7fb3fd742d1afed8f067a0085ea4315a1ebdd31e0023b4a5e495313dd65afa1dfd18f540503bcc8348a80bcd7c7e43ab71977e7db8a0b293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17bf277a65c9aae794a1eec66ed9178f3b62e7e8a7facf92d53a1174e5c34fa8e2f45875fe72f23b738c2aac2cd558ddd1d6c62ec78738a3f3a496d9a05bd9c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01fa6e4f18fd69f786dd1a6ba7ac01ae332b5255e70286cbf0f1287094d33db4e95e08796b22ddf5894577a6198d888631c11442f9697603622dd85e714ba7f"} build_url:https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011714 build_url: 'https://queue.taskcluster.net/v1/task/SZt9ITxWRCS4ZRkdhxXkzw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e9135f77bb67eacb9719e320f2eff5c1fe534b6a48180947c84d0dcb031b922bad88101bc8a5d3203389a7f2dc5e28f8162141f6155b6af3b1abbc8c4d29ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/122c9a6804a8660b7fb3fd742d1afed8f067a0085ea4315a1ebdd31e0023b4a5e495313dd65afa1dfd18f540503bcc8348a80bcd7c7e43ab71977e7db8a0b293", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17bf277a65c9aae794a1eec66ed9178f3b62e7e8a7facf92d53a1174e5c34fa8e2f45875fe72f23b738c2aac2cd558ddd1d6c62ec78738a3f3a496d9a05bd9c5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b01fa6e4f18fd69f786dd1a6ba7ac01ae332b5255e70286cbf0f1287094d33db4e95e08796b22ddf5894577a6198d888631c11442f9697603622dd85e714ba7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-22 04:47:14.131629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:47:14.131954) ========= 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.0x8SaTREm6/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.xAF85LUSqD/Listeners TMPDIR=/var/folders/0l/ckrq9r0505n_pgxf9zzz6jkh00000w/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.005000 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-22 04:47:14.180793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 04:47:14.181129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-22 04:47:14.181511) ========= ========= Total master_lag: 1.43 =========