builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1489149232.19 results: success (0) buildid: 20170310033122 builduid: b3a51395b8734c29b7b42abe107b0ce7 revision: 359c6746a4c6f40347a7c6a3813977c1744ab603 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.186596) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.187041) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.187345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.212491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.212884) ========= 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.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-03-10 04:33:52-- 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% 13.5M=0.001s 2017-03-10 04:33:52 (13.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.371220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.371671) ========= 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.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.023286 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:52.419746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 04:33:52.420090) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 359c6746a4c6f40347a7c6a3813977c1744ab603 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 359c6746a4c6f40347a7c6a3813977c1744ab603 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-03-10 04:33:52,503 truncating revision to first 12 chars 2017-03-10 04:33:52,503 Setting DEBUG logging. 2017-03-10 04:33:52,503 attempt 1/10 2017-03-10 04:33:52,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/359c6746a4c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 04:33:54,266 unpacking tar archive at: mozilla-aurora-359c6746a4c6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.023474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 04:33:54.467123) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:54.467461) ========= script_repo_revision: 359c6746a4c6f40347a7c6a3813977c1744ab603 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:54.467841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:54.468113) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 04:33:54.487919) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-10 04:33:54.488301) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:33:54 INFO - MultiFileLogger online at 20170310 04:33:54 in /builds/slave/test 04:33:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:33:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:54 INFO - {'append_to_log': False, 04:33:54 INFO - 'base_work_dir': '/builds/slave/test', 04:33:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:33:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:54 INFO - 'branch': 'Mozilla-Aurora', 04:33:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:54 INFO - 'config_files': ('talos/mac_config.py',), 04:33:54 INFO - 'default_actions': ('clobber', 04:33:54 INFO - 'read-buildbot-config', 04:33:54 INFO - 'download-and-extract', 04:33:54 INFO - 'populate-webroot', 04:33:54 INFO - 'create-virtualenv', 04:33:54 INFO - 'install', 04:33:54 INFO - 'run-tests'), 04:33:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:54 INFO - 'download_minidump_stackwalk': True, 04:33:54 INFO - 'download_symbols': 'ondemand', 04:33:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:54 INFO - 'gecko_profile': False, 04:33:54 INFO - 'gecko_profile_interval': 0, 04:33:54 INFO - 'installer_path': 'installer.exe', 04:33:54 INFO - 'log_level': 'info', 04:33:54 INFO - 'log_name': 'talos', 04:33:54 INFO - 'log_to_console': True, 04:33:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:33:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:33:54 INFO - 'opt_config_files': (), 04:33:54 INFO - 'pip_index': False, 04:33:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:54 INFO - 'cmd': ('bash', 04:33:54 INFO - '-c', 04:33:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:54 INFO - 'enabled': True, 04:33:54 INFO - 'halt_on_failure': False, 04:33:54 INFO - 'name': 'check_screen_resolution'},), 04:33:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:54 INFO - 'cmd': ('bash', 04:33:54 INFO - '-c', 04:33:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:54 INFO - 'enabled': True, 04:33:54 INFO - 'halt_on_failure': False, 04:33:54 INFO - 'name': 'check_screen_resolution'},), 04:33:54 INFO - 'run_cmd_checks_enabled': True, 04:33:54 INFO - 'suite': 'dromaeojs', 04:33:54 INFO - 'system_bits': '32', 04:33:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:54 INFO - 'title': 't-yosemite-r7-0088', 04:33:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:54 INFO - 'use_talos_json': True, 04:33:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:54 INFO - 'work_dir': 'build'} 04:33:54 INFO - [mozharness: 2017-03-10 12:33:54.697987Z] Running clobber step. 04:33:54 INFO - Running pre-action listener: _resource_record_pre_action 04:33:54 INFO - Running main action method: clobber 04:33:54 INFO - rmtree: /builds/slave/test/build 04:33:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:56 INFO - Running post-action listener: _resource_record_post_action 04:33:56 INFO - [mozharness: 2017-03-10 12:33:56.409209Z] Finished clobber step (success) 04:33:56 INFO - [mozharness: 2017-03-10 12:33:56.409404Z] Running read-buildbot-config step. 04:33:56 INFO - Running pre-action listener: _resource_record_pre_action 04:33:56 INFO - Running main action method: read_buildbot_config 04:33:56 INFO - Using buildbot properties: 04:33:56 INFO - { 04:33:56 INFO - "project": "", 04:33:56 INFO - "product": "firefox", 04:33:56 INFO - "script_repo_revision": "production", 04:33:56 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:33:56 INFO - "repository": "", 04:33:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:33:56 INFO - "buildid": "20170310033122", 04:33:56 INFO - "pgo_build": "False", 04:33:56 INFO - "basedir": "/builds/slave/test", 04:33:56 INFO - "buildnumber": 11, 04:33:56 INFO - "slavename": "t-yosemite-r7-0088", 04:33:56 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:33:56 INFO - "platform": "yosemite_r7", 04:33:56 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:33:56 INFO - "branch": "mozilla-aurora", 04:33:56 INFO - "repo_path": "releases/mozilla-aurora", 04:33:56 INFO - "revision": "359c6746a4c6f40347a7c6a3813977c1744ab603", 04:33:56 INFO - "stage_platform": "macosx64", 04:33:56 INFO - "builduid": "b3a51395b8734c29b7b42abe107b0ce7", 04:33:56 INFO - "slavebuilddir": "test" 04:33:56 INFO - } 04:33:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 04:33:56 INFO - Running post-action listener: _resource_record_post_action 04:33:56 INFO - [mozharness: 2017-03-10 12:33:56.412795Z] Finished read-buildbot-config step (success) 04:33:56 INFO - [mozharness: 2017-03-10 12:33:56.412920Z] Running download-and-extract step. 04:33:56 INFO - Running pre-action listener: _resource_record_pre_action 04:33:56 INFO - Running main action method: download_and_extract 04:33:56 INFO - mkdir: /builds/slave/test/build/tests 04:33:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:56 INFO - trying https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 04:33:56 INFO - Downloading https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:33:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 04:33:57 INFO - Downloaded 1199 bytes. 04:33:57 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 04:33:57 INFO - Using the following test package requirements: 04:33:57 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:33:57 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 04:33:57 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 04:33:57 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'jsshell-mac.zip'], 04:33:57 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 04:33:57 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 04:33:57 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 04:33:57 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 04:33:57 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 04:33:57 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 04:33:57 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 04:33:57 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:33:59 INFO - Expected file size: 51778959 04:33:59 INFO - Obtained file size: 51778959 04:34:15 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:34:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 04:34:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:34:15 INFO - Fetch https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 04:34:17 INFO - Expected file size: 51778959 04:34:17 INFO - Obtained file size: 51778959 04:34:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 04:34:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:34:32 INFO - Fetch https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 04:34:33 INFO - Expected file size: 14404424 04:34:33 INFO - Obtained file size: 14404424 04:34:33 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:34:33 INFO - trying https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:34:33 INFO - Downloading https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 04:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 04:34:35 INFO - Downloaded 74620269 bytes. 04:34:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:34:35 INFO - mkdir: /builds/slave/test/properties 04:34:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:35 INFO - Contents: 04:34:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 04:34:36 INFO - Running post-action listener: _resource_record_post_action 04:34:36 INFO - Running post-action listener: set_extra_try_arguments 04:34:36 INFO - [mozharness: 2017-03-10 12:34:36.334967Z] Finished download-and-extract step (success) 04:34:36 INFO - [mozharness: 2017-03-10 12:34:36.335088Z] Running populate-webroot step. 04:34:36 INFO - Running pre-action listener: _resource_record_pre_action 04:34:36 INFO - Running main action method: populate_webroot 04:34:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:36 INFO - '--tppagecycles', 04:34:36 INFO - '7'], 04:34:36 INFO - 'tests': ['tsvgm']}}, 04:34:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['damp', 'tps']}, 04:34:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'tests': ['damp', 'tps']}, 04:34:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['dromaeo_dom']}, 04:34:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['basic_compositor_video']}, 04:34:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['a11yr', 04:34:36 INFO - 'ts_paint', 04:34:36 INFO - 'tpaint', 04:34:36 INFO - 'sessionrestore', 04:34:36 INFO - 'sessionrestore_no_auto_restore', 04:34:36 INFO - 'tabpaint']}, 04:34:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['tsvgx', 04:34:36 INFO - 'tsvgr_opacity', 04:34:36 INFO - 'tart', 04:34:36 INFO - 'tscrollx', 04:34:36 INFO - 'cart', 04:34:36 INFO - 'tsvg_static']}, 04:34:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:36 INFO - 'tsvgr_opacity', 04:34:36 INFO - 'tart', 04:34:36 INFO - 'tscrollx', 04:34:36 INFO - 'cart', 04:34:36 INFO - 'tsvg_static']}, 04:34:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'talos_options': ['--disable-e10s'], 04:34:36 INFO - 'tests': ['tp5o']}, 04:34:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:34:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'talos_options': ['--disable-e10s', 04:34:36 INFO - '--xperf_path', 04:34:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:36 INFO - 'tests': ['tp5n']}, 04:34:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:34:36 INFO - 'talos_options': ['--xperf_path', 04:34:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:36 INFO - 'tests': ['tp5n']}}, 04:34:36 INFO - 'talos.zip': {'path': '', 04:34:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:36 INFO - Running post-action listener: _resource_record_post_action 04:34:36 INFO - [mozharness: 2017-03-10 12:34:36.353478Z] Finished populate-webroot step (success) 04:34:36 INFO - [mozharness: 2017-03-10 12:34:36.353573Z] Running create-virtualenv step. 04:34:36 INFO - Running pre-action listener: _resource_record_pre_action 04:34:36 INFO - Running main action method: create_virtualenv 04:34:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:36 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:34:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:36 INFO - Using real prefix '/tools/python27' 04:34:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:40 INFO - Installing pip.................done. 04:34:40 INFO - Return code: 0 04:34:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:40 INFO - Reading from file tmpfile_stdout 04:34:40 INFO - Output received: 04:34:40 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:34:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:40 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:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 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:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:40 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:34:40 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:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:40 INFO - 'HOME': '/Users/cltbld', 04:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:40 INFO - 'LOGNAME': 'cltbld', 04:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:40 INFO - 'MOZ_NO_REMOTE': '1', 04:34:40 INFO - 'NO_EM_RESTART': '1', 04:34:40 INFO - 'PAGER': '/bin/cat', 04:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:40 INFO - 'PWD': '/builds/slave/test', 04:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:40 INFO - 'SHELL': '/bin/bash', 04:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:40 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:40 INFO - 'USER': 'cltbld', 04:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:40 INFO - 'XPC_FLAGS': '0x0', 04:34:40 INFO - 'XPC_SERVICE_NAME': '0', 04:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:40 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:34:40 INFO - Cleaning up... 04:34:40 INFO - Return code: 0 04:34:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:40 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:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 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:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:40 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:40 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:34:40 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:34:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:40 INFO - 'HOME': '/Users/cltbld', 04:34:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:40 INFO - 'LOGNAME': 'cltbld', 04:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:40 INFO - 'MOZ_NO_REMOTE': '1', 04:34:40 INFO - 'NO_EM_RESTART': '1', 04:34:40 INFO - 'PAGER': '/bin/cat', 04:34:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:40 INFO - 'PWD': '/builds/slave/test', 04:34:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:40 INFO - 'SHELL': '/bin/bash', 04:34:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:40 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:40 INFO - 'USER': 'cltbld', 04:34:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:40 INFO - 'XPC_FLAGS': '0x0', 04:34:40 INFO - 'XPC_SERVICE_NAME': '0', 04:34:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:40 INFO - Downloading/unpacking psutil>=3.1.1 04:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:44 INFO - Installing collected packages: psutil 04:34:44 INFO - Running setup.py install for psutil 04:34:44 INFO - building 'psutil._psutil_osx' extension 04:34:44 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:34:44 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:34:44 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:34:44 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:34:44 INFO - building 'psutil._psutil_posix' extension 04:34:44 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:34:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:34:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:34:44 INFO - ^ 04:34:44 INFO - 1 warning generated. 04:34:44 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:34:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:45 INFO - Successfully installed psutil 04:34:45 INFO - Cleaning up... 04:34:45 INFO - Return code: 0 04:34:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34: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:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:34: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 mozsystemmonitor==0.3 04:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:45 INFO - 'HOME': '/Users/cltbld', 04:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:45 INFO - 'LOGNAME': 'cltbld', 04:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:45 INFO - 'MOZ_NO_REMOTE': '1', 04:34:45 INFO - 'NO_EM_RESTART': '1', 04:34:45 INFO - 'PAGER': '/bin/cat', 04:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:45 INFO - 'PWD': '/builds/slave/test', 04:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:45 INFO - 'SHELL': '/bin/bash', 04:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:45 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:45 INFO - 'USER': 'cltbld', 04:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:45 INFO - 'XPC_FLAGS': '0x0', 04:34:45 INFO - 'XPC_SERVICE_NAME': '0', 04:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34: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:34: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:34: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:34: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:34: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:34: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:34:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:48 INFO - Installing collected packages: mozsystemmonitor 04:34:48 INFO - Running setup.py install for mozsystemmonitor 04:34:48 INFO - Successfully installed mozsystemmonitor 04:34:48 INFO - Cleaning up... 04:34:48 INFO - Return code: 0 04:34:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:48 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:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 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:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:49 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:49 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:34:49 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:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:49 INFO - 'HOME': '/Users/cltbld', 04:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:49 INFO - 'LOGNAME': 'cltbld', 04:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:49 INFO - 'MOZ_NO_REMOTE': '1', 04:34:49 INFO - 'NO_EM_RESTART': '1', 04:34:49 INFO - 'PAGER': '/bin/cat', 04:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:49 INFO - 'PWD': '/builds/slave/test', 04:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:49 INFO - 'SHELL': '/bin/bash', 04:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:49 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:49 INFO - 'USER': 'cltbld', 04:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:49 INFO - 'XPC_FLAGS': '0x0', 04:34:49 INFO - 'XPC_SERVICE_NAME': '0', 04:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:34: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:34: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:34: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:34: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:34: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:34: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:34:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:52 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:34:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:53 INFO - warning: no files found matching '*.txt' 04:34:53 INFO - no previously-included directories found matching 'build' 04:34:53 INFO - no previously-included directories found matching 'dist' 04:34:53 INFO - no previously-included directories found matching '.git*' 04:34:53 INFO - Installing collected packages: jsonschema, functools32 04:34:53 INFO - Running setup.py install for functools32 04:34:53 INFO - warning: no files found matching '*.txt' 04:34:53 INFO - no previously-included directories found matching 'build' 04:34:53 INFO - no previously-included directories found matching 'dist' 04:34:53 INFO - no previously-included directories found matching '.git*' 04:34:53 INFO - Successfully installed jsonschema functools32 04:34:53 INFO - Cleaning up... 04:34:53 INFO - Return code: 0 04:34:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:53 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:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 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:34:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:53 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:53 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:34:53 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:34:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:53 INFO - 'HOME': '/Users/cltbld', 04:34:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:53 INFO - 'LOGNAME': 'cltbld', 04:34:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:53 INFO - 'MOZ_NO_REMOTE': '1', 04:34:53 INFO - 'NO_EM_RESTART': '1', 04:34:53 INFO - 'PAGER': '/bin/cat', 04:34:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:53 INFO - 'PWD': '/builds/slave/test', 04:34:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:53 INFO - 'SHELL': '/bin/bash', 04:34:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:53 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:53 INFO - 'USER': 'cltbld', 04:34:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:53 INFO - 'XPC_FLAGS': '0x0', 04:34:53 INFO - 'XPC_SERVICE_NAME': '0', 04:34:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:54 INFO - Cleaning up... 04:34:54 INFO - Return code: 0 04:34:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:54 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:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:54 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:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:54 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:54 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:34:54 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:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:54 INFO - 'HOME': '/Users/cltbld', 04:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:54 INFO - 'LOGNAME': 'cltbld', 04:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:54 INFO - 'MOZ_NO_REMOTE': '1', 04:34:54 INFO - 'NO_EM_RESTART': '1', 04:34:54 INFO - 'PAGER': '/bin/cat', 04:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:54 INFO - 'PWD': '/builds/slave/test', 04:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:54 INFO - 'SHELL': '/bin/bash', 04:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:54 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:54 INFO - 'USER': 'cltbld', 04:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:54 INFO - 'XPC_FLAGS': '0x0', 04:34:54 INFO - 'XPC_SERVICE_NAME': '0', 04:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:54 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:34:54 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:34:54 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:34:54 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:34:54 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:34:54 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:34:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:58 INFO - Downloading docopt-0.6.1.tar.gz 04:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:58 INFO - Running setup.py install for blobuploader 04:34:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:58 INFO - Running setup.py install for requests 04:34:58 INFO - Running setup.py install for docopt 04:34:59 INFO - Successfully installed blobuploader requests docopt 04:34:59 INFO - Cleaning up... 04:34:59 INFO - Return code: 0 04:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:59 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:34:59 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:34:59 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:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:59 INFO - 'HOME': '/Users/cltbld', 04:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:59 INFO - 'LOGNAME': 'cltbld', 04:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:59 INFO - 'MOZ_NO_REMOTE': '1', 04:34:59 INFO - 'NO_EM_RESTART': '1', 04:34:59 INFO - 'PAGER': '/bin/cat', 04:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:59 INFO - 'PWD': '/builds/slave/test', 04:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:59 INFO - 'SHELL': '/bin/bash', 04:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:34:59 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:59 INFO - 'USER': 'cltbld', 04:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:59 INFO - 'XPC_FLAGS': '0x0', 04:34:59 INFO - 'XPC_SERVICE_NAME': '0', 04:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cfm7lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RiOeVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-aCexQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-mu2eZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KHEvSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:59 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-tADmyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-sNyZv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KTc3il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-j8W5zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-6m_mjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-trCVaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JIdhSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KnSz5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-eVEcwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:00 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zknTnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JQ22By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:01 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-2jIY80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:01 INFO - Running setup.py install for manifestparser 04:35:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:01 INFO - Running setup.py install for mozcrash 04:35:01 INFO - Running setup.py install for mozdebug 04:35:01 INFO - Running setup.py install for mozdevice 04:35:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:01 INFO - Running setup.py install for mozfile 04:35:02 INFO - Running setup.py install for mozhttpd 04:35:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Running setup.py install for mozinfo 04:35:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Running setup.py install for mozInstall 04:35:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Running setup.py install for mozleak 04:35:02 INFO - Running setup.py install for mozlog 04:35:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Running setup.py install for moznetwork 04:35:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:02 INFO - Running setup.py install for mozprocess 04:35:03 INFO - Running setup.py install for mozprofile 04:35:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:03 INFO - Running setup.py install for mozrunner 04:35:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:03 INFO - Running setup.py install for mozscreenshot 04:35:03 INFO - Running setup.py install for moztest 04:35:03 INFO - Running setup.py install for mozversion 04:35:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:03 INFO - Cleaning up... 04:35:03 INFO - Return code: 0 04:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35: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:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:03 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:35:03 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:35:03 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:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:03 INFO - 'HOME': '/Users/cltbld', 04:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:03 INFO - 'LOGNAME': 'cltbld', 04:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:03 INFO - 'MOZ_NO_REMOTE': '1', 04:35:03 INFO - 'NO_EM_RESTART': '1', 04:35:03 INFO - 'PAGER': '/bin/cat', 04:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:03 INFO - 'PWD': '/builds/slave/test', 04:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:03 INFO - 'SHELL': '/bin/bash', 04:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:35:03 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:03 INFO - 'USER': 'cltbld', 04:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:03 INFO - 'XPC_FLAGS': '0x0', 04:35:03 INFO - 'XPC_SERVICE_NAME': '0', 04:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DEbGYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-aLMMkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-8J7Q8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ZzbqZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-PKBDSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ZMcq0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JBm4lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:04 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:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:04 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-d2tWbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ImdXtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Xkp_i1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-a8SsZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-J9lXMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-M7WsJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-jYjvcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-DBVTXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Lf3I8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:05 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:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:05 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pHynza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:06 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:35:08 INFO - Downloading blessings-1.6.tar.gz 04:35:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:08 INFO - Installing collected packages: blessings 04:35:08 INFO - Running setup.py install for blessings 04:35:08 INFO - Successfully installed blessings 04:35:08 INFO - Cleaning up... 04:35:09 INFO - Return code: 0 04:35:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:09 INFO - Reading from file tmpfile_stdout 04:35:09 INFO - Current package versions: 04:35:09 INFO - blessings == 1.6 04:35:09 INFO - blobuploader == 1.2.4 04:35:09 INFO - docopt == 0.6.1 04:35:09 INFO - functools32 == 3.2.3-2 04:35:09 INFO - jsonschema == 2.5.1 04:35:09 INFO - manifestparser == 1.1 04:35:09 INFO - mozInstall == 1.12 04:35:09 INFO - mozcrash == 1.0 04:35:09 INFO - mozdebug == 0.1 04:35:09 INFO - mozdevice == 0.49 04:35:09 INFO - mozfile == 1.2 04:35:09 INFO - mozhttpd == 0.7 04:35:09 INFO - mozinfo == 0.9 04:35:09 INFO - mozleak == 0.1 04:35:09 INFO - mozlog == 3.4 04:35:09 INFO - moznetwork == 0.27 04:35:09 INFO - mozprocess == 0.25 04:35:09 INFO - mozprofile == 0.28 04:35:09 INFO - mozrunner == 6.13 04:35:09 INFO - mozscreenshot == 0.1 04:35:09 INFO - mozsystemmonitor == 0.3 04:35:09 INFO - moztest == 0.8 04:35:09 INFO - mozversion == 1.4 04:35:09 INFO - psutil == 3.1.1 04:35:09 INFO - requests == 1.2.3 04:35:09 INFO - wsgiref == 0.1.2 04:35:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:09 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:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:09 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:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:09 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:35:09 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:35:09 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:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:09 INFO - 'HOME': '/Users/cltbld', 04:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:09 INFO - 'LOGNAME': 'cltbld', 04:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:09 INFO - 'MOZ_NO_REMOTE': '1', 04:35:09 INFO - 'NO_EM_RESTART': '1', 04:35:09 INFO - 'PAGER': '/bin/cat', 04:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:09 INFO - 'PWD': '/builds/slave/test', 04:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:09 INFO - 'SHELL': '/bin/bash', 04:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:35:09 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:09 INFO - 'USER': 'cltbld', 04:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:09 INFO - 'XPC_FLAGS': '0x0', 04:35:09 INFO - 'XPC_SERVICE_NAME': '0', 04:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 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:35:09 INFO - Cleaning up... 04:35:09 INFO - Return code: 0 04:35:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:09 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:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:09 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:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:09 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 0x10a3b5b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3b8768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85814854e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, '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.olvhl5arpy/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.xgESgeL4kI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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:35:09 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:35:09 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:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:09 INFO - 'HOME': '/Users/cltbld', 04:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:09 INFO - 'LOGNAME': 'cltbld', 04:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:09 INFO - 'MOZ_NO_REMOTE': '1', 04:35:09 INFO - 'NO_EM_RESTART': '1', 04:35:09 INFO - 'PAGER': '/bin/cat', 04:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:09 INFO - 'PWD': '/builds/slave/test', 04:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:09 INFO - 'SHELL': '/bin/bash', 04:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:35:09 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:09 INFO - 'USER': 'cltbld', 04:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:09 INFO - 'XPC_FLAGS': '0x0', 04:35:09 INFO - 'XPC_SERVICE_NAME': '0', 04:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:09 INFO - Cleaning up... 04:35:09 INFO - Return code: 0 04:35:09 INFO - Running post-action listener: _resource_record_post_action 04:35:09 INFO - Running post-action listener: _start_resource_monitoring 04:35:09 INFO - Starting resource monitoring. 04:35:09 INFO - [mozharness: 2017-03-10 12:35:09.884770Z] Finished create-virtualenv step (success) 04:35:09 INFO - [mozharness: 2017-03-10 12:35:09.885828Z] Running install step. 04:35:09 INFO - Running pre-action listener: _resource_record_pre_action 04:35:09 INFO - Running main action method: install 04:35:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:10 INFO - Reading from file tmpfile_stdout 04:35:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:10 INFO - Reading from file tmpfile_stdout 04:35:10 INFO - Output received: 04:35:10 INFO - Usage: mozinstall [options] installer 04:35:10 INFO - Options: 04:35:10 INFO - -h, --help show this help message and exit 04:35:10 INFO - -d DEST, --destination=DEST 04:35:10 INFO - Directory to install application into. [default: 04:35:10 INFO - "/builds/slave/test"] 04:35:10 INFO - --app=APP Application being installed. [default: firefox] 04:35:10 INFO - mkdir: /builds/slave/test/build/application 04:35:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:35:30 INFO - Reading from file tmpfile_stdout 04:35:30 INFO - Output received: 04:35:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:35:30 INFO - Running post-action listener: _resource_record_post_action 04:35:30 INFO - [mozharness: 2017-03-10 12:35:30.629530Z] Finished install step (success) 04:35:30 INFO - [mozharness: 2017-03-10 12:35:30.629676Z] Running run-tests step. 04:35:30 INFO - Running pre-action listener: _resource_record_pre_action 04:35:30 INFO - Running main action method: run_tests 04:35:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:35:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:35:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:35:30 INFO - 2017-03-10 04:35:30.644 screenresolution[2502:38652] starting screenresolution argv=screenresolution get 04:35:30 INFO - 2017-03-10 04:35:30.647 screenresolution[2502:38652] Display 0: 1600x1200x32@60 04:35:30 INFO - 2017-03-10 04:35:30.653 screenresolution[2503:38656] starting screenresolution argv=screenresolution list 04:35:30 INFO - Available Modes on Display 0 04:35:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:35:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:35:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:35:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:35:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:35:30 INFO - Intel Iris: 04:35:30 INFO - Chipset Model: Intel Iris 04:35:30 INFO - Type: GPU 04:35:30 INFO - Bus: Built-In 04:35:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:35:30 INFO - Vendor: Intel (0x8086) 04:35:30 INFO - Device ID: 0x0a2e 04:35:30 INFO - Revision ID: 0x0009 04:35:30 INFO - Displays: 04:35:30 INFO - Display: 04:35:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:35:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:35:30 INFO - Display Serial Number: 1600x1200 60 04:35:30 INFO - Main Display: Yes 04:35:30 INFO - Mirror: Off 04:35:30 INFO - Online: Yes 04:35:30 INFO - Rotation: Supported 04:35:30 INFO - Return code: 0 04:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:35:30 INFO - Python 2.7.3 04:35:30 INFO - Return code: 0 04:35:30 INFO - grabbing minidump binary from tooltool 04:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:30 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 0x10a193d30>, '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 0x10a0badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a188be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:35:30 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:35:30 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:35:30 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:35:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:35:31 INFO - Return code: 0 04:35:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:35:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:35:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:35:31 INFO - ENV: RUST_BACKTRACE is now 1 04:35:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:35:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.olvhl5arpy/Render', 04:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:31 INFO - 'HOME': '/Users/cltbld', 04:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:31 INFO - 'LOGNAME': 'cltbld', 04:35:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:35:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:31 INFO - 'MOZ_NO_REMOTE': '1', 04:35:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:35:31 INFO - 'NO_EM_RESTART': '1', 04:35:31 INFO - 'PAGER': '/bin/cat', 04:35:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:31 INFO - 'PWD': '/builds/slave/test', 04:35:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:31 INFO - 'RUST_BACKTRACE': '1', 04:35:31 INFO - 'SHELL': '/bin/bash', 04:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xgESgeL4kI/Listeners', 04:35:31 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 04:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:31 INFO - 'USER': 'cltbld', 04:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:31 INFO - 'XPC_FLAGS': '0x0', 04:35:31 INFO - 'XPC_SERVICE_NAME': '0', 04:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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:35:31 INFO - mozversion application_buildid: 20170310033122 04:35:31 INFO - mozversion application_changeset: 359c6746a4c6f40347a7c6a3813977c1744ab603 04:35:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:35:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:35:31 INFO - mozversion application_name: Firefox 04:35:31 INFO - mozversion application_remotingname: firefox-dev 04:35:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:35:31 INFO - mozversion application_vendor: Mozilla 04:35:31 INFO - mozversion application_version: 54.0a2 04:35:31 INFO - mozversion platform_buildid: 20170310033122 04:35:31 INFO - mozversion platform_changeset: 359c6746a4c6f40347a7c6a3813977c1744ab603 04:35:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:35:31 INFO - mozversion platform_version: 54.0a2 04:35:31 INFO - using testdate: 1489149331 04:35:31 INFO - actual date: 1489149331 04:35:31 INFO - starting webserver on 'localhost:64098' 04:35:31 INFO - SUITE-START | Running 2 tests 04:35:31 INFO - TEST-START | dromaeo_css 04:35:31 INFO - operating with platform_type : mac_ 04:35:31 INFO - Initialising browser for dromaeo_css test... 04:35:31 INFO - TEST-INFO | started process 2513 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpgQiit9/profile http://localhost:64098/getInfo.html) 04:35:33 INFO - PROCESS | 2513 | __metrics Screen width/height:1600/1200 04:35:33 INFO - PROCESS | 2513 | colorDepth:24 04:35:33 INFO - PROCESS | 2513 | Browser inner width/height: 1024/689 04:35:33 INFO - PROCESS | 2513 | __metrics 04:35:33 INFO - PROCESS | 2513 | 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:35:33 INFO - PROCESS | 2513 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:34 INFO - TEST-INFO | 2513: exit 0 04:35:34 INFO - Browser initialized. 04:35:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:34 INFO - TEST-INFO | started process 2515 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpgQiit9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:46 INFO - PROCESS | 2515 | RSS: Main: 214364160 04:35:46 INFO - PROCESS | 2515 | 04:38:49 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64098/tests/dromaeo/cssquery-ext.html) 04:38:53 INFO - PROCESS | 2515 | RSS: Main: 502267904 04:38:53 INFO - PROCESS | 2515 | 04:40:36 INFO - PROCESS | 2515 | ************************* 04:40:36 INFO - PROCESS | 2515 | A coding exception was thrown and uncaught in a Task. 04:40:36 INFO - PROCESS | 2515 | 04:40:36 ERROR - PROCESS | 2515 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:40:36 INFO - PROCESS | 2515 | Full stack: 04:40:36 INFO - PROCESS | 2515 | ************************* 04:41:56 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-ext.html (next: http://localhost:64098/tests/dromaeo/cssquery-jquery.html) 04:41:57 INFO - PROCESS | 2515 | RSS: Main: 353976320 04:41:57 INFO - PROCESS | 2515 | 04:45:00 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64098/tests/dromaeo/cssquery-mootools.html) 04:45:00 INFO - PROCESS | 2515 | RSS: Main: 347742208 04:45:00 INFO - PROCESS | 2515 | 04:48:03 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64098/tests/dromaeo/cssquery-prototype.html) 04:48:03 INFO - PROCESS | 2515 | RSS: Main: 339116032 04:48:03 INFO - PROCESS | 2515 | 04:51:07 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64098/tests/dromaeo/cssquery-yui.html) 04:51:08 INFO - PROCESS | 2515 | RSS: Main: 327979008 04:51:08 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | Cycle 1(1): loaded http://localhost:64098/tests/dromaeo/cssquery-yui.html (next: http://localhost:64098/tests/dromaeo/cssquery-dojo.html) 04:54:11 INFO - PROCESS | 2515 | RSS: Main: 505069568 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | __start_tp_report 04:54:11 INFO - PROCESS | 2515 | _x_x_mozilla_page_load 04:54:11 INFO - PROCESS | 2515 | _x_x_mozilla_page_load_details 04:54:11 INFO - PROCESS | 2515 | |i|pagename|runs| 04:54:11 INFO - PROCESS | 2515 | |0;dojo.html;2782.207070984769;3245.318483118545;3264.5103234514836;3288.309455014447;3331.866725330987;5714.971305165074;5749.827505174841;5776.711164441772;5799.246098007253;5828.825135245939;5752.28096487939;5797.246357973468;5798.217240672508;5808.2158908547435;5809.302883653967;5251.264822924793;5269.209618557209;5303.522682958553;5311.097113490697;5367.865803354908;5154.458781827911;5170.819021334254;5371.75827087782;5377.274068000809;5385.542228910528;5235.476452354772;5287.576993840503;5289.68261904285;5291.417944026154;5296;5280.471952804727;5283.339582552181;5288.920666189991;5290.497402746733;5291.3385826771655;5129.871753206163;5205.27126202332;5209.635325527214;5235.319408476912;5237.3453318335205;5790;5793.275840519935;5798.927198468255;5815.418458154193;5838.2702162229725;6110.749250451201;6130.979101202072;6147.200863887666;6165.537584681167;6171.166892469504;6222.906656400158;6229.065640153968;6278.49772018242;6346;6367.204099487564;5396.973015134939;5586.636868603528;5893.499052580536;5952.7321270542925;5957;6226.439620434183;6424.646644434508;6428.389303016206;6431.807045788634;6435.646039467781;6123.516836182961;6132.153139173424;6147.231596050494;6153.815385538441;6160.383961603804;6081.817545473643;6230.719617617218;6258.123862659231;6268.4671802896355;6300.338464461257;6348.968255158695;6352.841178970562;6363.33185015576;6369.5222858285815;6388.425041746265;6337.619742815354;6342.714577844008;6363.5863668861375;6364.172657554581;6375.681215939185;4285.507166675872;4928.285398617252;4964.751762411865;4978.029284289529;5108.795648174031;4427.335899615019;4436.977815110904;4474.530174331713;4478.283474644041;4491.258942274488;5644.350899646511;5664.801731939362;5671.319441667027;5672.659640421588;5679.091345384719;6103.511719062464;6260.467860231931;6270.2475702915945;6281.968590157111;6322.4942004639515;5732.742026608813;5737.770489180386;5759.827205183851;5768.134779782982;5795.768169273182;5571.8885622288135;5575.888482230333;5576.219329293902;5580.748866301026;5584.832455026356;6241.18864547615;6270.843228919131;6304.495640348853;6401.263854656681;6440.098386225932;6206.06908963659;6238.781642642486;6240.719167637377;6252.656103914328;6253.749850006131;6353.205849268841;6356;6449.935500644933;6472.223333200046;6473;6306.054091886253;6310.463610592968;6313.463355614824;6316.905246421399;6341;6326.082718005955;6331.715072821642;6332.113504109337;6346.143270658402;6348.619082855043;5166.560842328294;6056.848578785565;6117.051856962178;6139.048447490646;6141.355157708376;6003.729832157476;6108.281362586102;6110.315755985069;6131.437835141539;6141.455323060992;5941.435563621449;5980.102984552352;5985.970070149621;5987.221661184192;5997.070454079625;6125.968084364015;6142.069075791408;6142.836439233709;6146.569740118149;6149.20060392164;6117.614269788275;6133.487685122301;6135.722664536972;6136.825445958321;6141 04:54:11 INFO - PROCESS | 2515 | |1;ext.html;786.0999155966418;805.8025783682998;856.1353033436231;873.0004145253681;873.1443185678039;27216.591751123724;28332.575011374793;28356;28374.57438138427;37970.24059518808;28603;32292.354152916985;40690.79654601723;40767.796161019156;40871;8969.506677132755;9104.45373277602;9125.133112354315;9126.087391260888;9142.588583513758;7131.4651401144865;7328.230535793745;8999.730008099768;9122.179003889649;9134.040925702806;7261.983322334877;7288.416926645882;7344.669489872942;10674.09270212033;10894.346339219672;10778.514966826511;10849.67450976476;10850.511726972305;10856.3486190828;10885.564577416893;10694.893051069468;10718.892811071868;10757.246992710436;10759.139268858473;10775.5689772409;26856.462870742474;27424;28352.432951341063;38309.042273943094;38669.419958700644;3173.5557022016706;3781.1303400218103;3838.769673819552;3859.0352411897024;3863.5774012652405;26282.86858565714;26618.6007209892;27163.864180679167;27685;27899.581506277424;2957.8668959896854;3078.0150351887405;3146;3212.1327241644626;3239.6274428440797;329565;330164.9999999976;330593;330681;331012;50746.492535074176;51261.48738512642;51409.48590514122;51431.48568514267;51634.22548661773;43532.56467435285;44352.89117772081;51979.96040079177;53023.46976530185;53542.46457535453;12450.066245031478;12682.556110536087;14444.927775361057;14511.201883896276;14533.636659083608;12548.937255313665;12663.240205587694;12671.303078330597;12683.936580317224;12700.920421764253;12403.875961240452;12405.44175512104;12434.440450179764;12482.687932801753;12527;4847.975760121177;5555.027870122713;5670.5747068969995;5685.488306052475;5703.058995265817;882.8146089321186;919.7934185655331;950.95720692569;964.0793042644258;973.5424350555228;25692.871535642204;26644.333891652863;27328.453430931666;27735.72264277372;28050.719492804812;910.968116115946;942.4062840410497;1039.6673064619401;1045.362328979322;1069.534752382716;13501.122427042212;13839.446422143203;14302.427902883976;14432.206228657524;14538.781918271234;445369;445420;446583.5341646542;446688;447219;54449.91100177974;54459;54479.72760136253;54495.6376090593;54626.45373546293;1392.8258967629047;1434.8852091832837;1440.5894320118925;1449.8767604753502;1454.0766613200483;23917.009444528598;24221.152259670827;27322.45355092927;27374;27404.588931166447;45705.771471142434;45748.54251457443;45768.08463830638;45823.85440363884;45894;390433;391346;476747.2325276703;485048;579951;33626.49560256549;34452.310953781285;34506.96479105631;34541.82729086339;35427.64572354243;42356.36465453082;42776.5722342785;42818.57181428146;43386.78306608447;43971.56028439802;30664.540031899985;35028.82485587556;35378.46932295966;35788.926332210074;36922.44616330811;29901.850490747405;34335.484967726006;35102.473462897564;35245.29509409849;36333.27333453369;34988.82505587456;35381.506362991044;36017.27965440729;36205;36209.27581448304;30056.69943300539;31780.682193178698;31899;31920.840395797873;31921.680783192798;23603.881980590675;23698.170564030177;23879.4708233022;23993.880030599736;24293.028278869355 04:54:11 INFO - PROCESS | 2515 | |2;jquery.html;385.8553042609022;401.59639562239965;419.55736697783846;427.74976638666374;444.40671703276126;13167.670808229786;20020.69968950465;20689.896550517245;20863.47841303968;21031.47421314468;20258.39224823254;20923.95380230986;21021.894890525564;21066.473338166554;21275.468113297175;6165.938340616603;6249.687515624223;6510.08858759774;6510.414062734353;6521.31526189748;6188.102725104857;6355.713992870309;6368.395002474781;6370.745170193187;6372.044193370985;6086.969565152168;6232.781852635158;6319.115323854664;6374.26695929967;6381.872362552746;6370.394812492806;6436.742530298782;6443.355664433566;6447.96832506799;6454.290028096905;4958.479359667219;5976.641401515923;6209.3790620938;6211.2857021442205;6215.1609532712955;24905.750942490526;25429.872850635813;25486.23541293764;25554.488910221877;25816.74183258181;2789.5257806173;3193.217661672905;3208.9511271253623;3318.5354050432957;3365.2596428785628;14655.120692758468;14761.409543618242;15143.015703979207;15146.394144234217;15148.848511514854;1949.6588097083095;1952.2776572668063;2011.4569066352003;2066.276803118911;2075.8546901716886;121904;139226;149289.25355373154;152933;157564;14820.110793352433;18700;19566.119524621427;19798.70301945472;19995.400137995883;28736.281592959924;29532.261693457407;29588.704112959025;29667.25831854178;29704.702952970627;8270.669173233124;8559.614817333235;8696.434731742416;10023.448710321003;10137.797244055078;7136.750213742494;8248;8333.541655208901;8403.36974726898;8487.151284871463;8579.739698914498;9287;9424.246060315158;9451;9476.431414115175;3224.6614105518584;3728.2729867675544;3800.8859734208017;3816.637419445148;3821.6942344871486;998.0786985053743;1012.3723291559133;1015.3248090020202;1022.4580972084807;1055.5250137438184;20047.797132171825;20453.795462045488;20455.795442045688;20478.18087276522;20818.79181208199;992.9702108936743;998.3061772068343;1021.6219998600566;1028.876534815827;1031.7626945802508;9895.406275623485;10555.102816260704;10582.259241852997;10584.526023691276;10691.465426728633;747736;753306;762491;770997;795361;148062.99999999785;160500;161065.19467402823;164690;165168;1152.2337645465839;1164.138537482257;1174.0932489638164;1193.451012534244;1198.2750435986277;17688.646227075646;17820.732689009936;17917.64164716672;17947.192376342835;18288.268469261613;60269.698651506464;65149;68809.3119068823;69146.308536916;70566.64716676384;83080.16919830724;84228.57885710533;91085;94815.52592236994;95593;11511.366874821964;11532.423378830857;11761.647150585497;11812.114091443003;12014.75970480603;12696.17474864131;12768.872311276768;12779.744405112031;13084;13119.803202951773;9769.706908792748;11372.829407559058;11731.88268117308;11812.527498899948;11921.642350729491;9293.860592090989;11193.384363860067;11207.271527350696;11344.149188810707;11658.125640576822;11647.475863586329;11721.648350549498;11902.523899044287;11914.880851191378;12026.037916966796;11636.476358563716;11659;11843.230190037964;11998.280103193836;12077.698057548632;11259.662210133709;11439.14206434504;11621.88378116208;11625.825612615648;11818.940905295762 04:54:11 INFO - PROCESS | 2515 | |3;mootools.html;1482.5330021043378;1544.582962600098;1551.8137823461186;1567.5375764149576;1571.8113826340837;10410.219233557485;11037;11129.944350278258;11162.944185279082;11179.441027948611;10543;10977.506012229449;11084.889151108486;11089.445527723621;11117.72205694858;2298.712660917385;2336.5210131922913;2339.321596736953;2339.4034521197073;2348.1077190667525;2307.3885420363617;2329.1615018593293;2349.6710460535537;2352.2943117064897;2354.75275096115;2309.180241014441;2332.055517515409;2340.5552944940405;2344.7303560090554;2345.9296221113395;2292.472731271817;2310.318456055459;2316.7219933607907;2318.8144948404088;2324.1168356024773;2261.5816074026357;2350.882455877216;2351.5061837014246;2354.776296251853;2355.4464700795297;10996.340219586851;11085.50115244816;11093.278936869077;11109.611163609316;11118.944405278004;5430.538404235605;5594;5598.608097433182;5610.859728506779;5625.662460252398;3055.4500189965797;3239.174010627275;3397.2802092449356;3492.441209406483;3566.5363502744476;1128.2779021426293;1155.953761849525;1215.738616197513;1216;1245.682351000489;13318.86681133186;13556;13968.441262349595;15064.548063558112;15076;4364.519902810688;4516.322551617283;4524.25349817283;4545.272756358967;4545.545445455494;11512.94243528777;11515.884841151648;11525.250858694159;11551.711207219718;11562.190646654823;4735.550122738403;4882.926756098661;5256.185291279858;5513.58648101386;5523.889522209533;5033;5117.360329958755;5119.462456442095;5126.512981266774;5129.8717532062;3647.2158485925124;3750.962490375116;3757.7369584129397;3807.086299288206;3807.7334586578672;977.1108291454884;978.1392374710351;985.3348989432247;993.7515621094726;993.8558908958161;919.1911118216061;943.8018016216535;950.1543626172712;950.7005293332578;994.2791476179856;6137.693115344215;6415.550911436155;6527.249366322933;6585.73657053722;6652.667366631746;991.682661548312;991.8908920018793;1007.4861820471613;1020.5305559442592;1068.4604274841156;3402;4195.3497207932205;4209.557996410333;4308.9353659695125;4346.8043938022865;13224.074314797872;13514.459421623222;13581.660458488617;13628.114172578751;13638.590842274747;12011.939940300243;12887.16233444823;13168.539101131415;13618.046736728335;13639;9872.703818885446;10174.542145603466;10176.898231017594;10182.439965801655;10193.0316619921;6454.644994525346;6697.2587127348215;6893.586384816927;6897.965510172417;6947.930520694728;12030.879691202976;12065;12398.070144739;12406.62780116598;12414.813777793159;9330.533473326172;12298.631041068782;12351.25892446456;12599.370031498573;12718.236905785683;9101.726948191565;9381.624735010522;9383.108604682817;9389.154976052188;9393.953030234805;9976.850347244652;10030.097291243532;10205.897941020496;10267.281290309607;10294.433806140734;8934.553272336487;8992.055834137584;9071.410358326688;9292.395994260622;9300.767480813034;8562.614682339185;8656.78358041054;8688.304935605263;8857.867131993155;8871.379003469696;7651.88522172179;7809.804754880946;7813.1796161402235;7819.022622172229;7822.100458447124;5706.258186435737;5715.39988301239;5778.56660750437;5907.49786268172;5966.343702192842;5754.856128596651;5862.267216597926;6024.246969128859;6145.324014358328;6161.260648722182 04:54:11 INFO - PROCESS | 2515 | |4;prototype.html;359.6978538028056;367.92641471705656;374.34676489525765;376.5725901102252;382.4626399908128;4602.389163792675;4691.765411729417;5218.504242096999;5241.449647786984;5314.202869569566;4783.545563171502;4821.951780482194;4946.3817022872145;4949.752512374376;4995.775190116445;3399.881004164855;4199.370094485821;4204.88838259688;4227.632525785554;4256.616904478597;3745.8501659933568;4251.5535868733805;4252;4275.786210689453;4291.613754762071;3662.443461528853;3857.6661120022404;3941.4087886817065;4169.937450938239;4267.167902259061;3504.877329293488;3710.369237229664;4169.749075277435;4179.185058913513;4184.623383895464;3826.4642949987024;3857.8071096445065;3863.4011728182177;3885.3783394657003;3922.8626998054933;4832.420109586837;4906.037584966007;4942;4964.925526117111;4974;4611.515790841947;4774.379330687023;4829.5852073963015;4845.030993801219;4850.569082120783;4332.371806088099;4832.299316599108;5015.288686372059;5296.152615581527;5303.496167864047;3754.9861537384754;4143.8964025899295;4166.83332666693;4252.617264446215;4266.1254442839145;3994.400839874013;5242.056429842665;5250.65870718402;5358.089124848746;5465.398806131362;4207.453031105937;4345.5029387824425;4638.605718513897;4768.880777980578;4854.951450485521;4444.866654000385;4917.877053073702;4970.365706175733;4992.80028798844;5013.523715247119;4225.696995137658;4384.868453946387;4754.882602588389;4848.127337079289;5069.315642388304;5328.4671532846405;5378.515933565998;5388.973055134699;5394.649347792381;5448.400675925645;1437.6118448018976;1521.710874933759;1522.721153558504;1673.707101257275;1674.3637417781408;1270.634068376499;1363.7886127650231;1366.631009627395;1368.438940034601;1384.7092110656874;4781.163296423181;4972.751362431936;5027.371578552681;5165.564899341971;5169.6655657100955;5222.556082732935;5339.970811091838;5544.556435485151;5547.44525547442;5643.5203007743985;4257.637555982056;4316.892077698083;4651;4791.233402655628;5010.724410157476;2523.917767841538;2712.7287271272717;2778.722127787205;2869.7130286971137;2873.870675819593;5497.8075767347955;5618.578606604439;5750.686984761429;5772.451617096369;5838.474537291664;4891.760194911551;5307.7080760557765;5642.774289028475;5687.40282270364;5754.395788442237;5041.798328066836;5447.404712889474;5724.021804845593;5737.3688894221605;5850.566611180288;4829.396325459317;5187.455317191791;5351.147174034689;5539.590278228822;5545.750441230235;4488.4165058542185;4810.7113573185725;4911.950880491149;5259.342582177228;5408.1877423740225;4692.460367057832;4790.568848803624;5252.1113387637415;5420.783168673209;5600.719964001865;4768;4801.231802911518;4801.855944321676;4806.327114204084;4849.80600775965;4822.831200907952;5094.3254791234895;5146.588272938231;5537.2524709163745;5644.814588936205;4538.546145385435;4759.190937540558;4786.401699787527;5349.545288650508;5360.088784906653;4674.555917187861;5328.200769884548;5365.973170134124;5378.650387724785;5422.3941079181905;4403.524819185609;4663.556962088596;4847.951520484891;4949.045127174818;5252.139677337078;4592.196365635934;4903.362562866804;4995.526319735614;5095.796168153232;5355.955588660174;4718.009218064245;5166.586673066221;5218.851852592424;5252.632315738015;5285.7621407036 04:54:11 INFO - PROCESS | 2515 | |5;yui.html;716.8673795347864;742.4654248940764;775.4533054196792;819.3363375665712;829.8755186721991;14884.851151488481;15763.133027683487;15769.21153942304;15778.289976951037;15780.368785248576;14318.713625727505;14331.068480548756;14350.78473822891;14439.783403248959;14469;891.4473026723424;908.736466424736;911.539672465404;942.5334459442552;974.6101559376235;941.7598512379334;959.7120863740885;961.9519024048805;962.2350231565887;962.8651988721584;864.8097418567905;1007.471077684218;1012.6860673191334;1013.7769690668079;1014.0012088093222;1003.0370843989706;1005.9044390782864;1006.3710181136789;1007.4207330784755;1007.969760907174;640.7789312687162;749.5390334944025;749.9812504687372;750.9361704255144;753.6457864803533;15527.223638818014;15842.366305347772;15861.889667723264;16071.758923616038;16330;13913.860861391358;14043.929780351134;14203.218822964733;14267.928660356736;14373.06575072617;11650.524134082692;11780.587679431179;11851.881481185164;11887.465064072137;11893.93297831532;3604.475415642014;3650.251698401821;3697.186618943828;3736.3461394255896;3847.2882516734494;110974.44512777466;111007.44496277548;112072.4396378021;114258;114649;9489.715308540755;10756.892431075745;10784.245102842726;10796.784064318826;10916.181286403551;22291.77708222897;22623.434414139778;22994.19520316781;23041.308760737204;23086.191983280503;7659.770206893802;7688.500247484008;7752.030400119239;7782.922170778333;7788.376929845712;4263.445752052214;4282.5075116361395;4399.186150562156;4408;4526.117407105648;3509.1051781795477;3565.090901820019;3581.033121057352;3612.02475331659;3613.638636136365;624.9656268905254;631.1479502671449;637.221277822517;637.3721883944404;644.5745807766945;670.3263220463404;685.4208194075998;688.1638808847274;693.4625665109479;737.1854101218184;8804.647814087493;9703.509429249407;10425.426601536836;10536.209784266211;10725.731856703645;680.3672584496466;690.5131882023162;706.3113464372299;708.6952610377484;721.4805340155079;4136.503619565671;4868.488808675038;4975.975120124376;5033.370828646419;5064.898702025939;105363;105891.4705426468;108477.7456676301;108989;109476;46919;53523.732381338625;74630.62684686651;74895.62552187205;75104;68640;69694;76170;76727;77698.61150694323;10761.838572421577;10813.297135686154;11103.72240693989;11124.777504449703;11267.943660281646;46881.29678054764;47096.7645161772;47537;48685;50114.99770004507;61870.0719489217;61923.071153933626;63500.77747278823;63899.68050159719;64790;12561.183523070971;12652.367381631066;12671.049671274506;12892.41984110736;13449.193048417126;13900.37448314808;14152.150870947777;14604.853951460349;14733.336999835248;14854.183019934007;12344.75310493803;13177.27524986135;13204.537841175512;13291.734165316833;13624.93187534056;12907.354632268536;13592.524261650795;13665.385057672627;13828.308584570932;14173.149611023371;11625.36060516646;12948.028897832888;13337.3331333431;13809.79285310701;14012.579622611338;10919.290246134293;10954.945225273823;11200.607978720705;11239.157063220455;11342.546298147981;9365.47298881839;10169.338992965433;11183.944080279547;11368.261063030877;11388.94305528467 04:54:11 INFO - PROCESS | 2515 | __end_tp_report 04:54:11 INFO - PROCESS | 2515 | __start_cc_report 04:54:11 INFO - PROCESS | 2515 | _x_x_mozilla_cycle_collect,3542 04:54:11 INFO - PROCESS | 2515 | __end_cc_report 04:54:11 INFO - PROCESS | 2515 | __startTimestamp1489150451876__endTimestamp 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | ------- Summary: start ------- 04:54:11 INFO - PROCESS | 2515 | Number of tests: 6 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#0] dojo.html Cycles:165 Average:5790.30 Median:6056.85 stddev:676.14 (11.2%) stddev-sans-first:635.70 04:54:11 INFO - PROCESS | 2515 | Values: 2782.2 3245.3 3264.5 3288.3 3331.9 5715.0 5749.8 5776.7 5799.2 5828.8 5752.3 5797.2 5798.2 5808.2 5809.3 5251.3 5269.2 5303.5 5311.1 5367.9 5154.5 5170.8 5371.8 5377.3 5385.5 5235.5 5287.6 5289.7 5291.4 5296.0 5280.5 5283.3 5288.9 5290.5 5291.3 5129.9 5205.3 5209.6 5235.3 5237.3 5790.0 5793.3 5798.9 5815.4 5838.3 6110.7 6131.0 6147.2 6165.5 6171.2 6222.9 6229.1 6278.5 6346.0 6367.2 5397.0 5586.6 5893.5 5952.7 5957.0 6226.4 6424.6 6428.4 6431.8 6435.6 6123.5 6132.2 6147.2 6153.8 6160.4 6081.8 6230.7 6258.1 6268.5 6300.3 6349.0 6352.8 6363.3 6369.5 6388.4 6337.6 6342.7 6363.6 6364.2 6375.7 4285.5 4928.3 4964.8 4978.0 5108.8 4427.3 4437.0 4474.5 4478.3 4491.3 5644.4 5664.8 5671.3 5672.7 5679.1 6103.5 6260.5 6270.2 6282.0 6322.5 5732.7 5737.8 5759.8 5768.1 5795.8 5571.9 5575.9 5576.2 5580.7 5584.8 6241.2 6270.8 6304.5 6401.3 6440.1 6206.1 6238.8 6240.7 6252.7 6253.7 6353.2 6356.0 6449.9 6472.2 6473.0 6306.1 6310.5 6313.5 6316.9 6341.0 6326.1 6331.7 6332.1 6346.1 6348.6 5166.6 6056.8 6117.1 6139.0 6141.4 6003.7 6108.3 6110.3 6131.4 6141.5 5941.4 5980.1 5986.0 5987.2 5997.1 6126.0 6142.1 6142.8 6146.6 6149.2 6117.6 6133.5 6135.7 6136.8 6141.0 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#1] ext.html Cycles:180 Average:54889.10 Median:34524.40 stddev:111601.77 (323.3%) stddev-sans-first:111840.91 04:54:11 INFO - PROCESS | 2515 | Values: 786.1 805.8 856.1 873.0 873.1 27216.6 28332.6 28356.0 28374.6 37970.2 28603.0 32292.4 40690.8 40767.8 40871.0 8969.5 9104.5 9125.1 9126.1 9142.6 7131.5 7328.2 8999.7 9122.2 9134.0 7262.0 7288.4 7344.7 10674.1 10894.3 10778.5 10849.7 10850.5 10856.3 10885.6 10694.9 10718.9 10757.2 10759.1 10775.6 26856.5 27424.0 28352.4 38309.0 38669.4 3173.6 3781.1 3838.8 3859.0 3863.6 26282.9 26618.6 27163.9 27685.0 27899.6 2957.9 3078.0 3146.0 3212.1 3239.6 329565.0 330165.0 330593.0 330681.0 331012.0 50746.5 51261.5 51409.5 51431.5 51634.2 43532.6 44352.9 51980.0 53023.5 53542.5 12450.1 12682.6 14444.9 14511.2 14533.6 12548.9 12663.2 12671.3 12683.9 12700.9 12403.9 12405.4 12434.4 12482.7 12527.0 4848.0 5555.0 5670.6 5685.5 5703.1 882.8 919.8 951.0 964.1 973.5 25692.9 26644.3 27328.5 27735.7 28050.7 911.0 942.4 1039.7 1045.4 1069.5 13501.1 13839.4 14302.4 14432.2 14538.8 445369.0 445420.0 446583.5 446688.0 447219.0 54449.9 54459.0 54479.7 54495.6 54626.5 1392.8 1434.9 1440.6 1449.9 1454.1 23917.0 24221.2 27322.5 27374.0 27404.6 45705.8 45748.5 45768.1 45823.9 45894.0 390433.0 391346.0 476747.2 485048.0 579951.0 33626.5 34452.3 34507.0 34541.8 35427.6 42356.4 42776.6 42818.6 43386.8 43971.6 30664.5 35028.8 35378.5 35788.9 36922.4 29901.9 34335.5 35102.5 35245.3 36333.3 34988.8 35381.5 36017.3 36205.0 36209.3 30056.7 31780.7 31899.0 31920.8 31921.7 23603.9 23698.2 23879.5 23993.9 24293.0 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#2] jquery.html Cycles:180 Average:43233.48 Median:20893.72 stddev:127722.60 (611.3%) stddev-sans-first:128040.37 04:54:11 INFO - PROCESS | 2515 | Values: 385.9 401.6 419.6 427.7 444.4 13167.7 20020.7 20689.9 20863.5 21031.5 20258.4 20924.0 21021.9 21066.5 21275.5 6165.9 6249.7 6510.1 6510.4 6521.3 6188.1 6355.7 6368.4 6370.7 6372.0 6087.0 6232.8 6319.1 6374.3 6381.9 6370.4 6436.7 6443.4 6448.0 6454.3 4958.5 5976.6 6209.4 6211.3 6215.2 24905.8 25429.9 25486.2 25554.5 25816.7 2789.5 3193.2 3209.0 3318.5 3365.3 14655.1 14761.4 15143.0 15146.4 15148.8 1949.7 1952.3 2011.5 2066.3 2075.9 121904.0 139226.0 149289.3 152933.0 157564.0 14820.1 18700.0 19566.1 19798.7 19995.4 28736.3 29532.3 29588.7 29667.3 29704.7 8270.7 8559.6 8696.4 10023.4 10137.8 7136.8 8248.0 8333.5 8403.4 8487.2 8579.7 9287.0 9424.2 9451.0 9476.4 3224.7 3728.3 3800.9 3816.6 3821.7 998.1 1012.4 1015.3 1022.5 1055.5 20047.8 20453.8 20455.8 20478.2 20818.8 993.0 998.3 1021.6 1028.9 1031.8 9895.4 10555.1 10582.3 10584.5 10691.5 747736.0 753306.0 762491.0 770997.0 795361.0 148063.0 160500.0 161065.2 164690.0 165168.0 1152.2 1164.1 1174.1 1193.5 1198.3 17688.6 17820.7 17917.6 17947.2 18288.3 60269.7 65149.0 68809.3 69146.3 70566.6 83080.2 84228.6 91085.0 94815.5 95593.0 11511.4 11532.4 11761.6 11812.1 12014.8 12696.2 12768.9 12779.7 13084.0 13119.8 9769.7 11372.8 11731.9 11812.5 11921.6 9293.9 11193.4 11207.3 11344.1 11658.1 11647.5 11721.6 11902.5 11914.9 12026.0 11636.5 11659.0 11843.2 11998.3 12077.7 11259.7 11439.1 11621.9 11625.8 11818.9 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#3] mootools.html Cycles:180 Average:6628.90 Median:3147.31 stddev:4141.10 (131.6%) stddev-sans-first:4134.66 04:54:11 INFO - PROCESS | 2515 | Values: 1482.5 1544.6 1551.8 1567.5 1571.8 10410.2 11037.0 11129.9 11162.9 11179.4 10543.0 10977.5 11084.9 11089.4 11117.7 2298.7 2336.5 2339.3 2339.4 2348.1 2307.4 2329.2 2349.7 2352.3 2354.8 2309.2 2332.1 2340.6 2344.7 2345.9 2292.5 2310.3 2316.7 2318.8 2324.1 2261.6 2350.9 2351.5 2354.8 2355.4 10996.3 11085.5 11093.3 11109.6 11118.9 5430.5 5594.0 5598.6 5610.9 5625.7 3055.5 3239.2 3397.3 3492.4 3566.5 1128.3 1156.0 1215.7 1216.0 1245.7 13318.9 13556.0 13968.4 15064.5 15076.0 4364.5 4516.3 4524.3 4545.3 4545.5 11512.9 11515.9 11525.3 11551.7 11562.2 4735.6 4882.9 5256.2 5513.6 5523.9 5033.0 5117.4 5119.5 5126.5 5129.9 3647.2 3751.0 3757.7 3807.1 3807.7 977.1 978.1 985.3 993.8 993.9 919.2 943.8 950.2 950.7 994.3 6137.7 6415.6 6527.2 6585.7 6652.7 991.7 991.9 1007.5 1020.5 1068.5 3402.0 4195.3 4209.6 4308.9 4346.8 13224.1 13514.5 13581.7 13628.1 13638.6 12011.9 12887.2 13168.5 13618.0 13639.0 9872.7 10174.5 10176.9 10182.4 10193.0 6454.6 6697.3 6893.6 6898.0 6947.9 12030.9 12065.0 12398.1 12406.6 12414.8 9330.5 12298.6 12351.3 12599.4 12718.2 9101.7 9381.6 9383.1 9389.2 9394.0 9976.9 10030.1 10205.9 10267.3 10294.4 8934.6 8992.1 9071.4 9292.4 9300.8 8562.6 8656.8 8688.3 8857.9 8871.4 7651.9 7809.8 7813.2 7819.0 7822.1 5706.3 5715.4 5778.6 5907.5 5966.3 5754.9 5862.3 6024.2 6145.3 6161.3 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#4] prototype.html Cycles:180 Average:4491.62 Median:4832.36 stddev:1210.66 (25.1%) stddev-sans-first:1173.67 04:54:11 INFO - PROCESS | 2515 | Values: 359.7 367.9 374.3 376.6 382.5 4602.4 4691.8 5218.5 5241.4 5314.2 4783.5 4822.0 4946.4 4949.8 4995.8 3399.9 4199.4 4204.9 4227.6 4256.6 3745.9 4251.6 4252.0 4275.8 4291.6 3662.4 3857.7 3941.4 4169.9 4267.2 3504.9 3710.4 4169.7 4179.2 4184.6 3826.5 3857.8 3863.4 3885.4 3922.9 4832.4 4906.0 4942.0 4964.9 4974.0 4611.5 4774.4 4829.6 4845.0 4850.6 4332.4 4832.3 5015.3 5296.2 5303.5 3755.0 4143.9 4166.8 4252.6 4266.1 3994.4 5242.1 5250.7 5358.1 5465.4 4207.5 4345.5 4638.6 4768.9 4855.0 4444.9 4917.9 4970.4 4992.8 5013.5 4225.7 4384.9 4754.9 4848.1 5069.3 5328.5 5378.5 5389.0 5394.6 5448.4 1437.6 1521.7 1522.7 1673.7 1674.4 1270.6 1363.8 1366.6 1368.4 1384.7 4781.2 4972.8 5027.4 5165.6 5169.7 5222.6 5340.0 5544.6 5547.4 5643.5 4257.6 4316.9 4651.0 4791.2 5010.7 2523.9 2712.7 2778.7 2869.7 2873.9 5497.8 5618.6 5750.7 5772.5 5838.5 4891.8 5307.7 5642.8 5687.4 5754.4 5041.8 5447.4 5724.0 5737.4 5850.6 4829.4 5187.5 5351.1 5539.6 5545.8 4488.4 4810.7 4912.0 5259.3 5408.2 4692.5 4790.6 5252.1 5420.8 5600.7 4768.0 4801.2 4801.9 4806.3 4849.8 4822.8 5094.3 5146.6 5537.3 5644.8 4538.5 4759.2 4786.4 5349.5 5360.1 4674.6 5328.2 5366.0 5378.7 5422.4 4403.5 4663.6 4848.0 4949.0 5252.1 4592.2 4903.4 4995.5 5095.8 5356.0 4718.0 5166.6 5218.9 5252.6 5285.8 04:54:11 INFO - PROCESS | 2515 | 04:54:11 INFO - PROCESS | 2515 | [#5] yui.html Cycles:180 Average:19922.96 Median:22457.61 stddev:28608.66 (127.4%) stddev-sans-first:28652.57 04:54:11 INFO - PROCESS | 2515 | Values: 716.9 742.5 775.5 819.3 829.9 14884.9 15763.1 15769.2 15778.3 15780.4 14318.7 14331.1 14350.8 14439.8 14469.0 891.4 908.7 911.5 942.5 974.6 941.8 959.7 962.0 962.2 962.9 864.8 1007.5 1012.7 1013.8 1014.0 1003.0 1005.9 1006.4 1007.4 1008.0 640.8 749.5 750.0 750.9 753.6 15527.2 15842.4 15861.9 16071.8 16330.0 13913.9 14043.9 14203.2 14267.9 14373.1 11650.5 11780.6 11851.9 11887.5 11893.9 3604.5 3650.3 3697.2 3736.3 3847.3 110974.4 111007.4 112072.4 114258.0 114649.0 9489.7 10756.9 10784.2 10796.8 10916.2 22291.8 22623.4 22994.2 23041.3 23086.2 7659.8 7688.5 7752.0 7782.9 7788.4 4263.4 4282.5 4399.2 4408.0 4526.1 3509.1 3565.1 3581.0 3612.0 3613.6 625.0 631.1 637.2 637.4 644.6 670.3 685.4 688.2 693.5 737.2 8804.6 9703.5 10425.4 10536.2 10725.7 680.4 690.5 706.3 708.7 721.5 4136.5 4868.5 4976.0 5033.4 5064.9 105363.0 105891.5 108477.7 108989.0 109476.0 46919.0 53523.7 74630.6 74895.6 75104.0 68640.0 69694.0 76170.0 76727.0 77698.6 10761.8 10813.3 11103.7 11124.8 11267.9 46881.3 47096.8 47537.0 48685.0 50115.0 61870.1 61923.1 63500.8 63899.7 64790.0 12561.2 12652.4 12671.0 12892.4 13449.2 13900.4 14152.2 14604.9 14733.3 14854.2 12344.8 13177.3 13204.5 13291.7 13624.9 12907.4 13592.5 13665.4 13828.3 14173.1 11625.4 12948.0 13337.3 13809.8 14012.6 10919.3 10954.9 11200.6 11239.2 11342.5 9365.5 10169.3 11183.9 11368.3 11388.9 04:54:11 INFO - PROCESS | 2515 | -------- Summary: end -------- 04:54:11 INFO - PROCESS | 2515 | 04:54:12 INFO - TEST-INFO | 2515: exit 0 04:54:12 INFO - TEST-OK | dromaeo_css | took 1121343ms 04:54:12 INFO - TEST-START | kraken 04:54:12 INFO - operating with platform_type : mac_ 04:54:12 INFO - Initialising browser for kraken test... 04:54:12 INFO - TEST-INFO | started process 2518 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpl_wZwT/profile http://localhost:64098/getInfo.html) 04:54:14 INFO - PROCESS | 2518 | __metrics Screen width/height:1600/1200 04:54:14 INFO - PROCESS | 2518 | colorDepth:24 04:54:14 INFO - PROCESS | 2518 | Browser inner width/height: 1024/689 04:54:14 INFO - PROCESS | 2518 | __metrics 04:54:14 INFO - PROCESS | 2518 | 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:54:14 INFO - PROCESS | 2518 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:15 INFO - TEST-INFO | 2518: exit 0 04:54:15 INFO - Browser initialized. 04:54:15 INFO - Running cycle 1/1 for kraken test... 04:54:15 INFO - TEST-INFO | started process 2519 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpl_wZwT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:54:27 INFO - PROCESS | 2519 | RSS: Main: 214290432 04:54:27 INFO - PROCESS | 2519 | 04:54:30 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64098/tests/kraken/driver.html?testName=audio-beat-detection) 04:54:31 INFO - PROCESS | 2519 | RSS: Main: 267206656 04:54:31 INFO - PROCESS | 2519 | 04:54:34 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64098/tests/kraken/driver.html?testName=audio-dft) 04:54:35 INFO - PROCESS | 2519 | RSS: Main: 277757952 04:54:35 INFO - PROCESS | 2519 | 04:54:38 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64098/tests/kraken/driver.html?testName=audio-fft) 04:54:38 INFO - PROCESS | 2519 | RSS: Main: 374870016 04:54:38 INFO - PROCESS | 2519 | 04:54:41 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64098/tests/kraken/driver.html?testName=audio-oscillator) 04:54:41 INFO - PROCESS | 2519 | RSS: Main: 277954560 04:54:41 INFO - PROCESS | 2519 | 04:54:43 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:44 INFO - PROCESS | 2519 | RSS: Main: 278999040 04:54:44 INFO - PROCESS | 2519 | 04:54:47 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64098/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:48 INFO - PROCESS | 2519 | RSS: Main: 319143936 04:54:48 INFO - PROCESS | 2519 | 04:54:51 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64098/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:52 INFO - PROCESS | 2519 | RSS: Main: 322621440 04:54:52 INFO - PROCESS | 2519 | 04:54:54 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64098/tests/kraken/driver.html?testName=json-parse-financial) 04:54:55 INFO - PROCESS | 2519 | RSS: Main: 319008768 04:54:55 INFO - PROCESS | 2519 | 04:54:57 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:57 INFO - PROCESS | 2519 | RSS: Main: 294993920 04:54:57 INFO - PROCESS | 2519 | 04:54:59 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:00 INFO - PROCESS | 2519 | RSS: Main: 299053056 04:55:00 INFO - PROCESS | 2519 | 04:55:02 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:03 INFO - PROCESS | 2519 | RSS: Main: 303927296 04:55:03 INFO - PROCESS | 2519 | 04:55:06 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:07 INFO - PROCESS | 2519 | RSS: Main: 321761280 04:55:07 INFO - PROCESS | 2519 | 04:55:09 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:10 INFO - PROCESS | 2519 | RSS: Main: 315224064 04:55:10 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | Cycle 1(1): loaded http://localhost:64098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64098/tests/kraken/driver.html?testName=ai-astar) 04:55:12 INFO - PROCESS | 2519 | RSS: Main: 359264256 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | __start_tp_report 04:55:12 INFO - PROCESS | 2519 | _x_x_mozilla_page_load 04:55:12 INFO - PROCESS | 2519 | _x_x_mozilla_page_load_details 04:55:12 INFO - PROCESS | 2519 | |i|pagename|runs| 04:55:12 INFO - PROCESS | 2519 | |0;ai-astar;120;118;118;116;119;118;117;118;119;119 04:55:12 INFO - PROCESS | 2519 | |1;audio-beat-detection;132;111;115;173;142;124;108;107;129;113 04:55:12 INFO - PROCESS | 2519 | |2;audio-dft;185;186;186;185;185;187;185;184;187;185 04:55:12 INFO - PROCESS | 2519 | |3;audio-fft;85;75;87;119;65;61;71;52;75;74 04:55:12 INFO - PROCESS | 2519 | |4;audio-oscillator;85;71;89;71;70;69;82;69;69;84 04:55:12 INFO - PROCESS | 2519 | |5;imaging-gaussian-blur;88;87;88;88;88;87;88;87;96;135 04:55:12 INFO - PROCESS | 2519 | |6;imaging-darkroom;95;95;95;97;132;128;95;97;95;94 04:55:12 INFO - PROCESS | 2519 | |7;imaging-desaturate;84;86;82;83;84;84;84;84;87;84 04:55:12 INFO - PROCESS | 2519 | |8;json-parse-financial;62;61;60;62;65;65;65;67;66;66 04:55:12 INFO - PROCESS | 2519 | |9;json-stringify-tinderbox;55;55;63;63;63;62;59;59;59;58 04:55:12 INFO - PROCESS | 2519 | |10;stanford-crypto-aes;88;83;97;84;87;84;83;82;88;91 04:55:12 INFO - PROCESS | 2519 | |11;stanford-crypto-ccm;151;164;140;139;137;158;152;133;180;160 04:55:12 INFO - PROCESS | 2519 | |12;stanford-crypto-pbkdf2;168;166;174;229;187;167;165;165;166;169 04:55:12 INFO - PROCESS | 2519 | |13;stanford-crypto-sha256-iterative;64;69;82;81;69;65;63;64;64;65 04:55:12 INFO - PROCESS | 2519 | __end_tp_report 04:55:12 INFO - PROCESS | 2519 | __start_cc_report 04:55:12 INFO - PROCESS | 2519 | _x_x_mozilla_cycle_collect,2173 04:55:12 INFO - PROCESS | 2519 | __end_cc_report 04:55:12 INFO - PROCESS | 2519 | __startTimestamp1489150512700__endTimestamp 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | ------- Summary: start ------- 04:55:12 INFO - PROCESS | 2519 | Number of tests: 14 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#0] ai-astar Cycles:10 Average:118.20 Median:118.50 stddev:1.14 (1.0%) stddev-sans-first:1.00 04:55:12 INFO - PROCESS | 2519 | Values: 120.0 118.0 118.0 116.0 119.0 118.0 117.0 118.0 119.0 119.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#1] audio-beat-detection Cycles:10 Average:125.40 Median:126.50 stddev:20.30 (16.1%) stddev-sans-first:21.40 04:55:12 INFO - PROCESS | 2519 | Values: 132.0 111.0 115.0 173.0 142.0 124.0 108.0 107.0 129.0 113.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#2] audio-dft Cycles:10 Average:185.50 Median:185.50 stddev:0.97 (0.5%) stddev-sans-first:1.01 04:55:12 INFO - PROCESS | 2519 | Values: 185.0 186.0 186.0 185.0 185.0 187.0 185.0 184.0 187.0 185.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#3] audio-fft Cycles:10 Average:76.40 Median:74.50 stddev:18.26 (24.5%) stddev-sans-first:19.11 04:55:12 INFO - PROCESS | 2519 | Values: 85.0 75.0 87.0 119.0 65.0 61.0 71.0 52.0 75.0 74.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.50 stddev:8.05 (10.5%) stddev-sans-first:7.83 04:55:12 INFO - PROCESS | 2519 | Values: 85.0 71.0 89.0 71.0 70.0 69.0 82.0 69.0 69.0 84.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:88.00 stddev:14.93 (17.0%) stddev-sans-first:15.71 04:55:12 INFO - PROCESS | 2519 | Values: 88.0 87.0 88.0 88.0 88.0 87.0 88.0 87.0 96.0 135.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:95.00 stddev:14.66 (15.4%) stddev-sans-first:15.31 04:55:12 INFO - PROCESS | 2519 | Values: 95.0 95.0 95.0 97.0 132.0 128.0 95.0 97.0 95.0 94.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:1.40 (1.7%) stddev-sans-first:1.48 04:55:12 INFO - PROCESS | 2519 | Values: 84.0 86.0 82.0 83.0 84.0 84.0 84.0 84.0 87.0 84.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:65.00 stddev:2.42 (3.7%) stddev-sans-first:2.47 04:55:12 INFO - PROCESS | 2519 | Values: 62.0 61.0 60.0 62.0 65.0 65.0 65.0 67.0 66.0 66.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.50 stddev:3.10 (5.1%) stddev-sans-first:2.80 04:55:12 INFO - PROCESS | 2519 | Values: 55.0 55.0 63.0 63.0 63.0 62.0 59.0 59.0 59.0 58.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:4.62 (5.3%) stddev-sans-first:4.88 04:55:12 INFO - PROCESS | 2519 | Values: 88.0 83.0 97.0 84.0 87.0 84.0 83.0 82.0 88.0 91.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:155.00 stddev:14.62 (9.4%) stddev-sans-first:15.51 04:55:12 INFO - PROCESS | 2519 | Values: 151.0 164.0 140.0 139.0 137.0 158.0 152.0 133.0 180.0 160.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:168.50 stddev:19.91 (11.8%) stddev-sans-first:20.93 04:55:12 INFO - PROCESS | 2519 | Values: 168.0 166.0 174.0 229.0 187.0 167.0 165.0 165.0 166.0 169.0 04:55:12 INFO - PROCESS | 2519 | 04:55:12 INFO - PROCESS | 2519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:67.00 stddev:7.11 (10.6%) stddev-sans-first:7.34 04:55:12 INFO - PROCESS | 2519 | Values: 64.0 69.0 82.0 81.0 69.0 65.0 63.0 64.0 64.0 65.0 04:55:12 INFO - PROCESS | 2519 | -------- Summary: end -------- 04:55:12 INFO - PROCESS | 2519 | 04:55:13 INFO - TEST-INFO | 2519: exit 0 04:55:13 INFO - TEST-OK | kraken | took 61090ms 04:55:13 INFO - SUITE-END | took 1182s 04:55:13 INFO - Completed test suite (00:19:42) 04:55:13 INFO - javascript benchmark 04:55:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7569.089147873417, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2782.207070984769, 3245.318483118545, 3264.5103234514836, 3288.309455014447, 3331.866725330987, 5714.971305165074, 5749.827505174841, 5776.711164441772, 5799.246098007253, 5828.825135245939, 5752.28096487939, 5797.246357973468, 5798.217240672508, 5808.2158908547435, 5809.302883653967, 5251.264822924793, 5269.209618557209, 5303.522682958553, 5311.097113490697, 5367.865803354908, 5154.458781827911, 5170.819021334254, 5371.75827087782, 5377.274068000809, 5385.542228910528, 5235.476452354772, 5287.576993840503, 5289.68261904285, 5291.417944026154, 5296.0, 5280.471952804727, 5283.339582552181, 5288.920666189991, 5290.497402746733, 5291.3385826771655, 5129.871753206163, 5205.27126202332, 5209.635325527214, 5235.319408476912, 5237.3453318335205, 5790.0, 5793.275840519935, 5798.927198468255, 5815.418458154193, 5838.2702162229725, 6110.749250451201, 6130.979101202072, 6147.200863887666, 6165.537584681167, 6171.166892469504, 6222.906656400158, 6229.065640153968, 6278.49772018242, 6346.0, 6367.204099487564, 5396.973015134939, 5586.636868603528, 5893.499052580536, 5952.7321270542925, 5957.0, 6226.439620434183, 6424.646644434508, 6428.389303016206, 6431.807045788634, 6435.646039467781, 6123.516836182961, 6132.153139173424, 6147.231596050494, 6153.815385538441, 6160.383961603804, 6081.817545473643, 6230.719617617218, 6258.123862659231, 6268.4671802896355, 6300.338464461257, 6348.968255158695, 6352.841178970562, 6363.33185015576, 6369.5222858285815, 6388.425041746265, 6337.619742815354, 6342.714577844008, 6363.5863668861375, 6364.172657554581, 6375.681215939185, 4285.507166675872, 4928.285398617252, 4964.751762411865, 4978.029284289529, 5108.795648174031, 4427.335899615019, 4436.977815110904, 4474.530174331713, 4478.283474644041, 4491.258942274488, 5644.350899646511, 5664.801731939362, 5671.319441667027, 5672.659640421588, 5679.091345384719, 6103.511719062464, 6260.467860231931, 6270.2475702915945, 6281.968590157111, 6322.4942004639515, 5732.742026608813, 5737.770489180386, 5759.827205183851, 5768.134779782982, 5795.768169273182, 5571.8885622288135, 5575.888482230333, 5576.219329293902, 5580.748866301026, 5584.832455026356, 6241.18864547615, 6270.843228919131, 6304.495640348853, 6401.263854656681, 6440.098386225932, 6206.06908963659, 6238.781642642486, 6240.719167637377, 6252.656103914328, 6253.749850006131, 6353.205849268841, 6356.0, 6449.935500644933, 6472.223333200046, 6473.0, 6306.054091886253, 6310.463610592968, 6313.463355614824, 6316.905246421399, 6341.0, 6326.082718005955, 6331.715072821642, 6332.113504109337, 6346.143270658402, 6348.619082855043, 5166.560842328294, 6056.848578785565, 6117.051856962178, 6139.048447490646, 6141.355157708376, 6003.729832157476, 6108.281362586102, 6110.315755985069, 6131.437835141539, 6141.455323060992, 5941.435563621449, 5980.102984552352, 5985.970070149621, 5987.221661184192, 5997.070454079625, 6125.968084364015, 6142.069075791408, 6142.836439233709, 6146.569740118149, 6149.20060392164, 6117.614269788275, 6133.487685122301, 6135.722664536972, 6136.825445958321, 6141.0], "value": 5743.211190869586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.0999155966418, 805.8025783682998, 856.1353033436231, 873.0004145253681, 873.1443185678039, 27216.591751123724, 28332.575011374793, 28356.0, 28374.57438138427, 37970.24059518808, 28603.0, 32292.354152916985, 40690.79654601723, 40767.796161019156, 40871.0, 8969.506677132755, 9104.45373277602, 9125.133112354315, 9126.087391260888, 9142.588583513758, 7131.4651401144865, 7328.230535793745, 8999.730008099768, 9122.179003889649, 9134.040925702806, 7261.983322334877, 7288.416926645882, 7344.669489872942, 10674.09270212033, 10894.346339219672, 10778.514966826511, 10849.67450976476, 10850.511726972305, 10856.3486190828, 10885.564577416893, 10694.893051069468, 10718.892811071868, 10757.246992710436, 10759.139268858473, 10775.5689772409, 26856.462870742474, 27424.0, 28352.432951341063, 38309.042273943094, 38669.419958700644, 3173.5557022016706, 3781.1303400218103, 3838.769673819552, 3859.0352411897024, 3863.5774012652405, 26282.86858565714, 26618.6007209892, 27163.864180679167, 27685.0, 27899.581506277424, 2957.8668959896854, 3078.0150351887405, 3146.0, 3212.1327241644626, 3239.6274428440797, 329565.0, 330164.9999999976, 330593.0, 330681.0, 331012.0, 50746.492535074176, 51261.48738512642, 51409.48590514122, 51431.48568514267, 51634.22548661773, 43532.56467435285, 44352.89117772081, 51979.96040079177, 53023.46976530185, 53542.46457535453, 12450.066245031478, 12682.556110536087, 14444.927775361057, 14511.201883896276, 14533.636659083608, 12548.937255313665, 12663.240205587694, 12671.303078330597, 12683.936580317224, 12700.920421764253, 12403.875961240452, 12405.44175512104, 12434.440450179764, 12482.687932801753, 12527.0, 4847.975760121177, 5555.027870122713, 5670.5747068969995, 5685.488306052475, 5703.058995265817, 882.8146089321186, 919.7934185655331, 950.95720692569, 964.0793042644258, 973.5424350555228, 25692.871535642204, 26644.333891652863, 27328.453430931666, 27735.72264277372, 28050.719492804812, 910.968116115946, 942.4062840410497, 1039.6673064619401, 1045.362328979322, 1069.534752382716, 13501.122427042212, 13839.446422143203, 14302.427902883976, 14432.206228657524, 14538.781918271234, 445369.0, 445420.0, 446583.5341646542, 446688.0, 447219.0, 54449.91100177974, 54459.0, 54479.72760136253, 54495.6376090593, 54626.45373546293, 1392.8258967629047, 1434.8852091832837, 1440.5894320118925, 1449.8767604753502, 1454.0766613200483, 23917.009444528598, 24221.152259670827, 27322.45355092927, 27374.0, 27404.588931166447, 45705.771471142434, 45748.54251457443, 45768.08463830638, 45823.85440363884, 45894.0, 390433.0, 391346.0, 476747.2325276703, 485048.0, 579951.0, 33626.49560256549, 34452.310953781285, 34506.96479105631, 34541.82729086339, 35427.64572354243, 42356.36465453082, 42776.5722342785, 42818.57181428146, 43386.78306608447, 43971.56028439802, 30664.540031899985, 35028.82485587556, 35378.46932295966, 35788.926332210074, 36922.44616330811, 29901.850490747405, 34335.484967726006, 35102.473462897564, 35245.29509409849, 36333.27333453369, 34988.82505587456, 35381.506362991044, 36017.27965440729, 36205.0, 36209.27581448304, 30056.69943300539, 31780.682193178698, 31899.0, 31920.840395797873, 31921.680783192798, 23603.881980590675, 23698.170564030177, 23879.4708233022, 23993.880030599736, 24293.028278869355], "value": 18208.36903340755, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8553042609022, 401.59639562239965, 419.55736697783846, 427.74976638666374, 444.40671703276126, 13167.670808229786, 20020.69968950465, 20689.896550517245, 20863.47841303968, 21031.47421314468, 20258.39224823254, 20923.95380230986, 21021.894890525564, 21066.473338166554, 21275.468113297175, 6165.938340616603, 6249.687515624223, 6510.08858759774, 6510.414062734353, 6521.31526189748, 6188.102725104857, 6355.713992870309, 6368.395002474781, 6370.745170193187, 6372.044193370985, 6086.969565152168, 6232.781852635158, 6319.115323854664, 6374.26695929967, 6381.872362552746, 6370.394812492806, 6436.742530298782, 6443.355664433566, 6447.96832506799, 6454.290028096905, 4958.479359667219, 5976.641401515923, 6209.3790620938, 6211.2857021442205, 6215.1609532712955, 24905.750942490526, 25429.872850635813, 25486.23541293764, 25554.488910221877, 25816.74183258181, 2789.5257806173, 3193.217661672905, 3208.9511271253623, 3318.5354050432957, 3365.2596428785628, 14655.120692758468, 14761.409543618242, 15143.015703979207, 15146.394144234217, 15148.848511514854, 1949.6588097083095, 1952.2776572668063, 2011.4569066352003, 2066.276803118911, 2075.8546901716886, 121904.0, 139226.0, 149289.25355373154, 152933.0, 157564.0, 14820.110793352433, 18700.0, 19566.119524621427, 19798.70301945472, 19995.400137995883, 28736.281592959924, 29532.261693457407, 29588.704112959025, 29667.25831854178, 29704.702952970627, 8270.669173233124, 8559.614817333235, 8696.434731742416, 10023.448710321003, 10137.797244055078, 7136.750213742494, 8248.0, 8333.541655208901, 8403.36974726898, 8487.151284871463, 8579.739698914498, 9287.0, 9424.246060315158, 9451.0, 9476.431414115175, 3224.6614105518584, 3728.2729867675544, 3800.8859734208017, 3816.637419445148, 3821.6942344871486, 998.0786985053743, 1012.3723291559133, 1015.3248090020202, 1022.4580972084807, 1055.5250137438184, 20047.797132171825, 20453.795462045488, 20455.795442045688, 20478.18087276522, 20818.79181208199, 992.9702108936743, 998.3061772068343, 1021.6219998600566, 1028.876534815827, 1031.7626945802508, 9895.406275623485, 10555.102816260704, 10582.259241852997, 10584.526023691276, 10691.465426728633, 747736.0, 753306.0, 762491.0, 770997.0, 795361.0, 148062.99999999785, 160500.0, 161065.19467402823, 164690.0, 165168.0, 1152.2337645465839, 1164.138537482257, 1174.0932489638164, 1193.451012534244, 1198.2750435986277, 17688.646227075646, 17820.732689009936, 17917.64164716672, 17947.192376342835, 18288.268469261613, 60269.698651506464, 65149.0, 68809.3119068823, 69146.308536916, 70566.64716676384, 83080.16919830724, 84228.57885710533, 91085.0, 94815.52592236994, 95593.0, 11511.366874821964, 11532.423378830857, 11761.647150585497, 11812.114091443003, 12014.75970480603, 12696.17474864131, 12768.872311276768, 12779.744405112031, 13084.0, 13119.803202951773, 9769.706908792748, 11372.829407559058, 11731.88268117308, 11812.527498899948, 11921.642350729491, 9293.860592090989, 11193.384363860067, 11207.271527350696, 11344.149188810707, 11658.125640576822, 11647.475863586329, 11721.648350549498, 11902.523899044287, 11914.880851191378, 12026.037916966796, 11636.476358563716, 11659.0, 11843.230190037964, 11998.280103193836, 12077.698057548632, 11259.662210133709, 11439.14206434504, 11621.88378116208, 11625.825612615648, 11818.940905295762], "value": 11300.373876141939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.5330021043378, 1544.582962600098, 1551.8137823461186, 1567.5375764149576, 1571.8113826340837, 10410.219233557485, 11037.0, 11129.944350278258, 11162.944185279082, 11179.441027948611, 10543.0, 10977.506012229449, 11084.889151108486, 11089.445527723621, 11117.72205694858, 2298.712660917385, 2336.5210131922913, 2339.321596736953, 2339.4034521197073, 2348.1077190667525, 2307.3885420363617, 2329.1615018593293, 2349.6710460535537, 2352.2943117064897, 2354.75275096115, 2309.180241014441, 2332.055517515409, 2340.5552944940405, 2344.7303560090554, 2345.9296221113395, 2292.472731271817, 2310.318456055459, 2316.7219933607907, 2318.8144948404088, 2324.1168356024773, 2261.5816074026357, 2350.882455877216, 2351.5061837014246, 2354.776296251853, 2355.4464700795297, 10996.340219586851, 11085.50115244816, 11093.278936869077, 11109.611163609316, 11118.944405278004, 5430.538404235605, 5594.0, 5598.608097433182, 5610.859728506779, 5625.662460252398, 3055.4500189965797, 3239.174010627275, 3397.2802092449356, 3492.441209406483, 3566.5363502744476, 1128.2779021426293, 1155.953761849525, 1215.738616197513, 1216.0, 1245.682351000489, 13318.86681133186, 13556.0, 13968.441262349595, 15064.548063558112, 15076.0, 4364.519902810688, 4516.322551617283, 4524.25349817283, 4545.272756358967, 4545.545445455494, 11512.94243528777, 11515.884841151648, 11525.250858694159, 11551.711207219718, 11562.190646654823, 4735.550122738403, 4882.926756098661, 5256.185291279858, 5513.58648101386, 5523.889522209533, 5033.0, 5117.360329958755, 5119.462456442095, 5126.512981266774, 5129.8717532062, 3647.2158485925124, 3750.962490375116, 3757.7369584129397, 3807.086299288206, 3807.7334586578672, 977.1108291454884, 978.1392374710351, 985.3348989432247, 993.7515621094726, 993.8558908958161, 919.1911118216061, 943.8018016216535, 950.1543626172712, 950.7005293332578, 994.2791476179856, 6137.693115344215, 6415.550911436155, 6527.249366322933, 6585.73657053722, 6652.667366631746, 991.682661548312, 991.8908920018793, 1007.4861820471613, 1020.5305559442592, 1068.4604274841156, 3402.0, 4195.3497207932205, 4209.557996410333, 4308.9353659695125, 4346.8043938022865, 13224.074314797872, 13514.459421623222, 13581.660458488617, 13628.114172578751, 13638.590842274747, 12011.939940300243, 12887.16233444823, 13168.539101131415, 13618.046736728335, 13639.0, 9872.703818885446, 10174.542145603466, 10176.898231017594, 10182.439965801655, 10193.0316619921, 6454.644994525346, 6697.2587127348215, 6893.586384816927, 6897.965510172417, 6947.930520694728, 12030.879691202976, 12065.0, 12398.070144739, 12406.62780116598, 12414.813777793159, 9330.533473326172, 12298.631041068782, 12351.25892446456, 12599.370031498573, 12718.236905785683, 9101.726948191565, 9381.624735010522, 9383.108604682817, 9389.154976052188, 9393.953030234805, 9976.850347244652, 10030.097291243532, 10205.897941020496, 10267.281290309607, 10294.433806140734, 8934.553272336487, 8992.055834137584, 9071.410358326688, 9292.395994260622, 9300.767480813034, 8562.614682339185, 8656.78358041054, 8688.304935605263, 8857.867131993155, 8871.379003469696, 7651.88522172179, 7809.804754880946, 7813.1796161402235, 7819.022622172229, 7822.100458447124, 5706.258186435737, 5715.39988301239, 5778.56660750437, 5907.49786268172, 5966.343702192842, 5754.856128596651, 5862.267216597926, 6024.246969128859, 6145.324014358328, 6161.260648722182], "value": 5051.217891226694, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6978538028056, 367.92641471705656, 374.34676489525765, 376.5725901102252, 382.4626399908128, 4602.389163792675, 4691.765411729417, 5218.504242096999, 5241.449647786984, 5314.202869569566, 4783.545563171502, 4821.951780482194, 4946.3817022872145, 4949.752512374376, 4995.775190116445, 3399.881004164855, 4199.370094485821, 4204.88838259688, 4227.632525785554, 4256.616904478597, 3745.8501659933568, 4251.5535868733805, 4252.0, 4275.786210689453, 4291.613754762071, 3662.443461528853, 3857.6661120022404, 3941.4087886817065, 4169.937450938239, 4267.167902259061, 3504.877329293488, 3710.369237229664, 4169.749075277435, 4179.185058913513, 4184.623383895464, 3826.4642949987024, 3857.8071096445065, 3863.4011728182177, 3885.3783394657003, 3922.8626998054933, 4832.420109586837, 4906.037584966007, 4942.0, 4964.925526117111, 4974.0, 4611.515790841947, 4774.379330687023, 4829.5852073963015, 4845.030993801219, 4850.569082120783, 4332.371806088099, 4832.299316599108, 5015.288686372059, 5296.152615581527, 5303.496167864047, 3754.9861537384754, 4143.8964025899295, 4166.83332666693, 4252.617264446215, 4266.1254442839145, 3994.400839874013, 5242.056429842665, 5250.65870718402, 5358.089124848746, 5465.398806131362, 4207.453031105937, 4345.5029387824425, 4638.605718513897, 4768.880777980578, 4854.951450485521, 4444.866654000385, 4917.877053073702, 4970.365706175733, 4992.80028798844, 5013.523715247119, 4225.696995137658, 4384.868453946387, 4754.882602588389, 4848.127337079289, 5069.315642388304, 5328.4671532846405, 5378.515933565998, 5388.973055134699, 5394.649347792381, 5448.400675925645, 1437.6118448018976, 1521.710874933759, 1522.721153558504, 1673.707101257275, 1674.3637417781408, 1270.634068376499, 1363.7886127650231, 1366.631009627395, 1368.438940034601, 1384.7092110656874, 4781.163296423181, 4972.751362431936, 5027.371578552681, 5165.564899341971, 5169.6655657100955, 5222.556082732935, 5339.970811091838, 5544.556435485151, 5547.44525547442, 5643.5203007743985, 4257.637555982056, 4316.892077698083, 4651.0, 4791.233402655628, 5010.724410157476, 2523.917767841538, 2712.7287271272717, 2778.722127787205, 2869.7130286971137, 2873.870675819593, 5497.8075767347955, 5618.578606604439, 5750.686984761429, 5772.451617096369, 5838.474537291664, 4891.760194911551, 5307.7080760557765, 5642.774289028475, 5687.40282270364, 5754.395788442237, 5041.798328066836, 5447.404712889474, 5724.021804845593, 5737.3688894221605, 5850.566611180288, 4829.396325459317, 5187.455317191791, 5351.147174034689, 5539.590278228822, 5545.750441230235, 4488.4165058542185, 4810.7113573185725, 4911.950880491149, 5259.342582177228, 5408.1877423740225, 4692.460367057832, 4790.568848803624, 5252.1113387637415, 5420.783168673209, 5600.719964001865, 4768.0, 4801.231802911518, 4801.855944321676, 4806.327114204084, 4849.80600775965, 4822.831200907952, 5094.3254791234895, 5146.588272938231, 5537.2524709163745, 5644.814588936205, 4538.546145385435, 4759.190937540558, 4786.401699787527, 5349.545288650508, 5360.088784906653, 4674.555917187861, 5328.200769884548, 5365.973170134124, 5378.650387724785, 5422.3941079181905, 4403.524819185609, 4663.556962088596, 4847.951520484891, 4949.045127174818, 5252.139677337078, 4592.196365635934, 4903.362562866804, 4995.526319735614, 5095.796168153232, 5355.955588660174, 4718.009218064245, 5166.586673066221, 5218.851852592424, 5252.632315738015, 5285.7621407036], "value": 4150.011835215045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.8673795347864, 742.4654248940764, 775.4533054196792, 819.3363375665712, 829.8755186721991, 14884.851151488481, 15763.133027683487, 15769.21153942304, 15778.289976951037, 15780.368785248576, 14318.713625727505, 14331.068480548756, 14350.78473822891, 14439.783403248959, 14469.0, 891.4473026723424, 908.736466424736, 911.539672465404, 942.5334459442552, 974.6101559376235, 941.7598512379334, 959.7120863740885, 961.9519024048805, 962.2350231565887, 962.8651988721584, 864.8097418567905, 1007.471077684218, 1012.6860673191334, 1013.7769690668079, 1014.0012088093222, 1003.0370843989706, 1005.9044390782864, 1006.3710181136789, 1007.4207330784755, 1007.969760907174, 640.7789312687162, 749.5390334944025, 749.9812504687372, 750.9361704255144, 753.6457864803533, 15527.223638818014, 15842.366305347772, 15861.889667723264, 16071.758923616038, 16330.0, 13913.860861391358, 14043.929780351134, 14203.218822964733, 14267.928660356736, 14373.06575072617, 11650.524134082692, 11780.587679431179, 11851.881481185164, 11887.465064072137, 11893.93297831532, 3604.475415642014, 3650.251698401821, 3697.186618943828, 3736.3461394255896, 3847.2882516734494, 110974.44512777466, 111007.44496277548, 112072.4396378021, 114258.0, 114649.0, 9489.715308540755, 10756.892431075745, 10784.245102842726, 10796.784064318826, 10916.181286403551, 22291.77708222897, 22623.434414139778, 22994.19520316781, 23041.308760737204, 23086.191983280503, 7659.770206893802, 7688.500247484008, 7752.030400119239, 7782.922170778333, 7788.376929845712, 4263.445752052214, 4282.5075116361395, 4399.186150562156, 4408.0, 4526.117407105648, 3509.1051781795477, 3565.090901820019, 3581.033121057352, 3612.02475331659, 3613.638636136365, 624.9656268905254, 631.1479502671449, 637.221277822517, 637.3721883944404, 644.5745807766945, 670.3263220463404, 685.4208194075998, 688.1638808847274, 693.4625665109479, 737.1854101218184, 8804.647814087493, 9703.509429249407, 10425.426601536836, 10536.209784266211, 10725.731856703645, 680.3672584496466, 690.5131882023162, 706.3113464372299, 708.6952610377484, 721.4805340155079, 4136.503619565671, 4868.488808675038, 4975.975120124376, 5033.370828646419, 5064.898702025939, 105363.0, 105891.4705426468, 108477.7456676301, 108989.0, 109476.0, 46919.0, 53523.732381338625, 74630.62684686651, 74895.62552187205, 75104.0, 68640.0, 69694.0, 76170.0, 76727.0, 77698.61150694323, 10761.838572421577, 10813.297135686154, 11103.72240693989, 11124.777504449703, 11267.943660281646, 46881.29678054764, 47096.7645161772, 47537.0, 48685.0, 50114.99770004507, 61870.0719489217, 61923.071153933626, 63500.77747278823, 63899.68050159719, 64790.0, 12561.183523070971, 12652.367381631066, 12671.049671274506, 12892.41984110736, 13449.193048417126, 13900.37448314808, 14152.150870947777, 14604.853951460349, 14733.336999835248, 14854.183019934007, 12344.75310493803, 13177.27524986135, 13204.537841175512, 13291.734165316833, 13624.93187534056, 12907.354632268536, 13592.524261650795, 13665.385057672627, 13828.308584570932, 14173.149611023371, 11625.36060516646, 12948.028897832888, 13337.3331333431, 13809.79285310701, 14012.579622611338, 10919.290246134293, 10954.945225273823, 11200.607978720705, 11239.157063220455, 11342.546298147981, 9365.47298881839, 10169.338992965433, 11183.944080279547, 11368.261063030877, 11388.94305528467], "value": 7590.251511570653, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 118.0, 116.0, 119.0, 118.0, 117.0, 118.0, 119.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 111.0, 115.0, 173.0, 142.0, 124.0, 108.0, 107.0, 129.0, 113.0], "value": 125.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 186.0, 185.0, 185.0, 187.0, 185.0, 184.0, 187.0, 185.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 75.0, 87.0, 119.0, 65.0, 61.0, 71.0, 52.0, 75.0, 74.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 89.0, 71.0, 70.0, 69.0, 82.0, 69.0, 69.0, 84.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0, 96.0, 135.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 97.0, 132.0, 128.0, 95.0, 97.0, 95.0, 94.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 82.0, 83.0, 84.0, 84.0, 84.0, 84.0, 87.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 62.0, 65.0, 65.0, 65.0, 67.0, 66.0, 66.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 63.0, 63.0, 63.0, 62.0, 59.0, 59.0, 59.0, 58.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 97.0, 84.0, 87.0, 84.0, 83.0, 82.0, 88.0, 91.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 164.0, 140.0, 139.0, 137.0, 158.0, 152.0, 133.0, 180.0, 160.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 174.0, 229.0, 187.0, 167.0, 165.0, 165.0, 166.0, 169.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 82.0, 81.0, 69.0, 65.0, 63.0, 64.0, 64.0, 65.0], "value": 68.6, "unit": "score"}]}]} 04:55:13 INFO - Return code: 0 04:55:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:14 ERROR - # TBPL SUCCESS # 04:55:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:14 INFO - 2017-03-10 04:55:14.029 screenresolution[2524:41053] starting screenresolution argv=screenresolution get 04:55:14 INFO - 2017-03-10 04:55:14.034 screenresolution[2524:41053] Display 0: 1600x1200x32@60 04:55:14 INFO - 2017-03-10 04:55:14.040 screenresolution[2525:41055] starting screenresolution argv=screenresolution list 04:55:14 INFO - Available Modes on Display 0 04:55:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:14 INFO - Intel Iris: 04:55:14 INFO - Chipset Model: Intel Iris 04:55:14 INFO - Type: GPU 04:55:14 INFO - Bus: Built-In 04:55:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:14 INFO - Vendor: Intel (0x8086) 04:55:14 INFO - Device ID: 0x0a2e 04:55:14 INFO - Revision ID: 0x0009 04:55:14 INFO - Displays: 04:55:14 INFO - Display: 04:55:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:14 INFO - Display Serial Number: 1600x1200 60 04:55:14 INFO - Main Display: Yes 04:55:14 INFO - Mirror: Off 04:55:14 INFO - Online: Yes 04:55:14 INFO - Rotation: Supported 04:55:14 INFO - Return code: 0 04:55:14 INFO - Running post-action listener: _resource_record_post_action 04:55:14 INFO - [mozharness: 2017-03-10 12:55:14.280031Z] Finished run-tests step (success) 04:55:14 INFO - Running post-run listener: _resource_record_post_run 04:55:14 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 647168; Write bytes: 507189248; Read time: 6; Write time: 1687 04:55:14 INFO - TinderboxPrint: CPU usage
53.9% 04:55:14 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 6 04:55:14 INFO - TinderboxPrint: I/O write bytes / time
507,189,248 / 1,687 04:55:14 INFO - TinderboxPrint: CPU idle
2,221.0 (46.1%) 04:55:14 INFO - TinderboxPrint: CPU system
963.5 (20.0%) 04:55:14 INFO - TinderboxPrint: CPU user
1,629.3 (33.8%) 04:55:14 INFO - TinderboxPrint: Swap in / out
208,670,720 / 0 04:55:14 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201796096; Write bytes: 199618560; Read time: 15705; Write time: 380 04:55:14 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 647168; Write bytes: 297678848; Read time: 6; Write time: 1274 04:55:14 INFO - Running post-run listener: _upload_blobber_files 04:55:14 INFO - Blob upload gear active. 04:55:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:14 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:55:14 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:55:14 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:55:15 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:15 INFO - (blobuploader) - INFO - Done attempting. 04:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:16 INFO - (blobuploader) - INFO - Done attempting. 04:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:55:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:17 INFO - (blobuploader) - INFO - Done attempting. 04:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:55:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:20 INFO - (blobuploader) - INFO - Done attempting. 04:55:20 INFO - (blobuploader) - INFO - Iteration through files over. 04:55:20 INFO - Return code: 0 04:55:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:55:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:55:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a712a1d0ab8eb98cec05a017f586367b9e8298e490109be0aec7fb25492fc932a1e29873186a4e0f18ee350e68e5fe4f1cb8c4cd4bdb52acd7e72c61859d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d18dabaffde6342bd55807030a17d26945544e32811600d7b08b209e035d88306a2f8591f132a10eba09f3c2d6a5a8ce02093e1cf474b65d75871131c88ef6ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c791888fbf5203d65d50c4b96fef82a544b0858822326a1357684ea0e78c48c6764f930331d5ac269d8118a06bdba521e0866bb10055d56450f930f4399c487", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50d7b7200870eeb985882d3e85236e55f7306c34097eddaa6fe4a56b14505bfd1d848eb6ed89784583063d9b3246ac3c88007616dfaf561c2e8823104b4e9e0"} 04:55:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:55:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:55:20 INFO - Contents: 04:55:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a712a1d0ab8eb98cec05a017f586367b9e8298e490109be0aec7fb25492fc932a1e29873186a4e0f18ee350e68e5fe4f1cb8c4cd4bdb52acd7e72c61859d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d18dabaffde6342bd55807030a17d26945544e32811600d7b08b209e035d88306a2f8591f132a10eba09f3c2d6a5a8ce02093e1cf474b65d75871131c88ef6ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c791888fbf5203d65d50c4b96fef82a544b0858822326a1357684ea0e78c48c6764f930331d5ac269d8118a06bdba521e0866bb10055d56450f930f4399c487", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50d7b7200870eeb985882d3e85236e55f7306c34097eddaa6fe4a56b14505bfd1d848eb6ed89784583063d9b3246ac3c88007616dfaf561c2e8823104b4e9e0"} 04:55:20 INFO - Running post-run listener: copy_logs_to_upload_dir 04:55:20 INFO - Copying logs to upload dir... 04:55:20 INFO - mkdir: /builds/slave/test/build/upload/logs 04:55:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.555144 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-10 04:55:20.080950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:55:20.084589) ========= 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.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Mozilla-Aurora/sha512/c2a712a1d0ab8eb98cec05a017f586367b9e8298e490109be0aec7fb25492fc932a1e29873186a4e0f18ee350e68e5fe4f1cb8c4cd4bdb52acd7e72c61859d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d18dabaffde6342bd55807030a17d26945544e32811600d7b08b209e035d88306a2f8591f132a10eba09f3c2d6a5a8ce02093e1cf474b65d75871131c88ef6ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c791888fbf5203d65d50c4b96fef82a544b0858822326a1357684ea0e78c48c6764f930331d5ac269d8118a06bdba521e0866bb10055d56450f930f4399c487", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50d7b7200870eeb985882d3e85236e55f7306c34097eddaa6fe4a56b14505bfd1d848eb6ed89784583063d9b3246ac3c88007616dfaf561c2e8823104b4e9e0"} build_url:https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/AQdnI8liQH-h3X8WtZJYNQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2a712a1d0ab8eb98cec05a017f586367b9e8298e490109be0aec7fb25492fc932a1e29873186a4e0f18ee350e68e5fe4f1cb8c4cd4bdb52acd7e72c61859d73", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d18dabaffde6342bd55807030a17d26945544e32811600d7b08b209e035d88306a2f8591f132a10eba09f3c2d6a5a8ce02093e1cf474b65d75871131c88ef6ff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c791888fbf5203d65d50c4b96fef82a544b0858822326a1357684ea0e78c48c6764f930331d5ac269d8118a06bdba521e0866bb10055d56450f930f4399c487", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b50d7b7200870eeb985882d3e85236e55f7306c34097eddaa6fe4a56b14505bfd1d848eb6ed89784583063d9b3246ac3c88007616dfaf561c2e8823104b4e9e0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:55:20.121832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:55:20.122169) ========= 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.olvhl5arpy/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.xgESgeL4kI/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005478 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:55:20.171124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:55:20.171490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:55:20.171854) ========= ========= Total master_lag: 0.18 =========